builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-036 starttime: 1498194040.13 results: success (0) revision: 7455c74d833a9db4e02be17eda14588c7ef0de76 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-22 22:00:40.128579) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-22 22:00:40.129929) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-22 22:00:40.130651) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-22 22:00:40.148042) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-22 22:00:40.148725) ========= 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=14ef55db36f7623abb31b9cf000001d5-1498194038.511534-101350444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-22 22:00:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 25.4M=0s 2017-06-22 22:00:40 (25.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125745 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-22 22:00:40.293775) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-22 22:00:40.294615) ========= 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=14ef55db36f7623abb31b9cf000001d5-1498194038.511534-101350444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016985 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-22 22:00:40.348327) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-22 22:00:40.349093) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7455c74d833a9db4e02be17eda14588c7ef0de76 --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 7455c74d833a9db4e02be17eda14588c7ef0de76 --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=14ef55db36f7623abb31b9cf000001d5-1498194038.511534-101350444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-22 22:00:40,487 truncating revision to first 12 chars 2017-06-22 22:00:40,487 Setting DEBUG logging. 2017-06-22 22:00:40,487 attempt 1/10 2017-06-22 22:00:40,487 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7455c74d833a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-22 22:00:40,786 unpacking tar archive at: mozilla-central-7455c74d833a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.619098 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-22 22:00:40.982549) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-22 22:00:40.982893) ========= script_repo_revision: 7455c74d833a9db4e02be17eda14588c7ef0de76 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-22 22:00:40.983317) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-22 22:00:40.983634) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-22 22:00:40.992718) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-06-22 22:00:40.993015) ========= /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=14ef55db36f7623abb31b9cf000001d5-1498194038.511534-101350444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:00:41 INFO - MultiFileLogger online at 20170622 22:00:41 in /builds/slave/test 22:00:41 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 22:00:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:00:41 INFO - {'append_to_log': False, 22:00:41 INFO - 'base_work_dir': '/builds/slave/test', 22:00:41 INFO - 'blob_upload_branch': 'Firefox', 22:00:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:00:41 INFO - 'branch': 'Firefox', 22:00:41 INFO - 'buildbot_json_path': 'buildprops.json', 22:00:41 INFO - 'config_files': ('talos/linux_config.py',), 22:00:41 INFO - 'default_actions': ('clobber', 22:00:41 INFO - 'read-buildbot-config', 22:00:41 INFO - 'download-and-extract', 22:00:41 INFO - 'populate-webroot', 22:00:41 INFO - 'create-virtualenv', 22:00:41 INFO - 'install', 22:00:41 INFO - 'setup-mitmproxy', 22:00:41 INFO - 'run-tests'), 22:00:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:00:41 INFO - 'download_minidump_stackwalk': True, 22:00:41 INFO - 'download_symbols': 'ondemand', 22:00:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:00:41 INFO - 'tooltool.py': '/tools/tooltool.py', 22:00:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:00:41 INFO - '/tools/misc-python/virtualenv.py')}, 22:00:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:00:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:00:41 INFO - 'gecko_profile': False, 22:00:41 INFO - 'gecko_profile_interval': 0, 22:00:41 INFO - 'installer_path': 'installer.exe', 22:00:41 INFO - 'log_level': 'info', 22:00:41 INFO - 'log_name': 'talos', 22:00:41 INFO - 'log_to_console': True, 22:00:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:00:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:00:41 INFO - 'opt_config_files': (), 22:00:41 INFO - 'pip_index': False, 22:00:41 INFO - 'suite': 'dromaeojs-e10s', 22:00:41 INFO - 'system_bits': '32', 22:00:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:00:41 INFO - 'title': 'talos-linux64-ix-036', 22:00:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:00:41 INFO - 'use_talos_json': True, 22:00:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:00:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:00:41 INFO - 'work_dir': 'build'} 22:00:41 INFO - [mozharness: 2017-06-23 05:00:41.233291Z] Running clobber step. 22:00:41 INFO - Running pre-action listener: _resource_record_pre_action 22:00:41 INFO - Running main action method: clobber 22:00:41 INFO - rmtree: /builds/slave/test/build 22:00:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:00:42 INFO - Running post-action listener: _resource_record_post_action 22:00:42 INFO - [mozharness: 2017-06-23 05:00:42.287054Z] Finished clobber step (success) 22:00:42 INFO - [mozharness: 2017-06-23 05:00:42.287153Z] Running read-buildbot-config step. 22:00:42 INFO - Running pre-action listener: _resource_record_pre_action 22:00:42 INFO - Running main action method: read_buildbot_config 22:00:42 INFO - Using buildbot properties: 22:00:42 INFO - { 22:00:42 INFO - "project": "", 22:00:42 INFO - "product": "firefox", 22:00:42 INFO - "who": "philringnalda@gmail.com", 22:00:42 INFO - "installer_path": "public/build/target.tar.bz2", 22:00:42 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 22:00:42 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 22:00:42 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 22:00:42 INFO - "stage_platform": "linux64-pgo", 22:00:42 INFO - "basedir": "/builds/slave/test", 22:00:42 INFO - "buildnumber": 28, 22:00:42 INFO - "platform": "ubuntu64_hw", 22:00:42 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:00:42 INFO - "slavebuilddir": "test", 22:00:42 INFO - "taskId": "fYfjuTwKREuR2-FbnR1pZg", 22:00:42 INFO - "branch": "mozilla-central", 22:00:42 INFO - "script_repo_revision": "production", 22:00:42 INFO - "revision": "7455c74d833a9db4e02be17eda14588c7ef0de76", 22:00:42 INFO - "slavename": "talos-linux64-ix-036", 22:00:42 INFO - "repo_path": "mozilla-central" 22:00:42 INFO - } 22:00:42 INFO - Finding installer, test and symbols from parent task. 22:00:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fYfjuTwKREuR2-FbnR1pZg'}, attempt #1 22:00:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fYfjuTwKREuR2-FbnR1pZg'}, attempt #1 22:00:43 INFO - Task dependencies: baktnaa2RvObUaWwfN7tLg 22:00:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/baktnaa2RvObUaWwfN7tLg'}, attempt #1 22:00:43 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/baktnaa2RvObUaWwfN7tLg/artifacts/public/build/target.tar.bz2 22:00:43 INFO - Set test_url: https://queue.taskcluster.net/v1/task/baktnaa2RvObUaWwfN7tLg/artifacts/public/build/test_packages.json 22:00:43 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/baktnaa2RvObUaWwfN7tLg/artifacts/public/build/target.crashreporter-symbols.zip 22:00:43 INFO - Running post-action listener: _resource_record_post_action 22:00:43 INFO - [mozharness: 2017-06-23 05:00:43.638127Z] Finished read-buildbot-config step (success) 22:00:43 INFO - [mozharness: 2017-06-23 05:00:43.638345Z] Running download-and-extract step. 22:00:43 INFO - Running pre-action listener: _resource_record_pre_action 22:00:43 INFO - Running main action method: download_and_extract 22:00:43 INFO - mkdir: /builds/slave/test/build/tests 22:00:43 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')]} 22:00:43 INFO - trying https://queue.taskcluster.net/v1/task/baktnaa2RvObUaWwfN7tLg/artifacts/public/build/target.test_packages.json 22:00:43 INFO - Downloading https://queue.taskcluster.net/v1/task/baktnaa2RvObUaWwfN7tLg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 22:00:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/baktnaa2RvObUaWwfN7tLg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 22:00:44 INFO - Downloaded 989 bytes. 22:00:44 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 22:00:44 INFO - Using the following test package requirements: 22:00:44 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 22:00:44 INFO - u'common': [u'target.common.tests.zip'], 22:00:44 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 22:00:44 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 22:00:44 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 22:00:44 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 22:00:44 INFO - u'mozbase': [u'target.common.tests.zip'], 22:00:44 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 22:00:44 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 22:00:44 INFO - u'web-platform': [u'target.common.tests.zip', 22:00:44 INFO - u'target.web-platform.tests.tar.gz'], 22:00:44 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 22:00:44 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 22:00:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/baktnaa2RvObUaWwfN7tLg/artifacts/public/build/target.common.tests.zip 22:00:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/baktnaa2RvObUaWwfN7tLg/artifacts/public/build/target.common.tests.zip'}, attempt #1 22:00:44 INFO - Fetch https://queue.taskcluster.net/v1/task/baktnaa2RvObUaWwfN7tLg/artifacts/public/build/target.common.tests.zip into memory 22:00:45 INFO - Content-Length response header: 68593822 22:00:45 INFO - Bytes received: 68593822 22:00:56 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 22:00:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/baktnaa2RvObUaWwfN7tLg/artifacts/public/build/target.common.tests.zip 22:00:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/baktnaa2RvObUaWwfN7tLg/artifacts/public/build/target.common.tests.zip'}, attempt #1 22:00:56 INFO - Fetch https://queue.taskcluster.net/v1/task/baktnaa2RvObUaWwfN7tLg/artifacts/public/build/target.common.tests.zip into memory 22:00:57 INFO - Content-Length response header: 68593822 22:00:57 INFO - Bytes received: 68593822 22:01:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/baktnaa2RvObUaWwfN7tLg/artifacts/public/build/target.talos.tests.zip 22:01:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/baktnaa2RvObUaWwfN7tLg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 22:01:11 INFO - Fetch https://queue.taskcluster.net/v1/task/baktnaa2RvObUaWwfN7tLg/artifacts/public/build/target.talos.tests.zip into memory 22:01:12 INFO - Content-Length response header: 14441306 22:01:12 INFO - Bytes received: 14441306 22:01:12 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')]} 22:01:12 INFO - trying https://queue.taskcluster.net/v1/task/baktnaa2RvObUaWwfN7tLg/artifacts/public/build/target.tar.bz2 22:01:12 INFO - Downloading https://queue.taskcluster.net/v1/task/baktnaa2RvObUaWwfN7tLg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 22:01:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/baktnaa2RvObUaWwfN7tLg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 22:01:13 INFO - Downloaded 62677222 bytes. 22:01:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/baktnaa2RvObUaWwfN7tLg/artifacts/public/build/target.tar.bz2 22:01:13 INFO - mkdir: /builds/slave/test/properties 22:01:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:01:13 INFO - Writing to file /builds/slave/test/properties/build_url 22:01:13 INFO - Contents: 22:01:13 INFO - build_url:https://queue.taskcluster.net/v1/task/baktnaa2RvObUaWwfN7tLg/artifacts/public/build/target.tar.bz2 22:01:13 INFO - Running post-action listener: _resource_record_post_action 22:01:13 INFO - Running post-action listener: set_extra_try_arguments 22:01:13 INFO - [mozharness: 2017-06-23 05:01:13.925139Z] Finished download-and-extract step (success) 22:01:13 INFO - [mozharness: 2017-06-23 05:01:13.925235Z] Running populate-webroot step. 22:01:13 INFO - Running pre-action listener: _resource_record_pre_action 22:01:13 INFO - Running main action method: populate_webroot 22:01:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:01:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:01:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:01:13 INFO - '--tppagecycles', 22:01:13 INFO - '7'], 22:01:13 INFO - 'tests': ['tsvgm']}}, 22:01:13 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:01:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:01:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:01:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:01:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 22:01:13 INFO - 'talos_options': ['--disable-e10s'], 22:01:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:01:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 22:01:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:01:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 22:01:13 INFO - 'talos_options': ['--disable-e10s'], 22:01:13 INFO - 'tests': ['damp', 'tps']}, 22:01:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 22:01:13 INFO - 'tests': ['damp', 'tps']}, 22:01:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:01:13 INFO - 'tests': ['dromaeo_dom']}, 22:01:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:01:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:01:13 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 22:01:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 22:01:13 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 22:01:13 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 22:01:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:01:13 INFO - 'tests': ['a11yr', 22:01:13 INFO - 'ts_paint', 22:01:13 INFO - 'tpaint', 22:01:13 INFO - 'sessionrestore', 22:01:13 INFO - 'sessionrestore_no_auto_restore', 22:01:13 INFO - 'tabpaint']}, 22:01:13 INFO - 'other-e10s': {'tests': ['a11yr', 22:01:13 INFO - 'ts_paint', 22:01:13 INFO - 'tpaint', 22:01:13 INFO - 'sessionrestore', 22:01:13 INFO - 'sessionrestore_no_auto_restore', 22:01:13 INFO - 'tabpaint']}, 22:01:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:01:13 INFO - 'ts_paint', 22:01:13 INFO - 'tpaint', 22:01:13 INFO - 'sessionrestore', 22:01:13 INFO - 'sessionrestore_no_auto_restore', 22:01:13 INFO - 'tabpaint']}, 22:01:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:01:13 INFO - 'ts_paint', 22:01:13 INFO - 'tpaint', 22:01:13 INFO - 'sessionrestore', 22:01:13 INFO - 'sessionrestore_no_auto_restore', 22:01:13 INFO - 'tabpaint']}, 22:01:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:01:13 INFO - 'tests': ['a11yr', 22:01:13 INFO - 'ts_paint', 22:01:13 INFO - 'tpaint', 22:01:13 INFO - 'sessionrestore', 22:01:13 INFO - 'sessionrestore_no_auto_restore', 22:01:13 INFO - 'tabpaint']}, 22:01:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:01:13 INFO - 'tests': ['a11yr', 22:01:13 INFO - 'ts_paint', 22:01:13 INFO - 'tpaint', 22:01:13 INFO - 'sessionrestore', 22:01:13 INFO - 'sessionrestore_no_auto_restore', 22:01:13 INFO - 'tabpaint']}, 22:01:13 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 22:01:13 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 22:01:13 INFO - 'bloom_basic_ref']}, 22:01:13 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 22:01:13 INFO - 'talos_options': ['--mitmproxy', 22:01:13 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 22:01:13 INFO - '--firstNonBlankPaint'], 22:01:13 INFO - 'tests': ['quantum_pageload_google', 22:01:13 INFO - 'quantum_pageload_youtube', 22:01:13 INFO - 'quantum_pageload_amazon', 22:01:13 INFO - 'quantum_pageload_facebook']}, 22:01:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:01:13 INFO - 'tests': ['tsvgx', 22:01:13 INFO - 'tsvgr_opacity', 22:01:13 INFO - 'tart', 22:01:13 INFO - 'tscrollx', 22:01:13 INFO - 'cart', 22:01:13 INFO - 'tsvg_static']}, 22:01:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:01:13 INFO - 'tsvgr_opacity', 22:01:13 INFO - 'tart', 22:01:13 INFO - 'tscrollx', 22:01:13 INFO - 'cart', 22:01:13 INFO - 'tsvg_static']}, 22:01:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 22:01:13 INFO - 'talos_options': ['--disable-e10s'], 22:01:13 INFO - 'tests': ['tp5o']}, 22:01:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 22:01:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 22:01:13 INFO - 'talos_options': ['--disable-e10s', 22:01:13 INFO - '--xperf_path', 22:01:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:01:13 INFO - 'tests': ['tp5n']}, 22:01:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 22:01:13 INFO - 'talos_options': ['--xperf_path', 22:01:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:01:13 INFO - 'tests': ['tp5n']}}, 22:01:13 INFO - 'talos.zip': {'path': '', 22:01:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:01:13 INFO - Running post-action listener: _resource_record_post_action 22:01:13 INFO - [mozharness: 2017-06-23 05:01:13.939967Z] Finished populate-webroot step (success) 22:01:13 INFO - [mozharness: 2017-06-23 05:01:13.940057Z] Running create-virtualenv step. 22:01:13 INFO - Running pre-action listener: _resource_record_pre_action 22:01:13 INFO - Running main action method: create_virtualenv 22:01:13 INFO - Creating virtualenv /builds/slave/test/build/venv 22:01:13 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 22:01:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:01:13 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 22:01:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:01:14 INFO - Using real prefix '/usr' 22:01:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:01:14 INFO - Installing distribute.............................................................................................................................................................................................done. 22:01:16 INFO - Installing pip.................done. 22:01:16 INFO - Return code: 0 22:01:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 22:01:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 22:01:16 INFO - Reading from file tmpfile_stdout 22:01:16 INFO - Output received: 22:01:16 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) 22:01:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:01: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')]} 22:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01: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')]} 22:01:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd33b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21519a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214f140>, '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 0x214fa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214fed0>, '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': '14ef55db36f7623abb31b9cf000001d5-1498194038.511534-101350444', '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 22:01:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:01:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:01:16 INFO - Using env: {'DISPLAY': ':0', 22:01:16 INFO - 'HOME': '/home/cltbld', 22:01:16 INFO - 'LANG': 'en_US.UTF-8', 22:01:16 INFO - 'LANGUAGE': 'en_US:en', 22:01:16 INFO - 'LOGNAME': 'cltbld', 22:01:16 INFO - 'MAIL': '/var/mail/cltbld', 22:01:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:16 INFO - 'MOZ_NO_REMOTE': '1', 22:01:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:16 INFO - 'NO_EM_RESTART': '1', 22:01:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:16 INFO - 'PWD': '/builds/slave/test', 22:01:16 INFO - 'SHELL': '/bin/bash', 22:01:16 INFO - 'SHLVL': '1', 22:01:16 INFO - 'TERM': 'linux', 22:01:16 INFO - 'TMOUT': '86400', 22:01:16 INFO - 'USER': 'cltbld', 22:01:16 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1498194038.511534-101350444', 22:01:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:16 INFO - '_': '/tools/buildbot/bin/python'} 22:01:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:16 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 22:01:16 INFO - Cleaning up... 22:01:16 INFO - Return code: 0 22:01:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:01: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')]} 22:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01: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')]} 22:01:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1dd33b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21519a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214f140>, '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 0x214fa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214fed0>, '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': '14ef55db36f7623abb31b9cf000001d5-1498194038.511534-101350444', '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 22:01:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 22:01:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 22:01:16 INFO - Using env: {'DISPLAY': ':0', 22:01:16 INFO - 'HOME': '/home/cltbld', 22:01:16 INFO - 'LANG': 'en_US.UTF-8', 22:01:16 INFO - 'LANGUAGE': 'en_US:en', 22:01:16 INFO - 'LOGNAME': 'cltbld', 22:01:16 INFO - 'MAIL': '/var/mail/cltbld', 22:01:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:16 INFO - 'MOZ_NO_REMOTE': '1', 22:01:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:16 INFO - 'NO_EM_RESTART': '1', 22:01:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:16 INFO - 'PWD': '/builds/slave/test', 22:01:16 INFO - 'SHELL': '/bin/bash', 22:01:16 INFO - 'SHLVL': '1', 22:01:16 INFO - 'TERM': 'linux', 22:01:16 INFO - 'TMOUT': '86400', 22:01:16 INFO - 'USER': 'cltbld', 22:01:16 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1498194038.511534-101350444', 22:01:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:16 INFO - '_': '/tools/buildbot/bin/python'} 22:01:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:17 INFO - Downloading/unpacking psutil>=3.1.1 22:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:01:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:01:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:01:18 INFO - Installing collected packages: psutil 22:01:18 INFO - Running setup.py install for psutil 22:01:18 INFO - building 'psutil._psutil_linux' extension 22:01:18 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 22:01:18 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 22:01:18 INFO - building 'psutil._psutil_posix' extension 22:01:18 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 22:01:18 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 22:01:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:01:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:01:18 INFO - Successfully installed psutil 22:01:18 INFO - Cleaning up... 22:01:18 INFO - Return code: 0 22:01:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:01:18 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')]} 22:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:18 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')]} 22:01:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:18 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 0x1dd33b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21519a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214f140>, '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 0x214fa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214fed0>, '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': '14ef55db36f7623abb31b9cf000001d5-1498194038.511534-101350444', '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 22:01:18 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 22:01:18 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 22:01:18 INFO - Using env: {'DISPLAY': ':0', 22:01:18 INFO - 'HOME': '/home/cltbld', 22:01:18 INFO - 'LANG': 'en_US.UTF-8', 22:01:18 INFO - 'LANGUAGE': 'en_US:en', 22:01:18 INFO - 'LOGNAME': 'cltbld', 22:01:18 INFO - 'MAIL': '/var/mail/cltbld', 22:01:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:18 INFO - 'MOZ_NO_REMOTE': '1', 22:01:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:18 INFO - 'NO_EM_RESTART': '1', 22:01:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:18 INFO - 'PWD': '/builds/slave/test', 22:01:18 INFO - 'SHELL': '/bin/bash', 22:01:18 INFO - 'SHLVL': '1', 22:01:18 INFO - 'TERM': 'linux', 22:01:18 INFO - 'TMOUT': '86400', 22:01:18 INFO - 'USER': 'cltbld', 22:01:18 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1498194038.511534-101350444', 22:01:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:18 INFO - '_': '/tools/buildbot/bin/python'} 22:01:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:01:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:01:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:01:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:01:20 INFO - Installing collected packages: mozsystemmonitor 22:01:20 INFO - Running setup.py install for mozsystemmonitor 22:01:20 INFO - Successfully installed mozsystemmonitor 22:01:20 INFO - Cleaning up... 22:01:20 INFO - Return code: 0 22:01:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:01:20 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')]} 22:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:20 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')]} 22:01:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:20 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 0x1dd33b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21519a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214f140>, '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 0x214fa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214fed0>, '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': '14ef55db36f7623abb31b9cf000001d5-1498194038.511534-101350444', '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 22:01:20 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 22:01:20 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 22:01:20 INFO - Using env: {'DISPLAY': ':0', 22:01:20 INFO - 'HOME': '/home/cltbld', 22:01:20 INFO - 'LANG': 'en_US.UTF-8', 22:01:20 INFO - 'LANGUAGE': 'en_US:en', 22:01:20 INFO - 'LOGNAME': 'cltbld', 22:01:20 INFO - 'MAIL': '/var/mail/cltbld', 22:01:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:20 INFO - 'MOZ_NO_REMOTE': '1', 22:01:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:20 INFO - 'NO_EM_RESTART': '1', 22:01:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:20 INFO - 'PWD': '/builds/slave/test', 22:01:20 INFO - 'SHELL': '/bin/bash', 22:01:20 INFO - 'SHLVL': '1', 22:01:20 INFO - 'TERM': 'linux', 22:01:20 INFO - 'TMOUT': '86400', 22:01:20 INFO - 'USER': 'cltbld', 22:01:20 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1498194038.511534-101350444', 22:01:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:20 INFO - '_': '/tools/buildbot/bin/python'} 22:01:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:20 INFO - Downloading/unpacking jsonschema==2.5.1 22:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:01:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:01: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 22:01: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 22:01: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 22:01: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 22:01:21 INFO - Downloading functools32-3.2.3-2.tar.gz 22:01:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:01:21 INFO - warning: no files found matching '*.txt' 22:01:21 INFO - no previously-included directories found matching 'build' 22:01:21 INFO - no previously-included directories found matching 'dist' 22:01:21 INFO - no previously-included directories found matching '.git*' 22:01:21 INFO - Installing collected packages: jsonschema, functools32 22:01:21 INFO - Running setup.py install for functools32 22:01:21 INFO - warning: no files found matching '*.txt' 22:01:21 INFO - no previously-included directories found matching 'build' 22:01:21 INFO - no previously-included directories found matching 'dist' 22:01:21 INFO - no previously-included directories found matching '.git*' 22:01:21 INFO - Successfully installed jsonschema functools32 22:01:21 INFO - Cleaning up... 22:01:22 INFO - Return code: 0 22:01:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:01:22 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')]} 22:01:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:22 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')]} 22:01:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:22 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 0x1dd33b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21519a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214f140>, '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 0x214fa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214fed0>, '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': '14ef55db36f7623abb31b9cf000001d5-1498194038.511534-101350444', '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 22:01:22 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 22:01:22 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 22:01:22 INFO - Using env: {'DISPLAY': ':0', 22:01:22 INFO - 'HOME': '/home/cltbld', 22:01:22 INFO - 'LANG': 'en_US.UTF-8', 22:01:22 INFO - 'LANGUAGE': 'en_US:en', 22:01:22 INFO - 'LOGNAME': 'cltbld', 22:01:22 INFO - 'MAIL': '/var/mail/cltbld', 22:01:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:22 INFO - 'MOZ_NO_REMOTE': '1', 22:01:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:22 INFO - 'NO_EM_RESTART': '1', 22:01:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:22 INFO - 'PWD': '/builds/slave/test', 22:01:22 INFO - 'SHELL': '/bin/bash', 22:01:22 INFO - 'SHLVL': '1', 22:01:22 INFO - 'TERM': 'linux', 22:01:22 INFO - 'TMOUT': '86400', 22:01:22 INFO - 'USER': 'cltbld', 22:01:22 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1498194038.511534-101350444', 22:01:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:22 INFO - '_': '/tools/buildbot/bin/python'} 22:01:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:01:22 INFO - Cleaning up... 22:01:22 INFO - Return code: 0 22:01:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:01:22 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')]} 22:01:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:22 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')]} 22:01:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:22 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 0x1dd33b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21519a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214f140>, '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 0x214fa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214fed0>, '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': '14ef55db36f7623abb31b9cf000001d5-1498194038.511534-101350444', '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 22:01:22 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 22:01:22 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 22:01:22 INFO - Using env: {'DISPLAY': ':0', 22:01:22 INFO - 'HOME': '/home/cltbld', 22:01:22 INFO - 'LANG': 'en_US.UTF-8', 22:01:22 INFO - 'LANGUAGE': 'en_US:en', 22:01:22 INFO - 'LOGNAME': 'cltbld', 22:01:22 INFO - 'MAIL': '/var/mail/cltbld', 22:01:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:22 INFO - 'MOZ_NO_REMOTE': '1', 22:01:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:22 INFO - 'NO_EM_RESTART': '1', 22:01:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:22 INFO - 'PWD': '/builds/slave/test', 22:01:22 INFO - 'SHELL': '/bin/bash', 22:01:22 INFO - 'SHLVL': '1', 22:01:22 INFO - 'TERM': 'linux', 22:01:22 INFO - 'TMOUT': '86400', 22:01:22 INFO - 'USER': 'cltbld', 22:01:22 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1498194038.511534-101350444', 22:01:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:22 INFO - '_': '/tools/buildbot/bin/python'} 22:01:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:22 INFO - Downloading/unpacking blobuploader==1.2.4 22:01:22 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 22:01:22 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 22:01:22 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 22:01:22 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 22:01:23 INFO - Downloading blobuploader-1.2.4.tar.gz 22:01:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:01:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:01: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 22:01: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 22:01: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 22:01: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 22:01:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:01:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:01: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 22:01: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 22:01: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 22:01: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 22:01:24 INFO - Downloading docopt-0.6.1.tar.gz 22:01:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:01:24 INFO - Installing collected packages: blobuploader, requests, docopt 22:01:24 INFO - Running setup.py install for blobuploader 22:01:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:01:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:01:24 INFO - Running setup.py install for requests 22:01:24 INFO - Running setup.py install for docopt 22:01:24 INFO - Successfully installed blobuploader requests docopt 22:01:24 INFO - Cleaning up... 22:01:24 INFO - Return code: 0 22:01:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:01: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')]} 22:01:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01: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')]} 22:01:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:24 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 0x1dd33b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21519a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214f140>, '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 0x214fa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214fed0>, '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': '14ef55db36f7623abb31b9cf000001d5-1498194038.511534-101350444', '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 22:01:24 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 22:01:24 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 22:01:24 INFO - Using env: {'DISPLAY': ':0', 22:01:24 INFO - 'HOME': '/home/cltbld', 22:01:24 INFO - 'LANG': 'en_US.UTF-8', 22:01:24 INFO - 'LANGUAGE': 'en_US:en', 22:01:24 INFO - 'LOGNAME': 'cltbld', 22:01:24 INFO - 'MAIL': '/var/mail/cltbld', 22:01:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:24 INFO - 'MOZ_NO_REMOTE': '1', 22:01:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:24 INFO - 'NO_EM_RESTART': '1', 22:01:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:24 INFO - 'PWD': '/builds/slave/test', 22:01:24 INFO - 'SHELL': '/bin/bash', 22:01:24 INFO - 'SHLVL': '1', 22:01:24 INFO - 'TERM': 'linux', 22:01:24 INFO - 'TMOUT': '86400', 22:01:24 INFO - 'USER': 'cltbld', 22:01:24 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1498194038.511534-101350444', 22:01:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:24 INFO - '_': '/tools/buildbot/bin/python'} 22:01:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:01:24 INFO - Running setup.py (path:/tmp/pip-cFeh_9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:01:24 INFO - Running setup.py (path:/tmp/pip-r3WOTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:01:25 INFO - Running setup.py (path:/tmp/pip-1CgOax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:01:25 INFO - Running setup.py (path:/tmp/pip-M7QDMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:01:25 INFO - Running setup.py (path:/tmp/pip-rOSW3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:01:25 INFO - Running setup.py (path:/tmp/pip-SoJ1MF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:01:25 INFO - Running setup.py (path:/tmp/pip-AsBoYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:01:25 INFO - Running setup.py (path:/tmp/pip-J6AI13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:01:25 INFO - Running setup.py (path:/tmp/pip-cHlEwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:01:25 INFO - Running setup.py (path:/tmp/pip-d7teMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:01:25 INFO - Running setup.py (path:/tmp/pip-wUgKn2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:01:25 INFO - Running setup.py (path:/tmp/pip-3Mr6qB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:01:25 INFO - Running setup.py (path:/tmp/pip-O1DobM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:01:25 INFO - Running setup.py (path:/tmp/pip-75sKZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:01:25 INFO - Running setup.py (path:/tmp/pip-T790O0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:01:25 INFO - Running setup.py (path:/tmp/pip-CGdkU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:01:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:01:26 INFO - Running setup.py (path:/tmp/pip-mMn1oM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:01:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:01:26 INFO - Running setup.py install for manifestparser 22:01:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:01:26 INFO - Running setup.py install for mozcrash 22:01:26 INFO - Running setup.py install for mozdebug 22:01:26 INFO - Running setup.py install for mozdevice 22:01:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:01:26 INFO - Running setup.py install for mozfile 22:01:26 INFO - Running setup.py install for mozhttpd 22:01:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:01:26 INFO - Running setup.py install for mozinfo 22:01:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:01:26 INFO - Running setup.py install for mozInstall 22:01:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:01:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:01:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:01:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:01:26 INFO - Running setup.py install for mozleak 22:01:27 INFO - Running setup.py install for mozlog 22:01:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:01:27 INFO - Running setup.py install for moznetwork 22:01:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:01:27 INFO - Running setup.py install for mozprocess 22:01:27 INFO - Running setup.py install for mozprofile 22:01:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:01:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:01:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:01:27 INFO - Running setup.py install for mozrunner 22:01:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:01:27 INFO - Running setup.py install for mozscreenshot 22:01:27 INFO - Running setup.py install for moztest 22:01:27 INFO - Running setup.py install for mozversion 22:01:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:01:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:01:27 INFO - Cleaning up... 22:01:27 INFO - Return code: 0 22:01:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:01:27 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')]} 22:01:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:27 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')]} 22:01:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:27 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 0x1dd33b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21519a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214f140>, '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 0x214fa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214fed0>, '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': '14ef55db36f7623abb31b9cf000001d5-1498194038.511534-101350444', '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 22:01:27 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 22:01:27 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 22:01:27 INFO - Using env: {'DISPLAY': ':0', 22:01:27 INFO - 'HOME': '/home/cltbld', 22:01:27 INFO - 'LANG': 'en_US.UTF-8', 22:01:27 INFO - 'LANGUAGE': 'en_US:en', 22:01:27 INFO - 'LOGNAME': 'cltbld', 22:01:27 INFO - 'MAIL': '/var/mail/cltbld', 22:01:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:27 INFO - 'MOZ_NO_REMOTE': '1', 22:01:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:27 INFO - 'NO_EM_RESTART': '1', 22:01:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:27 INFO - 'PWD': '/builds/slave/test', 22:01:27 INFO - 'SHELL': '/bin/bash', 22:01:27 INFO - 'SHLVL': '1', 22:01:27 INFO - 'TERM': 'linux', 22:01:27 INFO - 'TMOUT': '86400', 22:01:27 INFO - 'USER': 'cltbld', 22:01:27 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1498194038.511534-101350444', 22:01:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:27 INFO - '_': '/tools/buildbot/bin/python'} 22:01:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:01:28 INFO - Running setup.py (path:/tmp/pip-9Ho1mV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:01:28 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)) 22:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:01:28 INFO - Running setup.py (path:/tmp/pip-zcoxu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:01:28 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)) 22:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:01:28 INFO - Running setup.py (path:/tmp/pip-heHXH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:01:28 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)) 22:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:01:28 INFO - Running setup.py (path:/tmp/pip-38Uz5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:01:28 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)) 22:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:01:28 INFO - Running setup.py (path:/tmp/pip-0PdaUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:01:28 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)) 22:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:01:28 INFO - Running setup.py (path:/tmp/pip-8QFuZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:01:28 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)) 22:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:01:28 INFO - Running setup.py (path:/tmp/pip-BSz1bB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:01:28 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)) 22:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:01:28 INFO - Running setup.py (path:/tmp/pip-8fY1zP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:01:28 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)) 22:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:01:28 INFO - Running setup.py (path:/tmp/pip-J_b1_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:01:28 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)) 22:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:01:28 INFO - Running setup.py (path:/tmp/pip-7Fe43B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:01:28 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)) 22:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:01:28 INFO - Running setup.py (path:/tmp/pip-G2CBW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:01:28 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)) 22:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:01:28 INFO - Running setup.py (path:/tmp/pip-vA57oj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:01:29 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)) 22:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:01:29 INFO - Running setup.py (path:/tmp/pip-PS0w9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:01:29 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)) 22:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:01:29 INFO - Running setup.py (path:/tmp/pip-ywexVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:01:29 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)) 22:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:01:29 INFO - Running setup.py (path:/tmp/pip-uio15d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:01:29 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)) 22:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:01:29 INFO - Running setup.py (path:/tmp/pip-ktP1WS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:01:29 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)) 22:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:01:29 INFO - Running setup.py (path:/tmp/pip-OVnQwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:01:29 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)) 22:01:29 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)) 22:01:29 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)) 22:01:29 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)) 22:01:29 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)) 22:01:29 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)) 22:01:29 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)) 22:01:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:01:29 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 22:01:29 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 22:01:29 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 22:01:29 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 22:01:30 INFO - Downloading blessings-1.6.tar.gz 22:01:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:01:30 INFO - Installing collected packages: blessings 22:01:30 INFO - Running setup.py install for blessings 22:01:30 INFO - Successfully installed blessings 22:01:30 INFO - Cleaning up... 22:01:30 INFO - Return code: 0 22:01:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:01:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:01:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:01:30 INFO - Reading from file tmpfile_stdout 22:01:30 INFO - Current package versions: 22:01:30 INFO - argparse == 1.2.1 22:01:30 INFO - blessings == 1.6 22:01:30 INFO - blobuploader == 1.2.4 22:01:30 INFO - docopt == 0.6.1 22:01:30 INFO - functools32 == 3.2.3-2 22:01:30 INFO - jsonschema == 2.5.1 22:01:30 INFO - manifestparser == 1.1 22:01:30 INFO - mozInstall == 1.13 22:01:30 INFO - mozcrash == 1.0 22:01:30 INFO - mozdebug == 0.1 22:01:30 INFO - mozdevice == 0.51 22:01:30 INFO - mozfile == 1.2 22:01:30 INFO - mozhttpd == 0.7 22:01:30 INFO - mozinfo == 0.10 22:01:30 INFO - mozleak == 0.1 22:01:30 INFO - mozlog == 3.4 22:01:30 INFO - moznetwork == 0.27 22:01:30 INFO - mozprocess == 0.25 22:01:30 INFO - mozprofile == 0.28 22:01:30 INFO - mozrunner == 6.13 22:01:30 INFO - mozscreenshot == 0.1 22:01:30 INFO - mozsystemmonitor == 0.3 22:01:30 INFO - moztest == 0.8 22:01:30 INFO - mozversion == 1.4 22:01:30 INFO - psutil == 3.1.1 22:01:30 INFO - requests == 1.2.3 22:01:30 INFO - wsgiref == 0.1.2 22:01:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:01:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:01:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:01:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:30 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 0x1dd33b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21519a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214f140>, '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 0x214fa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214fed0>, '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': '14ef55db36f7623abb31b9cf000001d5-1498194038.511534-101350444', '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 22:01:30 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 22:01:30 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 22:01:30 INFO - Using env: {'DISPLAY': ':0', 22:01:30 INFO - 'HOME': '/home/cltbld', 22:01:30 INFO - 'LANG': 'en_US.UTF-8', 22:01:30 INFO - 'LANGUAGE': 'en_US:en', 22:01:30 INFO - 'LOGNAME': 'cltbld', 22:01:30 INFO - 'MAIL': '/var/mail/cltbld', 22:01:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:30 INFO - 'MOZ_NO_REMOTE': '1', 22:01:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:30 INFO - 'NO_EM_RESTART': '1', 22:01:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:30 INFO - 'PWD': '/builds/slave/test', 22:01:30 INFO - 'SHELL': '/bin/bash', 22:01:30 INFO - 'SHLVL': '1', 22:01:30 INFO - 'TERM': 'linux', 22:01:30 INFO - 'TMOUT': '86400', 22:01:30 INFO - 'USER': 'cltbld', 22:01:30 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1498194038.511534-101350444', 22:01:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:30 INFO - '_': '/tools/buildbot/bin/python'} 22:01:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:31 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)) 22:01:31 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)) 22:01:31 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)) 22:01:31 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)) 22:01:31 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)) 22:01:31 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)) 22:01:31 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)) 22:01:31 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)) 22:01:31 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)) 22:01:31 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 22:01:31 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 22:01:31 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 22:01:31 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 22:01:31 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 22:01:32 INFO - Downloading marionette_driver-1.4.0.tar.gz 22:01:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 22:01:32 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)) 22:01:32 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)) 22:01:32 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)) 22:01:32 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)) 22:01:32 INFO - Installing collected packages: marionette-driver 22:01:32 INFO - Running setup.py install for marionette-driver 22:01:32 INFO - Successfully installed marionette-driver 22:01:32 INFO - Cleaning up... 22:01:32 INFO - Return code: 0 22:01:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:01: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')]} 22:01:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01: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')]} 22:01:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1dd33b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fada80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21519a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x214f140>, '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 0x214fa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214fed0>, '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': '14ef55db36f7623abb31b9cf000001d5-1498194038.511534-101350444', '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 22:01:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:01:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:01:32 INFO - Using env: {'DISPLAY': ':0', 22:01:32 INFO - 'HOME': '/home/cltbld', 22:01:32 INFO - 'LANG': 'en_US.UTF-8', 22:01:32 INFO - 'LANGUAGE': 'en_US:en', 22:01:32 INFO - 'LOGNAME': 'cltbld', 22:01:32 INFO - 'MAIL': '/var/mail/cltbld', 22:01:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:32 INFO - 'MOZ_NO_REMOTE': '1', 22:01:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:32 INFO - 'NO_EM_RESTART': '1', 22:01:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:32 INFO - 'PWD': '/builds/slave/test', 22:01:32 INFO - 'SHELL': '/bin/bash', 22:01:32 INFO - 'SHLVL': '1', 22:01:32 INFO - 'TERM': 'linux', 22:01:32 INFO - 'TMOUT': '86400', 22:01:32 INFO - 'USER': 'cltbld', 22:01:32 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1498194038.511534-101350444', 22:01:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:32 INFO - '_': '/tools/buildbot/bin/python'} 22:01:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:01:32 INFO - Cleaning up... 22:01:32 INFO - Return code: 0 22:01:32 INFO - Running post-action listener: _resource_record_post_action 22:01:32 INFO - Running post-action listener: _start_resource_monitoring 22:01:32 INFO - Starting resource monitoring. 22:01:32 INFO - [mozharness: 2017-06-23 05:01:32.705958Z] Finished create-virtualenv step (success) 22:01:32 INFO - [mozharness: 2017-06-23 05:01:32.706457Z] Running install step. 22:01:32 INFO - Running pre-action listener: _resource_record_pre_action 22:01:32 INFO - Running main action method: install 22:01:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:01:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:01:32 INFO - Reading from file tmpfile_stdout 22:01:32 INFO - Detecting whether we're running mozinstall >=1.0... 22:01:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:01:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:01:33 INFO - Reading from file tmpfile_stdout 22:01:33 INFO - Output received: 22:01:33 INFO - Usage: mozinstall [options] installer 22:01:33 INFO - Options: 22:01:33 INFO - -h, --help show this help message and exit 22:01:33 INFO - -d DEST, --destination=DEST 22:01:33 INFO - Directory to install application into. [default: 22:01:33 INFO - "/builds/slave/test"] 22:01:33 INFO - --app=APP Application being installed. [default: firefox] 22:01:33 INFO - mkdir: /builds/slave/test/build/application 22:01:33 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'] 22:01:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 22:01:50 INFO - Reading from file tmpfile_stdout 22:01:50 INFO - Output received: 22:01:50 INFO - /builds/slave/test/build/application/firefox/firefox 22:01:50 INFO - Running post-action listener: _resource_record_post_action 22:01:50 INFO - [mozharness: 2017-06-23 05:01:50.802281Z] Finished install step (success) 22:01:50 INFO - [mozharness: 2017-06-23 05:01:50.802563Z] Running setup-mitmproxy step. 22:01:50 INFO - Running pre-action listener: _resource_record_pre_action 22:01:50 INFO - Running main action method: setup_mitmproxy 22:01:50 INFO - Skipping: mitmproxy is not required 22:01:50 INFO - Running post-action listener: _resource_record_post_action 22:01:50 INFO - [mozharness: 2017-06-23 05:01:50.803696Z] Finished setup-mitmproxy step (success) 22:01:50 INFO - [mozharness: 2017-06-23 05:01:50.803929Z] Running run-tests step. 22:01:50 INFO - Running pre-action listener: _resource_record_pre_action 22:01:50 INFO - Running main action method: run_tests 22:01:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:01:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:01:50 INFO - Python 2.7.3 22:01:50 INFO - Return code: 0 22:01:50 INFO - grabbing minidump binary from tooltool 22:01:50 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')]} 22:01:50 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 0x214f140>, '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 0x214fa40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x214fed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:01:50 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 22:01:50 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 22:01:50 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 22:01:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:01:50 INFO - Return code: 0 22:01:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:01:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:01:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:01:50 INFO - ENV: RUST_BACKTRACE is now 1 22:01:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:01:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:01:50 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/baktnaa2RvObUaWwfN7tLg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 22:01:50 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/baktnaa2RvObUaWwfN7tLg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 22:01:50 INFO - Using env: {'DISPLAY': ':0', 22:01:50 INFO - 'HOME': '/home/cltbld', 22:01:50 INFO - 'LANG': 'en_US.UTF-8', 22:01:50 INFO - 'LANGUAGE': 'en_US:en', 22:01:50 INFO - 'LOGNAME': 'cltbld', 22:01:50 INFO - 'MAIL': '/var/mail/cltbld', 22:01:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:01:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:01:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:50 INFO - 'MOZ_NO_REMOTE': '1', 22:01:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:01:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:50 INFO - 'NO_EM_RESTART': '1', 22:01:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:50 INFO - 'PWD': '/builds/slave/test', 22:01:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:01:50 INFO - 'RUST_BACKTRACE': '1', 22:01:50 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 22:01:50 INFO - 'SHELL': '/bin/bash', 22:01:50 INFO - 'SHLVL': '1', 22:01:50 INFO - 'TERM': 'linux', 22:01:50 INFO - 'TMOUT': '86400', 22:01:50 INFO - 'USER': 'cltbld', 22:01:50 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1498194038.511534-101350444', 22:01:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:50 INFO - '_': '/tools/buildbot/bin/python'} 22:01:50 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/baktnaa2RvObUaWwfN7tLg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 22:01:51 INFO - mozversion application_buildid: 20170623034504 22:01:51 INFO - mozversion application_changeset: 7455c74d833a9db4e02be17eda14588c7ef0de76 22:01:51 INFO - mozversion application_display_name: Nightly 22:01:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:01:51 INFO - mozversion application_name: Firefox 22:01:51 INFO - mozversion application_remotingname: firefox 22:01:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 22:01:51 INFO - mozversion application_vendor: Mozilla 22:01:51 INFO - mozversion application_version: 56.0a1 22:01:51 INFO - mozversion platform_buildid: 20170623034504 22:01:51 INFO - mozversion platform_changeset: 7455c74d833a9db4e02be17eda14588c7ef0de76 22:01:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 22:01:51 INFO - mozversion platform_version: 56.0a1 22:01:51 INFO - using testdate: 1498194111 22:01:51 INFO - actual date: 1498194111 22:01:51 INFO - starting webserver on 'localhost:51338' 22:01:51 INFO - SUITE-START | Running 2 tests 22:01:51 INFO - TEST-START | dromaeo_css 22:01:51 INFO - operating with platform_type : linux_ 22:01:51 INFO - Initialising browser for dromaeo_css test... 22:01:51 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51338/getInfo.html -profile /tmp/tmpYJOZcP/profile 22:01:51 INFO - TEST-INFO | started process 4858 (/builds/slave/test/build/application/firefox/firefox http://localhost:51338/getInfo.html) 22:01:57 INFO - TEST-INFO | 4858: exit 0 22:01:57 INFO - Browser initialized. 22:01:57 INFO - Running cycle 1/1 for dromaeo_css test... 22:01:57 INFO - TEST-INFO | started process 5092 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYJOZcP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:02:08 INFO - PID 5092 | RSS: Main: 169345024 22:02:08 INFO - PID 5092 | 22:05:12 INFO - PID 5092 | Cycle 1(1): loaded http://localhost:51338/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51338/tests/dromaeo/cssquery-ext.html) 22:05:14 INFO - PID 5092 | RSS: Main: 175022080 22:05:14 INFO - PID 5092 | 22:08:15 INFO - PID 5092 | Cycle 1(1): loaded http://localhost:51338/tests/dromaeo/cssquery-ext.html (next: http://localhost:51338/tests/dromaeo/cssquery-jquery.html) 22:08:16 INFO - PID 5092 | RSS: Main: 172470272 22:08:16 INFO - PID 5092 | 22:11:18 INFO - PID 5092 | Cycle 1(1): loaded http://localhost:51338/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51338/tests/dromaeo/cssquery-mootools.html) 22:11:18 INFO - PID 5092 | RSS: Main: 177192960 22:11:18 INFO - PID 5092 | 22:14:20 INFO - PID 5092 | Cycle 1(1): loaded http://localhost:51338/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51338/tests/dromaeo/cssquery-prototype.html) 22:14:20 INFO - PID 5092 | RSS: Main: 172969984 22:14:20 INFO - PID 5092 | 22:17:23 INFO - PID 5092 | Cycle 1(1): loaded http://localhost:51338/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51338/tests/dromaeo/cssquery-yui.html) 22:17:24 INFO - PID 5092 | RSS: Main: 176353280 22:17:24 INFO - PID 5092 | 22:20:25 INFO - PID 5092 | Cycle 1(1): loaded http://localhost:51338/tests/dromaeo/cssquery-yui.html (next: http://localhost:51338/tests/dromaeo/cssquery-dojo.html) 22:20:25 INFO - PID 5092 | RSS: Main: 175034368 22:20:25 INFO - PID 5092 | 22:20:25 INFO - PID 5092 | __start_tp_report 22:20:25 INFO - PID 5092 | _x_x_mozilla_page_load 22:20:25 INFO - PID 5092 | _x_x_mozilla_page_load_details 22:20:25 INFO - PID 5092 | |i|pagename|runs| 22:20:25 INFO - PID 5092 | |0;dojo.html;3394.964535816575;3399.4390925497296;3405.0125463615555;3455.360758259722;3456.7925924444535;6162.352952939944;6194.3805619438035;6245.313015568284;6257.937420625793;6285.685715714208;6228.19033525641;6295;6319.684015799215;6325.778597749079;6327.651979141146;5536.390996990328;5556.9444305556835;5582.051051321285;5626.718664066801;5635.690037047961;5471.562275018009;5540.667559946416;5563.332400111992;5567.526760225385;5579.776808927638;5472.5621950243885;5513.531349835269;5525.281713377235;5525.585581081395;5537.833864984057;5569.637973531708;5570.3315602128005;5580.274564306615;5584.469475399871;5624.887502249973;5508.6970216638065;5547.362053363874;5558.44415558445;5571.804986825442;5577.386487486373;6203.720832562545;6245.968770156165;6278.30938596754;6283.842903927392;6315.179026726496;6604.141461610008;6689.632070236135;6690.063391125246;6692.63190524521;6819.420349270318;6868.656567171622;6904.13698287714;6925.861482770317;6926.307369263084;6931.653417329164;6272.3100458949475;6326.778562750374;6335.176427064452;6352.047192921099;6353.682315884187;6778.593284402853;6869.313068693191;6888.586684798928;6890.8621827563165;6893.345132212432;6560.40956313934;6592.604443733296;6661.9000714989315;6682.264950855402;6693.832654183684;6770.187577490733;6780.559263647847;6794.45644348451;6794.728210871609;6800.115984922028;6611.702473388709;6715.429188518933;6763.560368576027;6764.0868482754195;6775.93224067753;6688;6712.798616041527;6716.630585317855;6761.425278851353;6764.323567643295;5092.465291144451;5120.4111527174855;5124.538791508782;5140.948590514122;5161.690298582097;4492.910141797146;4520.81916723334;4520.864374068783;4528.071745292207;4538.11506756186;6379.393957574116;6402.359764023654;6407.423331900151;6429.45349645276;6438.678066096676;6690.13028306317;6758.864822703518;6794.898076528856;6904.620245886424;6925.549839260432;6289.528285378615;6330.272018717815;6345.841353966188;6365.840853978595;6383.170187875547;5634.971825140848;5673.461021202979;5685.431456854281;5686.3744988051285;5690.7439165237665;7049.7532586361285;7077.610731409719;7085.893711594227;7093.290670932865;7123.394511466583;6632.104665870046;6704.698288577123;6817.5568588041615;6828.2830302819475;6835.624040677611;6970.198427180939;7064.964675176797;7077.256888026683;7110.964445177948;7135.215126336203;6690.130283063365;6717.395434410926;6777.423918966746;6778.0510728497065;6798.93201067983;6934.445244380337;6938.687759050754;6942.514024018472;6947.5831450113155;6957.756478523227;6497.512686548623;6658.500612453989;6694.564853284521;6697.732090716511;6701.262861085374;6471.255805582418;6564.770233041821;6567.737290508326;6596.043573681885;6603.9339606605245;6527.51043671736;6626.602403855784;6674.199096108498;6687.398134167948;6732.158480189976;6682.565633233824;6731.259561448139;6732.865342693217;6734.3265673434225;6757.898631520433;6533.607983521004;6577.210734711865;6589.308122647245;6594.241662208716;6601.273859875314 22:20:25 INFO - PID 5092 | |1;ext.html;878.8362586684988;905.7961958559321;939.2486011191047;946.659202687033;960.0111884758696;40376.394354084674;42285;42477.150456990916;42630.14739705204;42747.78626106873;38941.221175576546;39150.804245978805;39168.21663566727;39231.41152882709;39363.40954885679;6720.831979200522;6791.626460544668;6811.965940170317;6822.113125293729;6829.385355318021;6691.464682825363;6745.696443660047;6793.694283757242;6851.588904665736;6861.725530978755;6809.931900681004;6817.216020157671;6831.282715314895;6837.042814006043;6852.6916288767125;6787.083743694588;6820.6930688118655;6846.212685541127;6862.759803406857;6868.690908909111;6205.976013957692;6239.064140378934;7189.640517974132;7277.126744790606;7359.816004599874;38022;38208;38420.615793841986;38472.42291365604;38644;3468.843902024415;3561.626029266916;3564.7326450516057;3579.552555930509;3583.175869550018;29801.25496862574;29885.103446896628;29924;30191.547126793117;30330.69669303301;3518.700910422617;3653.5433070866143;3667;3668.064643515913;3679.4480827875764;196506;198455;204905;206990;207254.9637251819;47884.521154788;47980.76009619999;48021.279680804815;48179.5182048182;48576.5142348572;50466.24300635493;50823.23765143526;51031.489685103414;51048.234276485884;51145.488545114815;14083.577492675236;14106.85893141076;14169.78745318821;14190.432382704783;14196.929015354857;11451.770964580663;11468.082553395709;11503.597374091867;11555.2489088209;11565.76868462626;13842.653933651538;13913.652158695912;14003.43986240539;14010.719785604231;14128.50550230737;5602.711376383455;5627.634203776742;5661.207430959669;5702.429757024264;5743.396943320891;1076.5855145768778;1082.4587706146926;1083.1659622090947;1096.155959910864;1112.821948488238;23762.287131386085;24931.252062438154;24952.5009499809;25266.36834079126;25279;1086.8261078227445;1201.7782734020666;1213.8044026633759;1215.726461546145;1221.2062159596155;12380.885720285038;12429.564965226355;12581.308028058545;12780.169288996185;12782.105252632413;260031;261621;262950;263839.40401490114;265951;52627.210591841154;52781.47218527842;53030.204546931825;53249;53697;1435.8923080768984;1502.7219964306419;1503.2558883352592;1520.825105112904;1524.1083965879864;21697.891510542348;22188.557743746605;22282.331530054125;22540.66189007199;23213.41966450852;37646.811765941;37684;37906.81046594749;38102.80948595239;38281;237637;237718;238809;239208;240034;33045.83477082695;35609;36181;37185.69850055235;37361.43957840689;42989.570104299804;44108.33837492504;45064;45315.64053078413;45583.54416455793;30899.382012360078;31194.68805311918;32090.197745055626;32270.19324516812;33280.500792488616;31886;31952;32934.559458932454;32947.34105317928;33397.83301083479;38408.807955960045;38931.22137557176;39013.21973560456;39065;39095.41356879592;29247.683854227038;31030.379392412477;31743;31750.52374214435;32511.674883250864;24134.39664008414;26165.869170654027;26314.4737105253;26458.206253812416;26603.733962660124 22:20:25 INFO - PID 5092 | |2;jquery.html;553.2973124132352;562.1567648527209;572.3761100400562;576.2738948924356;583.387443184656;21449.67825482619;22513.662295065587;22513.887430562867;22579.887100564494;22589.54820903581;24467.877660611717;24956.62565061521;26481.735182648168;26585.468290634177;26706.19881403556;6251.031090181018;6350.936490635104;6360.268569114542;6373.139626150457;6377;6158.6612736299485;6186.226721659793;6215.409536094064;6236.501079913596;6244.469220116295;5814.534837213034;6050.757969681229;6150.292716337612;6206.069089636568;6217;6157.846053848667;6225.159603453521;6234.532410069263;6239.2824825145235;6257.18656574647;5696.601237913348;5744.281964754406;5745.454181852718;5767.106098554689;5795.449432303924;28619;29161.708382916324;29693.851530742424;29720.55419168714;29802.254943626365;2157.1802714968367;2233.932982010542;2237.832162587796;2245.8203343732625;2248.853824501402;18877;19400.708989365172;19435.416937491897;19446.902765486222;19459.4162175135;2371.1345358944036;2392.306231192952;2433.7566243375522;2448.1431498975217;2450.9509809803703;128409;130656;131203.99999999904;134230;138503.30748346294;14777.556673299818;14878.776818347516;15204;15251.771223431657;15309.46416875404;23344.883275583514;23453.296401107993;23535.293941181793;23554.057837686643;23706.17028404032;9327.207187389147;9383.390079644802;9388.155066044088;9577.23382129442;9636.180924621485;8302.958485207535;8325.209105135002;8525.275351595059;8528.232459078712;8557.272631826365;9180.265578753684;9298.349115561845;9355.345125841126;9426.575804088832;9608.711738647851;2636.986815065912;2640.6303117563557;4063.959360406358;4208.684348673862;4564.3838081859185;1032.6592224566025;1046.0323852421914;1057.825458799305;1079.3416016230094;1087.4508373271606;20914.954252287323;20948;21097.610488894134;21208.469788255108;21897.562048759253;1052.5158427123456;1072.84443755655;1081.6479400749063;1092.355510248957;1104.5526561742506;11119.22165448427;11215.775684486265;11261.43692815356;11264.774704506028;11433.828492572618;523956;527184;531925;541670;543040;107115.46442267895;108556.45721771341;112643;114004;116563.41718291354;1203.897668698153;1204.566356111799;1237.5792230641446;1237.6534570320325;1240.6588188248124;17098.487045388658;18143.455696329132;18351.449456516326;18429.53926151803;18734.156962936428;50131.24803128029;51921.740391297804;54064.45935540594;54132.72933635306;54926;70336;70824.64587677029;71267.64366178136;72086.63956680182;72403;16447.93088449247;16603.501894943172;16761.91619041946;16823.915880420518;16899.408520701716;16113.194340283173;17600.647987040444;17661.205245763715;17821.198046088215;17824.287028519233;14794;14868.776968345268;14964.925175374054;15019.09885406879;15134.848651513345;13195.73608527805;13455.663608409868;13819.516316928859;13916;13927.303634818421;13929.60703929599;13975.951803614973;14144.292785360485;14162.645933851736;14210.786838197642;16671.83297169235;16767.24547395346;16767.245473953946;16848.241829117964;16973.575660608585;14091.647708806951;14361;14755.114693118447;14831.629209269855;14881.627959301104 22:20:25 INFO - PID 5092 | |3;mootools.html;1418.1491105336795;1465.120927443534;1466.3108339080632;1467.7431449496328;1474.3660226102786;14779.704405911889;15258.923705381485;15351.69296614067;15463.458778942739;15466.226688665578;14930.104193748382;15023.924880375584;15091.773623395658;15109.773353399707;15130.773038404433;2696.5820297853866;2718.225305787851;2720.7687346575567;2722.8638568071615;2735.5212837753315;2548.8980440782348;2662.081581854267;2664.174106027128;2666.9466610667773;2671.2119924622184;2582.1349847801007;2644.960325595108;2686;2693.1920423872857;2697.3526353675074;2662.6804783426014;2768.2387343480505;2770.030489328719;2771.4872748541584;2772.9029483968066;2673.3717576369536;2703.1349968010245;2708.729127087295;2710.91867243983;2714.9728502714916;14878.107313561113;15201.619959500991;15209.315580798891;15221.010634308734;15240;7952.8409431811615;8122.959385203036;8169;8186;8199.95900020496;4469.486009108961;4557.475890272628;4716.292556116576;4773.188557945123;4837.588804951583;1590.992045039779;1599.2563457991973;1605.08510149215;1636.9508914732578;1640.6718656268795;25658.615120773204;25665;25919.611205831927;25953.74046259551;25998.61002084951;6796.218434879953;6909.585424874524;6920.30796920314;7025.473089518205;7062.435005199572;17585.47243582669;17595.73606395905;17628.20673069715;17664.558386040193;17757.911210443865;7785.182555831556;8053.59732013397;8109.635066422025;8110.594470276463;8119.147489513516;7394.260573942563;7478.102627684604;7570.16728159902;7619.809504762426;7642.273983971514;5611.354694210218;5748.597598168088;5778.6821724804695;5794.072948328248;5819.243498345188;1755.5611097225694;1769.646070785848;1794.156746329223;1804.9819501805077;1815.7457955886186;920.4891285336569;936.091990768953;938.5401153434905;968.6948611187454;979.9020097990286;7610.505317154367;7613.9238607613215;7659.885101723478;7771.145174030852;7836.412269079728;736.7605528203355;738.8005238585552;759.0473955186317;770.2374649097353;776.5263189454429;4296.162248361602;4479.686421950498;4956.8512944611;5345.973270133624;5539.362973258127;19843.603127937648;19935;19985.300514482213;21347.46631334229;21348.78651213499;20836.791632083485;21136.682949755766;21408.143674252857;21502.462438439165;21656.675149872764;11323.207375483636;11386.202965792316;11411.087113030937;11470.254433461798;11483.770324593628;7800;8186;8389.077201507951;8521.786955325919;8672.219500245008;17722.822771772633;17788.3774067907;18044.458666240032;18659.81340186581;18668.533286667942;18110.27558897682;18395.356162534248;18940.526486837938;19076.904615476833;19287.228510859408;11738.119641026786;11978;11992.160548761503;12014.219075760047;12061;13700.24648644334;13726.107802992774;13738.65653358634;13841.515546955809;13882.09766365183;10282.742931426774;10414.947925260325;10624.52189651483;10744.30162039465;11278.210525263481;10607.098396636064;11136.276142050741;11377.805330440184;11419.143564232882;11818.995385391994;9760.60957561718;9808.65669701557;9842.212622990286;9904.405735655884;9910.900890990997;7170.605616691132;7251.419886408969;7323.523970941872;7402.148752893271;7662.578558179353;7021.262767409348;7116.893246601202;7204.207537171012;7392.4086073115095;7512.098548174035 22:20:25 INFO - PID 5092 | |4;prototype.html;514.8635611562934;514.9562287205587;519.7167543688689;533.5758072332495;537.1030379266624;6344.302126766058;6384.170057892467;6386.074019267204;6401.471418789575;6407.935920640793;6260.624362538251;6264.342244064376;6273.7804176853815;6299.118123462719;6302.936970630292;5044.612731498849;5045.495450454961;5047.49525047496;5057.671251368668;5059.974700126503;5051.924221136685;5052.671576347526;5058.974705126469;5066.544011039005;5073.644844860862;5035.647504674675;5047.31861198739;5050.747462626872;5060.089183946888;5065.822696205633;5045.445001049881;5055.165897626887;5068.18908974566;5078.59371250301;5090.0583392072585;4187.853425130136;4359.520452750195;4435.423394958635;4658.208104622222;4678.578927896506;6093.349393014053;6095.695215239265;6103;6109.755609775648;6121.693915304217;5798.478136967693;5829.271341082364;5837.190470953976;5848.181254624356;5864.882702345972;6634.601923884582;6636.867262654768;6663.200415950117;6683;6704.597724136519;4977.626677999128;4987;4999.225120106389;4999.900001999976;5020.949790502084;6744.898826517606;6900.3099690031095;6930.341617546325;7002.124734408199;7003.5097543172;4928.876778080505;5066.113430149709;5067.949320506747;5124.231365295161;5155.381354237516;5170.1986192140275;5170.45710200431;5203.869903252449;5224.164133738584;5243.68537887728;5811.215485909433;5829.766809327664;5831.883362332815;5838.591298609056;5845.918505076575;6690.123247003738;6704.229013663394;6705.1283333166375;6707.798766037026;6755.49333799967;1795.9820401795814;1811.8731688781922;1814.8911065336122;1822.7903791064198;1823.1522342110982;1190.7499425120648;1257.3273298785107;1265.2914367953974;1280.775864223757;1299.389287035092;6303;6313.779017734358;6314.179156709598;6330.145430366933;6361.936380636134;6790.219124800612;6792.320767923168;6848.14398200225;6870.656467176721;6900.137482814648;6270.122182894398;6294.538004097728;6331.746730130835;6356.904646430307;6379.904301435482;3613.728970327236;3627.5646922368956;3638.4178531434845;3658.359787037258;3668.926621467609;7073.514561941947;7142.178649455275;7167.605781681953;7171.1394632644415;7187.245339239409;6571.244306904767;7070.929290707027;7071.116110486189;7087.007818905357;7132.536385134949;7088.822779430556;7116.323949224816;7121.465890058266;7133.785986420416;7177.89233161503;6837.794866154023;6863.862722745617;6890.896636550556;6899.344562266577;6919.619420931897;6738.561993470409;6753.831154221184;6768.153980752406;6769.221539523018;6787.5588086774205;7100.254473280231;7158.534695244793;7168.498205125591;7178.892316615151;7214.675339609835;5138.229265610188;5173.017126745906;5182.8963420732125;5194.662346947436;5225.686458812484;6674.699638516181;6819.693113809792;6832.624205668736;6877.899536074204;6934.375906168469;6361.173047503795;6570.127513658585;6644.734210631521;6667.599944003376;6695.531312808057;6575.704093315908;6621.238557565942;6629.337066293332;6637.800865974028;6656.900146497903;6641;6664.801175259556;6677.565958212701;6679.198496180489;6716.361945615159;6687.832804179934;6695.598264104169;6696.363845434676;6696.933030669826;6721.865562688817;6507.414332710079;6513.697260548004;6514.57655252407;6551.246606640298;6569.310222426768 22:20:25 INFO - PID 5092 | |5;yui.html;853.2406158518916;895.4582477601051;896.7220161749857;903.9548022598868;907.4328544659588;15242.46651367201;15657.765133522978;15722.764158537617;17207.397741079065;17860;15738.527844164664;15933.84066159338;16203.594910127253;18487.168077436512;19254.326098586553;1047.3035431438084;1061.612511433329;1065.9200559957994;1071.1537885070784;1074.0548317480607;1006.3106771861299;1011.367895065584;1012.0992316837983;1013.4071568132651;1067.8398240263984;1123.5955056179769;1127.8984891359776;1129.1362107987395;1133.0878642692628;1140.7205234717505;1065.4140222877386;1114.83834843948;1122.5958654884275;1127.8026345389565;1129.2941911305393;772.1814876231213;797.2585495489193;811.3184924663252;812.4272387966529;814.6415577146096;16873.66252674952;16944.915275423667;16951.49145525636;17010.48968530946;17017.404390846386;18297.542561435937;18934.810651893444;18977.810221897744;19010.33463828773;19039.90480047591;14930.70138597222;15295;15493.690126197413;15529.611759706098;15613.765793513106;3484.8083355415442;3504.912377190565;3534.6995505382074;3545.0960005198767;3549.6450354964295;106060;108443;108770.45614771955;109150.45424772825;111833.44083279613;14513.201773902325;14798.038127521892;14893.255337233311;15002.02486838352;15203.163825989677;25287.36781580475;26767;26836.865815671186;26916.192514224604;27123.593146102823;8030.07654119772;8093.0692970309165;8132.024157101067;8231.09457959624;8306.418550701514;4074.714769966074;4087.5912408758886;4140.772257525865;4145.66834653227;4160.2303573838935;5239.318888544541;5332.68003919766;5343.732813359316;5717.085266357363;5830.854228644318;1142.0406858238953;1171.7890779659572;1173.8063219568846;1177.1700950829645;1177.7408970026581;692.1071817355555;714.1822613108066;719.5970256656185;727.7562016724456;735.1472292141091;12775.936120319524;12891.871081289068;12943.676408089874;13350.465981360638;13392.330383480787;685.4310921934782;692.1348314606741;718.9245129261457;729.7774178875494;737.3879679865698;6100.8779824404155;6102;6184.6598437085495;6203.751849925952;6303.117563541108;110756;111665;115794;115906;118918;86360.56819715862;99835.50082249542;100867;101388.49305753424;101887;81096;87002;89815.55092224627;91060.54469727741;91080.54459727659;12514.624561263177;12724.936375318064;12753.426095825525;12926.806097908351;12942.41759120823;40663.796681017586;42341;42669.14661706811;42957.355639664805;44253.55746442623;69683.65158174177;71975.64012179905;72424;73892;74894;18634.72047919255;19038.619227615094;19048.142833572245;19245.711314330016;19261.22955081837;20172.697409539163;21254.681179782005;21476.26872306079;21583.784162158805;22053.779462205173;18657.626847462703;20209.69685454749;20410.59178816445;20521.38435846927;20564.691529627366;18235.635287293913;19001.42995710131;19020.524486887938;19184.328548500736;19485.025748712225;18593.34923277679;19422.417327480198;19749.111289992274;19856;20311.187552497733;13217.801732973821;13974.720505590034;14172.858271417153;14173;14539.636509087357;14298.928505357406;15066.246687665793;15284.847151528342;15468.767968480257;16151.111688856756 22:20:25 INFO - PID 5092 | __end_tp_report 22:20:25 INFO - PID 5092 | __start_cc_report 22:20:25 INFO - PID 5092 | _x_x_mozilla_cycle_collect,339 22:20:25 INFO - PID 5092 | __end_cc_report 22:20:25 INFO - PID 5092 | __startTimestamp1498195225827__endTimestamp 22:20:25 INFO - PID 5092 | 22:20:25 INFO - PID 5092 | ------- Summary: start ------- 22:20:25 INFO - PID 5092 | Number of tests: 6 22:20:25 INFO - PID 5092 | 22:20:25 INFO - PID 5092 | [#0] dojo.html Cycles:165 Average:6253.40 Median:6577.21 stddev:789.51 (12.0%) stddev-sans-first:759.41 22:20:25 INFO - PID 5092 | Values: 3395.0 3399.4 3405.0 3455.4 3456.8 6162.4 6194.4 6245.3 6257.9 6285.7 6228.2 6295.0 6319.7 6325.8 6327.7 5536.4 5556.9 5582.1 5626.7 5635.7 5471.6 5540.7 5563.3 5567.5 5579.8 5472.6 5513.5 5525.3 5525.6 5537.8 5569.6 5570.3 5580.3 5584.5 5624.9 5508.7 5547.4 5558.4 5571.8 5577.4 6203.7 6246.0 6278.3 6283.8 6315.2 6604.1 6689.6 6690.1 6692.6 6819.4 6868.7 6904.1 6925.9 6926.3 6931.7 6272.3 6326.8 6335.2 6352.0 6353.7 6778.6 6869.3 6888.6 6890.9 6893.3 6560.4 6592.6 6661.9 6682.3 6693.8 6770.2 6780.6 6794.5 6794.7 6800.1 6611.7 6715.4 6763.6 6764.1 6775.9 6688.0 6712.8 6716.6 6761.4 6764.3 5092.5 5120.4 5124.5 5140.9 5161.7 4492.9 4520.8 4520.9 4528.1 4538.1 6379.4 6402.4 6407.4 6429.5 6438.7 6690.1 6758.9 6794.9 6904.6 6925.5 6289.5 6330.3 6345.8 6365.8 6383.2 5635.0 5673.5 5685.4 5686.4 5690.7 7049.8 7077.6 7085.9 7093.3 7123.4 6632.1 6704.7 6817.6 6828.3 6835.6 6970.2 7065.0 7077.3 7111.0 7135.2 6690.1 6717.4 6777.4 6778.1 6798.9 6934.4 6938.7 6942.5 6947.6 6957.8 6497.5 6658.5 6694.6 6697.7 6701.3 6471.3 6564.8 6567.7 6596.0 6603.9 6527.5 6626.6 6674.2 6687.4 6732.2 6682.6 6731.3 6732.9 6734.3 6757.9 6533.6 6577.2 6589.3 6594.2 6601.3 22:20:25 INFO - PID 5092 | 22:20:25 INFO - PID 5092 | [#1] ext.html Cycles:180 Average:39898.27 Median:3572.14 stddev:61500.22 (1721.7%) stddev-sans-first:61602.96 22:20:25 INFO - PID 5092 | Values: 878.8 905.8 939.2 946.7 960.0 40376.4 42285.0 42477.2 42630.1 42747.8 38941.2 39150.8 39168.2 39231.4 39363.4 6720.8 6791.6 6812.0 6822.1 6829.4 6691.5 6745.7 6793.7 6851.6 6861.7 6809.9 6817.2 6831.3 6837.0 6852.7 6787.1 6820.7 6846.2 6862.8 6868.7 6206.0 6239.1 7189.6 7277.1 7359.8 38022.0 38208.0 38420.6 38472.4 38644.0 3468.8 3561.6 3564.7 3579.6 3583.2 29801.3 29885.1 29924.0 30191.5 30330.7 3518.7 3653.5 3667.0 3668.1 3679.4 196506.0 198455.0 204905.0 206990.0 207255.0 47884.5 47980.8 48021.3 48179.5 48576.5 50466.2 50823.2 51031.5 51048.2 51145.5 14083.6 14106.9 14169.8 14190.4 14196.9 11451.8 11468.1 11503.6 11555.2 11565.8 13842.7 13913.7 14003.4 14010.7 14128.5 5602.7 5627.6 5661.2 5702.4 5743.4 1076.6 1082.5 1083.2 1096.2 1112.8 23762.3 24931.3 24952.5 25266.4 25279.0 1086.8 1201.8 1213.8 1215.7 1221.2 12380.9 12429.6 12581.3 12780.2 12782.1 260031.0 261621.0 262950.0 263839.4 265951.0 52627.2 52781.5 53030.2 53249.0 53697.0 1435.9 1502.7 1503.3 1520.8 1524.1 21697.9 22188.6 22282.3 22540.7 23213.4 37646.8 37684.0 37906.8 38102.8 38281.0 237637.0 237718.0 238809.0 239208.0 240034.0 33045.8 35609.0 36181.0 37185.7 37361.4 42989.6 44108.3 45064.0 45315.6 45583.5 30899.4 31194.7 32090.2 32270.2 33280.5 31886.0 31952.0 32934.6 32947.3 33397.8 38408.8 38931.2 39013.2 39065.0 39095.4 29247.7 31030.4 31743.0 31750.5 32511.7 24134.4 26165.9 26314.5 26458.2 26603.7 22:20:25 INFO - PID 5092 | 22:20:25 INFO - PID 5092 | [#2] jquery.html Cycles:180 Average:35188.13 Median:12381.26 stddev:89133.25 (719.9%) stddev-sans-first:89345.36 22:20:25 INFO - PID 5092 | Values: 553.3 562.2 572.4 576.3 583.4 21449.7 22513.7 22513.9 22579.9 22589.5 24467.9 24956.6 26481.7 26585.5 26706.2 6251.0 6350.9 6360.3 6373.1 6377.0 6158.7 6186.2 6215.4 6236.5 6244.5 5814.5 6050.8 6150.3 6206.1 6217.0 6157.8 6225.2 6234.5 6239.3 6257.2 5696.6 5744.3 5745.5 5767.1 5795.4 28619.0 29161.7 29693.9 29720.6 29802.3 2157.2 2233.9 2237.8 2245.8 2248.9 18877.0 19400.7 19435.4 19446.9 19459.4 2371.1 2392.3 2433.8 2448.1 2451.0 128409.0 130656.0 131204.0 134230.0 138503.3 14777.6 14878.8 15204.0 15251.8 15309.5 23344.9 23453.3 23535.3 23554.1 23706.2 9327.2 9383.4 9388.2 9577.2 9636.2 8303.0 8325.2 8525.3 8528.2 8557.3 9180.3 9298.3 9355.3 9426.6 9608.7 2637.0 2640.6 4064.0 4208.7 4564.4 1032.7 1046.0 1057.8 1079.3 1087.5 20915.0 20948.0 21097.6 21208.5 21897.6 1052.5 1072.8 1081.6 1092.4 1104.6 11119.2 11215.8 11261.4 11264.8 11433.8 523956.0 527184.0 531925.0 541670.0 543040.0 107115.5 108556.5 112643.0 114004.0 116563.4 1203.9 1204.6 1237.6 1237.7 1240.7 17098.5 18143.5 18351.4 18429.5 18734.2 50131.2 51921.7 54064.5 54132.7 54926.0 70336.0 70824.6 71267.6 72086.6 72403.0 16447.9 16603.5 16761.9 16823.9 16899.4 16113.2 17600.6 17661.2 17821.2 17824.3 14794.0 14868.8 14964.9 15019.1 15134.8 13195.7 13455.7 13819.5 13916.0 13927.3 13929.6 13976.0 14144.3 14162.6 14210.8 16671.8 16767.2 16767.2 16848.2 16973.6 14091.6 14361.0 14755.1 14831.6 14881.6 22:20:25 INFO - PID 5092 | 22:20:25 INFO - PID 5092 | [#3] mootools.html Cycles:180 Average:9257.91 Median:2665.56 stddev:6553.42 (245.9%) stddev-sans-first:6545.33 22:20:25 INFO - PID 5092 | Values: 1418.1 1465.1 1466.3 1467.7 1474.4 14779.7 15258.9 15351.7 15463.5 15466.2 14930.1 15023.9 15091.8 15109.8 15130.8 2696.6 2718.2 2720.8 2722.9 2735.5 2548.9 2662.1 2664.2 2666.9 2671.2 2582.1 2645.0 2686.0 2693.2 2697.4 2662.7 2768.2 2770.0 2771.5 2772.9 2673.4 2703.1 2708.7 2710.9 2715.0 14878.1 15201.6 15209.3 15221.0 15240.0 7952.8 8123.0 8169.0 8186.0 8200.0 4469.5 4557.5 4716.3 4773.2 4837.6 1591.0 1599.3 1605.1 1637.0 1640.7 25658.6 25665.0 25919.6 25953.7 25998.6 6796.2 6909.6 6920.3 7025.5 7062.4 17585.5 17595.7 17628.2 17664.6 17757.9 7785.2 8053.6 8109.6 8110.6 8119.1 7394.3 7478.1 7570.2 7619.8 7642.3 5611.4 5748.6 5778.7 5794.1 5819.2 1755.6 1769.6 1794.2 1805.0 1815.7 920.5 936.1 938.5 968.7 979.9 7610.5 7613.9 7659.9 7771.1 7836.4 736.8 738.8 759.0 770.2 776.5 4296.2 4479.7 4956.9 5346.0 5539.4 19843.6 19935.0 19985.3 21347.5 21348.8 20836.8 21136.7 21408.1 21502.5 21656.7 11323.2 11386.2 11411.1 11470.3 11483.8 7800.0 8186.0 8389.1 8521.8 8672.2 17722.8 17788.4 18044.5 18659.8 18668.5 18110.3 18395.4 18940.5 19076.9 19287.2 11738.1 11978.0 11992.2 12014.2 12061.0 13700.2 13726.1 13738.7 13841.5 13882.1 10282.7 10414.9 10624.5 10744.3 11278.2 10607.1 11136.3 11377.8 11419.1 11819.0 9760.6 9808.7 9842.2 9904.4 9910.9 7170.6 7251.4 7323.5 7402.1 7662.6 7021.3 7116.9 7204.2 7392.4 7512.1 22:20:25 INFO - PID 5092 | 22:20:25 INFO - PID 5092 | [#4] prototype.html Cycles:180 Average:5684.01 Median:6330.95 stddev:1612.71 (25.5%) stddev-sans-first:1569.87 22:20:25 INFO - PID 5092 | Values: 514.9 515.0 519.7 533.6 537.1 6344.3 6384.2 6386.1 6401.5 6407.9 6260.6 6264.3 6273.8 6299.1 6302.9 5044.6 5045.5 5047.5 5057.7 5060.0 5051.9 5052.7 5059.0 5066.5 5073.6 5035.6 5047.3 5050.7 5060.1 5065.8 5045.4 5055.2 5068.2 5078.6 5090.1 4187.9 4359.5 4435.4 4658.2 4678.6 6093.3 6095.7 6103.0 6109.8 6121.7 5798.5 5829.3 5837.2 5848.2 5864.9 6634.6 6636.9 6663.2 6683.0 6704.6 4977.6 4987.0 4999.2 4999.9 5020.9 6744.9 6900.3 6930.3 7002.1 7003.5 4928.9 5066.1 5067.9 5124.2 5155.4 5170.2 5170.5 5203.9 5224.2 5243.7 5811.2 5829.8 5831.9 5838.6 5845.9 6690.1 6704.2 6705.1 6707.8 6755.5 1796.0 1811.9 1814.9 1822.8 1823.2 1190.7 1257.3 1265.3 1280.8 1299.4 6303.0 6313.8 6314.2 6330.1 6361.9 6790.2 6792.3 6848.1 6870.7 6900.1 6270.1 6294.5 6331.7 6356.9 6379.9 3613.7 3627.6 3638.4 3658.4 3668.9 7073.5 7142.2 7167.6 7171.1 7187.2 6571.2 7070.9 7071.1 7087.0 7132.5 7088.8 7116.3 7121.5 7133.8 7177.9 6837.8 6863.9 6890.9 6899.3 6919.6 6738.6 6753.8 6768.2 6769.2 6787.6 7100.3 7158.5 7168.5 7178.9 7214.7 5138.2 5173.0 5182.9 5194.7 5225.7 6674.7 6819.7 6832.6 6877.9 6934.4 6361.2 6570.1 6644.7 6667.6 6695.5 6575.7 6621.2 6629.3 6637.8 6656.9 6641.0 6664.8 6677.6 6679.2 6716.4 6687.8 6695.6 6696.4 6696.9 6721.9 6507.4 6513.7 6514.6 6551.2 6569.3 22:20:25 INFO - PID 5092 | 22:20:25 INFO - PID 5092 | [#5] yui.html Cycles:180 Average:23361.41 Median:19015.43 stddev:31320.39 (164.7%) stddev-sans-first:31362.65 22:20:25 INFO - PID 5092 | Values: 853.2 895.5 896.7 904.0 907.4 15242.5 15657.8 15722.8 17207.4 17860.0 15738.5 15933.8 16203.6 18487.2 19254.3 1047.3 1061.6 1065.9 1071.2 1074.1 1006.3 1011.4 1012.1 1013.4 1067.8 1123.6 1127.9 1129.1 1133.1 1140.7 1065.4 1114.8 1122.6 1127.8 1129.3 772.2 797.3 811.3 812.4 814.6 16873.7 16944.9 16951.5 17010.5 17017.4 18297.5 18934.8 18977.8 19010.3 19039.9 14930.7 15295.0 15493.7 15529.6 15613.8 3484.8 3504.9 3534.7 3545.1 3549.6 106060.0 108443.0 108770.5 109150.5 111833.4 14513.2 14798.0 14893.3 15002.0 15203.2 25287.4 26767.0 26836.9 26916.2 27123.6 8030.1 8093.1 8132.0 8231.1 8306.4 4074.7 4087.6 4140.8 4145.7 4160.2 5239.3 5332.7 5343.7 5717.1 5830.9 1142.0 1171.8 1173.8 1177.2 1177.7 692.1 714.2 719.6 727.8 735.1 12775.9 12891.9 12943.7 13350.5 13392.3 685.4 692.1 718.9 729.8 737.4 6100.9 6102.0 6184.7 6203.8 6303.1 110756.0 111665.0 115794.0 115906.0 118918.0 86360.6 99835.5 100867.0 101388.5 101887.0 81096.0 87002.0 89815.6 91060.5 91080.5 12514.6 12724.9 12753.4 12926.8 12942.4 40663.8 42341.0 42669.1 42957.4 44253.6 69683.7 71975.6 72424.0 73892.0 74894.0 18634.7 19038.6 19048.1 19245.7 19261.2 20172.7 21254.7 21476.3 21583.8 22053.8 18657.6 20209.7 20410.6 20521.4 20564.7 18235.6 19001.4 19020.5 19184.3 19485.0 18593.3 19422.4 19749.1 19856.0 20311.2 13217.8 13974.7 14172.9 14173.0 14539.6 14298.9 15066.2 15284.8 15468.8 16151.1 22:20:25 INFO - PID 5092 | -------- Summary: end -------- 22:20:25 INFO - PID 5092 | 22:20:26 INFO - TEST-INFO | 5092: exit 0 22:20:26 INFO - TEST-OK | dromaeo_css | took 1115286ms 22:20:26 INFO - TEST-START | kraken 22:20:26 INFO - operating with platform_type : linux_ 22:20:26 INFO - Initialising browser for kraken test... 22:20:26 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51338/getInfo.html -profile /tmp/tmpbbqvqx/profile 22:20:26 INFO - TEST-INFO | started process 5520 (/builds/slave/test/build/application/firefox/firefox http://localhost:51338/getInfo.html) 22:20:32 INFO - TEST-INFO | 5520: exit 0 22:20:32 INFO - Browser initialized. 22:20:32 INFO - Running cycle 1/1 for kraken test... 22:20:32 INFO - TEST-INFO | started process 5750 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbbqvqx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 22:20:43 INFO - PID 5750 | RSS: Main: 162770944 22:20:43 INFO - PID 5750 | 22:20:46 INFO - PID 5750 | Cycle 1(1): loaded http://localhost:51338/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51338/tests/kraken/driver.html?testName=audio-beat-detection) 22:20:47 INFO - PID 5750 | RSS: Main: 167239680 22:20:47 INFO - PID 5750 | 22:20:49 INFO - PID 5750 | Cycle 1(1): loaded http://localhost:51338/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51338/tests/kraken/driver.html?testName=audio-dft) 22:20:50 INFO - PID 5750 | RSS: Main: 167559168 22:20:50 INFO - PID 5750 | 22:20:53 INFO - PID 5750 | Cycle 1(1): loaded http://localhost:51338/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51338/tests/kraken/driver.html?testName=audio-fft) 22:20:53 INFO - PID 5750 | RSS: Main: 162701312 22:20:53 INFO - PID 5750 | 22:20:55 INFO - PID 5750 | Cycle 1(1): loaded http://localhost:51338/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51338/tests/kraken/driver.html?testName=audio-oscillator) 22:20:56 INFO - PID 5750 | RSS: Main: 163819520 22:20:56 INFO - PID 5750 | 22:20:58 INFO - PID 5750 | Cycle 1(1): loaded http://localhost:51338/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51338/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:20:59 INFO - PID 5750 | RSS: Main: 163418112 22:20:59 INFO - PID 5750 | 22:21:02 INFO - PID 5750 | Cycle 1(1): loaded http://localhost:51338/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51338/tests/kraken/driver.html?testName=imaging-darkroom) 22:21:02 INFO - PID 5750 | RSS: Main: 163205120 22:21:02 INFO - PID 5750 | 22:21:06 INFO - PID 5750 | Cycle 1(1): loaded http://localhost:51338/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51338/tests/kraken/driver.html?testName=imaging-desaturate) 22:21:06 INFO - PID 5750 | RSS: Main: 166891520 22:21:06 INFO - PID 5750 | 22:21:09 INFO - PID 5750 | Cycle 1(1): loaded http://localhost:51338/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51338/tests/kraken/driver.html?testName=json-parse-financial) 22:21:10 INFO - PID 5750 | RSS: Main: 168755200 22:21:10 INFO - PID 5750 | 22:21:11 INFO - PID 5750 | Cycle 1(1): loaded http://localhost:51338/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51338/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:21:12 INFO - PID 5750 | RSS: Main: 167096320 22:21:12 INFO - PID 5750 | 22:21:13 INFO - PID 5750 | Cycle 1(1): loaded http://localhost:51338/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51338/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:21:14 INFO - PID 5750 | RSS: Main: 167387136 22:21:14 INFO - PID 5750 | 22:21:16 INFO - PID 5750 | Cycle 1(1): loaded http://localhost:51338/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51338/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:21:17 INFO - PID 5750 | RSS: Main: 167264256 22:21:17 INFO - PID 5750 | 22:21:19 INFO - PID 5750 | Cycle 1(1): loaded http://localhost:51338/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51338/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:21:20 INFO - PID 5750 | RSS: Main: 167059456 22:21:20 INFO - PID 5750 | 22:21:23 INFO - PID 5750 | Cycle 1(1): loaded http://localhost:51338/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51338/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:21:23 INFO - PID 5750 | RSS: Main: 167776256 22:21:23 INFO - PID 5750 | 22:21:25 INFO - PID 5750 | Cycle 1(1): loaded http://localhost:51338/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51338/tests/kraken/driver.html?testName=ai-astar) 22:21:25 INFO - PID 5750 | RSS: Main: 169627648 22:21:25 INFO - PID 5750 | 22:21:25 INFO - PID 5750 | __start_tp_report 22:21:25 INFO - PID 5750 | _x_x_mozilla_page_load 22:21:25 INFO - PID 5750 | _x_x_mozilla_page_load_details 22:21:25 INFO - PID 5750 | |i|pagename|runs| 22:21:25 INFO - PID 5750 | |0;ai-astar;100;106;107;106;108;109;113;112;109;107 22:21:25 INFO - PID 5750 | |1;audio-beat-detection;147;120;140;182;116;148;145;122;173;121 22:21:25 INFO - PID 5750 | |2;audio-dft;161;162;163;159;161;171;162;161;166;163 22:21:25 INFO - PID 5750 | |3;audio-fft;74;76;76;174;78;74;74;73;149;74 22:21:25 INFO - PID 5750 | |4;audio-oscillator;81;81;133;80;81;81;124;81;81;128 22:21:25 INFO - PID 5750 | |5;imaging-gaussian-blur;114;113;113;113;113;114;114;114;114;114 22:21:25 INFO - PID 5750 | |6;imaging-darkroom;147;147;147;149;149;147;147;147;147;147 22:21:25 INFO - PID 5750 | |7;imaging-desaturate;94;95;95;94;93;95;94;94;94;94 22:21:25 INFO - PID 5750 | |8;json-parse-financial;47;45;47;48;48;48;45;49;46;45 22:21:25 INFO - PID 5750 | |9;json-stringify-tinderbox;53;53;54;53;54;53;55;53;52;54 22:21:25 INFO - PID 5750 | |10;stanford-crypto-aes;83;76;76;74;73;74;75;76;73;74 22:21:25 INFO - PID 5750 | |11;stanford-crypto-ccm;121;120;121;122;119;120;118;125;121;159 22:21:25 INFO - PID 5750 | |12;stanford-crypto-pbkdf2;170;172;172;173;168;172;168;169;173;168 22:21:25 INFO - PID 5750 | |13;stanford-crypto-sha256-iterative;61;71;64;62;60;60;62;68;62;61 22:21:25 INFO - PID 5750 | __end_tp_report 22:21:25 INFO - PID 5750 | __start_cc_report 22:21:25 INFO - PID 5750 | _x_x_mozilla_cycle_collect,818 22:21:25 INFO - PID 5750 | __end_cc_report 22:21:25 INFO - PID 5750 | __startTimestamp1498195285788__endTimestamp 22:21:25 INFO - PID 5750 | 22:21:25 INFO - PID 5750 | ------- Summary: start ------- 22:21:25 INFO - PID 5750 | Number of tests: 14 22:21:25 INFO - PID 5750 | 22:21:25 INFO - PID 5750 | [#0] ai-astar Cycles:10 Average:107.70 Median:108.50 stddev:3.59 (3.3%) stddev-sans-first:2.51 22:21:25 INFO - PID 5750 | Values: 100.0 106.0 107.0 106.0 108.0 109.0 113.0 112.0 109.0 107.0 22:21:25 INFO - PID 5750 | 22:21:25 INFO - PID 5750 | [#1] audio-beat-detection Cycles:10 Average:141.40 Median:146.00 stddev:22.69 (15.5%) stddev-sans-first:23.97 22:21:25 INFO - PID 5750 | Values: 147.0 120.0 140.0 182.0 116.0 148.0 145.0 122.0 173.0 121.0 22:21:25 INFO - PID 5750 | 22:21:25 INFO - PID 5750 | [#2] audio-dft Cycles:10 Average:162.90 Median:162.50 stddev:3.38 (2.1%) stddev-sans-first:3.52 22:21:25 INFO - PID 5750 | Values: 161.0 162.0 163.0 159.0 161.0 171.0 162.0 161.0 166.0 163.0 22:21:25 INFO - PID 5750 | 22:21:25 INFO - PID 5750 | [#3] audio-fft Cycles:10 Average:92.20 Median:74.00 stddev:37.02 (50.0%) stddev-sans-first:38.68 22:21:25 INFO - PID 5750 | Values: 74.0 76.0 76.0 174.0 78.0 74.0 74.0 73.0 149.0 74.0 22:21:25 INFO - PID 5750 | 22:21:25 INFO - PID 5750 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:81.00 stddev:23.03 (28.4%) stddev-sans-first:23.86 22:21:25 INFO - PID 5750 | Values: 81.0 81.0 133.0 80.0 81.0 81.0 124.0 81.0 81.0 128.0 22:21:25 INFO - PID 5750 | 22:21:25 INFO - PID 5750 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:114.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 22:21:25 INFO - PID 5750 | Values: 114.0 113.0 113.0 113.0 113.0 114.0 114.0 114.0 114.0 114.0 22:21:25 INFO - PID 5750 | 22:21:25 INFO - PID 5750 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:0.84 (0.6%) stddev-sans-first:0.88 22:21:25 INFO - PID 5750 | Values: 147.0 147.0 147.0 149.0 149.0 147.0 147.0 147.0 147.0 147.0 22:21:25 INFO - PID 5750 | 22:21:25 INFO - PID 5750 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 22:21:25 INFO - PID 5750 | Values: 94.0 95.0 95.0 94.0 93.0 95.0 94.0 94.0 94.0 94.0 22:21:25 INFO - PID 5750 | 22:21:25 INFO - PID 5750 | [#8] json-parse-financial Cycles:10 Average:46.80 Median:47.50 stddev:1.48 (3.1%) stddev-sans-first:1.56 22:21:25 INFO - PID 5750 | Values: 47.0 45.0 47.0 48.0 48.0 48.0 45.0 49.0 46.0 45.0 22:21:25 INFO - PID 5750 | 22:21:25 INFO - PID 5750 | [#9] json-stringify-tinderbox Cycles:10 Average:53.40 Median:53.50 stddev:0.84 (1.6%) stddev-sans-first:0.88 22:21:25 INFO - PID 5750 | Values: 53.0 53.0 54.0 53.0 54.0 53.0 55.0 53.0 52.0 54.0 22:21:25 INFO - PID 5750 | 22:21:25 INFO - PID 5750 | [#10] stanford-crypto-aes Cycles:10 Average:75.40 Median:75.50 stddev:2.91 (3.9%) stddev-sans-first:1.24 22:21:25 INFO - PID 5750 | Values: 83.0 76.0 76.0 74.0 73.0 74.0 75.0 76.0 73.0 74.0 22:21:25 INFO - PID 5750 | 22:21:25 INFO - PID 5750 | [#11] stanford-crypto-ccm Cycles:10 Average:124.60 Median:121.00 stddev:12.23 (10.1%) stddev-sans-first:12.90 22:21:25 INFO - PID 5750 | Values: 121.0 120.0 121.0 122.0 119.0 120.0 118.0 125.0 121.0 159.0 22:21:25 INFO - PID 5750 | 22:21:25 INFO - PID 5750 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.50 Median:172.00 stddev:2.12 (1.2%) stddev-sans-first:2.24 22:21:25 INFO - PID 5750 | Values: 170.0 172.0 172.0 173.0 168.0 172.0 168.0 169.0 173.0 168.0 22:21:25 INFO - PID 5750 | 22:21:25 INFO - PID 5750 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:62.00 stddev:3.63 (5.9%) stddev-sans-first:3.77 22:21:25 INFO - PID 5750 | Values: 61.0 71.0 64.0 62.0 60.0 60.0 62.0 68.0 62.0 61.0 22:21:25 INFO - PID 5750 | -------- Summary: end -------- 22:21:25 INFO - PID 5750 | 22:21:26 INFO - TEST-INFO | 5750: exit 0 22:21:26 INFO - TEST-OK | kraken | took 60104ms 22:21:26 INFO - SUITE-END | took 1175s 22:21:27 INFO - Completed test suite (00:19:35) 22:21:27 INFO - javascript benchmark 22:21:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8550.10383016613, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3394.964535816575, 3399.4390925497296, 3405.0125463615555, 3455.360758259722, 3456.7925924444535, 6162.352952939944, 6194.3805619438035, 6245.313015568284, 6257.937420625793, 6285.685715714208, 6228.19033525641, 6295.0, 6319.684015799215, 6325.778597749079, 6327.651979141146, 5536.390996990328, 5556.9444305556835, 5582.051051321285, 5626.718664066801, 5635.690037047961, 5471.562275018009, 5540.667559946416, 5563.332400111992, 5567.526760225385, 5579.776808927638, 5472.5621950243885, 5513.531349835269, 5525.281713377235, 5525.585581081395, 5537.833864984057, 5569.637973531708, 5570.3315602128005, 5580.274564306615, 5584.469475399871, 5624.887502249973, 5508.6970216638065, 5547.362053363874, 5558.44415558445, 5571.804986825442, 5577.386487486373, 6203.720832562545, 6245.968770156165, 6278.30938596754, 6283.842903927392, 6315.179026726496, 6604.141461610008, 6689.632070236135, 6690.063391125246, 6692.63190524521, 6819.420349270318, 6868.656567171622, 6904.13698287714, 6925.861482770317, 6926.307369263084, 6931.653417329164, 6272.3100458949475, 6326.778562750374, 6335.176427064452, 6352.047192921099, 6353.682315884187, 6778.593284402853, 6869.313068693191, 6888.586684798928, 6890.8621827563165, 6893.345132212432, 6560.40956313934, 6592.604443733296, 6661.9000714989315, 6682.264950855402, 6693.832654183684, 6770.187577490733, 6780.559263647847, 6794.45644348451, 6794.728210871609, 6800.115984922028, 6611.702473388709, 6715.429188518933, 6763.560368576027, 6764.0868482754195, 6775.93224067753, 6688.0, 6712.798616041527, 6716.630585317855, 6761.425278851353, 6764.323567643295, 5092.465291144451, 5120.4111527174855, 5124.538791508782, 5140.948590514122, 5161.690298582097, 4492.910141797146, 4520.81916723334, 4520.864374068783, 4528.071745292207, 4538.11506756186, 6379.393957574116, 6402.359764023654, 6407.423331900151, 6429.45349645276, 6438.678066096676, 6690.13028306317, 6758.864822703518, 6794.898076528856, 6904.620245886424, 6925.549839260432, 6289.528285378615, 6330.272018717815, 6345.841353966188, 6365.840853978595, 6383.170187875547, 5634.971825140848, 5673.461021202979, 5685.431456854281, 5686.3744988051285, 5690.7439165237665, 7049.7532586361285, 7077.610731409719, 7085.893711594227, 7093.290670932865, 7123.394511466583, 6632.104665870046, 6704.698288577123, 6817.5568588041615, 6828.2830302819475, 6835.624040677611, 6970.198427180939, 7064.964675176797, 7077.256888026683, 7110.964445177948, 7135.215126336203, 6690.130283063365, 6717.395434410926, 6777.423918966746, 6778.0510728497065, 6798.93201067983, 6934.445244380337, 6938.687759050754, 6942.514024018472, 6947.5831450113155, 6957.756478523227, 6497.512686548623, 6658.500612453989, 6694.564853284521, 6697.732090716511, 6701.262861085374, 6471.255805582418, 6564.770233041821, 6567.737290508326, 6596.043573681885, 6603.9339606605245, 6527.51043671736, 6626.602403855784, 6674.199096108498, 6687.398134167948, 6732.158480189976, 6682.565633233824, 6731.259561448139, 6732.865342693217, 6734.3265673434225, 6757.898631520433, 6533.607983521004, 6577.210734711865, 6589.308122647245, 6594.241662208716, 6601.273859875314], "value": 6193.402675108765, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [878.8362586684988, 905.7961958559321, 939.2486011191047, 946.659202687033, 960.0111884758696, 40376.394354084674, 42285.0, 42477.150456990916, 42630.14739705204, 42747.78626106873, 38941.221175576546, 39150.804245978805, 39168.21663566727, 39231.41152882709, 39363.40954885679, 6720.831979200522, 6791.626460544668, 6811.965940170317, 6822.113125293729, 6829.385355318021, 6691.464682825363, 6745.696443660047, 6793.694283757242, 6851.588904665736, 6861.725530978755, 6809.931900681004, 6817.216020157671, 6831.282715314895, 6837.042814006043, 6852.6916288767125, 6787.083743694588, 6820.6930688118655, 6846.212685541127, 6862.759803406857, 6868.690908909111, 6205.976013957692, 6239.064140378934, 7189.640517974132, 7277.126744790606, 7359.816004599874, 38022.0, 38208.0, 38420.615793841986, 38472.42291365604, 38644.0, 3468.843902024415, 3561.626029266916, 3564.7326450516057, 3579.552555930509, 3583.175869550018, 29801.25496862574, 29885.103446896628, 29924.0, 30191.547126793117, 30330.69669303301, 3518.700910422617, 3653.5433070866143, 3667.0, 3668.064643515913, 3679.4480827875764, 196506.0, 198455.0, 204905.0, 206990.0, 207254.9637251819, 47884.521154788, 47980.76009619999, 48021.279680804815, 48179.5182048182, 48576.5142348572, 50466.24300635493, 50823.23765143526, 51031.489685103414, 51048.234276485884, 51145.488545114815, 14083.577492675236, 14106.85893141076, 14169.78745318821, 14190.432382704783, 14196.929015354857, 11451.770964580663, 11468.082553395709, 11503.597374091867, 11555.2489088209, 11565.76868462626, 13842.653933651538, 13913.652158695912, 14003.43986240539, 14010.719785604231, 14128.50550230737, 5602.711376383455, 5627.634203776742, 5661.207430959669, 5702.429757024264, 5743.396943320891, 1076.5855145768778, 1082.4587706146926, 1083.1659622090947, 1096.155959910864, 1112.821948488238, 23762.287131386085, 24931.252062438154, 24952.5009499809, 25266.36834079126, 25279.0, 1086.8261078227445, 1201.7782734020666, 1213.8044026633759, 1215.726461546145, 1221.2062159596155, 12380.885720285038, 12429.564965226355, 12581.308028058545, 12780.169288996185, 12782.105252632413, 260031.0, 261621.0, 262950.0, 263839.40401490114, 265951.0, 52627.210591841154, 52781.47218527842, 53030.204546931825, 53249.0, 53697.0, 1435.8923080768984, 1502.7219964306419, 1503.2558883352592, 1520.825105112904, 1524.1083965879864, 21697.891510542348, 22188.557743746605, 22282.331530054125, 22540.66189007199, 23213.41966450852, 37646.811765941, 37684.0, 37906.81046594749, 38102.80948595239, 38281.0, 237637.0, 237718.0, 238809.0, 239208.0, 240034.0, 33045.83477082695, 35609.0, 36181.0, 37185.69850055235, 37361.43957840689, 42989.570104299804, 44108.33837492504, 45064.0, 45315.64053078413, 45583.54416455793, 30899.382012360078, 31194.68805311918, 32090.197745055626, 32270.19324516812, 33280.500792488616, 31886.0, 31952.0, 32934.559458932454, 32947.34105317928, 33397.83301083479, 38408.807955960045, 38931.22137557176, 39013.21973560456, 39065.0, 39095.41356879592, 29247.683854227038, 31030.379392412477, 31743.0, 31750.52374214435, 32511.674883250864, 24134.39664008414, 26165.869170654027, 26314.4737105253, 26458.206253812416, 26603.733962660124], "value": 16992.63237559581, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.2973124132352, 562.1567648527209, 572.3761100400562, 576.2738948924356, 583.387443184656, 21449.67825482619, 22513.662295065587, 22513.887430562867, 22579.887100564494, 22589.54820903581, 24467.877660611717, 24956.62565061521, 26481.735182648168, 26585.468290634177, 26706.19881403556, 6251.031090181018, 6350.936490635104, 6360.268569114542, 6373.139626150457, 6377.0, 6158.6612736299485, 6186.226721659793, 6215.409536094064, 6236.501079913596, 6244.469220116295, 5814.534837213034, 6050.757969681229, 6150.292716337612, 6206.069089636568, 6217.0, 6157.846053848667, 6225.159603453521, 6234.532410069263, 6239.2824825145235, 6257.18656574647, 5696.601237913348, 5744.281964754406, 5745.454181852718, 5767.106098554689, 5795.449432303924, 28619.0, 29161.708382916324, 29693.851530742424, 29720.55419168714, 29802.254943626365, 2157.1802714968367, 2233.932982010542, 2237.832162587796, 2245.8203343732625, 2248.853824501402, 18877.0, 19400.708989365172, 19435.416937491897, 19446.902765486222, 19459.4162175135, 2371.1345358944036, 2392.306231192952, 2433.7566243375522, 2448.1431498975217, 2450.9509809803703, 128409.0, 130656.0, 131203.99999999904, 134230.0, 138503.30748346294, 14777.556673299818, 14878.776818347516, 15204.0, 15251.771223431657, 15309.46416875404, 23344.883275583514, 23453.296401107993, 23535.293941181793, 23554.057837686643, 23706.17028404032, 9327.207187389147, 9383.390079644802, 9388.155066044088, 9577.23382129442, 9636.180924621485, 8302.958485207535, 8325.209105135002, 8525.275351595059, 8528.232459078712, 8557.272631826365, 9180.265578753684, 9298.349115561845, 9355.345125841126, 9426.575804088832, 9608.711738647851, 2636.986815065912, 2640.6303117563557, 4063.959360406358, 4208.684348673862, 4564.3838081859185, 1032.6592224566025, 1046.0323852421914, 1057.825458799305, 1079.3416016230094, 1087.4508373271606, 20914.954252287323, 20948.0, 21097.610488894134, 21208.469788255108, 21897.562048759253, 1052.5158427123456, 1072.84443755655, 1081.6479400749063, 1092.355510248957, 1104.5526561742506, 11119.22165448427, 11215.775684486265, 11261.43692815356, 11264.774704506028, 11433.828492572618, 523956.0, 527184.0, 531925.0, 541670.0, 543040.0, 107115.46442267895, 108556.45721771341, 112643.0, 114004.0, 116563.41718291354, 1203.897668698153, 1204.566356111799, 1237.5792230641446, 1237.6534570320325, 1240.6588188248124, 17098.487045388658, 18143.455696329132, 18351.449456516326, 18429.53926151803, 18734.156962936428, 50131.24803128029, 51921.740391297804, 54064.45935540594, 54132.72933635306, 54926.0, 70336.0, 70824.64587677029, 71267.64366178136, 72086.63956680182, 72403.0, 16447.93088449247, 16603.501894943172, 16761.91619041946, 16823.915880420518, 16899.408520701716, 16113.194340283173, 17600.647987040444, 17661.205245763715, 17821.198046088215, 17824.287028519233, 14794.0, 14868.776968345268, 14964.925175374054, 15019.09885406879, 15134.848651513345, 13195.73608527805, 13455.663608409868, 13819.516316928859, 13916.0, 13927.303634818421, 13929.60703929599, 13975.951803614973, 14144.292785360485, 14162.645933851736, 14210.786838197642, 16671.83297169235, 16767.24547395346, 16767.245473953946, 16848.241829117964, 16973.575660608585, 14091.647708806951, 14361.0, 14755.114693118447, 14831.629209269855, 14881.627959301104], "value": 11729.238517450898, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1418.1491105336795, 1465.120927443534, 1466.3108339080632, 1467.7431449496328, 1474.3660226102786, 14779.704405911889, 15258.923705381485, 15351.69296614067, 15463.458778942739, 15466.226688665578, 14930.104193748382, 15023.924880375584, 15091.773623395658, 15109.773353399707, 15130.773038404433, 2696.5820297853866, 2718.225305787851, 2720.7687346575567, 2722.8638568071615, 2735.5212837753315, 2548.8980440782348, 2662.081581854267, 2664.174106027128, 2666.9466610667773, 2671.2119924622184, 2582.1349847801007, 2644.960325595108, 2686.0, 2693.1920423872857, 2697.3526353675074, 2662.6804783426014, 2768.2387343480505, 2770.030489328719, 2771.4872748541584, 2772.9029483968066, 2673.3717576369536, 2703.1349968010245, 2708.729127087295, 2710.91867243983, 2714.9728502714916, 14878.107313561113, 15201.619959500991, 15209.315580798891, 15221.010634308734, 15240.0, 7952.8409431811615, 8122.959385203036, 8169.0, 8186.0, 8199.95900020496, 4469.486009108961, 4557.475890272628, 4716.292556116576, 4773.188557945123, 4837.588804951583, 1590.992045039779, 1599.2563457991973, 1605.08510149215, 1636.9508914732578, 1640.6718656268795, 25658.615120773204, 25665.0, 25919.611205831927, 25953.74046259551, 25998.61002084951, 6796.218434879953, 6909.585424874524, 6920.30796920314, 7025.473089518205, 7062.435005199572, 17585.47243582669, 17595.73606395905, 17628.20673069715, 17664.558386040193, 17757.911210443865, 7785.182555831556, 8053.59732013397, 8109.635066422025, 8110.594470276463, 8119.147489513516, 7394.260573942563, 7478.102627684604, 7570.16728159902, 7619.809504762426, 7642.273983971514, 5611.354694210218, 5748.597598168088, 5778.6821724804695, 5794.072948328248, 5819.243498345188, 1755.5611097225694, 1769.646070785848, 1794.156746329223, 1804.9819501805077, 1815.7457955886186, 920.4891285336569, 936.091990768953, 938.5401153434905, 968.6948611187454, 979.9020097990286, 7610.505317154367, 7613.9238607613215, 7659.885101723478, 7771.145174030852, 7836.412269079728, 736.7605528203355, 738.8005238585552, 759.0473955186317, 770.2374649097353, 776.5263189454429, 4296.162248361602, 4479.686421950498, 4956.8512944611, 5345.973270133624, 5539.362973258127, 19843.603127937648, 19935.0, 19985.300514482213, 21347.46631334229, 21348.78651213499, 20836.791632083485, 21136.682949755766, 21408.143674252857, 21502.462438439165, 21656.675149872764, 11323.207375483636, 11386.202965792316, 11411.087113030937, 11470.254433461798, 11483.770324593628, 7800.0, 8186.0, 8389.077201507951, 8521.786955325919, 8672.219500245008, 17722.822771772633, 17788.3774067907, 18044.458666240032, 18659.81340186581, 18668.533286667942, 18110.27558897682, 18395.356162534248, 18940.526486837938, 19076.904615476833, 19287.228510859408, 11738.119641026786, 11978.0, 11992.160548761503, 12014.219075760047, 12061.0, 13700.24648644334, 13726.107802992774, 13738.65653358634, 13841.515546955809, 13882.09766365183, 10282.742931426774, 10414.947925260325, 10624.52189651483, 10744.30162039465, 11278.210525263481, 10607.098396636064, 11136.276142050741, 11377.805330440184, 11419.143564232882, 11818.995385391994, 9760.60957561718, 9808.65669701557, 9842.212622990286, 9904.405735655884, 9910.900890990997, 7170.605616691132, 7251.419886408969, 7323.523970941872, 7402.148752893271, 7662.578558179353, 7021.262767409348, 7116.893246601202, 7204.207537171012, 7392.4086073115095, 7512.098548174035], "value": 6617.051569205838, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [514.8635611562934, 514.9562287205587, 519.7167543688689, 533.5758072332495, 537.1030379266624, 6344.302126766058, 6384.170057892467, 6386.074019267204, 6401.471418789575, 6407.935920640793, 6260.624362538251, 6264.342244064376, 6273.7804176853815, 6299.118123462719, 6302.936970630292, 5044.612731498849, 5045.495450454961, 5047.49525047496, 5057.671251368668, 5059.974700126503, 5051.924221136685, 5052.671576347526, 5058.974705126469, 5066.544011039005, 5073.644844860862, 5035.647504674675, 5047.31861198739, 5050.747462626872, 5060.089183946888, 5065.822696205633, 5045.445001049881, 5055.165897626887, 5068.18908974566, 5078.59371250301, 5090.0583392072585, 4187.853425130136, 4359.520452750195, 4435.423394958635, 4658.208104622222, 4678.578927896506, 6093.349393014053, 6095.695215239265, 6103.0, 6109.755609775648, 6121.693915304217, 5798.478136967693, 5829.271341082364, 5837.190470953976, 5848.181254624356, 5864.882702345972, 6634.601923884582, 6636.867262654768, 6663.200415950117, 6683.0, 6704.597724136519, 4977.626677999128, 4987.0, 4999.225120106389, 4999.900001999976, 5020.949790502084, 6744.898826517606, 6900.3099690031095, 6930.341617546325, 7002.124734408199, 7003.5097543172, 4928.876778080505, 5066.113430149709, 5067.949320506747, 5124.231365295161, 5155.381354237516, 5170.1986192140275, 5170.45710200431, 5203.869903252449, 5224.164133738584, 5243.68537887728, 5811.215485909433, 5829.766809327664, 5831.883362332815, 5838.591298609056, 5845.918505076575, 6690.123247003738, 6704.229013663394, 6705.1283333166375, 6707.798766037026, 6755.49333799967, 1795.9820401795814, 1811.8731688781922, 1814.8911065336122, 1822.7903791064198, 1823.1522342110982, 1190.7499425120648, 1257.3273298785107, 1265.2914367953974, 1280.775864223757, 1299.389287035092, 6303.0, 6313.779017734358, 6314.179156709598, 6330.145430366933, 6361.936380636134, 6790.219124800612, 6792.320767923168, 6848.14398200225, 6870.656467176721, 6900.137482814648, 6270.122182894398, 6294.538004097728, 6331.746730130835, 6356.904646430307, 6379.904301435482, 3613.728970327236, 3627.5646922368956, 3638.4178531434845, 3658.359787037258, 3668.926621467609, 7073.514561941947, 7142.178649455275, 7167.605781681953, 7171.1394632644415, 7187.245339239409, 6571.244306904767, 7070.929290707027, 7071.116110486189, 7087.007818905357, 7132.536385134949, 7088.822779430556, 7116.323949224816, 7121.465890058266, 7133.785986420416, 7177.89233161503, 6837.794866154023, 6863.862722745617, 6890.896636550556, 6899.344562266577, 6919.619420931897, 6738.561993470409, 6753.831154221184, 6768.153980752406, 6769.221539523018, 6787.5588086774205, 7100.254473280231, 7158.534695244793, 7168.498205125591, 7178.892316615151, 7214.675339609835, 5138.229265610188, 5173.017126745906, 5182.8963420732125, 5194.662346947436, 5225.686458812484, 6674.699638516181, 6819.693113809792, 6832.624205668736, 6877.899536074204, 6934.375906168469, 6361.173047503795, 6570.127513658585, 6644.734210631521, 6667.599944003376, 6695.531312808057, 6575.704093315908, 6621.238557565942, 6629.337066293332, 6637.800865974028, 6656.900146497903, 6641.0, 6664.801175259556, 6677.565958212701, 6679.198496180489, 6716.361945615159, 6687.832804179934, 6695.598264104169, 6696.363845434676, 6696.933030669826, 6721.865562688817, 6507.414332710079, 6513.697260548004, 6514.57655252407, 6551.246606640298, 6569.310222426768], "value": 5208.794040648192, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [853.2406158518916, 895.4582477601051, 896.7220161749857, 903.9548022598868, 907.4328544659588, 15242.46651367201, 15657.765133522978, 15722.764158537617, 17207.397741079065, 17860.0, 15738.527844164664, 15933.84066159338, 16203.594910127253, 18487.168077436512, 19254.326098586553, 1047.3035431438084, 1061.612511433329, 1065.9200559957994, 1071.1537885070784, 1074.0548317480607, 1006.3106771861299, 1011.367895065584, 1012.0992316837983, 1013.4071568132651, 1067.8398240263984, 1123.5955056179769, 1127.8984891359776, 1129.1362107987395, 1133.0878642692628, 1140.7205234717505, 1065.4140222877386, 1114.83834843948, 1122.5958654884275, 1127.8026345389565, 1129.2941911305393, 772.1814876231213, 797.2585495489193, 811.3184924663252, 812.4272387966529, 814.6415577146096, 16873.66252674952, 16944.915275423667, 16951.49145525636, 17010.48968530946, 17017.404390846386, 18297.542561435937, 18934.810651893444, 18977.810221897744, 19010.33463828773, 19039.90480047591, 14930.70138597222, 15295.0, 15493.690126197413, 15529.611759706098, 15613.765793513106, 3484.8083355415442, 3504.912377190565, 3534.6995505382074, 3545.0960005198767, 3549.6450354964295, 106060.0, 108443.0, 108770.45614771955, 109150.45424772825, 111833.44083279613, 14513.201773902325, 14798.038127521892, 14893.255337233311, 15002.02486838352, 15203.163825989677, 25287.36781580475, 26767.0, 26836.865815671186, 26916.192514224604, 27123.593146102823, 8030.07654119772, 8093.0692970309165, 8132.024157101067, 8231.09457959624, 8306.418550701514, 4074.714769966074, 4087.5912408758886, 4140.772257525865, 4145.66834653227, 4160.2303573838935, 5239.318888544541, 5332.68003919766, 5343.732813359316, 5717.085266357363, 5830.854228644318, 1142.0406858238953, 1171.7890779659572, 1173.8063219568846, 1177.1700950829645, 1177.7408970026581, 692.1071817355555, 714.1822613108066, 719.5970256656185, 727.7562016724456, 735.1472292141091, 12775.936120319524, 12891.871081289068, 12943.676408089874, 13350.465981360638, 13392.330383480787, 685.4310921934782, 692.1348314606741, 718.9245129261457, 729.7774178875494, 737.3879679865698, 6100.8779824404155, 6102.0, 6184.6598437085495, 6203.751849925952, 6303.117563541108, 110756.0, 111665.0, 115794.0, 115906.0, 118918.0, 86360.56819715862, 99835.50082249542, 100867.0, 101388.49305753424, 101887.0, 81096.0, 87002.0, 89815.55092224627, 91060.54469727741, 91080.54459727659, 12514.624561263177, 12724.936375318064, 12753.426095825525, 12926.806097908351, 12942.41759120823, 40663.796681017586, 42341.0, 42669.14661706811, 42957.355639664805, 44253.55746442623, 69683.65158174177, 71975.64012179905, 72424.0, 73892.0, 74894.0, 18634.72047919255, 19038.619227615094, 19048.142833572245, 19245.711314330016, 19261.22955081837, 20172.697409539163, 21254.681179782005, 21476.26872306079, 21583.784162158805, 22053.779462205173, 18657.626847462703, 20209.69685454749, 20410.59178816445, 20521.38435846927, 20564.691529627366, 18235.635287293913, 19001.42995710131, 19020.524486887938, 19184.328548500736, 19485.025748712225, 18593.34923277679, 19422.417327480198, 19749.111289992274, 19856.0, 20311.187552497733, 13217.801732973821, 13974.720505590034, 14172.858271417153, 14173.0, 14539.636509087357, 14298.928505357406, 15066.246687665793, 15284.847151528342, 15468.767968480257, 16151.111688856756], "value": 9182.112009652528, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1488.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 106.0, 107.0, 106.0, 108.0, 109.0, 113.0, 112.0, 109.0, 107.0], "value": 107.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 120.0, 140.0, 182.0, 116.0, 148.0, 145.0, 122.0, 173.0, 121.0], "value": 141.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 163.0, 159.0, 161.0, 171.0, 162.0, 161.0, 166.0, 163.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 174.0, 78.0, 74.0, 74.0, 73.0, 149.0, 74.0], "value": 92.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 133.0, 80.0, 81.0, 81.0, 124.0, 81.0, 81.0, 128.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 113.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 149.0, 149.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 93.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 45.0, 47.0, 48.0, 48.0, 48.0, 45.0, 49.0, 46.0, 45.0], "value": 46.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 54.0, 53.0, 54.0, 53.0, 55.0, 53.0, 52.0, 54.0], "value": 53.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 76.0, 76.0, 74.0, 73.0, 74.0, 75.0, 76.0, 73.0, 74.0], "value": 75.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 120.0, 121.0, 122.0, 119.0, 120.0, 118.0, 125.0, 121.0, 159.0], "value": 124.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 172.0, 172.0, 173.0, 168.0, 172.0, 168.0, 169.0, 173.0, 168.0], "value": 170.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 71.0, 64.0, 62.0, 60.0, 60.0, 62.0, 68.0, 62.0, 61.0], "value": 63.1, "unit": "score"}]}]} 22:21:27 INFO - Return code: 0 22:21:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:21:27 INFO - # TBPL SUCCESS # 22:21:27 INFO - Running post-action listener: _resource_record_post_action 22:21:27 INFO - [mozharness: 2017-06-23 05:21:27.136732Z] Finished run-tests step (success) 22:21:27 INFO - Running post-run listener: _resource_record_post_run 22:21:27 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 36864; Write bytes: 435359744; Read time: 44; Write time: 364380 22:21:27 INFO - TinderboxPrint: CPU usage
13.1% 22:21:27 INFO - TinderboxPrint: I/O read bytes / time
36,864 / 44 22:21:27 INFO - TinderboxPrint: I/O write bytes / time
435,359,744 / 364,380 22:21:27 INFO - TinderboxPrint: CPU idle
8,271.1 (86.9%) 22:21:27 INFO - TinderboxPrint: CPU user
1,198.4 (12.6%) 22:21:27 INFO - TinderboxPrint: Swap in / out
0 / 0 22:21:27 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 116764672; Read time: 0; Write time: 117180 22:21:27 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 22:21:27 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 36864; Write bytes: 318595072; Read time: 44; Write time: 247200 22:21:27 INFO - Running post-run listener: _upload_blobber_files 22:21:27 INFO - Blob upload gear active. 22:21:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:21:27 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 22:21:27 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'] 22:21:27 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 22:21:28 INFO - (blobuploader) - INFO - Open directory for files ... 22:21:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 22:21:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:21:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:21:29 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 22:21:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:21:29 INFO - (blobuploader) - INFO - Done attempting. 22:21:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:21:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:21:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:21:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:21:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:21:29 INFO - (blobuploader) - INFO - Done attempting. 22:21:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:21:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:21:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:21:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:21:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:21:30 INFO - (blobuploader) - INFO - Done attempting. 22:21:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:21:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:21:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:21:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:21:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:21:37 INFO - (blobuploader) - INFO - Done attempting. 22:21:37 INFO - (blobuploader) - INFO - Iteration through files over. 22:21:37 INFO - Return code: 0 22:21:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:21:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:21:37 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c720668c092ef31e7ddb25f021bfbfc73b6ba73460aeae3d92dc700ba5e0009689bfa6b2be4a00bca817cb120a0473e16e6406d1a9db913ebfb69753ec8b2b5d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/831752ccf4415b2ce535684f795b714045e32802cf9ddc66971c9bf9fb9d9e5db6f886c0639137e9f47bdee74fc41dcf5c745a9813b3809e51e90479c88b16e1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cda85dd2d877aceb6ae1e4faa7f800aefea41e5e0398e2c81e1a71e93079f6df9f8b10e1d7acb797eae6f598a537c7ec3d2b859a93b92b11521b448f46778824", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30aa1dcdfa3dd5350a0184bac788c3bcf65bffb8cc6669f8994a6fc8e45cd5a692818c308abd41d00fc07823125540c85bf159b2f79ec4546436495af7aef62d"} 22:21:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:21:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:21:37 INFO - Contents: 22:21:37 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c720668c092ef31e7ddb25f021bfbfc73b6ba73460aeae3d92dc700ba5e0009689bfa6b2be4a00bca817cb120a0473e16e6406d1a9db913ebfb69753ec8b2b5d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/831752ccf4415b2ce535684f795b714045e32802cf9ddc66971c9bf9fb9d9e5db6f886c0639137e9f47bdee74fc41dcf5c745a9813b3809e51e90479c88b16e1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cda85dd2d877aceb6ae1e4faa7f800aefea41e5e0398e2c81e1a71e93079f6df9f8b10e1d7acb797eae6f598a537c7ec3d2b859a93b92b11521b448f46778824", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30aa1dcdfa3dd5350a0184bac788c3bcf65bffb8cc6669f8994a6fc8e45cd5a692818c308abd41d00fc07823125540c85bf159b2f79ec4546436495af7aef62d"} 22:21:37 INFO - Running post-run listener: copy_logs_to_upload_dir 22:21:37 INFO - Copying logs to upload dir... 22:21:37 INFO - mkdir: /builds/slave/test/build/upload/logs 22:21:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.489758 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-06-22 22:21:37.509744) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-22 22:21:37.513051) ========= 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=14ef55db36f7623abb31b9cf000001d5-1498194038.511534-101350444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c720668c092ef31e7ddb25f021bfbfc73b6ba73460aeae3d92dc700ba5e0009689bfa6b2be4a00bca817cb120a0473e16e6406d1a9db913ebfb69753ec8b2b5d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/831752ccf4415b2ce535684f795b714045e32802cf9ddc66971c9bf9fb9d9e5db6f886c0639137e9f47bdee74fc41dcf5c745a9813b3809e51e90479c88b16e1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cda85dd2d877aceb6ae1e4faa7f800aefea41e5e0398e2c81e1a71e93079f6df9f8b10e1d7acb797eae6f598a537c7ec3d2b859a93b92b11521b448f46778824", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30aa1dcdfa3dd5350a0184bac788c3bcf65bffb8cc6669f8994a6fc8e45cd5a692818c308abd41d00fc07823125540c85bf159b2f79ec4546436495af7aef62d"} build_url:https://queue.taskcluster.net/v1/task/baktnaa2RvObUaWwfN7tLg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011244 build_url: 'https://queue.taskcluster.net/v1/task/baktnaa2RvObUaWwfN7tLg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c720668c092ef31e7ddb25f021bfbfc73b6ba73460aeae3d92dc700ba5e0009689bfa6b2be4a00bca817cb120a0473e16e6406d1a9db913ebfb69753ec8b2b5d", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/831752ccf4415b2ce535684f795b714045e32802cf9ddc66971c9bf9fb9d9e5db6f886c0639137e9f47bdee74fc41dcf5c745a9813b3809e51e90479c88b16e1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cda85dd2d877aceb6ae1e4faa7f800aefea41e5e0398e2c81e1a71e93079f6df9f8b10e1d7acb797eae6f598a537c7ec3d2b859a93b92b11521b448f46778824", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/30aa1dcdfa3dd5350a0184bac788c3bcf65bffb8cc6669f8994a6fc8e45cd5a692818c308abd41d00fc07823125540c85bf159b2f79ec4546436495af7aef62d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-22 22:21:37.539130) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-22 22:21:37.539629) ========= 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=14ef55db36f7623abb31b9cf000001d5-1498194038.511534-101350444 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004461 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-22 22:21:37.624338) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-22 22:21:37.624658) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-22 22:21:37.624947) ========= ========= Total master_lag: 0.19 =========