builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-015 starttime: 1496334775.67 results: success (0) revision: 62005e6aecdf95c9cffe5fb825d93123ec49c4b3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-01 09:32:55.673897) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-01 09:32:55.674529) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-01 09:32:55.674808) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-01 09:32:55.856507) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 09:32:55.856781) ========= 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=20e666a3d4cfbb71505a330e000001b4-1496327515.119291-338637468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-01 09:32:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 29.9M=0s 2017-06-01 09:32:57 (29.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.139725 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 09:32:56.074301) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 09:32:56.074621) ========= 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=20e666a3d4cfbb71505a330e000001b4-1496327515.119291-338637468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019091 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 09:32:56.188523) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-01 09:32:56.188848) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 62005e6aecdf95c9cffe5fb825d93123ec49c4b3 --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 62005e6aecdf95c9cffe5fb825d93123ec49c4b3 --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=20e666a3d4cfbb71505a330e000001b4-1496327515.119291-338637468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-01 09:32:57,422 truncating revision to first 12 chars 2017-06-01 09:32:57,422 Setting DEBUG logging. 2017-06-01 09:32:57,422 attempt 1/10 2017-06-01 09:32:57,422 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/62005e6aecdf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-01 09:32:58,702 unpacking tar archive at: mozilla-central-62005e6aecdf/testing/mozharness/ program finished with exit code 0 elapsedTime=1.578246 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-01 09:32:57.798553) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-01 09:32:57.798855) ========= script_repo_revision: 62005e6aecdf95c9cffe5fb825d93123ec49c4b3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-01 09:32:57.802304) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-01 09:32:57.802596) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-01 09:32:57.811782) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2017-06-01 09:32:57.812163) ========= /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=20e666a3d4cfbb71505a330e000001b4-1496327515.119291-338637468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:32:59 INFO - MultiFileLogger online at 20170601 09:32:59 in /builds/slave/test 09:32:59 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:32:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:32:59 INFO - {'append_to_log': False, 09:32:59 INFO - 'base_work_dir': '/builds/slave/test', 09:32:59 INFO - 'blob_upload_branch': 'Firefox', 09:32:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:32:59 INFO - 'branch': 'Firefox', 09:32:59 INFO - 'buildbot_json_path': 'buildprops.json', 09:32:59 INFO - 'config_files': ('talos/linux_config.py',), 09:32:59 INFO - 'default_actions': ('clobber', 09:32:59 INFO - 'read-buildbot-config', 09:32:59 INFO - 'download-and-extract', 09:32:59 INFO - 'populate-webroot', 09:32:59 INFO - 'create-virtualenv', 09:32:59 INFO - 'install', 09:32:59 INFO - 'setup-mitmproxy', 09:32:59 INFO - 'run-tests'), 09:32:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:32:59 INFO - 'download_minidump_stackwalk': True, 09:32:59 INFO - 'download_symbols': 'ondemand', 09:32:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:32:59 INFO - 'tooltool.py': '/tools/tooltool.py', 09:32:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:32:59 INFO - '/tools/misc-python/virtualenv.py')}, 09:32:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:32:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:32:59 INFO - 'gecko_profile': False, 09:32:59 INFO - 'gecko_profile_interval': 0, 09:32:59 INFO - 'installer_path': 'installer.exe', 09:32:59 INFO - 'log_level': 'info', 09:32:59 INFO - 'log_name': 'talos', 09:32:59 INFO - 'log_to_console': True, 09:32:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:32:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:32:59 INFO - 'opt_config_files': (), 09:32:59 INFO - 'pip_index': False, 09:32:59 INFO - 'suite': 'dromaeojs-e10s', 09:32:59 INFO - 'system_bits': '32', 09:32:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:32:59 INFO - 'title': 'talos-linux64-ix-015', 09:32:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:32:59 INFO - 'use_talos_json': True, 09:32:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:32:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:32:59 INFO - 'work_dir': 'build'} 09:32:59 INFO - [mozharness: 2017-06-01 16:32:59.130456Z] Running clobber step. 09:32:59 INFO - Running pre-action listener: _resource_record_pre_action 09:32:59 INFO - Running main action method: clobber 09:32:59 INFO - rmtree: /builds/slave/test/build 09:32:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:33:00 INFO - Running post-action listener: _resource_record_post_action 09:33:00 INFO - [mozharness: 2017-06-01 16:33:00.155747Z] Finished clobber step (success) 09:33:00 INFO - [mozharness: 2017-06-01 16:33:00.155849Z] Running read-buildbot-config step. 09:33:00 INFO - Running pre-action listener: _resource_record_pre_action 09:33:00 INFO - Running main action method: read_buildbot_config 09:33:00 INFO - Using buildbot properties: 09:33:00 INFO - { 09:33:00 INFO - "project": "", 09:33:00 INFO - "product": "firefox", 09:33:00 INFO - "who": "ryanvm@gmail.com", 09:33:00 INFO - "installer_path": "public/build/target.tar.bz2", 09:33:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 09:33:00 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:33:00 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 09:33:00 INFO - "stage_platform": "linux64-stylosequential", 09:33:00 INFO - "basedir": "/builds/slave/test", 09:33:00 INFO - "buildnumber": 43, 09:33:00 INFO - "platform": "ubuntu64_hw_styloseq", 09:33:00 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:33:00 INFO - "slavebuilddir": "test", 09:33:00 INFO - "taskId": "RfI_iBDCSi27MexiQpueng", 09:33:00 INFO - "branch": "mozilla-central", 09:33:00 INFO - "script_repo_revision": "production", 09:33:00 INFO - "revision": "62005e6aecdf95c9cffe5fb825d93123ec49c4b3", 09:33:00 INFO - "slavename": "talos-linux64-ix-015", 09:33:00 INFO - "repo_path": "mozilla-central" 09:33:00 INFO - } 09:33:00 INFO - Finding installer, test and symbols from parent task. 09:33:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RfI_iBDCSi27MexiQpueng'}, attempt #1 09:33:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RfI_iBDCSi27MexiQpueng'}, attempt #1 09:33:01 INFO - Task dependencies: BrxE3naNRfiJs9uQ0VKz8Q 09:33:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BrxE3naNRfiJs9uQ0VKz8Q'}, attempt #1 09:33:01 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/BrxE3naNRfiJs9uQ0VKz8Q/artifacts/public/build/target.tar.bz2 09:33:01 INFO - Set test_url: https://queue.taskcluster.net/v1/task/BrxE3naNRfiJs9uQ0VKz8Q/artifacts/public/build/test_packages.json 09:33:01 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/BrxE3naNRfiJs9uQ0VKz8Q/artifacts/public/build/target.crashreporter-symbols.zip 09:33:01 INFO - Running post-action listener: _resource_record_post_action 09:33:01 INFO - [mozharness: 2017-06-01 16:33:01.546353Z] Finished read-buildbot-config step (success) 09:33:01 INFO - [mozharness: 2017-06-01 16:33:01.546575Z] Running download-and-extract step. 09:33:01 INFO - Running pre-action listener: _resource_record_pre_action 09:33:01 INFO - Running main action method: download_and_extract 09:33:01 INFO - mkdir: /builds/slave/test/build/tests 09:33:01 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:33:01 INFO - trying https://queue.taskcluster.net/v1/task/BrxE3naNRfiJs9uQ0VKz8Q/artifacts/public/build/target.test_packages.json 09:33:01 INFO - Downloading https://queue.taskcluster.net/v1/task/BrxE3naNRfiJs9uQ0VKz8Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:33:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BrxE3naNRfiJs9uQ0VKz8Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:33:02 INFO - Downloaded 986 bytes. 09:33:02 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:33:02 INFO - Using the following test package requirements: 09:33:02 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:33:02 INFO - u'common': [u'target.common.tests.zip'], 09:33:02 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:33:02 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:33:02 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:33:02 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:33:02 INFO - u'mozbase': [u'target.common.tests.zip'], 09:33:02 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:33:02 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:33:02 INFO - u'web-platform': [u'target.common.tests.zip', 09:33:02 INFO - u'target.web-platform.tests.zip'], 09:33:02 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:33:02 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:33:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BrxE3naNRfiJs9uQ0VKz8Q/artifacts/public/build/target.common.tests.zip 09:33:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BrxE3naNRfiJs9uQ0VKz8Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:33:02 INFO - Fetch https://queue.taskcluster.net/v1/task/BrxE3naNRfiJs9uQ0VKz8Q/artifacts/public/build/target.common.tests.zip into memory 09:33:03 INFO - Content-Length response header: 63535482 09:33:03 INFO - Bytes received: 63535482 09:33:14 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:33:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BrxE3naNRfiJs9uQ0VKz8Q/artifacts/public/build/target.common.tests.zip 09:33:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BrxE3naNRfiJs9uQ0VKz8Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:33:14 INFO - Fetch https://queue.taskcluster.net/v1/task/BrxE3naNRfiJs9uQ0VKz8Q/artifacts/public/build/target.common.tests.zip into memory 09:33:16 INFO - Content-Length response header: 63535482 09:33:16 INFO - Bytes received: 63535482 09:33:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BrxE3naNRfiJs9uQ0VKz8Q/artifacts/public/build/target.talos.tests.zip 09:33:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BrxE3naNRfiJs9uQ0VKz8Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:33:27 INFO - Fetch https://queue.taskcluster.net/v1/task/BrxE3naNRfiJs9uQ0VKz8Q/artifacts/public/build/target.talos.tests.zip into memory 09:33:28 INFO - Content-Length response header: 14447425 09:33:28 INFO - Bytes received: 14447425 09:33:28 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:33:28 INFO - trying https://queue.taskcluster.net/v1/task/BrxE3naNRfiJs9uQ0VKz8Q/artifacts/public/build/target.tar.bz2 09:33:28 INFO - Downloading https://queue.taskcluster.net/v1/task/BrxE3naNRfiJs9uQ0VKz8Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:33:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BrxE3naNRfiJs9uQ0VKz8Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:33:30 INFO - Downloaded 55965834 bytes. 09:33:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BrxE3naNRfiJs9uQ0VKz8Q/artifacts/public/build/target.tar.bz2 09:33:30 INFO - mkdir: /builds/slave/test/properties 09:33:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:33:30 INFO - Writing to file /builds/slave/test/properties/build_url 09:33:30 INFO - Contents: 09:33:30 INFO - build_url:https://queue.taskcluster.net/v1/task/BrxE3naNRfiJs9uQ0VKz8Q/artifacts/public/build/target.tar.bz2 09:33:30 INFO - Running post-action listener: _resource_record_post_action 09:33:30 INFO - Running post-action listener: set_extra_try_arguments 09:33:30 INFO - [mozharness: 2017-06-01 16:33:30.365853Z] Finished download-and-extract step (success) 09:33:30 INFO - [mozharness: 2017-06-01 16:33:30.365962Z] Running populate-webroot step. 09:33:30 INFO - Running pre-action listener: _resource_record_pre_action 09:33:30 INFO - Running main action method: populate_webroot 09:33:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:33:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:33:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:33:30 INFO - '--tppagecycles', 09:33:30 INFO - '7'], 09:33:30 INFO - 'tests': ['tsvgm']}}, 09:33:30 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:33:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:33:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:33:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:33:30 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:33:30 INFO - 'talos_options': ['--disable-e10s'], 09:33:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:33:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:33:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:33:30 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:33:30 INFO - 'talos_options': ['--disable-e10s'], 09:33:30 INFO - 'tests': ['damp', 'tps']}, 09:33:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:33:30 INFO - 'tests': ['damp', 'tps']}, 09:33:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:33:30 INFO - 'tests': ['dromaeo_dom']}, 09:33:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:33:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:33:30 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:33:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:33:30 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:33:30 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:33:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:33:30 INFO - 'tests': ['a11yr', 09:33:30 INFO - 'ts_paint', 09:33:30 INFO - 'tpaint', 09:33:30 INFO - 'sessionrestore', 09:33:30 INFO - 'sessionrestore_no_auto_restore', 09:33:30 INFO - 'tabpaint']}, 09:33:30 INFO - 'other-e10s': {'tests': ['a11yr', 09:33:30 INFO - 'ts_paint', 09:33:30 INFO - 'tpaint', 09:33:30 INFO - 'sessionrestore', 09:33:30 INFO - 'sessionrestore_no_auto_restore', 09:33:30 INFO - 'tabpaint']}, 09:33:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:33:30 INFO - 'ts_paint', 09:33:30 INFO - 'tpaint', 09:33:30 INFO - 'sessionrestore', 09:33:30 INFO - 'sessionrestore_no_auto_restore', 09:33:30 INFO - 'tabpaint']}, 09:33:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:33:30 INFO - 'ts_paint', 09:33:30 INFO - 'tpaint', 09:33:30 INFO - 'sessionrestore', 09:33:30 INFO - 'sessionrestore_no_auto_restore', 09:33:30 INFO - 'tabpaint']}, 09:33:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:33:30 INFO - 'tests': ['a11yr', 09:33:30 INFO - 'ts_paint', 09:33:30 INFO - 'tpaint', 09:33:30 INFO - 'sessionrestore', 09:33:30 INFO - 'sessionrestore_no_auto_restore', 09:33:30 INFO - 'tabpaint']}, 09:33:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:33:30 INFO - 'tests': ['a11yr', 09:33:30 INFO - 'ts_paint', 09:33:30 INFO - 'tpaint', 09:33:30 INFO - 'sessionrestore', 09:33:30 INFO - 'sessionrestore_no_auto_restore', 09:33:30 INFO - 'tabpaint']}, 09:33:30 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:33:30 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:33:30 INFO - 'bloom_basic_ref']}, 09:33:30 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 09:33:30 INFO - 'talos_options': ['--mitmproxy', 09:33:30 INFO - 'mitmproxy-recording-1.mp', 09:33:30 INFO - '--firstNonBlankPaint'], 09:33:30 INFO - 'tests': ['Quantum_1']}, 09:33:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:33:30 INFO - 'tests': ['tsvgx', 09:33:30 INFO - 'tsvgr_opacity', 09:33:30 INFO - 'tart', 09:33:30 INFO - 'tscrollx', 09:33:30 INFO - 'cart', 09:33:30 INFO - 'tsvg_static']}, 09:33:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:33:30 INFO - 'tsvgr_opacity', 09:33:30 INFO - 'tart', 09:33:30 INFO - 'tscrollx', 09:33:30 INFO - 'cart', 09:33:30 INFO - 'tsvg_static']}, 09:33:30 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:33:30 INFO - 'talos_options': ['--disable-e10s'], 09:33:30 INFO - 'tests': ['tp5o']}, 09:33:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:33:30 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:33:30 INFO - 'talos_options': ['--disable-e10s', 09:33:30 INFO - '--xperf_path', 09:33:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:33:30 INFO - 'tests': ['tp5n']}, 09:33:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:33:30 INFO - 'talos_options': ['--xperf_path', 09:33:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:33:30 INFO - 'tests': ['tp5n']}}, 09:33:30 INFO - 'talos.zip': {'path': '', 09:33:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:33:30 INFO - Running post-action listener: _resource_record_post_action 09:33:30 INFO - [mozharness: 2017-06-01 16:33:30.380330Z] Finished populate-webroot step (success) 09:33:30 INFO - [mozharness: 2017-06-01 16:33:30.380424Z] Running create-virtualenv step. 09:33:30 INFO - Running pre-action listener: _resource_record_pre_action 09:33:30 INFO - Running main action method: create_virtualenv 09:33:30 INFO - Creating virtualenv /builds/slave/test/build/venv 09:33:30 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:33:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:33:30 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:33:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:33:30 INFO - Using real prefix '/usr' 09:33:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:33:30 INFO - Installing distribute.............................................................................................................................................................................................done. 09:33:32 INFO - Installing pip.................done. 09:33:32 INFO - Return code: 0 09:33:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:33:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:33:33 INFO - Reading from file tmpfile_stdout 09:33:33 INFO - Output received: 09:33:33 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:33:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:33: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:33:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33: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:33:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13793b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1553a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f7dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f4840>, '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 0x16f5740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f5bd0>, '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': '20e666a3d4cfbb71505a330e000001b4-1496327515.119291-338637468', '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:33: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', 'pip>=1.5'] in /builds/slave/test/build 09:33: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 pip>=1.5 09:33:33 INFO - Using env: {'DISPLAY': ':0', 09:33:33 INFO - 'HOME': '/home/cltbld', 09:33:33 INFO - 'LANG': 'en_US.UTF-8', 09:33:33 INFO - 'LANGUAGE': 'en_US:en', 09:33:33 INFO - 'LOGNAME': 'cltbld', 09:33:33 INFO - 'MAIL': '/var/mail/cltbld', 09:33:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:33 INFO - 'MOZ_NO_REMOTE': '1', 09:33:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:33 INFO - 'NO_EM_RESTART': '1', 09:33:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:33 INFO - 'PWD': '/builds/slave/test', 09:33:33 INFO - 'SHELL': '/bin/bash', 09:33:33 INFO - 'SHLVL': '1', 09:33:33 INFO - 'TERM': 'linux', 09:33:33 INFO - 'TMOUT': '86400', 09:33:33 INFO - 'USER': 'cltbld', 09:33:33 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1496327515.119291-338637468', 09:33:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:33 INFO - '_': '/tools/buildbot/bin/python'} 09:33:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:33 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:33:33 INFO - Cleaning up... 09:33:33 INFO - Return code: 0 09:33:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:33: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:33:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33: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:33:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33: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', '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 0x13793b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1553a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f7dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f4840>, '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 0x16f5740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f5bd0>, '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': '20e666a3d4cfbb71505a330e000001b4-1496327515.119291-338637468', '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:33: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', 'psutil>=3.1.1'] in /builds/slave/test/build 09:33: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 psutil>=3.1.1 09:33:33 INFO - Using env: {'DISPLAY': ':0', 09:33:33 INFO - 'HOME': '/home/cltbld', 09:33:33 INFO - 'LANG': 'en_US.UTF-8', 09:33:33 INFO - 'LANGUAGE': 'en_US:en', 09:33:33 INFO - 'LOGNAME': 'cltbld', 09:33:33 INFO - 'MAIL': '/var/mail/cltbld', 09:33:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:33 INFO - 'MOZ_NO_REMOTE': '1', 09:33:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:33 INFO - 'NO_EM_RESTART': '1', 09:33:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:33 INFO - 'PWD': '/builds/slave/test', 09:33:33 INFO - 'SHELL': '/bin/bash', 09:33:33 INFO - 'SHLVL': '1', 09:33:33 INFO - 'TERM': 'linux', 09:33:33 INFO - 'TMOUT': '86400', 09:33:33 INFO - 'USER': 'cltbld', 09:33:33 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1496327515.119291-338637468', 09:33:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:33 INFO - '_': '/tools/buildbot/bin/python'} 09:33:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:33 INFO - Downloading/unpacking psutil>=3.1.1 09:33: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:33: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:33: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:33: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:33:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:33:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:33:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:33:34 INFO - Installing collected packages: psutil 09:33:34 INFO - Running setup.py install for psutil 09:33:34 INFO - building 'psutil._psutil_linux' extension 09:33:34 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:33:35 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:33:35 INFO - building 'psutil._psutil_posix' extension 09:33:35 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:33:35 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:33:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:33:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:33:35 INFO - Successfully installed psutil 09:33:35 INFO - Cleaning up... 09:33:35 INFO - Return code: 0 09:33:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:33: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:33:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33: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:33:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13793b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1553a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f7dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f4840>, '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 0x16f5740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f5bd0>, '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': '20e666a3d4cfbb71505a330e000001b4-1496327515.119291-338637468', '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:33: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:33: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 mozsystemmonitor==0.3 09:33:35 INFO - Using env: {'DISPLAY': ':0', 09:33:35 INFO - 'HOME': '/home/cltbld', 09:33:35 INFO - 'LANG': 'en_US.UTF-8', 09:33:35 INFO - 'LANGUAGE': 'en_US:en', 09:33:35 INFO - 'LOGNAME': 'cltbld', 09:33:35 INFO - 'MAIL': '/var/mail/cltbld', 09:33:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:35 INFO - 'MOZ_NO_REMOTE': '1', 09:33:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:35 INFO - 'NO_EM_RESTART': '1', 09:33:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:35 INFO - 'PWD': '/builds/slave/test', 09:33:35 INFO - 'SHELL': '/bin/bash', 09:33:35 INFO - 'SHLVL': '1', 09:33:35 INFO - 'TERM': 'linux', 09:33:35 INFO - 'TMOUT': '86400', 09:33:35 INFO - 'USER': 'cltbld', 09:33:35 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1496327515.119291-338637468', 09:33:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:35 INFO - '_': '/tools/buildbot/bin/python'} 09:33:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:33: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:33: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:33: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:33: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:33:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:33:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:33:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:33:36 INFO - Installing collected packages: mozsystemmonitor 09:33:36 INFO - Running setup.py install for mozsystemmonitor 09:33:36 INFO - Successfully installed mozsystemmonitor 09:33:36 INFO - Cleaning up... 09:33:36 INFO - Return code: 0 09:33:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:33:36 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:33:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:36 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:33:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:36 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 0x13793b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1553a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f7dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f4840>, '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 0x16f5740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f5bd0>, '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': '20e666a3d4cfbb71505a330e000001b4-1496327515.119291-338637468', '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:33:36 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:33:36 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:33:36 INFO - Using env: {'DISPLAY': ':0', 09:33:36 INFO - 'HOME': '/home/cltbld', 09:33:36 INFO - 'LANG': 'en_US.UTF-8', 09:33:36 INFO - 'LANGUAGE': 'en_US:en', 09:33:36 INFO - 'LOGNAME': 'cltbld', 09:33:36 INFO - 'MAIL': '/var/mail/cltbld', 09:33:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:36 INFO - 'MOZ_NO_REMOTE': '1', 09:33:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:36 INFO - 'NO_EM_RESTART': '1', 09:33:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:36 INFO - 'PWD': '/builds/slave/test', 09:33:36 INFO - 'SHELL': '/bin/bash', 09:33:36 INFO - 'SHLVL': '1', 09:33:36 INFO - 'TERM': 'linux', 09:33:36 INFO - 'TMOUT': '86400', 09:33:36 INFO - 'USER': 'cltbld', 09:33:36 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1496327515.119291-338637468', 09:33:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:36 INFO - '_': '/tools/buildbot/bin/python'} 09:33:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:37 INFO - Downloading/unpacking jsonschema==2.5.1 09:33: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:33: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:33: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:33: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:33:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:33:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:33:38 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:33:38 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:33:38 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:33:38 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:33:38 INFO - Downloading functools32-3.2.3-2.tar.gz 09:33:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:33:38 INFO - warning: no files found matching '*.txt' 09:33:38 INFO - no previously-included directories found matching 'build' 09:33:38 INFO - no previously-included directories found matching 'dist' 09:33:38 INFO - no previously-included directories found matching '.git*' 09:33:38 INFO - Installing collected packages: jsonschema, functools32 09:33:38 INFO - Running setup.py install for functools32 09:33:38 INFO - warning: no files found matching '*.txt' 09:33:38 INFO - no previously-included directories found matching 'build' 09:33:38 INFO - no previously-included directories found matching 'dist' 09:33:38 INFO - no previously-included directories found matching '.git*' 09:33:38 INFO - Successfully installed jsonschema functools32 09:33:38 INFO - Cleaning up... 09:33:38 INFO - Return code: 0 09:33:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:33: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:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33: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:33:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:38 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 0x13793b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1553a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f7dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f4840>, '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 0x16f5740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f5bd0>, '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': '20e666a3d4cfbb71505a330e000001b4-1496327515.119291-338637468', '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:33:38 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:33:38 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:33:38 INFO - Using env: {'DISPLAY': ':0', 09:33:38 INFO - 'HOME': '/home/cltbld', 09:33:38 INFO - 'LANG': 'en_US.UTF-8', 09:33:38 INFO - 'LANGUAGE': 'en_US:en', 09:33:38 INFO - 'LOGNAME': 'cltbld', 09:33:38 INFO - 'MAIL': '/var/mail/cltbld', 09:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:38 INFO - 'MOZ_NO_REMOTE': '1', 09:33:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:38 INFO - 'NO_EM_RESTART': '1', 09:33:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:38 INFO - 'PWD': '/builds/slave/test', 09:33:38 INFO - 'SHELL': '/bin/bash', 09:33:38 INFO - 'SHLVL': '1', 09:33:38 INFO - 'TERM': 'linux', 09:33:38 INFO - 'TMOUT': '86400', 09:33:38 INFO - 'USER': 'cltbld', 09:33:38 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1496327515.119291-338637468', 09:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:38 INFO - '_': '/tools/buildbot/bin/python'} 09:33:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:33:38 INFO - Cleaning up... 09:33:38 INFO - Return code: 0 09:33:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:33: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:33:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33: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:33:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:38 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 0x13793b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1553a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f7dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f4840>, '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 0x16f5740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f5bd0>, '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': '20e666a3d4cfbb71505a330e000001b4-1496327515.119291-338637468', '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:33:38 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:33:38 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:33:38 INFO - Using env: {'DISPLAY': ':0', 09:33:38 INFO - 'HOME': '/home/cltbld', 09:33:38 INFO - 'LANG': 'en_US.UTF-8', 09:33:38 INFO - 'LANGUAGE': 'en_US:en', 09:33:38 INFO - 'LOGNAME': 'cltbld', 09:33:38 INFO - 'MAIL': '/var/mail/cltbld', 09:33:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:38 INFO - 'MOZ_NO_REMOTE': '1', 09:33:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:38 INFO - 'NO_EM_RESTART': '1', 09:33:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:38 INFO - 'PWD': '/builds/slave/test', 09:33:38 INFO - 'SHELL': '/bin/bash', 09:33:38 INFO - 'SHLVL': '1', 09:33:38 INFO - 'TERM': 'linux', 09:33:38 INFO - 'TMOUT': '86400', 09:33:38 INFO - 'USER': 'cltbld', 09:33:38 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1496327515.119291-338637468', 09:33:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:38 INFO - '_': '/tools/buildbot/bin/python'} 09:33:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:38 INFO - Downloading/unpacking blobuploader==1.2.4 09:33:38 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:33:38 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:33:38 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:33:38 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:33:40 INFO - Downloading blobuploader-1.2.4.tar.gz 09:33:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:33:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:33:40 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:33:40 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:33:40 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:33:40 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:33:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:33:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:33:40 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:33:40 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:33:40 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:33:40 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:33:40 INFO - Downloading docopt-0.6.1.tar.gz 09:33:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:33:40 INFO - Installing collected packages: blobuploader, requests, docopt 09:33:40 INFO - Running setup.py install for blobuploader 09:33:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:33:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:33:40 INFO - Running setup.py install for requests 09:33:41 INFO - Running setup.py install for docopt 09:33:41 INFO - Successfully installed blobuploader requests docopt 09:33:41 INFO - Cleaning up... 09:33:41 INFO - Return code: 0 09:33:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33: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:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33: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:33:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:41 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 0x13793b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1553a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f7dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f4840>, '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 0x16f5740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f5bd0>, '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': '20e666a3d4cfbb71505a330e000001b4-1496327515.119291-338637468', '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:33:41 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:33:41 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:33:41 INFO - Using env: {'DISPLAY': ':0', 09:33:41 INFO - 'HOME': '/home/cltbld', 09:33:41 INFO - 'LANG': 'en_US.UTF-8', 09:33:41 INFO - 'LANGUAGE': 'en_US:en', 09:33:41 INFO - 'LOGNAME': 'cltbld', 09:33:41 INFO - 'MAIL': '/var/mail/cltbld', 09:33:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:41 INFO - 'MOZ_NO_REMOTE': '1', 09:33:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:41 INFO - 'NO_EM_RESTART': '1', 09:33:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:41 INFO - 'PWD': '/builds/slave/test', 09:33:41 INFO - 'SHELL': '/bin/bash', 09:33:41 INFO - 'SHLVL': '1', 09:33:41 INFO - 'TERM': 'linux', 09:33:41 INFO - 'TMOUT': '86400', 09:33:41 INFO - 'USER': 'cltbld', 09:33:41 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1496327515.119291-338637468', 09:33:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:41 INFO - '_': '/tools/buildbot/bin/python'} 09:33:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:33:41 INFO - Running setup.py (path:/tmp/pip-rsSzLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:33:41 INFO - Running setup.py (path:/tmp/pip-ZUY4hy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:33:41 INFO - Running setup.py (path:/tmp/pip-bhPrLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:33:41 INFO - Running setup.py (path:/tmp/pip-edEqRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:33:41 INFO - Running setup.py (path:/tmp/pip-orKxLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:33:41 INFO - Running setup.py (path:/tmp/pip-QwpXvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:33:41 INFO - Running setup.py (path:/tmp/pip-YTQCW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:33:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:33:41 INFO - Running setup.py (path:/tmp/pip-XD4WHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:33:42 INFO - Running setup.py (path:/tmp/pip-hYf7Qr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:33:42 INFO - Running setup.py (path:/tmp/pip-V_IDjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:33:42 INFO - Running setup.py (path:/tmp/pip-NLNpxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:33:42 INFO - Running setup.py (path:/tmp/pip-AlDJxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:33:42 INFO - Running setup.py (path:/tmp/pip-Nr95HQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:33:42 INFO - Running setup.py (path:/tmp/pip-aBE6X6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:42 INFO - Running setup.py (path:/tmp/pip-_9pvoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:33:42 INFO - Running setup.py (path:/tmp/pip-TV9gwk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:33:42 INFO - Running setup.py (path:/tmp/pip-uXsZ2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:33:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:33:42 INFO - Running setup.py install for manifestparser 09:33:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:33:42 INFO - Running setup.py install for mozcrash 09:33:42 INFO - Running setup.py install for mozdebug 09:33:42 INFO - Running setup.py install for mozdevice 09:33:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:33:43 INFO - Running setup.py install for mozfile 09:33:43 INFO - Running setup.py install for mozhttpd 09:33:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:33:43 INFO - Running setup.py install for mozinfo 09:33:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:33:43 INFO - Running setup.py install for mozInstall 09:33:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:33:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:33:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:33:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:33:43 INFO - Running setup.py install for mozleak 09:33:43 INFO - Running setup.py install for mozlog 09:33:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:33:43 INFO - Running setup.py install for moznetwork 09:33:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:33:43 INFO - Running setup.py install for mozprocess 09:33:43 INFO - Running setup.py install for mozprofile 09:33:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:33:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:33:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:33:43 INFO - Running setup.py install for mozrunner 09:33:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:33:44 INFO - Running setup.py install for mozscreenshot 09:33:44 INFO - Running setup.py install for moztest 09:33:44 INFO - Running setup.py install for mozversion 09:33:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:33:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:33:44 INFO - Cleaning up... 09:33:44 INFO - Return code: 0 09:33:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33: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:33:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33: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:33:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:44 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 0x13793b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1553a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f7dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f4840>, '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 0x16f5740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f5bd0>, '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': '20e666a3d4cfbb71505a330e000001b4-1496327515.119291-338637468', '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:33:44 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:33:44 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:33:44 INFO - Using env: {'DISPLAY': ':0', 09:33:44 INFO - 'HOME': '/home/cltbld', 09:33:44 INFO - 'LANG': 'en_US.UTF-8', 09:33:44 INFO - 'LANGUAGE': 'en_US:en', 09:33:44 INFO - 'LOGNAME': 'cltbld', 09:33:44 INFO - 'MAIL': '/var/mail/cltbld', 09:33:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:44 INFO - 'MOZ_NO_REMOTE': '1', 09:33:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:44 INFO - 'NO_EM_RESTART': '1', 09:33:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:44 INFO - 'PWD': '/builds/slave/test', 09:33:44 INFO - 'SHELL': '/bin/bash', 09:33:44 INFO - 'SHLVL': '1', 09:33:44 INFO - 'TERM': 'linux', 09:33:44 INFO - 'TMOUT': '86400', 09:33:44 INFO - 'USER': 'cltbld', 09:33:44 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1496327515.119291-338637468', 09:33:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:44 INFO - '_': '/tools/buildbot/bin/python'} 09:33:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:33:44 INFO - Running setup.py (path:/tmp/pip-YU2zYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:33:44 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:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:33:44 INFO - Running setup.py (path:/tmp/pip-gwBTc8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:33:44 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:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:33:44 INFO - Running setup.py (path:/tmp/pip-Lo0bgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:33:44 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:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:33:44 INFO - Running setup.py (path:/tmp/pip-Ia6xpc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:33:44 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:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:33:44 INFO - Running setup.py (path:/tmp/pip-w5nkTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:33:45 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:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:33:45 INFO - Running setup.py (path:/tmp/pip-CHzKLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:33:45 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:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:33:45 INFO - Running setup.py (path:/tmp/pip-fSBuck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:33:45 INFO - Running setup.py (path:/tmp/pip-lmHGJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:33:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:33:45 INFO - Running setup.py (path:/tmp/pip-oBgtyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:33:45 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:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:33:45 INFO - Running setup.py (path:/tmp/pip-3VHHzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:33:45 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:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:33:45 INFO - Running setup.py (path:/tmp/pip-7V20Tg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:33:45 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:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:33:45 INFO - Running setup.py (path:/tmp/pip-VdmJjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:33:45 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:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:33:45 INFO - Running setup.py (path:/tmp/pip-lJH3jf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:33:45 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:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:33:45 INFO - Running setup.py (path:/tmp/pip-tijaTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:33:45 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:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:45 INFO - Running setup.py (path:/tmp/pip-CEtF4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:45 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:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:33:45 INFO - Running setup.py (path:/tmp/pip-QAiO8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:33:45 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:33:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:33:45 INFO - Running setup.py (path:/tmp/pip-vcTr3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:33:45 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:33:45 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:33:45 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:33:45 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:33:45 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:33:45 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:33:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:33:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:33:46 INFO - Downloading blessings-1.6.tar.gz 09:33:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:33:47 INFO - Installing collected packages: blessings 09:33:47 INFO - Running setup.py install for blessings 09:33:47 INFO - Successfully installed blessings 09:33:47 INFO - Cleaning up... 09:33:47 INFO - Return code: 0 09:33:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:33:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:33:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:33:47 INFO - Reading from file tmpfile_stdout 09:33:47 INFO - Current package versions: 09:33:47 INFO - argparse == 1.2.1 09:33:47 INFO - blessings == 1.6 09:33:47 INFO - blobuploader == 1.2.4 09:33:47 INFO - docopt == 0.6.1 09:33:47 INFO - functools32 == 3.2.3-2 09:33:47 INFO - jsonschema == 2.5.1 09:33:47 INFO - manifestparser == 1.1 09:33:47 INFO - mozInstall == 1.12 09:33:47 INFO - mozcrash == 1.0 09:33:47 INFO - mozdebug == 0.1 09:33:47 INFO - mozdevice == 0.51 09:33:47 INFO - mozfile == 1.2 09:33:47 INFO - mozhttpd == 0.7 09:33:47 INFO - mozinfo == 0.9 09:33:47 INFO - mozleak == 0.1 09:33:47 INFO - mozlog == 3.4 09:33:47 INFO - moznetwork == 0.27 09:33:47 INFO - mozprocess == 0.25 09:33:47 INFO - mozprofile == 0.28 09:33:47 INFO - mozrunner == 6.13 09:33:47 INFO - mozscreenshot == 0.1 09:33:47 INFO - mozsystemmonitor == 0.3 09:33:47 INFO - moztest == 0.8 09:33:47 INFO - mozversion == 1.4 09:33:47 INFO - psutil == 3.1.1 09:33:47 INFO - requests == 1.2.3 09:33:47 INFO - wsgiref == 0.1.2 09:33:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:47 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 0x13793b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1553a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f7dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f4840>, '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 0x16f5740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f5bd0>, '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': '20e666a3d4cfbb71505a330e000001b4-1496327515.119291-338637468', '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:33:47 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:33:47 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:33:47 INFO - Using env: {'DISPLAY': ':0', 09:33:47 INFO - 'HOME': '/home/cltbld', 09:33:47 INFO - 'LANG': 'en_US.UTF-8', 09:33:47 INFO - 'LANGUAGE': 'en_US:en', 09:33:47 INFO - 'LOGNAME': 'cltbld', 09:33:47 INFO - 'MAIL': '/var/mail/cltbld', 09:33:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:47 INFO - 'MOZ_NO_REMOTE': '1', 09:33:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:47 INFO - 'NO_EM_RESTART': '1', 09:33:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:47 INFO - 'PWD': '/builds/slave/test', 09:33:47 INFO - 'SHELL': '/bin/bash', 09:33:47 INFO - 'SHLVL': '1', 09:33:47 INFO - 'TERM': 'linux', 09:33:47 INFO - 'TMOUT': '86400', 09:33:47 INFO - 'USER': 'cltbld', 09:33:47 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1496327515.119291-338637468', 09:33:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:47 INFO - '_': '/tools/buildbot/bin/python'} 09:33:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:47 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:33:47 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:33:47 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:33:47 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:33:47 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:33:47 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:33:47 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:33:47 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:33:47 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:33:47 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:33:47 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:33:47 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:33:47 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:33:47 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:33:48 INFO - Downloading marionette_driver-1.4.0.tar.gz 09:33:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 09:33:48 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:33:48 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:33:48 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:33:48 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:33:48 INFO - Installing collected packages: marionette-driver 09:33:48 INFO - Running setup.py install for marionette-driver 09:33:48 INFO - Successfully installed marionette-driver 09:33:48 INFO - Cleaning up... 09:33:48 INFO - Return code: 0 09:33:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:33:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:48 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 0x13793b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1553a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16f7dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f4840>, '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 0x16f5740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f5bd0>, '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': '20e666a3d4cfbb71505a330e000001b4-1496327515.119291-338637468', '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:33:49 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:33:49 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:33:49 INFO - Using env: {'DISPLAY': ':0', 09:33:49 INFO - 'HOME': '/home/cltbld', 09:33:49 INFO - 'LANG': 'en_US.UTF-8', 09:33:49 INFO - 'LANGUAGE': 'en_US:en', 09:33:49 INFO - 'LOGNAME': 'cltbld', 09:33:49 INFO - 'MAIL': '/var/mail/cltbld', 09:33:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:49 INFO - 'MOZ_NO_REMOTE': '1', 09:33:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:33:49 INFO - 'NO_EM_RESTART': '1', 09:33:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:33:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:49 INFO - 'PWD': '/builds/slave/test', 09:33:49 INFO - 'SHELL': '/bin/bash', 09:33:49 INFO - 'SHLVL': '1', 09:33:49 INFO - 'TERM': 'linux', 09:33:49 INFO - 'TMOUT': '86400', 09:33:49 INFO - 'USER': 'cltbld', 09:33:49 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1496327515.119291-338637468', 09:33:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:49 INFO - '_': '/tools/buildbot/bin/python'} 09:33:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:33:49 INFO - Cleaning up... 09:33:49 INFO - Return code: 0 09:33:49 INFO - Running post-action listener: _resource_record_post_action 09:33:49 INFO - Running post-action listener: _start_resource_monitoring 09:33:49 INFO - Starting resource monitoring. 09:33:49 INFO - [mozharness: 2017-06-01 16:33:49.253463Z] Finished create-virtualenv step (success) 09:33:49 INFO - [mozharness: 2017-06-01 16:33:49.253975Z] Running install step. 09:33:49 INFO - Running pre-action listener: _resource_record_pre_action 09:33:49 INFO - Running main action method: install 09:33:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:33:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:33:49 INFO - Reading from file tmpfile_stdout 09:33:49 INFO - Detecting whether we're running mozinstall >=1.0... 09:33:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:33:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:33:49 INFO - Reading from file tmpfile_stdout 09:33:49 INFO - Output received: 09:33:49 INFO - Usage: mozinstall [options] installer 09:33:49 INFO - Options: 09:33:49 INFO - -h, --help show this help message and exit 09:33:49 INFO - -d DEST, --destination=DEST 09:33:49 INFO - Directory to install application into. [default: 09:33:49 INFO - "/builds/slave/test"] 09:33:49 INFO - --app=APP Application being installed. [default: firefox] 09:33:49 INFO - mkdir: /builds/slave/test/build/application 09:33:49 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:33:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:34:06 INFO - Reading from file tmpfile_stdout 09:34:06 INFO - Output received: 09:34:06 INFO - /builds/slave/test/build/application/firefox/firefox 09:34:06 INFO - Running post-action listener: _resource_record_post_action 09:34:06 INFO - [mozharness: 2017-06-01 16:34:06.129301Z] Finished install step (success) 09:34:06 INFO - [mozharness: 2017-06-01 16:34:06.129581Z] Running setup-mitmproxy step. 09:34:06 INFO - Running pre-action listener: _resource_record_pre_action 09:34:06 INFO - Running main action method: setup_mitmproxy 09:34:06 INFO - Skipping: mitmproxy is not required 09:34:06 INFO - Running post-action listener: _resource_record_post_action 09:34:06 INFO - [mozharness: 2017-06-01 16:34:06.130813Z] Finished setup-mitmproxy step (success) 09:34:06 INFO - [mozharness: 2017-06-01 16:34:06.131033Z] Running run-tests step. 09:34:06 INFO - Running pre-action listener: _resource_record_pre_action 09:34:06 INFO - Running main action method: run_tests 09:34:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:34:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:34:06 INFO - Python 2.7.3 09:34:06 INFO - Return code: 0 09:34:06 INFO - grabbing minidump binary from tooltool 09:34:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:34:06 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 0x16f4840>, '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 0x16f5740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f5bd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:34:06 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:34:06 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:34:06 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:34:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:34:06 INFO - Return code: 0 09:34:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:34:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:34:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:34:06 INFO - ENV: RUST_BACKTRACE is now 1 09:34:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:34:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:34:06 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/BrxE3naNRfiJs9uQ0VKz8Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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:34:06 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/BrxE3naNRfiJs9uQ0VKz8Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-015 --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:34:06 INFO - Using env: {'DISPLAY': ':0', 09:34:06 INFO - 'HOME': '/home/cltbld', 09:34:06 INFO - 'LANG': 'en_US.UTF-8', 09:34:06 INFO - 'LANGUAGE': 'en_US:en', 09:34:06 INFO - 'LOGNAME': 'cltbld', 09:34:06 INFO - 'MAIL': '/var/mail/cltbld', 09:34:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:34:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:34:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:06 INFO - 'MOZ_NO_REMOTE': '1', 09:34:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:34:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:34:06 INFO - 'NO_EM_RESTART': '1', 09:34:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:34:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:06 INFO - 'PWD': '/builds/slave/test', 09:34:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:34:06 INFO - 'RUST_BACKTRACE': '1', 09:34:06 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:34:06 INFO - 'SHELL': '/bin/bash', 09:34:06 INFO - 'SHLVL': '1', 09:34:06 INFO - 'TERM': 'linux', 09:34:06 INFO - 'TMOUT': '86400', 09:34:06 INFO - 'USER': 'cltbld', 09:34:06 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1496327515.119291-338637468', 09:34:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:06 INFO - '_': '/tools/buildbot/bin/python'} 09:34:06 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/BrxE3naNRfiJs9uQ0VKz8Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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:34:06 INFO - mozversion application_buildid: 20170601155445 09:34:06 INFO - mozversion application_changeset: 62005e6aecdf95c9cffe5fb825d93123ec49c4b3 09:34:06 INFO - mozversion application_display_name: Nightly 09:34:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:34:06 INFO - mozversion application_name: Firefox 09:34:06 INFO - mozversion application_remotingname: firefox 09:34:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:34:06 INFO - mozversion application_vendor: Mozilla 09:34:06 INFO - mozversion application_version: 55.0a1 09:34:06 INFO - mozversion platform_buildid: 20170601155445 09:34:06 INFO - mozversion platform_changeset: 62005e6aecdf95c9cffe5fb825d93123ec49c4b3 09:34:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:34:06 INFO - mozversion platform_version: 55.0a1 09:34:06 INFO - using testdate: 1496334846 09:34:06 INFO - actual date: 1496334846 09:34:06 INFO - starting webserver on 'localhost:45092' 09:34:06 INFO - SUITE-START | Running 2 tests 09:34:06 INFO - TEST-START | dromaeo_css 09:34:06 INFO - operating with platform_type : linux_ 09:34:06 INFO - Initialising browser for dromaeo_css test... 09:34:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45092/getInfo.html -profile /tmp/tmpaynOxD/profile 09:34:06 INFO - TEST-INFO | started process 26303 (/builds/slave/test/build/application/firefox/firefox http://localhost:45092/getInfo.html) 09:34:41 INFO - TEST-INFO | 26303: killed by SIGTERM 09:34:41 INFO - Browser initialized. 09:34:41 INFO - Running cycle 1/1 for dromaeo_css test... 09:34:41 INFO - TEST-INFO | started process 26529 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaynOxD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:34:53 INFO - PID 26529 | RSS: Main: 188121088 09:34:53 INFO - PID 26529 | 09:37:58 INFO - PID 26529 | Cycle 1(1): loaded http://localhost:45092/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45092/tests/dromaeo/cssquery-ext.html) 09:37:59 INFO - PID 26529 | RSS: Main: 183787520 09:37:59 INFO - PID 26529 | 09:41:01 INFO - PID 26529 | Cycle 1(1): loaded http://localhost:45092/tests/dromaeo/cssquery-ext.html (next: http://localhost:45092/tests/dromaeo/cssquery-jquery.html) 09:41:02 INFO - PID 26529 | RSS: Main: 189489152 09:41:02 INFO - PID 26529 | 09:44:04 INFO - PID 26529 | Cycle 1(1): loaded http://localhost:45092/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45092/tests/dromaeo/cssquery-mootools.html) 09:44:04 INFO - PID 26529 | RSS: Main: 186466304 09:44:04 INFO - PID 26529 | 09:47:06 INFO - PID 26529 | Cycle 1(1): loaded http://localhost:45092/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45092/tests/dromaeo/cssquery-prototype.html) 09:47:07 INFO - PID 26529 | RSS: Main: 190148608 09:47:07 INFO - PID 26529 | 09:50:10 INFO - PID 26529 | Cycle 1(1): loaded http://localhost:45092/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45092/tests/dromaeo/cssquery-yui.html) 09:50:11 INFO - PID 26529 | RSS: Main: 189079552 09:50:11 INFO - PID 26529 | 09:53:13 INFO - PID 26529 | Cycle 1(1): loaded http://localhost:45092/tests/dromaeo/cssquery-yui.html (next: http://localhost:45092/tests/dromaeo/cssquery-dojo.html) 09:53:13 INFO - PID 26529 | RSS: Main: 186564608 09:53:13 INFO - PID 26529 | 09:53:13 INFO - PID 26529 | __start_tp_report 09:53:13 INFO - PID 26529 | _x_x_mozilla_page_load 09:53:13 INFO - PID 26529 | _x_x_mozilla_page_load_details 09:53:13 INFO - PID 26529 | |i|pagename|runs| 09:53:13 INFO - PID 26529 | |0;dojo.html;2730.2628290361604;2753.187809596169;2764.3780149466374;2773.292810333365;2783.4293969736204;5188.247704082905;5309.044372013036;5346.893062138755;5358.142697168454;5367.382750983638;5255;5295.4969277918535;5315.3887302960175;5370.194470829378;5402.8919421611545;4426.247537918562;4659.464161621423;4716.221823399135;4748.240281554952;4751.382320298357;4799.904001919959;4819.7590120494015;4833.081714474239;4854.417469903617;4886.51134886512;4619.16854966106;4683.508231635663;4728.6453515986095;4753.47711751707;4774.665773395864;4711.929321060187;4723.149833030053;4726.5746082852365;4757.429108506966;4777.617790576745;4672.6261899047995;4693.694909830884;4697.342372067913;4703.576678098988;4721.409823772028;5163.40620828602;5241.082810508184;5281.128613778722;5302.337207849019;5317.096093664087;5721.056025755745;5764.596478246524;5824.970875145639;5837.241158649391;5842.737076831553;5815.563832712522;5828.0966450200285;5833.183354330397;5834.124881267801;5839.270091238595;5391.002664507078;5391.029614669319;5398.082326004589;5401;5408.621396502207;5674.120511320752;5737.627054241461;5764.020116580192;5902.881942361215;6028.065649824284;5572.554195664337;5577.6932268724795;5627.915581266284;5640.32316122068;5672.205891175238;5620.1288800236025;5745.626534275259;5748.511376532958;5748.993926062923;5755.625884317506;5619.831405057773;5690.9430905690415;5704.657720536781;5727.11229759388;5731.8567035824435;5710.971445142748;5757.88484230313;5790.073588225863;5814.3313518945015;5822.592418530662;4818.614510839195;4834;4835.709857408567;4840.1287768201355;4868.732219727878;4041.090754580196;4127.979360103241;4129.607687269765;4131.710780245354;4149.771762553089;4810.542998415145;4826.831060912921;4856.053069651454;4856.660033797671;4907.656464047483;5803.506701930383;5808.041673123887;5830.242068531149;5847.093700476433;5882;4843.2735089736825;4845.370101886732;4846.854594362175;4850.5149485051215;4891.1685013547785;4992.201247800334;5069.847904562869;5103.3110530077965;5114.514121158484;5125.436202017775;5319.547838433777;5359.14253719403;5380.192971054373;5382.138857782736;5390.595705322038;5635.351934527582;5722.513586345207;5729;5799.5070419014855;5808.5643576732755;5221.269022336952;5233.188855727369;5265.131253343308;5285.048691235615;5336.119540275811;5538.141588053858;5607.271054762855;5689.943100568941;5715.799947001835;5718.971405142947;5742.023855944416;5758.424157584208;5794.971025144847;5827.446392592697;5863.912041319299;5450.5367043801725;5470.17947307907;5488.862778430571;5494.752736126964;5552.97223513896;5468.4531546845;5470.671759694431;5471.2887324647545;5495.890082198413;5509.118541033416;5404.135338345845;5421.295231619864;5500.917486237629;5509.531689806411;5585.916211256753;5593.384727680033;5600.60795744294;5621.831345059655;5639.210510528611;5647.096464565814;5426.213199086189;5433.157860531624;5437.510624043855;5442.972785136049;5444.754986025559 09:53:13 INFO - PID 26529 | |1;ext.html;743.2678811370798;765.8430021845522;969.4231932000457;983.1741337276686;1211.9272843629378;31920.521192182106;33168.834155829245;33177;33183.66816331836;33211.83394083026;32118.518222226685;32492.512612310835;32499.187520312003;32508.424073351973;32531.83734081326;6420.518461115412;6444.097826304321;6574.769883054094;6622.470202383822;6660.067590537305;6597;6694.631795251259;6723.260441351447;6743.190817101955;6748.426383757386;6690.431313338372;6692.330766923293;6725.865482690343;6728.83177920551;6761.560498567577;6616.834579135512;6660.433863121592;6667.066610674461;6695.096162018114;6701.29636388182;6614.503912206604;6623.3045530219115;6660.700268487882;6693.866122677519;6711.765088221889;31244.531332030037;31310.37379252402;31314.21714457134;31441.37117257642;31501.36997260065;2995.8052726572705;3013.442513135055;3033.605631267943;3035.5598438226334;3040.0727778027695;24738.50522989548;24758.25725228228;24839.130630427848;24855.87572062128;24861.129860454796;2555.6166575013713;2564.666593342872;2575.896964121433;2584.2505673354704;2595.4809038192247;146054.26972865174;146207.26896365557;146326;146405;146564;30010.099697009126;30463.847680761453;38503.422448663296;38921.22157556833;40809.387859182134;41382.79308603438;41413;41452.79273603613;41498.79250603728;41530.58469415267;10320;10409.375437473624;10438.947805260925;10451.425171615634;10455.21585881062;7956.124826269106;7993.360531157494;7994.68021279154;8020.679172833022;8024.117347091816;12601.621951341474;12668.556600518938;12696;12711.300878451773;12801.551945681857;5277.498637629419;5308.522232999048;5317.973410133002;5327.280817089721;5404.54061404785;845.1970627903394;882.9470231785984;892.4288455388556;905.8233644439402;926.8887733472027;20005.899970500053;20280;20905.686414703792;20938.685919711217;21216.575668486854;954.9856752148723;961.2166084641135;979.6816034788723;983.1741337276721;988.2785566536469;10329.586816527404;10983.39591322485;11015.504302306415;11087.72280692973;11244.718882028015;176915;178631;178813;179565;179775;40200.39699404511;40358.79820600878;40571.59428405737;40637.79681101635;40694;1148.6898537394857;1190.4166958190597;1192.8568571771443;1198.34091249814;1198.5086114692933;18032.90983545074;18304.542386440444;18729;18900.462848251165;18954.147063382457;28363.574546382235;28402.147935561967;28461.861525539574;28507.144785656463;28527.857360713893;148781;149749;149939;150073.24963375114;150941.24529377284;25795.355116122246;25845;28044;29466.410671786874;29751.107466776033;36637.450438242915;36794.816025919696;36981.445278321386;37150.25699485941;37163.07092322713;26880.462390752466;27647.617619119366;27752.44495110046;27851.164465066082;28448;27040;27724.30689232785;27765.44469110647;28542.85728571344;28886.133415997552;31060;31064.534031989086;31117.8444107778;31132;31215.84392078025;26250;26357.868210658824;26880.73119268782;27424.862875685492;27640.723592763814;21507;22660.206892759335;22700.416879104876;22869;22892 09:53:13 INFO - PID 26529 | |2;jquery.html;407.3035109961965;412.1818190891083;420.67607941884756;429.2381023682962;440.89859332353564;12135.939320303409;12713.23720576766;17285.827141728594;17828.910855445705;17978.10109494525;16728.41450549231;17468.388606398777;17473.65052698945;17495.650086998252;17567.385141520048;5479.150731636592;5669.603127781057;5686.9146962795385;5697.914531282034;5715.371309155989;5055.898882022376;5399.7030163341;5566.526845218162;5640.407757185498;5651.717414129277;5310.07073762092;5345.973270133663;5359.517643412111;5369.463053694639;5371.167469042285;5348.705821179834;5368.865778355553;5372.650777699437;5372.865678358034;5382.4886635769535;4849.733264670442;4855.247436647325;4857.052874689437;4870.902581948377;4877.073356062372;21916.342509724574;22366.552668946693;22425.887870560706;22483.55032899333;22498.43753906149;1634.8610368118725;1688.0209478502438;1708.8462038416603;1712.3749831311607;1721.1996421663862;14790.482333118396;15017.24913754308;15041.398344066225;15057.924710376488;15091.622709432242;1931.8357939575153;1945.5816999345068;1968.1733671857853;1970.9605807883906;1979.0599465254033;102131.48934255356;103589.48205258926;104370.47814760878;104808.99999999924;104842;10113.898861011443;10887.945560272306;10952.430904177507;10988;11480.498447973448;15764.290606922716;15778.289976951064;15789.131597762233;15832.445864394691;15840.207989600474;6939.883335582595;6943.618101004493;7037.2962703730245;7089.468289878177;7092.645367731593;6232.158658581124;6238.157848690369;6318.905216421757;6330.651814150174;6379.776707815297;6775.1531058617675;7029.472789540805;7062.6821793019435;7113.288671132846;7142.714291428389;2016.4555569996019;2049.6574743543;2061.8556701030784;2069.88615626139;2130.2224687988773;824.1140773668211;855.8801767752519;877.6216453411199;903.3631289940577;906.5603182456504;17369.65260694779;17390.47828565145;17482.213300401512;17520.29918803259;17872.87224735666;873.6068769053951;881.0572687224608;885;885.291766586728;885.4156256870564;9193.862092068624;11294.322340659586;12292.139550231397;12345;12379.133460657667;383280;396828;398618;399332;404668;91489.54255228814;93716;93826;94022;95054;1059.247933966892;1064.446487826326;1096.703889949725;1106.2311693373028;1107.5625128074366;18391.81608183901;18481.72277415813;19211.039448027263;19296.938668373376;19465.610687786448;44902.77548612367;45792.54207457883;46118.76940615275;46130.30957523457;47869;57202.7139864298;57211.427885722274;57317.42682573121;57594.42405576058;58429.415705842395;8989.865152022594;9302.674406395743;9701.126898579161;9833.16418104469;9835.311528192959;15583.688326233638;15762.527124186292;15763.290651920463;15799.447019354267;15802.36790528412;13107;13152.539661111816;13239.735205296032;13243.80134297967;13256.270905100311;10702.785944280915;11042.33745975244;11917.82123268169;12075.335856527976;12131.150819442908;13857;14081.788773168206;14149.221792801494;14304.57086287413;14339.139651620937;9327.207187388876;9339.252859771337;9344.626214951326;9416.764580885532;9579.808403832023;12637.304948227937;12736.23582585048;12736.426860791102;12793.61619151427;12793.872061279268 09:53:13 INFO - PID 26529 | |3;mootools.html;1255.403683250456;1321.1676643714459;1324.6622111361607;1332.4603535568099;1344.6369480240335;10301.124404425624;10607.893921060788;10873.891261087387;10885.074768644674;10895.346279223251;10726.195535334862;10990;11009.559617615307;11012.559497620106;11020.338779673206;2073.42980680313;2123.8725676459385;2124.352072617851;2125.224293133003;2131.968020479694;2176.923807666732;2211.8562293450873;2217.623004089309;2218.6671999200166;2220.134147682405;2110.113752224062;2146.6887301341294;2148.0870629982196;2158.4927542027613;2161.7730138335482;2063.8142567168875;2076.1280262289874;2090.247510896076;2091.6130515854616;2092.591944570809;1817.9636407271912;1888.5656299051295;1944.8930308833008;2124.5007423255524;2217.623004089309;10626.36241825493;10727.731806704816;10746.623868164656;10754.731131721692;10759.193060520493;4728.503507131736;4830.879228019293;4860.854174374775;4862.489438608931;4880.487548807359;3206.615206175274;3259.9348013039607;3348.28011977426;3396.235846934445;3445.13871532117;1016.4460369098858;1036.3160314192671;1055.155875299757;1060.6446840308429;1088.172988528716;15523.844761552353;15660.843391565939;15733.292001859943;15828.050316981018;15873.206339682969;4557.361969324297;4631.212693842055;4764.665893549812;4767.666263361601;4802.615790736732;11596.76806463866;11690.064794816395;11692.766144677058;11705.88294117065;11724.237924534878;5162.251473536391;5328.600354973392;5343.893122137535;5347.331583552056;5363.785448582091;4844.878878028007;4912.975435122873;4916.8770780730765;4922.655414121049;4941.25881117828;3963.4938723284968;3993.820278087493;4023.517177938666;4039.7374170678813;4077.9796101019897;1126.9943650281696;1138.1350173867754;1143.085531574737;1145.7651181507772;1149.1496292743477;703;713.4470785141453;716.6022857314241;721.7004942948722;731.2687312687312;5445.863853403617;5537.8061767837935;5593.636413633101;5706.343770466367;5729.427057294237;494.868859752166;511.8464460661861;513.1404896797923;513.3249776543832;515.0574448758837;3870.013146647643;3988.1824226033596;3996.780177090288;4035.233305671913;4061.0862555925273;13495.730085398238;14073.577792666236;14392.280385980659;14396.568102956928;14478.131312121306;13921.30393480322;14095.929520352538;14174;14184.078034927697;14195.006349555431;6556.8360790980605;6804.353586409283;6838.794836154923;6846.4522838172825;7080.327368899946;5870.442307980735;5935.080062590306;5991.430814072656;6000.51995840323;6067.12026756109;12164.330961797186;12337.814932775836;12367.134300598871;12408.131430799758;12434.12961092751;12840.743185136433;12864.614061578168;12942.223466592035;13007.609771706864;13316.866831331563;8261.710840120568;8374.790630234293;8412.411131221;8423.241908228289;8437.114103019094;9564.61741530331;9592.568334425107;9638.325317227727;9764.60767112062;9975.401475911469;8646.308295336232;8655.48067115975;8679.826403472021;8762.737117886474;8846.513441760508;8371.790705232417;8468.407211495136;8488.278496327881;8513.616887239965;8644.870326944974;7413.555186688816;7498.437617178624;7540.849183016199;7561.584112873845;7572.053493313336;4432;5290.497402746733;5379.757910894097;5380.11228147367;5412.377576578587;5428.83713488596;5444.3194600674915;5465.344158700981;5535.612507124623;5593.9440605595055 09:53:13 INFO - PID 26529 | |4;prototype.html;346.3989977389231;351.2921463251549;356.1452513966482;356.6059504247806;362.2519497238202;5534.197541356501;5589.329280486342;5620.859478513039;5622.634528755628;5629.211910332547;5434.347878254605;5443.1835224716315;5485.232067510552;5486.533644640211;5505.256790333304;3973.562908080109;4095.283325418055;4109.732867363612;4140.171965606875;4154.543000269968;4123.422720819088;4139.337705967046;4141.088960428701;4144.626983571478;4154.8961275968195;4083.2650122977852;4100.774457404841;4107.753534787922;4111.136661301115;4113.300738874384;4097.8770636880945;4103.584263429112;4106.630403263721;4119.320312148522;4122.649574786146;3547.2373439710586;3601.873934412283;3609.0871837925943;3616;3620.2578471413563;5383.246345511592;5383.650062745948;5393.78424863005;5395;5397.433269506684;4852.902941941142;4860.854174374739;4879.82920597781;4880.731559764212;4886.682365646222;5797.768089276424;5818.621789583706;5824.126381042835;5831.387704291031;5849.649021058707;4062.9593704062877;4087.5299340575916;4089.161721847014;4089.8364065437345;4094.856680016215;5887.558433117533;6101.633901965896;6152.261728592597;6212.81361559154;6238.4697300729495;4083.7549747015273;4119.176164766998;4151.73730316978;4152.709310348247;4163.437935878678;4207.389928460418;4208.747475151501;4213.894652633709;4217.62041416274;4221.767802770877;4714.669973101919;4842.297866809293;4845.878853028703;4848;4852.80588776445;5755.453231942959;5775.191473193756;5784.132380143013;5786.71066446676;5790;1430.4635761589404;1443.4947768281017;1448.876845468126;1450.4633285684154;1457.227669335254;953.7186529973675;965.5654955270156;986.5313975861409;988.0613417253638;992.3202606214766;5004.299398084271;5019.749012549358;5019.899602007939;5040.722760248148;5043.193089105725;5998.820035398945;6038.969805150946;6049.485793707496;6050.334463209044;6074.51403887688;4966.850994470172;4975.850724478271;4987.700737955734;5001.524855138829;5004.674696144739;3193.9041828745176;3215.405150047202;3217.260030193022;3225.661305562929;3241.303119829201;5522.9447705523235;5525.530329922001;5539.612227144142;5572.442755724395;5576.860578485489;6204.658743769046;6208.751649933952;6214.906776398358;6228.5017198624;6269.247690277196;5568.832935011957;5572.693501857437;5586.357568879468;5597.440255974451;5604;6017.789377371771;6038.305594856648;6092.939070609237;6101.786437474667;6126.448619624255;5949.2266005419015;5958.821235362946;5972.462478376967;5978.790742323998;5981.581289309881;5217.843464696065;5333.813316533902;5477.863053423696;5556.194351819045;5575.693336866511;4130.731502452331;4155.750654960712;4163.791810409407;4164.355079743424;4166.375043743342;6024.1265016573225;6036.577439579188;6039.698015099315;6043.456088952015;6064.636121832704;5634.4365563443325;5814.970925145347;5822.76708931655;5824.679642619697;5828.125781132864;5810.970945145247;5815.651060936358;5824.009918313982;5873.735681894411;5876.911846322223;5775.249217601685;5789.205346342479;5795.623284486495;5796.565257605781;5813.273340832396;5895.204147440212;5896.9115463268945;5899.734511947058;5905.586608937333;5941.465268125889;5714.771409143587;5731.799387021434;5733.627314224562;5739.8565035874435;5762.423757624204 09:53:13 INFO - PID 26529 | |5;yui.html;645.6674812471575;649.2663290481755;700.0094865764943;703.4513079797757;720.1502227371701;11318.32090074595;12081.275123492596;12126.333051682153;13403.798943015838;14431.494897678584;13723;13733.244671543061;13881.09772864763;13904.860951390483;13912.51306204283;867.1848462445297;878.8286284174588;879.8196369744219;883.0727735877335;883.8541640629288;865.1694373401542;886.2422628652506;889.2219308105408;889.7731078574955;896.735463038402;928.3826255540058;929.0894922975488;929.2658799548349;930.50683137937;930.9255259579218;913.4930113786845;913.6482454255126;914.7850255190025;915.8671992561042;916.3356566489308;672.2907332763932;672.3008071605573;672.5762769455212;675.6925598852511;676.5162908520432;13645;13659.86340136596;13678.110922789987;13704.10923289983;13727.107737996997;14513.492027778977;14689.485867994568;14970.326335314938;15022.399104035825;15039.473618423412;11468.770624587545;11765;11851;12078.335691536962;12273.079519036019;3016.472117379472;3036.1195253376495;3041.832699201543;3045.923851903698;3061.479548476764;75938.62030689811;87034.56482717546;87399.12600874036;87864;88729.55635221847;12262.754744905053;12371.257724536557;12517.687057823445;12590.685232869067;12591.685207869694;21260.893695531424;22195.223167189393;22451.55096898053;22493.4376640582;22504.88747556252;6356.586821856657;6388.872222555616;6394.71223794921;6398.328175541595;6405.391487808651;2896.0443053792196;2936.603558519615;3050.176452357851;3063.326068264978;3070.5547695584464;3482.4776283557667;3561.0919215599856;3586.964130358715;3588.049166970755;3597.2985267873037;720.6000669628406;726.5422783646269;728.1517032657001;728.8724473217165;731.0897932074602;532.4276402866933;565.5729923907505;567.1832561111986;573.2061095382842;575.91937128802;9284.582193801296;9807.901920980841;9865.556049977768;10099.69700908974;10211.795764084676;537.4356925228494;541.4742552254236;545.9653955753824;546.3471151973354;560.7560711090689;4196;4219.615917006881;4225.197212529671;4265.4881414230495;4289;71509.64245178844;74387;74458.6277068622;76189.6190519055;82024.58987705024;62021.37978620156;63054;63340;64091;65693;57483;58870.70564647149;59038;60469.69765151146;61120;9137;9163.258980793627;9363.578638961399;9460.148586626961;9553.713388598353;27691.55456539041;28078.578821318104;28128.71871281343;28180.71819281863;29260.122196334145;33783.15542111368;33976.490352644236;33998.49002264919;34601.307973840885;34656.133596659274;11904.761904761683;12082;12233.571824986082;12237.26576405383;12399.814002790146;13696.589102326947;13747;13801.930990344985;13885.51400701011;14078.296085195903;12786.808197877226;13057.673558161123;13233.933830330787;13249.403776830259;13397.06220564551;12958;13228.47086116583;13395.665108372368;13503.324833758077;13541.526046588717;13064.673383165496;13076.869231307946;13269.601911942656;13323.467061317438;13494.460221591027;8832.602532886163;8891.422057566237;8999.415038022507;9205.171534561654;9422.152006319464;10258.640947566799;10650.573977041142;10706.464676765974;10846.783064338826;11290.209685321948 09:53:13 INFO - PID 26529 | __end_tp_report 09:53:13 INFO - PID 26529 | __start_cc_report 09:53:13 INFO - PID 26529 | _x_x_mozilla_cycle_collect,383 09:53:13 INFO - PID 26529 | __end_cc_report 09:53:13 INFO - PID 26529 | __startTimestamp1496335993259__endTimestamp 09:53:13 INFO - PID 26529 | 09:53:13 INFO - PID 26529 | ------- Summary: start ------- 09:53:13 INFO - PID 26529 | Number of tests: 6 09:53:13 INFO - PID 26529 | 09:53:13 INFO - PID 26529 | [#0] dojo.html Cycles:165 Average:5239.21 Median:5401.00 stddev:621.60 (11.5%) stddev-sans-first:591.53 09:53:13 INFO - PID 26529 | Values: 2730.3 2753.2 2764.4 2773.3 2783.4 5188.2 5309.0 5346.9 5358.1 5367.4 5255.0 5295.5 5315.4 5370.2 5402.9 4426.2 4659.5 4716.2 4748.2 4751.4 4799.9 4819.8 4833.1 4854.4 4886.5 4619.2 4683.5 4728.6 4753.5 4774.7 4711.9 4723.1 4726.6 4757.4 4777.6 4672.6 4693.7 4697.3 4703.6 4721.4 5163.4 5241.1 5281.1 5302.3 5317.1 5721.1 5764.6 5825.0 5837.2 5842.7 5815.6 5828.1 5833.2 5834.1 5839.3 5391.0 5391.0 5398.1 5401.0 5408.6 5674.1 5737.6 5764.0 5902.9 6028.1 5572.6 5577.7 5627.9 5640.3 5672.2 5620.1 5745.6 5748.5 5749.0 5755.6 5619.8 5690.9 5704.7 5727.1 5731.9 5711.0 5757.9 5790.1 5814.3 5822.6 4818.6 4834.0 4835.7 4840.1 4868.7 4041.1 4128.0 4129.6 4131.7 4149.8 4810.5 4826.8 4856.1 4856.7 4907.7 5803.5 5808.0 5830.2 5847.1 5882.0 4843.3 4845.4 4846.9 4850.5 4891.2 4992.2 5069.8 5103.3 5114.5 5125.4 5319.5 5359.1 5380.2 5382.1 5390.6 5635.4 5722.5 5729.0 5799.5 5808.6 5221.3 5233.2 5265.1 5285.0 5336.1 5538.1 5607.3 5689.9 5715.8 5719.0 5742.0 5758.4 5795.0 5827.4 5863.9 5450.5 5470.2 5488.9 5494.8 5553.0 5468.5 5470.7 5471.3 5495.9 5509.1 5404.1 5421.3 5500.9 5509.5 5585.9 5593.4 5600.6 5621.8 5639.2 5647.1 5426.2 5433.2 5437.5 5443.0 5444.8 09:53:13 INFO - PID 26529 | 09:53:13 INFO - PID 26529 | [#1] ext.html Cycles:180 Average:29808.69 Median:3037.82 stddev:41084.40 (1352.4%) stddev-sans-first:41141.68 09:53:13 INFO - PID 26529 | Values: 743.3 765.8 969.4 983.2 1211.9 31920.5 33168.8 33177.0 33183.7 33211.8 32118.5 32492.5 32499.2 32508.4 32531.8 6420.5 6444.1 6574.8 6622.5 6660.1 6597.0 6694.6 6723.3 6743.2 6748.4 6690.4 6692.3 6725.9 6728.8 6761.6 6616.8 6660.4 6667.1 6695.1 6701.3 6614.5 6623.3 6660.7 6693.9 6711.8 31244.5 31310.4 31314.2 31441.4 31501.4 2995.8 3013.4 3033.6 3035.6 3040.1 24738.5 24758.3 24839.1 24855.9 24861.1 2555.6 2564.7 2575.9 2584.3 2595.5 146054.3 146207.3 146326.0 146405.0 146564.0 30010.1 30463.8 38503.4 38921.2 40809.4 41382.8 41413.0 41452.8 41498.8 41530.6 10320.0 10409.4 10438.9 10451.4 10455.2 7956.1 7993.4 7994.7 8020.7 8024.1 12601.6 12668.6 12696.0 12711.3 12801.6 5277.5 5308.5 5318.0 5327.3 5404.5 845.2 882.9 892.4 905.8 926.9 20005.9 20280.0 20905.7 20938.7 21216.6 955.0 961.2 979.7 983.2 988.3 10329.6 10983.4 11015.5 11087.7 11244.7 176915.0 178631.0 178813.0 179565.0 179775.0 40200.4 40358.8 40571.6 40637.8 40694.0 1148.7 1190.4 1192.9 1198.3 1198.5 18032.9 18304.5 18729.0 18900.5 18954.1 28363.6 28402.1 28461.9 28507.1 28527.9 148781.0 149749.0 149939.0 150073.2 150941.2 25795.4 25845.0 28044.0 29466.4 29751.1 36637.5 36794.8 36981.4 37150.3 37163.1 26880.5 27647.6 27752.4 27851.2 28448.0 27040.0 27724.3 27765.4 28542.9 28886.1 31060.0 31064.5 31117.8 31132.0 31215.8 26250.0 26357.9 26880.7 27424.9 27640.7 21507.0 22660.2 22700.4 22869.0 22892.0 09:53:13 INFO - PID 26529 | 09:53:13 INFO - PID 26529 | [#2] jquery.html Cycles:180 Average:27365.09 Median:22396.22 stddev:66684.20 (297.7%) stddev-sans-first:66840.55 09:53:13 INFO - PID 26529 | Values: 407.3 412.2 420.7 429.2 440.9 12135.9 12713.2 17285.8 17828.9 17978.1 16728.4 17468.4 17473.7 17495.7 17567.4 5479.2 5669.6 5686.9 5697.9 5715.4 5055.9 5399.7 5566.5 5640.4 5651.7 5310.1 5346.0 5359.5 5369.5 5371.2 5348.7 5368.9 5372.7 5372.9 5382.5 4849.7 4855.2 4857.1 4870.9 4877.1 21916.3 22366.6 22425.9 22483.6 22498.4 1634.9 1688.0 1708.8 1712.4 1721.2 14790.5 15017.2 15041.4 15057.9 15091.6 1931.8 1945.6 1968.2 1971.0 1979.1 102131.5 103589.5 104370.5 104809.0 104842.0 10113.9 10887.9 10952.4 10988.0 11480.5 15764.3 15778.3 15789.1 15832.4 15840.2 6939.9 6943.6 7037.3 7089.5 7092.6 6232.2 6238.2 6318.9 6330.7 6379.8 6775.2 7029.5 7062.7 7113.3 7142.7 2016.5 2049.7 2061.9 2069.9 2130.2 824.1 855.9 877.6 903.4 906.6 17369.7 17390.5 17482.2 17520.3 17872.9 873.6 881.1 885.0 885.3 885.4 9193.9 11294.3 12292.1 12345.0 12379.1 383280.0 396828.0 398618.0 399332.0 404668.0 91489.5 93716.0 93826.0 94022.0 95054.0 1059.2 1064.4 1096.7 1106.2 1107.6 18391.8 18481.7 19211.0 19296.9 19465.6 44902.8 45792.5 46118.8 46130.3 47869.0 57202.7 57211.4 57317.4 57594.4 58429.4 8989.9 9302.7 9701.1 9833.2 9835.3 15583.7 15762.5 15763.3 15799.4 15802.4 13107.0 13152.5 13239.7 13243.8 13256.3 10702.8 11042.3 11917.8 12075.3 12131.2 13857.0 14081.8 14149.2 14304.6 14339.1 9327.2 9339.3 9344.6 9416.8 9579.8 12637.3 12736.2 12736.4 12793.6 12793.9 09:53:13 INFO - PID 26529 | 09:53:13 INFO - PID 26529 | [#3] mootools.html Cycles:180 Average:6435.77 Median:3916.75 stddev:4332.42 (110.6%) stddev-sans-first:4327.09 09:53:13 INFO - PID 26529 | Values: 1255.4 1321.2 1324.7 1332.5 1344.6 10301.1 10607.9 10873.9 10885.1 10895.3 10726.2 10990.0 11009.6 11012.6 11020.3 2073.4 2123.9 2124.4 2125.2 2132.0 2176.9 2211.9 2217.6 2218.7 2220.1 2110.1 2146.7 2148.1 2158.5 2161.8 2063.8 2076.1 2090.2 2091.6 2092.6 1818.0 1888.6 1944.9 2124.5 2217.6 10626.4 10727.7 10746.6 10754.7 10759.2 4728.5 4830.9 4860.9 4862.5 4880.5 3206.6 3259.9 3348.3 3396.2 3445.1 1016.4 1036.3 1055.2 1060.6 1088.2 15523.8 15660.8 15733.3 15828.1 15873.2 4557.4 4631.2 4764.7 4767.7 4802.6 11596.8 11690.1 11692.8 11705.9 11724.2 5162.3 5328.6 5343.9 5347.3 5363.8 4844.9 4913.0 4916.9 4922.7 4941.3 3963.5 3993.8 4023.5 4039.7 4078.0 1127.0 1138.1 1143.1 1145.8 1149.1 703.0 713.4 716.6 721.7 731.3 5445.9 5537.8 5593.6 5706.3 5729.4 494.9 511.8 513.1 513.3 515.1 3870.0 3988.2 3996.8 4035.2 4061.1 13495.7 14073.6 14392.3 14396.6 14478.1 13921.3 14095.9 14174.0 14184.1 14195.0 6556.8 6804.4 6838.8 6846.5 7080.3 5870.4 5935.1 5991.4 6000.5 6067.1 12164.3 12337.8 12367.1 12408.1 12434.1 12840.7 12864.6 12942.2 13007.6 13316.9 8261.7 8374.8 8412.4 8423.2 8437.1 9564.6 9592.6 9638.3 9764.6 9975.4 8646.3 8655.5 8679.8 8762.7 8846.5 8371.8 8468.4 8488.3 8513.6 8644.9 7413.6 7498.4 7540.8 7561.6 7572.1 4432.0 5290.5 5379.8 5380.1 5412.4 5428.8 5444.3 5465.3 5535.6 5593.9 09:53:13 INFO - PID 26529 | 09:53:13 INFO - PID 26529 | [#4] prototype.html Cycles:180 Average:4791.75 Median:5485.88 stddev:1431.22 (26.1%) stddev-sans-first:1395.80 09:53:13 INFO - PID 26529 | Values: 346.4 351.3 356.1 356.6 362.3 5534.2 5589.3 5620.9 5622.6 5629.2 5434.3 5443.2 5485.2 5486.5 5505.3 3973.6 4095.3 4109.7 4140.2 4154.5 4123.4 4139.3 4141.1 4144.6 4154.9 4083.3 4100.8 4107.8 4111.1 4113.3 4097.9 4103.6 4106.6 4119.3 4122.6 3547.2 3601.9 3609.1 3616.0 3620.3 5383.2 5383.7 5393.8 5395.0 5397.4 4852.9 4860.9 4879.8 4880.7 4886.7 5797.8 5818.6 5824.1 5831.4 5849.6 4063.0 4087.5 4089.2 4089.8 4094.9 5887.6 6101.6 6152.3 6212.8 6238.5 4083.8 4119.2 4151.7 4152.7 4163.4 4207.4 4208.7 4213.9 4217.6 4221.8 4714.7 4842.3 4845.9 4848.0 4852.8 5755.5 5775.2 5784.1 5786.7 5790.0 1430.5 1443.5 1448.9 1450.5 1457.2 953.7 965.6 986.5 988.1 992.3 5004.3 5019.7 5019.9 5040.7 5043.2 5998.8 6039.0 6049.5 6050.3 6074.5 4966.9 4975.9 4987.7 5001.5 5004.7 3193.9 3215.4 3217.3 3225.7 3241.3 5522.9 5525.5 5539.6 5572.4 5576.9 6204.7 6208.8 6214.9 6228.5 6269.2 5568.8 5572.7 5586.4 5597.4 5604.0 6017.8 6038.3 6092.9 6101.8 6126.4 5949.2 5958.8 5972.5 5978.8 5981.6 5217.8 5333.8 5477.9 5556.2 5575.7 4130.7 4155.8 4163.8 4164.4 4166.4 6024.1 6036.6 6039.7 6043.5 6064.6 5634.4 5815.0 5822.8 5824.7 5828.1 5811.0 5815.7 5824.0 5873.7 5876.9 5775.2 5789.2 5795.6 5796.6 5813.3 5895.2 5896.9 5899.7 5905.6 5941.5 5714.8 5731.8 5733.6 5739.9 5762.4 09:53:13 INFO - PID 26529 | 09:53:13 INFO - PID 26529 | [#5] yui.html Cycles:180 Average:16109.98 Median:3592.67 stddev:21245.95 (591.4%) stddev-sans-first:21273.82 09:53:13 INFO - PID 26529 | Values: 645.7 649.3 700.0 703.5 720.2 11318.3 12081.3 12126.3 13403.8 14431.5 13723.0 13733.2 13881.1 13904.9 13912.5 867.2 878.8 879.8 883.1 883.9 865.2 886.2 889.2 889.8 896.7 928.4 929.1 929.3 930.5 930.9 913.5 913.6 914.8 915.9 916.3 672.3 672.3 672.6 675.7 676.5 13645.0 13659.9 13678.1 13704.1 13727.1 14513.5 14689.5 14970.3 15022.4 15039.5 11468.8 11765.0 11851.0 12078.3 12273.1 3016.5 3036.1 3041.8 3045.9 3061.5 75938.6 87034.6 87399.1 87864.0 88729.6 12262.8 12371.3 12517.7 12590.7 12591.7 21260.9 22195.2 22451.6 22493.4 22504.9 6356.6 6388.9 6394.7 6398.3 6405.4 2896.0 2936.6 3050.2 3063.3 3070.6 3482.5 3561.1 3587.0 3588.0 3597.3 720.6 726.5 728.2 728.9 731.1 532.4 565.6 567.2 573.2 575.9 9284.6 9807.9 9865.6 10099.7 10211.8 537.4 541.5 546.0 546.3 560.8 4196.0 4219.6 4225.2 4265.5 4289.0 71509.6 74387.0 74458.6 76189.6 82024.6 62021.4 63054.0 63340.0 64091.0 65693.0 57483.0 58870.7 59038.0 60469.7 61120.0 9137.0 9163.3 9363.6 9460.1 9553.7 27691.6 28078.6 28128.7 28180.7 29260.1 33783.2 33976.5 33998.5 34601.3 34656.1 11904.8 12082.0 12233.6 12237.3 12399.8 13696.6 13747.0 13801.9 13885.5 14078.3 12786.8 13057.7 13233.9 13249.4 13397.1 12958.0 13228.5 13395.7 13503.3 13541.5 13064.7 13076.9 13269.6 13323.5 13494.5 8832.6 8891.4 8999.4 9205.2 9422.2 10258.6 10650.6 10706.5 10846.8 11290.2 09:53:13 INFO - PID 26529 | -------- Summary: end -------- 09:53:13 INFO - PID 26529 | 09:53:14 INFO - TEST-INFO | 26529: exit 0 09:53:14 INFO - TEST-OK | dromaeo_css | took 1147793ms 09:53:14 INFO - TEST-START | kraken 09:53:14 INFO - operating with platform_type : linux_ 09:53:14 INFO - Initialising browser for kraken test... 09:53:14 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:45092/getInfo.html -profile /tmp/tmpFhx2As/profile 09:53:14 INFO - TEST-INFO | started process 26957 (/builds/slave/test/build/application/firefox/firefox http://localhost:45092/getInfo.html) 09:53:49 INFO - TEST-INFO | 26957: killed by SIGTERM 09:53:49 INFO - Browser initialized. 09:53:49 INFO - Running cycle 1/1 for kraken test... 09:53:49 INFO - TEST-INFO | started process 27187 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFhx2As/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:54:01 INFO - PID 27187 | RSS: Main: 188297216 09:54:01 INFO - PID 27187 | 09:54:03 INFO - PID 27187 | Cycle 1(1): loaded http://localhost:45092/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45092/tests/kraken/driver.html?testName=audio-beat-detection) 09:54:05 INFO - PID 27187 | RSS: Main: 191893504 09:54:05 INFO - PID 27187 | 09:54:07 INFO - PID 27187 | Cycle 1(1): loaded http://localhost:45092/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45092/tests/kraken/driver.html?testName=audio-dft) 09:54:08 INFO - PID 27187 | RSS: Main: 190218240 09:54:08 INFO - PID 27187 | 09:54:11 INFO - PID 27187 | Cycle 1(1): loaded http://localhost:45092/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45092/tests/kraken/driver.html?testName=audio-fft) 09:54:11 INFO - PID 27187 | RSS: Main: 186052608 09:54:11 INFO - PID 27187 | 09:54:14 INFO - PID 27187 | Cycle 1(1): loaded http://localhost:45092/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45092/tests/kraken/driver.html?testName=audio-oscillator) 09:54:14 INFO - PID 27187 | RSS: Main: 186257408 09:54:14 INFO - PID 27187 | 09:54:16 INFO - PID 27187 | Cycle 1(1): loaded http://localhost:45092/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45092/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:54:17 INFO - PID 27187 | RSS: Main: 186761216 09:54:17 INFO - PID 27187 | 09:54:20 INFO - PID 27187 | Cycle 1(1): loaded http://localhost:45092/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45092/tests/kraken/driver.html?testName=imaging-darkroom) 09:54:21 INFO - PID 27187 | RSS: Main: 188129280 09:54:21 INFO - PID 27187 | 09:54:24 INFO - PID 27187 | Cycle 1(1): loaded http://localhost:45092/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45092/tests/kraken/driver.html?testName=imaging-desaturate) 09:54:25 INFO - PID 27187 | RSS: Main: 186662912 09:54:25 INFO - PID 27187 | 09:54:28 INFO - PID 27187 | Cycle 1(1): loaded http://localhost:45092/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45092/tests/kraken/driver.html?testName=json-parse-financial) 09:54:28 INFO - PID 27187 | RSS: Main: 187437056 09:54:28 INFO - PID 27187 | 09:54:30 INFO - PID 27187 | Cycle 1(1): loaded http://localhost:45092/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45092/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:54:31 INFO - PID 27187 | RSS: Main: 187523072 09:54:31 INFO - PID 27187 | 09:54:33 INFO - PID 27187 | Cycle 1(1): loaded http://localhost:45092/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45092/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:54:33 INFO - PID 27187 | RSS: Main: 187461632 09:54:33 INFO - PID 27187 | 09:54:36 INFO - PID 27187 | Cycle 1(1): loaded http://localhost:45092/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45092/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:54:36 INFO - PID 27187 | RSS: Main: 187310080 09:54:36 INFO - PID 27187 | 09:54:39 INFO - PID 27187 | Cycle 1(1): loaded http://localhost:45092/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45092/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:54:40 INFO - PID 27187 | RSS: Main: 187170816 09:54:40 INFO - PID 27187 | 09:54:43 INFO - PID 27187 | Cycle 1(1): loaded http://localhost:45092/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45092/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:54:44 INFO - PID 27187 | RSS: Main: 187056128 09:54:44 INFO - PID 27187 | 09:54:45 INFO - PID 27187 | Cycle 1(1): loaded http://localhost:45092/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45092/tests/kraken/driver.html?testName=ai-astar) 09:54:46 INFO - PID 27187 | RSS: Main: 188432384 09:54:46 INFO - PID 27187 | 09:54:46 INFO - PID 27187 | __start_tp_report 09:54:46 INFO - PID 27187 | _x_x_mozilla_page_load 09:54:46 INFO - PID 27187 | _x_x_mozilla_page_load_details 09:54:46 INFO - PID 27187 | |i|pagename|runs| 09:54:46 INFO - PID 27187 | |0;ai-astar;103;111;112;109;110;110;112;109;118;111 09:54:46 INFO - PID 27187 | |1;audio-beat-detection;147;135;123;168;124;123;122;123;147;123 09:54:46 INFO - PID 27187 | |2;audio-dft;167;166;166;167;170;168;184;165;164;165 09:54:46 INFO - PID 27187 | |3;audio-fft;75;74;74;110;77;74;74;74;93;79 09:54:46 INFO - PID 27187 | |4;audio-oscillator;84;83;99;89;83;82;98;83;83;106 09:54:46 INFO - PID 27187 | |5;imaging-gaussian-blur;113;117;113;114;113;114;114;114;114;114 09:54:46 INFO - PID 27187 | |6;imaging-darkroom;153;152;155;155;153;154;152;152;152;152 09:54:46 INFO - PID 27187 | |7;imaging-desaturate;95;95;94;95;96;100;95;95;94;95 09:54:46 INFO - PID 27187 | |8;json-parse-financial;55;56;60;56;56;57;58;60;58;58 09:54:46 INFO - PID 27187 | |9;json-stringify-tinderbox;55;55;58;57;57;60;56;55;56;55 09:54:46 INFO - PID 27187 | |10;stanford-crypto-aes;87;90;87;89;92;89;88;97;119;86 09:54:46 INFO - PID 27187 | |11;stanford-crypto-ccm;130;155;141;135;135;140;134;129;135;141 09:54:46 INFO - PID 27187 | |12;stanford-crypto-pbkdf2;186;203;198;189;197;197;197;202;199;214 09:54:46 INFO - PID 27187 | |13;stanford-crypto-sha256-iterative;72;74;79;73;74;77;72;71;73;71 09:54:46 INFO - PID 27187 | __end_tp_report 09:54:46 INFO - PID 27187 | __start_cc_report 09:54:46 INFO - PID 27187 | _x_x_mozilla_cycle_collect,1027 09:54:46 INFO - PID 27187 | __end_cc_report 09:54:46 INFO - PID 27187 | __startTimestamp1496336086162__endTimestamp 09:54:46 INFO - PID 27187 | 09:54:46 INFO - PID 27187 | ------- Summary: start ------- 09:54:46 INFO - PID 27187 | Number of tests: 14 09:54:46 INFO - PID 27187 | 09:54:46 INFO - PID 27187 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:3.69 (3.3%) stddev-sans-first:2.74 09:54:46 INFO - PID 27187 | Values: 103.0 111.0 112.0 109.0 110.0 110.0 112.0 109.0 118.0 111.0 09:54:46 INFO - PID 27187 | 09:54:46 INFO - PID 27187 | [#1] audio-beat-detection Cycles:10 Average:133.50 Median:129.50 stddev:15.71 (12.1%) stddev-sans-first:15.88 09:54:46 INFO - PID 27187 | Values: 147.0 135.0 123.0 168.0 124.0 123.0 122.0 123.0 147.0 123.0 09:54:46 INFO - PID 27187 | 09:54:46 INFO - PID 27187 | [#2] audio-dft Cycles:10 Average:168.20 Median:167.00 stddev:5.81 (3.5%) stddev-sans-first:6.14 09:54:46 INFO - PID 27187 | Values: 167.0 166.0 166.0 167.0 170.0 168.0 184.0 165.0 164.0 165.0 09:54:46 INFO - PID 27187 | 09:54:46 INFO - PID 27187 | [#3] audio-fft Cycles:10 Average:80.40 Median:74.50 stddev:11.94 (16.0%) stddev-sans-first:12.50 09:54:46 INFO - PID 27187 | Values: 75.0 74.0 74.0 110.0 77.0 74.0 74.0 74.0 93.0 79.0 09:54:46 INFO - PID 27187 | 09:54:46 INFO - PID 27187 | [#4] audio-oscillator Cycles:10 Average:89.00 Median:83.50 stddev:8.74 (10.5%) stddev-sans-first:9.08 09:54:46 INFO - PID 27187 | Values: 84.0 83.0 99.0 89.0 83.0 82.0 98.0 83.0 83.0 106.0 09:54:46 INFO - PID 27187 | 09:54:46 INFO - PID 27187 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:1.15 (1.0%) stddev-sans-first:1.17 09:54:46 INFO - PID 27187 | Values: 113.0 117.0 113.0 114.0 113.0 114.0 114.0 114.0 114.0 114.0 09:54:46 INFO - PID 27187 | 09:54:46 INFO - PID 27187 | [#6] imaging-darkroom Cycles:10 Average:153.00 Median:153.00 stddev:1.25 (0.8%) stddev-sans-first:1.32 09:54:46 INFO - PID 27187 | Values: 153.0 152.0 155.0 155.0 153.0 154.0 152.0 152.0 152.0 152.0 09:54:46 INFO - PID 27187 | 09:54:46 INFO - PID 27187 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:1.71 (1.8%) stddev-sans-first:1.81 09:54:46 INFO - PID 27187 | Values: 95.0 95.0 94.0 95.0 96.0 100.0 95.0 95.0 94.0 95.0 09:54:46 INFO - PID 27187 | 09:54:46 INFO - PID 27187 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:58.00 stddev:1.71 (3.0%) stddev-sans-first:1.58 09:54:46 INFO - PID 27187 | Values: 55.0 56.0 60.0 56.0 56.0 57.0 58.0 60.0 58.0 58.0 09:54:46 INFO - PID 27187 | 09:54:46 INFO - PID 27187 | [#9] json-stringify-tinderbox Cycles:10 Average:56.40 Median:56.50 stddev:1.65 (2.9%) stddev-sans-first:1.67 09:54:46 INFO - PID 27187 | Values: 55.0 55.0 58.0 57.0 57.0 60.0 56.0 55.0 56.0 55.0 09:54:46 INFO - PID 27187 | 09:54:46 INFO - PID 27187 | [#10] stanford-crypto-aes Cycles:10 Average:92.40 Median:89.00 stddev:9.87 (11.1%) stddev-sans-first:10.27 09:54:46 INFO - PID 27187 | Values: 87.0 90.0 87.0 89.0 92.0 89.0 88.0 97.0 119.0 86.0 09:54:46 INFO - PID 27187 | 09:54:46 INFO - PID 27187 | [#11] stanford-crypto-ccm Cycles:10 Average:137.50 Median:137.50 stddev:7.43 (5.4%) stddev-sans-first:7.37 09:54:46 INFO - PID 27187 | Values: 130.0 155.0 141.0 135.0 135.0 140.0 134.0 129.0 135.0 141.0 09:54:46 INFO - PID 27187 | 09:54:46 INFO - PID 27187 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:198.20 Median:198.50 stddev:7.64 (3.8%) stddev-sans-first:6.71 09:54:46 INFO - PID 27187 | Values: 186.0 203.0 198.0 189.0 197.0 197.0 197.0 202.0 199.0 214.0 09:54:46 INFO - PID 27187 | 09:54:46 INFO - PID 27187 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.60 Median:73.50 stddev:2.59 (3.5%) stddev-sans-first:2.68 09:54:46 INFO - PID 27187 | Values: 72.0 74.0 79.0 73.0 74.0 77.0 72.0 71.0 73.0 71.0 09:54:46 INFO - PID 27187 | -------- Summary: end -------- 09:54:46 INFO - PID 27187 | 09:54:47 INFO - TEST-INFO | 27187: exit 0 09:54:47 INFO - TEST-OK | kraken | took 93193ms 09:54:47 INFO - SUITE-END | took 1240s 09:54:47 INFO - Completed test suite (00:20:41) 09:54:47 INFO - javascript benchmark 09:54:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6732.462645732184, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2730.2628290361604, 2753.187809596169, 2764.3780149466374, 2773.292810333365, 2783.4293969736204, 5188.247704082905, 5309.044372013036, 5346.893062138755, 5358.142697168454, 5367.382750983638, 5255.0, 5295.4969277918535, 5315.3887302960175, 5370.194470829378, 5402.8919421611545, 4426.247537918562, 4659.464161621423, 4716.221823399135, 4748.240281554952, 4751.382320298357, 4799.904001919959, 4819.7590120494015, 4833.081714474239, 4854.417469903617, 4886.51134886512, 4619.16854966106, 4683.508231635663, 4728.6453515986095, 4753.47711751707, 4774.665773395864, 4711.929321060187, 4723.149833030053, 4726.5746082852365, 4757.429108506966, 4777.617790576745, 4672.6261899047995, 4693.694909830884, 4697.342372067913, 4703.576678098988, 4721.409823772028, 5163.40620828602, 5241.082810508184, 5281.128613778722, 5302.337207849019, 5317.096093664087, 5721.056025755745, 5764.596478246524, 5824.970875145639, 5837.241158649391, 5842.737076831553, 5815.563832712522, 5828.0966450200285, 5833.183354330397, 5834.124881267801, 5839.270091238595, 5391.002664507078, 5391.029614669319, 5398.082326004589, 5401.0, 5408.621396502207, 5674.120511320752, 5737.627054241461, 5764.020116580192, 5902.881942361215, 6028.065649824284, 5572.554195664337, 5577.6932268724795, 5627.915581266284, 5640.32316122068, 5672.205891175238, 5620.1288800236025, 5745.626534275259, 5748.511376532958, 5748.993926062923, 5755.625884317506, 5619.831405057773, 5690.9430905690415, 5704.657720536781, 5727.11229759388, 5731.8567035824435, 5710.971445142748, 5757.88484230313, 5790.073588225863, 5814.3313518945015, 5822.592418530662, 4818.614510839195, 4834.0, 4835.709857408567, 4840.1287768201355, 4868.732219727878, 4041.090754580196, 4127.979360103241, 4129.607687269765, 4131.710780245354, 4149.771762553089, 4810.542998415145, 4826.831060912921, 4856.053069651454, 4856.660033797671, 4907.656464047483, 5803.506701930383, 5808.041673123887, 5830.242068531149, 5847.093700476433, 5882.0, 4843.2735089736825, 4845.370101886732, 4846.854594362175, 4850.5149485051215, 4891.1685013547785, 4992.201247800334, 5069.847904562869, 5103.3110530077965, 5114.514121158484, 5125.436202017775, 5319.547838433777, 5359.14253719403, 5380.192971054373, 5382.138857782736, 5390.595705322038, 5635.351934527582, 5722.513586345207, 5729.0, 5799.5070419014855, 5808.5643576732755, 5221.269022336952, 5233.188855727369, 5265.131253343308, 5285.048691235615, 5336.119540275811, 5538.141588053858, 5607.271054762855, 5689.943100568941, 5715.799947001835, 5718.971405142947, 5742.023855944416, 5758.424157584208, 5794.971025144847, 5827.446392592697, 5863.912041319299, 5450.5367043801725, 5470.17947307907, 5488.862778430571, 5494.752736126964, 5552.97223513896, 5468.4531546845, 5470.671759694431, 5471.2887324647545, 5495.890082198413, 5509.118541033416, 5404.135338345845, 5421.295231619864, 5500.917486237629, 5509.531689806411, 5585.916211256753, 5593.384727680033, 5600.60795744294, 5621.831345059655, 5639.210510528611, 5647.096464565814, 5426.213199086189, 5433.157860531624, 5437.510624043855, 5442.972785136049, 5444.754986025559], "value": 5193.772750859121, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.2678811370798, 765.8430021845522, 969.4231932000457, 983.1741337276686, 1211.9272843629378, 31920.521192182106, 33168.834155829245, 33177.0, 33183.66816331836, 33211.83394083026, 32118.518222226685, 32492.512612310835, 32499.187520312003, 32508.424073351973, 32531.83734081326, 6420.518461115412, 6444.097826304321, 6574.769883054094, 6622.470202383822, 6660.067590537305, 6597.0, 6694.631795251259, 6723.260441351447, 6743.190817101955, 6748.426383757386, 6690.431313338372, 6692.330766923293, 6725.865482690343, 6728.83177920551, 6761.560498567577, 6616.834579135512, 6660.433863121592, 6667.066610674461, 6695.096162018114, 6701.29636388182, 6614.503912206604, 6623.3045530219115, 6660.700268487882, 6693.866122677519, 6711.765088221889, 31244.531332030037, 31310.37379252402, 31314.21714457134, 31441.37117257642, 31501.36997260065, 2995.8052726572705, 3013.442513135055, 3033.605631267943, 3035.5598438226334, 3040.0727778027695, 24738.50522989548, 24758.25725228228, 24839.130630427848, 24855.87572062128, 24861.129860454796, 2555.6166575013713, 2564.666593342872, 2575.896964121433, 2584.2505673354704, 2595.4809038192247, 146054.26972865174, 146207.26896365557, 146326.0, 146405.0, 146564.0, 30010.099697009126, 30463.847680761453, 38503.422448663296, 38921.22157556833, 40809.387859182134, 41382.79308603438, 41413.0, 41452.79273603613, 41498.79250603728, 41530.58469415267, 10320.0, 10409.375437473624, 10438.947805260925, 10451.425171615634, 10455.21585881062, 7956.124826269106, 7993.360531157494, 7994.68021279154, 8020.679172833022, 8024.117347091816, 12601.621951341474, 12668.556600518938, 12696.0, 12711.300878451773, 12801.551945681857, 5277.498637629419, 5308.522232999048, 5317.973410133002, 5327.280817089721, 5404.54061404785, 845.1970627903394, 882.9470231785984, 892.4288455388556, 905.8233644439402, 926.8887733472027, 20005.899970500053, 20280.0, 20905.686414703792, 20938.685919711217, 21216.575668486854, 954.9856752148723, 961.2166084641135, 979.6816034788723, 983.1741337276721, 988.2785566536469, 10329.586816527404, 10983.39591322485, 11015.504302306415, 11087.72280692973, 11244.718882028015, 176915.0, 178631.0, 178813.0, 179565.0, 179775.0, 40200.39699404511, 40358.79820600878, 40571.59428405737, 40637.79681101635, 40694.0, 1148.6898537394857, 1190.4166958190597, 1192.8568571771443, 1198.34091249814, 1198.5086114692933, 18032.90983545074, 18304.542386440444, 18729.0, 18900.462848251165, 18954.147063382457, 28363.574546382235, 28402.147935561967, 28461.861525539574, 28507.144785656463, 28527.857360713893, 148781.0, 149749.0, 149939.0, 150073.24963375114, 150941.24529377284, 25795.355116122246, 25845.0, 28044.0, 29466.410671786874, 29751.107466776033, 36637.450438242915, 36794.816025919696, 36981.445278321386, 37150.25699485941, 37163.07092322713, 26880.462390752466, 27647.617619119366, 27752.44495110046, 27851.164465066082, 28448.0, 27040.0, 27724.30689232785, 27765.44469110647, 28542.85728571344, 28886.133415997552, 31060.0, 31064.534031989086, 31117.8444107778, 31132.0, 31215.84392078025, 26250.0, 26357.868210658824, 26880.73119268782, 27424.862875685492, 27640.723592763814, 21507.0, 22660.206892759335, 22700.416879104876, 22869.0, 22892.0], "value": 14025.073828894012, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [407.3035109961965, 412.1818190891083, 420.67607941884756, 429.2381023682962, 440.89859332353564, 12135.939320303409, 12713.23720576766, 17285.827141728594, 17828.910855445705, 17978.10109494525, 16728.41450549231, 17468.388606398777, 17473.65052698945, 17495.650086998252, 17567.385141520048, 5479.150731636592, 5669.603127781057, 5686.9146962795385, 5697.914531282034, 5715.371309155989, 5055.898882022376, 5399.7030163341, 5566.526845218162, 5640.407757185498, 5651.717414129277, 5310.07073762092, 5345.973270133663, 5359.517643412111, 5369.463053694639, 5371.167469042285, 5348.705821179834, 5368.865778355553, 5372.650777699437, 5372.865678358034, 5382.4886635769535, 4849.733264670442, 4855.247436647325, 4857.052874689437, 4870.902581948377, 4877.073356062372, 21916.342509724574, 22366.552668946693, 22425.887870560706, 22483.55032899333, 22498.43753906149, 1634.8610368118725, 1688.0209478502438, 1708.8462038416603, 1712.3749831311607, 1721.1996421663862, 14790.482333118396, 15017.24913754308, 15041.398344066225, 15057.924710376488, 15091.622709432242, 1931.8357939575153, 1945.5816999345068, 1968.1733671857853, 1970.9605807883906, 1979.0599465254033, 102131.48934255356, 103589.48205258926, 104370.47814760878, 104808.99999999924, 104842.0, 10113.898861011443, 10887.945560272306, 10952.430904177507, 10988.0, 11480.498447973448, 15764.290606922716, 15778.289976951064, 15789.131597762233, 15832.445864394691, 15840.207989600474, 6939.883335582595, 6943.618101004493, 7037.2962703730245, 7089.468289878177, 7092.645367731593, 6232.158658581124, 6238.157848690369, 6318.905216421757, 6330.651814150174, 6379.776707815297, 6775.1531058617675, 7029.472789540805, 7062.6821793019435, 7113.288671132846, 7142.714291428389, 2016.4555569996019, 2049.6574743543, 2061.8556701030784, 2069.88615626139, 2130.2224687988773, 824.1140773668211, 855.8801767752519, 877.6216453411199, 903.3631289940577, 906.5603182456504, 17369.65260694779, 17390.47828565145, 17482.213300401512, 17520.29918803259, 17872.87224735666, 873.6068769053951, 881.0572687224608, 885.0, 885.291766586728, 885.4156256870564, 9193.862092068624, 11294.322340659586, 12292.139550231397, 12345.0, 12379.133460657667, 383280.0, 396828.0, 398618.0, 399332.0, 404668.0, 91489.54255228814, 93716.0, 93826.0, 94022.0, 95054.0, 1059.247933966892, 1064.446487826326, 1096.703889949725, 1106.2311693373028, 1107.5625128074366, 18391.81608183901, 18481.72277415813, 19211.039448027263, 19296.938668373376, 19465.610687786448, 44902.77548612367, 45792.54207457883, 46118.76940615275, 46130.30957523457, 47869.0, 57202.7139864298, 57211.427885722274, 57317.42682573121, 57594.42405576058, 58429.415705842395, 8989.865152022594, 9302.674406395743, 9701.126898579161, 9833.16418104469, 9835.311528192959, 15583.688326233638, 15762.527124186292, 15763.290651920463, 15799.447019354267, 15802.36790528412, 13107.0, 13152.539661111816, 13239.735205296032, 13243.80134297967, 13256.270905100311, 10702.785944280915, 11042.33745975244, 11917.82123268169, 12075.335856527976, 12131.150819442908, 13857.0, 14081.788773168206, 14149.221792801494, 14304.57086287413, 14339.139651620937, 9327.207187388876, 9339.252859771337, 9344.626214951326, 9416.764580885532, 9579.808403832023, 12637.304948227937, 12736.23582585048, 12736.426860791102, 12793.61619151427, 12793.872061279268], "value": 9313.995361058614, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1255.403683250456, 1321.1676643714459, 1324.6622111361607, 1332.4603535568099, 1344.6369480240335, 10301.124404425624, 10607.893921060788, 10873.891261087387, 10885.074768644674, 10895.346279223251, 10726.195535334862, 10990.0, 11009.559617615307, 11012.559497620106, 11020.338779673206, 2073.42980680313, 2123.8725676459385, 2124.352072617851, 2125.224293133003, 2131.968020479694, 2176.923807666732, 2211.8562293450873, 2217.623004089309, 2218.6671999200166, 2220.134147682405, 2110.113752224062, 2146.6887301341294, 2148.0870629982196, 2158.4927542027613, 2161.7730138335482, 2063.8142567168875, 2076.1280262289874, 2090.247510896076, 2091.6130515854616, 2092.591944570809, 1817.9636407271912, 1888.5656299051295, 1944.8930308833008, 2124.5007423255524, 2217.623004089309, 10626.36241825493, 10727.731806704816, 10746.623868164656, 10754.731131721692, 10759.193060520493, 4728.503507131736, 4830.879228019293, 4860.854174374775, 4862.489438608931, 4880.487548807359, 3206.615206175274, 3259.9348013039607, 3348.28011977426, 3396.235846934445, 3445.13871532117, 1016.4460369098858, 1036.3160314192671, 1055.155875299757, 1060.6446840308429, 1088.172988528716, 15523.844761552353, 15660.843391565939, 15733.292001859943, 15828.050316981018, 15873.206339682969, 4557.361969324297, 4631.212693842055, 4764.665893549812, 4767.666263361601, 4802.615790736732, 11596.76806463866, 11690.064794816395, 11692.766144677058, 11705.88294117065, 11724.237924534878, 5162.251473536391, 5328.600354973392, 5343.893122137535, 5347.331583552056, 5363.785448582091, 4844.878878028007, 4912.975435122873, 4916.8770780730765, 4922.655414121049, 4941.25881117828, 3963.4938723284968, 3993.820278087493, 4023.517177938666, 4039.7374170678813, 4077.9796101019897, 1126.9943650281696, 1138.1350173867754, 1143.085531574737, 1145.7651181507772, 1149.1496292743477, 703.0, 713.4470785141453, 716.6022857314241, 721.7004942948722, 731.2687312687312, 5445.863853403617, 5537.8061767837935, 5593.636413633101, 5706.343770466367, 5729.427057294237, 494.868859752166, 511.8464460661861, 513.1404896797923, 513.3249776543832, 515.0574448758837, 3870.013146647643, 3988.1824226033596, 3996.780177090288, 4035.233305671913, 4061.0862555925273, 13495.730085398238, 14073.577792666236, 14392.280385980659, 14396.568102956928, 14478.131312121306, 13921.30393480322, 14095.929520352538, 14174.0, 14184.078034927697, 14195.006349555431, 6556.8360790980605, 6804.353586409283, 6838.794836154923, 6846.4522838172825, 7080.327368899946, 5870.442307980735, 5935.080062590306, 5991.430814072656, 6000.51995840323, 6067.12026756109, 12164.330961797186, 12337.814932775836, 12367.134300598871, 12408.131430799758, 12434.12961092751, 12840.743185136433, 12864.614061578168, 12942.223466592035, 13007.609771706864, 13316.866831331563, 8261.710840120568, 8374.790630234293, 8412.411131221, 8423.241908228289, 8437.114103019094, 9564.61741530331, 9592.568334425107, 9638.325317227727, 9764.60767112062, 9975.401475911469, 8646.308295336232, 8655.48067115975, 8679.826403472021, 8762.737117886474, 8846.513441760508, 8371.790705232417, 8468.407211495136, 8488.278496327881, 8513.616887239965, 8644.870326944974, 7413.555186688816, 7498.437617178624, 7540.849183016199, 7561.584112873845, 7572.053493313336, 4432.0, 5290.497402746733, 5379.757910894097, 5380.11228147367, 5412.377576578587, 5428.83713488596, 5444.3194600674915, 5465.344158700981, 5535.612507124623, 5593.9440605595055], "value": 4708.174833952649, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.3989977389231, 351.2921463251549, 356.1452513966482, 356.6059504247806, 362.2519497238202, 5534.197541356501, 5589.329280486342, 5620.859478513039, 5622.634528755628, 5629.211910332547, 5434.347878254605, 5443.1835224716315, 5485.232067510552, 5486.533644640211, 5505.256790333304, 3973.562908080109, 4095.283325418055, 4109.732867363612, 4140.171965606875, 4154.543000269968, 4123.422720819088, 4139.337705967046, 4141.088960428701, 4144.626983571478, 4154.8961275968195, 4083.2650122977852, 4100.774457404841, 4107.753534787922, 4111.136661301115, 4113.300738874384, 4097.8770636880945, 4103.584263429112, 4106.630403263721, 4119.320312148522, 4122.649574786146, 3547.2373439710586, 3601.873934412283, 3609.0871837925943, 3616.0, 3620.2578471413563, 5383.246345511592, 5383.650062745948, 5393.78424863005, 5395.0, 5397.433269506684, 4852.902941941142, 4860.854174374739, 4879.82920597781, 4880.731559764212, 4886.682365646222, 5797.768089276424, 5818.621789583706, 5824.126381042835, 5831.387704291031, 5849.649021058707, 4062.9593704062877, 4087.5299340575916, 4089.161721847014, 4089.8364065437345, 4094.856680016215, 5887.558433117533, 6101.633901965896, 6152.261728592597, 6212.81361559154, 6238.4697300729495, 4083.7549747015273, 4119.176164766998, 4151.73730316978, 4152.709310348247, 4163.437935878678, 4207.389928460418, 4208.747475151501, 4213.894652633709, 4217.62041416274, 4221.767802770877, 4714.669973101919, 4842.297866809293, 4845.878853028703, 4848.0, 4852.80588776445, 5755.453231942959, 5775.191473193756, 5784.132380143013, 5786.71066446676, 5790.0, 1430.4635761589404, 1443.4947768281017, 1448.876845468126, 1450.4633285684154, 1457.227669335254, 953.7186529973675, 965.5654955270156, 986.5313975861409, 988.0613417253638, 992.3202606214766, 5004.299398084271, 5019.749012549358, 5019.899602007939, 5040.722760248148, 5043.193089105725, 5998.820035398945, 6038.969805150946, 6049.485793707496, 6050.334463209044, 6074.51403887688, 4966.850994470172, 4975.850724478271, 4987.700737955734, 5001.524855138829, 5004.674696144739, 3193.9041828745176, 3215.405150047202, 3217.260030193022, 3225.661305562929, 3241.303119829201, 5522.9447705523235, 5525.530329922001, 5539.612227144142, 5572.442755724395, 5576.860578485489, 6204.658743769046, 6208.751649933952, 6214.906776398358, 6228.5017198624, 6269.247690277196, 5568.832935011957, 5572.693501857437, 5586.357568879468, 5597.440255974451, 5604.0, 6017.789377371771, 6038.305594856648, 6092.939070609237, 6101.786437474667, 6126.448619624255, 5949.2266005419015, 5958.821235362946, 5972.462478376967, 5978.790742323998, 5981.581289309881, 5217.843464696065, 5333.813316533902, 5477.863053423696, 5556.194351819045, 5575.693336866511, 4130.731502452331, 4155.750654960712, 4163.791810409407, 4164.355079743424, 4166.375043743342, 6024.1265016573225, 6036.577439579188, 6039.698015099315, 6043.456088952015, 6064.636121832704, 5634.4365563443325, 5814.970925145347, 5822.76708931655, 5824.679642619697, 5828.125781132864, 5810.970945145247, 5815.651060936358, 5824.009918313982, 5873.735681894411, 5876.911846322223, 5775.249217601685, 5789.205346342479, 5795.623284486495, 5796.565257605781, 5813.273340832396, 5895.204147440212, 5896.9115463268945, 5899.734511947058, 5905.586608937333, 5941.465268125889, 5714.771409143587, 5731.799387021434, 5733.627314224562, 5739.8565035874435, 5762.423757624204], "value": 4342.176704324232, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [645.6674812471575, 649.2663290481755, 700.0094865764943, 703.4513079797757, 720.1502227371701, 11318.32090074595, 12081.275123492596, 12126.333051682153, 13403.798943015838, 14431.494897678584, 13723.0, 13733.244671543061, 13881.09772864763, 13904.860951390483, 13912.51306204283, 867.1848462445297, 878.8286284174588, 879.8196369744219, 883.0727735877335, 883.8541640629288, 865.1694373401542, 886.2422628652506, 889.2219308105408, 889.7731078574955, 896.735463038402, 928.3826255540058, 929.0894922975488, 929.2658799548349, 930.50683137937, 930.9255259579218, 913.4930113786845, 913.6482454255126, 914.7850255190025, 915.8671992561042, 916.3356566489308, 672.2907332763932, 672.3008071605573, 672.5762769455212, 675.6925598852511, 676.5162908520432, 13645.0, 13659.86340136596, 13678.110922789987, 13704.10923289983, 13727.107737996997, 14513.492027778977, 14689.485867994568, 14970.326335314938, 15022.399104035825, 15039.473618423412, 11468.770624587545, 11765.0, 11851.0, 12078.335691536962, 12273.079519036019, 3016.472117379472, 3036.1195253376495, 3041.832699201543, 3045.923851903698, 3061.479548476764, 75938.62030689811, 87034.56482717546, 87399.12600874036, 87864.0, 88729.55635221847, 12262.754744905053, 12371.257724536557, 12517.687057823445, 12590.685232869067, 12591.685207869694, 21260.893695531424, 22195.223167189393, 22451.55096898053, 22493.4376640582, 22504.88747556252, 6356.586821856657, 6388.872222555616, 6394.71223794921, 6398.328175541595, 6405.391487808651, 2896.0443053792196, 2936.603558519615, 3050.176452357851, 3063.326068264978, 3070.5547695584464, 3482.4776283557667, 3561.0919215599856, 3586.964130358715, 3588.049166970755, 3597.2985267873037, 720.6000669628406, 726.5422783646269, 728.1517032657001, 728.8724473217165, 731.0897932074602, 532.4276402866933, 565.5729923907505, 567.1832561111986, 573.2061095382842, 575.91937128802, 9284.582193801296, 9807.901920980841, 9865.556049977768, 10099.69700908974, 10211.795764084676, 537.4356925228494, 541.4742552254236, 545.9653955753824, 546.3471151973354, 560.7560711090689, 4196.0, 4219.615917006881, 4225.197212529671, 4265.4881414230495, 4289.0, 71509.64245178844, 74387.0, 74458.6277068622, 76189.6190519055, 82024.58987705024, 62021.37978620156, 63054.0, 63340.0, 64091.0, 65693.0, 57483.0, 58870.70564647149, 59038.0, 60469.69765151146, 61120.0, 9137.0, 9163.258980793627, 9363.578638961399, 9460.148586626961, 9553.713388598353, 27691.55456539041, 28078.578821318104, 28128.71871281343, 28180.71819281863, 29260.122196334145, 33783.15542111368, 33976.490352644236, 33998.49002264919, 34601.307973840885, 34656.133596659274, 11904.761904761683, 12082.0, 12233.571824986082, 12237.26576405383, 12399.814002790146, 13696.589102326947, 13747.0, 13801.930990344985, 13885.51400701011, 14078.296085195903, 12786.808197877226, 13057.673558161123, 13233.933830330787, 13249.403776830259, 13397.06220564551, 12958.0, 13228.47086116583, 13395.665108372368, 13503.324833758077, 13541.526046588717, 13064.673383165496, 13076.869231307946, 13269.601911942656, 13323.467061317438, 13494.460221591027, 8832.602532886163, 8891.422057566237, 8999.415038022507, 9205.171534561654, 9422.152006319464, 10258.640947566799, 10650.573977041142, 10706.464676765974, 10846.783064338826, 11290.209685321948], "value": 6713.181857390841, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1559.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 112.0, 109.0, 110.0, 110.0, 112.0, 109.0, 118.0, 111.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 135.0, 123.0, 168.0, 124.0, 123.0, 122.0, 123.0, 147.0, 123.0], "value": 133.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 166.0, 166.0, 167.0, 170.0, 168.0, 184.0, 165.0, 164.0, 165.0], "value": 168.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 110.0, 77.0, 74.0, 74.0, 74.0, 93.0, 79.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 99.0, 89.0, 83.0, 82.0, 98.0, 83.0, 83.0, 106.0], "value": 89.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 113.0, 114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 152.0, 155.0, 155.0, 153.0, 154.0, 152.0, 152.0, 152.0, 152.0], "value": 153.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 96.0, 100.0, 95.0, 95.0, 94.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 60.0, 56.0, 56.0, 57.0, 58.0, 60.0, 58.0, 58.0], "value": 57.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 58.0, 57.0, 57.0, 60.0, 56.0, 55.0, 56.0, 55.0], "value": 56.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 90.0, 87.0, 89.0, 92.0, 89.0, 88.0, 97.0, 119.0, 86.0], "value": 92.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 155.0, 141.0, 135.0, 135.0, 140.0, 134.0, 129.0, 135.0, 141.0], "value": 137.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 203.0, 198.0, 189.0, 197.0, 197.0, 197.0, 202.0, 199.0, 214.0], "value": 198.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 79.0, 73.0, 74.0, 77.0, 72.0, 71.0, 73.0, 71.0], "value": 73.6, "unit": "score"}]}]} 09:54:47 INFO - Return code: 0 09:54:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:54:48 INFO - # TBPL SUCCESS # 09:54:48 INFO - Running post-action listener: _resource_record_post_action 09:54:48 INFO - [mozharness: 2017-06-01 16:54:48.031879Z] Finished run-tests step (success) 09:54:48 INFO - Running post-run listener: _resource_record_post_run 09:54:48 INFO - Total resource usage - Wall time: 1258s; CPU: 13.0%; Read bytes: 0; Write bytes: 410603520; Read time: 0; Write time: 382672 09:54:48 INFO - TinderboxPrint: CPU usage
12.7% 09:54:48 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:54:48 INFO - TinderboxPrint: I/O write bytes / time
410,603,520 / 382,672 09:54:48 INFO - TinderboxPrint: CPU idle
8,766.1 (87.3%) 09:54:48 INFO - TinderboxPrint: CPU user
1,221.8 (12.2%) 09:54:48 INFO - TinderboxPrint: Swap in / out
0 / 0 09:54:48 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 95465472; Read time: 0; Write time: 110148 09:54:48 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:54:48 INFO - run-tests - Wall time: 1242s; CPU: 13.0%; Read bytes: 0; Write bytes: 315138048; Read time: 0; Write time: 272524 09:54:48 INFO - Running post-run listener: _upload_blobber_files 09:54:48 INFO - Blob upload gear active. 09:54:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:54:48 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:54:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:54:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:54:49 INFO - (blobuploader) - INFO - Open directory for files ... 09:54:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:54:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:54:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:54:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:54:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:54:50 INFO - (blobuploader) - INFO - Done attempting. 09:54:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:54:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:54:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:54:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:54:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:54:53 INFO - (blobuploader) - INFO - Done attempting. 09:54:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:54:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:54:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:54:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:54:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:54:54 INFO - (blobuploader) - INFO - Done attempting. 09:54:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:54:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:54:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:54:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:54:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:54:55 INFO - (blobuploader) - INFO - Done attempting. 09:54:55 INFO - (blobuploader) - INFO - Iteration through files over. 09:54:55 INFO - Return code: 0 09:54:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:54:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:54:55 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c8afde5d1ecd6fd3846e28342b22390431d25045161110f009d3cf652ba7d88b5d2ab769e5bef7b474dd63d01cf195a7c5a8d3cb5bb098d658f27a5bcc93d71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21d64364f83d1a2f1d16c6bac322759afcc9c95e6ed98993031474942261d39aa7c19d3d361a5ba5d6abd99a9df7bd494533de5d7e8965762aee96d7612827d7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f2df7490c62abe3d850478d97ef053ab3d74db2bf236f43a1ccbe4d302c244074f4eb5286a3dfb56ef487ed6c6400aef92a6e332a91fdc38f5afe398ce4d280", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73274c4126b4d23dcd8465bdacfc08f9902854d9d502f2b0cad25e5203629ef1cd7e0110926cc2a98ca14e789765da6cce9ae8f93af6855f5e6e819bbd69bd63"} 09:54:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:54:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:54:55 INFO - Contents: 09:54:55 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c8afde5d1ecd6fd3846e28342b22390431d25045161110f009d3cf652ba7d88b5d2ab769e5bef7b474dd63d01cf195a7c5a8d3cb5bb098d658f27a5bcc93d71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21d64364f83d1a2f1d16c6bac322759afcc9c95e6ed98993031474942261d39aa7c19d3d361a5ba5d6abd99a9df7bd494533de5d7e8965762aee96d7612827d7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f2df7490c62abe3d850478d97ef053ab3d74db2bf236f43a1ccbe4d302c244074f4eb5286a3dfb56ef487ed6c6400aef92a6e332a91fdc38f5afe398ce4d280", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73274c4126b4d23dcd8465bdacfc08f9902854d9d502f2b0cad25e5203629ef1cd7e0110926cc2a98ca14e789765da6cce9ae8f93af6855f5e6e819bbd69bd63"} 09:54:55 INFO - Running post-run listener: copy_logs_to_upload_dir 09:54:55 INFO - Copying logs to upload dir... 09:54:55 INFO - mkdir: /builds/slave/test/build/upload/logs 09:54:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1316.771835 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2017-06-01 09:54:54.660933) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-01 09:54:54.665495) ========= 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=20e666a3d4cfbb71505a330e000001b4-1496327515.119291-338637468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c8afde5d1ecd6fd3846e28342b22390431d25045161110f009d3cf652ba7d88b5d2ab769e5bef7b474dd63d01cf195a7c5a8d3cb5bb098d658f27a5bcc93d71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21d64364f83d1a2f1d16c6bac322759afcc9c95e6ed98993031474942261d39aa7c19d3d361a5ba5d6abd99a9df7bd494533de5d7e8965762aee96d7612827d7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f2df7490c62abe3d850478d97ef053ab3d74db2bf236f43a1ccbe4d302c244074f4eb5286a3dfb56ef487ed6c6400aef92a6e332a91fdc38f5afe398ce4d280", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73274c4126b4d23dcd8465bdacfc08f9902854d9d502f2b0cad25e5203629ef1cd7e0110926cc2a98ca14e789765da6cce9ae8f93af6855f5e6e819bbd69bd63"} build_url:https://queue.taskcluster.net/v1/task/BrxE3naNRfiJs9uQ0VKz8Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011220 build_url: 'https://queue.taskcluster.net/v1/task/BrxE3naNRfiJs9uQ0VKz8Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c8afde5d1ecd6fd3846e28342b22390431d25045161110f009d3cf652ba7d88b5d2ab769e5bef7b474dd63d01cf195a7c5a8d3cb5bb098d658f27a5bcc93d71", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21d64364f83d1a2f1d16c6bac322759afcc9c95e6ed98993031474942261d39aa7c19d3d361a5ba5d6abd99a9df7bd494533de5d7e8965762aee96d7612827d7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1f2df7490c62abe3d850478d97ef053ab3d74db2bf236f43a1ccbe4d302c244074f4eb5286a3dfb56ef487ed6c6400aef92a6e332a91fdc38f5afe398ce4d280", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73274c4126b4d23dcd8465bdacfc08f9902854d9d502f2b0cad25e5203629ef1cd7e0110926cc2a98ca14e789765da6cce9ae8f93af6855f5e6e819bbd69bd63"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-01 09:54:54.692118) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 09:54:54.692436) ========= 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=20e666a3d4cfbb71505a330e000001b4-1496327515.119291-338637468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004673 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 09:54:54.773853) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-01 09:54:54.774173) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-01 09:54:54.774463) ========= ========= Total master_lag: 0.37 =========