builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-082 starttime: 1498409323.79 results: success (0) revision: d50abca6521baeae8ac6b07ddf843d63a1aa5f84 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-25 09:48:43.792808) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-25 09:48:43.793263) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-25 09:48:43.793561) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-25 09:48:43.808994) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-25 09:48:43.809290) ========= 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=51fc86400edbde9650d2781a000001d0-1498389334.749262-625243051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-25 09:48:44-- 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% 40.8M=0s 2017-06-25 09:48:44 (40.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.154290 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-25 09:48:43.989738) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-25 09:48:43.990016) ========= 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=51fc86400edbde9650d2781a000001d0-1498389334.749262-625243051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013974 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-25 09:48:44.040444) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-25 09:48:44.040801) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d50abca6521baeae8ac6b07ddf843d63a1aa5f84 --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 d50abca6521baeae8ac6b07ddf843d63a1aa5f84 --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=51fc86400edbde9650d2781a000001d0-1498389334.749262-625243051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-25 09:48:44,861 truncating revision to first 12 chars 2017-06-25 09:48:44,861 Setting DEBUG logging. 2017-06-25 09:48:44,861 attempt 1/10 2017-06-25 09:48:44,861 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d50abca6521b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-25 09:48:45,292 unpacking tar archive at: mozilla-central-d50abca6521b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.738961 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-25 09:48:44.796135) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-25 09:48:44.796442) ========= script_repo_revision: d50abca6521baeae8ac6b07ddf843d63a1aa5f84 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-25 09:48:44.799836) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-25 09:48:44.800102) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-25 09:48:44.808277) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-06-25 09:48:44.808571) ========= /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=51fc86400edbde9650d2781a000001d0-1498389334.749262-625243051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:48:45 INFO - MultiFileLogger online at 20170625 09:48:45 in /builds/slave/test 09:48:45 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:48:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:48:45 INFO - {'append_to_log': False, 09:48:45 INFO - 'base_work_dir': '/builds/slave/test', 09:48:45 INFO - 'blob_upload_branch': 'Firefox', 09:48:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:48:45 INFO - 'branch': 'Firefox', 09:48:45 INFO - 'buildbot_json_path': 'buildprops.json', 09:48:45 INFO - 'config_files': ('talos/linux_config.py',), 09:48:45 INFO - 'default_actions': ('clobber', 09:48:45 INFO - 'read-buildbot-config', 09:48:45 INFO - 'download-and-extract', 09:48:45 INFO - 'populate-webroot', 09:48:45 INFO - 'create-virtualenv', 09:48:45 INFO - 'install', 09:48:45 INFO - 'setup-mitmproxy', 09:48:45 INFO - 'run-tests'), 09:48:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:48:45 INFO - 'download_minidump_stackwalk': True, 09:48:45 INFO - 'download_symbols': 'ondemand', 09:48:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:48:45 INFO - 'tooltool.py': '/tools/tooltool.py', 09:48:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:48:45 INFO - '/tools/misc-python/virtualenv.py')}, 09:48:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:48:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:48:45 INFO - 'gecko_profile': False, 09:48:45 INFO - 'gecko_profile_interval': 0, 09:48:45 INFO - 'installer_path': 'installer.exe', 09:48:45 INFO - 'log_level': 'info', 09:48:45 INFO - 'log_name': 'talos', 09:48:45 INFO - 'log_to_console': True, 09:48:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:48:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:48:45 INFO - 'opt_config_files': (), 09:48:45 INFO - 'pip_index': False, 09:48:45 INFO - 'suite': 'dromaeojs-e10s', 09:48:45 INFO - 'system_bits': '32', 09:48:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:48:45 INFO - 'title': 'talos-linux64-ix-082', 09:48:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:48:45 INFO - 'use_talos_json': True, 09:48:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:48:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:48:45 INFO - 'work_dir': 'build'} 09:48:45 INFO - [mozharness: 2017-06-25 16:48:45.730438Z] Running clobber step. 09:48:45 INFO - Running pre-action listener: _resource_record_pre_action 09:48:45 INFO - Running main action method: clobber 09:48:45 INFO - rmtree: /builds/slave/test/build 09:48:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:48:47 INFO - Running post-action listener: _resource_record_post_action 09:48:47 INFO - [mozharness: 2017-06-25 16:48:47.277252Z] Finished clobber step (success) 09:48:47 INFO - [mozharness: 2017-06-25 16:48:47.277351Z] Running read-buildbot-config step. 09:48:47 INFO - Running pre-action listener: _resource_record_pre_action 09:48:47 INFO - Running main action method: read_buildbot_config 09:48:47 INFO - Using buildbot properties: 09:48:47 INFO - { 09:48:47 INFO - "project": "", 09:48:47 INFO - "product": "firefox", 09:48:47 INFO - "who": "ffxbld@noreply.mozilla.org", 09:48:47 INFO - "installer_path": "public/build/target.tar.bz2", 09:48:47 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 09:48:47 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 09:48:47 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 09:48:47 INFO - "stage_platform": "linux64-pgo", 09:48:47 INFO - "basedir": "/builds/slave/test", 09:48:47 INFO - "buildnumber": 32, 09:48:47 INFO - "platform": "ubuntu64_hw", 09:48:47 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:48:47 INFO - "slavebuilddir": "test", 09:48:47 INFO - "taskId": "NeIxCfBfRfOWvd7PfbkxXA", 09:48:47 INFO - "branch": "mozilla-central", 09:48:47 INFO - "script_repo_revision": "production", 09:48:47 INFO - "revision": "d50abca6521baeae8ac6b07ddf843d63a1aa5f84", 09:48:47 INFO - "slavename": "talos-linux64-ix-082", 09:48:47 INFO - "repo_path": "mozilla-central" 09:48:47 INFO - } 09:48:47 INFO - Finding installer, test and symbols from parent task. 09:48:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NeIxCfBfRfOWvd7PfbkxXA'}, attempt #1 09:48:47 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NeIxCfBfRfOWvd7PfbkxXA'}, attempt #1 09:48:48 INFO - Task dependencies: El7EscZXQ1uK6wyAw0q7oQ 09:48:48 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/El7EscZXQ1uK6wyAw0q7oQ'}, attempt #1 09:48:48 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/El7EscZXQ1uK6wyAw0q7oQ/artifacts/public/build/target.tar.bz2 09:48:48 INFO - Set test_url: https://queue.taskcluster.net/v1/task/El7EscZXQ1uK6wyAw0q7oQ/artifacts/public/build/test_packages.json 09:48:48 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/El7EscZXQ1uK6wyAw0q7oQ/artifacts/public/build/target.crashreporter-symbols.zip 09:48:48 INFO - Running post-action listener: _resource_record_post_action 09:48:48 INFO - [mozharness: 2017-06-25 16:48:48.663040Z] Finished read-buildbot-config step (success) 09:48:48 INFO - [mozharness: 2017-06-25 16:48:48.663256Z] Running download-and-extract step. 09:48:48 INFO - Running pre-action listener: _resource_record_pre_action 09:48:48 INFO - Running main action method: download_and_extract 09:48:48 INFO - mkdir: /builds/slave/test/build/tests 09:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:48 INFO - trying https://queue.taskcluster.net/v1/task/El7EscZXQ1uK6wyAw0q7oQ/artifacts/public/build/target.test_packages.json 09:48:48 INFO - Downloading https://queue.taskcluster.net/v1/task/El7EscZXQ1uK6wyAw0q7oQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:48:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/El7EscZXQ1uK6wyAw0q7oQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:48:49 INFO - Downloaded 989 bytes. 09:48:49 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:48:49 INFO - Using the following test package requirements: 09:48:49 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:48:49 INFO - u'common': [u'target.common.tests.zip'], 09:48:49 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:48:49 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:48:49 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:48:49 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:48:49 INFO - u'mozbase': [u'target.common.tests.zip'], 09:48:49 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:48:49 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:48:49 INFO - u'web-platform': [u'target.common.tests.zip', 09:48:49 INFO - u'target.web-platform.tests.tar.gz'], 09:48:49 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:48:49 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:48:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/El7EscZXQ1uK6wyAw0q7oQ/artifacts/public/build/target.common.tests.zip 09:48:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/El7EscZXQ1uK6wyAw0q7oQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:48:49 INFO - Fetch https://queue.taskcluster.net/v1/task/El7EscZXQ1uK6wyAw0q7oQ/artifacts/public/build/target.common.tests.zip into memory 09:48:50 INFO - Content-Length response header: 68375168 09:48:50 INFO - Bytes received: 68375168 09:49:01 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:49:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/El7EscZXQ1uK6wyAw0q7oQ/artifacts/public/build/target.common.tests.zip 09:49:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/El7EscZXQ1uK6wyAw0q7oQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:49:01 INFO - Fetch https://queue.taskcluster.net/v1/task/El7EscZXQ1uK6wyAw0q7oQ/artifacts/public/build/target.common.tests.zip into memory 09:49:03 INFO - Content-Length response header: 68375168 09:49:03 INFO - Bytes received: 68375168 09:49:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/El7EscZXQ1uK6wyAw0q7oQ/artifacts/public/build/target.talos.tests.zip 09:49:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/El7EscZXQ1uK6wyAw0q7oQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:49:15 INFO - Fetch https://queue.taskcluster.net/v1/task/El7EscZXQ1uK6wyAw0q7oQ/artifacts/public/build/target.talos.tests.zip into memory 09:49:16 INFO - Content-Length response header: 14441306 09:49:16 INFO - Bytes received: 14441306 09:49: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:49:16 INFO - trying https://queue.taskcluster.net/v1/task/El7EscZXQ1uK6wyAw0q7oQ/artifacts/public/build/target.tar.bz2 09:49:16 INFO - Downloading https://queue.taskcluster.net/v1/task/El7EscZXQ1uK6wyAw0q7oQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:49:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/El7EscZXQ1uK6wyAw0q7oQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:49:18 INFO - Downloaded 62443572 bytes. 09:49:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/El7EscZXQ1uK6wyAw0q7oQ/artifacts/public/build/target.tar.bz2 09:49:18 INFO - mkdir: /builds/slave/test/properties 09:49:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:49:18 INFO - Writing to file /builds/slave/test/properties/build_url 09:49:18 INFO - Contents: 09:49:18 INFO - build_url:https://queue.taskcluster.net/v1/task/El7EscZXQ1uK6wyAw0q7oQ/artifacts/public/build/target.tar.bz2 09:49:18 INFO - Running post-action listener: _resource_record_post_action 09:49:18 INFO - Running post-action listener: set_extra_try_arguments 09:49:18 INFO - [mozharness: 2017-06-25 16:49:18.442674Z] Finished download-and-extract step (success) 09:49:18 INFO - [mozharness: 2017-06-25 16:49:18.442835Z] Running populate-webroot step. 09:49:18 INFO - Running pre-action listener: _resource_record_pre_action 09:49:18 INFO - Running main action method: populate_webroot 09:49:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:49:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:49:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:49:18 INFO - '--tppagecycles', 09:49:18 INFO - '7'], 09:49:18 INFO - 'tests': ['tsvgm']}}, 09:49:18 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:49:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:49:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:49:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:49:18 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:49:18 INFO - 'talos_options': ['--disable-e10s'], 09:49:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:49:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:49:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:49:18 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:49:18 INFO - 'talos_options': ['--disable-e10s'], 09:49:18 INFO - 'tests': ['damp', 'tps']}, 09:49:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:49:18 INFO - 'tests': ['damp', 'tps']}, 09:49:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:49:18 INFO - 'tests': ['dromaeo_dom']}, 09:49:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:49:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:49:18 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:49:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:49:18 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:49:18 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:49:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:49:18 INFO - 'tests': ['a11yr', 09:49:18 INFO - 'ts_paint', 09:49:18 INFO - 'tpaint', 09:49:18 INFO - 'sessionrestore', 09:49:18 INFO - 'sessionrestore_no_auto_restore', 09:49:18 INFO - 'tabpaint']}, 09:49:18 INFO - 'other-e10s': {'tests': ['a11yr', 09:49:18 INFO - 'ts_paint', 09:49:18 INFO - 'tpaint', 09:49:18 INFO - 'sessionrestore', 09:49:18 INFO - 'sessionrestore_no_auto_restore', 09:49:18 INFO - 'tabpaint']}, 09:49:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:49:18 INFO - 'ts_paint', 09:49:18 INFO - 'tpaint', 09:49:18 INFO - 'sessionrestore', 09:49:18 INFO - 'sessionrestore_no_auto_restore', 09:49:18 INFO - 'tabpaint']}, 09:49:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:49:18 INFO - 'ts_paint', 09:49:18 INFO - 'tpaint', 09:49:18 INFO - 'sessionrestore', 09:49:18 INFO - 'sessionrestore_no_auto_restore', 09:49:18 INFO - 'tabpaint']}, 09:49:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:49:18 INFO - 'tests': ['a11yr', 09:49:18 INFO - 'ts_paint', 09:49:18 INFO - 'tpaint', 09:49:18 INFO - 'sessionrestore', 09:49:18 INFO - 'sessionrestore_no_auto_restore', 09:49:18 INFO - 'tabpaint']}, 09:49:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:49:18 INFO - 'tests': ['a11yr', 09:49:18 INFO - 'ts_paint', 09:49:18 INFO - 'tpaint', 09:49:18 INFO - 'sessionrestore', 09:49:18 INFO - 'sessionrestore_no_auto_restore', 09:49:18 INFO - 'tabpaint']}, 09:49:18 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:49:18 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:49:18 INFO - 'bloom_basic_ref']}, 09:49:18 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:49:18 INFO - 'talos_options': ['--mitmproxy', 09:49:18 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:49:18 INFO - '--firstNonBlankPaint'], 09:49:18 INFO - 'tests': ['quantum_pageload_google', 09:49:18 INFO - 'quantum_pageload_youtube', 09:49:18 INFO - 'quantum_pageload_amazon', 09:49:18 INFO - 'quantum_pageload_facebook']}, 09:49:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:49:18 INFO - 'tests': ['tsvgx', 09:49:18 INFO - 'tsvgr_opacity', 09:49:18 INFO - 'tart', 09:49:18 INFO - 'tscrollx', 09:49:18 INFO - 'cart', 09:49:18 INFO - 'tsvg_static']}, 09:49:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:49:18 INFO - 'tsvgr_opacity', 09:49:18 INFO - 'tart', 09:49:18 INFO - 'tscrollx', 09:49:18 INFO - 'cart', 09:49:18 INFO - 'tsvg_static']}, 09:49:18 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:49:18 INFO - 'talos_options': ['--disable-e10s'], 09:49:18 INFO - 'tests': ['tp5o']}, 09:49:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:49:18 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:49:18 INFO - 'talos_options': ['--disable-e10s', 09:49:18 INFO - '--xperf_path', 09:49:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:49:18 INFO - 'tests': ['tp5n']}, 09:49:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:49:18 INFO - 'talos_options': ['--xperf_path', 09:49:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:49:18 INFO - 'tests': ['tp5n']}}, 09:49:18 INFO - 'talos.zip': {'path': '', 09:49:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:49:18 INFO - Running post-action listener: _resource_record_post_action 09:49:18 INFO - [mozharness: 2017-06-25 16:49:18.460630Z] Finished populate-webroot step (success) 09:49:18 INFO - [mozharness: 2017-06-25 16:49:18.460720Z] Running create-virtualenv step. 09:49:18 INFO - Running pre-action listener: _resource_record_pre_action 09:49:18 INFO - Running main action method: create_virtualenv 09:49:18 INFO - Creating virtualenv /builds/slave/test/build/venv 09:49:18 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:49:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:49:18 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:49:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:49:18 INFO - Using real prefix '/usr' 09:49:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:49:19 INFO - Installing distribute.............................................................................................................................................................................................done. 09:49:21 INFO - Installing pip.................done. 09:49:21 INFO - Return code: 0 09:49:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:49:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:49:21 INFO - Reading from file tmpfile_stdout 09:49:21 INFO - Output received: 09:49:21 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:49:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:49: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:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49: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:49:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:21 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 0x1f8a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2164a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23089a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2306140>, '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 0x2306a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2306ed0>, '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': '51fc86400edbde9650d2781a000001d0-1498389334.749262-625243051', '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:49:21 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:49:21 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:49:21 INFO - Using env: {'DISPLAY': ':0', 09:49:21 INFO - 'HOME': '/home/cltbld', 09:49:21 INFO - 'LANG': 'en_US.UTF-8', 09:49:21 INFO - 'LANGUAGE': 'en_US:en', 09:49:21 INFO - 'LOGNAME': 'cltbld', 09:49:21 INFO - 'MAIL': '/var/mail/cltbld', 09:49:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:21 INFO - 'MOZ_NO_REMOTE': '1', 09:49:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:21 INFO - 'NO_EM_RESTART': '1', 09:49:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:21 INFO - 'PWD': '/builds/slave/test', 09:49:21 INFO - 'SHELL': '/bin/bash', 09:49:21 INFO - 'SHLVL': '1', 09:49:21 INFO - 'TERM': 'linux', 09:49:21 INFO - 'TMOUT': '86400', 09:49:21 INFO - 'USER': 'cltbld', 09:49:21 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1498389334.749262-625243051', 09:49:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:21 INFO - '_': '/tools/buildbot/bin/python'} 09:49:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:21 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:49:21 INFO - Cleaning up... 09:49:21 INFO - Return code: 0 09:49:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:49: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:49:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49: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:49:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:21 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 0x1f8a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2164a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23089a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2306140>, '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 0x2306a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2306ed0>, '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': '51fc86400edbde9650d2781a000001d0-1498389334.749262-625243051', '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:49:21 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:49:21 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:49:21 INFO - Using env: {'DISPLAY': ':0', 09:49:21 INFO - 'HOME': '/home/cltbld', 09:49:21 INFO - 'LANG': 'en_US.UTF-8', 09:49:21 INFO - 'LANGUAGE': 'en_US:en', 09:49:21 INFO - 'LOGNAME': 'cltbld', 09:49:21 INFO - 'MAIL': '/var/mail/cltbld', 09:49:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:21 INFO - 'MOZ_NO_REMOTE': '1', 09:49:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:21 INFO - 'NO_EM_RESTART': '1', 09:49:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:21 INFO - 'PWD': '/builds/slave/test', 09:49:21 INFO - 'SHELL': '/bin/bash', 09:49:21 INFO - 'SHLVL': '1', 09:49:21 INFO - 'TERM': 'linux', 09:49:21 INFO - 'TMOUT': '86400', 09:49:21 INFO - 'USER': 'cltbld', 09:49:21 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1498389334.749262-625243051', 09:49:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:21 INFO - '_': '/tools/buildbot/bin/python'} 09:49:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:21 INFO - Downloading/unpacking psutil>=3.1.1 09:49: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:49: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:49: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:49: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:49:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:49:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:49:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:49:22 INFO - Installing collected packages: psutil 09:49:22 INFO - Running setup.py install for psutil 09:49:22 INFO - building 'psutil._psutil_linux' extension 09:49:22 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:49:23 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:49:23 INFO - building 'psutil._psutil_posix' extension 09:49:23 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:49:23 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:49:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:49:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:49:23 INFO - Successfully installed psutil 09:49:23 INFO - Cleaning up... 09:49:23 INFO - Return code: 0 09:49:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:49:23 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:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:23 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:49:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:23 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 0x1f8a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2164a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23089a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2306140>, '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 0x2306a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2306ed0>, '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': '51fc86400edbde9650d2781a000001d0-1498389334.749262-625243051', '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:49:23 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:49:23 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:49:23 INFO - Using env: {'DISPLAY': ':0', 09:49:23 INFO - 'HOME': '/home/cltbld', 09:49:23 INFO - 'LANG': 'en_US.UTF-8', 09:49:23 INFO - 'LANGUAGE': 'en_US:en', 09:49:23 INFO - 'LOGNAME': 'cltbld', 09:49:23 INFO - 'MAIL': '/var/mail/cltbld', 09:49:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:23 INFO - 'MOZ_NO_REMOTE': '1', 09:49:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:23 INFO - 'NO_EM_RESTART': '1', 09:49:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:23 INFO - 'PWD': '/builds/slave/test', 09:49:23 INFO - 'SHELL': '/bin/bash', 09:49:23 INFO - 'SHLVL': '1', 09:49:23 INFO - 'TERM': 'linux', 09:49:23 INFO - 'TMOUT': '86400', 09:49:23 INFO - 'USER': 'cltbld', 09:49:23 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1498389334.749262-625243051', 09:49:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:23 INFO - '_': '/tools/buildbot/bin/python'} 09:49:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:49:23 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:49:23 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:49:23 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:49:23 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:49:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:49:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:49:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:49:24 INFO - Installing collected packages: mozsystemmonitor 09:49:24 INFO - Running setup.py install for mozsystemmonitor 09:49:24 INFO - Successfully installed mozsystemmonitor 09:49:24 INFO - Cleaning up... 09:49:24 INFO - Return code: 0 09:49:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:49:24 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:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:24 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:49:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:24 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 0x1f8a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2164a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23089a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2306140>, '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 0x2306a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2306ed0>, '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': '51fc86400edbde9650d2781a000001d0-1498389334.749262-625243051', '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:49:24 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:49:24 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:49:24 INFO - Using env: {'DISPLAY': ':0', 09:49:24 INFO - 'HOME': '/home/cltbld', 09:49:24 INFO - 'LANG': 'en_US.UTF-8', 09:49:24 INFO - 'LANGUAGE': 'en_US:en', 09:49:24 INFO - 'LOGNAME': 'cltbld', 09:49:24 INFO - 'MAIL': '/var/mail/cltbld', 09:49:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:24 INFO - 'MOZ_NO_REMOTE': '1', 09:49:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:24 INFO - 'NO_EM_RESTART': '1', 09:49:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:24 INFO - 'PWD': '/builds/slave/test', 09:49:24 INFO - 'SHELL': '/bin/bash', 09:49:24 INFO - 'SHLVL': '1', 09:49:24 INFO - 'TERM': 'linux', 09:49:24 INFO - 'TMOUT': '86400', 09:49:24 INFO - 'USER': 'cltbld', 09:49:24 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1498389334.749262-625243051', 09:49:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:24 INFO - '_': '/tools/buildbot/bin/python'} 09:49:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:25 INFO - Downloading/unpacking jsonschema==2.5.1 09:49:25 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:49:25 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:49:25 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:49:25 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:49:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:49:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:49: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:49: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:49: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:49: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:49:26 INFO - Downloading functools32-3.2.3-2.tar.gz 09:49:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:49:26 INFO - warning: no files found matching '*.txt' 09:49:26 INFO - no previously-included directories found matching 'build' 09:49:26 INFO - no previously-included directories found matching 'dist' 09:49:26 INFO - no previously-included directories found matching '.git*' 09:49:26 INFO - Installing collected packages: jsonschema, functools32 09:49:26 INFO - Running setup.py install for functools32 09:49:26 INFO - warning: no files found matching '*.txt' 09:49:26 INFO - no previously-included directories found matching 'build' 09:49:26 INFO - no previously-included directories found matching 'dist' 09:49:26 INFO - no previously-included directories found matching '.git*' 09:49:26 INFO - Successfully installed jsonschema functools32 09:49:26 INFO - Cleaning up... 09:49:26 INFO - Return code: 0 09:49:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:26 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 0x1f8a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2164a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23089a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2306140>, '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 0x2306a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2306ed0>, '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': '51fc86400edbde9650d2781a000001d0-1498389334.749262-625243051', '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:49:26 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:49:26 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:49:26 INFO - Using env: {'DISPLAY': ':0', 09:49:26 INFO - 'HOME': '/home/cltbld', 09:49:26 INFO - 'LANG': 'en_US.UTF-8', 09:49:26 INFO - 'LANGUAGE': 'en_US:en', 09:49:26 INFO - 'LOGNAME': 'cltbld', 09:49:26 INFO - 'MAIL': '/var/mail/cltbld', 09:49:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:26 INFO - 'MOZ_NO_REMOTE': '1', 09:49:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:26 INFO - 'NO_EM_RESTART': '1', 09:49:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:26 INFO - 'PWD': '/builds/slave/test', 09:49:26 INFO - 'SHELL': '/bin/bash', 09:49:26 INFO - 'SHLVL': '1', 09:49:26 INFO - 'TERM': 'linux', 09:49:26 INFO - 'TMOUT': '86400', 09:49:26 INFO - 'USER': 'cltbld', 09:49:26 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1498389334.749262-625243051', 09:49:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:26 INFO - '_': '/tools/buildbot/bin/python'} 09:49:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:49:26 INFO - Cleaning up... 09:49:26 INFO - Return code: 0 09:49:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:26 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 0x1f8a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2164a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23089a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2306140>, '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 0x2306a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2306ed0>, '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': '51fc86400edbde9650d2781a000001d0-1498389334.749262-625243051', '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:49:26 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:49:26 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:49:26 INFO - Using env: {'DISPLAY': ':0', 09:49:26 INFO - 'HOME': '/home/cltbld', 09:49:26 INFO - 'LANG': 'en_US.UTF-8', 09:49:26 INFO - 'LANGUAGE': 'en_US:en', 09:49:26 INFO - 'LOGNAME': 'cltbld', 09:49:26 INFO - 'MAIL': '/var/mail/cltbld', 09:49:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:26 INFO - 'MOZ_NO_REMOTE': '1', 09:49:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:26 INFO - 'NO_EM_RESTART': '1', 09:49:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:26 INFO - 'PWD': '/builds/slave/test', 09:49:26 INFO - 'SHELL': '/bin/bash', 09:49:26 INFO - 'SHLVL': '1', 09:49:26 INFO - 'TERM': 'linux', 09:49:26 INFO - 'TMOUT': '86400', 09:49:26 INFO - 'USER': 'cltbld', 09:49:26 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1498389334.749262-625243051', 09:49:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:26 INFO - '_': '/tools/buildbot/bin/python'} 09:49:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:27 INFO - Downloading/unpacking blobuploader==1.2.4 09:49:27 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:49:27 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:49:27 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:49:27 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:49:28 INFO - Downloading blobuploader-1.2.4.tar.gz 09:49:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:49:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:49: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:49: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:49: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:49: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:49:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:49:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:49: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:49: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:49: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:49: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:49:28 INFO - Downloading docopt-0.6.1.tar.gz 09:49:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:49:28 INFO - Installing collected packages: blobuploader, requests, docopt 09:49:28 INFO - Running setup.py install for blobuploader 09:49:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:49:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:49:28 INFO - Running setup.py install for requests 09:49:29 INFO - Running setup.py install for docopt 09:49:29 INFO - Successfully installed blobuploader requests docopt 09:49:29 INFO - Cleaning up... 09:49:29 INFO - Return code: 0 09:49:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:49: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:49:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49: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:49:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:29 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 0x1f8a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2164a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23089a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2306140>, '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 0x2306a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2306ed0>, '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': '51fc86400edbde9650d2781a000001d0-1498389334.749262-625243051', '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:49:29 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:49:29 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:49:29 INFO - Using env: {'DISPLAY': ':0', 09:49:29 INFO - 'HOME': '/home/cltbld', 09:49:29 INFO - 'LANG': 'en_US.UTF-8', 09:49:29 INFO - 'LANGUAGE': 'en_US:en', 09:49:29 INFO - 'LOGNAME': 'cltbld', 09:49:29 INFO - 'MAIL': '/var/mail/cltbld', 09:49:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:29 INFO - 'MOZ_NO_REMOTE': '1', 09:49:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:29 INFO - 'NO_EM_RESTART': '1', 09:49:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:29 INFO - 'PWD': '/builds/slave/test', 09:49:29 INFO - 'SHELL': '/bin/bash', 09:49:29 INFO - 'SHLVL': '1', 09:49:29 INFO - 'TERM': 'linux', 09:49:29 INFO - 'TMOUT': '86400', 09:49:29 INFO - 'USER': 'cltbld', 09:49:29 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1498389334.749262-625243051', 09:49:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:29 INFO - '_': '/tools/buildbot/bin/python'} 09:49:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:49:29 INFO - Running setup.py (path:/tmp/pip-OuDnKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:49:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:49:29 INFO - Running setup.py (path:/tmp/pip-3FeskD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:49:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:49:29 INFO - Running setup.py (path:/tmp/pip-SIKB_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:49:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:49:29 INFO - Running setup.py (path:/tmp/pip-VDupQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:49:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:49:29 INFO - Running setup.py (path:/tmp/pip-TNCzVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:49:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:49:29 INFO - Running setup.py (path:/tmp/pip-QQJmzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:49:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:49:29 INFO - Running setup.py (path:/tmp/pip-kh6jez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:49:30 INFO - Running setup.py (path:/tmp/pip-4b7KtU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:49:30 INFO - Running setup.py (path:/tmp/pip-9AMdzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:49:30 INFO - Running setup.py (path:/tmp/pip-U8aJrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:49:30 INFO - Running setup.py (path:/tmp/pip-G8sRMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:49:30 INFO - Running setup.py (path:/tmp/pip-x0_uSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:49:30 INFO - Running setup.py (path:/tmp/pip-4ePdd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:49:30 INFO - Running setup.py (path:/tmp/pip-nWHmRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:30 INFO - Running setup.py (path:/tmp/pip-05_r9H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:49:30 INFO - Running setup.py (path:/tmp/pip-D_bD8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:49:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:49:30 INFO - Running setup.py (path:/tmp/pip-JemGNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:49:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:49:30 INFO - Running setup.py install for manifestparser 09:49:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:49:30 INFO - Running setup.py install for mozcrash 09:49:30 INFO - Running setup.py install for mozdebug 09:49:31 INFO - Running setup.py install for mozdevice 09:49:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:49:31 INFO - Running setup.py install for mozfile 09:49:31 INFO - Running setup.py install for mozhttpd 09:49:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:49:31 INFO - Running setup.py install for mozinfo 09:49:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:49:31 INFO - Running setup.py install for mozInstall 09:49:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:49:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:49:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:49:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:49:31 INFO - Running setup.py install for mozleak 09:49:31 INFO - Running setup.py install for mozlog 09:49:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:49:31 INFO - Running setup.py install for moznetwork 09:49:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:49:31 INFO - Running setup.py install for mozprocess 09:49:31 INFO - Running setup.py install for mozprofile 09:49:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:49:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:49:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:49:32 INFO - Running setup.py install for mozrunner 09:49:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:49:32 INFO - Running setup.py install for mozscreenshot 09:49:32 INFO - Running setup.py install for moztest 09:49:32 INFO - Running setup.py install for mozversion 09:49:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:49:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:49:32 INFO - Cleaning up... 09:49:32 INFO - Return code: 0 09:49:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:32 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 0x1f8a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2164a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23089a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2306140>, '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 0x2306a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2306ed0>, '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': '51fc86400edbde9650d2781a000001d0-1498389334.749262-625243051', '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:49:32 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:49:32 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:49:32 INFO - Using env: {'DISPLAY': ':0', 09:49:32 INFO - 'HOME': '/home/cltbld', 09:49:32 INFO - 'LANG': 'en_US.UTF-8', 09:49:32 INFO - 'LANGUAGE': 'en_US:en', 09:49:32 INFO - 'LOGNAME': 'cltbld', 09:49:32 INFO - 'MAIL': '/var/mail/cltbld', 09:49:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:32 INFO - 'MOZ_NO_REMOTE': '1', 09:49:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:32 INFO - 'NO_EM_RESTART': '1', 09:49:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:32 INFO - 'PWD': '/builds/slave/test', 09:49:32 INFO - 'SHELL': '/bin/bash', 09:49:32 INFO - 'SHLVL': '1', 09:49:32 INFO - 'TERM': 'linux', 09:49:32 INFO - 'TMOUT': '86400', 09:49:32 INFO - 'USER': 'cltbld', 09:49:32 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1498389334.749262-625243051', 09:49:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:32 INFO - '_': '/tools/buildbot/bin/python'} 09:49:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:49:32 INFO - Running setup.py (path:/tmp/pip-i73wq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:49:32 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:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:49:32 INFO - Running setup.py (path:/tmp/pip-gSyxIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:49:32 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:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:49:32 INFO - Running setup.py (path:/tmp/pip-3_L7CJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:49:32 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:49:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:49:32 INFO - Running setup.py (path:/tmp/pip-uKqZ_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:49:33 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:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:49:33 INFO - Running setup.py (path:/tmp/pip-UAqc_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:49:33 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:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:49:33 INFO - Running setup.py (path:/tmp/pip-Jq9qDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:49:33 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:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:49:33 INFO - Running setup.py (path:/tmp/pip-9hxBha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:49:33 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:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:49:33 INFO - Running setup.py (path:/tmp/pip-QlteVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:49:33 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:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:49:33 INFO - Running setup.py (path:/tmp/pip-6kXSO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:49:33 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:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:49:33 INFO - Running setup.py (path:/tmp/pip-io4ban-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:49:33 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:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:49:33 INFO - Running setup.py (path:/tmp/pip-RofFy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:49:33 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:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:49:33 INFO - Running setup.py (path:/tmp/pip-GSHE3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:49:33 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:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:49:33 INFO - Running setup.py (path:/tmp/pip-A2TYDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:49:33 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:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:49:33 INFO - Running setup.py (path:/tmp/pip-9dOmuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:49:33 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:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:33 INFO - Running setup.py (path:/tmp/pip-eJ1Hhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:49:33 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:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:49:33 INFO - Running setup.py (path:/tmp/pip-dr1Yr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:49:33 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:49:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:49:33 INFO - Running setup.py (path:/tmp/pip-8Kx8JN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:49:33 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:49:33 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:49:33 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:49:33 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:49:33 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:49:33 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:49:33 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:49:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:35 INFO - Downloading blessings-1.6.tar.gz 09:49:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:49:35 INFO - Installing collected packages: blessings 09:49:35 INFO - Running setup.py install for blessings 09:49:35 INFO - Successfully installed blessings 09:49:35 INFO - Cleaning up... 09:49:35 INFO - Return code: 0 09:49:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:49:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:49:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:49:35 INFO - Reading from file tmpfile_stdout 09:49:35 INFO - Current package versions: 09:49:35 INFO - argparse == 1.2.1 09:49:35 INFO - blessings == 1.6 09:49:35 INFO - blobuploader == 1.2.4 09:49:35 INFO - docopt == 0.6.1 09:49:35 INFO - functools32 == 3.2.3-2 09:49:35 INFO - jsonschema == 2.5.1 09:49:35 INFO - manifestparser == 1.1 09:49:35 INFO - mozInstall == 1.13 09:49:35 INFO - mozcrash == 1.0 09:49:35 INFO - mozdebug == 0.1 09:49:35 INFO - mozdevice == 0.51 09:49:35 INFO - mozfile == 1.2 09:49:35 INFO - mozhttpd == 0.7 09:49:35 INFO - mozinfo == 0.10 09:49:35 INFO - mozleak == 0.1 09:49:35 INFO - mozlog == 3.4 09:49:35 INFO - moznetwork == 0.27 09:49:35 INFO - mozprocess == 0.25 09:49:35 INFO - mozprofile == 0.28 09:49:35 INFO - mozrunner == 6.13 09:49:35 INFO - mozscreenshot == 0.1 09:49:35 INFO - mozsystemmonitor == 0.3 09:49:35 INFO - moztest == 0.8 09:49:35 INFO - mozversion == 1.4 09:49:35 INFO - psutil == 3.1.1 09:49:35 INFO - requests == 1.2.3 09:49:35 INFO - wsgiref == 0.1.2 09:49:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:49:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:35 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 0x1f8a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2164a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23089a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2306140>, '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 0x2306a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2306ed0>, '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': '51fc86400edbde9650d2781a000001d0-1498389334.749262-625243051', '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:49:35 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:49:35 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:49:35 INFO - Using env: {'DISPLAY': ':0', 09:49:35 INFO - 'HOME': '/home/cltbld', 09:49:35 INFO - 'LANG': 'en_US.UTF-8', 09:49:35 INFO - 'LANGUAGE': 'en_US:en', 09:49:35 INFO - 'LOGNAME': 'cltbld', 09:49:35 INFO - 'MAIL': '/var/mail/cltbld', 09:49:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:35 INFO - 'MOZ_NO_REMOTE': '1', 09:49:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:35 INFO - 'NO_EM_RESTART': '1', 09:49:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:35 INFO - 'PWD': '/builds/slave/test', 09:49:35 INFO - 'SHELL': '/bin/bash', 09:49:35 INFO - 'SHLVL': '1', 09:49:35 INFO - 'TERM': 'linux', 09:49:35 INFO - 'TMOUT': '86400', 09:49:35 INFO - 'USER': 'cltbld', 09:49:35 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1498389334.749262-625243051', 09:49:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:35 INFO - '_': '/tools/buildbot/bin/python'} 09:49:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:35 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:49:35 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:49:35 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:49:35 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:49:35 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:49:35 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:49:35 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:49:35 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:49:35 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:49:35 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:49:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:49:36 INFO - Downloading marionette_driver-1.4.0.tar.gz 09:49:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 09:49:37 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:49:37 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:49:37 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:49:37 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:49:37 INFO - Installing collected packages: marionette-driver 09:49:37 INFO - Running setup.py install for marionette-driver 09:49:37 INFO - Successfully installed marionette-driver 09:49:37 INFO - Cleaning up... 09:49:37 INFO - Return code: 0 09:49:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:49:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:49:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f8a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2164a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23089a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2306140>, '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 0x2306a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2306ed0>, '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': '51fc86400edbde9650d2781a000001d0-1498389334.749262-625243051', '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:49:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:49:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:49:37 INFO - Using env: {'DISPLAY': ':0', 09:49:37 INFO - 'HOME': '/home/cltbld', 09:49:37 INFO - 'LANG': 'en_US.UTF-8', 09:49:37 INFO - 'LANGUAGE': 'en_US:en', 09:49:37 INFO - 'LOGNAME': 'cltbld', 09:49:37 INFO - 'MAIL': '/var/mail/cltbld', 09:49:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:37 INFO - 'MOZ_NO_REMOTE': '1', 09:49:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:37 INFO - 'NO_EM_RESTART': '1', 09:49:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:37 INFO - 'PWD': '/builds/slave/test', 09:49:37 INFO - 'SHELL': '/bin/bash', 09:49:37 INFO - 'SHLVL': '1', 09:49:37 INFO - 'TERM': 'linux', 09:49:37 INFO - 'TMOUT': '86400', 09:49:37 INFO - 'USER': 'cltbld', 09:49:37 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1498389334.749262-625243051', 09:49:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:37 INFO - '_': '/tools/buildbot/bin/python'} 09:49:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:49:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:49:37 INFO - Cleaning up... 09:49:37 INFO - Return code: 0 09:49:37 INFO - Running post-action listener: _resource_record_post_action 09:49:37 INFO - Running post-action listener: _start_resource_monitoring 09:49:37 INFO - Starting resource monitoring. 09:49:37 INFO - [mozharness: 2017-06-25 16:49:37.502003Z] Finished create-virtualenv step (success) 09:49:37 INFO - [mozharness: 2017-06-25 16:49:37.502468Z] Running install step. 09:49:37 INFO - Running pre-action listener: _resource_record_pre_action 09:49:37 INFO - Running main action method: install 09:49:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:49:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:49:37 INFO - Reading from file tmpfile_stdout 09:49:37 INFO - Detecting whether we're running mozinstall >=1.0... 09:49:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:49:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:49:37 INFO - Reading from file tmpfile_stdout 09:49:37 INFO - Output received: 09:49:37 INFO - Usage: mozinstall [options] installer 09:49:37 INFO - Options: 09:49:37 INFO - -h, --help show this help message and exit 09:49:37 INFO - -d DEST, --destination=DEST 09:49:37 INFO - Directory to install application into. [default: 09:49:37 INFO - "/builds/slave/test"] 09:49:37 INFO - --app=APP Application being installed. [default: firefox] 09:49:37 INFO - mkdir: /builds/slave/test/build/application 09:49:37 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:49:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:49:55 INFO - Reading from file tmpfile_stdout 09:49:55 INFO - Output received: 09:49:55 INFO - /builds/slave/test/build/application/firefox/firefox 09:49:55 INFO - Running post-action listener: _resource_record_post_action 09:49:55 INFO - [mozharness: 2017-06-25 16:49:55.584389Z] Finished install step (success) 09:49:55 INFO - [mozharness: 2017-06-25 16:49:55.584537Z] Running setup-mitmproxy step. 09:49:55 INFO - Running pre-action listener: _resource_record_pre_action 09:49:55 INFO - Running main action method: setup_mitmproxy 09:49:55 INFO - Skipping: mitmproxy is not required 09:49:55 INFO - Running post-action listener: _resource_record_post_action 09:49:55 INFO - [mozharness: 2017-06-25 16:49:55.585068Z] Finished setup-mitmproxy step (success) 09:49:55 INFO - [mozharness: 2017-06-25 16:49:55.585177Z] Running run-tests step. 09:49:55 INFO - Running pre-action listener: _resource_record_pre_action 09:49:55 INFO - Running main action method: run_tests 09:49:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:49:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:49:55 INFO - Python 2.7.3 09:49:55 INFO - Return code: 0 09:49:55 INFO - grabbing minidump binary from tooltool 09:49:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:49:55 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 0x2306140>, '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 0x2306a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2306ed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:49:55 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:49:55 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:49:55 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:49:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:49:55 INFO - Return code: 0 09:49:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:49:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:49:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:49:55 INFO - ENV: RUST_BACKTRACE is now 1 09:49:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:49:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:49:55 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/El7EscZXQ1uK6wyAw0q7oQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-082', '--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:49:55 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/El7EscZXQ1uK6wyAw0q7oQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-082 --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:49:55 INFO - Using env: {'DISPLAY': ':0', 09:49:55 INFO - 'HOME': '/home/cltbld', 09:49:55 INFO - 'LANG': 'en_US.UTF-8', 09:49:55 INFO - 'LANGUAGE': 'en_US:en', 09:49:55 INFO - 'LOGNAME': 'cltbld', 09:49:55 INFO - 'MAIL': '/var/mail/cltbld', 09:49:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:49:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:49:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:49:55 INFO - 'MOZ_NO_REMOTE': '1', 09:49:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:49:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:49:55 INFO - 'NO_EM_RESTART': '1', 09:49:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:49:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:49:55 INFO - 'PWD': '/builds/slave/test', 09:49:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:49:55 INFO - 'RUST_BACKTRACE': '1', 09:49:55 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:49:55 INFO - 'SHELL': '/bin/bash', 09:49:55 INFO - 'SHLVL': '1', 09:49:55 INFO - 'TERM': 'linux', 09:49:55 INFO - 'TMOUT': '86400', 09:49:55 INFO - 'USER': 'cltbld', 09:49:55 INFO - 'XDG_SESSION_COOKIE': '51fc86400edbde9650d2781a000001d0-1498389334.749262-625243051', 09:49:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:49:55 INFO - '_': '/tools/buildbot/bin/python'} 09:49:55 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/El7EscZXQ1uK6wyAw0q7oQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-082', '--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:49:55 INFO - mozversion application_buildid: 20170625153553 09:49:55 INFO - mozversion application_changeset: d50abca6521baeae8ac6b07ddf843d63a1aa5f84 09:49:55 INFO - mozversion application_display_name: Nightly 09:49:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:49:55 INFO - mozversion application_name: Firefox 09:49:55 INFO - mozversion application_remotingname: firefox 09:49:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:49:55 INFO - mozversion application_vendor: Mozilla 09:49:55 INFO - mozversion application_version: 56.0a1 09:49:55 INFO - mozversion platform_buildid: 20170625153553 09:49:55 INFO - mozversion platform_changeset: d50abca6521baeae8ac6b07ddf843d63a1aa5f84 09:49:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:49:55 INFO - mozversion platform_version: 56.0a1 09:49:55 INFO - using testdate: 1498409395 09:49:55 INFO - actual date: 1498409395 09:49:55 INFO - starting webserver on 'localhost:34097' 09:49:55 INFO - SUITE-START | Running 2 tests 09:49:55 INFO - TEST-START | dromaeo_css 09:49:55 INFO - operating with platform_type : linux_ 09:49:55 INFO - Initialising browser for dromaeo_css test... 09:49:55 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34097/getInfo.html -profile /tmp/tmp8xDzmM/profile 09:49:55 INFO - TEST-INFO | started process 29548 (/builds/slave/test/build/application/firefox/firefox http://localhost:34097/getInfo.html) 09:50:01 INFO - TEST-INFO | 29548: exit 0 09:50:01 INFO - Browser initialized. 09:50:01 INFO - Running cycle 1/1 for dromaeo_css test... 09:50:01 INFO - TEST-INFO | started process 29777 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8xDzmM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:50:13 INFO - PID 29777 | RSS: Main: 169406464 09:50:13 INFO - PID 29777 | 09:53:16 INFO - PID 29777 | Cycle 1(1): loaded http://localhost:34097/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34097/tests/dromaeo/cssquery-ext.html) 09:53:18 INFO - PID 29777 | RSS: Main: 176005120 09:53:18 INFO - PID 29777 | 09:56:20 INFO - PID 29777 | Cycle 1(1): loaded http://localhost:34097/tests/dromaeo/cssquery-ext.html (next: http://localhost:34097/tests/dromaeo/cssquery-jquery.html) 09:56:21 INFO - PID 29777 | RSS: Main: 172695552 09:56:21 INFO - PID 29777 | 09:59:22 INFO - PID 29777 | Cycle 1(1): loaded http://localhost:34097/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34097/tests/dromaeo/cssquery-mootools.html) 09:59:23 INFO - PID 29777 | RSS: Main: 177074176 09:59:23 INFO - PID 29777 | 10:02:24 INFO - PID 29777 | Cycle 1(1): loaded http://localhost:34097/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34097/tests/dromaeo/cssquery-prototype.html) 10:02:25 INFO - PID 29777 | RSS: Main: 172752896 10:02:25 INFO - PID 29777 | 10:05:27 INFO - PID 29777 | Cycle 1(1): loaded http://localhost:34097/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34097/tests/dromaeo/cssquery-yui.html) 10:05:28 INFO - PID 29777 | RSS: Main: 176431104 10:05:28 INFO - PID 29777 | 10:08:30 INFO - PID 29777 | Cycle 1(1): loaded http://localhost:34097/tests/dromaeo/cssquery-yui.html (next: http://localhost:34097/tests/dromaeo/cssquery-dojo.html) 10:08:30 INFO - PID 29777 | RSS: Main: 175071232 10:08:30 INFO - PID 29777 | 10:08:30 INFO - PID 29777 | __start_tp_report 10:08:30 INFO - PID 29777 | _x_x_mozilla_page_load 10:08:30 INFO - PID 29777 | _x_x_mozilla_page_load_details 10:08:30 INFO - PID 29777 | |i|pagename|runs| 10:08:30 INFO - PID 29777 | |0;dojo.html;3351.095204294842;3373.561437013188;3388.5256064151017;3445.638207988163;3454.809985450801;6144.784932527363;6196.442320191182;6262.812115636538;6287.402696743813;6294.3705629437145;6254.687265636711;6299.937000629992;6319.905201421994;6357.268914074883;6361.777337793178;5540.919520693466;5572;5582.162675598652;5614.29821272341;5648.971755141219;5412.56699464042;5509.338879334466;5512.366077901032;5515.586331025189;5518.061929471999;5494.230807686927;5509.449055094498;5521.944780552183;5528.668279903179;5587.776488940478;5587.664740115565;5598.1602759586385;5603.327600687903;5620.775168993277;5640.351359593658;5519.199716041152;5550.611457197998;5553;5555.944440555583;5572.3870374258795;6225.066240063981;6304.621722696653;6309.4636955858805;6312.43188113072;6315;6646.202455705346;6736.932630673728;6799.320067993211;6808.6255255960905;6829.180498340182;6897.9655101724675;6910.861782764367;6913.965430172867;6918.411934985482;6919.065926099963;6283.560150789493;6349.682515874188;6356.237251529754;6367.108604795332;6418.326075762071;6856.485763567753;6974.093367862247;6978.546394484342;6980.965095174492;6988.93011069893;6649.0026496025985;6660.83347916306;6764.72941082361;6790.219124800711;6797.762078327235;6906.136732908387;6907.067545881342;6911.067005954233;6941.167059952838;6956.513044086865;6903.482238832007;6920.342567456084;6923.965380173167;6933.68798404073;6934.653267336613;6929.757458488929;6937.132858392701;6960.199577048705;6970.059042029363;6979.30206979298;5014.07239660664;5064.5441910228255;5091.287219789232;5175.404828444777;5176.197689358156;4495.168393847149;4540.704854184468;4543.273076307775;4579.9084018319445;4598.21830288845;6401.583897046677;6425.775097871552;6428.774992875227;6442;6482.027695845661;6919.930800691928;6925.203601585781;6940.41006514452;6950.687219075154;6979;6246.906296405557;6364.109024736541;6425.036244563353;6439.484841212692;6446.258680251831;5695.487406133385;5725.6850873202375;5730.885382292331;5757.107648314518;5758.481736643722;7039.190493093258;7072.08062951813;7112.57324560528;7125.35871771543;7155.964220178866;6809;6829.760958366433;6841.008053832067;6853.451723862178;6860.622665753232;7090.858182836418;7097.361237488651;7117.288271172842;7121.323474269936;7124.964375178091;6636.701348439428;6707.262201157966;6720.227173875067;6743.629100399525;6757.189137303555;6814.93185068143;6905.689243983932;6916.688749006206;6923.446124310144;6935.930640693528;6754.493412993947;6757.695903684247;6758.932410676027;6766.120404347404;6783.59298442095;6684.565503242468;6706.362895524917;6708.228553716385;6735.764248251287;6741.2921643226755;6505.577137486048;6606.174228221473;6633.402993730588;6637.103990961158;6682.164729408824;6630.171228596426;6699.263081060982;6704.161979752531;6732.461403087644;6754.290799465985;6488.286288508355;6519.250286217146;6588.835279117869;6591.835204119743;6593.076969224217 10:08:30 INFO - PID 29777 | |1;ext.html;828.2706820894316;890.6724087305473;905.2395987370608;919.0166521821645;932.2448816458669;42670;44169.55830441698;44215;44215.33676994844;44412;40264.396034059515;40298.59701402985;40605.39091913624;40764.38853417201;40787.79606101965;6758.729650813962;6774.356436138572;6823.590584564917;6862.725490980355;6898.413634841019;6437.517186211029;6446.580972236813;6514.44627206688;6515.967420162892;6528.738850445977;6505.316941721122;6533.444657204143;6538.542302038859;6542.313057129004;6546.803595892131;6475.579087359307;6490.383413575726;6502.122213501164;6503.934960650404;6525;6148.1699970504305;6148.477379422754;6156.076588511714;6203.689815509207;6206.844828879269;34613.480797788055;34827.825860870784;34899.302013959576;34902.30195396103;34949.301013979835;3377.9324413511836;3406.386850366933;3406.9829650851834;3470.236547959445;3549.8580056797696;32052.519212211835;32204.838975805204;32229.194270143198;32333;32362.676373236438;3779.1685829117823;3865;3872.7095467840027;3874.128321127752;3909.061825161969;197054;198230;199213;204945;205731;51252;51337.229941550904;51395.229071563954;51855;52040.739796300775;51523.742381287855;52516;52583.47416525862;53029.46970530322;53178;15440.922795385952;15613.063216207063;15701.450449234222;15716.68566628661;15748.370065197492;12819.935900320439;12876.35618219104;12900;12904.290264035568;12934.611961641165;14542.127472351693;14570;14583.635409114857;14591.197484138474;14635.634109147357;5742.5544673195745;5773.24947756789;5785.09506083392;5817.767289308465;5938.346781853993;1073.7721216941707;1089.929154604948;1094.4910616563336;1115.5705053554277;1116.7598966222301;23958.68227247518;24203.273901782974;24614.13850515259;24629.753702462745;24806.627900581505;1174.1682974559797;1186.6595533572965;1193.731410432663;1200.33981310279;1209.5161935225804;13250.801237981437;13389.19664820114;13426.932865335611;13488.460461581622;13510.662233444045;254642;255500;256009;256560;256776;54473;55110;55166;55182.72408638011;55497;1502.1662977047624;1507.1333982959843;1543.8996465229725;1544.5598004568644;1554.3316373959306;24052.639210412206;24111.39721506906;24124.75875241225;24228;24284.392890177885;53898;54751.72624136854;55022.72488637691;55153.448465516434;55242.72378638081;233706;234468;235068;237250;237465;34346.48480272848;34387.96836094921;34745.826270868485;35150.29699406049;37284.81357593195;44503.554964451236;44640.77679611581;44759.77620112009;45181.77409113065;46856.7657161712;30729.231769205948;32079;32124.83937580297;32740.422984836583;33141.17147071342;32096.358072837946;32759.67240327566;33031.66968330382;33097;33587.83206083954;38673.41989870098;39083.80458097691;39105.41341879817;39119.80440097781;39208.21583568255;30290.394192115593;30982.69017309798;31455;31814.840925795223;32790;24275;24894.50210995734;25755.424457554094;26349.20952371432;26504.469910602067 10:08:30 INFO - PID 29777 | |2;jquery.html;522.8170140450841;532.6484520216658;534.8475684429939;536.2947723743277;550.2255226893269;22835.200767973125;23276.76723232767;23548.058077676873;23625.291241262767;23853.16513922013;24786.62820057696;25586.616200757002;26816.59775103375;26975.460490790174;27019.864900675468;6816.829579260521;6952.409045231161;6994.6152961587095;6995.335443132894;7001.964990175042;6922.446204303644;6970.337817907291;6971.093757811477;6976.651167441608;6984.930150698504;4523.886902827423;6858.759943401982;6908.378245957862;6935.930640693604;6946.722131114775;6923.515353925202;6945.16658001038;6948.374646281859;6951.409130223937;6958.060661810667;6795.2185498667795;6826.795196144124;6829.385355318045;6853.828654283633;6866.656667166621;30712.232194195323;32417;32711.836440817882;32957.67042329594;32959.340813183844;2354.3643216331493;2378.6432035194684;2383.5232953409213;2404;2404.4349577849193;20299.28952486656;20876;20922.581548368948;20949.37151885446;20963.371098867057;2478.537662778951;2479.528889510987;2548.490301939601;2560.116759717894;2565.6279839423364;141118;146578;147272;147441.26279368642;147549;21623;22650.433739156324;24413.877930610233;24551.38621534476;24973.501589904663;45281.54718452839;45348.546514534435;45534.31698524525;45574.77212613982;45644.54355456469;10896.346219226712;11287.830682539769;11378.886211137782;11456.713582160513;11483.42582870853;9092.590833412512;9179.632814687471;9227.26181905446;9272.119148680864;9332;11522.654320370402;11976.490814225379;12089.15375923677;12136;12157.878421215852;2508.2224510401834;2514.333701569086;2520.6849143857016;2589.59861221511;2602.4014476670473;1019.887812340642;1028.88682244953;1031.582209205273;1044.206403133624;1107;21482.355529334145;21603.56792864134;21615.56768864614;21832.563348733252;21960.780392196193;1062.1184416933927;1067.8291473364225;1085.766560189563;1101.7686285879895;1125.5047778977387;13475.595732127857;14707.632309192142;14908.925455372872;14991.475298364505;15237.390504379922;595067;618000;630614;637600;642127;122258.38870805589;125465.37267313787;126487;127270;127447;1251.6870782304425;1294.7216348485122;1311.1412025123368;1327.9468821247042;1328.7408955253634;20919.8954005229;22332.665010025186;22698.498282610668;22819.20132795344;23314.067437302318;54282;55586.72206638941;56629.71685141548;57220.71389643025;58941.410585893595;73954.63022684852;74018.25981740114;80125;84386.57806710927;84499.15500844913;12412.255264684149;12745.553905613258;12748;12773.425195866022;12782.105252632598;19095.618087638446;20361.796382036584;20442.59114817725;20783.376498705064;20826.687599685712;14753;16486.67026659436;16553;16649.084300363596;16708.74936875972;13904.791428128789;14360.281985900454;14468.638284042983;14774;14774.778378324549;15393.153376564396;15429.691406172038;15469.917105802486;15563.922180389025;15566.37734490653;11807.409629518661;12474;12494.250344979331;12509.812352814533;12523.311217883103;15968.441104561285;16660.50018499447;16740.665186696442;16764.413245536347;16991.150442477578 10:08:30 INFO - PID 29777 | |3;mootools.html;1409.7603407420738;1433.3908089062145;1478.4899209772639;1496.4463148635;1500.9324580393884;14536.491222807204;15089.094654320748;15128;15129.848701513009;15138.77291840622;14570.198639074846;14890.181040042793;15511.379544818223;15549.766753498707;15564.766528502054;2707.6886158091825;2803.6074949507083;2808.620836187109;2813.9728998915452;2818.365867679766;2655.548556745358;2719.809613327058;2720.5919112133142;2723.714010028948;2724.4551089782026;2625.514279858223;2657.707652158271;2723.5914612808037;2729.3040274729915;2733.876975536106;2747.766439852615;2764.1016669582264;2781.276868014321;2788.093869492423;2790.330320723032;2641.3528685472183;2678.2233152385784;2687.0998215597797;2699.3386620278156;2718.184544636601;14176.149431034068;14418.783718244234;14490.710185796224;14504.70990580193;14523.564293071118;8170.550619715913;8292;8295.917040829574;8403.495790252604;8430.156984301582;4669.322948172496;4752.904941901143;4773.615651461072;4821.180399332122;4869.732164730938;1519.5213507745025;1544.6447317117127;1550.71311807316;1558.3637180959947;1567.8197007344074;24962.50074998508;25376.619350709752;25383.111591094224;25480.49039019209;25506.74493255081;7151.2491188424465;7277.781666549906;7368.4842061055215;7448.068991376078;7478.813029674302;19640.70538941917;19656.115474803668;19671.60656786885;19700.21199152018;19729.506762331057;8264.917350826536;8363.623636936352;8368.497890126611;8437.409381343246;8446.788830279293;7425.554466732014;7573.6213189340315;7604.429667774939;7618.657160427794;7645.617719114022;5628.971855140698;5747.6838773867;5783.884322313615;6031.336552979169;6157.7229024694;1765.7969333526553;1791.2208189437636;1802.0359107877223;1836.531684420491;1870.672632289344;917.2616044084576;919.296737995434;924.9445033298024;943.3820847345;943.7357539888842;7850.097238817495;7928.3260922821055;7933.087694915159;8031.598420078973;8105.27052565272;725.4957804325943;734.566605702638;759.5822297736223;761.2691815856839;766.5170942306312;4765.928511072337;5393.541548968382;5658.943410565924;5733.31200255972;5842.707864606753;20298.898505507674;20321.593568128555;20537.2811951581;20757.065932033096;21125.89437052805;20478.590428191354;20667.793322066587;20709.27517536909;20816.895915520327;21044.263450779148;10613.628523001658;10739.409332486632;10748.355098694103;11088.667339979813;11119.944400277947;8089.110197878111;8799.648014079621;8932.508712020901;9104.90741111071;9147.313951453802;17150.485485435456;17463.214155362784;17976;18025;18036.098195090457;18472.168752406444;18811.623767524845;18881.244750209837;18931.71602425937;19066.23735050638;11582.131340149692;12084.516619335129;12373.75252494963;12374.690632734253;12566.874331256937;13902.582922512342;13912.095713778572;14059.437622494986;14099.788503172666;14110.858891411364;9626.181774549243;10801.189910756882;11171.162162837658;11266;11800.350980696145;9843.704688859345;10487;10804;10955.233133680566;11192.496337664661;10167.7458063549;10206.438645874548;10212.387256764618;10237.23220758461;10275.486225688535;7561.508501947355;7716.5755883426955;7783.143854176149;7816.7264145754625;7864.21357864209;7529.360004399688;7586.48270345922;7615.086189657277;7624.8475030500185;7692.42306826979 10:08:30 INFO - PID 29777 | |4;prototype.html;483.9637027222959;492.1141944499902;496.81121173953903;501.76667849449973;506.83781190019187;6166.753329866806;6192.78325258616;6301.1808464899495;6312.842178945529;6335.429811316981;6173.444390004899;6204.813855584329;6234.968825155879;6238.220222472191;6239.563230573862;4854.417469903598;4894.412670479547;4896.77964491597;4904.8528544143555;4908.410990681124;4902.730349830758;4919.483454237307;4920.458749537548;4922.26166075088;4924.655274130794;4622.86131416058;4780.450248221464;4783.521647835206;4823.517648235166;4907.8773030674165;4765.380500534943;4773.498782627808;4774.40319960005;4811.374521312225;4819.180739274332;4279.593438623326;4298.656107511391;4300.268954277781;4308.547602501723;4322.697411181219;6126.448619624255;6131.049687298476;6147.508199344042;6160.722767475474;6195.96902015487;5737.971310143423;5737.995850726106;5752.913706294409;5765.827025189209;5786.797462088806;6643.800685979429;6648.772661158518;6657.600543967329;6667.466602671823;6716.462682985399;4882.633802464829;4894.583960363373;4895.730734809584;4899.216125419915;4923.384576927884;6727.29363416844;6976;7001.159860816683;7001.509894307401;7114.893276600855;4789.521047895182;4973.42805577356;4992.675476094042;5006.499350064964;5016.824411145665;5071.41678706946;5080.212567052113;5084;5092.745362731923;5100.591952643779;5690.857728556819;5692.943070569324;5703.144528320785;5703.486686198262;5735.971320143456;6637.269900310962;6643.202815662152;6656.334366563305;6672.666366681647;6682.63245521501;1744.6249056452923;1764.4353806781962;1766.920488578017;1768.0982698823693;1776.2539733311783;1160.6808127764764;1204.3195594489086;1223.2110288863632;1232.796588562877;1242.6520574239228;6256.968715156395;6279.937200628026;6290.874182516415;6297.622142671455;6316;6743.730250789913;6790.660466976631;6805.829854253683;6822.181338239344;6823.522353435311;6268.811935641938;6271.78048768291;6285.402886725754;6290.528210384239;6329.461995730322;3601.7838929664304;3616.222512159846;3628.963710362915;3634.236810269873;3635.4551813730495;7067.964660176769;7072.823179420556;7103.721330160517;7106.822329441805;7131.679074441558;6974.79075627732;6980.057692211588;6983.127109111361;6990.965045174843;7018.894716579255;7054.823629409203;7069.157627025504;7093.219745827955;7121.786346409616;7140.428765698732;6812.761553345609;6871.244163141951;6872.793816185523;6876.69054892541;6895.55178913369;6073.726682299219;6778.152730908637;6789.72841086351;6790.45676345901;6806;7059.858802823812;7063.470239731938;7075.646217688992;7093.397061249645;7140.714371425085;5018.924716129334;5025.748712564284;5035.169197082587;5041.546260836542;5043.142665746906;6557.901631475436;6739.326067393222;6799.626020568916;6899.793006209822;6907.758228461979;6493.155889734304;6595.505337099641;6605.636689982097;6623.138991931018;6641.833954151185;6619.569727967667;6629;6632.900506492503;6637.137172167781;6681.365270299314;6533.836654083686;6574.975511264872;6598.934010659832;6627.668616569249;6695.464362851058;6584.432071492026;6663.866722665616;6678.098456708282;6679.899801503078;6700.894352431989;6430.295971567445;6461.903071453838;6492;6515.869682606416;6530.346965303432 10:08:30 INFO - PID 29777 | |5;yui.html;855.1363123245524;879.4283715584869;882.2236431939892;889.6263569300893;910.8178364327136;18350.265989360425;18421.999999999967;18692.25230990762;18805.905970470147;18907;15834.683306333895;15903.84096159038;15932.52202433926;16410.917945410285;19865.900670496627;1010.1968934696915;1023.4780262066363;1028.4497793680382;1033.3231733214718;1034.7413146713322;1084.322298563398;1098.34099540276;1099.2689861242304;1100.5872797700863;1101.895319944608;1133.0652211925153;1134.6482590396963;1135.4549816088283;1137.9829302560468;1142.3260276436902;1055.862737844083;1105.1214284643647;1123.33723103369;1133.3766428464353;1133.9206255562115;815.6696537902159;817.8282560662268;819.7212947597786;823.5264722784423;824.6866190847439;17276.56808579783;17325.826741732548;17329.48011559655;17378.65242695139;17418.651626967516;19541.316053938186;20396.490087747778;20612.896935515375;20639.380818575468;20690.896545517175;14096.92951535246;14517.274136293248;14534.491292804807;14674.926625366912;14727.631809204748;3366.764326497146;3369.9157521061925;3408.7784294020807;3416.0605833395766;3423.6062852772;112802;113933.43033284863;114885.42557287244;116107;118916;14440.927795361165;15164.317605707769;15243;15571.299291531908;15759.29083191259;28895;28969.855150724532;29266.561001584992;29292;30114.24714382158;8063.637136328879;8211.260986511123;8212.17878212186;8217.383696222807;8277.130901255281;3841.9818748031794;3945.191235796655;3952.565217826037;3956.940645890314;3963.623455771697;5062;5258.158694608845;5269.499397557226;5319.946800531945;5321.973390133025;981.2738573455591;1011.5448048378112;1013.2350075692805;1016.8169729448771;1022.4632068164274;729.7628270812007;731.129955353128;733.6478490324674;734.6510407556368;757.1822431773782;12100.33448160342;12445;12528.123031387715;12730.299833509062;12773.425195866208;713.8822094354477;722.7795522365728;729.5513259345464;733.8018734941536;736.6574542837607;5604.747786349542;5622;5835.328937172195;5871.706414679335;5992.940070599326;117740.41129794296;118060.40969795268;120634;120690;125540.37229813976;100396.49801750944;100519;101931;102992;106634.46682766537;84000.57999710085;90768.54615727012;92542;92712;94412;12605.43275552584;13461.326933653083;13915.860841391457;14025.5091071812;14599.270036498345;41682.16635667209;42735.57264427316;43487.56512434835;44879;44980.77509612431;60091;60178;78154.6092269535;81040.59479702564;81100.59449702714;19091.713624295367;19286.13212405417;19715.802841971396;19904.104315306136;20419.4895127623;21710;22285.331440056823;22436.77563224347;22707.318780436613;22745.431364216027;20202.494937626678;20324.085416156013;20750.896245518677;20898.58202835965;20899;19614.651788690237;20195.495112621713;20249.69625455649;20439.693404598645;20439.693404599242;17399.30402783925;18209.362672306404;18338.908305458386;18391.90804045971;20472.897635511727;13046;13206.339683016004;13530.323483825967;13788.690074442911;13964.930175349464;14244.618688508299;14300.427982880568;15157.924210378878;16510.587235319214;16542.255598498337 10:08:30 INFO - PID 29777 | __end_tp_report 10:08:30 INFO - PID 29777 | __start_cc_report 10:08:30 INFO - PID 29777 | _x_x_mozilla_cycle_collect,339 10:08:30 INFO - PID 29777 | __end_cc_report 10:08:30 INFO - PID 29777 | __startTimestamp1498410510448__endTimestamp 10:08:30 INFO - PID 29777 | 10:08:30 INFO - PID 29777 | ------- Summary: start ------- 10:08:30 INFO - PID 29777 | Number of tests: 6 10:08:30 INFO - PID 29777 | 10:08:30 INFO - PID 29777 | [#0] dojo.html Cycles:165 Average:6294.43 Median:6630.17 stddev:814.01 (12.3%) stddev-sans-first:783.07 10:08:30 INFO - PID 29777 | Values: 3351.1 3373.6 3388.5 3445.6 3454.8 6144.8 6196.4 6262.8 6287.4 6294.4 6254.7 6299.9 6319.9 6357.3 6361.8 5540.9 5572.0 5582.2 5614.3 5649.0 5412.6 5509.3 5512.4 5515.6 5518.1 5494.2 5509.4 5521.9 5528.7 5587.8 5587.7 5598.2 5603.3 5620.8 5640.4 5519.2 5550.6 5553.0 5555.9 5572.4 6225.1 6304.6 6309.5 6312.4 6315.0 6646.2 6736.9 6799.3 6808.6 6829.2 6898.0 6910.9 6914.0 6918.4 6919.1 6283.6 6349.7 6356.2 6367.1 6418.3 6856.5 6974.1 6978.5 6981.0 6988.9 6649.0 6660.8 6764.7 6790.2 6797.8 6906.1 6907.1 6911.1 6941.2 6956.5 6903.5 6920.3 6924.0 6933.7 6934.7 6929.8 6937.1 6960.2 6970.1 6979.3 5014.1 5064.5 5091.3 5175.4 5176.2 4495.2 4540.7 4543.3 4579.9 4598.2 6401.6 6425.8 6428.8 6442.0 6482.0 6919.9 6925.2 6940.4 6950.7 6979.0 6246.9 6364.1 6425.0 6439.5 6446.3 5695.5 5725.7 5730.9 5757.1 5758.5 7039.2 7072.1 7112.6 7125.4 7156.0 6809.0 6829.8 6841.0 6853.5 6860.6 7090.9 7097.4 7117.3 7121.3 7125.0 6636.7 6707.3 6720.2 6743.6 6757.2 6814.9 6905.7 6916.7 6923.4 6935.9 6754.5 6757.7 6758.9 6766.1 6783.6 6684.6 6706.4 6708.2 6735.8 6741.3 6505.6 6606.2 6633.4 6637.1 6682.2 6630.2 6699.3 6704.2 6732.5 6754.3 6488.3 6519.3 6588.8 6591.8 6593.1 10:08:30 INFO - PID 29777 | 10:08:30 INFO - PID 29777 | [#1] ext.html Cycles:180 Average:40419.70 Median:19041.86 stddev:60427.93 (317.3%) stddev-sans-first:60524.32 10:08:30 INFO - PID 29777 | Values: 828.3 890.7 905.2 919.0 932.2 42670.0 44169.6 44215.0 44215.3 44412.0 40264.4 40298.6 40605.4 40764.4 40787.8 6758.7 6774.4 6823.6 6862.7 6898.4 6437.5 6446.6 6514.4 6516.0 6528.7 6505.3 6533.4 6538.5 6542.3 6546.8 6475.6 6490.4 6502.1 6503.9 6525.0 6148.2 6148.5 6156.1 6203.7 6206.8 34613.5 34827.8 34899.3 34902.3 34949.3 3377.9 3406.4 3407.0 3470.2 3549.9 32052.5 32204.8 32229.2 32333.0 32362.7 3779.2 3865.0 3872.7 3874.1 3909.1 197054.0 198230.0 199213.0 204945.0 205731.0 51252.0 51337.2 51395.2 51855.0 52040.7 51523.7 52516.0 52583.5 53029.5 53178.0 15440.9 15613.1 15701.5 15716.7 15748.4 12819.9 12876.4 12900.0 12904.3 12934.6 14542.1 14570.0 14583.6 14591.2 14635.6 5742.6 5773.2 5785.1 5817.8 5938.3 1073.8 1089.9 1094.5 1115.6 1116.8 23958.7 24203.3 24614.1 24629.8 24806.6 1174.2 1186.7 1193.7 1200.3 1209.5 13250.8 13389.2 13426.9 13488.5 13510.7 254642.0 255500.0 256009.0 256560.0 256776.0 54473.0 55110.0 55166.0 55182.7 55497.0 1502.2 1507.1 1543.9 1544.6 1554.3 24052.6 24111.4 24124.8 24228.0 24284.4 53898.0 54751.7 55022.7 55153.4 55242.7 233706.0 234468.0 235068.0 237250.0 237465.0 34346.5 34388.0 34745.8 35150.3 37284.8 44503.6 44640.8 44759.8 45181.8 46856.8 30729.2 32079.0 32124.8 32740.4 33141.2 32096.4 32759.7 33031.7 33097.0 33587.8 38673.4 39083.8 39105.4 39119.8 39208.2 30290.4 30982.7 31455.0 31814.8 32790.0 24275.0 24894.5 25755.4 26349.2 26504.5 10:08:30 INFO - PID 29777 | 10:08:30 INFO - PID 29777 | [#2] jquery.html Cycles:180 Average:40258.85 Median:22827.20 stddev:104065.39 (455.9%) stddev-sans-first:104314.55 10:08:30 INFO - PID 29777 | Values: 522.8 532.6 534.8 536.3 550.2 22835.2 23276.8 23548.1 23625.3 23853.2 24786.6 25586.6 26816.6 26975.5 27019.9 6816.8 6952.4 6994.6 6995.3 7002.0 6922.4 6970.3 6971.1 6976.7 6984.9 4523.9 6858.8 6908.4 6935.9 6946.7 6923.5 6945.2 6948.4 6951.4 6958.1 6795.2 6826.8 6829.4 6853.8 6866.7 30712.2 32417.0 32711.8 32957.7 32959.3 2354.4 2378.6 2383.5 2404.0 2404.4 20299.3 20876.0 20922.6 20949.4 20963.4 2478.5 2479.5 2548.5 2560.1 2565.6 141118.0 146578.0 147272.0 147441.3 147549.0 21623.0 22650.4 24413.9 24551.4 24973.5 45281.5 45348.5 45534.3 45574.8 45644.5 10896.3 11287.8 11378.9 11456.7 11483.4 9092.6 9179.6 9227.3 9272.1 9332.0 11522.7 11976.5 12089.2 12136.0 12157.9 2508.2 2514.3 2520.7 2589.6 2602.4 1019.9 1028.9 1031.6 1044.2 1107.0 21482.4 21603.6 21615.6 21832.6 21960.8 1062.1 1067.8 1085.8 1101.8 1125.5 13475.6 14707.6 14908.9 14991.5 15237.4 595067.0 618000.0 630614.0 637600.0 642127.0 122258.4 125465.4 126487.0 127270.0 127447.0 1251.7 1294.7 1311.1 1327.9 1328.7 20919.9 22332.7 22698.5 22819.2 23314.1 54282.0 55586.7 56629.7 57220.7 58941.4 73954.6 74018.3 80125.0 84386.6 84499.2 12412.3 12745.6 12748.0 12773.4 12782.1 19095.6 20361.8 20442.6 20783.4 20826.7 14753.0 16486.7 16553.0 16649.1 16708.7 13904.8 14360.3 14468.6 14774.0 14774.8 15393.2 15429.7 15469.9 15563.9 15566.4 11807.4 12474.0 12494.3 12509.8 12523.3 15968.4 16660.5 16740.7 16764.4 16991.2 10:08:30 INFO - PID 29777 | 10:08:30 INFO - PID 29777 | [#3] mootools.html Cycles:180 Average:9347.32 Median:2656.63 stddev:6514.10 (245.2%) stddev-sans-first:6505.07 10:08:30 INFO - PID 29777 | Values: 1409.8 1433.4 1478.5 1496.4 1500.9 14536.5 15089.1 15128.0 15129.8 15138.8 14570.2 14890.2 15511.4 15549.8 15564.8 2707.7 2803.6 2808.6 2814.0 2818.4 2655.5 2719.8 2720.6 2723.7 2724.5 2625.5 2657.7 2723.6 2729.3 2733.9 2747.8 2764.1 2781.3 2788.1 2790.3 2641.4 2678.2 2687.1 2699.3 2718.2 14176.1 14418.8 14490.7 14504.7 14523.6 8170.6 8292.0 8295.9 8403.5 8430.2 4669.3 4752.9 4773.6 4821.2 4869.7 1519.5 1544.6 1550.7 1558.4 1567.8 24962.5 25376.6 25383.1 25480.5 25506.7 7151.2 7277.8 7368.5 7448.1 7478.8 19640.7 19656.1 19671.6 19700.2 19729.5 8264.9 8363.6 8368.5 8437.4 8446.8 7425.6 7573.6 7604.4 7618.7 7645.6 5629.0 5747.7 5783.9 6031.3 6157.7 1765.8 1791.2 1802.0 1836.5 1870.7 917.3 919.3 924.9 943.4 943.7 7850.1 7928.3 7933.1 8031.6 8105.3 725.5 734.6 759.6 761.3 766.5 4765.9 5393.5 5658.9 5733.3 5842.7 20298.9 20321.6 20537.3 20757.1 21125.9 20478.6 20667.8 20709.3 20816.9 21044.3 10613.6 10739.4 10748.4 11088.7 11119.9 8089.1 8799.6 8932.5 9104.9 9147.3 17150.5 17463.2 17976.0 18025.0 18036.1 18472.2 18811.6 18881.2 18931.7 19066.2 11582.1 12084.5 12373.8 12374.7 12566.9 13902.6 13912.1 14059.4 14099.8 14110.9 9626.2 10801.2 11171.2 11266.0 11800.4 9843.7 10487.0 10804.0 10955.2 11192.5 10167.7 10206.4 10212.4 10237.2 10275.5 7561.5 7716.6 7783.1 7816.7 7864.2 7529.4 7586.5 7615.1 7624.8 7692.4 10:08:30 INFO - PID 29777 | 10:08:30 INFO - PID 29777 | [#4] prototype.html Cycles:180 Average:5612.79 Median:6275.86 stddev:1628.14 (25.9%) stddev-sans-first:1586.54 10:08:30 INFO - PID 29777 | Values: 484.0 492.1 496.8 501.8 506.8 6166.8 6192.8 6301.2 6312.8 6335.4 6173.4 6204.8 6235.0 6238.2 6239.6 4854.4 4894.4 4896.8 4904.9 4908.4 4902.7 4919.5 4920.5 4922.3 4924.7 4622.9 4780.5 4783.5 4823.5 4907.9 4765.4 4773.5 4774.4 4811.4 4819.2 4279.6 4298.7 4300.3 4308.5 4322.7 6126.4 6131.0 6147.5 6160.7 6196.0 5738.0 5738.0 5752.9 5765.8 5786.8 6643.8 6648.8 6657.6 6667.5 6716.5 4882.6 4894.6 4895.7 4899.2 4923.4 6727.3 6976.0 7001.2 7001.5 7114.9 4789.5 4973.4 4992.7 5006.5 5016.8 5071.4 5080.2 5084.0 5092.7 5100.6 5690.9 5692.9 5703.1 5703.5 5736.0 6637.3 6643.2 6656.3 6672.7 6682.6 1744.6 1764.4 1766.9 1768.1 1776.3 1160.7 1204.3 1223.2 1232.8 1242.7 6257.0 6279.9 6290.9 6297.6 6316.0 6743.7 6790.7 6805.8 6822.2 6823.5 6268.8 6271.8 6285.4 6290.5 6329.5 3601.8 3616.2 3629.0 3634.2 3635.5 7068.0 7072.8 7103.7 7106.8 7131.7 6974.8 6980.1 6983.1 6991.0 7018.9 7054.8 7069.2 7093.2 7121.8 7140.4 6812.8 6871.2 6872.8 6876.7 6895.6 6073.7 6778.2 6789.7 6790.5 6806.0 7059.9 7063.5 7075.6 7093.4 7140.7 5018.9 5025.7 5035.2 5041.5 5043.1 6557.9 6739.3 6799.6 6899.8 6907.8 6493.2 6595.5 6605.6 6623.1 6641.8 6619.6 6629.0 6632.9 6637.1 6681.4 6533.8 6575.0 6598.9 6627.7 6695.5 6584.4 6663.9 6678.1 6679.9 6700.9 6430.3 6461.9 6492.0 6515.9 6530.3 10:08:30 INFO - PID 29777 | 10:08:30 INFO - PID 29777 | [#5] yui.html Cycles:180 Average:24131.54 Median:19665.23 stddev:32794.30 (166.8%) stddev-sans-first:32839.73 10:08:30 INFO - PID 29777 | Values: 855.1 879.4 882.2 889.6 910.8 18350.3 18422.0 18692.3 18805.9 18907.0 15834.7 15903.8 15932.5 16410.9 19865.9 1010.2 1023.5 1028.4 1033.3 1034.7 1084.3 1098.3 1099.3 1100.6 1101.9 1133.1 1134.6 1135.5 1138.0 1142.3 1055.9 1105.1 1123.3 1133.4 1133.9 815.7 817.8 819.7 823.5 824.7 17276.6 17325.8 17329.5 17378.7 17418.7 19541.3 20396.5 20612.9 20639.4 20690.9 14096.9 14517.3 14534.5 14674.9 14727.6 3366.8 3369.9 3408.8 3416.1 3423.6 112802.0 113933.4 114885.4 116107.0 118916.0 14440.9 15164.3 15243.0 15571.3 15759.3 28895.0 28969.9 29266.6 29292.0 30114.2 8063.6 8211.3 8212.2 8217.4 8277.1 3842.0 3945.2 3952.6 3956.9 3963.6 5062.0 5258.2 5269.5 5319.9 5322.0 981.3 1011.5 1013.2 1016.8 1022.5 729.8 731.1 733.6 734.7 757.2 12100.3 12445.0 12528.1 12730.3 12773.4 713.9 722.8 729.6 733.8 736.7 5604.7 5622.0 5835.3 5871.7 5992.9 117740.4 118060.4 120634.0 120690.0 125540.4 100396.5 100519.0 101931.0 102992.0 106634.5 84000.6 90768.5 92542.0 92712.0 94412.0 12605.4 13461.3 13915.9 14025.5 14599.3 41682.2 42735.6 43487.6 44879.0 44980.8 60091.0 60178.0 78154.6 81040.6 81100.6 19091.7 19286.1 19715.8 19904.1 20419.5 21710.0 22285.3 22436.8 22707.3 22745.4 20202.5 20324.1 20750.9 20898.6 20899.0 19614.7 20195.5 20249.7 20439.7 20439.7 17399.3 18209.4 18338.9 18391.9 20472.9 13046.0 13206.3 13530.3 13788.7 13964.9 14244.6 14300.4 15157.9 16510.6 16542.3 10:08:30 INFO - PID 29777 | -------- Summary: end -------- 10:08:30 INFO - PID 29777 | 10:08:30 INFO - TEST-INFO | 29777: exit 0 10:08:31 INFO - TEST-OK | dromaeo_css | took 1115058ms 10:08:31 INFO - TEST-START | kraken 10:08:31 INFO - operating with platform_type : linux_ 10:08:31 INFO - Initialising browser for kraken test... 10:08:31 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34097/getInfo.html -profile /tmp/tmpDQwtCD/profile 10:08:31 INFO - TEST-INFO | started process 30204 (/builds/slave/test/build/application/firefox/firefox http://localhost:34097/getInfo.html) 10:08:36 INFO - TEST-INFO | 30204: exit 0 10:08:36 INFO - Browser initialized. 10:08:36 INFO - Running cycle 1/1 for kraken test... 10:08:36 INFO - TEST-INFO | started process 30440 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDQwtCD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 10:08:48 INFO - PID 30440 | RSS: Main: 163123200 10:08:48 INFO - PID 30440 | 10:08:50 INFO - PID 30440 | Cycle 1(1): loaded http://localhost:34097/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34097/tests/kraken/driver.html?testName=audio-beat-detection) 10:08:51 INFO - PID 30440 | RSS: Main: 166682624 10:08:51 INFO - PID 30440 | 10:08:54 INFO - PID 30440 | Cycle 1(1): loaded http://localhost:34097/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34097/tests/kraken/driver.html?testName=audio-dft) 10:08:54 INFO - PID 30440 | RSS: Main: 167280640 10:08:54 INFO - PID 30440 | 10:08:57 INFO - PID 30440 | Cycle 1(1): loaded http://localhost:34097/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34097/tests/kraken/driver.html?testName=audio-fft) 10:08:58 INFO - PID 30440 | RSS: Main: 166014976 10:08:58 INFO - PID 30440 | 10:09:00 INFO - PID 30440 | Cycle 1(1): loaded http://localhost:34097/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34097/tests/kraken/driver.html?testName=audio-oscillator) 10:09:00 INFO - PID 30440 | RSS: Main: 167288832 10:09:00 INFO - PID 30440 | 10:09:02 INFO - PID 30440 | Cycle 1(1): loaded http://localhost:34097/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34097/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:09:03 INFO - PID 30440 | RSS: Main: 166211584 10:09:03 INFO - PID 30440 | 10:09:06 INFO - PID 30440 | Cycle 1(1): loaded http://localhost:34097/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34097/tests/kraken/driver.html?testName=imaging-darkroom) 10:09:07 INFO - PID 30440 | RSS: Main: 166531072 10:09:07 INFO - PID 30440 | 10:09:10 INFO - PID 30440 | Cycle 1(1): loaded http://localhost:34097/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34097/tests/kraken/driver.html?testName=imaging-desaturate) 10:09:11 INFO - PID 30440 | RSS: Main: 169844736 10:09:11 INFO - PID 30440 | 10:09:13 INFO - PID 30440 | Cycle 1(1): loaded http://localhost:34097/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34097/tests/kraken/driver.html?testName=json-parse-financial) 10:09:14 INFO - PID 30440 | RSS: Main: 170119168 10:09:14 INFO - PID 30440 | 10:09:15 INFO - PID 30440 | Cycle 1(1): loaded http://localhost:34097/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34097/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:09:16 INFO - PID 30440 | RSS: Main: 169824256 10:09:16 INFO - PID 30440 | 10:09:18 INFO - PID 30440 | Cycle 1(1): loaded http://localhost:34097/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34097/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:09:18 INFO - PID 30440 | RSS: Main: 169869312 10:09:18 INFO - PID 30440 | 10:09:20 INFO - PID 30440 | Cycle 1(1): loaded http://localhost:34097/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34097/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:09:21 INFO - PID 30440 | RSS: Main: 170209280 10:09:21 INFO - PID 30440 | 10:09:24 INFO - PID 30440 | Cycle 1(1): loaded http://localhost:34097/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34097/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:09:24 INFO - PID 30440 | RSS: Main: 169734144 10:09:24 INFO - PID 30440 | 10:09:27 INFO - PID 30440 | Cycle 1(1): loaded http://localhost:34097/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34097/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:09:28 INFO - PID 30440 | RSS: Main: 169857024 10:09:28 INFO - PID 30440 | 10:09:29 INFO - PID 30440 | Cycle 1(1): loaded http://localhost:34097/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34097/tests/kraken/driver.html?testName=ai-astar) 10:09:30 INFO - PID 30440 | RSS: Main: 171610112 10:09:30 INFO - PID 30440 | 10:09:30 INFO - PID 30440 | __start_tp_report 10:09:30 INFO - PID 30440 | _x_x_mozilla_page_load 10:09:30 INFO - PID 30440 | _x_x_mozilla_page_load_details 10:09:30 INFO - PID 30440 | |i|pagename|runs| 10:09:30 INFO - PID 30440 | |0;ai-astar;98;105;107;105;106;108;112;107;107;108 10:09:30 INFO - PID 30440 | |1;audio-beat-detection;144;114;141;155;121;144;154;116;168;115 10:09:30 INFO - PID 30440 | |2;audio-dft;162;163;162;161;161;169;163;162;164;167 10:09:30 INFO - PID 30440 | |3;audio-fft;74;74;73;148;73;74;73;73;92;73 10:09:30 INFO - PID 30440 | |4;audio-oscillator;82;84;127;80;81;81;136;86;81;130 10:09:30 INFO - PID 30440 | |5;imaging-gaussian-blur;113;114;113;114;114;114;115;114;113;114 10:09:30 INFO - PID 30440 | |6;imaging-darkroom;147;148;148;148;147;146;147;148;148;147 10:09:30 INFO - PID 30440 | |7;imaging-desaturate;94;95;94;94;94;94;93;94;94;95 10:09:30 INFO - PID 30440 | |8;json-parse-financial;47;47;51;48;48;47;48;50;49;48 10:09:30 INFO - PID 30440 | |9;json-stringify-tinderbox;54;54;54;53;54;56;54;55;54;54 10:09:30 INFO - PID 30440 | |10;stanford-crypto-aes;74;74;74;73;74;80;78;73;73;74 10:09:30 INFO - PID 30440 | |11;stanford-crypto-ccm;127;126;124;119;120;119;128;126;119;148 10:09:30 INFO - PID 30440 | |12;stanford-crypto-pbkdf2;177;180;177;199;169;171;174;170;174;174 10:09:30 INFO - PID 30440 | |13;stanford-crypto-sha256-iterative;67;64;63;60;60;64;62;60;70;59 10:09:30 INFO - PID 30440 | __end_tp_report 10:09:30 INFO - PID 30440 | __start_cc_report 10:09:30 INFO - PID 30440 | _x_x_mozilla_cycle_collect,859 10:09:30 INFO - PID 30440 | __end_cc_report 10:09:30 INFO - PID 30440 | __startTimestamp1498410570231__endTimestamp 10:09:30 INFO - PID 30440 | 10:09:30 INFO - PID 30440 | ------- Summary: start ------- 10:09:30 INFO - PID 30440 | Number of tests: 14 10:09:30 INFO - PID 30440 | 10:09:30 INFO - PID 30440 | [#0] ai-astar Cycles:10 Average:106.30 Median:107.50 stddev:3.53 (3.3%) stddev-sans-first:2.11 10:09:30 INFO - PID 30440 | Values: 98.0 105.0 107.0 105.0 106.0 108.0 112.0 107.0 107.0 108.0 10:09:30 INFO - PID 30440 | 10:09:30 INFO - PID 30440 | [#1] audio-beat-detection Cycles:10 Average:137.20 Median:144.00 stddev:19.43 (13.5%) stddev-sans-first:20.45 10:09:30 INFO - PID 30440 | Values: 144.0 114.0 141.0 155.0 121.0 144.0 154.0 116.0 168.0 115.0 10:09:30 INFO - PID 30440 | 10:09:30 INFO - PID 30440 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:2.63 (1.6%) stddev-sans-first:2.74 10:09:30 INFO - PID 30440 | Values: 162.0 163.0 162.0 161.0 161.0 169.0 163.0 162.0 164.0 167.0 10:09:30 INFO - PID 30440 | 10:09:30 INFO - PID 30440 | [#3] audio-fft Cycles:10 Average:82.70 Median:73.50 stddev:23.68 (32.2%) stddev-sans-first:24.91 10:09:30 INFO - PID 30440 | Values: 74.0 74.0 73.0 148.0 73.0 74.0 73.0 73.0 92.0 73.0 10:09:30 INFO - PID 30440 | 10:09:30 INFO - PID 30440 | [#4] audio-oscillator Cycles:10 Average:96.80 Median:81.00 stddev:23.76 (29.3%) stddev-sans-first:24.59 10:09:30 INFO - PID 30440 | Values: 82.0 84.0 127.0 80.0 81.0 81.0 136.0 86.0 81.0 130.0 10:09:30 INFO - PID 30440 | 10:09:30 INFO - PID 30440 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 10:09:30 INFO - PID 30440 | Values: 113.0 114.0 113.0 114.0 114.0 114.0 115.0 114.0 113.0 114.0 10:09:30 INFO - PID 30440 | 10:09:30 INFO - PID 30440 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 10:09:30 INFO - PID 30440 | Values: 147.0 148.0 148.0 148.0 147.0 146.0 147.0 148.0 148.0 147.0 10:09:30 INFO - PID 30440 | 10:09:30 INFO - PID 30440 | [#7] imaging-desaturate Cycles:10 Average:94.10 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 10:09:30 INFO - PID 30440 | Values: 94.0 95.0 94.0 94.0 94.0 94.0 93.0 94.0 94.0 95.0 10:09:30 INFO - PID 30440 | 10:09:30 INFO - PID 30440 | [#8] json-parse-financial Cycles:10 Average:48.30 Median:48.00 stddev:1.34 (2.8%) stddev-sans-first:1.33 10:09:30 INFO - PID 30440 | Values: 47.0 47.0 51.0 48.0 48.0 47.0 48.0 50.0 49.0 48.0 10:09:30 INFO - PID 30440 | 10:09:30 INFO - PID 30440 | [#9] json-stringify-tinderbox Cycles:10 Average:54.20 Median:54.00 stddev:0.79 (1.5%) stddev-sans-first:0.83 10:09:30 INFO - PID 30440 | Values: 54.0 54.0 54.0 53.0 54.0 56.0 54.0 55.0 54.0 54.0 10:09:30 INFO - PID 30440 | 10:09:30 INFO - PID 30440 | [#10] stanford-crypto-aes Cycles:10 Average:74.70 Median:74.00 stddev:2.36 (3.2%) stddev-sans-first:2.49 10:09:30 INFO - PID 30440 | Values: 74.0 74.0 74.0 73.0 74.0 80.0 78.0 73.0 73.0 74.0 10:09:30 INFO - PID 30440 | 10:09:30 INFO - PID 30440 | [#11] stanford-crypto-ccm Cycles:10 Average:125.60 Median:126.00 stddev:8.66 (6.9%) stddev-sans-first:9.17 10:09:30 INFO - PID 30440 | Values: 127.0 126.0 124.0 119.0 120.0 119.0 128.0 126.0 119.0 148.0 10:09:30 INFO - PID 30440 | 10:09:30 INFO - PID 30440 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.50 Median:175.50 stddev:8.61 (4.9%) stddev-sans-first:9.13 10:09:30 INFO - PID 30440 | Values: 177.0 180.0 177.0 199.0 169.0 171.0 174.0 170.0 174.0 174.0 10:09:30 INFO - PID 30440 | 10:09:30 INFO - PID 30440 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.90 Median:63.50 stddev:3.51 (5.5%) stddev-sans-first:3.40 10:09:30 INFO - PID 30440 | Values: 67.0 64.0 63.0 60.0 60.0 64.0 62.0 60.0 70.0 59.0 10:09:30 INFO - PID 30440 | -------- Summary: end -------- 10:09:30 INFO - PID 30440 | 10:09:30 INFO - TEST-INFO | 30440: exit 0 10:09:31 INFO - TEST-OK | kraken | took 60003ms 10:09:31 INFO - SUITE-END | took 1175s 10:09:31 INFO - Completed test suite (00:19:35) 10:09:31 INFO - javascript benchmark 10:09:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8721.82133829023, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3351.095204294842, 3373.561437013188, 3388.5256064151017, 3445.638207988163, 3454.809985450801, 6144.784932527363, 6196.442320191182, 6262.812115636538, 6287.402696743813, 6294.3705629437145, 6254.687265636711, 6299.937000629992, 6319.905201421994, 6357.268914074883, 6361.777337793178, 5540.919520693466, 5572.0, 5582.162675598652, 5614.29821272341, 5648.971755141219, 5412.56699464042, 5509.338879334466, 5512.366077901032, 5515.586331025189, 5518.061929471999, 5494.230807686927, 5509.449055094498, 5521.944780552183, 5528.668279903179, 5587.776488940478, 5587.664740115565, 5598.1602759586385, 5603.327600687903, 5620.775168993277, 5640.351359593658, 5519.199716041152, 5550.611457197998, 5553.0, 5555.944440555583, 5572.3870374258795, 6225.066240063981, 6304.621722696653, 6309.4636955858805, 6312.43188113072, 6315.0, 6646.202455705346, 6736.932630673728, 6799.320067993211, 6808.6255255960905, 6829.180498340182, 6897.9655101724675, 6910.861782764367, 6913.965430172867, 6918.411934985482, 6919.065926099963, 6283.560150789493, 6349.682515874188, 6356.237251529754, 6367.108604795332, 6418.326075762071, 6856.485763567753, 6974.093367862247, 6978.546394484342, 6980.965095174492, 6988.93011069893, 6649.0026496025985, 6660.83347916306, 6764.72941082361, 6790.219124800711, 6797.762078327235, 6906.136732908387, 6907.067545881342, 6911.067005954233, 6941.167059952838, 6956.513044086865, 6903.482238832007, 6920.342567456084, 6923.965380173167, 6933.68798404073, 6934.653267336613, 6929.757458488929, 6937.132858392701, 6960.199577048705, 6970.059042029363, 6979.30206979298, 5014.07239660664, 5064.5441910228255, 5091.287219789232, 5175.404828444777, 5176.197689358156, 4495.168393847149, 4540.704854184468, 4543.273076307775, 4579.9084018319445, 4598.21830288845, 6401.583897046677, 6425.775097871552, 6428.774992875227, 6442.0, 6482.027695845661, 6919.930800691928, 6925.203601585781, 6940.41006514452, 6950.687219075154, 6979.0, 6246.906296405557, 6364.109024736541, 6425.036244563353, 6439.484841212692, 6446.258680251831, 5695.487406133385, 5725.6850873202375, 5730.885382292331, 5757.107648314518, 5758.481736643722, 7039.190493093258, 7072.08062951813, 7112.57324560528, 7125.35871771543, 7155.964220178866, 6809.0, 6829.760958366433, 6841.008053832067, 6853.451723862178, 6860.622665753232, 7090.858182836418, 7097.361237488651, 7117.288271172842, 7121.323474269936, 7124.964375178091, 6636.701348439428, 6707.262201157966, 6720.227173875067, 6743.629100399525, 6757.189137303555, 6814.93185068143, 6905.689243983932, 6916.688749006206, 6923.446124310144, 6935.930640693528, 6754.493412993947, 6757.695903684247, 6758.932410676027, 6766.120404347404, 6783.59298442095, 6684.565503242468, 6706.362895524917, 6708.228553716385, 6735.764248251287, 6741.2921643226755, 6505.577137486048, 6606.174228221473, 6633.402993730588, 6637.103990961158, 6682.164729408824, 6630.171228596426, 6699.263081060982, 6704.161979752531, 6732.461403087644, 6754.290799465985, 6488.286288508355, 6519.250286217146, 6588.835279117869, 6591.835204119743, 6593.076969224217], "value": 6231.022069763165, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [828.2706820894316, 890.6724087305473, 905.2395987370608, 919.0166521821645, 932.2448816458669, 42670.0, 44169.55830441698, 44215.0, 44215.33676994844, 44412.0, 40264.396034059515, 40298.59701402985, 40605.39091913624, 40764.38853417201, 40787.79606101965, 6758.729650813962, 6774.356436138572, 6823.590584564917, 6862.725490980355, 6898.413634841019, 6437.517186211029, 6446.580972236813, 6514.44627206688, 6515.967420162892, 6528.738850445977, 6505.316941721122, 6533.444657204143, 6538.542302038859, 6542.313057129004, 6546.803595892131, 6475.579087359307, 6490.383413575726, 6502.122213501164, 6503.934960650404, 6525.0, 6148.1699970504305, 6148.477379422754, 6156.076588511714, 6203.689815509207, 6206.844828879269, 34613.480797788055, 34827.825860870784, 34899.302013959576, 34902.30195396103, 34949.301013979835, 3377.9324413511836, 3406.386850366933, 3406.9829650851834, 3470.236547959445, 3549.8580056797696, 32052.519212211835, 32204.838975805204, 32229.194270143198, 32333.0, 32362.676373236438, 3779.1685829117823, 3865.0, 3872.7095467840027, 3874.128321127752, 3909.061825161969, 197054.0, 198230.0, 199213.0, 204945.0, 205731.0, 51252.0, 51337.229941550904, 51395.229071563954, 51855.0, 52040.739796300775, 51523.742381287855, 52516.0, 52583.47416525862, 53029.46970530322, 53178.0, 15440.922795385952, 15613.063216207063, 15701.450449234222, 15716.68566628661, 15748.370065197492, 12819.935900320439, 12876.35618219104, 12900.0, 12904.290264035568, 12934.611961641165, 14542.127472351693, 14570.0, 14583.635409114857, 14591.197484138474, 14635.634109147357, 5742.5544673195745, 5773.24947756789, 5785.09506083392, 5817.767289308465, 5938.346781853993, 1073.7721216941707, 1089.929154604948, 1094.4910616563336, 1115.5705053554277, 1116.7598966222301, 23958.68227247518, 24203.273901782974, 24614.13850515259, 24629.753702462745, 24806.627900581505, 1174.1682974559797, 1186.6595533572965, 1193.731410432663, 1200.33981310279, 1209.5161935225804, 13250.801237981437, 13389.19664820114, 13426.932865335611, 13488.460461581622, 13510.662233444045, 254642.0, 255500.0, 256009.0, 256560.0, 256776.0, 54473.0, 55110.0, 55166.0, 55182.72408638011, 55497.0, 1502.1662977047624, 1507.1333982959843, 1543.8996465229725, 1544.5598004568644, 1554.3316373959306, 24052.639210412206, 24111.39721506906, 24124.75875241225, 24228.0, 24284.392890177885, 53898.0, 54751.72624136854, 55022.72488637691, 55153.448465516434, 55242.72378638081, 233706.0, 234468.0, 235068.0, 237250.0, 237465.0, 34346.48480272848, 34387.96836094921, 34745.826270868485, 35150.29699406049, 37284.81357593195, 44503.554964451236, 44640.77679611581, 44759.77620112009, 45181.77409113065, 46856.7657161712, 30729.231769205948, 32079.0, 32124.83937580297, 32740.422984836583, 33141.17147071342, 32096.358072837946, 32759.67240327566, 33031.66968330382, 33097.0, 33587.83206083954, 38673.41989870098, 39083.80458097691, 39105.41341879817, 39119.80440097781, 39208.21583568255, 30290.394192115593, 30982.69017309798, 31455.0, 31814.840925795223, 32790.0, 24275.0, 24894.50210995734, 25755.424457554094, 26349.20952371432, 26504.469910602067], "value": 17328.868889208457, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [522.8170140450841, 532.6484520216658, 534.8475684429939, 536.2947723743277, 550.2255226893269, 22835.200767973125, 23276.76723232767, 23548.058077676873, 23625.291241262767, 23853.16513922013, 24786.62820057696, 25586.616200757002, 26816.59775103375, 26975.460490790174, 27019.864900675468, 6816.829579260521, 6952.409045231161, 6994.6152961587095, 6995.335443132894, 7001.964990175042, 6922.446204303644, 6970.337817907291, 6971.093757811477, 6976.651167441608, 6984.930150698504, 4523.886902827423, 6858.759943401982, 6908.378245957862, 6935.930640693604, 6946.722131114775, 6923.515353925202, 6945.16658001038, 6948.374646281859, 6951.409130223937, 6958.060661810667, 6795.2185498667795, 6826.795196144124, 6829.385355318045, 6853.828654283633, 6866.656667166621, 30712.232194195323, 32417.0, 32711.836440817882, 32957.67042329594, 32959.340813183844, 2354.3643216331493, 2378.6432035194684, 2383.5232953409213, 2404.0, 2404.4349577849193, 20299.28952486656, 20876.0, 20922.581548368948, 20949.37151885446, 20963.371098867057, 2478.537662778951, 2479.528889510987, 2548.490301939601, 2560.116759717894, 2565.6279839423364, 141118.0, 146578.0, 147272.0, 147441.26279368642, 147549.0, 21623.0, 22650.433739156324, 24413.877930610233, 24551.38621534476, 24973.501589904663, 45281.54718452839, 45348.546514534435, 45534.31698524525, 45574.77212613982, 45644.54355456469, 10896.346219226712, 11287.830682539769, 11378.886211137782, 11456.713582160513, 11483.42582870853, 9092.590833412512, 9179.632814687471, 9227.26181905446, 9272.119148680864, 9332.0, 11522.654320370402, 11976.490814225379, 12089.15375923677, 12136.0, 12157.878421215852, 2508.2224510401834, 2514.333701569086, 2520.6849143857016, 2589.59861221511, 2602.4014476670473, 1019.887812340642, 1028.88682244953, 1031.582209205273, 1044.206403133624, 1107.0, 21482.355529334145, 21603.56792864134, 21615.56768864614, 21832.563348733252, 21960.780392196193, 1062.1184416933927, 1067.8291473364225, 1085.766560189563, 1101.7686285879895, 1125.5047778977387, 13475.595732127857, 14707.632309192142, 14908.925455372872, 14991.475298364505, 15237.390504379922, 595067.0, 618000.0, 630614.0, 637600.0, 642127.0, 122258.38870805589, 125465.37267313787, 126487.0, 127270.0, 127447.0, 1251.6870782304425, 1294.7216348485122, 1311.1412025123368, 1327.9468821247042, 1328.7408955253634, 20919.8954005229, 22332.665010025186, 22698.498282610668, 22819.20132795344, 23314.067437302318, 54282.0, 55586.72206638941, 56629.71685141548, 57220.71389643025, 58941.410585893595, 73954.63022684852, 74018.25981740114, 80125.0, 84386.57806710927, 84499.15500844913, 12412.255264684149, 12745.553905613258, 12748.0, 12773.425195866022, 12782.105252632598, 19095.618087638446, 20361.796382036584, 20442.59114817725, 20783.376498705064, 20826.687599685712, 14753.0, 16486.67026659436, 16553.0, 16649.084300363596, 16708.74936875972, 13904.791428128789, 14360.281985900454, 14468.638284042983, 14774.0, 14774.778378324549, 15393.153376564396, 15429.691406172038, 15469.917105802486, 15563.922180389025, 15566.37734490653, 11807.409629518661, 12474.0, 12494.250344979331, 12509.812352814533, 12523.311217883103, 15968.441104561285, 16660.50018499447, 16740.665186696442, 16764.413245536347, 16991.150442477578], "value": 12793.558768360337, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1409.7603407420738, 1433.3908089062145, 1478.4899209772639, 1496.4463148635, 1500.9324580393884, 14536.491222807204, 15089.094654320748, 15128.0, 15129.848701513009, 15138.77291840622, 14570.198639074846, 14890.181040042793, 15511.379544818223, 15549.766753498707, 15564.766528502054, 2707.6886158091825, 2803.6074949507083, 2808.620836187109, 2813.9728998915452, 2818.365867679766, 2655.548556745358, 2719.809613327058, 2720.5919112133142, 2723.714010028948, 2724.4551089782026, 2625.514279858223, 2657.707652158271, 2723.5914612808037, 2729.3040274729915, 2733.876975536106, 2747.766439852615, 2764.1016669582264, 2781.276868014321, 2788.093869492423, 2790.330320723032, 2641.3528685472183, 2678.2233152385784, 2687.0998215597797, 2699.3386620278156, 2718.184544636601, 14176.149431034068, 14418.783718244234, 14490.710185796224, 14504.70990580193, 14523.564293071118, 8170.550619715913, 8292.0, 8295.917040829574, 8403.495790252604, 8430.156984301582, 4669.322948172496, 4752.904941901143, 4773.615651461072, 4821.180399332122, 4869.732164730938, 1519.5213507745025, 1544.6447317117127, 1550.71311807316, 1558.3637180959947, 1567.8197007344074, 24962.50074998508, 25376.619350709752, 25383.111591094224, 25480.49039019209, 25506.74493255081, 7151.2491188424465, 7277.781666549906, 7368.4842061055215, 7448.068991376078, 7478.813029674302, 19640.70538941917, 19656.115474803668, 19671.60656786885, 19700.21199152018, 19729.506762331057, 8264.917350826536, 8363.623636936352, 8368.497890126611, 8437.409381343246, 8446.788830279293, 7425.554466732014, 7573.6213189340315, 7604.429667774939, 7618.657160427794, 7645.617719114022, 5628.971855140698, 5747.6838773867, 5783.884322313615, 6031.336552979169, 6157.7229024694, 1765.7969333526553, 1791.2208189437636, 1802.0359107877223, 1836.531684420491, 1870.672632289344, 917.2616044084576, 919.296737995434, 924.9445033298024, 943.3820847345, 943.7357539888842, 7850.097238817495, 7928.3260922821055, 7933.087694915159, 8031.598420078973, 8105.27052565272, 725.4957804325943, 734.566605702638, 759.5822297736223, 761.2691815856839, 766.5170942306312, 4765.928511072337, 5393.541548968382, 5658.943410565924, 5733.31200255972, 5842.707864606753, 20298.898505507674, 20321.593568128555, 20537.2811951581, 20757.065932033096, 21125.89437052805, 20478.590428191354, 20667.793322066587, 20709.27517536909, 20816.895915520327, 21044.263450779148, 10613.628523001658, 10739.409332486632, 10748.355098694103, 11088.667339979813, 11119.944400277947, 8089.110197878111, 8799.648014079621, 8932.508712020901, 9104.90741111071, 9147.313951453802, 17150.485485435456, 17463.214155362784, 17976.0, 18025.0, 18036.098195090457, 18472.168752406444, 18811.623767524845, 18881.244750209837, 18931.71602425937, 19066.23735050638, 11582.131340149692, 12084.516619335129, 12373.75252494963, 12374.690632734253, 12566.874331256937, 13902.582922512342, 13912.095713778572, 14059.437622494986, 14099.788503172666, 14110.858891411364, 9626.181774549243, 10801.189910756882, 11171.162162837658, 11266.0, 11800.350980696145, 9843.704688859345, 10487.0, 10804.0, 10955.233133680566, 11192.496337664661, 10167.7458063549, 10206.438645874548, 10212.387256764618, 10237.23220758461, 10275.486225688535, 7561.508501947355, 7716.5755883426955, 7783.143854176149, 7816.7264145754625, 7864.21357864209, 7529.360004399688, 7586.48270345922, 7615.086189657277, 7624.8475030500185, 7692.42306826979], "value": 6703.12233957834, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [483.9637027222959, 492.1141944499902, 496.81121173953903, 501.76667849449973, 506.83781190019187, 6166.753329866806, 6192.78325258616, 6301.1808464899495, 6312.842178945529, 6335.429811316981, 6173.444390004899, 6204.813855584329, 6234.968825155879, 6238.220222472191, 6239.563230573862, 4854.417469903598, 4894.412670479547, 4896.77964491597, 4904.8528544143555, 4908.410990681124, 4902.730349830758, 4919.483454237307, 4920.458749537548, 4922.26166075088, 4924.655274130794, 4622.86131416058, 4780.450248221464, 4783.521647835206, 4823.517648235166, 4907.8773030674165, 4765.380500534943, 4773.498782627808, 4774.40319960005, 4811.374521312225, 4819.180739274332, 4279.593438623326, 4298.656107511391, 4300.268954277781, 4308.547602501723, 4322.697411181219, 6126.448619624255, 6131.049687298476, 6147.508199344042, 6160.722767475474, 6195.96902015487, 5737.971310143423, 5737.995850726106, 5752.913706294409, 5765.827025189209, 5786.797462088806, 6643.800685979429, 6648.772661158518, 6657.600543967329, 6667.466602671823, 6716.462682985399, 4882.633802464829, 4894.583960363373, 4895.730734809584, 4899.216125419915, 4923.384576927884, 6727.29363416844, 6976.0, 7001.159860816683, 7001.509894307401, 7114.893276600855, 4789.521047895182, 4973.42805577356, 4992.675476094042, 5006.499350064964, 5016.824411145665, 5071.41678706946, 5080.212567052113, 5084.0, 5092.745362731923, 5100.591952643779, 5690.857728556819, 5692.943070569324, 5703.144528320785, 5703.486686198262, 5735.971320143456, 6637.269900310962, 6643.202815662152, 6656.334366563305, 6672.666366681647, 6682.63245521501, 1744.6249056452923, 1764.4353806781962, 1766.920488578017, 1768.0982698823693, 1776.2539733311783, 1160.6808127764764, 1204.3195594489086, 1223.2110288863632, 1232.796588562877, 1242.6520574239228, 6256.968715156395, 6279.937200628026, 6290.874182516415, 6297.622142671455, 6316.0, 6743.730250789913, 6790.660466976631, 6805.829854253683, 6822.181338239344, 6823.522353435311, 6268.811935641938, 6271.78048768291, 6285.402886725754, 6290.528210384239, 6329.461995730322, 3601.7838929664304, 3616.222512159846, 3628.963710362915, 3634.236810269873, 3635.4551813730495, 7067.964660176769, 7072.823179420556, 7103.721330160517, 7106.822329441805, 7131.679074441558, 6974.79075627732, 6980.057692211588, 6983.127109111361, 6990.965045174843, 7018.894716579255, 7054.823629409203, 7069.157627025504, 7093.219745827955, 7121.786346409616, 7140.428765698732, 6812.761553345609, 6871.244163141951, 6872.793816185523, 6876.69054892541, 6895.55178913369, 6073.726682299219, 6778.152730908637, 6789.72841086351, 6790.45676345901, 6806.0, 7059.858802823812, 7063.470239731938, 7075.646217688992, 7093.397061249645, 7140.714371425085, 5018.924716129334, 5025.748712564284, 5035.169197082587, 5041.546260836542, 5043.142665746906, 6557.901631475436, 6739.326067393222, 6799.626020568916, 6899.793006209822, 6907.758228461979, 6493.155889734304, 6595.505337099641, 6605.636689982097, 6623.138991931018, 6641.833954151185, 6619.569727967667, 6629.0, 6632.900506492503, 6637.137172167781, 6681.365270299314, 6533.836654083686, 6574.975511264872, 6598.934010659832, 6627.668616569249, 6695.464362851058, 6584.432071492026, 6663.866722665616, 6678.098456708282, 6679.899801503078, 6700.894352431989, 6430.295971567445, 6461.903071453838, 6492.0, 6515.869682606416, 6530.346965303432], "value": 5126.65281009873, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [855.1363123245524, 879.4283715584869, 882.2236431939892, 889.6263569300893, 910.8178364327136, 18350.265989360425, 18421.999999999967, 18692.25230990762, 18805.905970470147, 18907.0, 15834.683306333895, 15903.84096159038, 15932.52202433926, 16410.917945410285, 19865.900670496627, 1010.1968934696915, 1023.4780262066363, 1028.4497793680382, 1033.3231733214718, 1034.7413146713322, 1084.322298563398, 1098.34099540276, 1099.2689861242304, 1100.5872797700863, 1101.895319944608, 1133.0652211925153, 1134.6482590396963, 1135.4549816088283, 1137.9829302560468, 1142.3260276436902, 1055.862737844083, 1105.1214284643647, 1123.33723103369, 1133.3766428464353, 1133.9206255562115, 815.6696537902159, 817.8282560662268, 819.7212947597786, 823.5264722784423, 824.6866190847439, 17276.56808579783, 17325.826741732548, 17329.48011559655, 17378.65242695139, 17418.651626967516, 19541.316053938186, 20396.490087747778, 20612.896935515375, 20639.380818575468, 20690.896545517175, 14096.92951535246, 14517.274136293248, 14534.491292804807, 14674.926625366912, 14727.631809204748, 3366.764326497146, 3369.9157521061925, 3408.7784294020807, 3416.0605833395766, 3423.6062852772, 112802.0, 113933.43033284863, 114885.42557287244, 116107.0, 118916.0, 14440.927795361165, 15164.317605707769, 15243.0, 15571.299291531908, 15759.29083191259, 28895.0, 28969.855150724532, 29266.561001584992, 29292.0, 30114.24714382158, 8063.637136328879, 8211.260986511123, 8212.17878212186, 8217.383696222807, 8277.130901255281, 3841.9818748031794, 3945.191235796655, 3952.565217826037, 3956.940645890314, 3963.623455771697, 5062.0, 5258.158694608845, 5269.499397557226, 5319.946800531945, 5321.973390133025, 981.2738573455591, 1011.5448048378112, 1013.2350075692805, 1016.8169729448771, 1022.4632068164274, 729.7628270812007, 731.129955353128, 733.6478490324674, 734.6510407556368, 757.1822431773782, 12100.33448160342, 12445.0, 12528.123031387715, 12730.299833509062, 12773.425195866208, 713.8822094354477, 722.7795522365728, 729.5513259345464, 733.8018734941536, 736.6574542837607, 5604.747786349542, 5622.0, 5835.328937172195, 5871.706414679335, 5992.940070599326, 117740.41129794296, 118060.40969795268, 120634.0, 120690.0, 125540.37229813976, 100396.49801750944, 100519.0, 101931.0, 102992.0, 106634.46682766537, 84000.57999710085, 90768.54615727012, 92542.0, 92712.0, 94412.0, 12605.43275552584, 13461.326933653083, 13915.860841391457, 14025.5091071812, 14599.270036498345, 41682.16635667209, 42735.57264427316, 43487.56512434835, 44879.0, 44980.77509612431, 60091.0, 60178.0, 78154.6092269535, 81040.59479702564, 81100.59449702714, 19091.713624295367, 19286.13212405417, 19715.802841971396, 19904.104315306136, 20419.4895127623, 21710.0, 22285.331440056823, 22436.77563224347, 22707.318780436613, 22745.431364216027, 20202.494937626678, 20324.085416156013, 20750.896245518677, 20898.58202835965, 20899.0, 19614.651788690237, 20195.495112621713, 20249.69625455649, 20439.693404598645, 20439.693404599242, 17399.30402783925, 18209.362672306404, 18338.908305458386, 18391.90804045971, 20472.897635511727, 13046.0, 13206.339683016004, 13530.323483825967, 13788.690074442911, 13964.930175349464, 14244.618688508299, 14300.427982880568, 15157.924210378878, 16510.587235319214, 16542.255598498337], "value": 9272.245299939093, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1483.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 105.0, 107.0, 105.0, 106.0, 108.0, 112.0, 107.0, 107.0, 108.0], "value": 106.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 114.0, 141.0, 155.0, 121.0, 144.0, 154.0, 116.0, 168.0, 115.0], "value": 137.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 161.0, 161.0, 169.0, 163.0, 162.0, 164.0, 167.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 73.0, 148.0, 73.0, 74.0, 73.0, 73.0, 92.0, 73.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 127.0, 80.0, 81.0, 81.0, 136.0, 86.0, 81.0, 130.0], "value": 96.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 114.0, 114.0, 114.0, 115.0, 114.0, 113.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 148.0, 147.0, 146.0, 147.0, 148.0, 148.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 95.0], "value": 94.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 47.0, 51.0, 48.0, 48.0, 47.0, 48.0, 50.0, 49.0, 48.0], "value": 48.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 53.0, 54.0, 56.0, 54.0, 55.0, 54.0, 54.0], "value": 54.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 73.0, 74.0, 80.0, 78.0, 73.0, 73.0, 74.0], "value": 74.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 126.0, 124.0, 119.0, 120.0, 119.0, 128.0, 126.0, 119.0, 148.0], "value": 125.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 180.0, 177.0, 199.0, 169.0, 171.0, 174.0, 170.0, 174.0, 174.0], "value": 176.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 64.0, 63.0, 60.0, 60.0, 64.0, 62.0, 60.0, 70.0, 59.0], "value": 62.9, "unit": "score"}]}]} 10:09:31 INFO - Return code: 0 10:09:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:09:31 INFO - # TBPL SUCCESS # 10:09:31 INFO - Running post-action listener: _resource_record_post_action 10:09:31 INFO - [mozharness: 2017-06-25 17:09:31.569715Z] Finished run-tests step (success) 10:09:31 INFO - Running post-run listener: _resource_record_post_run 10:09:31 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 431824896; Read time: 12; Write time: 276960 10:09:31 INFO - TinderboxPrint: CPU usage
13.1% 10:09:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 10:09:31 INFO - TinderboxPrint: I/O write bytes / time
431,824,896 / 276,960 10:09:31 INFO - TinderboxPrint: CPU idle
8,272.9 (86.9%) 10:09:31 INFO - TinderboxPrint: CPU user
1,198.4 (12.6%) 10:09:31 INFO - TinderboxPrint: Swap in / out
0 / 0 10:09:31 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106651648; Read time: 0; Write time: 82128 10:09:31 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 10:09:31 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 325173248; Read time: 0; Write time: 194832 10:09:32 INFO - Running post-run listener: _upload_blobber_files 10:09:32 INFO - Blob upload gear active. 10:09:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:09:32 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 10:09:32 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'] 10:09:32 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 10:09:32 INFO - (blobuploader) - INFO - Open directory for files ... 10:09:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:09:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:09:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:09:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:09:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:09:36 INFO - (blobuploader) - INFO - Done attempting. 10:09:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:09:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:09:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:09:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:09:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:09:37 INFO - (blobuploader) - INFO - Done attempting. 10:09:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:09:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:09:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:09:38 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:09:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:09:38 INFO - (blobuploader) - INFO - Done attempting. 10:09:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:09:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:09:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:09:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:09:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:09:38 INFO - (blobuploader) - INFO - Done attempting. 10:09:38 INFO - (blobuploader) - INFO - Iteration through files over. 10:09:38 INFO - Return code: 0 10:09:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:09:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:09:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3b907c149f5a8090ab26d139ec55c3db8195c18b50acbff7489ca84f923b0a41e36e5d8389194da37c2754bf7cdfc2608c234ef96481567ded026d198b5801a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9b30b6b39a69887f0b0340782e93cd1703b7d36d68b84dfd681bf7d434c3e78ad64b67653dcf3131a1229b08520b7d96502c7be57bdf6de3c32335c805b8cba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47dafc1cd3ecbf357005c79c83eeb580ef0096a297afa132aa37ec3effbacc28059e0449ab73ba2a13056583417f6e17ece45c2a8dcfb3a5b81240949fb45e7d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49a2b575b00de101261b1a5ddb468043cf46fc8a70e370c6b9a89b18e7ff0671d0585ea8c4d0f6ebeeb9f3a1e0945f626ce2a3136373e9639370aa26f5491dbb"} 10:09:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:09:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:09:38 INFO - Contents: 10:09:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3b907c149f5a8090ab26d139ec55c3db8195c18b50acbff7489ca84f923b0a41e36e5d8389194da37c2754bf7cdfc2608c234ef96481567ded026d198b5801a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9b30b6b39a69887f0b0340782e93cd1703b7d36d68b84dfd681bf7d434c3e78ad64b67653dcf3131a1229b08520b7d96502c7be57bdf6de3c32335c805b8cba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47dafc1cd3ecbf357005c79c83eeb580ef0096a297afa132aa37ec3effbacc28059e0449ab73ba2a13056583417f6e17ece45c2a8dcfb3a5b81240949fb45e7d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49a2b575b00de101261b1a5ddb468043cf46fc8a70e370c6b9a89b18e7ff0671d0585ea8c4d0f6ebeeb9f3a1e0945f626ce2a3136373e9639370aa26f5491dbb"} 10:09:38 INFO - Running post-run listener: copy_logs_to_upload_dir 10:09:38 INFO - Copying logs to upload dir... 10:09:38 INFO - mkdir: /builds/slave/test/build/upload/logs 10:09:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.330531 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2017-06-25 10:09:38.184999) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-25 10:09:38.192000) ========= 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=51fc86400edbde9650d2781a000001d0-1498389334.749262-625243051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3b907c149f5a8090ab26d139ec55c3db8195c18b50acbff7489ca84f923b0a41e36e5d8389194da37c2754bf7cdfc2608c234ef96481567ded026d198b5801a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9b30b6b39a69887f0b0340782e93cd1703b7d36d68b84dfd681bf7d434c3e78ad64b67653dcf3131a1229b08520b7d96502c7be57bdf6de3c32335c805b8cba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47dafc1cd3ecbf357005c79c83eeb580ef0096a297afa132aa37ec3effbacc28059e0449ab73ba2a13056583417f6e17ece45c2a8dcfb3a5b81240949fb45e7d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49a2b575b00de101261b1a5ddb468043cf46fc8a70e370c6b9a89b18e7ff0671d0585ea8c4d0f6ebeeb9f3a1e0945f626ce2a3136373e9639370aa26f5491dbb"} build_url:https://queue.taskcluster.net/v1/task/El7EscZXQ1uK6wyAw0q7oQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011249 build_url: 'https://queue.taskcluster.net/v1/task/El7EscZXQ1uK6wyAw0q7oQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e3b907c149f5a8090ab26d139ec55c3db8195c18b50acbff7489ca84f923b0a41e36e5d8389194da37c2754bf7cdfc2608c234ef96481567ded026d198b5801a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e9b30b6b39a69887f0b0340782e93cd1703b7d36d68b84dfd681bf7d434c3e78ad64b67653dcf3131a1229b08520b7d96502c7be57bdf6de3c32335c805b8cba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/47dafc1cd3ecbf357005c79c83eeb580ef0096a297afa132aa37ec3effbacc28059e0449ab73ba2a13056583417f6e17ece45c2a8dcfb3a5b81240949fb45e7d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49a2b575b00de101261b1a5ddb468043cf46fc8a70e370c6b9a89b18e7ff0671d0585ea8c4d0f6ebeeb9f3a1e0945f626ce2a3136373e9639370aa26f5491dbb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-25 10:09:38.215408) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-25 10:09:38.219776) ========= 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=51fc86400edbde9650d2781a000001d0-1498389334.749262-625243051 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004376 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-25 10:09:38.299289) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-25 10:09:38.301641) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-25 10:09:38.301933) ========= ========= Total master_lag: 0.21 =========