builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-062 starttime: 1497112116.58 results: success (0) revision: 8a990794c2ee923ccd839750912d10ff3a690a2a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-10 09:28:36.582729) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-10 09:28:36.583370) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-10 09:28:36.583697) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-10 09:28:36.600226) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-10 09:28:36.600607) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1497102457.494117-1620765085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-10 09:28:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 228M=0s 2017-06-10 09:28:36 (228 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.096004 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-10 09:28:36.710690) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-10 09:28:36.711108) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1497102457.494117-1620765085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022908 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-10 09:28:36.761153) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-10 09:28:36.761515) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8a990794c2ee923ccd839750912d10ff3a690a2a --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 8a990794c2ee923ccd839750912d10ff3a690a2a --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=a4ce256d2ec601f24a60a71e000001bc-1497102457.494117-1620765085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-10 09:28:36,976 truncating revision to first 12 chars 2017-06-10 09:28:36,976 Setting DEBUG logging. 2017-06-10 09:28:36,976 attempt 1/10 2017-06-10 09:28:36,976 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8a990794c2ee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-10 09:28:38,263 unpacking tar archive at: mozilla-central-8a990794c2ee/testing/mozharness/ program finished with exit code 0 elapsedTime=1.570125 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-10 09:28:38.344905) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-10 09:28:38.345285) ========= script_repo_revision: 8a990794c2ee923ccd839750912d10ff3a690a2a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-10 09:28:38.345732) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-10 09:28:38.346040) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-10 09:28:38.354919) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 51 secs) (at 2017-06-10 09:28:38.355358) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a4ce256d2ec601f24a60a71e000001bc-1497102457.494117-1620765085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:28:38 INFO - MultiFileLogger online at 20170610 09:28:38 in /builds/slave/test 09:28:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:28:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:28:38 INFO - {'append_to_log': False, 09:28:38 INFO - 'base_work_dir': '/builds/slave/test', 09:28:38 INFO - 'blob_upload_branch': 'Firefox', 09:28:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:28:38 INFO - 'branch': 'Firefox', 09:28:38 INFO - 'buildbot_json_path': 'buildprops.json', 09:28:38 INFO - 'config_files': ('talos/linux_config.py',), 09:28:38 INFO - 'default_actions': ('clobber', 09:28:38 INFO - 'read-buildbot-config', 09:28:38 INFO - 'download-and-extract', 09:28:38 INFO - 'populate-webroot', 09:28:38 INFO - 'create-virtualenv', 09:28:38 INFO - 'install', 09:28:38 INFO - 'setup-mitmproxy', 09:28:38 INFO - 'run-tests'), 09:28:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:28:38 INFO - 'download_minidump_stackwalk': True, 09:28:38 INFO - 'download_symbols': 'ondemand', 09:28:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:28:38 INFO - 'tooltool.py': '/tools/tooltool.py', 09:28:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:28:38 INFO - '/tools/misc-python/virtualenv.py')}, 09:28:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:28:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:28:38 INFO - 'gecko_profile': False, 09:28:38 INFO - 'gecko_profile_interval': 0, 09:28:38 INFO - 'installer_path': 'installer.exe', 09:28:38 INFO - 'log_level': 'info', 09:28:38 INFO - 'log_name': 'talos', 09:28:38 INFO - 'log_to_console': True, 09:28:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:28:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:28:38 INFO - 'opt_config_files': (), 09:28:38 INFO - 'pip_index': False, 09:28:38 INFO - 'suite': 'dromaeojs-e10s', 09:28:38 INFO - 'system_bits': '32', 09:28:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:28:38 INFO - 'title': 'talos-linux64-ix-062', 09:28:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:28:38 INFO - 'use_talos_json': True, 09:28:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:28:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:28:38 INFO - 'work_dir': 'build'} 09:28:38 INFO - [mozharness: 2017-06-10 16:28:38.671000Z] Running clobber step. 09:28:38 INFO - Running pre-action listener: _resource_record_pre_action 09:28:38 INFO - Running main action method: clobber 09:28:38 INFO - rmtree: /builds/slave/test/build 09:28:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:28:39 INFO - Running post-action listener: _resource_record_post_action 09:28:39 INFO - [mozharness: 2017-06-10 16:28:39.696431Z] Finished clobber step (success) 09:28:39 INFO - [mozharness: 2017-06-10 16:28:39.696534Z] Running read-buildbot-config step. 09:28:39 INFO - Running pre-action listener: _resource_record_pre_action 09:28:39 INFO - Running main action method: read_buildbot_config 09:28:39 INFO - Using buildbot properties: 09:28:39 INFO - { 09:28:39 INFO - "project": "", 09:28:39 INFO - "product": "firefox", 09:28:39 INFO - "who": "ffxbld@noreply.mozilla.org", 09:28:39 INFO - "installer_path": "public/build/target.tar.bz2", 09:28:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:28:39 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:28:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 09:28:39 INFO - "stage_platform": "linux64-pgo", 09:28:39 INFO - "basedir": "/builds/slave/test", 09:28:39 INFO - "buildnumber": 6, 09:28:39 INFO - "platform": "ubuntu64_hw", 09:28:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:28:39 INFO - "slavebuilddir": "test", 09:28:39 INFO - "taskId": "UO44DY4gQG2ug1VBWEshng", 09:28:39 INFO - "branch": "mozilla-central", 09:28:39 INFO - "script_repo_revision": "production", 09:28:39 INFO - "revision": "8a990794c2ee923ccd839750912d10ff3a690a2a", 09:28:39 INFO - "slavename": "talos-linux64-ix-062", 09:28:39 INFO - "repo_path": "mozilla-central" 09:28:39 INFO - } 09:28:39 INFO - Finding installer, test and symbols from parent task. 09:28:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UO44DY4gQG2ug1VBWEshng'}, attempt #1 09:28:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UO44DY4gQG2ug1VBWEshng'}, attempt #1 09:28:40 INFO - Task dependencies: CsZ6WwGvRvGOw2wq_DXcUA 09:28:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CsZ6WwGvRvGOw2wq_DXcUA'}, attempt #1 09:28:41 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/CsZ6WwGvRvGOw2wq_DXcUA/artifacts/public/build/target.tar.bz2 09:28:41 INFO - Set test_url: https://queue.taskcluster.net/v1/task/CsZ6WwGvRvGOw2wq_DXcUA/artifacts/public/build/test_packages.json 09:28:41 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/CsZ6WwGvRvGOw2wq_DXcUA/artifacts/public/build/target.crashreporter-symbols.zip 09:28:41 INFO - Running post-action listener: _resource_record_post_action 09:28:41 INFO - [mozharness: 2017-06-10 16:28:41.105838Z] Finished read-buildbot-config step (success) 09:28:41 INFO - [mozharness: 2017-06-10 16:28:41.106058Z] Running download-and-extract step. 09:28:41 INFO - Running pre-action listener: _resource_record_pre_action 09:28:41 INFO - Running main action method: download_and_extract 09:28:41 INFO - mkdir: /builds/slave/test/build/tests 09:28:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:28:41 INFO - trying https://queue.taskcluster.net/v1/task/CsZ6WwGvRvGOw2wq_DXcUA/artifacts/public/build/target.test_packages.json 09:28:41 INFO - Downloading https://queue.taskcluster.net/v1/task/CsZ6WwGvRvGOw2wq_DXcUA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:28:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CsZ6WwGvRvGOw2wq_DXcUA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:28:41 INFO - Downloaded 989 bytes. 09:28:41 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:28:41 INFO - Using the following test package requirements: 09:28:41 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:28:41 INFO - u'common': [u'target.common.tests.zip'], 09:28:41 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:28:41 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:28:41 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:28:41 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:28:41 INFO - u'mozbase': [u'target.common.tests.zip'], 09:28:41 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:28:41 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:28:41 INFO - u'web-platform': [u'target.common.tests.zip', 09:28:41 INFO - u'target.web-platform.tests.tar.gz'], 09:28:41 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:28:41 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:28:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CsZ6WwGvRvGOw2wq_DXcUA/artifacts/public/build/target.common.tests.zip 09:28:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CsZ6WwGvRvGOw2wq_DXcUA/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:28:41 INFO - Fetch https://queue.taskcluster.net/v1/task/CsZ6WwGvRvGOw2wq_DXcUA/artifacts/public/build/target.common.tests.zip into memory 09:28:42 INFO - Content-Length response header: 68501310 09:28:42 INFO - Bytes received: 68501310 09:28:53 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:28:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CsZ6WwGvRvGOw2wq_DXcUA/artifacts/public/build/target.common.tests.zip 09:28:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CsZ6WwGvRvGOw2wq_DXcUA/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:28:53 INFO - Fetch https://queue.taskcluster.net/v1/task/CsZ6WwGvRvGOw2wq_DXcUA/artifacts/public/build/target.common.tests.zip into memory 09:28:54 INFO - Content-Length response header: 68501310 09:28:54 INFO - Bytes received: 68501310 09:29:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CsZ6WwGvRvGOw2wq_DXcUA/artifacts/public/build/target.talos.tests.zip 09:29:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CsZ6WwGvRvGOw2wq_DXcUA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:29:08 INFO - Fetch https://queue.taskcluster.net/v1/task/CsZ6WwGvRvGOw2wq_DXcUA/artifacts/public/build/target.talos.tests.zip into memory 09:29:09 INFO - Content-Length response header: 14450010 09:29:09 INFO - Bytes received: 14450010 09:29:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:09 INFO - trying https://queue.taskcluster.net/v1/task/CsZ6WwGvRvGOw2wq_DXcUA/artifacts/public/build/target.tar.bz2 09:29:09 INFO - Downloading https://queue.taskcluster.net/v1/task/CsZ6WwGvRvGOw2wq_DXcUA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:29:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CsZ6WwGvRvGOw2wq_DXcUA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:29:11 INFO - Downloaded 60280831 bytes. 09:29:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CsZ6WwGvRvGOw2wq_DXcUA/artifacts/public/build/target.tar.bz2 09:29:11 INFO - mkdir: /builds/slave/test/properties 09:29:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:29:11 INFO - Writing to file /builds/slave/test/properties/build_url 09:29:11 INFO - Contents: 09:29:11 INFO - build_url:https://queue.taskcluster.net/v1/task/CsZ6WwGvRvGOw2wq_DXcUA/artifacts/public/build/target.tar.bz2 09:29:11 INFO - Running post-action listener: _resource_record_post_action 09:29:11 INFO - Running post-action listener: set_extra_try_arguments 09:29:11 INFO - [mozharness: 2017-06-10 16:29:11.022015Z] Finished download-and-extract step (success) 09:29:11 INFO - [mozharness: 2017-06-10 16:29:11.022111Z] Running populate-webroot step. 09:29:11 INFO - Running pre-action listener: _resource_record_pre_action 09:29:11 INFO - Running main action method: populate_webroot 09:29:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:29:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:29:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:29:11 INFO - '--tppagecycles', 09:29:11 INFO - '7'], 09:29:11 INFO - 'tests': ['tsvgm']}}, 09:29:11 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:29:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:29:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:29:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:29:11 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:29:11 INFO - 'talos_options': ['--disable-e10s'], 09:29:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:29:11 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:29:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:29:11 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:29:11 INFO - 'talos_options': ['--disable-e10s'], 09:29:11 INFO - 'tests': ['damp', 'tps']}, 09:29:11 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:29:11 INFO - 'tests': ['damp', 'tps']}, 09:29:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:29:11 INFO - 'tests': ['dromaeo_dom']}, 09:29:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:29:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:29:11 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:29:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:29:11 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:29:11 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:29:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:29:11 INFO - 'tests': ['a11yr', 09:29:11 INFO - 'ts_paint', 09:29:11 INFO - 'tpaint', 09:29:11 INFO - 'sessionrestore', 09:29:11 INFO - 'sessionrestore_no_auto_restore', 09:29:11 INFO - 'tabpaint']}, 09:29:11 INFO - 'other-e10s': {'tests': ['a11yr', 09:29:11 INFO - 'ts_paint', 09:29:11 INFO - 'tpaint', 09:29:11 INFO - 'sessionrestore', 09:29:11 INFO - 'sessionrestore_no_auto_restore', 09:29:11 INFO - 'tabpaint']}, 09:29:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:29:11 INFO - 'ts_paint', 09:29:11 INFO - 'tpaint', 09:29:11 INFO - 'sessionrestore', 09:29:11 INFO - 'sessionrestore_no_auto_restore', 09:29:11 INFO - 'tabpaint']}, 09:29:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:29:11 INFO - 'ts_paint', 09:29:11 INFO - 'tpaint', 09:29:11 INFO - 'sessionrestore', 09:29:11 INFO - 'sessionrestore_no_auto_restore', 09:29:11 INFO - 'tabpaint']}, 09:29:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:29:11 INFO - 'tests': ['a11yr', 09:29:11 INFO - 'ts_paint', 09:29:11 INFO - 'tpaint', 09:29:11 INFO - 'sessionrestore', 09:29:11 INFO - 'sessionrestore_no_auto_restore', 09:29:11 INFO - 'tabpaint']}, 09:29:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:29:11 INFO - 'tests': ['a11yr', 09:29:11 INFO - 'ts_paint', 09:29:11 INFO - 'tpaint', 09:29:11 INFO - 'sessionrestore', 09:29:11 INFO - 'sessionrestore_no_auto_restore', 09:29:11 INFO - 'tabpaint']}, 09:29:11 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:29:11 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:29:11 INFO - 'bloom_basic_ref']}, 09:29:11 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:29:11 INFO - 'talos_options': ['--mitmproxy', 09:29:11 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:29:11 INFO - '--firstNonBlankPaint'], 09:29:11 INFO - 'tests': ['quantum_pageload_google', 09:29:11 INFO - 'quantum_pageload_youtube', 09:29:11 INFO - 'quantum_pageload_amazon', 09:29:11 INFO - 'quantum_pageload_facebook']}, 09:29:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:29:11 INFO - 'tests': ['tsvgx', 09:29:11 INFO - 'tsvgr_opacity', 09:29:11 INFO - 'tart', 09:29:11 INFO - 'tscrollx', 09:29:11 INFO - 'cart', 09:29:11 INFO - 'tsvg_static']}, 09:29:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:29:11 INFO - 'tsvgr_opacity', 09:29:11 INFO - 'tart', 09:29:11 INFO - 'tscrollx', 09:29:11 INFO - 'cart', 09:29:11 INFO - 'tsvg_static']}, 09:29:11 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:29:11 INFO - 'talos_options': ['--disable-e10s'], 09:29:11 INFO - 'tests': ['tp5o']}, 09:29:11 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:29:11 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:29:11 INFO - 'talos_options': ['--disable-e10s', 09:29:11 INFO - '--xperf_path', 09:29:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:29:11 INFO - 'tests': ['tp5n']}, 09:29:11 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:29:11 INFO - 'talos_options': ['--xperf_path', 09:29:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:29:11 INFO - 'tests': ['tp5n']}}, 09:29:11 INFO - 'talos.zip': {'path': '', 09:29:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:29:11 INFO - Running post-action listener: _resource_record_post_action 09:29:11 INFO - [mozharness: 2017-06-10 16:29:11.037020Z] Finished populate-webroot step (success) 09:29:11 INFO - [mozharness: 2017-06-10 16:29:11.037109Z] Running create-virtualenv step. 09:29:11 INFO - Running pre-action listener: _resource_record_pre_action 09:29:11 INFO - Running main action method: create_virtualenv 09:29:11 INFO - Creating virtualenv /builds/slave/test/build/venv 09:29:11 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:29:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:29:11 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:29:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:29:11 INFO - Using real prefix '/usr' 09:29:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:29:11 INFO - Installing distribute.............................................................................................................................................................................................done. 09:29:13 INFO - Installing pip.................done. 09:29:13 INFO - Return code: 0 09:29:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:29:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:29:13 INFO - Reading from file tmpfile_stdout 09:29:13 INFO - Output received: 09:29:13 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:29:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:29:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:13 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 0x1b483b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d22a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec69a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec4140>, '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 0x1ec4a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec4ed0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1497102457.494117-1620765085', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:29:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:29:13 INFO - Using env: {'DISPLAY': ':0', 09:29:13 INFO - 'HOME': '/home/cltbld', 09:29:13 INFO - 'LANG': 'en_US.UTF-8', 09:29:13 INFO - 'LANGUAGE': 'en_US:en', 09:29:13 INFO - 'LOGNAME': 'cltbld', 09:29:13 INFO - 'MAIL': '/var/mail/cltbld', 09:29:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:13 INFO - 'MOZ_NO_REMOTE': '1', 09:29:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:13 INFO - 'NO_EM_RESTART': '1', 09:29:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:13 INFO - 'PWD': '/builds/slave/test', 09:29:13 INFO - 'SHELL': '/bin/bash', 09:29:13 INFO - 'SHLVL': '1', 09:29:13 INFO - 'TERM': 'linux', 09:29:13 INFO - 'TMOUT': '86400', 09:29:13 INFO - 'USER': 'cltbld', 09:29:13 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1497102457.494117-1620765085', 09:29:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:13 INFO - '_': '/tools/buildbot/bin/python'} 09:29:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:14 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:29:14 INFO - Cleaning up... 09:29:14 INFO - Return code: 0 09:29:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:29:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b483b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d22a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec69a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec4140>, '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 0x1ec4a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec4ed0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1497102457.494117-1620765085', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:29:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:29:14 INFO - Using env: {'DISPLAY': ':0', 09:29:14 INFO - 'HOME': '/home/cltbld', 09:29:14 INFO - 'LANG': 'en_US.UTF-8', 09:29:14 INFO - 'LANGUAGE': 'en_US:en', 09:29:14 INFO - 'LOGNAME': 'cltbld', 09:29:14 INFO - 'MAIL': '/var/mail/cltbld', 09:29:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:14 INFO - 'MOZ_NO_REMOTE': '1', 09:29:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:14 INFO - 'NO_EM_RESTART': '1', 09:29:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:14 INFO - 'PWD': '/builds/slave/test', 09:29:14 INFO - 'SHELL': '/bin/bash', 09:29:14 INFO - 'SHLVL': '1', 09:29:14 INFO - 'TERM': 'linux', 09:29:14 INFO - 'TMOUT': '86400', 09:29:14 INFO - 'USER': 'cltbld', 09:29:14 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1497102457.494117-1620765085', 09:29:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:14 INFO - '_': '/tools/buildbot/bin/python'} 09:29:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:14 INFO - Downloading/unpacking psutil>=3.1.1 09:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:29:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:29:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:29:15 INFO - Installing collected packages: psutil 09:29:15 INFO - Running setup.py install for psutil 09:29:15 INFO - building 'psutil._psutil_linux' extension 09:29:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:29:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:29:15 INFO - building 'psutil._psutil_posix' extension 09:29:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:29:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:29:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:29:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:29:15 INFO - Successfully installed psutil 09:29:15 INFO - Cleaning up... 09:29:16 INFO - Return code: 0 09:29:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:29:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b483b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d22a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec69a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec4140>, '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 0x1ec4a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec4ed0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1497102457.494117-1620765085', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:29:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:29:16 INFO - Using env: {'DISPLAY': ':0', 09:29:16 INFO - 'HOME': '/home/cltbld', 09:29:16 INFO - 'LANG': 'en_US.UTF-8', 09:29:16 INFO - 'LANGUAGE': 'en_US:en', 09:29:16 INFO - 'LOGNAME': 'cltbld', 09:29:16 INFO - 'MAIL': '/var/mail/cltbld', 09:29:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:16 INFO - 'MOZ_NO_REMOTE': '1', 09:29:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:16 INFO - 'NO_EM_RESTART': '1', 09:29:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:16 INFO - 'PWD': '/builds/slave/test', 09:29:16 INFO - 'SHELL': '/bin/bash', 09:29:16 INFO - 'SHLVL': '1', 09:29:16 INFO - 'TERM': 'linux', 09:29:16 INFO - 'TMOUT': '86400', 09:29:16 INFO - 'USER': 'cltbld', 09:29:16 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1497102457.494117-1620765085', 09:29:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:16 INFO - '_': '/tools/buildbot/bin/python'} 09:29:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:29:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:29:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:29:17 INFO - Installing collected packages: mozsystemmonitor 09:29:17 INFO - Running setup.py install for mozsystemmonitor 09:29:17 INFO - Successfully installed mozsystemmonitor 09:29:17 INFO - Cleaning up... 09:29:17 INFO - Return code: 0 09:29:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:17 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 0x1b483b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d22a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec69a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec4140>, '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 0x1ec4a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec4ed0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1497102457.494117-1620765085', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:29:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:29:17 INFO - Using env: {'DISPLAY': ':0', 09:29:17 INFO - 'HOME': '/home/cltbld', 09:29:17 INFO - 'LANG': 'en_US.UTF-8', 09:29:17 INFO - 'LANGUAGE': 'en_US:en', 09:29:17 INFO - 'LOGNAME': 'cltbld', 09:29:17 INFO - 'MAIL': '/var/mail/cltbld', 09:29:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:17 INFO - 'MOZ_NO_REMOTE': '1', 09:29:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:17 INFO - 'NO_EM_RESTART': '1', 09:29:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:17 INFO - 'PWD': '/builds/slave/test', 09:29:17 INFO - 'SHELL': '/bin/bash', 09:29:17 INFO - 'SHLVL': '1', 09:29:17 INFO - 'TERM': 'linux', 09:29:17 INFO - 'TMOUT': '86400', 09:29:17 INFO - 'USER': 'cltbld', 09:29:17 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1497102457.494117-1620765085', 09:29:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:17 INFO - '_': '/tools/buildbot/bin/python'} 09:29:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:17 INFO - Downloading/unpacking jsonschema==2.5.1 09:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:29:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:29:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:18 INFO - Downloading functools32-3.2.3-2.tar.gz 09:29:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:29:18 INFO - warning: no files found matching '*.txt' 09:29:18 INFO - no previously-included directories found matching 'build' 09:29:18 INFO - no previously-included directories found matching 'dist' 09:29:18 INFO - no previously-included directories found matching '.git*' 09:29:18 INFO - Installing collected packages: jsonschema, functools32 09:29:19 INFO - Running setup.py install for functools32 09:29:19 INFO - warning: no files found matching '*.txt' 09:29:19 INFO - no previously-included directories found matching 'build' 09:29:19 INFO - no previously-included directories found matching 'dist' 09:29:19 INFO - no previously-included directories found matching '.git*' 09:29:19 INFO - Successfully installed jsonschema functools32 09:29:19 INFO - Cleaning up... 09:29:19 INFO - Return code: 0 09:29:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:29:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:19 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 0x1b483b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d22a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec69a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec4140>, '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 0x1ec4a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec4ed0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1497102457.494117-1620765085', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:29:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:29:19 INFO - Using env: {'DISPLAY': ':0', 09:29:19 INFO - 'HOME': '/home/cltbld', 09:29:19 INFO - 'LANG': 'en_US.UTF-8', 09:29:19 INFO - 'LANGUAGE': 'en_US:en', 09:29:19 INFO - 'LOGNAME': 'cltbld', 09:29:19 INFO - 'MAIL': '/var/mail/cltbld', 09:29:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:19 INFO - 'MOZ_NO_REMOTE': '1', 09:29:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:19 INFO - 'NO_EM_RESTART': '1', 09:29:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:19 INFO - 'PWD': '/builds/slave/test', 09:29:19 INFO - 'SHELL': '/bin/bash', 09:29:19 INFO - 'SHLVL': '1', 09:29:19 INFO - 'TERM': 'linux', 09:29:19 INFO - 'TMOUT': '86400', 09:29:19 INFO - 'USER': 'cltbld', 09:29:19 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1497102457.494117-1620765085', 09:29:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:19 INFO - '_': '/tools/buildbot/bin/python'} 09:29:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:29:19 INFO - Cleaning up... 09:29:19 INFO - Return code: 0 09:29:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:29:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:19 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 0x1b483b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d22a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec69a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec4140>, '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 0x1ec4a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec4ed0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1497102457.494117-1620765085', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:29:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:29:19 INFO - Using env: {'DISPLAY': ':0', 09:29:19 INFO - 'HOME': '/home/cltbld', 09:29:19 INFO - 'LANG': 'en_US.UTF-8', 09:29:19 INFO - 'LANGUAGE': 'en_US:en', 09:29:19 INFO - 'LOGNAME': 'cltbld', 09:29:19 INFO - 'MAIL': '/var/mail/cltbld', 09:29:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:19 INFO - 'MOZ_NO_REMOTE': '1', 09:29:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:19 INFO - 'NO_EM_RESTART': '1', 09:29:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:19 INFO - 'PWD': '/builds/slave/test', 09:29:19 INFO - 'SHELL': '/bin/bash', 09:29:19 INFO - 'SHLVL': '1', 09:29:19 INFO - 'TERM': 'linux', 09:29:19 INFO - 'TMOUT': '86400', 09:29:19 INFO - 'USER': 'cltbld', 09:29:19 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1497102457.494117-1620765085', 09:29:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:19 INFO - '_': '/tools/buildbot/bin/python'} 09:29:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:19 INFO - Downloading/unpacking blobuploader==1.2.4 09:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:20 INFO - Downloading blobuploader-1.2.4.tar.gz 09:29:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:29:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:29:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:21 INFO - Downloading docopt-0.6.1.tar.gz 09:29:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:29:21 INFO - Installing collected packages: blobuploader, requests, docopt 09:29:21 INFO - Running setup.py install for blobuploader 09:29:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:29:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:29:21 INFO - Running setup.py install for requests 09:29:21 INFO - Running setup.py install for docopt 09:29:21 INFO - Successfully installed blobuploader requests docopt 09:29:21 INFO - Cleaning up... 09:29:21 INFO - Return code: 0 09:29:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:29:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:21 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 0x1b483b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d22a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec69a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec4140>, '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 0x1ec4a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec4ed0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1497102457.494117-1620765085', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:29:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:29:21 INFO - Using env: {'DISPLAY': ':0', 09:29:21 INFO - 'HOME': '/home/cltbld', 09:29:21 INFO - 'LANG': 'en_US.UTF-8', 09:29:21 INFO - 'LANGUAGE': 'en_US:en', 09:29:21 INFO - 'LOGNAME': 'cltbld', 09:29:21 INFO - 'MAIL': '/var/mail/cltbld', 09:29:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:21 INFO - 'MOZ_NO_REMOTE': '1', 09:29:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:21 INFO - 'NO_EM_RESTART': '1', 09:29:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:21 INFO - 'PWD': '/builds/slave/test', 09:29:21 INFO - 'SHELL': '/bin/bash', 09:29:21 INFO - 'SHLVL': '1', 09:29:21 INFO - 'TERM': 'linux', 09:29:21 INFO - 'TMOUT': '86400', 09:29:21 INFO - 'USER': 'cltbld', 09:29:21 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1497102457.494117-1620765085', 09:29:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:21 INFO - '_': '/tools/buildbot/bin/python'} 09:29:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:29:22 INFO - Running setup.py (path:/tmp/pip-53a88E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:29:22 INFO - Running setup.py (path:/tmp/pip-c9_gKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:29:22 INFO - Running setup.py (path:/tmp/pip-4MAFdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:29:22 INFO - Running setup.py (path:/tmp/pip-1TNuBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:29:22 INFO - Running setup.py (path:/tmp/pip-4fv5Oi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:29:22 INFO - Running setup.py (path:/tmp/pip-znvW_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:29:22 INFO - Running setup.py (path:/tmp/pip-YEMH_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:29:22 INFO - Running setup.py (path:/tmp/pip-KIxtwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:29:22 INFO - Running setup.py (path:/tmp/pip-c0KVqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:29:22 INFO - Running setup.py (path:/tmp/pip-_zklxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:29:22 INFO - Running setup.py (path:/tmp/pip-ZGck_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:29:22 INFO - Running setup.py (path:/tmp/pip-Fq4aXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:29:22 INFO - Running setup.py (path:/tmp/pip-nVT1jB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:29:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:29:23 INFO - Running setup.py (path:/tmp/pip-o68a0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:29:23 INFO - Running setup.py (path:/tmp/pip-viDDEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:29:23 INFO - Running setup.py (path:/tmp/pip-B7qiAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:29:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:29:23 INFO - Running setup.py (path:/tmp/pip-oHtXgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:29:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:29:23 INFO - Running setup.py install for manifestparser 09:29:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:29:23 INFO - Running setup.py install for mozcrash 09:29:23 INFO - Running setup.py install for mozdebug 09:29:23 INFO - Running setup.py install for mozdevice 09:29:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:29:23 INFO - Running setup.py install for mozfile 09:29:23 INFO - Running setup.py install for mozhttpd 09:29:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:29:23 INFO - Running setup.py install for mozinfo 09:29:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:29:23 INFO - Running setup.py install for mozInstall 09:29:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:29:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:29:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:29:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:29:24 INFO - Running setup.py install for mozleak 09:29:24 INFO - Running setup.py install for mozlog 09:29:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:29:24 INFO - Running setup.py install for moznetwork 09:29:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:29:24 INFO - Running setup.py install for mozprocess 09:29:24 INFO - Running setup.py install for mozprofile 09:29:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:29:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:29:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:29:24 INFO - Running setup.py install for mozrunner 09:29:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:29:24 INFO - Running setup.py install for mozscreenshot 09:29:24 INFO - Running setup.py install for moztest 09:29:24 INFO - Running setup.py install for mozversion 09:29:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:29:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:29:25 INFO - Cleaning up... 09:29:25 INFO - Return code: 0 09:29:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:29:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:25 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 0x1b483b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d22a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec69a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec4140>, '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 0x1ec4a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec4ed0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1497102457.494117-1620765085', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:29:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:29:25 INFO - Using env: {'DISPLAY': ':0', 09:29:25 INFO - 'HOME': '/home/cltbld', 09:29:25 INFO - 'LANG': 'en_US.UTF-8', 09:29:25 INFO - 'LANGUAGE': 'en_US:en', 09:29:25 INFO - 'LOGNAME': 'cltbld', 09:29:25 INFO - 'MAIL': '/var/mail/cltbld', 09:29:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:25 INFO - 'MOZ_NO_REMOTE': '1', 09:29:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:25 INFO - 'NO_EM_RESTART': '1', 09:29:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:25 INFO - 'PWD': '/builds/slave/test', 09:29:25 INFO - 'SHELL': '/bin/bash', 09:29:25 INFO - 'SHLVL': '1', 09:29:25 INFO - 'TERM': 'linux', 09:29:25 INFO - 'TMOUT': '86400', 09:29:25 INFO - 'USER': 'cltbld', 09:29:25 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1497102457.494117-1620765085', 09:29:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:25 INFO - '_': '/tools/buildbot/bin/python'} 09:29:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:29:25 INFO - Running setup.py (path:/tmp/pip-4ScszB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:29:25 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:29:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:29:25 INFO - Running setup.py (path:/tmp/pip-sNrDhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:29:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:29:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:29:25 INFO - Running setup.py (path:/tmp/pip-p0TrfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:29:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:29:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:29:25 INFO - Running setup.py (path:/tmp/pip-ojqj1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:29:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:29:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:29:25 INFO - Running setup.py (path:/tmp/pip-PQLKUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:29:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:29:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:29:25 INFO - Running setup.py (path:/tmp/pip-rA6p7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:29:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:29:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:29:25 INFO - Running setup.py (path:/tmp/pip-Ml3_FS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:29:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:29:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:29:25 INFO - Running setup.py (path:/tmp/pip-KJSeCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:29:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:29:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:29:25 INFO - Running setup.py (path:/tmp/pip-4jVgWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:29:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:29:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:29:25 INFO - Running setup.py (path:/tmp/pip-ktNwQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:29:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:29:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:29:26 INFO - Running setup.py (path:/tmp/pip-2jSCWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:29:26 INFO - Running setup.py (path:/tmp/pip-n1uxE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:29:26 INFO - Running setup.py (path:/tmp/pip-xGU7xn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:29:26 INFO - Running setup.py (path:/tmp/pip-WK8rU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:29:26 INFO - Running setup.py (path:/tmp/pip-MlVInY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:29:26 INFO - Running setup.py (path:/tmp/pip-lz2R2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:29:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:29:26 INFO - Running setup.py (path:/tmp/pip-ZX7gBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:29:26 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:29:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:27 INFO - Downloading blessings-1.6.tar.gz 09:29:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:29:27 INFO - Installing collected packages: blessings 09:29:27 INFO - Running setup.py install for blessings 09:29:27 INFO - Successfully installed blessings 09:29:27 INFO - Cleaning up... 09:29:27 INFO - Return code: 0 09:29:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:29:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:29:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:29:28 INFO - Reading from file tmpfile_stdout 09:29:28 INFO - Current package versions: 09:29:28 INFO - argparse == 1.2.1 09:29:28 INFO - blessings == 1.6 09:29:28 INFO - blobuploader == 1.2.4 09:29:28 INFO - docopt == 0.6.1 09:29:28 INFO - functools32 == 3.2.3-2 09:29:28 INFO - jsonschema == 2.5.1 09:29:28 INFO - manifestparser == 1.1 09:29:28 INFO - mozInstall == 1.13 09:29:28 INFO - mozcrash == 1.0 09:29:28 INFO - mozdebug == 0.1 09:29:28 INFO - mozdevice == 0.51 09:29:28 INFO - mozfile == 1.2 09:29:28 INFO - mozhttpd == 0.7 09:29:28 INFO - mozinfo == 0.10 09:29:28 INFO - mozleak == 0.1 09:29:28 INFO - mozlog == 3.4 09:29:28 INFO - moznetwork == 0.27 09:29:28 INFO - mozprocess == 0.25 09:29:28 INFO - mozprofile == 0.28 09:29:28 INFO - mozrunner == 6.13 09:29:28 INFO - mozscreenshot == 0.1 09:29:28 INFO - mozsystemmonitor == 0.3 09:29:28 INFO - moztest == 0.8 09:29:28 INFO - mozversion == 1.4 09:29:28 INFO - psutil == 3.1.1 09:29:28 INFO - requests == 1.2.3 09:29:28 INFO - wsgiref == 0.1.2 09:29:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:29:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:28 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 0x1b483b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d22a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec69a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec4140>, '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 0x1ec4a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec4ed0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1497102457.494117-1620765085', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:29:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:29:28 INFO - Using env: {'DISPLAY': ':0', 09:29:28 INFO - 'HOME': '/home/cltbld', 09:29:28 INFO - 'LANG': 'en_US.UTF-8', 09:29:28 INFO - 'LANGUAGE': 'en_US:en', 09:29:28 INFO - 'LOGNAME': 'cltbld', 09:29:28 INFO - 'MAIL': '/var/mail/cltbld', 09:29:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:28 INFO - 'MOZ_NO_REMOTE': '1', 09:29:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:28 INFO - 'NO_EM_RESTART': '1', 09:29:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:28 INFO - 'PWD': '/builds/slave/test', 09:29:28 INFO - 'SHELL': '/bin/bash', 09:29:28 INFO - 'SHLVL': '1', 09:29:28 INFO - 'TERM': 'linux', 09:29:28 INFO - 'TMOUT': '86400', 09:29:28 INFO - 'USER': 'cltbld', 09:29:28 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1497102457.494117-1620765085', 09:29:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:28 INFO - '_': '/tools/buildbot/bin/python'} 09:29:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:29:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:29:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:29:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:29:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:29:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:29:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:29:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:29:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:29:28 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:29:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:29 INFO - Downloading marionette_driver-1.4.0.tar.gz 09:29:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 09:29:29 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:29:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:29:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:29:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:29:29 INFO - Installing collected packages: marionette-driver 09:29:29 INFO - Running setup.py install for marionette-driver 09:29:29 INFO - Successfully installed marionette-driver 09:29:29 INFO - Cleaning up... 09:29:29 INFO - Return code: 0 09:29:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:29:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b483b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d22a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ec69a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ec4140>, '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 0x1ec4a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec4ed0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1497102457.494117-1620765085', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:29:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:29:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:29:29 INFO - Using env: {'DISPLAY': ':0', 09:29:29 INFO - 'HOME': '/home/cltbld', 09:29:29 INFO - 'LANG': 'en_US.UTF-8', 09:29:29 INFO - 'LANGUAGE': 'en_US:en', 09:29:29 INFO - 'LOGNAME': 'cltbld', 09:29:29 INFO - 'MAIL': '/var/mail/cltbld', 09:29:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:29 INFO - 'MOZ_NO_REMOTE': '1', 09:29:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:29 INFO - 'NO_EM_RESTART': '1', 09:29:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:29 INFO - 'PWD': '/builds/slave/test', 09:29:29 INFO - 'SHELL': '/bin/bash', 09:29:29 INFO - 'SHLVL': '1', 09:29:29 INFO - 'TERM': 'linux', 09:29:29 INFO - 'TMOUT': '86400', 09:29:29 INFO - 'USER': 'cltbld', 09:29:29 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1497102457.494117-1620765085', 09:29:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:29 INFO - '_': '/tools/buildbot/bin/python'} 09:29:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:29:29 INFO - Cleaning up... 09:29:29 INFO - Return code: 0 09:29:29 INFO - Running post-action listener: _resource_record_post_action 09:29:29 INFO - Running post-action listener: _start_resource_monitoring 09:29:29 INFO - Starting resource monitoring. 09:29:29 INFO - [mozharness: 2017-06-10 16:29:29.975506Z] Finished create-virtualenv step (success) 09:29:29 INFO - [mozharness: 2017-06-10 16:29:29.975968Z] Running install step. 09:29:29 INFO - Running pre-action listener: _resource_record_pre_action 09:29:29 INFO - Running main action method: install 09:29:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:29:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:29:30 INFO - Reading from file tmpfile_stdout 09:29:30 INFO - Detecting whether we're running mozinstall >=1.0... 09:29:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:29:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:29:30 INFO - Reading from file tmpfile_stdout 09:29:30 INFO - Output received: 09:29:30 INFO - Usage: mozinstall [options] installer 09:29:30 INFO - Options: 09:29:30 INFO - -h, --help show this help message and exit 09:29:30 INFO - -d DEST, --destination=DEST 09:29:30 INFO - Directory to install application into. [default: 09:29:30 INFO - "/builds/slave/test"] 09:29:30 INFO - --app=APP Application being installed. [default: firefox] 09:29:30 INFO - mkdir: /builds/slave/test/build/application 09:29:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:29:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:29:47 INFO - Reading from file tmpfile_stdout 09:29:47 INFO - Output received: 09:29:47 INFO - /builds/slave/test/build/application/firefox/firefox 09:29:47 INFO - Running post-action listener: _resource_record_post_action 09:29:47 INFO - [mozharness: 2017-06-10 16:29:47.953938Z] Finished install step (success) 09:29:47 INFO - [mozharness: 2017-06-10 16:29:47.954224Z] Running setup-mitmproxy step. 09:29:47 INFO - Running pre-action listener: _resource_record_pre_action 09:29:47 INFO - Running main action method: setup_mitmproxy 09:29:47 INFO - Skipping: mitmproxy is not required 09:29:47 INFO - Running post-action listener: _resource_record_post_action 09:29:47 INFO - [mozharness: 2017-06-10 16:29:47.955423Z] Finished setup-mitmproxy step (success) 09:29:47 INFO - [mozharness: 2017-06-10 16:29:47.955646Z] Running run-tests step. 09:29:47 INFO - Running pre-action listener: _resource_record_pre_action 09:29:47 INFO - Running main action method: run_tests 09:29:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:29:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:29:47 INFO - Python 2.7.3 09:29:47 INFO - Return code: 0 09:29:47 INFO - grabbing minidump binary from tooltool 09:29:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:29:47 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 0x1ec4140>, '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 0x1ec4a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ec4ed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:29:47 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:29:47 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:29:47 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:29:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:29:48 INFO - Return code: 0 09:29:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:29:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:29:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:29:48 INFO - ENV: RUST_BACKTRACE is now 1 09:29:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:29:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:29:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CsZ6WwGvRvGOw2wq_DXcUA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:29:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CsZ6WwGvRvGOw2wq_DXcUA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-062 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:29:48 INFO - Using env: {'DISPLAY': ':0', 09:29:48 INFO - 'HOME': '/home/cltbld', 09:29:48 INFO - 'LANG': 'en_US.UTF-8', 09:29:48 INFO - 'LANGUAGE': 'en_US:en', 09:29:48 INFO - 'LOGNAME': 'cltbld', 09:29:48 INFO - 'MAIL': '/var/mail/cltbld', 09:29:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:29:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:29:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:48 INFO - 'MOZ_NO_REMOTE': '1', 09:29:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:29:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:29:48 INFO - 'NO_EM_RESTART': '1', 09:29:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:29:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:48 INFO - 'PWD': '/builds/slave/test', 09:29:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:29:48 INFO - 'RUST_BACKTRACE': '1', 09:29:48 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:29:48 INFO - 'SHELL': '/bin/bash', 09:29:48 INFO - 'SHLVL': '1', 09:29:48 INFO - 'TERM': 'linux', 09:29:48 INFO - 'TMOUT': '86400', 09:29:48 INFO - 'USER': 'cltbld', 09:29:48 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1497102457.494117-1620765085', 09:29:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:48 INFO - '_': '/tools/buildbot/bin/python'} 09:29:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CsZ6WwGvRvGOw2wq_DXcUA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:29:48 INFO - mozversion application_buildid: 20170610152833 09:29:48 INFO - mozversion application_changeset: 8a990794c2ee923ccd839750912d10ff3a690a2a 09:29:48 INFO - mozversion application_display_name: Nightly 09:29:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:29:48 INFO - mozversion application_name: Firefox 09:29:48 INFO - mozversion application_remotingname: firefox 09:29:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:29:48 INFO - mozversion application_vendor: Mozilla 09:29:48 INFO - mozversion application_version: 55.0a1 09:29:48 INFO - mozversion platform_buildid: 20170610152833 09:29:48 INFO - mozversion platform_changeset: 8a990794c2ee923ccd839750912d10ff3a690a2a 09:29:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:29:48 INFO - mozversion platform_version: 55.0a1 09:29:48 INFO - using testdate: 1497112188 09:29:48 INFO - actual date: 1497112188 09:29:48 INFO - starting webserver on 'localhost:35088' 09:29:48 INFO - SUITE-START | Running 2 tests 09:29:48 INFO - TEST-START | dromaeo_css 09:29:48 INFO - operating with platform_type : linux_ 09:29:48 INFO - Initialising browser for dromaeo_css test... 09:29:48 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35088/getInfo.html -profile /tmp/tmph7WmlA/profile 09:29:48 INFO - TEST-INFO | started process 5636 (/builds/slave/test/build/application/firefox/firefox http://localhost:35088/getInfo.html) 09:30:23 INFO - TEST-INFO | 5636: killed by SIGTERM 09:30:23 INFO - Browser initialized. 09:30:23 INFO - Running cycle 1/1 for dromaeo_css test... 09:30:23 INFO - TEST-INFO | started process 5848 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph7WmlA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:30:34 INFO - PID 5848 | RSS: Main: 177864704 09:30:34 INFO - PID 5848 | 09:33:34 INFO - PID 5848 | Cycle 1(1): loaded http://localhost:35088/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35088/tests/dromaeo/cssquery-ext.html) 09:33:36 INFO - PID 5848 | RSS: Main: 174227456 09:33:36 INFO - PID 5848 | 09:36:38 INFO - PID 5848 | Cycle 1(1): loaded http://localhost:35088/tests/dromaeo/cssquery-ext.html (next: http://localhost:35088/tests/dromaeo/cssquery-jquery.html) 09:36:38 INFO - PID 5848 | RSS: Main: 178651136 09:36:38 INFO - PID 5848 | 09:39:40 INFO - PID 5848 | Cycle 1(1): loaded http://localhost:35088/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35088/tests/dromaeo/cssquery-mootools.html) 09:39:41 INFO - PID 5848 | RSS: Main: 178241536 09:39:41 INFO - PID 5848 | 09:42:42 INFO - PID 5848 | Cycle 1(1): loaded http://localhost:35088/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35088/tests/dromaeo/cssquery-prototype.html) 09:42:43 INFO - PID 5848 | RSS: Main: 181624832 09:42:43 INFO - PID 5848 | 09:45:46 INFO - PID 5848 | Cycle 1(1): loaded http://localhost:35088/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35088/tests/dromaeo/cssquery-yui.html) 09:45:46 INFO - PID 5848 | RSS: Main: 180133888 09:45:46 INFO - PID 5848 | 09:48:48 INFO - PID 5848 | Cycle 1(1): loaded http://localhost:35088/tests/dromaeo/cssquery-yui.html (next: http://localhost:35088/tests/dromaeo/cssquery-dojo.html) 09:48:48 INFO - PID 5848 | RSS: Main: 178896896 09:48:48 INFO - PID 5848 | 09:48:48 INFO - PID 5848 | __start_tp_report 09:48:48 INFO - PID 5848 | _x_x_mozilla_page_load 09:48:48 INFO - PID 5848 | _x_x_mozilla_page_load_details 09:48:48 INFO - PID 5848 | |i|pagename|runs| 09:48:48 INFO - PID 5848 | |0;dojo.html;3368.679975402337;3380.5605271314726;3388.2207092368753;3390;3406.0463070340306;5886.529077673787;5900.557458190631;5963.568743501555;5970.402959704027;5997.910031349527;5968.79109231177;5991.370906054856;6047.365026672191;6060.545459090575;6110.572259941795;4987.251912213161;5267.629566695003;5328.067588172074;5330.466953304677;5379.058664733676;5459.945400546003;5471.562275018009;5501;5509.807156749514;5528.06022976093;5256.632035757499;5313.203019547061;5372.597055220835;5391.110466772978;5436.456354364572;5377.596680248997;5378.46215378463;5382.6232163748555;5396.703181325026;5424.1321388578035;5290.788368465257;5331.840044798662;5371.81198658049;5375.758090885881;5406.324209473816;5821.592488525805;5882.499987501067;5925.229720136398;6014.278286605635;6026.819195424145;6403.103565500834;6500.544961852672;6516.9674151629415;6537.117489138953;6540;6582.275949645536;6610.107635469246;6611.933880661228;6619.834504137387;6641.435477984377;5923.970380148072;6092.177556029924;6100.23747031621;6130.386961303834;6132.816015519497;6580.276169621337;6610.570312929644;6708.19501659804;6722.495812814059;6750.358715922078;6191.628502289877;6213.751449942042;6338.651374174372;6441.903371449432;6477.77327793525;6510.869782604322;6520.0871877937125;6538.967305163444;6558.475321974231;6573.835654108686;6153.1693221415435;6436.066770318372;6461.224653041571;6462.838429039311;6560.770373037016;6328.6835658216905;6345.650989195547;6398.776042838478;6467.353264673589;6544.312847151075;4914.65597408178;4923.975380123076;4969.875753106129;4987.675801072919;4990.550850423407;4401.965538098544;4416.028473735773;4419.933700994423;4426.468823741107;4427.601515863587;5929.940700592939;6053.334133245339;6086.239220097488;6166.876662466726;6174.104754810527;6617.073609694647;6618.371254730793;6620.503462240351;6624.602523848488;6631.933680663132;6165.815025549241;6174.9073763893575;6177.752889884444;6178.783742569079;6179.81460556184;5376.91934620981;5487.204355368449;5487.396386397493;5584.357798853184;5598.888022239533;6838.589684618939;6860;6882.242953275136;6894.13823272091;6897;6546.738130474728;6584.572002819801;6612.867742645024;6639.070530125883;6639.767608133692;6552.1154644124335;6626.801195964129;6893.896591551231;6903.1371078615175;6906.136732908387;6323.430891219812;6388.584741991755;6409.775657851953;6415.101885735908;6416.262129855127;6578.210614726264;6579.80260592183;6599.208095028627;6605.867882642417;6611.33886611335;6088.665123418255;6194;6301.905471417841;6353.364663533795;6422.165118534561;6424.4860411166055;6441.71012304438;6442.484601231797;6443.065755465525;6476.643784591893;6403.839904002437;6417.839554011187;6426.518011149089;6434;6449.451796597342;6175.536834737502;6270.341614130633;6440.645764482999;6488.578242414228;6525.967370163119;6153.107799369156;6174.753009879554;6197.070439434121;6216.72024758896;6239.376062393724 09:48:48 INFO - PID 5848 | |1;ext.html;755.4598462099598;805.621357961758;831.1314676163407;1109.2401704832191;1121.3664279681973;38754.418683719734;39657.40513892294;39662.60337396625;39680.40479392808;39702.80148599257;41331.38002929959;41606.16787664245;41610;41699.583004170025;41705.58294417055;7119.394851437621;7226.024486694281;7243.384312333458;7251.057362542862;7497.550146991171;7410.777676669709;7441.330280274774;7475.439342049341;7499.175090740015;7526.8870966935265;7452.515586486888;7489.400847932152;7550.3959683225485;7556.811079723024;7563.810904727398;7498.250174982512;7499.962500187464;7502.624868756595;7518.849623007536;7522.736704215326;7036.40190583801;7066.611336376497;7070;7083.18543367509;7101.8224544386285;37470;37800.62199378026;37902.62097379019;38128.237435251416;38209.80895095535;3346.6486018967903;3358.580177477815;3367.1413789483768;3369.3598216339064;3390.3897298486263;29614;29769.25576860574;29931;29950.85024574885;30031.69968300311;3737.3459644562095;3754.3805272130066;3755.9436608450897;3759.5488541374934;3764.1154328732728;161017;165254;165328;197399.99999999857;198753;42664.36003459951;43020.56979430228;43035.569644303156;43051.56948430538;43082;44632.77683611561;44767.55232447634;44767.55232447699;44841.551584483735;44850;15365.231738413035;15365.308561114776;15487.922560387125;15497.845021549865;15539.378424862878;12419.503219871285;12610.054245931591;12619.30593817349;12637.052221083455;12637.810432843515;14759;14793.186374749492;14806.259687015607;14900.329485173193;15146.848531514765;5758.712064396764;5840.561957853178;5906.3207731110615;5978.970105149447;5999.670018148957;1019.3323373190572;1034.2294990232326;1037.9481025948671;1052.516062093459;1115.576081089181;25071.498570028863;25421.237362879143;25685.871570642026;25877.74122258791;25955;1113.777244551093;1155.156735583029;1173.4015652017533;1183.893449589524;1190.214458457414;13121.803172952414;13565.616296215248;13628.863711362957;13792.379342929593;13853.16880987144;274511;275239;277027;278379;278422;54971.175432368545;55524.16713749297;55601.721991390594;55723.72138139283;55814;1481.5555333399936;1503.7293287208188;1510.7205167044133;1517.2944580769774;1518.552027151993;24024.759752402253;24432.755672443047;24504;24817.1314004009;25033.87483062646;39709;39869.40195897006;39992.60007399889;40072.39891401573;40151.59848401479;211712;212362;212842;212845;213580;35329.82335088308;36486.27027459383;36981.260374792895;37114.628853712195;37225.25549488941;42915.356269655356;45327;45721.08557828891;45813.77093114513;45846.54153458556;32220.677793221766;32298.19254518562;32339.35321293608;32847;33874.3225135491;32146.839265803523;32149.678503215604;32199.195020124684;33209.33581328408;33387.66612333846;38398.232035359695;38762.22475550417;39284;39519.407208892466;39564.40653390259;30300;31737.36525269528;31876.203094922814;31968.36063278768;32583.348333032733;25718;25871;26846.865765671046;26896.193114205824;26945.865270673523 09:48:48 INFO - PID 5848 | |2;jquery.html;512.1881817319548;517.3444261158525;518.9091908915939;519.6492367651834;531.5588061908617;20576.794232057677;21347.57304853902;21427.67858482122;22689.659655105144;23472.29583112505;21111.6833247501;21274.36176914691;21382;21391.251306204285;21439;5822.359540450547;5942.346341902387;5948.553858460611;5959.761609535613;5972.283326000886;5734.541236701054;5748.712564371785;5749.3388260350175;5763.855903602423;5767.538596912237;5570.721463926808;5734.827955161331;5746.281714785652;5772.797952071678;5810.448007439287;5839.591228613998;5878.206442130343;5881.823545293627;5890.499307558863;5901.380355062743;5390.757415916293;5455.1544510600925;5464.9180262296095;5466.562674986031;5480.561555075625;27283.45433091327;27512;27548.17355479339;27782.444351112863;27816.443671126464;2073.056759174572;2108.0303060592146;2125.330520885916;2128.5742851429623;2129.169623846701;17842.375516856977;18420.907895460572;18522;18595.907020464947;18647.160877760532;2207.194374053459;2216.656418255173;2254.9098036078535;2282.5206706591634;2298.2300929188573;127839.36080319632;133822.3308883459;140111;140780;141518;14437.411884692676;14555.92722036383;14656.780148297785;14795.408183672747;14874.181919994504;21464.570708586052;21540.676889846665;21594.352169434944;21714.240001600185;21838.563228735653;8953.686620968236;9092.772680683036;9239.445633262027;9346.065393460736;9547.188488978376;8533.445326053787;8536.189062039097;8554.743357699279;8657.567121643893;8659.653613855502;8942.37403381757;9086.500242486594;9142.862857057149;9197.448153110701;9226.370484411911;2519.722830488645;2543.2070390374743;2546.5288921549572;2594.455164415494;2643.9074632387774;1001.8246806808779;1007.2143727892255;1025.348903446302;1027.1679939249232;1027.3476342522551;19732.210711571377;19835.404937851887;20310.492237694176;20384.592308153755;20919.163233470794;1008.2740426892625;1013.2451323763843;1022.7698767777339;1034.813733527957;1044.1698849414734;10810.729731756612;10866.130709543218;11125.944370278097;11280.71798205035;11451.599194028335;530202;546818;555728;576399;577672;110340;110872;111159;111883;111913;1150.246588484544;1175.435790820411;1260.1053252190864;1281.4553814628746;1285.254552359629;20138.39584812458;21316.147354105662;21440.46398839979;21632.783672163077;21756.34730958074;54151.458485414645;55258;55329;56746.71626641841;57798.7110064447;66968.6651566739;67523;67790;68105.65947170233;68197;12281.69295767613;12294.323812190058;12368.505259789868;12453.630100688735;12543.87456125427;18204.635907282045;18209.54323654078;18236.544086397946;18441.170147343135;18858;14844.183569903758;14909.179995100374;15000.474983375529;15088.54734357971;15094.245287735788;13676.452941882611;13861;13952.79070813959;14164.079334843202;14491.78262326045;15385.84614153844;15646;15800.76298855541;15829.683406332038;15853.286602103164;12222.294416649831;12308.446119924445;12353.752924941631;12378.81431778542;12487.687807804878;15102.622434439227;15159.848401515843;15208.695826083194;15566;15735.213239337758 09:48:48 INFO - PID 5848 | |3;mootools.html;1304.941277642506;1386.549371454277;1397.4759465200552;1406.2546850169413;1413.7101894111709;12942.352882355892;13033.283169425678;13488.46046158155;13550.525731599408;13598.320083995797;13027;13188.93405532971;13246.07277490576;13289.136206146593;13326.400311985959;2440.9145679901208;2478.25652304308;2492.5638013347684;2493.0651005872796;2498.250524842549;2380.047980807682;2442.767937045987;2446.972271645904;2449.5590793657134;2454.5581795276844;2345.2729653807287;2388.9880550597222;2398.9280321590295;2400.627902675088;2416.516696660675;2263.649134384173;2373.8338316317863;2376.9286921392386;2381.1070848431837;2383.4518060846017;2205.6691496275525;2214.7342318921833;2304.953900921972;2490.8131890108316;2494.239257026606;13100.707376209126;13196.53812116581;13244.933775331061;13256.801147982787;13282.734345313136;7211.603361815098;7430.108386993541;7434.628268586604;7466.328030477229;7480.214577469342;4204;4223.577642235752;4336.3712261722185;4373.956260437387;4375.912481750379;1545.0575149159004;1547.582152818744;1551.8215405228318;1594.6252630631793;1603.2144249317867;20996.580068398547;21175.152993880227;21221.469463263387;21255.5748885023;21285.14859405622;6175.135481032659;6255.718492667841;6360.522960777867;6367.56729735815;6418.133551970518;15013.174275414738;15052.924735376253;15088.773668394982;15115.31981060855;15184.848151518565;7237.131544214728;7480.8877866832045;7489.101307843093;7489.662965166581;7496.212897645778;6790.253072162058;6848.417884479775;6865.794026179223;6874.690638921261;6900.171979362408;4759.738214398172;4948.208286674115;4966.428860680996;5004.4995500450395;5027.145385284511;1391.6938273579797;1424.9643758905902;1454.8690617844445;1464.8022516960286;1477.4828809916658;811.9066307374727;837.5142417397894;850.4599579267086;857.1342943626858;857.7684025313131;6946.6179360134665;7199.71201151948;7416.184219735825;7526.32263096324;7730.690772369042;1001.2640709078821;1010.0656892374524;1012.0790081026231;1013.0679774607379;1022.6114076650974;4723.763811809465;4910.238912968495;4913.238448040559;5106.183010718267;5196.53231209193;17797.377091801984;18064.458066258034;18259;18278.817211827976;18296.817031829512;17564.91217543904;18098.547536311435;18211.908940455214;18366.357177498725;18367.35714249995;10226.488675566192;10648.574057037631;10711;10714.089302409227;10782.946085269523;6897.241303456515;7119.359257666835;7428.517146385468;7438.5536867788105;7505.66224519887;15692.764608530653;15998.760018599964;16094.436694715629;16164.919175404048;16585.585360366087;16437.09595972233;16669.083200424095;16927.49217523476;16931.15344232808;17119.14404279806;11018.614348497764;11031.724206894893;11056.613018544313;11197.60808371703;11218.66344009681;12288.201266917622;12352.62942111738;12363;12380.071494638118;12408.503659853866;10074.798504029732;10237.795244094927;10247.590096396061;10495.160387168855;10551.788964220827;9960.800783984425;9972.102510773775;10047;10068.496575171066;10207.642732504326;9097.545122743968;9242.12199841014;9253.398529095588;9265.351425400157;9274.44353338802;6374.6175229484525;6521.902171467337;6710;6822.8635427292165;7114.50198486101;7012.789616311519;7044.36600705939;7163.570185788869;7285.7814265572115;7330.230325815925 09:48:48 INFO - PID 5848 | |4;prototype.html;461.47391973150593;472.8392346602155;486.79554587073426;491.23858020068906;494.6982340772128;6237.376262373766;6243.219597550306;6250.40621140992;6291.276503202133;6317.747290108396;5965.791197308095;6112.602680825743;6121.234845644294;6127.908081378783;6140.662263575501;4781.545753153445;4787.1861783496715;4789.449213340476;4794.400699912511;4813.085513752393;4798.184308667535;4799.2801079837955;4807.206810876201;4811.566958973692;4815.807367705305;4777.5222477752295;4782.306565547993;4796.88007799806;4807.855764327076;4810.663253572251;4784.617230621542;4801.2798080287885;4805.702460335725;4807.519248075182;4823.734694591796;4323.956760432418;4330.0906809569715;4332.682015121894;4346.8043938022865;4362.498312694049;5992.880142397127;6063.575549711522;6100.938990610126;6107.625784198564;6113.296970848365;5716.828495145152;5732.369439361667;5737.598368114233;5741.856453588652;5765.308163020422;6578.27638959714;6621.9006714899315;6629.767958121491;6656.56732312403;6658.434033107192;4892.730899800509;4900.191468407708;4914.4839791821705;4921.409430868319;4923.433805112422;6500.284968653445;6838.794836154873;6864.691088901011;6867;6948.652567371611;4999.525045120708;5016.673916195508;5022.547970682656;5023.522765337287;5038.697678139323;4999.52504512078;5024.874378140503;5033.848984530397;5044.268581055726;5053.69677819332;5486.835394938158;5599.216109744639;5624.521915637135;5662.68855212959;5721.199032135504;6589.703463344161;6599.769008084694;6618.503612229102;6626.56927299724;6630.403263706289;1712.5290545100197;1720.819313972015;1721.8536424403815;1726.214572369569;1728.3086765293983;1177.3406892140429;1210.8062709966364;1235.3144005077268;1236.8206610041493;1241.4351470081092;6109.175261339662;6196.755222672394;6238.344973777779;6258.624482531062;6272.560920735596;6729.596224226562;6737.898931516032;6758.445557521699;6771.5259931805285;6835.726570937107;6267.780627678009;6275.905861412082;6279.937200627935;6280.811575652738;6282.591631543935;3584.3727347714566;3586.5337506124038;3591.8742844000335;3606.9278614427562;3633.182533929845;6959.582425054513;7062.540934839321;7082.521117608796;7083.256258092826;7099.07711997437;6873.243943166248;6966.12923384577;6973.302669733088;6984.860302793915;6999.650017499104;6942.687579058955;6976.651167441608;7014.859702805916;7029.61337126463;7045.612491312924;6722.327767223239;6723.596584204964;6725.49558783103;6737.831554210988;6743.089682892747;6342.8731425370315;6639.800805975829;6662.635369138554;6681.2984636612455;6731.124953756176;6419.614823110628;6942.2363540011565;6954.930450695429;6958.826029349307;7002.334778196063;4929.97535012337;4961.7271050092595;4963.9007219854675;4971.477994810492;4980.153373926513;6625.271220165874;6738.427233685192;6778.491613129134;6789.422899053636;6848.14398200225;6534.215894092739;6580.367852858894;6593.472522198309;6622.966885165543;6647.302033286435;6517.4134327910715;6629.933700662931;6634.090772828169;6642.575459956985;6643.169603799525;6522.249941256627;6564.770233041821;6568.1789776277965;6606.207255129415;6612.272650008399;6607.339266073546;6609.290191021658;6651.16860392451;6652.634105124264;6658.600483970784;6389.702982161038;6401.199850018747;6439;6452.451541619015;6453.128827608401 09:48:48 INFO - PID 5848 | |5;yui.html;758.525921299188;773.4237992695442;794.1343935110729;800.4116974024091;848.2196379331011;14432.5670229893;14817.407303707852;14831.258437078144;16185.43350982713;16908.915455422735;17048.14759262035;17685.73471397927;17693.64612707745;17697.734533982002;17794.46616601501;958.4776296918179;984.5864736810556;986.6546708651986;989.945552994585;993.359283262299;970.9514524273793;1013.0679774607379;1014.0569270578359;1014.4876837197241;1015.0306457333265;1055.59887242848;1055.688571871296;1062.8246339353998;1063.521415363086;1064.8562444070067;1040.5005597313257;1041.1150522056266;1044.5560636729397;1053.678628018454;1053.9789204215872;769.3960241210679;771.5987686403039;772.8261141243231;773.6054612147789;774.6436639146;15561.610959726097;16198;16405.17974101302;16409.097499637515;16508.504744857673;16955.04321903126;17098.230579623945;17429.912850435667;17552;17590.29638814446;15414.845851541453;15735;15763.763543546856;15789.28948197334;15826.446074387457;3367;3369.595648522193;3392.1689186149306;3393.558837351153;3434.210131669705;102496;102838;105287.47356263247;105486;105993;14411.855881441052;14772.48296309624;14968.775468367983;15071.171085590178;15305.46430874914;27255.45489090207;27583.172504824888;27646.861765691043;27780.861095694796;27816.582751258746;8337.374696897636;8372.03721572015;8383.748487545383;8447.36644751646;8490.193431623986;3851.326017946848;3869.400242962345;3886.8250928708276;3889.922201555953;3945.467361906106;4770.475247722748;4848.296996935424;4866.8783280417565;4882.340883980688;5038.269450929594;976.2921881635899;994.9751256218652;1003.4280460137652;1012.5494155101056;1019.3425240719843;691.7060249393987;709.9503034787618;711.3029231353199;719.8308397526577;733.1202556931597;11243.494042768096;12392;12554.937225313815;12760.872391275969;12771.489140434278;696.4219697650938;706.3501578547748;713.0623230451939;717.0857157124708;724.221461928429;4829.613630909519;5117.5394214520875;5180.222966555047;5245.239440281214;5333.679979201261;110938;113110.43444782724;113213;113877.43061284641;114284;101235.49382253189;101577;103196;103637.48181259196;104936.47531762446;83057.58471207727;83273.16726832776;84524;85870.57064714762;86717.5664121688;11904.404779761151;11915;12147.817782733442;12359.196652217577;12487.750244995232;38050;38614.2277154461;38671.22657546889;39248.607513925635;39706.40440393339;48909.75545122252;50894;61597;68783.3121668797;68925.65537172282;16676.58308542296;16695;16787.16064196761;16850.325986960874;16961.830381696025;19344.12951417218;19920.3027894023;19921.402357929284;20107.39677809668;20180.697289540964;19009.809901900804;19013.524661883563;19033.90483047576;19041.619167616846;19431.708524371865;17032.574185644964;17238.913805431395;17576.296948122443;17706.9375837445;17774.289028438718;16634.833651663812;16645.91677041607;16681.165941702624;18432.17055232491;18447.26210951547;11154.163437742363;11590.88409115898;11761.941190293994;11833.940830296138;11951.880481195425;13784.517541885985;13827.86172138306;14015.859841401456;14367.568972930829;14423.42306307736 09:48:48 INFO - PID 5848 | __end_tp_report 09:48:48 INFO - PID 5848 | __start_cc_report 09:48:48 INFO - PID 5848 | _x_x_mozilla_cycle_collect,347 09:48:48 INFO - PID 5848 | __end_cc_report 09:48:48 INFO - PID 5848 | __startTimestamp1497113328709__endTimestamp 09:48:48 INFO - PID 5848 | 09:48:48 INFO - PID 5848 | ------- Summary: start ------- 09:48:48 INFO - PID 5848 | Number of tests: 6 09:48:48 INFO - PID 5848 | 09:48:48 INFO - PID 5848 | [#0] dojo.html Cycles:165 Average:6013.52 Median:6197.07 stddev:740.27 (11.9%) stddev-sans-first:712.87 09:48:48 INFO - PID 5848 | Values: 3368.7 3380.6 3388.2 3390.0 3406.0 5886.5 5900.6 5963.6 5970.4 5997.9 5968.8 5991.4 6047.4 6060.5 6110.6 4987.3 5267.6 5328.1 5330.5 5379.1 5459.9 5471.6 5501.0 5509.8 5528.1 5256.6 5313.2 5372.6 5391.1 5436.5 5377.6 5378.5 5382.6 5396.7 5424.1 5290.8 5331.8 5371.8 5375.8 5406.3 5821.6 5882.5 5925.2 6014.3 6026.8 6403.1 6500.5 6517.0 6537.1 6540.0 6582.3 6610.1 6611.9 6619.8 6641.4 5924.0 6092.2 6100.2 6130.4 6132.8 6580.3 6610.6 6708.2 6722.5 6750.4 6191.6 6213.8 6338.7 6441.9 6477.8 6510.9 6520.1 6539.0 6558.5 6573.8 6153.2 6436.1 6461.2 6462.8 6560.8 6328.7 6345.7 6398.8 6467.4 6544.3 4914.7 4924.0 4969.9 4987.7 4990.6 4402.0 4416.0 4419.9 4426.5 4427.6 5929.9 6053.3 6086.2 6166.9 6174.1 6617.1 6618.4 6620.5 6624.6 6631.9 6165.8 6174.9 6177.8 6178.8 6179.8 5376.9 5487.2 5487.4 5584.4 5598.9 6838.6 6860.0 6882.2 6894.1 6897.0 6546.7 6584.6 6612.9 6639.1 6639.8 6552.1 6626.8 6893.9 6903.1 6906.1 6323.4 6388.6 6409.8 6415.1 6416.3 6578.2 6579.8 6599.2 6605.9 6611.3 6088.7 6194.0 6301.9 6353.4 6422.2 6424.5 6441.7 6442.5 6443.1 6476.6 6403.8 6417.8 6426.5 6434.0 6449.5 6175.5 6270.3 6440.6 6488.6 6526.0 6153.1 6174.8 6197.1 6216.7 6239.4 09:48:48 INFO - PID 5848 | 09:48:48 INFO - PID 5848 | [#1] ext.html Cycles:180 Average:39014.62 Median:18632.36 stddev:58879.38 (316.0%) stddev-sans-first:58974.48 09:48:48 INFO - PID 5848 | Values: 755.5 805.6 831.1 1109.2 1121.4 38754.4 39657.4 39662.6 39680.4 39702.8 41331.4 41606.2 41610.0 41699.6 41705.6 7119.4 7226.0 7243.4 7251.1 7497.6 7410.8 7441.3 7475.4 7499.2 7526.9 7452.5 7489.4 7550.4 7556.8 7563.8 7498.3 7500.0 7502.6 7518.8 7522.7 7036.4 7066.6 7070.0 7083.2 7101.8 37470.0 37800.6 37902.6 38128.2 38209.8 3346.6 3358.6 3367.1 3369.4 3390.4 29614.0 29769.3 29931.0 29950.9 30031.7 3737.3 3754.4 3755.9 3759.5 3764.1 161017.0 165254.0 165328.0 197400.0 198753.0 42664.4 43020.6 43035.6 43051.6 43082.0 44632.8 44767.6 44767.6 44841.6 44850.0 15365.2 15365.3 15487.9 15497.8 15539.4 12419.5 12610.1 12619.3 12637.1 12637.8 14759.0 14793.2 14806.3 14900.3 15146.8 5758.7 5840.6 5906.3 5979.0 5999.7 1019.3 1034.2 1037.9 1052.5 1115.6 25071.5 25421.2 25685.9 25877.7 25955.0 1113.8 1155.2 1173.4 1183.9 1190.2 13121.8 13565.6 13628.9 13792.4 13853.2 274511.0 275239.0 277027.0 278379.0 278422.0 54971.2 55524.2 55601.7 55723.7 55814.0 1481.6 1503.7 1510.7 1517.3 1518.6 24024.8 24432.8 24504.0 24817.1 25033.9 39709.0 39869.4 39992.6 40072.4 40151.6 211712.0 212362.0 212842.0 212845.0 213580.0 35329.8 36486.3 36981.3 37114.6 37225.3 42915.4 45327.0 45721.1 45813.8 45846.5 32220.7 32298.2 32339.4 32847.0 33874.3 32146.8 32149.7 32199.2 33209.3 33387.7 38398.2 38762.2 39284.0 39519.4 39564.4 30300.0 31737.4 31876.2 31968.4 32583.3 25718.0 25871.0 26846.9 26896.2 26945.9 09:48:48 INFO - PID 5848 | 09:48:48 INFO - PID 5848 | [#2] jquery.html Cycles:180 Average:35464.12 Median:21364.79 stddev:93086.16 (435.7%) stddev-sans-first:93310.30 09:48:48 INFO - PID 5848 | Values: 512.2 517.3 518.9 519.6 531.6 20576.8 21347.6 21427.7 22689.7 23472.3 21111.7 21274.4 21382.0 21391.3 21439.0 5822.4 5942.3 5948.6 5959.8 5972.3 5734.5 5748.7 5749.3 5763.9 5767.5 5570.7 5734.8 5746.3 5772.8 5810.4 5839.6 5878.2 5881.8 5890.5 5901.4 5390.8 5455.2 5464.9 5466.6 5480.6 27283.5 27512.0 27548.2 27782.4 27816.4 2073.1 2108.0 2125.3 2128.6 2129.2 17842.4 18420.9 18522.0 18595.9 18647.2 2207.2 2216.7 2254.9 2282.5 2298.2 127839.4 133822.3 140111.0 140780.0 141518.0 14437.4 14555.9 14656.8 14795.4 14874.2 21464.6 21540.7 21594.4 21714.2 21838.6 8953.7 9092.8 9239.4 9346.1 9547.2 8533.4 8536.2 8554.7 8657.6 8659.7 8942.4 9086.5 9142.9 9197.4 9226.4 2519.7 2543.2 2546.5 2594.5 2643.9 1001.8 1007.2 1025.3 1027.2 1027.3 19732.2 19835.4 20310.5 20384.6 20919.2 1008.3 1013.2 1022.8 1034.8 1044.2 10810.7 10866.1 11125.9 11280.7 11451.6 530202.0 546818.0 555728.0 576399.0 577672.0 110340.0 110872.0 111159.0 111883.0 111913.0 1150.2 1175.4 1260.1 1281.5 1285.3 20138.4 21316.1 21440.5 21632.8 21756.3 54151.5 55258.0 55329.0 56746.7 57798.7 66968.7 67523.0 67790.0 68105.7 68197.0 12281.7 12294.3 12368.5 12453.6 12543.9 18204.6 18209.5 18236.5 18441.2 18858.0 14844.2 14909.2 15000.5 15088.5 15094.2 13676.5 13861.0 13952.8 14164.1 14491.8 15385.8 15646.0 15800.8 15829.7 15853.3 12222.3 12308.4 12353.8 12378.8 12487.7 15102.6 15159.8 15208.7 15566.0 15735.2 09:48:48 INFO - PID 5848 | 09:48:48 INFO - PID 5848 | [#3] mootools.html Cycles:180 Average:8274.83 Median:2284.30 stddev:5607.18 (245.5%) stddev-sans-first:5598.45 09:48:48 INFO - PID 5848 | Values: 1304.9 1386.5 1397.5 1406.3 1413.7 12942.4 13033.3 13488.5 13550.5 13598.3 13027.0 13188.9 13246.1 13289.1 13326.4 2440.9 2478.3 2492.6 2493.1 2498.3 2380.0 2442.8 2447.0 2449.6 2454.6 2345.3 2389.0 2398.9 2400.6 2416.5 2263.6 2373.8 2376.9 2381.1 2383.5 2205.7 2214.7 2305.0 2490.8 2494.2 13100.7 13196.5 13244.9 13256.8 13282.7 7211.6 7430.1 7434.6 7466.3 7480.2 4204.0 4223.6 4336.4 4374.0 4375.9 1545.1 1547.6 1551.8 1594.6 1603.2 20996.6 21175.2 21221.5 21255.6 21285.1 6175.1 6255.7 6360.5 6367.6 6418.1 15013.2 15052.9 15088.8 15115.3 15184.8 7237.1 7480.9 7489.1 7489.7 7496.2 6790.3 6848.4 6865.8 6874.7 6900.2 4759.7 4948.2 4966.4 5004.5 5027.1 1391.7 1425.0 1454.9 1464.8 1477.5 811.9 837.5 850.5 857.1 857.8 6946.6 7199.7 7416.2 7526.3 7730.7 1001.3 1010.1 1012.1 1013.1 1022.6 4723.8 4910.2 4913.2 5106.2 5196.5 17797.4 18064.5 18259.0 18278.8 18296.8 17564.9 18098.5 18211.9 18366.4 18367.4 10226.5 10648.6 10711.0 10714.1 10782.9 6897.2 7119.4 7428.5 7438.6 7505.7 15692.8 15998.8 16094.4 16164.9 16585.6 16437.1 16669.1 16927.5 16931.2 17119.1 11018.6 11031.7 11056.6 11197.6 11218.7 12288.2 12352.6 12363.0 12380.1 12408.5 10074.8 10237.8 10247.6 10495.2 10551.8 9960.8 9972.1 10047.0 10068.5 10207.6 9097.5 9242.1 9253.4 9265.4 9274.4 6374.6 6521.9 6710.0 6822.9 7114.5 7012.8 7044.4 7163.6 7285.8 7330.2 09:48:48 INFO - PID 5848 | 09:48:48 INFO - PID 5848 | [#4] prototype.html Cycles:180 Average:5566.80 Median:6254.52 stddev:1609.58 (25.7%) stddev-sans-first:1567.82 09:48:48 INFO - PID 5848 | Values: 461.5 472.8 486.8 491.2 494.7 6237.4 6243.2 6250.4 6291.3 6317.7 5965.8 6112.6 6121.2 6127.9 6140.7 4781.5 4787.2 4789.4 4794.4 4813.1 4798.2 4799.3 4807.2 4811.6 4815.8 4777.5 4782.3 4796.9 4807.9 4810.7 4784.6 4801.3 4805.7 4807.5 4823.7 4324.0 4330.1 4332.7 4346.8 4362.5 5992.9 6063.6 6100.9 6107.6 6113.3 5716.8 5732.4 5737.6 5741.9 5765.3 6578.3 6621.9 6629.8 6656.6 6658.4 4892.7 4900.2 4914.5 4921.4 4923.4 6500.3 6838.8 6864.7 6867.0 6948.7 4999.5 5016.7 5022.5 5023.5 5038.7 4999.5 5024.9 5033.8 5044.3 5053.7 5486.8 5599.2 5624.5 5662.7 5721.2 6589.7 6599.8 6618.5 6626.6 6630.4 1712.5 1720.8 1721.9 1726.2 1728.3 1177.3 1210.8 1235.3 1236.8 1241.4 6109.2 6196.8 6238.3 6258.6 6272.6 6729.6 6737.9 6758.4 6771.5 6835.7 6267.8 6275.9 6279.9 6280.8 6282.6 3584.4 3586.5 3591.9 3606.9 3633.2 6959.6 7062.5 7082.5 7083.3 7099.1 6873.2 6966.1 6973.3 6984.9 6999.7 6942.7 6976.7 7014.9 7029.6 7045.6 6722.3 6723.6 6725.5 6737.8 6743.1 6342.9 6639.8 6662.6 6681.3 6731.1 6419.6 6942.2 6954.9 6958.8 7002.3 4930.0 4961.7 4963.9 4971.5 4980.2 6625.3 6738.4 6778.5 6789.4 6848.1 6534.2 6580.4 6593.5 6623.0 6647.3 6517.4 6629.9 6634.1 6642.6 6643.2 6522.2 6564.8 6568.2 6606.2 6612.3 6607.3 6609.3 6651.2 6652.6 6658.6 6389.7 6401.2 6439.0 6452.5 6453.1 09:48:48 INFO - PID 5848 | 09:48:48 INFO - PID 5848 | [#5] yui.html Cycles:180 Average:22312.64 Median:17695.69 stddev:30583.87 (172.8%) stddev-sans-first:30626.84 09:48:48 INFO - PID 5848 | Values: 758.5 773.4 794.1 800.4 848.2 14432.6 14817.4 14831.3 16185.4 16908.9 17048.1 17685.7 17693.6 17697.7 17794.5 958.5 984.6 986.7 989.9 993.4 971.0 1013.1 1014.1 1014.5 1015.0 1055.6 1055.7 1062.8 1063.5 1064.9 1040.5 1041.1 1044.6 1053.7 1054.0 769.4 771.6 772.8 773.6 774.6 15561.6 16198.0 16405.2 16409.1 16508.5 16955.0 17098.2 17429.9 17552.0 17590.3 15414.8 15735.0 15763.8 15789.3 15826.4 3367.0 3369.6 3392.2 3393.6 3434.2 102496.0 102838.0 105287.5 105486.0 105993.0 14411.9 14772.5 14968.8 15071.2 15305.5 27255.5 27583.2 27646.9 27780.9 27816.6 8337.4 8372.0 8383.7 8447.4 8490.2 3851.3 3869.4 3886.8 3889.9 3945.5 4770.5 4848.3 4866.9 4882.3 5038.3 976.3 995.0 1003.4 1012.5 1019.3 691.7 710.0 711.3 719.8 733.1 11243.5 12392.0 12554.9 12760.9 12771.5 696.4 706.4 713.1 717.1 724.2 4829.6 5117.5 5180.2 5245.2 5333.7 110938.0 113110.4 113213.0 113877.4 114284.0 101235.5 101577.0 103196.0 103637.5 104936.5 83057.6 83273.2 84524.0 85870.6 86717.6 11904.4 11915.0 12147.8 12359.2 12487.8 38050.0 38614.2 38671.2 39248.6 39706.4 48909.8 50894.0 61597.0 68783.3 68925.7 16676.6 16695.0 16787.2 16850.3 16961.8 19344.1 19920.3 19921.4 20107.4 20180.7 19009.8 19013.5 19033.9 19041.6 19431.7 17032.6 17238.9 17576.3 17706.9 17774.3 16634.8 16645.9 16681.2 18432.2 18447.3 11154.2 11590.9 11761.9 11833.9 11951.9 13784.5 13827.9 14015.9 14367.6 14423.4 09:48:48 INFO - PID 5848 | -------- Summary: end -------- 09:48:48 INFO - PID 5848 | 09:48:49 INFO - TEST-INFO | 5848: exit 0 09:48:49 INFO - TEST-OK | dromaeo_css | took 1141354ms 09:48:49 INFO - TEST-START | kraken 09:48:49 INFO - operating with platform_type : linux_ 09:48:49 INFO - Initialising browser for kraken test... 09:48:49 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35088/getInfo.html -profile /tmp/tmpoQqkBG/profile 09:48:49 INFO - TEST-INFO | started process 6265 (/builds/slave/test/build/application/firefox/firefox http://localhost:35088/getInfo.html) 09:49:24 INFO - TEST-INFO | 6265: killed by SIGTERM 09:49:24 INFO - Browser initialized. 09:49:24 INFO - Running cycle 1/1 for kraken test... 09:49:24 INFO - TEST-INFO | started process 6475 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoQqkBG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:49:35 INFO - PID 6475 | RSS: Main: 178016256 09:49:35 INFO - PID 6475 | 09:49:38 INFO - PID 6475 | Cycle 1(1): loaded http://localhost:35088/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35088/tests/kraken/driver.html?testName=audio-beat-detection) 09:49:39 INFO - PID 6475 | RSS: Main: 183304192 09:49:39 INFO - PID 6475 | 09:49:42 INFO - PID 6475 | Cycle 1(1): loaded http://localhost:35088/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35088/tests/kraken/driver.html?testName=audio-dft) 09:49:42 INFO - PID 6475 | RSS: Main: 181792768 09:49:42 INFO - PID 6475 | 09:49:45 INFO - PID 6475 | Cycle 1(1): loaded http://localhost:35088/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35088/tests/kraken/driver.html?testName=audio-fft) 09:49:46 INFO - PID 6475 | RSS: Main: 177008640 09:49:46 INFO - PID 6475 | 09:49:48 INFO - PID 6475 | Cycle 1(1): loaded http://localhost:35088/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35088/tests/kraken/driver.html?testName=audio-oscillator) 09:49:48 INFO - PID 6475 | RSS: Main: 178483200 09:49:48 INFO - PID 6475 | 09:49:51 INFO - PID 6475 | Cycle 1(1): loaded http://localhost:35088/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35088/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:49:51 INFO - PID 6475 | RSS: Main: 178561024 09:49:51 INFO - PID 6475 | 09:49:54 INFO - PID 6475 | Cycle 1(1): loaded http://localhost:35088/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35088/tests/kraken/driver.html?testName=imaging-darkroom) 09:49:55 INFO - PID 6475 | RSS: Main: 179482624 09:49:55 INFO - PID 6475 | 09:49:58 INFO - PID 6475 | Cycle 1(1): loaded http://localhost:35088/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35088/tests/kraken/driver.html?testName=imaging-desaturate) 09:49:59 INFO - PID 6475 | RSS: Main: 178757632 09:49:59 INFO - PID 6475 | 09:50:02 INFO - PID 6475 | Cycle 1(1): loaded http://localhost:35088/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35088/tests/kraken/driver.html?testName=json-parse-financial) 09:50:02 INFO - PID 6475 | RSS: Main: 179769344 09:50:02 INFO - PID 6475 | 09:50:04 INFO - PID 6475 | Cycle 1(1): loaded http://localhost:35088/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35088/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:50:05 INFO - PID 6475 | RSS: Main: 179707904 09:50:05 INFO - PID 6475 | 09:50:06 INFO - PID 6475 | Cycle 1(1): loaded http://localhost:35088/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35088/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:50:07 INFO - PID 6475 | RSS: Main: 179408896 09:50:07 INFO - PID 6475 | 09:50:09 INFO - PID 6475 | Cycle 1(1): loaded http://localhost:35088/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35088/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:50:10 INFO - PID 6475 | RSS: Main: 179728384 09:50:10 INFO - PID 6475 | 09:50:12 INFO - PID 6475 | Cycle 1(1): loaded http://localhost:35088/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35088/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:50:13 INFO - PID 6475 | RSS: Main: 179290112 09:50:13 INFO - PID 6475 | 09:50:16 INFO - PID 6475 | Cycle 1(1): loaded http://localhost:35088/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35088/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:50:17 INFO - PID 6475 | RSS: Main: 179556352 09:50:17 INFO - PID 6475 | 09:50:18 INFO - PID 6475 | Cycle 1(1): loaded http://localhost:35088/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35088/tests/kraken/driver.html?testName=ai-astar) 09:50:18 INFO - PID 6475 | RSS: Main: 180682752 09:50:18 INFO - PID 6475 | 09:50:18 INFO - PID 6475 | __start_tp_report 09:50:18 INFO - PID 6475 | _x_x_mozilla_page_load 09:50:18 INFO - PID 6475 | _x_x_mozilla_page_load_details 09:50:18 INFO - PID 6475 | |i|pagename|runs| 09:50:18 INFO - PID 6475 | |0;ai-astar;104;110;101;111;109;109;109;100;108;109 09:50:18 INFO - PID 6475 | |1;audio-beat-detection;149;119;149;191;121;153;147;118;175;124 09:50:18 INFO - PID 6475 | |2;audio-dft;164;165;164;165;170;167;170;170;173;169 09:50:18 INFO - PID 6475 | |3;audio-fft;74;75;74;170;74;74;73;73;157;74 09:50:18 INFO - PID 6475 | |4;audio-oscillator;84;82;136;83;84;83;129;82;83;131 09:50:18 INFO - PID 6475 | |5;imaging-gaussian-blur;115;116;116;114;114;117;119;116;116;114 09:50:18 INFO - PID 6475 | |6;imaging-darkroom;150;148;148;151;148;152;148;150;151;148 09:50:18 INFO - PID 6475 | |7;imaging-desaturate;95;96;95;96;96;96;95;96;100;100 09:50:18 INFO - PID 6475 | |8;json-parse-financial;48;51;50;49;50;47;47;50;46;46 09:50:18 INFO - PID 6475 | |9;json-stringify-tinderbox;56;55;55;55;55;56;55;56;55;56 09:50:18 INFO - PID 6475 | |10;stanford-crypto-aes;83;84;85;83;83;82;92;92;118;85 09:50:18 INFO - PID 6475 | |11;stanford-crypto-ccm;126;127;126;122;131;127;120;122;134;130 09:50:18 INFO - PID 6475 | |12;stanford-crypto-pbkdf2;166;177;180;175;178;174;176;175;179;179 09:50:18 INFO - PID 6475 | |13;stanford-crypto-sha256-iterative;66;64;65;64;66;67;63;65;63;65 09:50:18 INFO - PID 6475 | __end_tp_report 09:50:18 INFO - PID 6475 | __start_cc_report 09:50:18 INFO - PID 6475 | _x_x_mozilla_cycle_collect,940 09:50:18 INFO - PID 6475 | __end_cc_report 09:50:18 INFO - PID 6475 | __startTimestamp1497113418971__endTimestamp 09:50:18 INFO - PID 6475 | 09:50:18 INFO - PID 6475 | ------- Summary: start ------- 09:50:18 INFO - PID 6475 | Number of tests: 14 09:50:18 INFO - PID 6475 | 09:50:18 INFO - PID 6475 | [#0] ai-astar Cycles:10 Average:107.00 Median:109.00 stddev:3.89 (3.6%) stddev-sans-first:3.97 09:50:18 INFO - PID 6475 | Values: 104.0 110.0 101.0 111.0 109.0 109.0 109.0 100.0 108.0 109.0 09:50:18 INFO - PID 6475 | 09:50:18 INFO - PID 6475 | [#1] audio-beat-detection Cycles:10 Average:144.60 Median:149.00 stddev:24.80 (16.6%) stddev-sans-first:26.26 09:50:18 INFO - PID 6475 | Values: 149.0 119.0 149.0 191.0 121.0 153.0 147.0 118.0 175.0 124.0 09:50:18 INFO - PID 6475 | 09:50:18 INFO - PID 6475 | [#2] audio-dft Cycles:10 Average:167.70 Median:169.50 stddev:3.13 (1.8%) stddev-sans-first:3.02 09:50:18 INFO - PID 6475 | Values: 164.0 165.0 164.0 165.0 170.0 167.0 170.0 170.0 173.0 169.0 09:50:18 INFO - PID 6475 | 09:50:18 INFO - PID 6475 | [#3] audio-fft Cycles:10 Average:91.80 Median:74.00 stddev:37.92 (51.2%) stddev-sans-first:39.67 09:50:18 INFO - PID 6475 | Values: 74.0 75.0 74.0 170.0 74.0 74.0 73.0 73.0 157.0 74.0 09:50:18 INFO - PID 6475 | 09:50:18 INFO - PID 6475 | [#4] audio-oscillator Cycles:10 Average:97.70 Median:83.00 stddev:23.74 (28.6%) stddev-sans-first:24.66 09:50:18 INFO - PID 6475 | Values: 84.0 82.0 136.0 83.0 84.0 83.0 129.0 82.0 83.0 131.0 09:50:18 INFO - PID 6475 | 09:50:18 INFO - PID 6475 | [#5] imaging-gaussian-blur Cycles:10 Average:115.70 Median:116.00 stddev:1.57 (1.4%) stddev-sans-first:1.64 09:50:18 INFO - PID 6475 | Values: 115.0 116.0 116.0 114.0 114.0 117.0 119.0 116.0 116.0 114.0 09:50:18 INFO - PID 6475 | 09:50:18 INFO - PID 6475 | [#6] imaging-darkroom Cycles:10 Average:149.40 Median:150.00 stddev:1.58 (1.1%) stddev-sans-first:1.66 09:50:18 INFO - PID 6475 | Values: 150.0 148.0 148.0 151.0 148.0 152.0 148.0 150.0 151.0 148.0 09:50:18 INFO - PID 6475 | 09:50:18 INFO - PID 6475 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.00 stddev:1.90 (2.0%) stddev-sans-first:1.94 09:50:18 INFO - PID 6475 | Values: 95.0 96.0 95.0 96.0 96.0 96.0 95.0 96.0 100.0 100.0 09:50:18 INFO - PID 6475 | 09:50:18 INFO - PID 6475 | [#8] json-parse-financial Cycles:10 Average:48.40 Median:49.50 stddev:1.84 (3.7%) stddev-sans-first:1.94 09:50:18 INFO - PID 6475 | Values: 48.0 51.0 50.0 49.0 50.0 47.0 47.0 50.0 46.0 46.0 09:50:18 INFO - PID 6475 | 09:50:18 INFO - PID 6475 | [#9] json-stringify-tinderbox Cycles:10 Average:55.40 Median:55.50 stddev:0.52 (0.9%) stddev-sans-first:0.50 09:50:18 INFO - PID 6475 | Values: 56.0 55.0 55.0 55.0 55.0 56.0 55.0 56.0 55.0 56.0 09:50:18 INFO - PID 6475 | 09:50:18 INFO - PID 6475 | [#10] stanford-crypto-aes Cycles:10 Average:88.70 Median:84.50 stddev:10.91 (12.9%) stddev-sans-first:11.38 09:50:18 INFO - PID 6475 | Values: 83.0 84.0 85.0 83.0 83.0 82.0 92.0 92.0 118.0 85.0 09:50:18 INFO - PID 6475 | 09:50:18 INFO - PID 6475 | [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:127.00 stddev:4.38 (3.4%) stddev-sans-first:4.64 09:50:18 INFO - PID 6475 | Values: 126.0 127.0 126.0 122.0 131.0 127.0 120.0 122.0 134.0 130.0 09:50:18 INFO - PID 6475 | 09:50:18 INFO - PID 6475 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.90 Median:177.50 stddev:4.01 (2.3%) stddev-sans-first:2.12 09:50:18 INFO - PID 6475 | Values: 166.0 177.0 180.0 175.0 178.0 174.0 176.0 175.0 179.0 179.0 09:50:18 INFO - PID 6475 | 09:50:18 INFO - PID 6475 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.00 stddev:1.32 (2.0%) stddev-sans-first:1.32 09:50:18 INFO - PID 6475 | Values: 66.0 64.0 65.0 64.0 66.0 67.0 63.0 65.0 63.0 65.0 09:50:18 INFO - PID 6475 | -------- Summary: end -------- 09:50:18 INFO - PID 6475 | 09:50:20 INFO - TEST-INFO | 6475: exit 0 09:50:20 INFO - TEST-OK | kraken | took 90551ms 09:50:20 INFO - SUITE-END | took 1231s 09:50:20 INFO - Completed test suite (00:20:31) 09:50:20 INFO - javascript benchmark 09:50:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8207.709274515892, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3368.679975402337, 3380.5605271314726, 3388.2207092368753, 3390.0, 3406.0463070340306, 5886.529077673787, 5900.557458190631, 5963.568743501555, 5970.402959704027, 5997.910031349527, 5968.79109231177, 5991.370906054856, 6047.365026672191, 6060.545459090575, 6110.572259941795, 4987.251912213161, 5267.629566695003, 5328.067588172074, 5330.466953304677, 5379.058664733676, 5459.945400546003, 5471.562275018009, 5501.0, 5509.807156749514, 5528.06022976093, 5256.632035757499, 5313.203019547061, 5372.597055220835, 5391.110466772978, 5436.456354364572, 5377.596680248997, 5378.46215378463, 5382.6232163748555, 5396.703181325026, 5424.1321388578035, 5290.788368465257, 5331.840044798662, 5371.81198658049, 5375.758090885881, 5406.324209473816, 5821.592488525805, 5882.499987501067, 5925.229720136398, 6014.278286605635, 6026.819195424145, 6403.103565500834, 6500.544961852672, 6516.9674151629415, 6537.117489138953, 6540.0, 6582.275949645536, 6610.107635469246, 6611.933880661228, 6619.834504137387, 6641.435477984377, 5923.970380148072, 6092.177556029924, 6100.23747031621, 6130.386961303834, 6132.816015519497, 6580.276169621337, 6610.570312929644, 6708.19501659804, 6722.495812814059, 6750.358715922078, 6191.628502289877, 6213.751449942042, 6338.651374174372, 6441.903371449432, 6477.77327793525, 6510.869782604322, 6520.0871877937125, 6538.967305163444, 6558.475321974231, 6573.835654108686, 6153.1693221415435, 6436.066770318372, 6461.224653041571, 6462.838429039311, 6560.770373037016, 6328.6835658216905, 6345.650989195547, 6398.776042838478, 6467.353264673589, 6544.312847151075, 4914.65597408178, 4923.975380123076, 4969.875753106129, 4987.675801072919, 4990.550850423407, 4401.965538098544, 4416.028473735773, 4419.933700994423, 4426.468823741107, 4427.601515863587, 5929.940700592939, 6053.334133245339, 6086.239220097488, 6166.876662466726, 6174.104754810527, 6617.073609694647, 6618.371254730793, 6620.503462240351, 6624.602523848488, 6631.933680663132, 6165.815025549241, 6174.9073763893575, 6177.752889884444, 6178.783742569079, 6179.81460556184, 5376.91934620981, 5487.204355368449, 5487.396386397493, 5584.357798853184, 5598.888022239533, 6838.589684618939, 6860.0, 6882.242953275136, 6894.13823272091, 6897.0, 6546.738130474728, 6584.572002819801, 6612.867742645024, 6639.070530125883, 6639.767608133692, 6552.1154644124335, 6626.801195964129, 6893.896591551231, 6903.1371078615175, 6906.136732908387, 6323.430891219812, 6388.584741991755, 6409.775657851953, 6415.101885735908, 6416.262129855127, 6578.210614726264, 6579.80260592183, 6599.208095028627, 6605.867882642417, 6611.33886611335, 6088.665123418255, 6194.0, 6301.905471417841, 6353.364663533795, 6422.165118534561, 6424.4860411166055, 6441.71012304438, 6442.484601231797, 6443.065755465525, 6476.643784591893, 6403.839904002437, 6417.839554011187, 6426.518011149089, 6434.0, 6449.451796597342, 6175.536834737502, 6270.341614130633, 6440.645764482999, 6488.578242414228, 6525.967370163119, 6153.107799369156, 6174.753009879554, 6197.070439434121, 6216.72024758896, 6239.376062393724], "value": 5959.754128476778, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [755.4598462099598, 805.621357961758, 831.1314676163407, 1109.2401704832191, 1121.3664279681973, 38754.418683719734, 39657.40513892294, 39662.60337396625, 39680.40479392808, 39702.80148599257, 41331.38002929959, 41606.16787664245, 41610.0, 41699.583004170025, 41705.58294417055, 7119.394851437621, 7226.024486694281, 7243.384312333458, 7251.057362542862, 7497.550146991171, 7410.777676669709, 7441.330280274774, 7475.439342049341, 7499.175090740015, 7526.8870966935265, 7452.515586486888, 7489.400847932152, 7550.3959683225485, 7556.811079723024, 7563.810904727398, 7498.250174982512, 7499.962500187464, 7502.624868756595, 7518.849623007536, 7522.736704215326, 7036.40190583801, 7066.611336376497, 7070.0, 7083.18543367509, 7101.8224544386285, 37470.0, 37800.62199378026, 37902.62097379019, 38128.237435251416, 38209.80895095535, 3346.6486018967903, 3358.580177477815, 3367.1413789483768, 3369.3598216339064, 3390.3897298486263, 29614.0, 29769.25576860574, 29931.0, 29950.85024574885, 30031.69968300311, 3737.3459644562095, 3754.3805272130066, 3755.9436608450897, 3759.5488541374934, 3764.1154328732728, 161017.0, 165254.0, 165328.0, 197399.99999999857, 198753.0, 42664.36003459951, 43020.56979430228, 43035.569644303156, 43051.56948430538, 43082.0, 44632.77683611561, 44767.55232447634, 44767.55232447699, 44841.551584483735, 44850.0, 15365.231738413035, 15365.308561114776, 15487.922560387125, 15497.845021549865, 15539.378424862878, 12419.503219871285, 12610.054245931591, 12619.30593817349, 12637.052221083455, 12637.810432843515, 14759.0, 14793.186374749492, 14806.259687015607, 14900.329485173193, 15146.848531514765, 5758.712064396764, 5840.561957853178, 5906.3207731110615, 5978.970105149447, 5999.670018148957, 1019.3323373190572, 1034.2294990232326, 1037.9481025948671, 1052.516062093459, 1115.576081089181, 25071.498570028863, 25421.237362879143, 25685.871570642026, 25877.74122258791, 25955.0, 1113.777244551093, 1155.156735583029, 1173.4015652017533, 1183.893449589524, 1190.214458457414, 13121.803172952414, 13565.616296215248, 13628.863711362957, 13792.379342929593, 13853.16880987144, 274511.0, 275239.0, 277027.0, 278379.0, 278422.0, 54971.175432368545, 55524.16713749297, 55601.721991390594, 55723.72138139283, 55814.0, 1481.5555333399936, 1503.7293287208188, 1510.7205167044133, 1517.2944580769774, 1518.552027151993, 24024.759752402253, 24432.755672443047, 24504.0, 24817.1314004009, 25033.87483062646, 39709.0, 39869.40195897006, 39992.60007399889, 40072.39891401573, 40151.59848401479, 211712.0, 212362.0, 212842.0, 212845.0, 213580.0, 35329.82335088308, 36486.27027459383, 36981.260374792895, 37114.628853712195, 37225.25549488941, 42915.356269655356, 45327.0, 45721.08557828891, 45813.77093114513, 45846.54153458556, 32220.677793221766, 32298.19254518562, 32339.35321293608, 32847.0, 33874.3225135491, 32146.839265803523, 32149.678503215604, 32199.195020124684, 33209.33581328408, 33387.66612333846, 38398.232035359695, 38762.22475550417, 39284.0, 39519.407208892466, 39564.40653390259, 30300.0, 31737.36525269528, 31876.203094922814, 31968.36063278768, 32583.348333032733, 25718.0, 25871.0, 26846.865765671046, 26896.193114205824, 26945.865270673523], "value": 17240.371926311855, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [512.1881817319548, 517.3444261158525, 518.9091908915939, 519.6492367651834, 531.5588061908617, 20576.794232057677, 21347.57304853902, 21427.67858482122, 22689.659655105144, 23472.29583112505, 21111.6833247501, 21274.36176914691, 21382.0, 21391.251306204285, 21439.0, 5822.359540450547, 5942.346341902387, 5948.553858460611, 5959.761609535613, 5972.283326000886, 5734.541236701054, 5748.712564371785, 5749.3388260350175, 5763.855903602423, 5767.538596912237, 5570.721463926808, 5734.827955161331, 5746.281714785652, 5772.797952071678, 5810.448007439287, 5839.591228613998, 5878.206442130343, 5881.823545293627, 5890.499307558863, 5901.380355062743, 5390.757415916293, 5455.1544510600925, 5464.9180262296095, 5466.562674986031, 5480.561555075625, 27283.45433091327, 27512.0, 27548.17355479339, 27782.444351112863, 27816.443671126464, 2073.056759174572, 2108.0303060592146, 2125.330520885916, 2128.5742851429623, 2129.169623846701, 17842.375516856977, 18420.907895460572, 18522.0, 18595.907020464947, 18647.160877760532, 2207.194374053459, 2216.656418255173, 2254.9098036078535, 2282.5206706591634, 2298.2300929188573, 127839.36080319632, 133822.3308883459, 140111.0, 140780.0, 141518.0, 14437.411884692676, 14555.92722036383, 14656.780148297785, 14795.408183672747, 14874.181919994504, 21464.570708586052, 21540.676889846665, 21594.352169434944, 21714.240001600185, 21838.563228735653, 8953.686620968236, 9092.772680683036, 9239.445633262027, 9346.065393460736, 9547.188488978376, 8533.445326053787, 8536.189062039097, 8554.743357699279, 8657.567121643893, 8659.653613855502, 8942.37403381757, 9086.500242486594, 9142.862857057149, 9197.448153110701, 9226.370484411911, 2519.722830488645, 2543.2070390374743, 2546.5288921549572, 2594.455164415494, 2643.9074632387774, 1001.8246806808779, 1007.2143727892255, 1025.348903446302, 1027.1679939249232, 1027.3476342522551, 19732.210711571377, 19835.404937851887, 20310.492237694176, 20384.592308153755, 20919.163233470794, 1008.2740426892625, 1013.2451323763843, 1022.7698767777339, 1034.813733527957, 1044.1698849414734, 10810.729731756612, 10866.130709543218, 11125.944370278097, 11280.71798205035, 11451.599194028335, 530202.0, 546818.0, 555728.0, 576399.0, 577672.0, 110340.0, 110872.0, 111159.0, 111883.0, 111913.0, 1150.246588484544, 1175.435790820411, 1260.1053252190864, 1281.4553814628746, 1285.254552359629, 20138.39584812458, 21316.147354105662, 21440.46398839979, 21632.783672163077, 21756.34730958074, 54151.458485414645, 55258.0, 55329.0, 56746.71626641841, 57798.7110064447, 66968.6651566739, 67523.0, 67790.0, 68105.65947170233, 68197.0, 12281.69295767613, 12294.323812190058, 12368.505259789868, 12453.630100688735, 12543.87456125427, 18204.635907282045, 18209.54323654078, 18236.544086397946, 18441.170147343135, 18858.0, 14844.183569903758, 14909.179995100374, 15000.474983375529, 15088.54734357971, 15094.245287735788, 13676.452941882611, 13861.0, 13952.79070813959, 14164.079334843202, 14491.78262326045, 15385.84614153844, 15646.0, 15800.76298855541, 15829.683406332038, 15853.286602103164, 12222.294416649831, 12308.446119924445, 12353.752924941631, 12378.81431778542, 12487.687807804878, 15102.622434439227, 15159.848401515843, 15208.695826083194, 15566.0, 15735.213239337758], "value": 11209.887174029685, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1304.941277642506, 1386.549371454277, 1397.4759465200552, 1406.2546850169413, 1413.7101894111709, 12942.352882355892, 13033.283169425678, 13488.46046158155, 13550.525731599408, 13598.320083995797, 13027.0, 13188.93405532971, 13246.07277490576, 13289.136206146593, 13326.400311985959, 2440.9145679901208, 2478.25652304308, 2492.5638013347684, 2493.0651005872796, 2498.250524842549, 2380.047980807682, 2442.767937045987, 2446.972271645904, 2449.5590793657134, 2454.5581795276844, 2345.2729653807287, 2388.9880550597222, 2398.9280321590295, 2400.627902675088, 2416.516696660675, 2263.649134384173, 2373.8338316317863, 2376.9286921392386, 2381.1070848431837, 2383.4518060846017, 2205.6691496275525, 2214.7342318921833, 2304.953900921972, 2490.8131890108316, 2494.239257026606, 13100.707376209126, 13196.53812116581, 13244.933775331061, 13256.801147982787, 13282.734345313136, 7211.603361815098, 7430.108386993541, 7434.628268586604, 7466.328030477229, 7480.214577469342, 4204.0, 4223.577642235752, 4336.3712261722185, 4373.956260437387, 4375.912481750379, 1545.0575149159004, 1547.582152818744, 1551.8215405228318, 1594.6252630631793, 1603.2144249317867, 20996.580068398547, 21175.152993880227, 21221.469463263387, 21255.5748885023, 21285.14859405622, 6175.135481032659, 6255.718492667841, 6360.522960777867, 6367.56729735815, 6418.133551970518, 15013.174275414738, 15052.924735376253, 15088.773668394982, 15115.31981060855, 15184.848151518565, 7237.131544214728, 7480.8877866832045, 7489.101307843093, 7489.662965166581, 7496.212897645778, 6790.253072162058, 6848.417884479775, 6865.794026179223, 6874.690638921261, 6900.171979362408, 4759.738214398172, 4948.208286674115, 4966.428860680996, 5004.4995500450395, 5027.145385284511, 1391.6938273579797, 1424.9643758905902, 1454.8690617844445, 1464.8022516960286, 1477.4828809916658, 811.9066307374727, 837.5142417397894, 850.4599579267086, 857.1342943626858, 857.7684025313131, 6946.6179360134665, 7199.71201151948, 7416.184219735825, 7526.32263096324, 7730.690772369042, 1001.2640709078821, 1010.0656892374524, 1012.0790081026231, 1013.0679774607379, 1022.6114076650974, 4723.763811809465, 4910.238912968495, 4913.238448040559, 5106.183010718267, 5196.53231209193, 17797.377091801984, 18064.458066258034, 18259.0, 18278.817211827976, 18296.817031829512, 17564.91217543904, 18098.547536311435, 18211.908940455214, 18366.357177498725, 18367.35714249995, 10226.488675566192, 10648.574057037631, 10711.0, 10714.089302409227, 10782.946085269523, 6897.241303456515, 7119.359257666835, 7428.517146385468, 7438.5536867788105, 7505.66224519887, 15692.764608530653, 15998.760018599964, 16094.436694715629, 16164.919175404048, 16585.585360366087, 16437.09595972233, 16669.083200424095, 16927.49217523476, 16931.15344232808, 17119.14404279806, 11018.614348497764, 11031.724206894893, 11056.613018544313, 11197.60808371703, 11218.66344009681, 12288.201266917622, 12352.62942111738, 12363.0, 12380.071494638118, 12408.503659853866, 10074.798504029732, 10237.795244094927, 10247.590096396061, 10495.160387168855, 10551.788964220827, 9960.800783984425, 9972.102510773775, 10047.0, 10068.496575171066, 10207.642732504326, 9097.545122743968, 9242.12199841014, 9253.398529095588, 9265.351425400157, 9274.44353338802, 6374.6175229484525, 6521.902171467337, 6710.0, 6822.8635427292165, 7114.50198486101, 7012.789616311519, 7044.36600705939, 7163.570185788869, 7285.7814265572115, 7330.230325815925], "value": 6035.900736010155, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [461.47391973150593, 472.8392346602155, 486.79554587073426, 491.23858020068906, 494.6982340772128, 6237.376262373766, 6243.219597550306, 6250.40621140992, 6291.276503202133, 6317.747290108396, 5965.791197308095, 6112.602680825743, 6121.234845644294, 6127.908081378783, 6140.662263575501, 4781.545753153445, 4787.1861783496715, 4789.449213340476, 4794.400699912511, 4813.085513752393, 4798.184308667535, 4799.2801079837955, 4807.206810876201, 4811.566958973692, 4815.807367705305, 4777.5222477752295, 4782.306565547993, 4796.88007799806, 4807.855764327076, 4810.663253572251, 4784.617230621542, 4801.2798080287885, 4805.702460335725, 4807.519248075182, 4823.734694591796, 4323.956760432418, 4330.0906809569715, 4332.682015121894, 4346.8043938022865, 4362.498312694049, 5992.880142397127, 6063.575549711522, 6100.938990610126, 6107.625784198564, 6113.296970848365, 5716.828495145152, 5732.369439361667, 5737.598368114233, 5741.856453588652, 5765.308163020422, 6578.27638959714, 6621.9006714899315, 6629.767958121491, 6656.56732312403, 6658.434033107192, 4892.730899800509, 4900.191468407708, 4914.4839791821705, 4921.409430868319, 4923.433805112422, 6500.284968653445, 6838.794836154873, 6864.691088901011, 6867.0, 6948.652567371611, 4999.525045120708, 5016.673916195508, 5022.547970682656, 5023.522765337287, 5038.697678139323, 4999.52504512078, 5024.874378140503, 5033.848984530397, 5044.268581055726, 5053.69677819332, 5486.835394938158, 5599.216109744639, 5624.521915637135, 5662.68855212959, 5721.199032135504, 6589.703463344161, 6599.769008084694, 6618.503612229102, 6626.56927299724, 6630.403263706289, 1712.5290545100197, 1720.819313972015, 1721.8536424403815, 1726.214572369569, 1728.3086765293983, 1177.3406892140429, 1210.8062709966364, 1235.3144005077268, 1236.8206610041493, 1241.4351470081092, 6109.175261339662, 6196.755222672394, 6238.344973777779, 6258.624482531062, 6272.560920735596, 6729.596224226562, 6737.898931516032, 6758.445557521699, 6771.5259931805285, 6835.726570937107, 6267.780627678009, 6275.905861412082, 6279.937200627935, 6280.811575652738, 6282.591631543935, 3584.3727347714566, 3586.5337506124038, 3591.8742844000335, 3606.9278614427562, 3633.182533929845, 6959.582425054513, 7062.540934839321, 7082.521117608796, 7083.256258092826, 7099.07711997437, 6873.243943166248, 6966.12923384577, 6973.302669733088, 6984.860302793915, 6999.650017499104, 6942.687579058955, 6976.651167441608, 7014.859702805916, 7029.61337126463, 7045.612491312924, 6722.327767223239, 6723.596584204964, 6725.49558783103, 6737.831554210988, 6743.089682892747, 6342.8731425370315, 6639.800805975829, 6662.635369138554, 6681.2984636612455, 6731.124953756176, 6419.614823110628, 6942.2363540011565, 6954.930450695429, 6958.826029349307, 7002.334778196063, 4929.97535012337, 4961.7271050092595, 4963.9007219854675, 4971.477994810492, 4980.153373926513, 6625.271220165874, 6738.427233685192, 6778.491613129134, 6789.422899053636, 6848.14398200225, 6534.215894092739, 6580.367852858894, 6593.472522198309, 6622.966885165543, 6647.302033286435, 6517.4134327910715, 6629.933700662931, 6634.090772828169, 6642.575459956985, 6643.169603799525, 6522.249941256627, 6564.770233041821, 6568.1789776277965, 6606.207255129415, 6612.272650008399, 6607.339266073546, 6609.290191021658, 6651.16860392451, 6652.634105124264, 6658.600483970784, 6389.702982161038, 6401.199850018747, 6439.0, 6452.451541619015, 6453.128827608401], "value": 5083.536332876762, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [758.525921299188, 773.4237992695442, 794.1343935110729, 800.4116974024091, 848.2196379331011, 14432.5670229893, 14817.407303707852, 14831.258437078144, 16185.43350982713, 16908.915455422735, 17048.14759262035, 17685.73471397927, 17693.64612707745, 17697.734533982002, 17794.46616601501, 958.4776296918179, 984.5864736810556, 986.6546708651986, 989.945552994585, 993.359283262299, 970.9514524273793, 1013.0679774607379, 1014.0569270578359, 1014.4876837197241, 1015.0306457333265, 1055.59887242848, 1055.688571871296, 1062.8246339353998, 1063.521415363086, 1064.8562444070067, 1040.5005597313257, 1041.1150522056266, 1044.5560636729397, 1053.678628018454, 1053.9789204215872, 769.3960241210679, 771.5987686403039, 772.8261141243231, 773.6054612147789, 774.6436639146, 15561.610959726097, 16198.0, 16405.17974101302, 16409.097499637515, 16508.504744857673, 16955.04321903126, 17098.230579623945, 17429.912850435667, 17552.0, 17590.29638814446, 15414.845851541453, 15735.0, 15763.763543546856, 15789.28948197334, 15826.446074387457, 3367.0, 3369.595648522193, 3392.1689186149306, 3393.558837351153, 3434.210131669705, 102496.0, 102838.0, 105287.47356263247, 105486.0, 105993.0, 14411.855881441052, 14772.48296309624, 14968.775468367983, 15071.171085590178, 15305.46430874914, 27255.45489090207, 27583.172504824888, 27646.861765691043, 27780.861095694796, 27816.582751258746, 8337.374696897636, 8372.03721572015, 8383.748487545383, 8447.36644751646, 8490.193431623986, 3851.326017946848, 3869.400242962345, 3886.8250928708276, 3889.922201555953, 3945.467361906106, 4770.475247722748, 4848.296996935424, 4866.8783280417565, 4882.340883980688, 5038.269450929594, 976.2921881635899, 994.9751256218652, 1003.4280460137652, 1012.5494155101056, 1019.3425240719843, 691.7060249393987, 709.9503034787618, 711.3029231353199, 719.8308397526577, 733.1202556931597, 11243.494042768096, 12392.0, 12554.937225313815, 12760.872391275969, 12771.489140434278, 696.4219697650938, 706.3501578547748, 713.0623230451939, 717.0857157124708, 724.221461928429, 4829.613630909519, 5117.5394214520875, 5180.222966555047, 5245.239440281214, 5333.679979201261, 110938.0, 113110.43444782724, 113213.0, 113877.43061284641, 114284.0, 101235.49382253189, 101577.0, 103196.0, 103637.48181259196, 104936.47531762446, 83057.58471207727, 83273.16726832776, 84524.0, 85870.57064714762, 86717.5664121688, 11904.404779761151, 11915.0, 12147.817782733442, 12359.196652217577, 12487.750244995232, 38050.0, 38614.2277154461, 38671.22657546889, 39248.607513925635, 39706.40440393339, 48909.75545122252, 50894.0, 61597.0, 68783.3121668797, 68925.65537172282, 16676.58308542296, 16695.0, 16787.16064196761, 16850.325986960874, 16961.830381696025, 19344.12951417218, 19920.3027894023, 19921.402357929284, 20107.39677809668, 20180.697289540964, 19009.809901900804, 19013.524661883563, 19033.90483047576, 19041.619167616846, 19431.708524371865, 17032.574185644964, 17238.913805431395, 17576.296948122443, 17706.9375837445, 17774.289028438718, 16634.833651663812, 16645.91677041607, 16681.165941702624, 18432.17055232491, 18447.26210951547, 11154.163437742363, 11590.88409115898, 11761.941190293994, 11833.940830296138, 11951.880481195425, 13784.517541885985, 13827.86172138306, 14015.859841401456, 14367.568972930829, 14423.42306307736], "value": 8650.09034518466, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 110.0, 101.0, 111.0, 109.0, 109.0, 109.0, 100.0, 108.0, 109.0], "value": 107.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 119.0, 149.0, 191.0, 121.0, 153.0, 147.0, 118.0, 175.0, 124.0], "value": 144.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 164.0, 165.0, 170.0, 167.0, 170.0, 170.0, 173.0, 169.0], "value": 167.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 170.0, 74.0, 74.0, 73.0, 73.0, 157.0, 74.0], "value": 91.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 136.0, 83.0, 84.0, 83.0, 129.0, 82.0, 83.0, 131.0], "value": 97.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 116.0, 114.0, 114.0, 117.0, 119.0, 116.0, 116.0, 114.0], "value": 115.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 148.0, 151.0, 148.0, 152.0, 148.0, 150.0, 151.0, 148.0], "value": 149.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 100.0, 100.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 51.0, 50.0, 49.0, 50.0, 47.0, 47.0, 50.0, 46.0, 46.0], "value": 48.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 55.0, 55.0, 56.0, 55.0, 56.0, 55.0, 56.0], "value": 55.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 85.0, 83.0, 83.0, 82.0, 92.0, 92.0, 118.0, 85.0], "value": 88.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 127.0, 126.0, 122.0, 131.0, 127.0, 120.0, 122.0, 134.0, 130.0], "value": 126.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 177.0, 180.0, 175.0, 178.0, 174.0, 176.0, 175.0, 179.0, 179.0], "value": 175.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 65.0, 64.0, 66.0, 67.0, 63.0, 65.0, 63.0, 65.0], "value": 64.8, "unit": "score"}]}]} 09:50:20 INFO - Return code: 0 09:50:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:50:20 INFO - # TBPL SUCCESS # 09:50:20 INFO - Running post-action listener: _resource_record_post_action 09:50:20 INFO - [mozharness: 2017-06-10 16:50:20.339374Z] Finished run-tests step (success) 09:50:20 INFO - Running post-run listener: _resource_record_post_run 09:50:20 INFO - Total resource usage - Wall time: 1250s; CPU: 13.0%; Read bytes: 647168; Write bytes: 432455680; Read time: 116; Write time: 391976 09:50:20 INFO - TinderboxPrint: CPU usage
12.6% 09:50:20 INFO - TinderboxPrint: I/O read bytes / time
647,168 / 116 09:50:20 INFO - TinderboxPrint: I/O write bytes / time
432,455,680 / 391,976 09:50:20 INFO - TinderboxPrint: CPU idle
8,718.6 (87.4%) 09:50:20 INFO - TinderboxPrint: CPU user
1,201.4 (12.0%) 09:50:20 INFO - TinderboxPrint: Swap in / out
0 / 0 09:50:20 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 114872320; Read time: 0; Write time: 149564 09:50:20 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:50:20 INFO - run-tests - Wall time: 1232s; CPU: 13.0%; Read bytes: 647168; Write bytes: 317583360; Read time: 116; Write time: 242412 09:50:21 INFO - Running post-run listener: _upload_blobber_files 09:50:21 INFO - Blob upload gear active. 09:50:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:50:21 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:50:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:50:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:50:21 INFO - (blobuploader) - INFO - Open directory for files ... 09:50:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:50:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:50:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:50:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:50:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:50:22 INFO - (blobuploader) - INFO - Done attempting. 09:50:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:50:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:50:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:50:23 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:50:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:50:23 INFO - (blobuploader) - INFO - Done attempting. 09:50:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:50:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:50:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:50:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:50:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:50:29 INFO - (blobuploader) - INFO - Done attempting. 09:50:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:50:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:50:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:50:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:50:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:50:30 INFO - (blobuploader) - INFO - Done attempting. 09:50:30 INFO - (blobuploader) - INFO - Iteration through files over. 09:50:30 INFO - Return code: 0 09:50:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:50:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:50:30 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c42e0c229332fe8b78d37746498bfce782e2d8b0eddc39ee4e035810c6e826bca0da8b12fc22342b09086ca318146b72fd1f0327a0558372cfc4696b2781783", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab2ff6954499901b7d2f41ab1b5b87c2da0fa3243209663e175afe03b331fd29ca3f25c9bea474e9dd607653e53f82c97673bea8f5eb450cc758971bfd4792e8", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43aa4dd02bfd0024d1c93bd254f0c79c5cdfe9d06817f2b24659237c7eb1d67cd0c965af456771cd9dbf6e1ecd79609ee2257c0895f02fcf396b0ff0f782176d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf31e1b53d3b5dc9be1af2802338dad8778af562c53e5ee8fb0c2e611a1264eb827e0c560858d52ea1cd4edd5fbff063c772f476fe471994537b58a509309221"} 09:50:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:50:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:50:30 INFO - Contents: 09:50:30 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c42e0c229332fe8b78d37746498bfce782e2d8b0eddc39ee4e035810c6e826bca0da8b12fc22342b09086ca318146b72fd1f0327a0558372cfc4696b2781783", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab2ff6954499901b7d2f41ab1b5b87c2da0fa3243209663e175afe03b331fd29ca3f25c9bea474e9dd607653e53f82c97673bea8f5eb450cc758971bfd4792e8", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43aa4dd02bfd0024d1c93bd254f0c79c5cdfe9d06817f2b24659237c7eb1d67cd0c965af456771cd9dbf6e1ecd79609ee2257c0895f02fcf396b0ff0f782176d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf31e1b53d3b5dc9be1af2802338dad8778af562c53e5ee8fb0c2e611a1264eb827e0c560858d52ea1cd4edd5fbff063c772f476fe471994537b58a509309221"} 09:50:30 INFO - Running post-run listener: copy_logs_to_upload_dir 09:50:30 INFO - Copying logs to upload dir... 09:50:30 INFO - mkdir: /builds/slave/test/build/upload/logs 09:50:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1311.847361 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 51 secs) (at 2017-06-10 09:50:30.215630) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-10 09:50:30.218863) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1497102457.494117-1620765085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c42e0c229332fe8b78d37746498bfce782e2d8b0eddc39ee4e035810c6e826bca0da8b12fc22342b09086ca318146b72fd1f0327a0558372cfc4696b2781783", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab2ff6954499901b7d2f41ab1b5b87c2da0fa3243209663e175afe03b331fd29ca3f25c9bea474e9dd607653e53f82c97673bea8f5eb450cc758971bfd4792e8", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43aa4dd02bfd0024d1c93bd254f0c79c5cdfe9d06817f2b24659237c7eb1d67cd0c965af456771cd9dbf6e1ecd79609ee2257c0895f02fcf396b0ff0f782176d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf31e1b53d3b5dc9be1af2802338dad8778af562c53e5ee8fb0c2e611a1264eb827e0c560858d52ea1cd4edd5fbff063c772f476fe471994537b58a509309221"} build_url:https://queue.taskcluster.net/v1/task/CsZ6WwGvRvGOw2wq_DXcUA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011331 build_url: 'https://queue.taskcluster.net/v1/task/CsZ6WwGvRvGOw2wq_DXcUA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c42e0c229332fe8b78d37746498bfce782e2d8b0eddc39ee4e035810c6e826bca0da8b12fc22342b09086ca318146b72fd1f0327a0558372cfc4696b2781783", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab2ff6954499901b7d2f41ab1b5b87c2da0fa3243209663e175afe03b331fd29ca3f25c9bea474e9dd607653e53f82c97673bea8f5eb450cc758971bfd4792e8", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43aa4dd02bfd0024d1c93bd254f0c79c5cdfe9d06817f2b24659237c7eb1d67cd0c965af456771cd9dbf6e1ecd79609ee2257c0895f02fcf396b0ff0f782176d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf31e1b53d3b5dc9be1af2802338dad8778af562c53e5ee8fb0c2e611a1264eb827e0c560858d52ea1cd4edd5fbff063c772f476fe471994537b58a509309221"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-10 09:50:30.245894) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-10 09:50:30.246622) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1497102457.494117-1620765085 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004372 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-10 09:50:30.327642) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-10 09:50:30.328002) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-10 09:50:30.328356) ========= ========= Total master_lag: 0.16 =========