builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-070 starttime: 1497019196.1 results: success (0) revision: eca8d0ea03af1d2424550a037f714f14c0f7b1be ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-09 07:39:56.098737) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-09 07:39:56.099159) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-09 07:39:56.099446) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-09 07:39:56.137237) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-09 07:39:56.137586) ========= 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=2432103b8b3de4003b23cad4000001c2-1497018146.6005-1156111273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-09 07:39:56-- 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% 23.0M=0.001s 2017-06-09 07:39:56 (23.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.181502 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-09 07:39:56.362117) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-09 07:39:56.362415) ========= 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=2432103b8b3de4003b23cad4000001c2-1497018146.6005-1156111273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019630 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-09 07:39:56.417598) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-09 07:39:56.417900) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev eca8d0ea03af1d2424550a037f714f14c0f7b1be --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 eca8d0ea03af1d2424550a037f714f14c0f7b1be --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=2432103b8b3de4003b23cad4000001c2-1497018146.6005-1156111273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-09 07:39:56,542 truncating revision to first 12 chars 2017-06-09 07:39:56,543 Setting DEBUG logging. 2017-06-09 07:39:56,543 attempt 1/10 2017-06-09 07:39:56,543 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/eca8d0ea03af?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-09 07:39:57,405 unpacking tar archive at: mozilla-central-eca8d0ea03af/testing/mozharness/ program finished with exit code 0 elapsedTime=1.191969 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-09 07:39:57.622044) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-09 07:39:57.625373) ========= script_repo_revision: eca8d0ea03af1d2424550a037f714f14c0f7b1be ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-09 07:39:57.625769) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-09 07:39:57.626032) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-09 07:39:57.634714) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2017-06-09 07:39:57.635019) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2432103b8b3de4003b23cad4000001c2-1497018146.6005-1156111273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:39:57 INFO - MultiFileLogger online at 20170609 07:39:57 in /builds/slave/test 07:39:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 07:39:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:39:57 INFO - {'append_to_log': False, 07:39:57 INFO - 'base_work_dir': '/builds/slave/test', 07:39:57 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:39:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:39:57 INFO - 'branch': 'Firefox-Non-PGO', 07:39:57 INFO - 'buildbot_json_path': 'buildprops.json', 07:39:57 INFO - 'config_files': ('talos/linux_config.py',), 07:39:57 INFO - 'default_actions': ('clobber', 07:39:57 INFO - 'read-buildbot-config', 07:39:57 INFO - 'download-and-extract', 07:39:57 INFO - 'populate-webroot', 07:39:57 INFO - 'create-virtualenv', 07:39:57 INFO - 'install', 07:39:57 INFO - 'setup-mitmproxy', 07:39:57 INFO - 'run-tests'), 07:39:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:39:57 INFO - 'download_minidump_stackwalk': True, 07:39:57 INFO - 'download_symbols': 'ondemand', 07:39:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:39:57 INFO - 'tooltool.py': '/tools/tooltool.py', 07:39:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:39:57 INFO - '/tools/misc-python/virtualenv.py')}, 07:39:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:39:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:39:57 INFO - 'gecko_profile': False, 07:39:57 INFO - 'gecko_profile_interval': 0, 07:39:57 INFO - 'installer_path': 'installer.exe', 07:39:57 INFO - 'log_level': 'info', 07:39:57 INFO - 'log_name': 'talos', 07:39:57 INFO - 'log_to_console': True, 07:39:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:39:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:39:57 INFO - 'opt_config_files': (), 07:39:57 INFO - 'pip_index': False, 07:39:57 INFO - 'suite': 'dromaeojs-e10s', 07:39:57 INFO - 'system_bits': '32', 07:39:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:39:57 INFO - 'title': 'talos-linux64-ix-070', 07:39:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:39:57 INFO - 'use_talos_json': True, 07:39:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:39:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:39:57 INFO - 'work_dir': 'build'} 07:39:57 INFO - [mozharness: 2017-06-09 14:39:57.960355Z] Running clobber step. 07:39:57 INFO - Running pre-action listener: _resource_record_pre_action 07:39:57 INFO - Running main action method: clobber 07:39:57 INFO - rmtree: /builds/slave/test/build 07:39:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:39:58 INFO - Running post-action listener: _resource_record_post_action 07:39:58 INFO - [mozharness: 2017-06-09 14:39:58.955196Z] Finished clobber step (success) 07:39:58 INFO - [mozharness: 2017-06-09 14:39:58.955298Z] Running read-buildbot-config step. 07:39:58 INFO - Running pre-action listener: _resource_record_pre_action 07:39:58 INFO - Running main action method: read_buildbot_config 07:39:58 INFO - Using buildbot properties: 07:39:58 INFO - { 07:39:58 INFO - "project": "", 07:39:58 INFO - "product": "firefox", 07:39:58 INFO - "who": "cbook@mozilla.com", 07:39:58 INFO - "installer_path": "public/build/target.tar.bz2", 07:39:58 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:39:58 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 07:39:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 07:39:58 INFO - "stage_platform": "linux64", 07:39:58 INFO - "basedir": "/builds/slave/test", 07:39:58 INFO - "buildnumber": 662, 07:39:58 INFO - "platform": "ubuntu64_hw", 07:39:58 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:39:58 INFO - "slavebuilddir": "test", 07:39:58 INFO - "taskId": "AZHV-jOuTf2yR1Hj6_Y_2A", 07:39:58 INFO - "branch": "mozilla-central", 07:39:58 INFO - "script_repo_revision": "production", 07:39:58 INFO - "revision": "eca8d0ea03af1d2424550a037f714f14c0f7b1be", 07:39:58 INFO - "slavename": "talos-linux64-ix-070", 07:39:58 INFO - "repo_path": "mozilla-central" 07:39:58 INFO - } 07:39:58 INFO - Finding installer, test and symbols from parent task. 07:39:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AZHV-jOuTf2yR1Hj6_Y_2A'}, attempt #1 07:39:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AZHV-jOuTf2yR1Hj6_Y_2A'}, attempt #1 07:39:59 INFO - Task dependencies: QvlAUGC5St2tr8EEkJfhLQ 07:39:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QvlAUGC5St2tr8EEkJfhLQ'}, attempt #1 07:40:00 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/QvlAUGC5St2tr8EEkJfhLQ/artifacts/public/build/target.tar.bz2 07:40:00 INFO - Set test_url: https://queue.taskcluster.net/v1/task/QvlAUGC5St2tr8EEkJfhLQ/artifacts/public/build/test_packages.json 07:40:00 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/QvlAUGC5St2tr8EEkJfhLQ/artifacts/public/build/target.crashreporter-symbols.zip 07:40:00 INFO - Running post-action listener: _resource_record_post_action 07:40:00 INFO - [mozharness: 2017-06-09 14:40:00.321167Z] Finished read-buildbot-config step (success) 07:40:00 INFO - [mozharness: 2017-06-09 14:40:00.321389Z] Running download-and-extract step. 07:40:00 INFO - Running pre-action listener: _resource_record_pre_action 07:40:00 INFO - Running main action method: download_and_extract 07:40:00 INFO - mkdir: /builds/slave/test/build/tests 07:40:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:40:00 INFO - trying https://queue.taskcluster.net/v1/task/QvlAUGC5St2tr8EEkJfhLQ/artifacts/public/build/target.test_packages.json 07:40:00 INFO - Downloading https://queue.taskcluster.net/v1/task/QvlAUGC5St2tr8EEkJfhLQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:40:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QvlAUGC5St2tr8EEkJfhLQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:40:00 INFO - Downloaded 989 bytes. 07:40:00 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:40:00 INFO - Using the following test package requirements: 07:40:00 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:40:00 INFO - u'common': [u'target.common.tests.zip'], 07:40:00 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:40:00 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:40:00 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:40:00 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:40:00 INFO - u'mozbase': [u'target.common.tests.zip'], 07:40:00 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:40:00 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:40:00 INFO - u'web-platform': [u'target.common.tests.zip', 07:40:00 INFO - u'target.web-platform.tests.tar.gz'], 07:40:00 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:40:00 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:40:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QvlAUGC5St2tr8EEkJfhLQ/artifacts/public/build/target.common.tests.zip 07:40:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QvlAUGC5St2tr8EEkJfhLQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:40:00 INFO - Fetch https://queue.taskcluster.net/v1/task/QvlAUGC5St2tr8EEkJfhLQ/artifacts/public/build/target.common.tests.zip into memory 07:40:02 INFO - Content-Length response header: 67876614 07:40:02 INFO - Bytes received: 67876614 07:40:13 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:40:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QvlAUGC5St2tr8EEkJfhLQ/artifacts/public/build/target.common.tests.zip 07:40:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QvlAUGC5St2tr8EEkJfhLQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:40:13 INFO - Fetch https://queue.taskcluster.net/v1/task/QvlAUGC5St2tr8EEkJfhLQ/artifacts/public/build/target.common.tests.zip into memory 07:40:14 INFO - Content-Length response header: 67876614 07:40:14 INFO - Bytes received: 67876614 07:40:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QvlAUGC5St2tr8EEkJfhLQ/artifacts/public/build/target.talos.tests.zip 07:40:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QvlAUGC5St2tr8EEkJfhLQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:40:27 INFO - Fetch https://queue.taskcluster.net/v1/task/QvlAUGC5St2tr8EEkJfhLQ/artifacts/public/build/target.talos.tests.zip into memory 07:40:27 INFO - Content-Length response header: 14449999 07:40:27 INFO - Bytes received: 14449999 07:40: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')]} 07:40:28 INFO - trying https://queue.taskcluster.net/v1/task/QvlAUGC5St2tr8EEkJfhLQ/artifacts/public/build/target.tar.bz2 07:40:28 INFO - Downloading https://queue.taskcluster.net/v1/task/QvlAUGC5St2tr8EEkJfhLQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:40:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QvlAUGC5St2tr8EEkJfhLQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:40:29 INFO - Downloaded 59290887 bytes. 07:40:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QvlAUGC5St2tr8EEkJfhLQ/artifacts/public/build/target.tar.bz2 07:40:29 INFO - mkdir: /builds/slave/test/properties 07:40:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:40:29 INFO - Writing to file /builds/slave/test/properties/build_url 07:40:29 INFO - Contents: 07:40:29 INFO - build_url:https://queue.taskcluster.net/v1/task/QvlAUGC5St2tr8EEkJfhLQ/artifacts/public/build/target.tar.bz2 07:40:29 INFO - Running post-action listener: _resource_record_post_action 07:40:29 INFO - Running post-action listener: set_extra_try_arguments 07:40:29 INFO - [mozharness: 2017-06-09 14:40:29.898870Z] Finished download-and-extract step (success) 07:40:29 INFO - [mozharness: 2017-06-09 14:40:29.899096Z] Running populate-webroot step. 07:40:29 INFO - Running pre-action listener: _resource_record_pre_action 07:40:29 INFO - Running main action method: populate_webroot 07:40:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:40:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:40:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:40:29 INFO - '--tppagecycles', 07:40:29 INFO - '7'], 07:40:29 INFO - 'tests': ['tsvgm']}}, 07:40:29 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:40:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:40:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:40:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:40:29 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:40:29 INFO - 'talos_options': ['--disable-e10s'], 07:40:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:40:29 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:40:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:40:29 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:40:29 INFO - 'talos_options': ['--disable-e10s'], 07:40:29 INFO - 'tests': ['damp', 'tps']}, 07:40:29 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:40:29 INFO - 'tests': ['damp', 'tps']}, 07:40:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:40:29 INFO - 'tests': ['dromaeo_dom']}, 07:40:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:40:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:40:29 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 07:40:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 07:40:29 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 07:40:29 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 07:40:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:40:29 INFO - 'tests': ['a11yr', 07:40:29 INFO - 'ts_paint', 07:40:29 INFO - 'tpaint', 07:40:29 INFO - 'sessionrestore', 07:40:29 INFO - 'sessionrestore_no_auto_restore', 07:40:29 INFO - 'tabpaint']}, 07:40:29 INFO - 'other-e10s': {'tests': ['a11yr', 07:40:29 INFO - 'ts_paint', 07:40:29 INFO - 'tpaint', 07:40:29 INFO - 'sessionrestore', 07:40:29 INFO - 'sessionrestore_no_auto_restore', 07:40:29 INFO - 'tabpaint']}, 07:40:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:40:29 INFO - 'ts_paint', 07:40:29 INFO - 'tpaint', 07:40:29 INFO - 'sessionrestore', 07:40:29 INFO - 'sessionrestore_no_auto_restore', 07:40:29 INFO - 'tabpaint']}, 07:40:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:40:29 INFO - 'ts_paint', 07:40:29 INFO - 'tpaint', 07:40:29 INFO - 'sessionrestore', 07:40:29 INFO - 'sessionrestore_no_auto_restore', 07:40:29 INFO - 'tabpaint']}, 07:40:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:40:29 INFO - 'tests': ['a11yr', 07:40:29 INFO - 'ts_paint', 07:40:29 INFO - 'tpaint', 07:40:29 INFO - 'sessionrestore', 07:40:29 INFO - 'sessionrestore_no_auto_restore', 07:40:29 INFO - 'tabpaint']}, 07:40:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:40:29 INFO - 'tests': ['a11yr', 07:40:29 INFO - 'ts_paint', 07:40:29 INFO - 'tpaint', 07:40:29 INFO - 'sessionrestore', 07:40:29 INFO - 'sessionrestore_no_auto_restore', 07:40:29 INFO - 'tabpaint']}, 07:40:29 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 07:40:29 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 07:40:29 INFO - 'bloom_basic_ref']}, 07:40:29 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:40:29 INFO - 'talos_options': ['--mitmproxy', 07:40:29 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:40:29 INFO - '--firstNonBlankPaint'], 07:40:29 INFO - 'tests': ['quantum_pageload_google', 07:40:29 INFO - 'quantum_pageload_youtube', 07:40:29 INFO - 'quantum_pageload_amazon', 07:40:29 INFO - 'quantum_pageload_facebook']}, 07:40:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:40:29 INFO - 'tests': ['tsvgx', 07:40:29 INFO - 'tsvgr_opacity', 07:40:29 INFO - 'tart', 07:40:29 INFO - 'tscrollx', 07:40:29 INFO - 'cart', 07:40:29 INFO - 'tsvg_static']}, 07:40:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:40:29 INFO - 'tsvgr_opacity', 07:40:29 INFO - 'tart', 07:40:29 INFO - 'tscrollx', 07:40:29 INFO - 'cart', 07:40:29 INFO - 'tsvg_static']}, 07:40:29 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:40:29 INFO - 'talos_options': ['--disable-e10s'], 07:40:29 INFO - 'tests': ['tp5o']}, 07:40:29 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:40:29 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:40:29 INFO - 'talos_options': ['--disable-e10s', 07:40:29 INFO - '--xperf_path', 07:40:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:40:29 INFO - 'tests': ['tp5n']}, 07:40:29 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:40:29 INFO - 'talos_options': ['--xperf_path', 07:40:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:40:29 INFO - 'tests': ['tp5n']}}, 07:40:29 INFO - 'talos.zip': {'path': '', 07:40:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:40:29 INFO - Running post-action listener: _resource_record_post_action 07:40:29 INFO - [mozharness: 2017-06-09 14:40:29.918497Z] Finished populate-webroot step (success) 07:40:29 INFO - [mozharness: 2017-06-09 14:40:29.918587Z] Running create-virtualenv step. 07:40:29 INFO - Running pre-action listener: _resource_record_pre_action 07:40:29 INFO - Running main action method: create_virtualenv 07:40:29 INFO - Creating virtualenv /builds/slave/test/build/venv 07:40:29 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 07:40:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:40:29 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 07:40:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:40:30 INFO - Using real prefix '/usr' 07:40:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:40:30 INFO - Installing distribute.............................................................................................................................................................................................done. 07:40:32 INFO - Installing pip.................done. 07:40:32 INFO - Return code: 0 07:40:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:40:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:40:32 INFO - Reading from file tmpfile_stdout 07:40:32 INFO - Output received: 07:40:32 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) 07:40:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:40:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:40:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:40:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1648140>, '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 0x1648a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1648ed0>, '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': '2432103b8b3de4003b23cad4000001c2-1497018146.6005-1156111273', '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 07:40:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:40:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:40:32 INFO - Using env: {'DISPLAY': ':0', 07:40:32 INFO - 'HOME': '/home/cltbld', 07:40:32 INFO - 'LANG': 'en_US.UTF-8', 07:40:32 INFO - 'LANGUAGE': 'en_US:en', 07:40:32 INFO - 'LOGNAME': 'cltbld', 07:40:32 INFO - 'MAIL': '/var/mail/cltbld', 07:40:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:32 INFO - 'MOZ_NO_REMOTE': '1', 07:40:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:40:32 INFO - 'NO_EM_RESTART': '1', 07:40:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:40:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:32 INFO - 'PWD': '/builds/slave/test', 07:40:32 INFO - 'SHELL': '/bin/bash', 07:40:32 INFO - 'SHLVL': '1', 07:40:32 INFO - 'TERM': 'linux', 07:40:32 INFO - 'TMOUT': '86400', 07:40:32 INFO - 'USER': 'cltbld', 07:40:32 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1497018146.6005-1156111273', 07:40:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:32 INFO - '_': '/tools/buildbot/bin/python'} 07:40:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40: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 07:40:33 INFO - Cleaning up... 07:40:33 INFO - Return code: 0 07:40:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:40: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')]} 07:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40: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')]} 07:40:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40: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 0x12cc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1648140>, '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 0x1648a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1648ed0>, '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': '2432103b8b3de4003b23cad4000001c2-1497018146.6005-1156111273', '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 07:40: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 07:40: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 07:40:33 INFO - Using env: {'DISPLAY': ':0', 07:40:33 INFO - 'HOME': '/home/cltbld', 07:40:33 INFO - 'LANG': 'en_US.UTF-8', 07:40:33 INFO - 'LANGUAGE': 'en_US:en', 07:40:33 INFO - 'LOGNAME': 'cltbld', 07:40:33 INFO - 'MAIL': '/var/mail/cltbld', 07:40:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:33 INFO - 'MOZ_NO_REMOTE': '1', 07:40:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:40:33 INFO - 'NO_EM_RESTART': '1', 07:40:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:40:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:33 INFO - 'PWD': '/builds/slave/test', 07:40:33 INFO - 'SHELL': '/bin/bash', 07:40:33 INFO - 'SHLVL': '1', 07:40:33 INFO - 'TERM': 'linux', 07:40:33 INFO - 'TMOUT': '86400', 07:40:33 INFO - 'USER': 'cltbld', 07:40:33 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1497018146.6005-1156111273', 07:40:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:33 INFO - '_': '/tools/buildbot/bin/python'} 07:40:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:33 INFO - Downloading/unpacking psutil>=3.1.1 07:40: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 07:40: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 07:40: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 07:40: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 07:40:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:40:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:40:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:40:34 INFO - Installing collected packages: psutil 07:40:34 INFO - Running setup.py install for psutil 07:40:34 INFO - building 'psutil._psutil_linux' extension 07:40: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 07:40: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 07:40:35 INFO - building 'psutil._psutil_posix' extension 07:40: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 07:40: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 07:40:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:40:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:40:36 INFO - Successfully installed psutil 07:40:36 INFO - Cleaning up... 07:40:36 INFO - Return code: 0 07:40:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:40: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')]} 07:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40: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')]} 07:40:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12cc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1648140>, '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 0x1648a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1648ed0>, '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': '2432103b8b3de4003b23cad4000001c2-1497018146.6005-1156111273', '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 07:40: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:40: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 mozsystemmonitor==0.3 07:40:36 INFO - Using env: {'DISPLAY': ':0', 07:40:36 INFO - 'HOME': '/home/cltbld', 07:40:36 INFO - 'LANG': 'en_US.UTF-8', 07:40:36 INFO - 'LANGUAGE': 'en_US:en', 07:40:36 INFO - 'LOGNAME': 'cltbld', 07:40:36 INFO - 'MAIL': '/var/mail/cltbld', 07:40:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:36 INFO - 'MOZ_NO_REMOTE': '1', 07:40:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:40:36 INFO - 'NO_EM_RESTART': '1', 07:40:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:40:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:36 INFO - 'PWD': '/builds/slave/test', 07:40:36 INFO - 'SHELL': '/bin/bash', 07:40:36 INFO - 'SHLVL': '1', 07:40:36 INFO - 'TERM': 'linux', 07:40:36 INFO - 'TMOUT': '86400', 07:40:36 INFO - 'USER': 'cltbld', 07:40:36 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1497018146.6005-1156111273', 07:40:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:36 INFO - '_': '/tools/buildbot/bin/python'} 07:40:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:40:36 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 07:40:36 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 07:40:36 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 07:40:36 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 07:40:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:40:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:40:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:40:37 INFO - Installing collected packages: mozsystemmonitor 07:40:37 INFO - Running setup.py install for mozsystemmonitor 07:40:37 INFO - Successfully installed mozsystemmonitor 07:40:37 INFO - Cleaning up... 07:40:37 INFO - Return code: 0 07:40:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:40:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:40:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:40:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:37 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 0x12cc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1648140>, '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 0x1648a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1648ed0>, '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': '2432103b8b3de4003b23cad4000001c2-1497018146.6005-1156111273', '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 07:40:37 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 07:40:37 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 07:40:37 INFO - Using env: {'DISPLAY': ':0', 07:40:37 INFO - 'HOME': '/home/cltbld', 07:40:37 INFO - 'LANG': 'en_US.UTF-8', 07:40:37 INFO - 'LANGUAGE': 'en_US:en', 07:40:37 INFO - 'LOGNAME': 'cltbld', 07:40:37 INFO - 'MAIL': '/var/mail/cltbld', 07:40:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:37 INFO - 'MOZ_NO_REMOTE': '1', 07:40:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:40:37 INFO - 'NO_EM_RESTART': '1', 07:40:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:40:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:37 INFO - 'PWD': '/builds/slave/test', 07:40:37 INFO - 'SHELL': '/bin/bash', 07:40:37 INFO - 'SHLVL': '1', 07:40:37 INFO - 'TERM': 'linux', 07:40:37 INFO - 'TMOUT': '86400', 07:40:37 INFO - 'USER': 'cltbld', 07:40:37 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1497018146.6005-1156111273', 07:40:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:37 INFO - '_': '/tools/buildbot/bin/python'} 07:40:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:37 INFO - Downloading/unpacking jsonschema==2.5.1 07:40: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 07:40: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 07:40: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 07:40: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 07:40:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:40:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:40: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 07:40: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 07:40: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 07:40: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 07:40:38 INFO - Downloading functools32-3.2.3-2.tar.gz 07:40:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:40:39 INFO - warning: no files found matching '*.txt' 07:40:39 INFO - no previously-included directories found matching 'build' 07:40:39 INFO - no previously-included directories found matching 'dist' 07:40:39 INFO - no previously-included directories found matching '.git*' 07:40:39 INFO - Installing collected packages: jsonschema, functools32 07:40:39 INFO - Running setup.py install for functools32 07:40:39 INFO - warning: no files found matching '*.txt' 07:40:39 INFO - no previously-included directories found matching 'build' 07:40:39 INFO - no previously-included directories found matching 'dist' 07:40:39 INFO - no previously-included directories found matching '.git*' 07:40:39 INFO - Successfully installed jsonschema functools32 07:40:39 INFO - Cleaning up... 07:40:39 INFO - Return code: 0 07:40:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:40:39 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')]} 07:40:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:39 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')]} 07:40:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:39 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 0x12cc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1648140>, '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 0x1648a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1648ed0>, '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': '2432103b8b3de4003b23cad4000001c2-1497018146.6005-1156111273', '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 07:40:39 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 07:40:39 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 07:40:39 INFO - Using env: {'DISPLAY': ':0', 07:40:39 INFO - 'HOME': '/home/cltbld', 07:40:39 INFO - 'LANG': 'en_US.UTF-8', 07:40:39 INFO - 'LANGUAGE': 'en_US:en', 07:40:39 INFO - 'LOGNAME': 'cltbld', 07:40:39 INFO - 'MAIL': '/var/mail/cltbld', 07:40:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:39 INFO - 'MOZ_NO_REMOTE': '1', 07:40:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:40:39 INFO - 'NO_EM_RESTART': '1', 07:40:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:40:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:39 INFO - 'PWD': '/builds/slave/test', 07:40:39 INFO - 'SHELL': '/bin/bash', 07:40:39 INFO - 'SHLVL': '1', 07:40:39 INFO - 'TERM': 'linux', 07:40:39 INFO - 'TMOUT': '86400', 07:40:39 INFO - 'USER': 'cltbld', 07:40:39 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1497018146.6005-1156111273', 07:40:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:39 INFO - '_': '/tools/buildbot/bin/python'} 07:40:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:40:39 INFO - Cleaning up... 07:40:39 INFO - Return code: 0 07:40:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:40:39 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')]} 07:40:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:39 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')]} 07:40:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:39 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 0x12cc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1648140>, '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 0x1648a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1648ed0>, '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': '2432103b8b3de4003b23cad4000001c2-1497018146.6005-1156111273', '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 07:40:39 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 07:40:39 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 07:40:39 INFO - Using env: {'DISPLAY': ':0', 07:40:39 INFO - 'HOME': '/home/cltbld', 07:40:39 INFO - 'LANG': 'en_US.UTF-8', 07:40:39 INFO - 'LANGUAGE': 'en_US:en', 07:40:39 INFO - 'LOGNAME': 'cltbld', 07:40:39 INFO - 'MAIL': '/var/mail/cltbld', 07:40:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:39 INFO - 'MOZ_NO_REMOTE': '1', 07:40:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:40:39 INFO - 'NO_EM_RESTART': '1', 07:40:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:40:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:39 INFO - 'PWD': '/builds/slave/test', 07:40:39 INFO - 'SHELL': '/bin/bash', 07:40:39 INFO - 'SHLVL': '1', 07:40:39 INFO - 'TERM': 'linux', 07:40:39 INFO - 'TMOUT': '86400', 07:40:39 INFO - 'USER': 'cltbld', 07:40:39 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1497018146.6005-1156111273', 07:40:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:39 INFO - '_': '/tools/buildbot/bin/python'} 07:40:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:39 INFO - Downloading/unpacking blobuploader==1.2.4 07:40:39 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 07:40:39 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 07:40:39 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 07:40:39 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 07:40:40 INFO - Downloading blobuploader-1.2.4.tar.gz 07:40:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:40:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:40: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 07:40: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 07:40: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 07:40: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 07:40:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:40:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:40:41 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 07:40:41 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 07:40:41 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 07:40:41 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 07:40:41 INFO - Downloading docopt-0.6.1.tar.gz 07:40:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:40:41 INFO - Installing collected packages: blobuploader, requests, docopt 07:40:41 INFO - Running setup.py install for blobuploader 07:40:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:40:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:40:41 INFO - Running setup.py install for requests 07:40:41 INFO - Running setup.py install for docopt 07:40:41 INFO - Successfully installed blobuploader requests docopt 07:40:41 INFO - Cleaning up... 07:40:41 INFO - Return code: 0 07:40:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:40: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')]} 07:40:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40: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')]} 07:40:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40: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 0x12cc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1648140>, '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 0x1648a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1648ed0>, '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': '2432103b8b3de4003b23cad4000001c2-1497018146.6005-1156111273', '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 07:40: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 07:40: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 07:40:41 INFO - Using env: {'DISPLAY': ':0', 07:40:41 INFO - 'HOME': '/home/cltbld', 07:40:41 INFO - 'LANG': 'en_US.UTF-8', 07:40:41 INFO - 'LANGUAGE': 'en_US:en', 07:40:41 INFO - 'LOGNAME': 'cltbld', 07:40:41 INFO - 'MAIL': '/var/mail/cltbld', 07:40:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:41 INFO - 'MOZ_NO_REMOTE': '1', 07:40:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:40:41 INFO - 'NO_EM_RESTART': '1', 07:40:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:40:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:41 INFO - 'PWD': '/builds/slave/test', 07:40:41 INFO - 'SHELL': '/bin/bash', 07:40:41 INFO - 'SHLVL': '1', 07:40:41 INFO - 'TERM': 'linux', 07:40:41 INFO - 'TMOUT': '86400', 07:40:41 INFO - 'USER': 'cltbld', 07:40:41 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1497018146.6005-1156111273', 07:40:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:41 INFO - '_': '/tools/buildbot/bin/python'} 07:40:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:40:42 INFO - Running setup.py (path:/tmp/pip-t8OuCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:40:42 INFO - Running setup.py (path:/tmp/pip-JmaXhs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:40:42 INFO - Running setup.py (path:/tmp/pip-tb2whQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:40:42 INFO - Running setup.py (path:/tmp/pip-MK5CP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:40:42 INFO - Running setup.py (path:/tmp/pip-CsyXkp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:40:42 INFO - Running setup.py (path:/tmp/pip-UjUhQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:40:42 INFO - Running setup.py (path:/tmp/pip-I0GPuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:40:42 INFO - Running setup.py (path:/tmp/pip-vKcutM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:40:42 INFO - Running setup.py (path:/tmp/pip-6LnLHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:40:42 INFO - Running setup.py (path:/tmp/pip-v7QG9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:40:42 INFO - Running setup.py (path:/tmp/pip-bQAD9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:40:42 INFO - Running setup.py (path:/tmp/pip-0Lwzgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:40:43 INFO - Running setup.py (path:/tmp/pip-tE_Nbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:40:43 INFO - Running setup.py (path:/tmp/pip-PtdadK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:40:43 INFO - Running setup.py (path:/tmp/pip-dV__oh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:40:43 INFO - Running setup.py (path:/tmp/pip-5sSQG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:40:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:40:43 INFO - Running setup.py (path:/tmp/pip-C99S6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:40:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:40:43 INFO - Running setup.py install for manifestparser 07:40:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:40:43 INFO - Running setup.py install for mozcrash 07:40:43 INFO - Running setup.py install for mozdebug 07:40:43 INFO - Running setup.py install for mozdevice 07:40:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:40:43 INFO - Running setup.py install for mozfile 07:40:43 INFO - Running setup.py install for mozhttpd 07:40:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:40:43 INFO - Running setup.py install for mozinfo 07:40:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:40:44 INFO - Running setup.py install for mozInstall 07:40:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:40:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:40:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:40:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:40:44 INFO - Running setup.py install for mozleak 07:40:44 INFO - Running setup.py install for mozlog 07:40:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:40:44 INFO - Running setup.py install for moznetwork 07:40:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:40:44 INFO - Running setup.py install for mozprocess 07:40:44 INFO - Running setup.py install for mozprofile 07:40:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:40:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:40:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:40:44 INFO - Running setup.py install for mozrunner 07:40:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:40:44 INFO - Running setup.py install for mozscreenshot 07:40:44 INFO - Running setup.py install for moztest 07:40:45 INFO - Running setup.py install for mozversion 07:40:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:40:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:40:45 INFO - Cleaning up... 07:40:45 INFO - Return code: 0 07:40:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:40:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:40:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:40:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:45 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 0x12cc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1648140>, '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 0x1648a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1648ed0>, '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': '2432103b8b3de4003b23cad4000001c2-1497018146.6005-1156111273', '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 07:40:45 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 07:40:45 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 07:40:45 INFO - Using env: {'DISPLAY': ':0', 07:40:45 INFO - 'HOME': '/home/cltbld', 07:40:45 INFO - 'LANG': 'en_US.UTF-8', 07:40:45 INFO - 'LANGUAGE': 'en_US:en', 07:40:45 INFO - 'LOGNAME': 'cltbld', 07:40:45 INFO - 'MAIL': '/var/mail/cltbld', 07:40:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:45 INFO - 'MOZ_NO_REMOTE': '1', 07:40:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:40:45 INFO - 'NO_EM_RESTART': '1', 07:40:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:40:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:45 INFO - 'PWD': '/builds/slave/test', 07:40:45 INFO - 'SHELL': '/bin/bash', 07:40:45 INFO - 'SHLVL': '1', 07:40:45 INFO - 'TERM': 'linux', 07:40:45 INFO - 'TMOUT': '86400', 07:40:45 INFO - 'USER': 'cltbld', 07:40:45 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1497018146.6005-1156111273', 07:40:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:45 INFO - '_': '/tools/buildbot/bin/python'} 07:40:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:40:45 INFO - Running setup.py (path:/tmp/pip-Kg_G4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:40:45 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)) 07:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:40:45 INFO - Running setup.py (path:/tmp/pip-s6AIxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:40:45 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)) 07:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:40:45 INFO - Running setup.py (path:/tmp/pip-kvfsNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:40:45 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)) 07:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:40:45 INFO - Running setup.py (path:/tmp/pip-XxSK0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:40:45 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)) 07:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:40:45 INFO - Running setup.py (path:/tmp/pip-LBqQz0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:40: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)) 07:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:40:45 INFO - Running setup.py (path:/tmp/pip-1Xs7bL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:40: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)) 07:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:40:45 INFO - Running setup.py (path:/tmp/pip-BosrbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:40:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:40:45 INFO - Running setup.py (path:/tmp/pip-XDJ5Yp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:40: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)) 07:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:40:45 INFO - Running setup.py (path:/tmp/pip-1Uo4Yo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:40: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)) 07:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:40:45 INFO - Running setup.py (path:/tmp/pip-w54j4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:40:46 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)) 07:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:40:46 INFO - Running setup.py (path:/tmp/pip-JWlV1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:40:46 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)) 07:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:40:46 INFO - Running setup.py (path:/tmp/pip-pCOGd4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:40:46 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)) 07:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:40:46 INFO - Running setup.py (path:/tmp/pip-LPUwG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:40:46 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)) 07:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:40:46 INFO - Running setup.py (path:/tmp/pip-46nQaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:40:46 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)) 07:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:40:46 INFO - Running setup.py (path:/tmp/pip-vEJ9hc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:40:46 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)) 07:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:40:46 INFO - Running setup.py (path:/tmp/pip-mOSlY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:40:46 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)) 07:40:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:40:46 INFO - Running setup.py (path:/tmp/pip-o1lLXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:40:46 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)) 07:40:46 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)) 07:40:46 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)) 07:40:46 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)) 07:40:46 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)) 07:40:46 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)) 07:40:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:40:46 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 07:40:46 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 07:40:46 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 07:40:46 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 07:40:47 INFO - Downloading blessings-1.6.tar.gz 07:40:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:40:47 INFO - Installing collected packages: blessings 07:40:47 INFO - Running setup.py install for blessings 07:40:47 INFO - Successfully installed blessings 07:40:47 INFO - Cleaning up... 07:40:47 INFO - Return code: 0 07:40:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:40:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:40:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:40:48 INFO - Reading from file tmpfile_stdout 07:40:48 INFO - Current package versions: 07:40:48 INFO - argparse == 1.2.1 07:40:48 INFO - blessings == 1.6 07:40:48 INFO - blobuploader == 1.2.4 07:40:48 INFO - docopt == 0.6.1 07:40:48 INFO - functools32 == 3.2.3-2 07:40:48 INFO - jsonschema == 2.5.1 07:40:48 INFO - manifestparser == 1.1 07:40:48 INFO - mozInstall == 1.12 07:40:48 INFO - mozcrash == 1.0 07:40:48 INFO - mozdebug == 0.1 07:40:48 INFO - mozdevice == 0.51 07:40:48 INFO - mozfile == 1.2 07:40:48 INFO - mozhttpd == 0.7 07:40:48 INFO - mozinfo == 0.10 07:40:48 INFO - mozleak == 0.1 07:40:48 INFO - mozlog == 3.4 07:40:48 INFO - moznetwork == 0.27 07:40:48 INFO - mozprocess == 0.25 07:40:48 INFO - mozprofile == 0.28 07:40:48 INFO - mozrunner == 6.13 07:40:48 INFO - mozscreenshot == 0.1 07:40:48 INFO - mozsystemmonitor == 0.3 07:40:48 INFO - moztest == 0.8 07:40:48 INFO - mozversion == 1.4 07:40:48 INFO - psutil == 3.1.1 07:40:48 INFO - requests == 1.2.3 07:40:48 INFO - wsgiref == 0.1.2 07:40:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:40:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:40:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:40:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:48 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 0x12cc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1648140>, '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 0x1648a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1648ed0>, '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': '2432103b8b3de4003b23cad4000001c2-1497018146.6005-1156111273', '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 07:40:48 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 07:40:48 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 07:40:48 INFO - Using env: {'DISPLAY': ':0', 07:40:48 INFO - 'HOME': '/home/cltbld', 07:40:48 INFO - 'LANG': 'en_US.UTF-8', 07:40:48 INFO - 'LANGUAGE': 'en_US:en', 07:40:48 INFO - 'LOGNAME': 'cltbld', 07:40:48 INFO - 'MAIL': '/var/mail/cltbld', 07:40:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:48 INFO - 'MOZ_NO_REMOTE': '1', 07:40:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:40:48 INFO - 'NO_EM_RESTART': '1', 07:40:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:40:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:48 INFO - 'PWD': '/builds/slave/test', 07:40:48 INFO - 'SHELL': '/bin/bash', 07:40:48 INFO - 'SHLVL': '1', 07:40:48 INFO - 'TERM': 'linux', 07:40:48 INFO - 'TMOUT': '86400', 07:40:48 INFO - 'USER': 'cltbld', 07:40:48 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1497018146.6005-1156111273', 07:40:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:48 INFO - '_': '/tools/buildbot/bin/python'} 07:40:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:48 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)) 07:40:48 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)) 07:40:48 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)) 07:40:48 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)) 07:40:48 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)) 07:40:48 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)) 07:40:48 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)) 07:40:48 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)) 07:40:48 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)) 07:40:48 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 07:40:48 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 07:40:48 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 07:40:48 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 07:40:48 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 07:40:49 INFO - Downloading marionette_driver-1.4.0.tar.gz 07:40:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 07:40:49 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)) 07:40:49 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)) 07:40:49 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)) 07:40:49 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)) 07:40:49 INFO - Installing collected packages: marionette-driver 07:40:49 INFO - Running setup.py install for marionette-driver 07:40:49 INFO - Successfully installed marionette-driver 07:40:49 INFO - Cleaning up... 07:40:49 INFO - Return code: 0 07:40:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:40:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:40:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:40:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:40:49 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 0x12cc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14a6a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x164a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1648140>, '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 0x1648a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1648ed0>, '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': '2432103b8b3de4003b23cad4000001c2-1497018146.6005-1156111273', '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 07:40: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 07:40: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 07:40:49 INFO - Using env: {'DISPLAY': ':0', 07:40:49 INFO - 'HOME': '/home/cltbld', 07:40:49 INFO - 'LANG': 'en_US.UTF-8', 07:40:49 INFO - 'LANGUAGE': 'en_US:en', 07:40:49 INFO - 'LOGNAME': 'cltbld', 07:40:49 INFO - 'MAIL': '/var/mail/cltbld', 07:40:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:40:49 INFO - 'MOZ_NO_REMOTE': '1', 07:40:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:40:49 INFO - 'NO_EM_RESTART': '1', 07:40:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:40:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:40:49 INFO - 'PWD': '/builds/slave/test', 07:40:49 INFO - 'SHELL': '/bin/bash', 07:40:49 INFO - 'SHLVL': '1', 07:40:49 INFO - 'TERM': 'linux', 07:40:49 INFO - 'TMOUT': '86400', 07:40:49 INFO - 'USER': 'cltbld', 07:40:49 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1497018146.6005-1156111273', 07:40:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:40:49 INFO - '_': '/tools/buildbot/bin/python'} 07:40:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:40:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:40:49 INFO - Cleaning up... 07:40:49 INFO - Return code: 0 07:40:49 INFO - Running post-action listener: _resource_record_post_action 07:40:49 INFO - Running post-action listener: _start_resource_monitoring 07:40:49 INFO - Starting resource monitoring. 07:40:49 INFO - [mozharness: 2017-06-09 14:40:49.902879Z] Finished create-virtualenv step (success) 07:40:49 INFO - [mozharness: 2017-06-09 14:40:49.903867Z] Running install step. 07:40:49 INFO - Running pre-action listener: _resource_record_pre_action 07:40:49 INFO - Running main action method: install 07:40:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:40:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:40:50 INFO - Reading from file tmpfile_stdout 07:40:50 INFO - Detecting whether we're running mozinstall >=1.0... 07:40:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:40:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:40:50 INFO - Reading from file tmpfile_stdout 07:40:50 INFO - Output received: 07:40:50 INFO - Usage: mozinstall [options] installer 07:40:50 INFO - Options: 07:40:50 INFO - -h, --help show this help message and exit 07:40:50 INFO - -d DEST, --destination=DEST 07:40:50 INFO - Directory to install application into. [default: 07:40:50 INFO - "/builds/slave/test"] 07:40:50 INFO - --app=APP Application being installed. [default: firefox] 07:40:50 INFO - mkdir: /builds/slave/test/build/application 07:40:50 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'] 07:40:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:41:07 INFO - Reading from file tmpfile_stdout 07:41:07 INFO - Output received: 07:41:07 INFO - /builds/slave/test/build/application/firefox/firefox 07:41:07 INFO - Running post-action listener: _resource_record_post_action 07:41:07 INFO - [mozharness: 2017-06-09 14:41:07.331986Z] Finished install step (success) 07:41:07 INFO - [mozharness: 2017-06-09 14:41:07.332268Z] Running setup-mitmproxy step. 07:41:07 INFO - Running pre-action listener: _resource_record_pre_action 07:41:07 INFO - Running main action method: setup_mitmproxy 07:41:07 INFO - Skipping: mitmproxy is not required 07:41:07 INFO - Running post-action listener: _resource_record_post_action 07:41:07 INFO - [mozharness: 2017-06-09 14:41:07.333403Z] Finished setup-mitmproxy step (success) 07:41:07 INFO - [mozharness: 2017-06-09 14:41:07.333626Z] Running run-tests step. 07:41:07 INFO - Running pre-action listener: _resource_record_pre_action 07:41:07 INFO - Running main action method: run_tests 07:41:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:41:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:41:07 INFO - Python 2.7.3 07:41:07 INFO - Return code: 0 07:41:07 INFO - grabbing minidump binary from tooltool 07:41:07 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')]} 07:41:07 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 0x1648140>, '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 0x1648a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1648ed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:41:07 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 07:41:07 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 07:41:07 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 07:41:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:41:07 INFO - Return code: 0 07:41:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:41:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:41:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:41:07 INFO - ENV: RUST_BACKTRACE is now 1 07:41:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:41:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:41:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QvlAUGC5St2tr8EEkJfhLQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-070', '--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 07:41:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QvlAUGC5St2tr8EEkJfhLQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-070 --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 07:41:07 INFO - Using env: {'DISPLAY': ':0', 07:41:07 INFO - 'HOME': '/home/cltbld', 07:41:07 INFO - 'LANG': 'en_US.UTF-8', 07:41:07 INFO - 'LANGUAGE': 'en_US:en', 07:41:07 INFO - 'LOGNAME': 'cltbld', 07:41:07 INFO - 'MAIL': '/var/mail/cltbld', 07:41:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:41:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:41:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:07 INFO - 'MOZ_NO_REMOTE': '1', 07:41:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:41:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:41:07 INFO - 'NO_EM_RESTART': '1', 07:41:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:41:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:07 INFO - 'PWD': '/builds/slave/test', 07:41:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:41:07 INFO - 'RUST_BACKTRACE': '1', 07:41:07 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:41:07 INFO - 'SHELL': '/bin/bash', 07:41:07 INFO - 'SHLVL': '1', 07:41:07 INFO - 'TERM': 'linux', 07:41:07 INFO - 'TMOUT': '86400', 07:41:07 INFO - 'USER': 'cltbld', 07:41:07 INFO - 'XDG_SESSION_COOKIE': '2432103b8b3de4003b23cad4000001c2-1497018146.6005-1156111273', 07:41:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:07 INFO - '_': '/tools/buildbot/bin/python'} 07:41:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QvlAUGC5St2tr8EEkJfhLQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-070', '--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 07:41:07 INFO - mozversion application_buildid: 20170609140357 07:41:07 INFO - mozversion application_changeset: eca8d0ea03af1d2424550a037f714f14c0f7b1be 07:41:07 INFO - mozversion application_display_name: Nightly 07:41:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:41:07 INFO - mozversion application_name: Firefox 07:41:07 INFO - mozversion application_remotingname: firefox 07:41:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:41:07 INFO - mozversion application_vendor: Mozilla 07:41:07 INFO - mozversion application_version: 55.0a1 07:41:07 INFO - mozversion platform_buildid: 20170609140357 07:41:07 INFO - mozversion platform_changeset: eca8d0ea03af1d2424550a037f714f14c0f7b1be 07:41:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:41:07 INFO - mozversion platform_version: 55.0a1 07:41:07 INFO - using testdate: 1497019267 07:41:07 INFO - actual date: 1497019267 07:41:07 INFO - starting webserver on 'localhost:57644' 07:41:07 INFO - SUITE-START | Running 2 tests 07:41:07 INFO - TEST-START | dromaeo_css 07:41:07 INFO - operating with platform_type : linux_ 07:41:07 INFO - Initialising browser for dromaeo_css test... 07:41:08 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57644/getInfo.html -profile /tmp/tmpKdwmcQ/profile 07:41:08 INFO - TEST-INFO | started process 3374 (/builds/slave/test/build/application/firefox/firefox http://localhost:57644/getInfo.html) 07:41:44 INFO - TEST-INFO | 3374: killed by SIGTERM 07:41:44 INFO - Browser initialized. 07:41:44 INFO - Running cycle 1/1 for dromaeo_css test... 07:41:44 INFO - TEST-INFO | started process 3584 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKdwmcQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:41:56 INFO - PID 3584 | RSS: Main: 183828480 07:41:56 INFO - PID 3584 | 07:44:56 INFO - PID 3584 | Cycle 1(1): loaded http://localhost:57644/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57644/tests/dromaeo/cssquery-ext.html) 07:44:57 INFO - PID 3584 | RSS: Main: 179765248 07:44:57 INFO - PID 3584 | 07:47:59 INFO - PID 3584 | Cycle 1(1): loaded http://localhost:57644/tests/dromaeo/cssquery-ext.html (next: http://localhost:57644/tests/dromaeo/cssquery-jquery.html) 07:48:00 INFO - PID 3584 | RSS: Main: 184451072 07:48:00 INFO - PID 3584 | 07:51:02 INFO - PID 3584 | Cycle 1(1): loaded http://localhost:57644/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57644/tests/dromaeo/cssquery-mootools.html) 07:51:02 INFO - PID 3584 | RSS: Main: 184442880 07:51:02 INFO - PID 3584 | 07:54:04 INFO - PID 3584 | Cycle 1(1): loaded http://localhost:57644/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57644/tests/dromaeo/cssquery-prototype.html) 07:54:05 INFO - PID 3584 | RSS: Main: 185196544 07:54:05 INFO - PID 3584 | 07:57:07 INFO - PID 3584 | Cycle 1(1): loaded http://localhost:57644/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57644/tests/dromaeo/cssquery-yui.html) 07:57:08 INFO - PID 3584 | RSS: Main: 185413632 07:57:08 INFO - PID 3584 | 08:00:10 INFO - PID 3584 | Cycle 1(1): loaded http://localhost:57644/tests/dromaeo/cssquery-yui.html (next: http://localhost:57644/tests/dromaeo/cssquery-dojo.html) 08:00:10 INFO - PID 3584 | RSS: Main: 184881152 08:00:10 INFO - PID 3584 | 08:00:10 INFO - PID 3584 | __start_tp_report 08:00:10 INFO - PID 3584 | _x_x_mozilla_page_load 08:00:10 INFO - PID 3584 | _x_x_mozilla_page_load_details 08:00:10 INFO - PID 3584 | |i|pagename|runs| 08:00:10 INFO - PID 3584 | |0;dojo.html;3046.1927589188863;3078.2766049978236;3082.58385118009;3093.5669006339117;3094.3811237752457;5808.099744539592;5971.641701497902;6012.1582978383;6018.638881667098;6021.187139736135;5851.941480585193;5892.381299963496;5931.495822855051;5999.880002399949;6013.909791353133;5384.5692344612535;5494.450554944514;5527.088030474967;5550.500454959053;5551.361593416768;5564.554835613141;5604.3835178130375;5615.5507559395355;5625.212470254168;5649.406812284713;5342.385625653061;5415.9458405415835;5443.673379597197;5531.2532808071;5586.91619625706;5517.779288828442;5530.11518157097;5550.16747487876;5556.555475561945;5559.193916882029;5457.781688732446;5489.752961116759;5493.505584497374;5513.724313784295;5514.172874068921;5733.655980641175;5926.140709597127;5935.49548288396;5947.791827286068;5954.345022047614;6224;6231.158793562857;6319.778807741753;6328.778492752732;6343.904841427382;6437.710303036374;6455.386738259858;6461.773837915697;6469.385408386196;6471.611703297817;5998.670073145975;6001.369856165127;6010.429009244115;6021.187139736167;6026.096085587197;6334.461570766536;6416.197975253093;6453.161089058486;6513.967430162819;6527.608343499405;6112.572119951649;6123.234595675541;6199.039148931923;6334.461570766536;6339.841503962438;6335.65153916539;6356.110144579762;6359.777407790798;6369.5222858285815;6408.871822563616;6313.589616674902;6377.330380310001;6392.744290228432;6400.839979000562;6427.485801135991;6230.470410015199;6317.46301564363;6321.715522801485;6381.617102973836;6395.42441180296;5252.1596544552685;5272.209168624737;5279.049771041249;5280.155175171954;5314.946850531523;4469.351943968107;4495.685302028892;4497.617702495259;4515.367848501212;4518.887027824265;5450.5367043800925;5494.395616482184;5563.02647036775;5631.6902570359025;5664.433556644385;6365.745370185141;6395.584287021329;6428.292887782341;6431.678416079178;6450.387213214737;5557.166425036277;5604.159376093618;5614.550835933115;5615.185798059259;5645.887082258332;5552.305961754781;5598.384177740445;5665.745041473144;5669.376368599451;5677.290338707661;6140.565599444434;6220.937790622126;6222.937770622327;6244.125822384961;6245;6367.044943258548;6403.679816009274;6403.743850245938;6409.327020662763;6411.134496842867;6061.939380606137;6199.969000154971;6223.844403889758;6224.128621992834;6242.812715618538;6219.067139929047;6235.064740288812;6322.209723784527;6343.270523889627;6374.3306952771145;6334.524910631629;6403.231612206565;6405.19935008124;6418.679066046772;6462.515311351762;6077.20996270482;6179.28938172116;6272.529560283088;6285.088662143872;6301.4328710416285;6140.350877192904;6168;6183.598066125687;6204.976178930426;6214.40963108504;6086.02623580225;6129.754809807558;6151.477124444473;6154.1999540059505;6168.845778855564;6119.602225855483;6257.374262573889;6257.749690012349;6272.843178920563;6298.212723409574;6070.423309785563;6080.7567697291615;6145.139680444652;6149.600275982047;6150.138980542638 08:00:10 INFO - PID 3584 | |1;ext.html;737.1265050914664;782.913879473258;796.6454927557238;1141.4121727310437;1160.3965937712385;36586;37481.06297342564;37489.62510374896;37648.81175594125;37664.05839854005;39019.804900975454;39243.41134882979;39484.605153948454;39573.60426395735;39586;7281.162666293365;7407.481476296648;7410.666520006613;7437.405007599406;7563.508371955805;7005.29947005298;7063.505554611179;7113.2531084235925;7116.7509137180205;7123.252058533857;7052.647367631598;7084.220735719066;7110.786676399691;7114.786556403316;7144.642767861612;7024.630197111565;7041.084658994349;7056.611886346249;7095.042169307155;7118.537295075804;7342.4860259781835;7368.3736882365065;7370.852582948364;7378.778636640909;7420.257974202591;36221.094472638135;36419.81790091059;36496.81751591225;36569.81715091434;36602.45096323557;3442.6901578858024;3478.6347433519622;3504.334176506481;3512.051746028558;3512.297540491912;28522.429551408855;28553;28584.28539286514;28587.285317867012;28606.284842878886;3559.8220088995445;3576.481410195507;3583.8387272572795;3590.8743193988084;3622.5109610202812;141361;144751;148616;169906;171111;43469;43506.99999999937;43579.346309805376;43643.34534981978;43764;46138.307925381145;46146.5385346149;46392.76803615961;46611;47412.52587474081;14689;14754.852451475348;14843.628909277355;14892.255387230594;14896.851031489547;11739.647810565697;11784.116191285688;11823.172377933462;11825.467853946593;11924.165308428326;14517.78223326651;14530.418783248762;14620.634484137981;14694;14799.70400591982;5764.164196191528;5790.276215473066;5887.558433117533;5972.910406343908;5996.1005849122985;996.7657600463886;1001.4942454060798;1012.6000229909145;1016.9084782369474;1022.1295526814733;22602.886985565296;22667.20664776725;23191.304260872203;23199.840007999872;23968.16111436126;1075.3601607043797;1088.646189988241;1102.20090434436;1123.5225029362489;1135.330155208431;12119.818202726967;12274.447649855778;12535.541848821162;12849.743005139844;12978.935105324414;204251;204577;205813;206058;207102;49287;49869.501304987214;49974.500254997714;49994;49995.250071248964;1396.4344440501613;1448.9275536223147;1448.9420423183165;1457.9489717860035;1458.1469840143634;21486.892565537073;22282.108715651193;23178.536429270982;23608.527829443658;23645;35836;35934.64065359418;36069.45895811512;36167.81916090403;36191;168558;169969;170286;170716.1464192671;170730;34368;34741.826290869394;34806.47790283097;34977.65022349744;35046.29907401888;40233.79883100566;40468.1906361877;40674.59325406826;41269.58730412657;41719.1656166881;29374.853125734233;29453.55819662664;30406.695933040388;30552.541711873895;31218.21954451157;29203.269918252212;29726.25684357908;29881.850590747777;30273.394532109676;30460.695393045786;33754.46841486849;33854.492182617774;33899.49150762691;33923.83038084794;34000;30097.548536771526;30533.847330763205;30579.694203058574;31529.842350788098;31829;22214.555708886055;24717.752822471546;25078.49843003166;25166.62250066214;25177.370565736004 08:00:10 INFO - PID 3584 | |2;jquery.html;493.7827355963374;505.4844059059758;506.6200349737697;518.543681560227;521.324884274864;14516.201608911506;17343.566410839736;19637.705434418476;20568.588628227444;20629.793702062976;21784;21807.23674671387;21920.89039554804;21966.121355145777;21997.890010549963;6075.544334174943;6158;6184.536159788034;6207.596506227103;6211.192544969148;5928.3775203603645;6125.877482450371;6135.447809697126;6136.601120927147;6137.6317420954665;5579.721013949306;5828.47543721065;5841.123831425278;6073.483753880925;6086.026235802273;5862.472377486026;5876.882462350772;5887.999040163182;5898.616589921663;5907.232059832238;5430.402655707869;5435.592330575183;5452.809151679712;5453.672779633234;5457.126859702428;24771.380715482075;24799.380015499577;25044.624330635055;25076.373090672696;25127.37181570457;1903.809619038099;1928.0745242283642;1948.1428171604448;1958.637652034364;1959.8824070555813;18057.27770889163;18467.538311542183;18525.814741852544;18561.628767424576;18582;2298.218605674079;2336.953260934789;2359.8702071386065;2361.2089949866813;2368.301351101429;115357.4232128834;120401;121019.99999999911;121381.39309303486;122008;19065.523361916064;19328.323508677127;19763.505912352306;19804.50488737793;19827.206911723657;39237;39360;39474.80262598669;39499;39547.80226098908;10358.46217676674;10364.326318789406;10401.375917444977;10590.788184236271;10595.470226488645;8639;8665.740027799176;8772.605232764541;8782.077881822444;8808.427452215585;7728.420368472387;10472.476376181161;10561.155107591529;10675.62635307776;10780.29928054674;2373.8575685458927;2399.532091242191;2407.3500154958065;2433.951320973606;2498.8375755576194;957.2772556719772;961.110972350573;962.855571664242;986.1174249047062;998.8801343838786;17623;17644.558886027953;17994.91002545005;18238.726419103725;18583.814161858478;978.9657361992296;981.764376549623;1015.5836107196014;1018.8522664213648;1019.7348689340824;9638;9842.409455432697;10007.449590272605;10102.646407375707;10228.335158214692;437060;448661;451621;455783;459176;101497;105033.47483262535;105601.47199264108;106113.46943265235;106266;1177.3877583656451;1200.477792160413;1226.7607816475702;1235.1292338901053;1248.7377650693275;16806.66386672284;17437.054489547292;18594.349197778014;19086.61826763429;19334.903325483283;48027;49332.50667493279;49458;49580;50285.49714502808;62141.378586213556;62803;63013;63389;64153.35846641474;10885.510152043336;11027.283226590245;11140.108791296514;11170.609028683957;11173.106151508022;16104.838951610334;16283.511494655178;16305.836941630907;16458;16472.341106356092;13580.864191358356;14041.92979035139;14110.50613228532;14119.294035298399;14179.220142891827;12382.133250672367;12947.741045179233;13012;13013.739725205633;13164.670883227996;14136.78794818058;14241.928790355982;14330.498432555227;14345.99578029528;14368.856311436752;10802.189835762192;10890.23768336209;10941.179411544006;10946.507407166537;10985.121190304917;12633.873661263637;12844.229346239255;13531.052826302064;13749.243791591558;13951.302434878013 08:00:10 INFO - PID 3584 | |3;mootools.html;1272.9809052864205;1339.5847287340919;1341.4835288413958;1345.6837643153858;1355.0988592585932;11355;11870.821937670942;11876.821847672281;11946.402679865994;12389.19470234434;12041.879581204184;12155.878441215586;12176.452059657315;12214.69463263419;12287.262764234152;2375.714914210297;2427.817913656474;2432.0271891243556;2437.81716371272;2441.108995216751;2312.398776318161;2381.2141993142222;2464.3346296499935;2468.6297055441737;2471.456279618481;2478.5414698280783;2485.428351479161;2513.45960618467;2514.2959971208093;2524.0787112703824;2333.3349995251274;2354.458474550854;2360.5986982213067;2362.976370236293;2363.810895128403;2173.228503881131;2184.7159869217057;2191.561687662474;2199.527101673148;2207.8896055197174;11602.187846850724;11742.119341049456;11844.881551184464;11867.347295898722;11877.346745928971;6645.60126392418;6889.069975553286;6908.5509441886115;6923.169219693618;6924.446044316443;3834.69322454203;3892.4355968384707;3925.1168487090463;3977.840886364542;4012.6388625023887;1321.2865052871439;1331.8202042724206;1359.8096266522696;1363.2842757552264;1365.542543248013;16579.917100414543;17155.39956101543;17780.46658600244;17915.552111197194;18020.63958720818;5562.3047119110115;5708.1723150143;5825.650460972355;5858.179854820329;5878.676672783038;13006.934965325303;13041.869581304256;13045.608631741063;13046.47814087445;13113.803292950613;6559.245686746085;6571.31001244872;6616.768413105518;6627.734890604322;6633.104530888365;6135.417135372132;6186.876262474725;6234.470070044006;6235.282942461584;6287.685615719196;4128.814203360856;4220.2192594370135;4261.914761704748;4287.721298115613;4321.286987647066;1272.2557303977278;1337.7993301004733;1339.1563315111418;1347.3330701302723;1362.2779926638898;856.9914300856911;867.7830542364409;870.9520976346362;878.6441491195948;903.2864037410372;6224.408681175281;6668.833279167962;6839.179298484214;6931.1682598088555;7180.798350973151;667.396006614015;680.129434324066;682.4199430484049;683.4703105093492;690.7478770248823;3983.9203215935518;4019.0957034666967;4165.770882601425;4214.578542145761;4332.523422423531;14577.125372477685;15359.846401536066;15365.539033829004;15371.846281537266;15417.922910385376;14698.63253418673;14990.775138372934;15058.247087645574;15093.39626414953;15407.922960385127;8808.339374546935;8988.820223595492;9008.729738107868;9026.593803278869;9034.367594268339;7097.787066388017;7470.0662417197855;7641.465097443125;7730;7871.960640196762;13902.16587004783;14121.2939353034;14195.361208745839;14228.857711422754;14335.354909029327;14269.500567480089;14327;14396;14413.567592972227;14415.207163606103;9724.465154416292;9967.601295948081;10003.249756268455;10003.2997690161;10003.449810260505;10996.23026388145;11162.720931976766;11189.38458384764;11259.099272058053;11334.659960201207;9024.187823095954;9184.173424391836;9194.218491428304;9218;9378.812423751624;8964.596593153194;8996.730098097067;9006.909930900607;9154.496502692416;9207.263418926605;7837.137914829478;7878.094019187867;7919.366450684047;7943.4836735612;7959.920400795918;5615.508474161465;5881.882362352643;5898.1152827076285;5976.641401515923;5987.9401205989125;5331.9466805333;5507.5593952484505;5574.721263936868;5623.803166889139;5636.464535869086 08:00:10 INFO - PID 3584 | |4;prototype.html;448.7845833999679;449.8065831692372;462.90279041401305;462.96064834489044;469.1531785127845;6236.345183755709;6339.524535659827;6340.334264902182;6392.456641185493;6402.391772781578;5932.436418540243;6075.908861367083;6149.692515374236;6177.351378105302;6207.534434917388;4866.148424025799;4877.682950608208;4887.804487820501;4900.705957642535;4915.139850526161;4875.8537243882565;4880.194767863299;4895.265710143472;4906.435759887623;4908.705477671333;4765.451973023095;4781.784819683123;4789.425268967729;4808.519148085198;4854.417469903617;4823.107725070873;4831.323614693928;4835.347228124193;4851.151048566522;4857.514248575149;4306.978465107686;4309.017851788181;4316.589923957219;4318.460192475941;4326.156399502099;5989.215015018038;6073.301570319426;6073.726682299307;6090.725917333731;6091.329953705089;5526.281583394133;5540.9168862466695;5591.685953800894;5595.776168953237;5596.440355964371;6534.967325163391;6535.529505861191;6547.526806468554;6555.704993275314;6583.604983700993;4669.719816811003;4676.859694209145;4698.7650617469335;4720.551547602972;4729.408823897013;6559.540832141752;6762.053312536298;6846.760363387308;6936.306369363074;6960.756373526953;4547.795349209294;4750.14497390473;4752;4767.927216376288;4813.4945830687975;4822.252550854553;4845.345878306454;4848.927266091011;4867.367242258484;4869.805207791719;5475.972620136874;5482.533984611353;5505.449455054542;5533.418991005887;5538.224648549206;6334.683265836689;6492.156019717407;6499.902501462482;6570;6584.802455926234;1663.6755832612766;1683.8063622683549;1685.3764107280385;1687.6118492746737;1691.5263726156695;1105.3754628634956;1130.4178348150708;1140.1676775953601;1141.298101667485;1162.9417230320537;5832.154337621106;5835.416458354215;5844.9415505845245;5849.61977471463;5868.941310586925;6710.295418981034;6721.8655626887185;6730.831729206809;6750.966245168743;6765.763198288135;5757.625754326039;5777;5781.219535362672;5789.8263052108505;5795.623284486495;3555.72433642469;3564.698884907042;3585.9779962710504;3587.833953964972;3609.097725568608;6506.219253689587;6558.672066396661;6561.311062338481;6580.703868325841;6584.901226481511;6865;6888.380045795902;6909.550879192836;6923.9653801730665;6944.4097251734165;6473.611583305017;6504.414602685781;6535.379138981789;6543.419606275721;6544.3782840630065;6663.833404164935;6729.730810767514;6730;6753.662316884038;6756.932430675631;6685.966570167313;6724.193096828412;6725.70440484169;6756.412243122961;6772.173721847141;6155.969220153871;6498.870022599427;6566.967165164144;6592.439642630238;6597.901031484627;4814.975925120352;4815.205491094071;4828.082664293773;4830.637702172421;4845.127876982177;6735.696893639896;6739.427148692416;6744.966275168789;6753.189617245962;6768.830779230361;6275.623462592259;6488.188976377953;6563.803085907431;6565.540412171103;6587.143671322698;6539.051837483634;6543.672816359068;6549.345065493412;6556.934430655823;6598.472122230306;6423.325550817284;6473.255575608865;6475.352464753675;6495.188101487314;6517.315681853337;6576.2766095728475;6607.537472376887;6629.596878543971;6635.23694775107;6657.968014957689;6408.788967806099;6428.55000149985;6442.774502892376;6454.870902582016;6462.935370646233 08:00:10 INFO - PID 3584 | |5;yui.html;789.8617741895174;833.3291700181353;833.7415401225617;835.8829763833064;836.8075342671185;16411.67176656466;17082.40211592593;17152.142392880367;17154.742678859813;18678.813211867877;17539.386121485717;17911.104444777775;18188.818111818877;18197.090145492737;18215.27138914445;939.671115109713;964.8263312603729;968.0948313327061;971.8736564246637;972.2367941166151;928.4336554701661;931.74842792446;935.6351023100996;958.4776296918196;977.0278572820054;1018.2057994764095;1033.9534720937538;1042.7393151712072;1043.7495001199695;1044.7753732947415;1020.8570800087994;1032.6282538286212;1033.2508931025022;1034.4672493665769;1037.7146284771673;741.7700512840983;750.4971668981796;752.1763668782675;753.3445902065183;754.6528596845403;16249.350025998945;16447.588810279718;16549.50351489457;16764.07797571133;16889.324427022904;17246;17499.737503937453;17615.647687046316;17671.29314827418;17849.464516064538;14960.850391496055;15185.316660750294;15205.01167424125;15256.694866102727;15258.542243732705;3361.9831900840586;3366.208940898887;3372.359251742161;3382.391169589473;3409.215880347509;83265;84328;84584.57707711484;85009;85035.57482212612;13779.517716880062;13800.861991379958;13988.370523326475;14001.579952601438;14041.1575305482;24001.399965001016;24407.511849762905;26029.9588016481;26161.476770464484;26201.73798261993;8134.674613015413;8291.668333266722;8538.530380829114;8547.487150770974;8567.957160214159;3925.646691797752;3983.6813054955533;3991.3015222335976;3996.980015099906;4004.099077707551;4120.2583534964;4120.896977575585;4182.121754431542;4231.428757117811;4234.174336004511;846.7925358287135;861.2679222660813;871.3247233394044;877.8288233794476;879.0418443896184;593.851537115721;595.9880802383929;602.2231321595181;605.9545534084962;620.3765215957933;9619.56711947964;10940.179486538382;11519.827202591969;11802.94098529502;12039.699007524707;669.334012657409;674.780696273713;676.1413005483009;683.9760608378683;684.0799125176629;5530.009196689189;5704.486596206361;5733.4233085901715;5888.17565540816;6018.307894592091;85884.57057714672;88000.5599971996;89882.55058724665;91420.08579914116;91555.08444915598;75683.62158189174;76293.6185319081;76708.61645691848;76784.61607691926;77196.61401692955;67921.3207867925;68957.999999999;71879.6406017977;73051;74275.62862185655;11698;12398.07014473936;12411;12518.311492867979;12587.811182832447;31196;31455;32020.6797932027;32664.183395414355;33072;40200.396994045695;40497;40966.590334096276;40976.1804763909;42199.57800421956;17319.2206350712;17440.73838892443;17791;17840.19719112617;18146.092695364914;17691;17723.556911076812;17769.555761106076;18070.186841592422;18099.185536651145;17278.395256165975;17362.13189340553;17364.652706946043;17731.113444327475;17980.19089141018;17378.47864564065;17426.564335891704;17536;17893;18012.189451474453;16869.240884159997;17132.143392830058;17140.228689708743;17222.741658874875;17477.475675729747;10532.420716860646;10692.716873975172;11150.10799136051;11272.380019099028;11481.598144064918;11714.414279285831;11783.293002419883;11805.852678082696;12216.816747748613;12300.138990270596 08:00:10 INFO - PID 3584 | __end_tp_report 08:00:10 INFO - PID 3584 | __start_cc_report 08:00:10 INFO - PID 3584 | _x_x_mozilla_cycle_collect,394 08:00:10 INFO - PID 3584 | __end_cc_report 08:00:10 INFO - PID 3584 | __startTimestamp1497020410625__endTimestamp 08:00:10 INFO - PID 3584 | 08:00:10 INFO - PID 3584 | ------- Summary: start ------- 08:00:10 INFO - PID 3584 | Number of tests: 6 08:00:10 INFO - PID 3584 | 08:00:10 INFO - PID 3584 | [#0] dojo.html Cycles:165 Average:5891.26 Median:6123.23 stddev:663.20 (10.8%) stddev-sans-first:626.56 08:00:10 INFO - PID 3584 | Values: 3046.2 3078.3 3082.6 3093.6 3094.4 5808.1 5971.6 6012.2 6018.6 6021.2 5851.9 5892.4 5931.5 5999.9 6013.9 5384.6 5494.5 5527.1 5550.5 5551.4 5564.6 5604.4 5615.6 5625.2 5649.4 5342.4 5415.9 5443.7 5531.3 5586.9 5517.8 5530.1 5550.2 5556.6 5559.2 5457.8 5489.8 5493.5 5513.7 5514.2 5733.7 5926.1 5935.5 5947.8 5954.3 6224.0 6231.2 6319.8 6328.8 6343.9 6437.7 6455.4 6461.8 6469.4 6471.6 5998.7 6001.4 6010.4 6021.2 6026.1 6334.5 6416.2 6453.2 6514.0 6527.6 6112.6 6123.2 6199.0 6334.5 6339.8 6335.7 6356.1 6359.8 6369.5 6408.9 6313.6 6377.3 6392.7 6400.8 6427.5 6230.5 6317.5 6321.7 6381.6 6395.4 5252.2 5272.2 5279.0 5280.2 5314.9 4469.4 4495.7 4497.6 4515.4 4518.9 5450.5 5494.4 5563.0 5631.7 5664.4 6365.7 6395.6 6428.3 6431.7 6450.4 5557.2 5604.2 5614.6 5615.2 5645.9 5552.3 5598.4 5665.7 5669.4 5677.3 6140.6 6220.9 6222.9 6244.1 6245.0 6367.0 6403.7 6403.7 6409.3 6411.1 6061.9 6200.0 6223.8 6224.1 6242.8 6219.1 6235.1 6322.2 6343.3 6374.3 6334.5 6403.2 6405.2 6418.7 6462.5 6077.2 6179.3 6272.5 6285.1 6301.4 6140.4 6168.0 6183.6 6205.0 6214.4 6086.0 6129.8 6151.5 6154.2 6168.8 6119.6 6257.4 6257.7 6272.8 6298.2 6070.4 6080.8 6145.1 6149.6 6150.1 08:00:10 INFO - PID 3584 | 08:00:10 INFO - PID 3584 | [#1] ext.html Cycles:180 Average:34079.51 Median:34184.00 stddev:46088.74 (134.8%) stddev-sans-first:46150.03 08:00:10 INFO - PID 3584 | Values: 737.1 782.9 796.6 1141.4 1160.4 36586.0 37481.1 37489.6 37648.8 37664.1 39019.8 39243.4 39484.6 39573.6 39586.0 7281.2 7407.5 7410.7 7437.4 7563.5 7005.3 7063.5 7113.3 7116.8 7123.3 7052.6 7084.2 7110.8 7114.8 7144.6 7024.6 7041.1 7056.6 7095.0 7118.5 7342.5 7368.4 7370.9 7378.8 7420.3 36221.1 36419.8 36496.8 36569.8 36602.5 3442.7 3478.6 3504.3 3512.1 3512.3 28522.4 28553.0 28584.3 28587.3 28606.3 3559.8 3576.5 3583.8 3590.9 3622.5 141361.0 144751.0 148616.0 169906.0 171111.0 43469.0 43507.0 43579.3 43643.3 43764.0 46138.3 46146.5 46392.8 46611.0 47412.5 14689.0 14754.9 14843.6 14892.3 14896.9 11739.6 11784.1 11823.2 11825.5 11924.2 14517.8 14530.4 14620.6 14694.0 14799.7 5764.2 5790.3 5887.6 5972.9 5996.1 996.8 1001.5 1012.6 1016.9 1022.1 22602.9 22667.2 23191.3 23199.8 23968.2 1075.4 1088.6 1102.2 1123.5 1135.3 12119.8 12274.4 12535.5 12849.7 12978.9 204251.0 204577.0 205813.0 206058.0 207102.0 49287.0 49869.5 49974.5 49994.0 49995.3 1396.4 1448.9 1448.9 1457.9 1458.1 21486.9 22282.1 23178.5 23608.5 23645.0 35836.0 35934.6 36069.5 36167.8 36191.0 168558.0 169969.0 170286.0 170716.1 170730.0 34368.0 34741.8 34806.5 34977.7 35046.3 40233.8 40468.2 40674.6 41269.6 41719.2 29374.9 29453.6 30406.7 30552.5 31218.2 29203.3 29726.3 29881.9 30273.4 30460.7 33754.5 33854.5 33899.5 33923.8 34000.0 30097.5 30533.8 30579.7 31529.8 31829.0 22214.6 24717.8 25078.5 25166.6 25177.4 08:00:10 INFO - PID 3584 | 08:00:10 INFO - PID 3584 | [#2] jquery.html Cycles:180 Average:31635.07 Median:19784.01 stddev:75672.66 (382.5%) stddev-sans-first:75848.82 08:00:10 INFO - PID 3584 | Values: 493.8 505.5 506.6 518.5 521.3 14516.2 17343.6 19637.7 20568.6 20629.8 21784.0 21807.2 21920.9 21966.1 21997.9 6075.5 6158.0 6184.5 6207.6 6211.2 5928.4 6125.9 6135.4 6136.6 6137.6 5579.7 5828.5 5841.1 6073.5 6086.0 5862.5 5876.9 5888.0 5898.6 5907.2 5430.4 5435.6 5452.8 5453.7 5457.1 24771.4 24799.4 25044.6 25076.4 25127.4 1903.8 1928.1 1948.1 1958.6 1959.9 18057.3 18467.5 18525.8 18561.6 18582.0 2298.2 2337.0 2359.9 2361.2 2368.3 115357.4 120401.0 121020.0 121381.4 122008.0 19065.5 19328.3 19763.5 19804.5 19827.2 39237.0 39360.0 39474.8 39499.0 39547.8 10358.5 10364.3 10401.4 10590.8 10595.5 8639.0 8665.7 8772.6 8782.1 8808.4 7728.4 10472.5 10561.2 10675.6 10780.3 2373.9 2399.5 2407.4 2434.0 2498.8 957.3 961.1 962.9 986.1 998.9 17623.0 17644.6 17994.9 18238.7 18583.8 979.0 981.8 1015.6 1018.9 1019.7 9638.0 9842.4 10007.4 10102.6 10228.3 437060.0 448661.0 451621.0 455783.0 459176.0 101497.0 105033.5 105601.5 106113.5 106266.0 1177.4 1200.5 1226.8 1235.1 1248.7 16806.7 17437.1 18594.3 19086.6 19334.9 48027.0 49332.5 49458.0 49580.0 50285.5 62141.4 62803.0 63013.0 63389.0 64153.4 10885.5 11027.3 11140.1 11170.6 11173.1 16104.8 16283.5 16305.8 16458.0 16472.3 13580.9 14041.9 14110.5 14119.3 14179.2 12382.1 12947.7 13012.0 13013.7 13164.7 14136.8 14241.9 14330.5 14346.0 14368.9 10802.2 10890.2 10941.2 10946.5 10985.1 12633.9 12844.2 13531.1 13749.2 13951.3 08:00:10 INFO - PID 3584 | 08:00:10 INFO - PID 3584 | [#3] mootools.html Cycles:180 Average:7289.21 Median:2513.88 stddev:4750.06 (189.0%) stddev-sans-first:4741.87 08:00:10 INFO - PID 3584 | Values: 1273.0 1339.6 1341.5 1345.7 1355.1 11355.0 11870.8 11876.8 11946.4 12389.2 12041.9 12155.9 12176.5 12214.7 12287.3 2375.7 2427.8 2432.0 2437.8 2441.1 2312.4 2381.2 2464.3 2468.6 2471.5 2478.5 2485.4 2513.5 2514.3 2524.1 2333.3 2354.5 2360.6 2363.0 2363.8 2173.2 2184.7 2191.6 2199.5 2207.9 11602.2 11742.1 11844.9 11867.3 11877.3 6645.6 6889.1 6908.6 6923.2 6924.4 3834.7 3892.4 3925.1 3977.8 4012.6 1321.3 1331.8 1359.8 1363.3 1365.5 16579.9 17155.4 17780.5 17915.6 18020.6 5562.3 5708.2 5825.7 5858.2 5878.7 13006.9 13041.9 13045.6 13046.5 13113.8 6559.2 6571.3 6616.8 6627.7 6633.1 6135.4 6186.9 6234.5 6235.3 6287.7 4128.8 4220.2 4261.9 4287.7 4321.3 1272.3 1337.8 1339.2 1347.3 1362.3 857.0 867.8 871.0 878.6 903.3 6224.4 6668.8 6839.2 6931.2 7180.8 667.4 680.1 682.4 683.5 690.7 3983.9 4019.1 4165.8 4214.6 4332.5 14577.1 15359.8 15365.5 15371.8 15417.9 14698.6 14990.8 15058.2 15093.4 15407.9 8808.3 8988.8 9008.7 9026.6 9034.4 7097.8 7470.1 7641.5 7730.0 7872.0 13902.2 14121.3 14195.4 14228.9 14335.4 14269.5 14327.0 14396.0 14413.6 14415.2 9724.5 9967.6 10003.2 10003.3 10003.4 10996.2 11162.7 11189.4 11259.1 11334.7 9024.2 9184.2 9194.2 9218.0 9378.8 8964.6 8996.7 9006.9 9154.5 9207.3 7837.1 7878.1 7919.4 7943.5 7959.9 5615.5 5881.9 5898.1 5976.6 5987.9 5331.9 5507.6 5574.7 5623.8 5636.5 08:00:10 INFO - PID 3584 | 08:00:10 INFO - PID 3584 | [#4] prototype.html Cycles:180 Average:5466.12 Median:6091.03 stddev:1583.87 (26.0%) stddev-sans-first:1542.90 08:00:10 INFO - PID 3584 | Values: 448.8 449.8 462.9 463.0 469.2 6236.3 6339.5 6340.3 6392.5 6402.4 5932.4 6075.9 6149.7 6177.4 6207.5 4866.1 4877.7 4887.8 4900.7 4915.1 4875.9 4880.2 4895.3 4906.4 4908.7 4765.5 4781.8 4789.4 4808.5 4854.4 4823.1 4831.3 4835.3 4851.2 4857.5 4307.0 4309.0 4316.6 4318.5 4326.2 5989.2 6073.3 6073.7 6090.7 6091.3 5526.3 5540.9 5591.7 5595.8 5596.4 6535.0 6535.5 6547.5 6555.7 6583.6 4669.7 4676.9 4698.8 4720.6 4729.4 6559.5 6762.1 6846.8 6936.3 6960.8 4547.8 4750.1 4752.0 4767.9 4813.5 4822.3 4845.3 4848.9 4867.4 4869.8 5476.0 5482.5 5505.4 5533.4 5538.2 6334.7 6492.2 6499.9 6570.0 6584.8 1663.7 1683.8 1685.4 1687.6 1691.5 1105.4 1130.4 1140.2 1141.3 1162.9 5832.2 5835.4 5844.9 5849.6 5868.9 6710.3 6721.9 6730.8 6751.0 6765.8 5757.6 5777.0 5781.2 5789.8 5795.6 3555.7 3564.7 3586.0 3587.8 3609.1 6506.2 6558.7 6561.3 6580.7 6584.9 6865.0 6888.4 6909.6 6924.0 6944.4 6473.6 6504.4 6535.4 6543.4 6544.4 6663.8 6729.7 6730.0 6753.7 6756.9 6686.0 6724.2 6725.7 6756.4 6772.2 6156.0 6498.9 6567.0 6592.4 6597.9 4815.0 4815.2 4828.1 4830.6 4845.1 6735.7 6739.4 6745.0 6753.2 6768.8 6275.6 6488.2 6563.8 6565.5 6587.1 6539.1 6543.7 6549.3 6556.9 6598.5 6423.3 6473.3 6475.4 6495.2 6517.3 6576.3 6607.5 6629.6 6635.2 6658.0 6408.8 6428.6 6442.8 6454.9 6462.9 08:00:10 INFO - PID 3584 | 08:00:10 INFO - PID 3584 | [#5] yui.html Cycles:180 Average:19066.07 Median:31737.84 stddev:23752.87 (74.8%) stddev-sans-first:23779.85 08:00:10 INFO - PID 3584 | Values: 789.9 833.3 833.7 835.9 836.8 16411.7 17082.4 17152.1 17154.7 18678.8 17539.4 17911.1 18188.8 18197.1 18215.3 939.7 964.8 968.1 971.9 972.2 928.4 931.7 935.6 958.5 977.0 1018.2 1034.0 1042.7 1043.7 1044.8 1020.9 1032.6 1033.3 1034.5 1037.7 741.8 750.5 752.2 753.3 754.7 16249.4 16447.6 16549.5 16764.1 16889.3 17246.0 17499.7 17615.6 17671.3 17849.5 14960.9 15185.3 15205.0 15256.7 15258.5 3362.0 3366.2 3372.4 3382.4 3409.2 83265.0 84328.0 84584.6 85009.0 85035.6 13779.5 13800.9 13988.4 14001.6 14041.2 24001.4 24407.5 26030.0 26161.5 26201.7 8134.7 8291.7 8538.5 8547.5 8568.0 3925.6 3983.7 3991.3 3997.0 4004.1 4120.3 4120.9 4182.1 4231.4 4234.2 846.8 861.3 871.3 877.8 879.0 593.9 596.0 602.2 606.0 620.4 9619.6 10940.2 11519.8 11802.9 12039.7 669.3 674.8 676.1 684.0 684.1 5530.0 5704.5 5733.4 5888.2 6018.3 85884.6 88000.6 89882.6 91420.1 91555.1 75683.6 76293.6 76708.6 76784.6 77196.6 67921.3 68958.0 71879.6 73051.0 74275.6 11698.0 12398.1 12411.0 12518.3 12587.8 31196.0 31455.0 32020.7 32664.2 33072.0 40200.4 40497.0 40966.6 40976.2 42199.6 17319.2 17440.7 17791.0 17840.2 18146.1 17691.0 17723.6 17769.6 18070.2 18099.2 17278.4 17362.1 17364.7 17731.1 17980.2 17378.5 17426.6 17536.0 17893.0 18012.2 16869.2 17132.1 17140.2 17222.7 17477.5 10532.4 10692.7 11150.1 11272.4 11481.6 11714.4 11783.3 11805.9 12216.8 12300.1 08:00:10 INFO - PID 3584 | -------- Summary: end -------- 08:00:10 INFO - PID 3584 | 08:00:11 INFO - TEST-INFO | 3584: exit 0 08:00:11 INFO - TEST-OK | dromaeo_css | took 1143644ms 08:00:11 INFO - TEST-START | kraken 08:00:11 INFO - operating with platform_type : linux_ 08:00:11 INFO - Initialising browser for kraken test... 08:00:11 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:57644/getInfo.html -profile /tmp/tmpFAG2o7/profile 08:00:11 INFO - TEST-INFO | started process 3992 (/builds/slave/test/build/application/firefox/firefox http://localhost:57644/getInfo.html) 08:00:46 INFO - TEST-INFO | 3992: killed by SIGTERM 08:00:46 INFO - Browser initialized. 08:00:46 INFO - Running cycle 1/1 for kraken test... 08:00:46 INFO - TEST-INFO | started process 4198 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFAG2o7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:00:58 INFO - PID 4198 | RSS: Main: 184041472 08:00:58 INFO - PID 4198 | 08:01:00 INFO - PID 4198 | Cycle 1(1): loaded http://localhost:57644/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57644/tests/kraken/driver.html?testName=audio-beat-detection) 08:01:01 INFO - PID 4198 | RSS: Main: 188383232 08:01:01 INFO - PID 4198 | 08:01:04 INFO - PID 4198 | Cycle 1(1): loaded http://localhost:57644/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57644/tests/kraken/driver.html?testName=audio-dft) 08:01:05 INFO - PID 4198 | RSS: Main: 187613184 08:01:05 INFO - PID 4198 | 08:01:08 INFO - PID 4198 | Cycle 1(1): loaded http://localhost:57644/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57644/tests/kraken/driver.html?testName=audio-fft) 08:01:08 INFO - PID 4198 | RSS: Main: 183664640 08:01:08 INFO - PID 4198 | 08:01:10 INFO - PID 4198 | Cycle 1(1): loaded http://localhost:57644/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57644/tests/kraken/driver.html?testName=audio-oscillator) 08:01:11 INFO - PID 4198 | RSS: Main: 184635392 08:01:11 INFO - PID 4198 | 08:01:13 INFO - PID 4198 | Cycle 1(1): loaded http://localhost:57644/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57644/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:01:14 INFO - PID 4198 | RSS: Main: 184438784 08:01:14 INFO - PID 4198 | 08:01:17 INFO - PID 4198 | Cycle 1(1): loaded http://localhost:57644/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57644/tests/kraken/driver.html?testName=imaging-darkroom) 08:01:17 INFO - PID 4198 | RSS: Main: 185667584 08:01:17 INFO - PID 4198 | 08:01:21 INFO - PID 4198 | Cycle 1(1): loaded http://localhost:57644/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57644/tests/kraken/driver.html?testName=imaging-desaturate) 08:01:22 INFO - PID 4198 | RSS: Main: 184541184 08:01:22 INFO - PID 4198 | 08:01:24 INFO - PID 4198 | Cycle 1(1): loaded http://localhost:57644/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57644/tests/kraken/driver.html?testName=json-parse-financial) 08:01:25 INFO - PID 4198 | RSS: Main: 185077760 08:01:25 INFO - PID 4198 | 08:01:27 INFO - PID 4198 | Cycle 1(1): loaded http://localhost:57644/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57644/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:01:27 INFO - PID 4198 | RSS: Main: 185577472 08:01:27 INFO - PID 4198 | 08:01:29 INFO - PID 4198 | Cycle 1(1): loaded http://localhost:57644/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57644/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:01:30 INFO - PID 4198 | RSS: Main: 185262080 08:01:30 INFO - PID 4198 | 08:01:32 INFO - PID 4198 | Cycle 1(1): loaded http://localhost:57644/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57644/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:01:33 INFO - PID 4198 | RSS: Main: 185356288 08:01:33 INFO - PID 4198 | 08:01:35 INFO - PID 4198 | Cycle 1(1): loaded http://localhost:57644/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57644/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:01:36 INFO - PID 4198 | RSS: Main: 185155584 08:01:36 INFO - PID 4198 | 08:01:39 INFO - PID 4198 | Cycle 1(1): loaded http://localhost:57644/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57644/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:01:40 INFO - PID 4198 | RSS: Main: 185323520 08:01:40 INFO - PID 4198 | 08:01:41 INFO - PID 4198 | Cycle 1(1): loaded http://localhost:57644/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57644/tests/kraken/driver.html?testName=ai-astar) 08:01:42 INFO - PID 4198 | RSS: Main: 186753024 08:01:42 INFO - PID 4198 | 08:01:42 INFO - PID 4198 | __start_tp_report 08:01:42 INFO - PID 4198 | _x_x_mozilla_page_load 08:01:42 INFO - PID 4198 | _x_x_mozilla_page_load_details 08:01:42 INFO - PID 4198 | |i|pagename|runs| 08:01:42 INFO - PID 4198 | |0;ai-astar;116;111;104;110;112;113;111;101;112;111 08:01:42 INFO - PID 4198 | |1;audio-beat-detection;150;125;156;182;121;147;150;122;170;128 08:01:42 INFO - PID 4198 | |2;audio-dft;165;170;166;166;167;165;168;173;162;165 08:01:42 INFO - PID 4198 | |3;audio-fft;76;75;74;187;75;73;74;73;173;76 08:01:42 INFO - PID 4198 | |4;audio-oscillator;83;83;132;84;82;85;128;82;83;143 08:01:42 INFO - PID 4198 | |5;imaging-gaussian-blur;113;115;113;113;115;118;113;114;115;114 08:01:42 INFO - PID 4198 | |6;imaging-darkroom;151;150;151;152;150;150;150;151;151;150 08:01:42 INFO - PID 4198 | |7;imaging-desaturate;94;95;94;94;94;94;94;96;94;94 08:01:42 INFO - PID 4198 | |8;json-parse-financial;56;61;60;57;55;56;63;57;55;59 08:01:42 INFO - PID 4198 | |9;json-stringify-tinderbox;55;55;56;55;55;55;54;54;56;55 08:01:42 INFO - PID 4198 | |10;stanford-crypto-aes;83;82;84;86;85;85;83;89;111;83 08:01:42 INFO - PID 4198 | |11;stanford-crypto-ccm;141;136;131;129;132;130;128;143;130;130 08:01:42 INFO - PID 4198 | |12;stanford-crypto-pbkdf2;179;193;190;193;191;188;190;189;178;190 08:01:42 INFO - PID 4198 | |13;stanford-crypto-sha256-iterative;70;72;76;69;69;69;70;71;71;68 08:01:42 INFO - PID 4198 | __end_tp_report 08:01:42 INFO - PID 4198 | __start_cc_report 08:01:42 INFO - PID 4198 | _x_x_mozilla_cycle_collect,1031 08:01:42 INFO - PID 4198 | __end_cc_report 08:01:42 INFO - PID 4198 | __startTimestamp1497020502054__endTimestamp 08:01:42 INFO - PID 4198 | 08:01:42 INFO - PID 4198 | ------- Summary: start ------- 08:01:42 INFO - PID 4198 | Number of tests: 14 08:01:42 INFO - PID 4198 | 08:01:42 INFO - PID 4198 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.50 stddev:4.38 (3.9%) stddev-sans-first:4.10 08:01:42 INFO - PID 4198 | Values: 116.0 111.0 104.0 110.0 112.0 113.0 111.0 101.0 112.0 111.0 08:01:42 INFO - PID 4198 | 08:01:42 INFO - PID 4198 | [#1] audio-beat-detection Cycles:10 Average:145.10 Median:150.00 stddev:20.98 (14.0%) stddev-sans-first:22.18 08:01:42 INFO - PID 4198 | Values: 150.0 125.0 156.0 182.0 121.0 147.0 150.0 122.0 170.0 128.0 08:01:42 INFO - PID 4198 | 08:01:42 INFO - PID 4198 | [#2] audio-dft Cycles:10 Average:166.70 Median:166.50 stddev:3.06 (1.8%) stddev-sans-first:3.18 08:01:42 INFO - PID 4198 | Values: 165.0 170.0 166.0 166.0 167.0 165.0 168.0 173.0 162.0 165.0 08:01:42 INFO - PID 4198 | 08:01:42 INFO - PID 4198 | [#3] audio-fft Cycles:10 Average:95.60 Median:74.50 stddev:44.62 (59.9%) stddev-sans-first:46.76 08:01:42 INFO - PID 4198 | Values: 76.0 75.0 74.0 187.0 75.0 73.0 74.0 73.0 173.0 76.0 08:01:42 INFO - PID 4198 | 08:01:42 INFO - PID 4198 | [#4] audio-oscillator Cycles:10 Average:98.50 Median:83.00 stddev:25.01 (30.1%) stddev-sans-first:25.89 08:01:42 INFO - PID 4198 | Values: 83.0 83.0 132.0 84.0 82.0 85.0 128.0 82.0 83.0 143.0 08:01:42 INFO - PID 4198 | 08:01:42 INFO - PID 4198 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.50 stddev:1.57 (1.4%) stddev-sans-first:1.59 08:01:42 INFO - PID 4198 | Values: 113.0 115.0 113.0 113.0 115.0 118.0 113.0 114.0 115.0 114.0 08:01:42 INFO - PID 4198 | 08:01:42 INFO - PID 4198 | [#6] imaging-darkroom Cycles:10 Average:150.60 Median:151.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 08:01:42 INFO - PID 4198 | Values: 151.0 150.0 151.0 152.0 150.0 150.0 150.0 151.0 151.0 150.0 08:01:42 INFO - PID 4198 | 08:01:42 INFO - PID 4198 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 08:01:42 INFO - PID 4198 | Values: 94.0 95.0 94.0 94.0 94.0 94.0 94.0 96.0 94.0 94.0 08:01:42 INFO - PID 4198 | 08:01:42 INFO - PID 4198 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:58.00 stddev:2.73 (4.7%) stddev-sans-first:2.80 08:01:42 INFO - PID 4198 | Values: 56.0 61.0 60.0 57.0 55.0 56.0 63.0 57.0 55.0 59.0 08:01:42 INFO - PID 4198 | 08:01:42 INFO - PID 4198 | [#9] json-stringify-tinderbox Cycles:10 Average:55.00 Median:55.00 stddev:0.67 (1.2%) stddev-sans-first:0.71 08:01:42 INFO - PID 4198 | Values: 55.0 55.0 56.0 55.0 55.0 55.0 54.0 54.0 56.0 55.0 08:01:42 INFO - PID 4198 | 08:01:42 INFO - PID 4198 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:84.50 stddev:8.63 (10.2%) stddev-sans-first:9.03 08:01:42 INFO - PID 4198 | Values: 83.0 82.0 84.0 86.0 85.0 85.0 83.0 89.0 111.0 83.0 08:01:42 INFO - PID 4198 | 08:01:42 INFO - PID 4198 | [#11] stanford-crypto-ccm Cycles:10 Average:133.00 Median:131.50 stddev:5.23 (4.0%) stddev-sans-first:4.68 08:01:42 INFO - PID 4198 | Values: 141.0 136.0 131.0 129.0 132.0 130.0 128.0 143.0 130.0 130.0 08:01:42 INFO - PID 4198 | 08:01:42 INFO - PID 4198 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.10 Median:190.00 stddev:5.30 (2.8%) stddev-sans-first:4.48 08:01:42 INFO - PID 4198 | Values: 179.0 193.0 190.0 193.0 191.0 188.0 190.0 189.0 178.0 190.0 08:01:42 INFO - PID 4198 | 08:01:42 INFO - PID 4198 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:70.50 stddev:2.27 (3.2%) stddev-sans-first:2.40 08:01:42 INFO - PID 4198 | Values: 70.0 72.0 76.0 69.0 69.0 69.0 70.0 71.0 71.0 68.0 08:01:42 INFO - PID 4198 | -------- Summary: end -------- 08:01:42 INFO - PID 4198 | 08:01:43 INFO - TEST-INFO | 4198: exit 0 08:01:43 INFO - TEST-OK | kraken | took 91711ms 08:01:43 INFO - SUITE-END | took 1235s 08:01:43 INFO - Completed test suite (00:20:35) 08:01:43 INFO - javascript benchmark 08:01:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7802.343778539849, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3046.1927589188863, 3078.2766049978236, 3082.58385118009, 3093.5669006339117, 3094.3811237752457, 5808.099744539592, 5971.641701497902, 6012.1582978383, 6018.638881667098, 6021.187139736135, 5851.941480585193, 5892.381299963496, 5931.495822855051, 5999.880002399949, 6013.909791353133, 5384.5692344612535, 5494.450554944514, 5527.088030474967, 5550.500454959053, 5551.361593416768, 5564.554835613141, 5604.3835178130375, 5615.5507559395355, 5625.212470254168, 5649.406812284713, 5342.385625653061, 5415.9458405415835, 5443.673379597197, 5531.2532808071, 5586.91619625706, 5517.779288828442, 5530.11518157097, 5550.16747487876, 5556.555475561945, 5559.193916882029, 5457.781688732446, 5489.752961116759, 5493.505584497374, 5513.724313784295, 5514.172874068921, 5733.655980641175, 5926.140709597127, 5935.49548288396, 5947.791827286068, 5954.345022047614, 6224.0, 6231.158793562857, 6319.778807741753, 6328.778492752732, 6343.904841427382, 6437.710303036374, 6455.386738259858, 6461.773837915697, 6469.385408386196, 6471.611703297817, 5998.670073145975, 6001.369856165127, 6010.429009244115, 6021.187139736167, 6026.096085587197, 6334.461570766536, 6416.197975253093, 6453.161089058486, 6513.967430162819, 6527.608343499405, 6112.572119951649, 6123.234595675541, 6199.039148931923, 6334.461570766536, 6339.841503962438, 6335.65153916539, 6356.110144579762, 6359.777407790798, 6369.5222858285815, 6408.871822563616, 6313.589616674902, 6377.330380310001, 6392.744290228432, 6400.839979000562, 6427.485801135991, 6230.470410015199, 6317.46301564363, 6321.715522801485, 6381.617102973836, 6395.42441180296, 5252.1596544552685, 5272.209168624737, 5279.049771041249, 5280.155175171954, 5314.946850531523, 4469.351943968107, 4495.685302028892, 4497.617702495259, 4515.367848501212, 4518.887027824265, 5450.5367043800925, 5494.395616482184, 5563.02647036775, 5631.6902570359025, 5664.433556644385, 6365.745370185141, 6395.584287021329, 6428.292887782341, 6431.678416079178, 6450.387213214737, 5557.166425036277, 5604.159376093618, 5614.550835933115, 5615.185798059259, 5645.887082258332, 5552.305961754781, 5598.384177740445, 5665.745041473144, 5669.376368599451, 5677.290338707661, 6140.565599444434, 6220.937790622126, 6222.937770622327, 6244.125822384961, 6245.0, 6367.044943258548, 6403.679816009274, 6403.743850245938, 6409.327020662763, 6411.134496842867, 6061.939380606137, 6199.969000154971, 6223.844403889758, 6224.128621992834, 6242.812715618538, 6219.067139929047, 6235.064740288812, 6322.209723784527, 6343.270523889627, 6374.3306952771145, 6334.524910631629, 6403.231612206565, 6405.19935008124, 6418.679066046772, 6462.515311351762, 6077.20996270482, 6179.28938172116, 6272.529560283088, 6285.088662143872, 6301.4328710416285, 6140.350877192904, 6168.0, 6183.598066125687, 6204.976178930426, 6214.40963108504, 6086.02623580225, 6129.754809807558, 6151.477124444473, 6154.1999540059505, 6168.845778855564, 6119.602225855483, 6257.374262573889, 6257.749690012349, 6272.843178920563, 6298.212723409574, 6070.423309785563, 6080.7567697291615, 6145.139680444652, 6149.600275982047, 6150.138980542638], "value": 5843.57683043205, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.1265050914664, 782.913879473258, 796.6454927557238, 1141.4121727310437, 1160.3965937712385, 36586.0, 37481.06297342564, 37489.62510374896, 37648.81175594125, 37664.05839854005, 39019.804900975454, 39243.41134882979, 39484.605153948454, 39573.60426395735, 39586.0, 7281.162666293365, 7407.481476296648, 7410.666520006613, 7437.405007599406, 7563.508371955805, 7005.29947005298, 7063.505554611179, 7113.2531084235925, 7116.7509137180205, 7123.252058533857, 7052.647367631598, 7084.220735719066, 7110.786676399691, 7114.786556403316, 7144.642767861612, 7024.630197111565, 7041.084658994349, 7056.611886346249, 7095.042169307155, 7118.537295075804, 7342.4860259781835, 7368.3736882365065, 7370.852582948364, 7378.778636640909, 7420.257974202591, 36221.094472638135, 36419.81790091059, 36496.81751591225, 36569.81715091434, 36602.45096323557, 3442.6901578858024, 3478.6347433519622, 3504.334176506481, 3512.051746028558, 3512.297540491912, 28522.429551408855, 28553.0, 28584.28539286514, 28587.285317867012, 28606.284842878886, 3559.8220088995445, 3576.481410195507, 3583.8387272572795, 3590.8743193988084, 3622.5109610202812, 141361.0, 144751.0, 148616.0, 169906.0, 171111.0, 43469.0, 43506.99999999937, 43579.346309805376, 43643.34534981978, 43764.0, 46138.307925381145, 46146.5385346149, 46392.76803615961, 46611.0, 47412.52587474081, 14689.0, 14754.852451475348, 14843.628909277355, 14892.255387230594, 14896.851031489547, 11739.647810565697, 11784.116191285688, 11823.172377933462, 11825.467853946593, 11924.165308428326, 14517.78223326651, 14530.418783248762, 14620.634484137981, 14694.0, 14799.70400591982, 5764.164196191528, 5790.276215473066, 5887.558433117533, 5972.910406343908, 5996.1005849122985, 996.7657600463886, 1001.4942454060798, 1012.6000229909145, 1016.9084782369474, 1022.1295526814733, 22602.886985565296, 22667.20664776725, 23191.304260872203, 23199.840007999872, 23968.16111436126, 1075.3601607043797, 1088.646189988241, 1102.20090434436, 1123.5225029362489, 1135.330155208431, 12119.818202726967, 12274.447649855778, 12535.541848821162, 12849.743005139844, 12978.935105324414, 204251.0, 204577.0, 205813.0, 206058.0, 207102.0, 49287.0, 49869.501304987214, 49974.500254997714, 49994.0, 49995.250071248964, 1396.4344440501613, 1448.9275536223147, 1448.9420423183165, 1457.9489717860035, 1458.1469840143634, 21486.892565537073, 22282.108715651193, 23178.536429270982, 23608.527829443658, 23645.0, 35836.0, 35934.64065359418, 36069.45895811512, 36167.81916090403, 36191.0, 168558.0, 169969.0, 170286.0, 170716.1464192671, 170730.0, 34368.0, 34741.826290869394, 34806.47790283097, 34977.65022349744, 35046.29907401888, 40233.79883100566, 40468.1906361877, 40674.59325406826, 41269.58730412657, 41719.1656166881, 29374.853125734233, 29453.55819662664, 30406.695933040388, 30552.541711873895, 31218.21954451157, 29203.269918252212, 29726.25684357908, 29881.850590747777, 30273.394532109676, 30460.695393045786, 33754.46841486849, 33854.492182617774, 33899.49150762691, 33923.83038084794, 34000.0, 30097.548536771526, 30533.847330763205, 30579.694203058574, 31529.842350788098, 31829.0, 22214.555708886055, 24717.752822471546, 25078.49843003166, 25166.62250066214, 25177.370565736004], "value": 16217.070080879967, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [493.7827355963374, 505.4844059059758, 506.6200349737697, 518.543681560227, 521.324884274864, 14516.201608911506, 17343.566410839736, 19637.705434418476, 20568.588628227444, 20629.793702062976, 21784.0, 21807.23674671387, 21920.89039554804, 21966.121355145777, 21997.890010549963, 6075.544334174943, 6158.0, 6184.536159788034, 6207.596506227103, 6211.192544969148, 5928.3775203603645, 6125.877482450371, 6135.447809697126, 6136.601120927147, 6137.6317420954665, 5579.721013949306, 5828.47543721065, 5841.123831425278, 6073.483753880925, 6086.026235802273, 5862.472377486026, 5876.882462350772, 5887.999040163182, 5898.616589921663, 5907.232059832238, 5430.402655707869, 5435.592330575183, 5452.809151679712, 5453.672779633234, 5457.126859702428, 24771.380715482075, 24799.380015499577, 25044.624330635055, 25076.373090672696, 25127.37181570457, 1903.809619038099, 1928.0745242283642, 1948.1428171604448, 1958.637652034364, 1959.8824070555813, 18057.27770889163, 18467.538311542183, 18525.814741852544, 18561.628767424576, 18582.0, 2298.218605674079, 2336.953260934789, 2359.8702071386065, 2361.2089949866813, 2368.301351101429, 115357.4232128834, 120401.0, 121019.99999999911, 121381.39309303486, 122008.0, 19065.523361916064, 19328.323508677127, 19763.505912352306, 19804.50488737793, 19827.206911723657, 39237.0, 39360.0, 39474.80262598669, 39499.0, 39547.80226098908, 10358.46217676674, 10364.326318789406, 10401.375917444977, 10590.788184236271, 10595.470226488645, 8639.0, 8665.740027799176, 8772.605232764541, 8782.077881822444, 8808.427452215585, 7728.420368472387, 10472.476376181161, 10561.155107591529, 10675.62635307776, 10780.29928054674, 2373.8575685458927, 2399.532091242191, 2407.3500154958065, 2433.951320973606, 2498.8375755576194, 957.2772556719772, 961.110972350573, 962.855571664242, 986.1174249047062, 998.8801343838786, 17623.0, 17644.558886027953, 17994.91002545005, 18238.726419103725, 18583.814161858478, 978.9657361992296, 981.764376549623, 1015.5836107196014, 1018.8522664213648, 1019.7348689340824, 9638.0, 9842.409455432697, 10007.449590272605, 10102.646407375707, 10228.335158214692, 437060.0, 448661.0, 451621.0, 455783.0, 459176.0, 101497.0, 105033.47483262535, 105601.47199264108, 106113.46943265235, 106266.0, 1177.3877583656451, 1200.477792160413, 1226.7607816475702, 1235.1292338901053, 1248.7377650693275, 16806.66386672284, 17437.054489547292, 18594.349197778014, 19086.61826763429, 19334.903325483283, 48027.0, 49332.50667493279, 49458.0, 49580.0, 50285.49714502808, 62141.378586213556, 62803.0, 63013.0, 63389.0, 64153.35846641474, 10885.510152043336, 11027.283226590245, 11140.108791296514, 11170.609028683957, 11173.106151508022, 16104.838951610334, 16283.511494655178, 16305.836941630907, 16458.0, 16472.341106356092, 13580.864191358356, 14041.92979035139, 14110.50613228532, 14119.294035298399, 14179.220142891827, 12382.133250672367, 12947.741045179233, 13012.0, 13013.739725205633, 13164.670883227996, 14136.78794818058, 14241.928790355982, 14330.498432555227, 14345.99578029528, 14368.856311436752, 10802.189835762192, 10890.23768336209, 10941.179411544006, 10946.507407166537, 10985.121190304917, 12633.873661263637, 12844.229346239255, 13531.052826302064, 13749.243791591558, 13951.302434878013], "value": 10931.672896706412, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1272.9809052864205, 1339.5847287340919, 1341.4835288413958, 1345.6837643153858, 1355.0988592585932, 11355.0, 11870.821937670942, 11876.821847672281, 11946.402679865994, 12389.19470234434, 12041.879581204184, 12155.878441215586, 12176.452059657315, 12214.69463263419, 12287.262764234152, 2375.714914210297, 2427.817913656474, 2432.0271891243556, 2437.81716371272, 2441.108995216751, 2312.398776318161, 2381.2141993142222, 2464.3346296499935, 2468.6297055441737, 2471.456279618481, 2478.5414698280783, 2485.428351479161, 2513.45960618467, 2514.2959971208093, 2524.0787112703824, 2333.3349995251274, 2354.458474550854, 2360.5986982213067, 2362.976370236293, 2363.810895128403, 2173.228503881131, 2184.7159869217057, 2191.561687662474, 2199.527101673148, 2207.8896055197174, 11602.187846850724, 11742.119341049456, 11844.881551184464, 11867.347295898722, 11877.346745928971, 6645.60126392418, 6889.069975553286, 6908.5509441886115, 6923.169219693618, 6924.446044316443, 3834.69322454203, 3892.4355968384707, 3925.1168487090463, 3977.840886364542, 4012.6388625023887, 1321.2865052871439, 1331.8202042724206, 1359.8096266522696, 1363.2842757552264, 1365.542543248013, 16579.917100414543, 17155.39956101543, 17780.46658600244, 17915.552111197194, 18020.63958720818, 5562.3047119110115, 5708.1723150143, 5825.650460972355, 5858.179854820329, 5878.676672783038, 13006.934965325303, 13041.869581304256, 13045.608631741063, 13046.47814087445, 13113.803292950613, 6559.245686746085, 6571.31001244872, 6616.768413105518, 6627.734890604322, 6633.104530888365, 6135.417135372132, 6186.876262474725, 6234.470070044006, 6235.282942461584, 6287.685615719196, 4128.814203360856, 4220.2192594370135, 4261.914761704748, 4287.721298115613, 4321.286987647066, 1272.2557303977278, 1337.7993301004733, 1339.1563315111418, 1347.3330701302723, 1362.2779926638898, 856.9914300856911, 867.7830542364409, 870.9520976346362, 878.6441491195948, 903.2864037410372, 6224.408681175281, 6668.833279167962, 6839.179298484214, 6931.1682598088555, 7180.798350973151, 667.396006614015, 680.129434324066, 682.4199430484049, 683.4703105093492, 690.7478770248823, 3983.9203215935518, 4019.0957034666967, 4165.770882601425, 4214.578542145761, 4332.523422423531, 14577.125372477685, 15359.846401536066, 15365.539033829004, 15371.846281537266, 15417.922910385376, 14698.63253418673, 14990.775138372934, 15058.247087645574, 15093.39626414953, 15407.922960385127, 8808.339374546935, 8988.820223595492, 9008.729738107868, 9026.593803278869, 9034.367594268339, 7097.787066388017, 7470.0662417197855, 7641.465097443125, 7730.0, 7871.960640196762, 13902.16587004783, 14121.2939353034, 14195.361208745839, 14228.857711422754, 14335.354909029327, 14269.500567480089, 14327.0, 14396.0, 14413.567592972227, 14415.207163606103, 9724.465154416292, 9967.601295948081, 10003.249756268455, 10003.2997690161, 10003.449810260505, 10996.23026388145, 11162.720931976766, 11189.38458384764, 11259.099272058053, 11334.659960201207, 9024.187823095954, 9184.173424391836, 9194.218491428304, 9218.0, 9378.812423751624, 8964.596593153194, 8996.730098097067, 9006.909930900607, 9154.496502692416, 9207.263418926605, 7837.137914829478, 7878.094019187867, 7919.366450684047, 7943.4836735612, 7959.920400795918, 5615.508474161465, 5881.882362352643, 5898.1152827076285, 5976.641401515923, 5987.9401205989125, 5331.9466805333, 5507.5593952484505, 5574.721263936868, 5623.803166889139, 5636.464535869086], "value": 5405.527595202043, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [448.7845833999679, 449.8065831692372, 462.90279041401305, 462.96064834489044, 469.1531785127845, 6236.345183755709, 6339.524535659827, 6340.334264902182, 6392.456641185493, 6402.391772781578, 5932.436418540243, 6075.908861367083, 6149.692515374236, 6177.351378105302, 6207.534434917388, 4866.148424025799, 4877.682950608208, 4887.804487820501, 4900.705957642535, 4915.139850526161, 4875.8537243882565, 4880.194767863299, 4895.265710143472, 4906.435759887623, 4908.705477671333, 4765.451973023095, 4781.784819683123, 4789.425268967729, 4808.519148085198, 4854.417469903617, 4823.107725070873, 4831.323614693928, 4835.347228124193, 4851.151048566522, 4857.514248575149, 4306.978465107686, 4309.017851788181, 4316.589923957219, 4318.460192475941, 4326.156399502099, 5989.215015018038, 6073.301570319426, 6073.726682299307, 6090.725917333731, 6091.329953705089, 5526.281583394133, 5540.9168862466695, 5591.685953800894, 5595.776168953237, 5596.440355964371, 6534.967325163391, 6535.529505861191, 6547.526806468554, 6555.704993275314, 6583.604983700993, 4669.719816811003, 4676.859694209145, 4698.7650617469335, 4720.551547602972, 4729.408823897013, 6559.540832141752, 6762.053312536298, 6846.760363387308, 6936.306369363074, 6960.756373526953, 4547.795349209294, 4750.14497390473, 4752.0, 4767.927216376288, 4813.4945830687975, 4822.252550854553, 4845.345878306454, 4848.927266091011, 4867.367242258484, 4869.805207791719, 5475.972620136874, 5482.533984611353, 5505.449455054542, 5533.418991005887, 5538.224648549206, 6334.683265836689, 6492.156019717407, 6499.902501462482, 6570.0, 6584.802455926234, 1663.6755832612766, 1683.8063622683549, 1685.3764107280385, 1687.6118492746737, 1691.5263726156695, 1105.3754628634956, 1130.4178348150708, 1140.1676775953601, 1141.298101667485, 1162.9417230320537, 5832.154337621106, 5835.416458354215, 5844.9415505845245, 5849.61977471463, 5868.941310586925, 6710.295418981034, 6721.8655626887185, 6730.831729206809, 6750.966245168743, 6765.763198288135, 5757.625754326039, 5777.0, 5781.219535362672, 5789.8263052108505, 5795.623284486495, 3555.72433642469, 3564.698884907042, 3585.9779962710504, 3587.833953964972, 3609.097725568608, 6506.219253689587, 6558.672066396661, 6561.311062338481, 6580.703868325841, 6584.901226481511, 6865.0, 6888.380045795902, 6909.550879192836, 6923.9653801730665, 6944.4097251734165, 6473.611583305017, 6504.414602685781, 6535.379138981789, 6543.419606275721, 6544.3782840630065, 6663.833404164935, 6729.730810767514, 6730.0, 6753.662316884038, 6756.932430675631, 6685.966570167313, 6724.193096828412, 6725.70440484169, 6756.412243122961, 6772.173721847141, 6155.969220153871, 6498.870022599427, 6566.967165164144, 6592.439642630238, 6597.901031484627, 4814.975925120352, 4815.205491094071, 4828.082664293773, 4830.637702172421, 4845.127876982177, 6735.696893639896, 6739.427148692416, 6744.966275168789, 6753.189617245962, 6768.830779230361, 6275.623462592259, 6488.188976377953, 6563.803085907431, 6565.540412171103, 6587.143671322698, 6539.051837483634, 6543.672816359068, 6549.345065493412, 6556.934430655823, 6598.472122230306, 6423.325550817284, 6473.255575608865, 6475.352464753675, 6495.188101487314, 6517.315681853337, 6576.2766095728475, 6607.537472376887, 6629.596878543971, 6635.23694775107, 6657.968014957689, 6408.788967806099, 6428.55000149985, 6442.774502892376, 6454.870902582016, 6462.935370646233], "value": 4982.731198351699, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [789.8617741895174, 833.3291700181353, 833.7415401225617, 835.8829763833064, 836.8075342671185, 16411.67176656466, 17082.40211592593, 17152.142392880367, 17154.742678859813, 18678.813211867877, 17539.386121485717, 17911.104444777775, 18188.818111818877, 18197.090145492737, 18215.27138914445, 939.671115109713, 964.8263312603729, 968.0948313327061, 971.8736564246637, 972.2367941166151, 928.4336554701661, 931.74842792446, 935.6351023100996, 958.4776296918196, 977.0278572820054, 1018.2057994764095, 1033.9534720937538, 1042.7393151712072, 1043.7495001199695, 1044.7753732947415, 1020.8570800087994, 1032.6282538286212, 1033.2508931025022, 1034.4672493665769, 1037.7146284771673, 741.7700512840983, 750.4971668981796, 752.1763668782675, 753.3445902065183, 754.6528596845403, 16249.350025998945, 16447.588810279718, 16549.50351489457, 16764.07797571133, 16889.324427022904, 17246.0, 17499.737503937453, 17615.647687046316, 17671.29314827418, 17849.464516064538, 14960.850391496055, 15185.316660750294, 15205.01167424125, 15256.694866102727, 15258.542243732705, 3361.9831900840586, 3366.208940898887, 3372.359251742161, 3382.391169589473, 3409.215880347509, 83265.0, 84328.0, 84584.57707711484, 85009.0, 85035.57482212612, 13779.517716880062, 13800.861991379958, 13988.370523326475, 14001.579952601438, 14041.1575305482, 24001.399965001016, 24407.511849762905, 26029.9588016481, 26161.476770464484, 26201.73798261993, 8134.674613015413, 8291.668333266722, 8538.530380829114, 8547.487150770974, 8567.957160214159, 3925.646691797752, 3983.6813054955533, 3991.3015222335976, 3996.980015099906, 4004.099077707551, 4120.2583534964, 4120.896977575585, 4182.121754431542, 4231.428757117811, 4234.174336004511, 846.7925358287135, 861.2679222660813, 871.3247233394044, 877.8288233794476, 879.0418443896184, 593.851537115721, 595.9880802383929, 602.2231321595181, 605.9545534084962, 620.3765215957933, 9619.56711947964, 10940.179486538382, 11519.827202591969, 11802.94098529502, 12039.699007524707, 669.334012657409, 674.780696273713, 676.1413005483009, 683.9760608378683, 684.0799125176629, 5530.009196689189, 5704.486596206361, 5733.4233085901715, 5888.17565540816, 6018.307894592091, 85884.57057714672, 88000.5599971996, 89882.55058724665, 91420.08579914116, 91555.08444915598, 75683.62158189174, 76293.6185319081, 76708.61645691848, 76784.61607691926, 77196.61401692955, 67921.3207867925, 68957.999999999, 71879.6406017977, 73051.0, 74275.62862185655, 11698.0, 12398.07014473936, 12411.0, 12518.311492867979, 12587.811182832447, 31196.0, 31455.0, 32020.6797932027, 32664.183395414355, 33072.0, 40200.396994045695, 40497.0, 40966.590334096276, 40976.1804763909, 42199.57800421956, 17319.2206350712, 17440.73838892443, 17791.0, 17840.19719112617, 18146.092695364914, 17691.0, 17723.556911076812, 17769.555761106076, 18070.186841592422, 18099.185536651145, 17278.395256165975, 17362.13189340553, 17364.652706946043, 17731.113444327475, 17980.19089141018, 17378.47864564065, 17426.564335891704, 17536.0, 17893.0, 18012.189451474453, 16869.240884159997, 17132.143392830058, 17140.228689708743, 17222.741658874875, 17477.475675729747, 10532.420716860646, 10692.716873975172, 11150.10799136051, 11272.380019099028, 11481.598144064918, 11714.414279285831, 11783.293002419883, 11805.852678082696, 12216.816747748613, 12300.138990270596], "value": 8084.98271211201, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1566.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 111.0, 104.0, 110.0, 112.0, 113.0, 111.0, 101.0, 112.0, 111.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 125.0, 156.0, 182.0, 121.0, 147.0, 150.0, 122.0, 170.0, 128.0], "value": 145.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 170.0, 166.0, 166.0, 167.0, 165.0, 168.0, 173.0, 162.0, 165.0], "value": 166.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 187.0, 75.0, 73.0, 74.0, 73.0, 173.0, 76.0], "value": 95.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 132.0, 84.0, 82.0, 85.0, 128.0, 82.0, 83.0, 143.0], "value": 98.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 113.0, 113.0, 115.0, 118.0, 113.0, 114.0, 115.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 151.0, 152.0, 150.0, 150.0, 150.0, 151.0, 151.0, 150.0], "value": 150.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 96.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 61.0, 60.0, 57.0, 55.0, 56.0, 63.0, 57.0, 55.0, 59.0], "value": 57.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 55.0, 55.0, 55.0, 54.0, 54.0, 56.0, 55.0], "value": 55.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 84.0, 86.0, 85.0, 85.0, 83.0, 89.0, 111.0, 83.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 136.0, 131.0, 129.0, 132.0, 130.0, 128.0, 143.0, 130.0, 130.0], "value": 133.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 193.0, 190.0, 193.0, 191.0, 188.0, 190.0, 189.0, 178.0, 190.0], "value": 188.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 76.0, 69.0, 69.0, 69.0, 70.0, 71.0, 71.0, 68.0], "value": 70.5, "unit": "score"}]}]} 08:01:43 INFO - Return code: 0 08:01:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:01:43 INFO - # TBPL SUCCESS # 08:01:43 INFO - Running post-action listener: _resource_record_post_action 08:01:43 INFO - [mozharness: 2017-06-09 15:01:43.940697Z] Finished run-tests step (success) 08:01:43 INFO - Running post-run listener: _resource_record_post_run 08:01:44 INFO - Total resource usage - Wall time: 1253s; CPU: 13.0%; Read bytes: 8716288; Write bytes: 438611968; Read time: 2156; Write time: 336728 08:01:44 INFO - TinderboxPrint: CPU usage
12.6% 08:01:44 INFO - TinderboxPrint: I/O read bytes / time
8,716,288 / 2,156 08:01:44 INFO - TinderboxPrint: I/O write bytes / time
438,611,968 / 336,728 08:01:44 INFO - TinderboxPrint: CPU idle
8,735.3 (87.4%) 08:01:44 INFO - TinderboxPrint: CPU user
1,207.8 (12.1%) 08:01:44 INFO - TinderboxPrint: Swap in / out
0 / 0 08:01:44 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 114286592; Read time: 0; Write time: 97952 08:01:44 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 08:01:44 INFO - run-tests - Wall time: 1237s; CPU: 13.0%; Read bytes: 6582272; Write bytes: 289964032; Read time: 1832; Write time: 222224 08:01:44 INFO - Running post-run listener: _upload_blobber_files 08:01:44 INFO - Blob upload gear active. 08:01:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:01:44 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 08:01:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:01:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:01:45 INFO - (blobuploader) - INFO - Open directory for files ... 08:01:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:01:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:01:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:01:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:01:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:01:45 INFO - (blobuploader) - INFO - Done attempting. 08:01:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:01:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:01:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:01:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:01:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:01:46 INFO - (blobuploader) - INFO - Done attempting. 08:01:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:01:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:01:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:01:47 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:01:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:01:47 INFO - (blobuploader) - INFO - Done attempting. 08:01:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:01:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:01:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:01:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:01:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:01:54 INFO - (blobuploader) - INFO - Done attempting. 08:01:54 INFO - (blobuploader) - INFO - Iteration through files over. 08:01:54 INFO - Return code: 0 08:01:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:01:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:01:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e76bddadac5fcd8b80d3f9317f275592b844284b13e4076f833d19d2cdc783b2a3a553a2b5a6f7bd2a4020c68d16cb2d728371f0648b6964b2093df680e71f76", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/80947e440dcb3f8b8e747f2414682129a665f808e3ba3229c2b46b61796f709232ad4e13e7af5304d65fa4ac872207a645f4864897c2aff804c28d139bb80524", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bdc60ddaf5c6f835d0ea4d45afb76ae5899515320ce165bfa147f9238a18fb8607b5a9e14139c3c62b9ae15f7f89c222a7c93012e8510e61bb0ec5c23f216427", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/992e1b6bb4065914a1a03b23ef569affcfbf7c9a0365f5ba5d9f39d851ad77ad3f51857ea21cdf0f0758b75a4437cf195276b4299bb6ec359849bf1921014313"} 08:01:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:01:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:01:54 INFO - Contents: 08:01:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e76bddadac5fcd8b80d3f9317f275592b844284b13e4076f833d19d2cdc783b2a3a553a2b5a6f7bd2a4020c68d16cb2d728371f0648b6964b2093df680e71f76", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/80947e440dcb3f8b8e747f2414682129a665f808e3ba3229c2b46b61796f709232ad4e13e7af5304d65fa4ac872207a645f4864897c2aff804c28d139bb80524", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bdc60ddaf5c6f835d0ea4d45afb76ae5899515320ce165bfa147f9238a18fb8607b5a9e14139c3c62b9ae15f7f89c222a7c93012e8510e61bb0ec5c23f216427", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/992e1b6bb4065914a1a03b23ef569affcfbf7c9a0365f5ba5d9f39d851ad77ad3f51857ea21cdf0f0758b75a4437cf195276b4299bb6ec359849bf1921014313"} 08:01:54 INFO - Running post-run listener: copy_logs_to_upload_dir 08:01:54 INFO - Copying logs to upload dir... 08:01:54 INFO - mkdir: /builds/slave/test/build/upload/logs 08:01:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1316.558568 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2017-06-09 08:01:54.219582) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-09 08:01:54.222701) ========= 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=2432103b8b3de4003b23cad4000001c2-1497018146.6005-1156111273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e76bddadac5fcd8b80d3f9317f275592b844284b13e4076f833d19d2cdc783b2a3a553a2b5a6f7bd2a4020c68d16cb2d728371f0648b6964b2093df680e71f76", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/80947e440dcb3f8b8e747f2414682129a665f808e3ba3229c2b46b61796f709232ad4e13e7af5304d65fa4ac872207a645f4864897c2aff804c28d139bb80524", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bdc60ddaf5c6f835d0ea4d45afb76ae5899515320ce165bfa147f9238a18fb8607b5a9e14139c3c62b9ae15f7f89c222a7c93012e8510e61bb0ec5c23f216427", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/992e1b6bb4065914a1a03b23ef569affcfbf7c9a0365f5ba5d9f39d851ad77ad3f51857ea21cdf0f0758b75a4437cf195276b4299bb6ec359849bf1921014313"} build_url:https://queue.taskcluster.net/v1/task/QvlAUGC5St2tr8EEkJfhLQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011418 build_url: 'https://queue.taskcluster.net/v1/task/QvlAUGC5St2tr8EEkJfhLQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e76bddadac5fcd8b80d3f9317f275592b844284b13e4076f833d19d2cdc783b2a3a553a2b5a6f7bd2a4020c68d16cb2d728371f0648b6964b2093df680e71f76", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/80947e440dcb3f8b8e747f2414682129a665f808e3ba3229c2b46b61796f709232ad4e13e7af5304d65fa4ac872207a645f4864897c2aff804c28d139bb80524", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bdc60ddaf5c6f835d0ea4d45afb76ae5899515320ce165bfa147f9238a18fb8607b5a9e14139c3c62b9ae15f7f89c222a7c93012e8510e61bb0ec5c23f216427", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/992e1b6bb4065914a1a03b23ef569affcfbf7c9a0365f5ba5d9f39d851ad77ad3f51857ea21cdf0f0758b75a4437cf195276b4299bb6ec359849bf1921014313"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-09 08:01:54.249543) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-09 08:01:54.249838) ========= 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=2432103b8b3de4003b23cad4000001c2-1497018146.6005-1156111273 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004415 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-09 08:01:54.332106) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-09 08:01:54.335450) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-09 08:01:54.335771) ========= ========= Total master_lag: 0.21 =========