builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-076 starttime: 1496941317.93 results: success (0) revision: e61060be36424240058f8bef4c5597f401bc8b7e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-08 10:01:57.926481) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-08 10:01:57.926930) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-08 10:01:57.927199) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-08 10:01:57.943453) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 10:01:57.943780) ========= 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=9bfb7e13875ed353a705960e000001c0-1496931357.65609-362803370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-08 10:02:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 25.5M=0s 2017-06-08 10:02:02 (25.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.133282 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 10:01:58.090240) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 10:01:58.093647) ========= 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=9bfb7e13875ed353a705960e000001c0-1496931357.65609-362803370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015268 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 10:01:58.143261) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-08 10:01:58.146709) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e61060be36424240058f8bef4c5597f401bc8b7e --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 e61060be36424240058f8bef4c5597f401bc8b7e --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=9bfb7e13875ed353a705960e000001c0-1496931357.65609-362803370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-08 10:02:02,292 truncating revision to first 12 chars 2017-06-08 10:02:02,292 Setting DEBUG logging. 2017-06-08 10:02:02,292 attempt 1/10 2017-06-08 10:02:02,292 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e61060be3642?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-08 10:02:03,098 unpacking tar archive at: mozilla-central-e61060be3642/testing/mozharness/ program finished with exit code 0 elapsedTime=1.138495 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-08 10:01:59.300732) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-08 10:01:59.301127) ========= script_repo_revision: e61060be36424240058f8bef4c5597f401bc8b7e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-08 10:01:59.301556) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-08 10:01:59.301837) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-08 10:01:59.311209) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 51 secs) (at 2017-06-08 10:01:59.311611) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9bfb7e13875ed353a705960e000001c0-1496931357.65609-362803370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:02:03 INFO - MultiFileLogger online at 20170608 10:02:03 in /builds/slave/test 10:02:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 10:02:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:02:03 INFO - {'append_to_log': False, 10:02:03 INFO - 'base_work_dir': '/builds/slave/test', 10:02:03 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 10:02:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:02:03 INFO - 'branch': 'Firefox-Non-PGO', 10:02:03 INFO - 'buildbot_json_path': 'buildprops.json', 10:02:03 INFO - 'config_files': ('talos/linux_config.py',), 10:02:03 INFO - 'default_actions': ('clobber', 10:02:03 INFO - 'read-buildbot-config', 10:02:03 INFO - 'download-and-extract', 10:02:03 INFO - 'populate-webroot', 10:02:03 INFO - 'create-virtualenv', 10:02:03 INFO - 'install', 10:02:03 INFO - 'setup-mitmproxy', 10:02:03 INFO - 'run-tests'), 10:02:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:02:03 INFO - 'download_minidump_stackwalk': True, 10:02:03 INFO - 'download_symbols': 'ondemand', 10:02:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:02:03 INFO - 'tooltool.py': '/tools/tooltool.py', 10:02:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:02:03 INFO - '/tools/misc-python/virtualenv.py')}, 10:02:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:02:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:02:03 INFO - 'gecko_profile': False, 10:02:03 INFO - 'gecko_profile_interval': 0, 10:02:03 INFO - 'installer_path': 'installer.exe', 10:02:03 INFO - 'log_level': 'info', 10:02:03 INFO - 'log_name': 'talos', 10:02:03 INFO - 'log_to_console': True, 10:02:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:02:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:02:03 INFO - 'opt_config_files': (), 10:02:03 INFO - 'pip_index': False, 10:02:03 INFO - 'suite': 'dromaeojs-e10s', 10:02:03 INFO - 'system_bits': '32', 10:02:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:02:03 INFO - 'title': 'talos-linux64-ix-076', 10:02:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:02:03 INFO - 'use_talos_json': True, 10:02:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:02:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:02:03 INFO - 'work_dir': 'build'} 10:02:03 INFO - [mozharness: 2017-06-08 17:02:03.551074Z] Running clobber step. 10:02:03 INFO - Running pre-action listener: _resource_record_pre_action 10:02:03 INFO - Running main action method: clobber 10:02:03 INFO - rmtree: /builds/slave/test/build 10:02:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:02:04 INFO - Running post-action listener: _resource_record_post_action 10:02:04 INFO - [mozharness: 2017-06-08 17:02:04.582607Z] Finished clobber step (success) 10:02:04 INFO - [mozharness: 2017-06-08 17:02:04.582709Z] Running read-buildbot-config step. 10:02:04 INFO - Running pre-action listener: _resource_record_pre_action 10:02:04 INFO - Running main action method: read_buildbot_config 10:02:04 INFO - Using buildbot properties: 10:02:04 INFO - { 10:02:04 INFO - "project": "", 10:02:04 INFO - "product": "firefox", 10:02:04 INFO - "who": "ffxbld@noreply.mozilla.org", 10:02:04 INFO - "installer_path": "public/build/target.tar.bz2", 10:02:04 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 10:02:04 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 10:02:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 10:02:04 INFO - "stage_platform": "linux64", 10:02:04 INFO - "basedir": "/builds/slave/test", 10:02:04 INFO - "buildnumber": 661, 10:02:04 INFO - "platform": "ubuntu64_hw", 10:02:04 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:02:04 INFO - "slavebuilddir": "test", 10:02:04 INFO - "taskId": "a2vFkIsiRMWSEhhGIXPGAg", 10:02:04 INFO - "branch": "mozilla-central", 10:02:04 INFO - "script_repo_revision": "production", 10:02:04 INFO - "revision": "e61060be36424240058f8bef4c5597f401bc8b7e", 10:02:04 INFO - "slavename": "talos-linux64-ix-076", 10:02:04 INFO - "repo_path": "mozilla-central" 10:02:04 INFO - } 10:02:04 INFO - Finding installer, test and symbols from parent task. 10:02:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a2vFkIsiRMWSEhhGIXPGAg'}, attempt #1 10:02:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a2vFkIsiRMWSEhhGIXPGAg'}, attempt #1 10:02:05 INFO - Task dependencies: bpIrWjRKQX-5uA_EuI5bMg 10:02:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bpIrWjRKQX-5uA_EuI5bMg'}, attempt #1 10:02:05 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/bpIrWjRKQX-5uA_EuI5bMg/artifacts/public/build/target.tar.bz2 10:02:05 INFO - Set test_url: https://queue.taskcluster.net/v1/task/bpIrWjRKQX-5uA_EuI5bMg/artifacts/public/build/test_packages.json 10:02:05 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/bpIrWjRKQX-5uA_EuI5bMg/artifacts/public/build/target.crashreporter-symbols.zip 10:02:05 INFO - Running post-action listener: _resource_record_post_action 10:02:05 INFO - [mozharness: 2017-06-08 17:02:05.983295Z] Finished read-buildbot-config step (success) 10:02:05 INFO - [mozharness: 2017-06-08 17:02:05.983518Z] Running download-and-extract step. 10:02:05 INFO - Running pre-action listener: _resource_record_pre_action 10:02:05 INFO - Running main action method: download_and_extract 10:02:05 INFO - mkdir: /builds/slave/test/build/tests 10:02:05 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')]} 10:02:05 INFO - trying https://queue.taskcluster.net/v1/task/bpIrWjRKQX-5uA_EuI5bMg/artifacts/public/build/target.test_packages.json 10:02:05 INFO - Downloading https://queue.taskcluster.net/v1/task/bpIrWjRKQX-5uA_EuI5bMg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 10:02:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bpIrWjRKQX-5uA_EuI5bMg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 10:02:06 INFO - Downloaded 989 bytes. 10:02:06 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 10:02:06 INFO - Using the following test package requirements: 10:02:06 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 10:02:06 INFO - u'common': [u'target.common.tests.zip'], 10:02:06 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 10:02:06 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 10:02:06 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 10:02:06 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 10:02:06 INFO - u'mozbase': [u'target.common.tests.zip'], 10:02:06 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 10:02:06 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 10:02:06 INFO - u'web-platform': [u'target.common.tests.zip', 10:02:06 INFO - u'target.web-platform.tests.tar.gz'], 10:02:06 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 10:02:06 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 10:02:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bpIrWjRKQX-5uA_EuI5bMg/artifacts/public/build/target.common.tests.zip 10:02:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bpIrWjRKQX-5uA_EuI5bMg/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:02:06 INFO - Fetch https://queue.taskcluster.net/v1/task/bpIrWjRKQX-5uA_EuI5bMg/artifacts/public/build/target.common.tests.zip into memory 10:02:07 INFO - Content-Length response header: 67875771 10:02:07 INFO - Bytes received: 67875771 10:02:18 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 10:02:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bpIrWjRKQX-5uA_EuI5bMg/artifacts/public/build/target.common.tests.zip 10:02:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bpIrWjRKQX-5uA_EuI5bMg/artifacts/public/build/target.common.tests.zip'}, attempt #1 10:02:18 INFO - Fetch https://queue.taskcluster.net/v1/task/bpIrWjRKQX-5uA_EuI5bMg/artifacts/public/build/target.common.tests.zip into memory 10:02:20 INFO - Content-Length response header: 67875771 10:02:20 INFO - Bytes received: 67875771 10:02:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bpIrWjRKQX-5uA_EuI5bMg/artifacts/public/build/target.talos.tests.zip 10:02:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bpIrWjRKQX-5uA_EuI5bMg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 10:02:32 INFO - Fetch https://queue.taskcluster.net/v1/task/bpIrWjRKQX-5uA_EuI5bMg/artifacts/public/build/target.talos.tests.zip into memory 10:02:33 INFO - Content-Length response header: 14447568 10:02:33 INFO - Bytes received: 14447568 10:02:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:33 INFO - trying https://queue.taskcluster.net/v1/task/bpIrWjRKQX-5uA_EuI5bMg/artifacts/public/build/target.tar.bz2 10:02:33 INFO - Downloading https://queue.taskcluster.net/v1/task/bpIrWjRKQX-5uA_EuI5bMg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 10:02:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bpIrWjRKQX-5uA_EuI5bMg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 10:02:35 INFO - Downloaded 58790525 bytes. 10:02:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bpIrWjRKQX-5uA_EuI5bMg/artifacts/public/build/target.tar.bz2 10:02:35 INFO - mkdir: /builds/slave/test/properties 10:02:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:02:35 INFO - Writing to file /builds/slave/test/properties/build_url 10:02:35 INFO - Contents: 10:02:35 INFO - build_url:https://queue.taskcluster.net/v1/task/bpIrWjRKQX-5uA_EuI5bMg/artifacts/public/build/target.tar.bz2 10:02:35 INFO - Running post-action listener: _resource_record_post_action 10:02:35 INFO - Running post-action listener: set_extra_try_arguments 10:02:35 INFO - [mozharness: 2017-06-08 17:02:35.065254Z] Finished download-and-extract step (success) 10:02:35 INFO - [mozharness: 2017-06-08 17:02:35.065479Z] Running populate-webroot step. 10:02:35 INFO - Running pre-action listener: _resource_record_pre_action 10:02:35 INFO - Running main action method: populate_webroot 10:02:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:02:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:02:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:02:35 INFO - '--tppagecycles', 10:02:35 INFO - '7'], 10:02:35 INFO - 'tests': ['tsvgm']}}, 10:02:35 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:02:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:02:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:02:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:02:35 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:02:35 INFO - 'talos_options': ['--disable-e10s'], 10:02:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:02:35 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:02:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:02:35 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:02:35 INFO - 'talos_options': ['--disable-e10s'], 10:02:35 INFO - 'tests': ['damp', 'tps']}, 10:02:35 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:02:35 INFO - 'tests': ['damp', 'tps']}, 10:02:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:02:35 INFO - 'tests': ['dromaeo_dom']}, 10:02:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:02:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:02:35 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 10:02:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 10:02:35 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 10:02:35 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 10:02:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:02:35 INFO - 'tests': ['a11yr', 10:02:35 INFO - 'ts_paint', 10:02:35 INFO - 'tpaint', 10:02:35 INFO - 'sessionrestore', 10:02:35 INFO - 'sessionrestore_no_auto_restore', 10:02:35 INFO - 'tabpaint']}, 10:02:35 INFO - 'other-e10s': {'tests': ['a11yr', 10:02:35 INFO - 'ts_paint', 10:02:35 INFO - 'tpaint', 10:02:35 INFO - 'sessionrestore', 10:02:35 INFO - 'sessionrestore_no_auto_restore', 10:02:35 INFO - 'tabpaint']}, 10:02:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:02:35 INFO - 'ts_paint', 10:02:35 INFO - 'tpaint', 10:02:35 INFO - 'sessionrestore', 10:02:35 INFO - 'sessionrestore_no_auto_restore', 10:02:35 INFO - 'tabpaint']}, 10:02:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:02:35 INFO - 'ts_paint', 10:02:35 INFO - 'tpaint', 10:02:35 INFO - 'sessionrestore', 10:02:35 INFO - 'sessionrestore_no_auto_restore', 10:02:35 INFO - 'tabpaint']}, 10:02:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:02:35 INFO - 'tests': ['a11yr', 10:02:35 INFO - 'ts_paint', 10:02:35 INFO - 'tpaint', 10:02:35 INFO - 'sessionrestore', 10:02:35 INFO - 'sessionrestore_no_auto_restore', 10:02:35 INFO - 'tabpaint']}, 10:02:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:02:35 INFO - 'tests': ['a11yr', 10:02:35 INFO - 'ts_paint', 10:02:35 INFO - 'tpaint', 10:02:35 INFO - 'sessionrestore', 10:02:35 INFO - 'sessionrestore_no_auto_restore', 10:02:35 INFO - 'tabpaint']}, 10:02:35 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 10:02:35 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 10:02:35 INFO - 'bloom_basic_ref']}, 10:02:35 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 10:02:35 INFO - 'talos_options': ['--mitmproxy', 10:02:35 INFO - 'mitmproxy-recording-1.mp', 10:02:35 INFO - '--firstNonBlankPaint'], 10:02:35 INFO - 'tests': ['Quantum_1']}, 10:02:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:02:35 INFO - 'tests': ['tsvgx', 10:02:35 INFO - 'tsvgr_opacity', 10:02:35 INFO - 'tart', 10:02:35 INFO - 'tscrollx', 10:02:35 INFO - 'cart', 10:02:35 INFO - 'tsvg_static']}, 10:02:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:02:35 INFO - 'tsvgr_opacity', 10:02:35 INFO - 'tart', 10:02:35 INFO - 'tscrollx', 10:02:35 INFO - 'cart', 10:02:35 INFO - 'tsvg_static']}, 10:02:35 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:02:35 INFO - 'talos_options': ['--disable-e10s'], 10:02:35 INFO - 'tests': ['tp5o']}, 10:02:35 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:02:35 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:02:35 INFO - 'talos_options': ['--disable-e10s', 10:02:35 INFO - '--xperf_path', 10:02:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:02:35 INFO - 'tests': ['tp5n']}, 10:02:35 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:02:35 INFO - 'talos_options': ['--xperf_path', 10:02:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:02:35 INFO - 'tests': ['tp5n']}}, 10:02:35 INFO - 'talos.zip': {'path': '', 10:02:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:02:35 INFO - Running post-action listener: _resource_record_post_action 10:02:35 INFO - [mozharness: 2017-06-08 17:02:35.082531Z] Finished populate-webroot step (success) 10:02:35 INFO - [mozharness: 2017-06-08 17:02:35.082627Z] Running create-virtualenv step. 10:02:35 INFO - Running pre-action listener: _resource_record_pre_action 10:02:35 INFO - Running main action method: create_virtualenv 10:02:35 INFO - Creating virtualenv /builds/slave/test/build/venv 10:02:35 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 10:02:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:02:35 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 10:02:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:02:35 INFO - Using real prefix '/usr' 10:02:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:02:35 INFO - Installing distribute.............................................................................................................................................................................................done. 10:02:37 INFO - Installing pip.................done. 10:02:37 INFO - Return code: 0 10:02:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:02:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:02:37 INFO - Reading from file tmpfile_stdout 10:02:37 INFO - Output received: 10:02:37 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) 10:02:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x151f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x189d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189b140>, '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 0x189ba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x189bed0>, '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': '9bfb7e13875ed353a705960e000001c0-1496931357.65609-362803370', '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 10:02:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:02:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:02:37 INFO - Using env: {'DISPLAY': ':0', 10:02:37 INFO - 'HOME': '/home/cltbld', 10:02:37 INFO - 'LANG': 'en_US.UTF-8', 10:02:37 INFO - 'LANGUAGE': 'en_US:en', 10:02:37 INFO - 'LOGNAME': 'cltbld', 10:02:37 INFO - 'MAIL': '/var/mail/cltbld', 10:02:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:37 INFO - 'MOZ_NO_REMOTE': '1', 10:02:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:37 INFO - 'NO_EM_RESTART': '1', 10:02:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:37 INFO - 'PWD': '/builds/slave/test', 10:02:37 INFO - 'SHELL': '/bin/bash', 10:02:37 INFO - 'SHLVL': '1', 10:02:37 INFO - 'TERM': 'linux', 10:02:37 INFO - 'TMOUT': '86400', 10:02:37 INFO - 'USER': 'cltbld', 10:02:37 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1496931357.65609-362803370', 10:02:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:37 INFO - '_': '/tools/buildbot/bin/python'} 10:02:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:38 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 10:02:38 INFO - Cleaning up... 10:02:38 INFO - Return code: 0 10:02:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:02:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x151f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x189d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189b140>, '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 0x189ba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x189bed0>, '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': '9bfb7e13875ed353a705960e000001c0-1496931357.65609-362803370', '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 10:02:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:02:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:02:38 INFO - Using env: {'DISPLAY': ':0', 10:02:38 INFO - 'HOME': '/home/cltbld', 10:02:38 INFO - 'LANG': 'en_US.UTF-8', 10:02:38 INFO - 'LANGUAGE': 'en_US:en', 10:02:38 INFO - 'LOGNAME': 'cltbld', 10:02:38 INFO - 'MAIL': '/var/mail/cltbld', 10:02:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:38 INFO - 'MOZ_NO_REMOTE': '1', 10:02:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:38 INFO - 'NO_EM_RESTART': '1', 10:02:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:38 INFO - 'PWD': '/builds/slave/test', 10:02:38 INFO - 'SHELL': '/bin/bash', 10:02:38 INFO - 'SHLVL': '1', 10:02:38 INFO - 'TERM': 'linux', 10:02:38 INFO - 'TMOUT': '86400', 10:02:38 INFO - 'USER': 'cltbld', 10:02:38 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1496931357.65609-362803370', 10:02:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:38 INFO - '_': '/tools/buildbot/bin/python'} 10:02:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:38 INFO - Downloading/unpacking psutil>=3.1.1 10:02:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:02:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:02:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:02:39 INFO - Installing collected packages: psutil 10:02:39 INFO - Running setup.py install for psutil 10:02:39 INFO - building 'psutil._psutil_linux' extension 10:02:39 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 10:02:39 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 10:02:39 INFO - building 'psutil._psutil_posix' extension 10:02:39 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 10:02:39 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 10:02:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:02:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:02:39 INFO - Successfully installed psutil 10:02:39 INFO - Cleaning up... 10:02:40 INFO - Return code: 0 10:02:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:02:40 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')]} 10:02:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:40 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')]} 10:02:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:40 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 0x151f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x189d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189b140>, '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 0x189ba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x189bed0>, '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': '9bfb7e13875ed353a705960e000001c0-1496931357.65609-362803370', '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 10:02:40 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 10:02:40 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 10:02:40 INFO - Using env: {'DISPLAY': ':0', 10:02:40 INFO - 'HOME': '/home/cltbld', 10:02:40 INFO - 'LANG': 'en_US.UTF-8', 10:02:40 INFO - 'LANGUAGE': 'en_US:en', 10:02:40 INFO - 'LOGNAME': 'cltbld', 10:02:40 INFO - 'MAIL': '/var/mail/cltbld', 10:02:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:40 INFO - 'MOZ_NO_REMOTE': '1', 10:02:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:40 INFO - 'NO_EM_RESTART': '1', 10:02:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:40 INFO - 'PWD': '/builds/slave/test', 10:02:40 INFO - 'SHELL': '/bin/bash', 10:02:40 INFO - 'SHLVL': '1', 10:02:40 INFO - 'TERM': 'linux', 10:02:40 INFO - 'TMOUT': '86400', 10:02:40 INFO - 'USER': 'cltbld', 10:02:40 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1496931357.65609-362803370', 10:02:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:40 INFO - '_': '/tools/buildbot/bin/python'} 10:02:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:02:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:02:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:02:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:02:41 INFO - Installing collected packages: mozsystemmonitor 10:02:41 INFO - Running setup.py install for mozsystemmonitor 10:02:41 INFO - Successfully installed mozsystemmonitor 10:02:41 INFO - Cleaning up... 10:02:41 INFO - Return code: 0 10:02:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:02:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:41 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 0x151f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x189d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189b140>, '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 0x189ba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x189bed0>, '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': '9bfb7e13875ed353a705960e000001c0-1496931357.65609-362803370', '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 10:02:41 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 10:02:41 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 10:02:41 INFO - Using env: {'DISPLAY': ':0', 10:02:41 INFO - 'HOME': '/home/cltbld', 10:02:41 INFO - 'LANG': 'en_US.UTF-8', 10:02:41 INFO - 'LANGUAGE': 'en_US:en', 10:02:41 INFO - 'LOGNAME': 'cltbld', 10:02:41 INFO - 'MAIL': '/var/mail/cltbld', 10:02:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:41 INFO - 'MOZ_NO_REMOTE': '1', 10:02:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:41 INFO - 'NO_EM_RESTART': '1', 10:02:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:41 INFO - 'PWD': '/builds/slave/test', 10:02:41 INFO - 'SHELL': '/bin/bash', 10:02:41 INFO - 'SHLVL': '1', 10:02:41 INFO - 'TERM': 'linux', 10:02:41 INFO - 'TMOUT': '86400', 10:02:41 INFO - 'USER': 'cltbld', 10:02:41 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1496931357.65609-362803370', 10:02:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:41 INFO - '_': '/tools/buildbot/bin/python'} 10:02:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:41 INFO - Downloading/unpacking jsonschema==2.5.1 10:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:02:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:02:42 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 10:02:42 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 10:02:42 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 10:02:42 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 10:02:42 INFO - Downloading functools32-3.2.3-2.tar.gz 10:02:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:02:42 INFO - warning: no files found matching '*.txt' 10:02:42 INFO - no previously-included directories found matching 'build' 10:02:42 INFO - no previously-included directories found matching 'dist' 10:02:42 INFO - no previously-included directories found matching '.git*' 10:02:42 INFO - Installing collected packages: jsonschema, functools32 10:02:43 INFO - Running setup.py install for functools32 10:02:43 INFO - warning: no files found matching '*.txt' 10:02:43 INFO - no previously-included directories found matching 'build' 10:02:43 INFO - no previously-included directories found matching 'dist' 10:02:43 INFO - no previously-included directories found matching '.git*' 10:02:43 INFO - Successfully installed jsonschema functools32 10:02:43 INFO - Cleaning up... 10:02:43 INFO - Return code: 0 10:02:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:02: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')]} 10:02:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02: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')]} 10:02:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:43 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 0x151f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x189d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189b140>, '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 0x189ba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x189bed0>, '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': '9bfb7e13875ed353a705960e000001c0-1496931357.65609-362803370', '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 10:02:43 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 10:02:43 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 10:02:43 INFO - Using env: {'DISPLAY': ':0', 10:02:43 INFO - 'HOME': '/home/cltbld', 10:02:43 INFO - 'LANG': 'en_US.UTF-8', 10:02:43 INFO - 'LANGUAGE': 'en_US:en', 10:02:43 INFO - 'LOGNAME': 'cltbld', 10:02:43 INFO - 'MAIL': '/var/mail/cltbld', 10:02:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:43 INFO - 'MOZ_NO_REMOTE': '1', 10:02:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:43 INFO - 'NO_EM_RESTART': '1', 10:02:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:43 INFO - 'PWD': '/builds/slave/test', 10:02:43 INFO - 'SHELL': '/bin/bash', 10:02:43 INFO - 'SHLVL': '1', 10:02:43 INFO - 'TERM': 'linux', 10:02:43 INFO - 'TMOUT': '86400', 10:02:43 INFO - 'USER': 'cltbld', 10:02:43 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1496931357.65609-362803370', 10:02:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:43 INFO - '_': '/tools/buildbot/bin/python'} 10:02:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:02:43 INFO - Cleaning up... 10:02:43 INFO - Return code: 0 10:02:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:02: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')]} 10:02:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02: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')]} 10:02:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:43 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 0x151f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x189d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189b140>, '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 0x189ba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x189bed0>, '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': '9bfb7e13875ed353a705960e000001c0-1496931357.65609-362803370', '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 10:02:43 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 10:02:43 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 10:02:43 INFO - Using env: {'DISPLAY': ':0', 10:02:43 INFO - 'HOME': '/home/cltbld', 10:02:43 INFO - 'LANG': 'en_US.UTF-8', 10:02:43 INFO - 'LANGUAGE': 'en_US:en', 10:02:43 INFO - 'LOGNAME': 'cltbld', 10:02:43 INFO - 'MAIL': '/var/mail/cltbld', 10:02:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:43 INFO - 'MOZ_NO_REMOTE': '1', 10:02:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:43 INFO - 'NO_EM_RESTART': '1', 10:02:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:43 INFO - 'PWD': '/builds/slave/test', 10:02:43 INFO - 'SHELL': '/bin/bash', 10:02:43 INFO - 'SHLVL': '1', 10:02:43 INFO - 'TERM': 'linux', 10:02:43 INFO - 'TMOUT': '86400', 10:02:43 INFO - 'USER': 'cltbld', 10:02:43 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1496931357.65609-362803370', 10:02:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:43 INFO - '_': '/tools/buildbot/bin/python'} 10:02:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:43 INFO - Downloading/unpacking blobuploader==1.2.4 10:02:43 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 10:02:43 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 10:02:43 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 10:02:43 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 10:02:44 INFO - Downloading blobuploader-1.2.4.tar.gz 10:02:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:02:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:02:44 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 10:02:44 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 10:02:44 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 10:02:44 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 10:02:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:02:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:02:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:02:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:02:45 INFO - Downloading docopt-0.6.1.tar.gz 10:02:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:02:45 INFO - Installing collected packages: blobuploader, requests, docopt 10:02:45 INFO - Running setup.py install for blobuploader 10:02:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:02:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:02:45 INFO - Running setup.py install for requests 10:02:45 INFO - Running setup.py install for docopt 10:02:45 INFO - Successfully installed blobuploader requests docopt 10:02:45 INFO - Cleaning up... 10:02:45 INFO - Return code: 0 10:02:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:02:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:45 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 0x151f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x189d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189b140>, '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 0x189ba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x189bed0>, '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': '9bfb7e13875ed353a705960e000001c0-1496931357.65609-362803370', '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 10:02:45 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 10:02:45 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 10:02:45 INFO - Using env: {'DISPLAY': ':0', 10:02:45 INFO - 'HOME': '/home/cltbld', 10:02:45 INFO - 'LANG': 'en_US.UTF-8', 10:02:45 INFO - 'LANGUAGE': 'en_US:en', 10:02:45 INFO - 'LOGNAME': 'cltbld', 10:02:45 INFO - 'MAIL': '/var/mail/cltbld', 10:02:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:45 INFO - 'MOZ_NO_REMOTE': '1', 10:02:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:45 INFO - 'NO_EM_RESTART': '1', 10:02:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:45 INFO - 'PWD': '/builds/slave/test', 10:02:45 INFO - 'SHELL': '/bin/bash', 10:02:45 INFO - 'SHLVL': '1', 10:02:45 INFO - 'TERM': 'linux', 10:02:45 INFO - 'TMOUT': '86400', 10:02:45 INFO - 'USER': 'cltbld', 10:02:45 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1496931357.65609-362803370', 10:02:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:45 INFO - '_': '/tools/buildbot/bin/python'} 10:02:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:02:46 INFO - Running setup.py (path:/tmp/pip-ug27ro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:02:46 INFO - Running setup.py (path:/tmp/pip-xLcIlB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:02:46 INFO - Running setup.py (path:/tmp/pip-cFuPxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:02:46 INFO - Running setup.py (path:/tmp/pip-EIWdCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:02:46 INFO - Running setup.py (path:/tmp/pip-J9UApe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:02:46 INFO - Running setup.py (path:/tmp/pip-cBZa9_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:02:46 INFO - Running setup.py (path:/tmp/pip-jkWhj7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:02:46 INFO - Running setup.py (path:/tmp/pip-pMLdbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:02:46 INFO - Running setup.py (path:/tmp/pip-DkETRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:02:46 INFO - Running setup.py (path:/tmp/pip-fCIpWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:02:46 INFO - Running setup.py (path:/tmp/pip-4J7r1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:02:46 INFO - Running setup.py (path:/tmp/pip-d6G5NO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:02:46 INFO - Running setup.py (path:/tmp/pip-ZcxCHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:02:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:02:47 INFO - Running setup.py (path:/tmp/pip-HafP54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:47 INFO - Running setup.py (path:/tmp/pip-1gZ2xy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:02:47 INFO - Running setup.py (path:/tmp/pip-jynbeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:02:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:02:47 INFO - Running setup.py (path:/tmp/pip-L58iu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:02:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:02:47 INFO - Running setup.py install for manifestparser 10:02:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:02:47 INFO - Running setup.py install for mozcrash 10:02:47 INFO - Running setup.py install for mozdebug 10:02:47 INFO - Running setup.py install for mozdevice 10:02:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:02:47 INFO - Running setup.py install for mozfile 10:02:47 INFO - Running setup.py install for mozhttpd 10:02:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:02:47 INFO - Running setup.py install for mozinfo 10:02:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:02:47 INFO - Running setup.py install for mozInstall 10:02:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:02:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:02:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:02:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:02:48 INFO - Running setup.py install for mozleak 10:02:48 INFO - Running setup.py install for mozlog 10:02:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:02:48 INFO - Running setup.py install for moznetwork 10:02:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:02:48 INFO - Running setup.py install for mozprocess 10:02:48 INFO - Running setup.py install for mozprofile 10:02:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:02:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:02:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:02:48 INFO - Running setup.py install for mozrunner 10:02:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:02:48 INFO - Running setup.py install for mozscreenshot 10:02:48 INFO - Running setup.py install for moztest 10:02:48 INFO - Running setup.py install for mozversion 10:02:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:02:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:02:49 INFO - Cleaning up... 10:02:49 INFO - Return code: 0 10:02:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:02:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:02:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:49 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 0x151f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x189d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189b140>, '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 0x189ba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x189bed0>, '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': '9bfb7e13875ed353a705960e000001c0-1496931357.65609-362803370', '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 10:02:49 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 10:02:49 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 10:02:49 INFO - Using env: {'DISPLAY': ':0', 10:02:49 INFO - 'HOME': '/home/cltbld', 10:02:49 INFO - 'LANG': 'en_US.UTF-8', 10:02:49 INFO - 'LANGUAGE': 'en_US:en', 10:02:49 INFO - 'LOGNAME': 'cltbld', 10:02:49 INFO - 'MAIL': '/var/mail/cltbld', 10:02:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:49 INFO - 'MOZ_NO_REMOTE': '1', 10:02:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:49 INFO - 'NO_EM_RESTART': '1', 10:02:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:49 INFO - 'PWD': '/builds/slave/test', 10:02:49 INFO - 'SHELL': '/bin/bash', 10:02:49 INFO - 'SHLVL': '1', 10:02:49 INFO - 'TERM': 'linux', 10:02:49 INFO - 'TMOUT': '86400', 10:02:49 INFO - 'USER': 'cltbld', 10:02:49 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1496931357.65609-362803370', 10:02:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:49 INFO - '_': '/tools/buildbot/bin/python'} 10:02:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:02:49 INFO - Running setup.py (path:/tmp/pip-wLKjGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:02:49 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)) 10:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:02:49 INFO - Running setup.py (path:/tmp/pip-BJuhIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:02:49 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)) 10:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:02:49 INFO - Running setup.py (path:/tmp/pip-e8H1hu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:02:49 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)) 10:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:02:49 INFO - Running setup.py (path:/tmp/pip-uk0Olk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:02:49 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)) 10:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:02:49 INFO - Running setup.py (path:/tmp/pip-Hyt6VB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:02:49 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)) 10:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:02:49 INFO - Running setup.py (path:/tmp/pip-mCC2Ty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:02:49 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)) 10:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:02:49 INFO - Running setup.py (path:/tmp/pip-NWpddx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:02:49 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)) 10:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:02:49 INFO - Running setup.py (path:/tmp/pip-OGk_wR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:02:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:02:49 INFO - Running setup.py (path:/tmp/pip-cGHzji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:02:49 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)) 10:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:02:49 INFO - Running setup.py (path:/tmp/pip-Z41ZKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:02:49 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)) 10:02:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:02:49 INFO - Running setup.py (path:/tmp/pip-m2wLmC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:02:50 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)) 10:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:02:50 INFO - Running setup.py (path:/tmp/pip-_N9Aw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:02:50 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)) 10:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:02:50 INFO - Running setup.py (path:/tmp/pip-4s1MtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:02:50 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)) 10:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:02:50 INFO - Running setup.py (path:/tmp/pip-wwWMuV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:02:50 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)) 10:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:50 INFO - Running setup.py (path:/tmp/pip-XiRctM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:02:50 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)) 10:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:02:50 INFO - Running setup.py (path:/tmp/pip-CaHN3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:02:50 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)) 10:02:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:02:50 INFO - Running setup.py (path:/tmp/pip-0wi4_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:02:50 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)) 10:02:50 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)) 10:02:50 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)) 10:02:50 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)) 10:02:50 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)) 10:02:50 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)) 10:02:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:02:50 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 10:02:50 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 10:02:50 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 10:02:50 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 10:02:51 INFO - Downloading blessings-1.6.tar.gz 10:02:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:02:51 INFO - Installing collected packages: blessings 10:02:51 INFO - Running setup.py install for blessings 10:02:51 INFO - Successfully installed blessings 10:02:51 INFO - Cleaning up... 10:02:51 INFO - Return code: 0 10:02:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:02:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:02:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:02:51 INFO - Reading from file tmpfile_stdout 10:02:51 INFO - Current package versions: 10:02:51 INFO - argparse == 1.2.1 10:02:51 INFO - blessings == 1.6 10:02:51 INFO - blobuploader == 1.2.4 10:02:51 INFO - docopt == 0.6.1 10:02:51 INFO - functools32 == 3.2.3-2 10:02:52 INFO - jsonschema == 2.5.1 10:02:52 INFO - manifestparser == 1.1 10:02:52 INFO - mozInstall == 1.12 10:02:52 INFO - mozcrash == 1.0 10:02:52 INFO - mozdebug == 0.1 10:02:52 INFO - mozdevice == 0.51 10:02:52 INFO - mozfile == 1.2 10:02:52 INFO - mozhttpd == 0.7 10:02:52 INFO - mozinfo == 0.10 10:02:52 INFO - mozleak == 0.1 10:02:52 INFO - mozlog == 3.4 10:02:52 INFO - moznetwork == 0.27 10:02:52 INFO - mozprocess == 0.25 10:02:52 INFO - mozprofile == 0.28 10:02:52 INFO - mozrunner == 6.13 10:02:52 INFO - mozscreenshot == 0.1 10:02:52 INFO - mozsystemmonitor == 0.3 10:02:52 INFO - moztest == 0.8 10:02:52 INFO - mozversion == 1.4 10:02:52 INFO - psutil == 3.1.1 10:02:52 INFO - requests == 1.2.3 10:02:52 INFO - wsgiref == 0.1.2 10:02:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:02:52 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')]} 10:02:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:52 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')]} 10:02:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:52 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 0x151f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x189d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189b140>, '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 0x189ba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x189bed0>, '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': '9bfb7e13875ed353a705960e000001c0-1496931357.65609-362803370', '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 10:02:52 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 10:02:52 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 10:02:52 INFO - Using env: {'DISPLAY': ':0', 10:02:52 INFO - 'HOME': '/home/cltbld', 10:02:52 INFO - 'LANG': 'en_US.UTF-8', 10:02:52 INFO - 'LANGUAGE': 'en_US:en', 10:02:52 INFO - 'LOGNAME': 'cltbld', 10:02:52 INFO - 'MAIL': '/var/mail/cltbld', 10:02:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:52 INFO - 'MOZ_NO_REMOTE': '1', 10:02:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:52 INFO - 'NO_EM_RESTART': '1', 10:02:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:52 INFO - 'PWD': '/builds/slave/test', 10:02:52 INFO - 'SHELL': '/bin/bash', 10:02:52 INFO - 'SHLVL': '1', 10:02:52 INFO - 'TERM': 'linux', 10:02:52 INFO - 'TMOUT': '86400', 10:02:52 INFO - 'USER': 'cltbld', 10:02:52 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1496931357.65609-362803370', 10:02:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:52 INFO - '_': '/tools/buildbot/bin/python'} 10:02:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:52 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)) 10:02:52 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)) 10:02:52 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)) 10:02:52 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)) 10:02:52 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)) 10:02:52 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)) 10:02:52 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)) 10:02:52 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)) 10:02:52 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)) 10:02:52 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 10:02:52 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 10:02:52 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 10:02:52 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 10:02:52 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 10:02:53 INFO - Downloading marionette_driver-1.4.0.tar.gz 10:02:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 10:02:53 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)) 10:02:53 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)) 10:02:53 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)) 10:02:53 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)) 10:02:53 INFO - Installing collected packages: marionette-driver 10:02:53 INFO - Running setup.py install for marionette-driver 10:02:53 INFO - Successfully installed marionette-driver 10:02:53 INFO - Cleaning up... 10:02:53 INFO - Return code: 0 10:02:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:02:53 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')]} 10:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:02:53 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')]} 10:02:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:02:53 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 0x151f3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x189d9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189b140>, '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 0x189ba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x189bed0>, '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': '9bfb7e13875ed353a705960e000001c0-1496931357.65609-362803370', '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 10:02:53 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 10:02:53 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 10:02:53 INFO - Using env: {'DISPLAY': ':0', 10:02:53 INFO - 'HOME': '/home/cltbld', 10:02:53 INFO - 'LANG': 'en_US.UTF-8', 10:02:53 INFO - 'LANGUAGE': 'en_US:en', 10:02:53 INFO - 'LOGNAME': 'cltbld', 10:02:53 INFO - 'MAIL': '/var/mail/cltbld', 10:02:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:02:53 INFO - 'MOZ_NO_REMOTE': '1', 10:02:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:02:53 INFO - 'NO_EM_RESTART': '1', 10:02:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:02:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:02:53 INFO - 'PWD': '/builds/slave/test', 10:02:53 INFO - 'SHELL': '/bin/bash', 10:02:53 INFO - 'SHLVL': '1', 10:02:53 INFO - 'TERM': 'linux', 10:02:53 INFO - 'TMOUT': '86400', 10:02:53 INFO - 'USER': 'cltbld', 10:02:53 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1496931357.65609-362803370', 10:02:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:02:53 INFO - '_': '/tools/buildbot/bin/python'} 10:02:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:02:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:02:53 INFO - Cleaning up... 10:02:53 INFO - Return code: 0 10:02:53 INFO - Running post-action listener: _resource_record_post_action 10:02:53 INFO - Running post-action listener: _start_resource_monitoring 10:02:53 INFO - Starting resource monitoring. 10:02:53 INFO - [mozharness: 2017-06-08 17:02:53.803057Z] Finished create-virtualenv step (success) 10:02:53 INFO - [mozharness: 2017-06-08 17:02:53.803579Z] Running install step. 10:02:53 INFO - Running pre-action listener: _resource_record_pre_action 10:02:53 INFO - Running main action method: install 10:02:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:02:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:02:54 INFO - Reading from file tmpfile_stdout 10:02:54 INFO - Detecting whether we're running mozinstall >=1.0... 10:02:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:02:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:02:54 INFO - Reading from file tmpfile_stdout 10:02:54 INFO - Output received: 10:02:54 INFO - Usage: mozinstall [options] installer 10:02:54 INFO - Options: 10:02:54 INFO - -h, --help show this help message and exit 10:02:54 INFO - -d DEST, --destination=DEST 10:02:54 INFO - Directory to install application into. [default: 10:02:54 INFO - "/builds/slave/test"] 10:02:54 INFO - --app=APP Application being installed. [default: firefox] 10:02:54 INFO - mkdir: /builds/slave/test/build/application 10:02:54 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'] 10:02:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 10:03:11 INFO - Reading from file tmpfile_stdout 10:03:11 INFO - Output received: 10:03:11 INFO - /builds/slave/test/build/application/firefox/firefox 10:03:11 INFO - Running post-action listener: _resource_record_post_action 10:03:11 INFO - [mozharness: 2017-06-08 17:03:11.033090Z] Finished install step (success) 10:03:11 INFO - [mozharness: 2017-06-08 17:03:11.033367Z] Running setup-mitmproxy step. 10:03:11 INFO - Running pre-action listener: _resource_record_pre_action 10:03:11 INFO - Running main action method: setup_mitmproxy 10:03:11 INFO - Skipping: mitmproxy is not required 10:03:11 INFO - Running post-action listener: _resource_record_post_action 10:03:11 INFO - [mozharness: 2017-06-08 17:03:11.034585Z] Finished setup-mitmproxy step (success) 10:03:11 INFO - [mozharness: 2017-06-08 17:03:11.034805Z] Running run-tests step. 10:03:11 INFO - Running pre-action listener: _resource_record_pre_action 10:03:11 INFO - Running main action method: run_tests 10:03:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:03:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:03:11 INFO - Python 2.7.3 10:03:11 INFO - Return code: 0 10:03:11 INFO - grabbing minidump binary from tooltool 10:03:11 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')]} 10:03:11 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 0x189b140>, '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 0x189ba40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x189bed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:03:11 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 10:03:11 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 10:03:11 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 10:03:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:03:11 INFO - Return code: 0 10:03:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:03:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:03:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:03:11 INFO - ENV: RUST_BACKTRACE is now 1 10:03:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:03:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:03:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bpIrWjRKQX-5uA_EuI5bMg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--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 10:03:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bpIrWjRKQX-5uA_EuI5bMg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-076 --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 10:03:11 INFO - Using env: {'DISPLAY': ':0', 10:03:11 INFO - 'HOME': '/home/cltbld', 10:03:11 INFO - 'LANG': 'en_US.UTF-8', 10:03:11 INFO - 'LANGUAGE': 'en_US:en', 10:03:11 INFO - 'LOGNAME': 'cltbld', 10:03:11 INFO - 'MAIL': '/var/mail/cltbld', 10:03:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:03:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:03:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:03:11 INFO - 'MOZ_NO_REMOTE': '1', 10:03:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:03:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:03:11 INFO - 'NO_EM_RESTART': '1', 10:03:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:03:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:03:11 INFO - 'PWD': '/builds/slave/test', 10:03:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:03:11 INFO - 'RUST_BACKTRACE': '1', 10:03:11 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 10:03:11 INFO - 'SHELL': '/bin/bash', 10:03:11 INFO - 'SHLVL': '1', 10:03:11 INFO - 'TERM': 'linux', 10:03:11 INFO - 'TMOUT': '86400', 10:03:11 INFO - 'USER': 'cltbld', 10:03:11 INFO - 'XDG_SESSION_COOKIE': '9bfb7e13875ed353a705960e000001c0-1496931357.65609-362803370', 10:03:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:03:11 INFO - '_': '/tools/buildbot/bin/python'} 10:03:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bpIrWjRKQX-5uA_EuI5bMg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-076', '--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 10:03:11 INFO - mozversion application_buildid: 20170608162720 10:03:11 INFO - mozversion application_changeset: e61060be36424240058f8bef4c5597f401bc8b7e 10:03:11 INFO - mozversion application_display_name: Nightly 10:03:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:03:11 INFO - mozversion application_name: Firefox 10:03:11 INFO - mozversion application_remotingname: firefox 10:03:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:03:11 INFO - mozversion application_vendor: Mozilla 10:03:11 INFO - mozversion application_version: 55.0a1 10:03:11 INFO - mozversion platform_buildid: 20170608162720 10:03:11 INFO - mozversion platform_changeset: e61060be36424240058f8bef4c5597f401bc8b7e 10:03:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:03:11 INFO - mozversion platform_version: 55.0a1 10:03:11 INFO - using testdate: 1496941391 10:03:11 INFO - actual date: 1496941391 10:03:11 INFO - starting webserver on 'localhost:35747' 10:03:11 INFO - SUITE-START | Running 2 tests 10:03:11 INFO - TEST-START | dromaeo_css 10:03:11 INFO - operating with platform_type : linux_ 10:03:11 INFO - Initialising browser for dromaeo_css test... 10:03:11 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35747/getInfo.html -profile /tmp/tmp04eVgE/profile 10:03:11 INFO - TEST-INFO | started process 5305 (/builds/slave/test/build/application/firefox/firefox http://localhost:35747/getInfo.html) 10:03:46 INFO - TEST-INFO | 5305: killed by SIGTERM 10:03:46 INFO - Browser initialized. 10:03:46 INFO - Running cycle 1/1 for dromaeo_css test... 10:03:46 INFO - TEST-INFO | started process 5509 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp04eVgE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:03:58 INFO - PID 5509 | RSS: Main: 183246848 10:03:58 INFO - PID 5509 | 10:06:59 INFO - PID 5509 | Cycle 1(1): loaded http://localhost:35747/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35747/tests/dromaeo/cssquery-ext.html) 10:07:01 INFO - PID 5509 | RSS: Main: 182145024 10:07:01 INFO - PID 5509 | 10:10:02 INFO - PID 5509 | Cycle 1(1): loaded http://localhost:35747/tests/dromaeo/cssquery-ext.html (next: http://localhost:35747/tests/dromaeo/cssquery-jquery.html) 10:10:03 INFO - PID 5509 | RSS: Main: 184430592 10:10:03 INFO - PID 5509 | 10:13:05 INFO - PID 5509 | Cycle 1(1): loaded http://localhost:35747/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35747/tests/dromaeo/cssquery-mootools.html) 10:13:05 INFO - PID 5509 | RSS: Main: 184451072 10:13:05 INFO - PID 5509 | 10:16:07 INFO - PID 5509 | Cycle 1(1): loaded http://localhost:35747/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35747/tests/dromaeo/cssquery-prototype.html) 10:16:08 INFO - PID 5509 | RSS: Main: 182759424 10:16:08 INFO - PID 5509 | 10:19:11 INFO - PID 5509 | Cycle 1(1): loaded http://localhost:35747/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35747/tests/dromaeo/cssquery-yui.html) 10:19:11 INFO - PID 5509 | RSS: Main: 187842560 10:19:11 INFO - PID 5509 | 10:22:13 INFO - PID 5509 | Cycle 1(1): loaded http://localhost:35747/tests/dromaeo/cssquery-yui.html (next: http://localhost:35747/tests/dromaeo/cssquery-dojo.html) 10:22:13 INFO - PID 5509 | RSS: Main: 183861248 10:22:13 INFO - PID 5509 | 10:22:13 INFO - PID 5509 | __start_tp_report 10:22:13 INFO - PID 5509 | _x_x_mozilla_page_load 10:22:13 INFO - PID 5509 | _x_x_mozilla_page_load_details 10:22:13 INFO - PID 5509 | |i|pagename|runs| 10:22:13 INFO - PID 5509 | |0;dojo.html;3024.7731420143496;3056.5873607063045;3093.1493839194227;3104.4567200739866;3134.185111870913;5877.58856880018;5889.352171261158;5892.911606325909;5942.881142377155;5944.048952167654;5861.413858614136;5877.823665290048;5912.645241285526;5935.881282374361;5943.940560594393;5421.918671219935;5469.535089517396;5476.4249753775875;5508.807191748289;5575.888482230353;5553.555715542767;5559.221708960748;5589.496945274925;5590.301212348457;5597.160425936101;5546;5546.029444847156;5563.805266815662;5565.276514053187;5577.358603760558;5527.889442211153;5538.6122971392015;5567.387587365387;5568.276124103861;5585.525230355384;5443.164473258983;5462.371827239878;5527.640703354269;5555.333359996826;5563.471470210324;5919.230500035011;5940.227770389865;5983.491403230731;6010.75956961721;6030.879382412371;6159.692015399212;6264.373562643745;6296.842578935563;6358.427741503287;6396.39234272748;6251.843703907393;6253.874922501524;6254.8123556293385;6260.342664020258;6261.686915654244;5773.538116950634;5855.443732845373;5861.238039054938;5861.325947516005;5918.112283157518;5079.492050794891;6419.2296924369375;6423.164988551458;6426.518011149183;6556.541042127005;6203.069539569101;6206.472449841724;6260.530460215502;6261.7182226799905;6264.37356264379;6216.4405203531;6309.842253943596;6355.269144048401;6365.172527571386;6368.968155159288;6202.100695399232;6239.376062393815;6306.842328941813;6331.936680633226;6334.366563343721;5409.864753381118;6317.684115794192;6340.144080549159;6344.714487848058;6355.872882542323;5077.416097148875;5112.718800465936;5141.897162056738;5165.354330708661;5208.635395522277;4391.077873646506;4422.159789639958;4442.2892337225885;4454.57681520255;4461.063176732922;5440.836774896759;5480.479354461319;5501.862453438696;5519.199716041152;5534.252875861707;6346;6352.555321127569;6362.968185159045;6366.904496432558;6372.490200783926;5476.123820188751;5548.334199896039;5549.38956714761;5557.833265002057;5567.832965011056;5544.972275138599;5686.943130568641;5699.173619825185;5720.227769251181;5724.513416359573;6073;6112.381899552462;6250.812475625738;6307.684615769285;6312.747490100436;6365.554411191358;6406.711697973696;6416.101745755691;6419.101325814483;6448.5486015980305;4821.855344339535;6149.292831324276;6177.876442471035;6180.567360284737;6188.783392581238;6326.145970293951;6327.335629758809;6328.588641738273;6334.904976425265;6335.524835637438;6448.097266382804;6453.1610890583925;6460.095586617971;6462.321456247214;6463.418292353711;6143.32423433413;6181.96909015452;6255.812325630239;6256.562040657111;6279.372062793684;6163.35284795108;6188.412100850412;6203.7828675996125;6206.255249370104;6210.068489726577;6087.969560152171;6137.631742095488;6140.228185505611;6149.538784591263;6156.815295541141;5050.823221187241;6233.252009758858;6306.495480361652;6310.6844657766005;6311.053341998737;6142.232220972379;6149.44654981036;6159.29168145669;6162.414570615784;6165.753369865334 10:22:13 INFO - PID 5509 | |1;ext.html;772.2817779465099;790.6995341770127;1049.55393957568;1133.5635780224611;1140.2474366917836;35241.47137792935;36279.81860090696;36456.088597785034;36486.81756591213;36577.26845463089;34648.30703385931;35165.47251791219;35208.823955880245;35298.823505882436;35305.2938941221;6706.932930670704;6838.487113466497;6944.583325000516;6953.096097507342;6961.512694111414;6844.1444819397575;7356.043714317131;7358.043454350927;7360.558366498;7433.219511951248;7317.085364329459;7375.668094935714;7391.0761154855645;7415.814604634873;7445.143808462015;7387.7783666490095;7396.519226250277;7398.371138453238;7401.62991850408;7434.814129646775;7186.317299856505;7315.30504602062;7319.085114360705;7330.193678695393;7335.669894854691;34941.47587786185;34957.47563786545;35010.12474688128;35206.82396588001;35308.82345588281;3441.827908604585;3479.6694314040124;3481.3559491494157;3482.407990641597;3482.878099266539;26927.32681682954;27139.86430067837;27160.320991975357;27183.320416989536;27266.591001135;3469.271452994874;3483.512308276843;3490.581130264359;3510.824458777051;3543;167093;167613;168593;168845;169988;36444.27111457756;36729.26541469209;36828;36936.815315923246;37021.25957480889;37816.43275350872;42456.15087698229;44595.777021114685;44750.77624611856;44823.77588112038;13858.16850988944;13922.86077139236;14038.649033774032;14040.578782636538;14063.226522541358;10396;10533.525991330409;11350;11422.885771142348;11516.884831151581;13361.866381336256;13488.662783430493;13498.257595832323;13544.322783860966;13684.178949263076;5663.292088488939;5666.2350582670815;5729.5702822288495;5729.7708091676695;5784.7107644618445;973.3527204408989;981.4503877828439;985.1923801217239;1019.0726438940528;1031.5358088860044;21557;21809.56380872374;21835.15235320269;22257.55484890293;22363;1061.103367654331;1070.1545778834634;1075.7794652096302;1090.7436752363187;1120.0647459371353;11447.54209831614;11478.540858365572;11540.884591154148;11932.343721095423;12150.878491215151;211702;212133;214124;214166;214224;44720;44777;45021.32468012982;45096.54903450989;45183.322250166275;1379.0966916669597;1417.149710173908;1435.0887186636562;1435.842057373688;1442.7475191841595;20000.899995500513;21761.782382175974;21771.56456870822;21777.23779667704;22531.5493690122;33948.49077263794;34039.31921361509;34241.82879085688;34306.14234644154;34348.48477272793;178978;179445.1027744853;179795;179830;180579;25615.87192064028;26312.605310920735;28947.565786512798;29213.561796572645;29263.85368073146;32234.194145145622;35596.466053008706;35792.64207357893;35800.28399432049;38321;27632.309192270353;29071.709282907745;29359;29772.10683679493;30356.544651829798;29180.124596262147;29261.561076583443;29469.705302946695;30327.848360758057;30482;32439.351212975136;32666;33158.83420582882;33451;34384;27280.590791138548;27948.580771288853;28511.28721781972;29521.81912723467;30143.397132057675;21997.340079797632;23325.88337058304;23691.763082368954;23788.453750506163;23966.28101156968 10:22:13 INFO - PID 5509 | |2;jquery.html;458.37660781337377;458.9931151032733;467.16610849633406;471.55202557570294;487.16937621355595;14260.286985650728;19526.121324540396;20177;20217;20222;16896.662066758687;16959.660806783857;17068.402605908796;17155.056471894073;17426.3900763473;3556.662117098878;3668.248009158116;3672;6164.537659675542;6172.321044685081;5954.880902381949;5993.160957465958;6061.151438798572;6070.392960703938;6077.39226077391;6043.969780151093;6047.334793172748;6048.790241951605;6054.212952316193;6064.181335519715;5975.462208401243;5983.6409815411;5996.610220335708;6022.397760223965;6031.065184896348;3291.8518666660057;3454.084667563098;3454.1537323355938;5278;5480.7533660985355;25064;25093.24720258377;25107;25117.37206569832;25292.620610690854;1927.739755133067;1954.99022504888;1955.6577598920273;1956.2175129947993;1957.1388589020785;16346.918265408716;16846.83153168465;16859;16862.662746745118;16906.492805215865;2003.5492014296813;2112.8379391334856;2148.8818115003824;2161.9027143778567;2168.967465488019;101305;104600.47699761452;104658.47670761673;104713.99999999924;113381;11349.886501135048;12526.561570344995;12601.558945436866;12922.741545169043;13354.465821367037;18432.723509147374;18509;18526.722099168524;18553.721694174597;18625.53436164107;8337.708180213664;8473.915260847436;8861.335399845037;8901.51041692713;9112.134347237003;7642.770716878503;7673.386129109658;7935.365170786324;8060.073091594424;8221.79445513855;7922.088959769585;8012.839743205103;8101.594920253964;8173.877391839127;8283.544405057779;2312.433453803795;2330.6970093887685;2344.6365813298626;2402.4354276744953;2548.2610043087666;930.9534523273809;959.1128206409044;966.6326795817545;995.1590905684685;1011.7217765114506;17691.908506646556;17918.820811791717;17954;18355.265789368543;18632.81367186338;958.5830163878735;972.2173650211647;973.7273563402259;990.3513198854762;1006.8942761009988;9728.951355243178;9847.704568862946;10069.79860402788;10071;10097;355572;357122;363943;368985;372891;84936.57531712302;88937;89374;89522.55238723895;89993.55003224942;999.7950420163849;1017.2574020964737;1124.3310230412892;1136.9431528423545;1138.703936976392;14837.554873353816;18078.638427231646;18297.176627052082;18422.90788546049;18749.250029998646;43450.565494345916;47378.52621473741;47461.7626911877;48002.27996579984;48219;58179;58246.12630810626;59185.70407147937;59187;59218.111728323245;10785.245032847626;10976.396298203355;11011.504482298476;11050.115990720884;11093.5562577496;16509;16541.090240036912;16563.42028029013;16603.584910377336;16665.91667041657;13235.139715918434;13357.13178643385;13544.32278386057;14262.714745705236;14302.284885755878;12331.568395106127;12532.310722910328;12662.683432914251;12682.682932926751;13022.958163347099;13757.931210343884;14451.710965780836;14666.193359365338;14721.92639036798;14730.705385892008;10580.894191058298;10902.836457453303;10922.235443518877;10933.343999360064;11249.381284029458;13887.513937012156;13903.374348154559;13950.302484875918;14216.289185540889;14242 10:22:13 INFO - PID 5509 | |3;mootools.html;1262.5896583610327;1350.189886068359;1351.8580549042351;1367.7811550151978;1368.5757415201288;11585.53657853686;12152;12197.51209951602;12199.756004879908;12200.51197952083;11876.406179691003;12370.07224458167;12733.426995785188;12747.235165890053;12759.872401275985;2399.1363109280646;2449.644801503781;2475.084218839032;2477.170148000422;2485.5898776701824;2427.854328740272;2469.0494159748537;2471.0486462711897;2480.3675062858947;2480.7395223501544;2363.775441333071;2395.125779090628;2408.4821763320883;2411.1922505960524;2417.6494408310787;2297.058206135476;2335.065973610552;2337.6610391493223;2338.7427382987858;2342.390978345625;2310.514791893704;2311.93064208074;2313.90744370225;2314.525522267931;2320.3155069254612;11719.414029298587;11821.290722556674;12014.69963250917;12029.218100823418;12041.337726425043;6757.189137303555;6913.308669133096;7004.299570043006;7029.82425439363;7037.824054398629;3815.8855234343014;3999.680025597945;4087.448194493735;4097.918041639151;4131.958680413218;1376.9862301376959;1379.1518216297006;1383.6955869708647;1403.9578812635636;1404.7611905975907;16559.83440165595;17507.38724144649;18419.815801841945;18564;18579.628407431912;5174.275601415805;5765.4522820332;5891.263592050994;5967.254093238345;6051.152838602599;13553.525626603021;13644.454221831214;13666.52167174144;13673.111247768864;13676.931615342059;6870.141232345957;6907.34380233877;6908.792736217922;6910.965445172843;6950.339717726808;6442.6778661066755;6501.219853617502;6517.4460170886005;6529;6584.374484423972;4520.367148599199;4567.862964111082;4599.67802253839;4614.315774742195;4627.0514544518965;1264.0582765839508;1282.5639282643947;1295.6760809797552;1303.5372442782866;1321.669582604349;809.1059379385812;818.2431251092715;824.6000689665508;842.4902933725131;843.6541018182515;6192.81421557354;7177.784666460015;7279.89080163798;7327.963360183165;7510.84978300431;893.7944272817158;946.0284883578961;960.4957397366298;979.9657012004545;983.6704703924122;3962.821673024721;4036.5963403659985;4127.9587204128175;4397.406350142754;4441.089576636782;15179.924100379427;15516.45692400783;16038.839611603968;16076.839231607533;16131;15431.305591248421;15436.768448473282;15704.921475392779;15811.841881581267;15884.60288492797;9709.5145242739;9726;9773.462459564793;9792.951035244778;9803.117719405287;6377.2984971654005;6624;6682.966585167043;6852.5203235773015;6927.930720692729;13634.795478068036;14220.644483887572;14252.429902803771;14439;14920.253987300375;13586.524471643444;14462.91528135373;14859.777103343675;15090.849091509384;15121.714654254072;9038.909610903807;9278.768030799283;9281.953590232006;9293.488858112869;9297.256219502287;10496.947515262375;10544.26190166681;10587.788244234918;10621.362718236931;10626.36241825493;9231.76920576991;9373.1564159226;9721.659741909;9726.562304696447;9838.163756080814;8916.598753056258;9349.672761453316;9446.763830904283;9653.806923861343;9777.80444391094;8161.673533058849;8245.546494942835;8300.460470069425;8300.916990830256;8311.044229913638;5769.30768307789;5892.6759028252145;5915.053591425351;5953.404659534012;6060.757569697163;5863.2670916135485;5992.250968628921;6068.6965651716355;6103.877922441615;6180.412860778219 10:22:13 INFO - PID 5509 | |4;prototype.html;411.5575756062234;432.9862177613522;440.59465291931417;450.31327225980397;460.5003571125327;6032.1554982302405;6277.058441233818;6280.697722060392;6322.241331040276;6363.300036995933;6011.128386383972;6027.909581356273;6045.516358691305;6054.757809687607;6071.666058366788;4912.691035213453;5042.722650254234;5109.872253193663;5110.974445127769;5136.486351364871;5104.157813960692;5112.616553758483;5115.872103197413;5131.717755523445;5136.897262054776;5061.848144555669;5082.695038297696;5088.982203559284;5093.26147708582;5107.208382700669;5001.674891132065;5019.222020586815;5028.6171302891635;5050.141475949061;5056.620753443506;4371.169477799208;4442.466903971512;4620.907581848344;4628;4630.8147674093;5785.710714464302;5990.131430942489;5994;6038.456538911475;6068.6358818471035;5763.625364351304;5771.394003629643;5771.864410168223;5772.134179873011;5784.508316793078;6515.315891831337;6551.213854337462;6553.442957348631;6579.47364210862;6584.407403333723;4961.05739909416;5004.948960718217;5022.221555658879;5037.823676171353;5039.370078740158;6777.220619628707;6787.083743694637;6794.388505034522;6798.592084474898;6800.795976120724;5198.090334191501;5202.595299269176;5206.375234971828;5227.895442091137;5231.97976394607;5225.928684619644;5229.529342359206;5239.449857764956;5246.950609878039;5271.446498117719;5796.94203057964;5812.273465816773;5814;5817.156512305776;5824.94175058244;6564.113844631009;6594.604323740495;6602.7689030883685;6606.86786264272;6645.06969024337;1852.7128295114278;1854.7959724430302;1859.907004649762;1862.3016368861677;1866.234843714098;1159.4202898550725;1299.4217573180033;1320.4982106799355;1321.9801702974464;1334.159479527891;5790.6681463263685;5792.623479473821;5801.9129713054335;5819.447152520504;5845.824625261249;6705.094812200388;6730.687515934345;6737.3599508046655;6757.155355580552;6765.221999470025;5700.23046888673;5719.885602287931;5734.340550836624;5743.368229494752;5793.826185214451;3425.2293234022145;3509.94735078974;3527.206378564854;3529.1530032791943;3536.381133301662;6237.688115594202;6382.234131904108;6399.968000159969;6531.83984652129;6566.376194261537;6800.455963522906;6812.761553345609;6838.316168383122;6864.38220560152;6885.483588730865;6512.446442052384;6527.445167160845;6544.2474115475425;6548.672566371758;6553.377429144223;6643.800685979429;6683.565568238049;6688.565243259172;6699.564528305645;6714.563553369016;6647.634380109141;6655.334466553306;6676.6661666917435;6684.83287917806;6689.127044427568;6509.103448965165;6512.837179070561;6514.902276465762;6523.282438931618;6525.1517302750335;5155.355580552431;5173.63784535079;5181.481851814789;5191.351081114861;5199.610029247746;6734.966325168343;6777.593344399352;6781.728730850711;6807.421369183675;6827.829304267433;6163.445289923929;6560.540762146604;6570.5729127608465;6574.967125164344;6593.142891424084;6143.723532440961;6472.546921715435;6530.444912182517;6531.11829902957;6547.770828020996;6420.6147631142285;6447.323031081669;6480.25477070143;6482.611043337415;6501.609903405811;6458.354164583692;6581.769638062645;6584.144061272004;6607.141071660653;6611.933880661324;6396.168498095404;6396.32838551964;6401.807945761635;6405.551611387158;6417.2299324081405 10:22:13 INFO - PID 5509 | |5;yui.html;823;861.194782878009;864.5633954852794;867.4318321499418;867.9088695686953;15444;15919.124448155375;15962.361505539793;16419.179041047944;17171.65656686867;13420.798688019688;14071.155730656143;14178.43286268548;14213.218272994982;14321.355539000744;717.411722387641;926.3191554207652;936.8828896387952;1005.0452070532987;1006.8691070160905;993.8360170571847;995.7311525888006;998.0518507417946;998.9001099890025;1002.4887307473205;1044.8589440425521;1047.6647472808704;1049.3913530152493;1049.6168898352123;1049.716576524338;1037.3101887244973;1044.9111825494842;1046.466302185887;1046.5499835070916;1046.6964580271713;517.0254071076012;521.8590980435299;534.2360424592831;730.5543618392776;758.6131073152677;17682.646347073114;17771.822281777277;17779.288828446846;17968.460946171635;17980.280788768432;18290.817091829045;18618.069096545252;19064.80935190658;19335.613287734308;19453.9027304864;14903.180325082116;15199.468018619295;15303.846961530353;15327.31027103783;15462.61343466411;3397.0827876473213;3433.0215888471917;3438;3438.2607739336163;3441.7074548663145;76710;87080.56459717725;91821;91979;94714.52642736811;14857.851421485862;15066.171360575274;15131.848681513044;15171.924140379228;15237.771433428508;25115.874420628144;25218.87390563072;25265.242042738748;25454.872725636622;25471.10851120202;8342.916570834213;8360.414770966096;8461.661533538712;8463.619137138843;8512.233898949124;3673.6326367363586;3720.925581488355;3750.0249935016545;3758.5489741231227;3774.9056273592832;4531.750753708512;4627.3521706961055;4632.073585282957;4632.930506042412;4658.650601204923;902.3187493442409;906.7587567834238;913.0321858829661;920.1120918313859;925.2135684668112;610.7404353149893;618.6844709198341;639.8976163813768;640.5068097564849;656.8226578823691;10078.949605252074;10177.694669159937;10496.527656255486;11041.39272340013;11229.3262404256;650.1807722269974;680.1124532485055;690.2993461636443;692.5048590257888;706.5301574453034;4621.584057434847;4695.5069717679835;4761.785719642625;4831.0820944020525;5225;81822;85243;86236;89129;89279.55360223158;65185.34814651793;71203;72613.63693181501;72736.63631681808;76063.61968190124;60554.697226514465;61680;62723;64150.67924660347;67202.99195512071;10080.243981701255;10615;10662.626808061681;10917.781644367227;11097.445127743742;27804.30489237785;29118.854405727834;29737.10788676343;29985.400291994476;30232.09303720804;36805.63194368022;36832.63167368292;37271.44092838556;38305.80847095747;38453.80773096117;13249.13880597758;13993.720125597227;14027.859721402656;14141.43434262618;14143;15975.28111234974;16374.345026199295;16412.917935410245;16427.09650969208;16592.585185370463;14413.85586144125;14455.638609034437;14503.709925801635;14571.344289506786;14672.046316989361;14793;14886.404543818126;15198.316075776396;15216.771748424004;15431.15128667889;13738.86261137376;14071;14254.928725356722;14491.78262326045;14670.486532971296;9849.45827979468;10508.159347252355;11004.294334377864;11176.273542220055;11266.380349080551;10718.19613529004;11410.315381077162;11504.25222360544;11850.348230847041;12312.445939932546 10:22:13 INFO - PID 5509 | __end_tp_report 10:22:13 INFO - PID 5509 | __start_cc_report 10:22:13 INFO - PID 5509 | _x_x_mozilla_cycle_collect,369 10:22:13 INFO - PID 5509 | __end_cc_report 10:22:13 INFO - PID 5509 | __startTimestamp1496942533659__endTimestamp 10:22:13 INFO - PID 5509 | 10:22:13 INFO - PID 5509 | ------- Summary: start ------- 10:22:13 INFO - PID 5509 | Number of tests: 6 10:22:13 INFO - PID 5509 | 10:22:13 INFO - PID 5509 | [#0] dojo.html Cycles:165 Average:5844.47 Median:6137.63 stddev:673.27 (11.0%) stddev-sans-first:637.97 10:22:13 INFO - PID 5509 | Values: 3024.8 3056.6 3093.1 3104.5 3134.2 5877.6 5889.4 5892.9 5942.9 5944.0 5861.4 5877.8 5912.6 5935.9 5943.9 5421.9 5469.5 5476.4 5508.8 5575.9 5553.6 5559.2 5589.5 5590.3 5597.2 5546.0 5546.0 5563.8 5565.3 5577.4 5527.9 5538.6 5567.4 5568.3 5585.5 5443.2 5462.4 5527.6 5555.3 5563.5 5919.2 5940.2 5983.5 6010.8 6030.9 6159.7 6264.4 6296.8 6358.4 6396.4 6251.8 6253.9 6254.8 6260.3 6261.7 5773.5 5855.4 5861.2 5861.3 5918.1 5079.5 6419.2 6423.2 6426.5 6556.5 6203.1 6206.5 6260.5 6261.7 6264.4 6216.4 6309.8 6355.3 6365.2 6369.0 6202.1 6239.4 6306.8 6331.9 6334.4 5409.9 6317.7 6340.1 6344.7 6355.9 5077.4 5112.7 5141.9 5165.4 5208.6 4391.1 4422.2 4442.3 4454.6 4461.1 5440.8 5480.5 5501.9 5519.2 5534.3 6346.0 6352.6 6363.0 6366.9 6372.5 5476.1 5548.3 5549.4 5557.8 5567.8 5545.0 5686.9 5699.2 5720.2 5724.5 6073.0 6112.4 6250.8 6307.7 6312.7 6365.6 6406.7 6416.1 6419.1 6448.5 4821.9 6149.3 6177.9 6180.6 6188.8 6326.1 6327.3 6328.6 6334.9 6335.5 6448.1 6453.2 6460.1 6462.3 6463.4 6143.3 6182.0 6255.8 6256.6 6279.4 6163.4 6188.4 6203.8 6206.3 6210.1 6088.0 6137.6 6140.2 6149.5 6156.8 5050.8 6233.3 6306.5 6310.7 6311.1 6142.2 6149.4 6159.3 6162.4 6165.8 10:22:13 INFO - PID 5509 | 10:22:13 INFO - PID 5509 | [#1] ext.html Cycles:180 Average:33573.53 Median:32336.77 stddev:48626.73 (150.4%) stddev-sans-first:48700.76 10:22:13 INFO - PID 5509 | Values: 772.3 790.7 1049.6 1133.6 1140.2 35241.5 36279.8 36456.1 36486.8 36577.3 34648.3 35165.5 35208.8 35298.8 35305.3 6706.9 6838.5 6944.6 6953.1 6961.5 6844.1 7356.0 7358.0 7360.6 7433.2 7317.1 7375.7 7391.1 7415.8 7445.1 7387.8 7396.5 7398.4 7401.6 7434.8 7186.3 7315.3 7319.1 7330.2 7335.7 34941.5 34957.5 35010.1 35206.8 35308.8 3441.8 3479.7 3481.4 3482.4 3482.9 26927.3 27139.9 27160.3 27183.3 27266.6 3469.3 3483.5 3490.6 3510.8 3543.0 167093.0 167613.0 168593.0 168845.0 169988.0 36444.3 36729.3 36828.0 36936.8 37021.3 37816.4 42456.2 44595.8 44750.8 44823.8 13858.2 13922.9 14038.6 14040.6 14063.2 10396.0 10533.5 11350.0 11422.9 11516.9 13361.9 13488.7 13498.3 13544.3 13684.2 5663.3 5666.2 5729.6 5729.8 5784.7 973.4 981.5 985.2 1019.1 1031.5 21557.0 21809.6 21835.2 22257.6 22363.0 1061.1 1070.2 1075.8 1090.7 1120.1 11447.5 11478.5 11540.9 11932.3 12150.9 211702.0 212133.0 214124.0 214166.0 214224.0 44720.0 44777.0 45021.3 45096.5 45183.3 1379.1 1417.1 1435.1 1435.8 1442.7 20000.9 21761.8 21771.6 21777.2 22531.5 33948.5 34039.3 34241.8 34306.1 34348.5 178978.0 179445.1 179795.0 179830.0 180579.0 25615.9 26312.6 28947.6 29213.6 29263.9 32234.2 35596.5 35792.6 35800.3 38321.0 27632.3 29071.7 29359.0 29772.1 30356.5 29180.1 29261.6 29469.7 30327.8 30482.0 32439.4 32666.0 33158.8 33451.0 34384.0 27280.6 27948.6 28511.3 29521.8 30143.4 21997.3 23325.9 23691.8 23788.5 23966.3 10:22:13 INFO - PID 5509 | 10:22:13 INFO - PID 5509 | [#2] jquery.html Cycles:180 Average:27038.99 Median:2130.86 stddev:61444.17 (2883.5%) stddev-sans-first:61584.13 10:22:13 INFO - PID 5509 | Values: 458.4 459.0 467.2 471.6 487.2 14260.3 19526.1 20177.0 20217.0 20222.0 16896.7 16959.7 17068.4 17155.1 17426.4 3556.7 3668.2 3672.0 6164.5 6172.3 5954.9 5993.2 6061.2 6070.4 6077.4 6044.0 6047.3 6048.8 6054.2 6064.2 5975.5 5983.6 5996.6 6022.4 6031.1 3291.9 3454.1 3454.2 5278.0 5480.8 25064.0 25093.2 25107.0 25117.4 25292.6 1927.7 1955.0 1955.7 1956.2 1957.1 16346.9 16846.8 16859.0 16862.7 16906.5 2003.5 2112.8 2148.9 2161.9 2169.0 101305.0 104600.5 104658.5 104714.0 113381.0 11349.9 12526.6 12601.6 12922.7 13354.5 18432.7 18509.0 18526.7 18553.7 18625.5 8337.7 8473.9 8861.3 8901.5 9112.1 7642.8 7673.4 7935.4 8060.1 8221.8 7922.1 8012.8 8101.6 8173.9 8283.5 2312.4 2330.7 2344.6 2402.4 2548.3 931.0 959.1 966.6 995.2 1011.7 17691.9 17918.8 17954.0 18355.3 18632.8 958.6 972.2 973.7 990.4 1006.9 9729.0 9847.7 10069.8 10071.0 10097.0 355572.0 357122.0 363943.0 368985.0 372891.0 84936.6 88937.0 89374.0 89522.6 89993.6 999.8 1017.3 1124.3 1136.9 1138.7 14837.6 18078.6 18297.2 18422.9 18749.3 43450.6 47378.5 47461.8 48002.3 48219.0 58179.0 58246.1 59185.7 59187.0 59218.1 10785.2 10976.4 11011.5 11050.1 11093.6 16509.0 16541.1 16563.4 16603.6 16665.9 13235.1 13357.1 13544.3 14262.7 14302.3 12331.6 12532.3 12662.7 12682.7 13023.0 13757.9 14451.7 14666.2 14721.9 14730.7 10580.9 10902.8 10922.2 10933.3 11249.4 13887.5 13903.4 13950.3 14216.3 14242.0 10:22:13 INFO - PID 5509 | 10:22:13 INFO - PID 5509 | [#3] mootools.html Cycles:180 Average:7437.06 Median:3889.35 stddev:4859.07 (124.9%) stddev-sans-first:4850.55 10:22:13 INFO - PID 5509 | Values: 1262.6 1350.2 1351.9 1367.8 1368.6 11585.5 12152.0 12197.5 12199.8 12200.5 11876.4 12370.1 12733.4 12747.2 12759.9 2399.1 2449.6 2475.1 2477.2 2485.6 2427.9 2469.0 2471.0 2480.4 2480.7 2363.8 2395.1 2408.5 2411.2 2417.6 2297.1 2335.1 2337.7 2338.7 2342.4 2310.5 2311.9 2313.9 2314.5 2320.3 11719.4 11821.3 12014.7 12029.2 12041.3 6757.2 6913.3 7004.3 7029.8 7037.8 3815.9 3999.7 4087.4 4097.9 4132.0 1377.0 1379.2 1383.7 1404.0 1404.8 16559.8 17507.4 18419.8 18564.0 18579.6 5174.3 5765.5 5891.3 5967.3 6051.2 13553.5 13644.5 13666.5 13673.1 13676.9 6870.1 6907.3 6908.8 6911.0 6950.3 6442.7 6501.2 6517.4 6529.0 6584.4 4520.4 4567.9 4599.7 4614.3 4627.1 1264.1 1282.6 1295.7 1303.5 1321.7 809.1 818.2 824.6 842.5 843.7 6192.8 7177.8 7279.9 7328.0 7510.8 893.8 946.0 960.5 980.0 983.7 3962.8 4036.6 4128.0 4397.4 4441.1 15179.9 15516.5 16038.8 16076.8 16131.0 15431.3 15436.8 15704.9 15811.8 15884.6 9709.5 9726.0 9773.5 9793.0 9803.1 6377.3 6624.0 6683.0 6852.5 6927.9 13634.8 14220.6 14252.4 14439.0 14920.3 13586.5 14462.9 14859.8 15090.8 15121.7 9038.9 9278.8 9282.0 9293.5 9297.3 10496.9 10544.3 10587.8 10621.4 10626.4 9231.8 9373.2 9721.7 9726.6 9838.2 8916.6 9349.7 9446.8 9653.8 9777.8 8161.7 8245.5 8300.5 8300.9 8311.0 5769.3 5892.7 5915.1 5953.4 6060.8 5863.3 5992.3 6068.7 6103.9 6180.4 10:22:13 INFO - PID 5509 | 10:22:13 INFO - PID 5509 | [#4] prototype.html Cycles:180 Average:5542.06 Median:6035.31 stddev:1529.11 (25.3%) stddev-sans-first:1484.12 10:22:13 INFO - PID 5509 | Values: 411.6 433.0 440.6 450.3 460.5 6032.2 6277.1 6280.7 6322.2 6363.3 6011.1 6027.9 6045.5 6054.8 6071.7 4912.7 5042.7 5109.9 5111.0 5136.5 5104.2 5112.6 5115.9 5131.7 5136.9 5061.8 5082.7 5089.0 5093.3 5107.2 5001.7 5019.2 5028.6 5050.1 5056.6 4371.2 4442.5 4620.9 4628.0 4630.8 5785.7 5990.1 5994.0 6038.5 6068.6 5763.6 5771.4 5771.9 5772.1 5784.5 6515.3 6551.2 6553.4 6579.5 6584.4 4961.1 5004.9 5022.2 5037.8 5039.4 6777.2 6787.1 6794.4 6798.6 6800.8 5198.1 5202.6 5206.4 5227.9 5232.0 5225.9 5229.5 5239.4 5247.0 5271.4 5796.9 5812.3 5814.0 5817.2 5824.9 6564.1 6594.6 6602.8 6606.9 6645.1 1852.7 1854.8 1859.9 1862.3 1866.2 1159.4 1299.4 1320.5 1322.0 1334.2 5790.7 5792.6 5801.9 5819.4 5845.8 6705.1 6730.7 6737.4 6757.2 6765.2 5700.2 5719.9 5734.3 5743.4 5793.8 3425.2 3509.9 3527.2 3529.2 3536.4 6237.7 6382.2 6400.0 6531.8 6566.4 6800.5 6812.8 6838.3 6864.4 6885.5 6512.4 6527.4 6544.2 6548.7 6553.4 6643.8 6683.6 6688.6 6699.6 6714.6 6647.6 6655.3 6676.7 6684.8 6689.1 6509.1 6512.8 6514.9 6523.3 6525.2 5155.4 5173.6 5181.5 5191.4 5199.6 6735.0 6777.6 6781.7 6807.4 6827.8 6163.4 6560.5 6570.6 6575.0 6593.1 6143.7 6472.5 6530.4 6531.1 6547.8 6420.6 6447.3 6480.3 6482.6 6501.6 6458.4 6581.8 6584.1 6607.1 6611.9 6396.2 6396.3 6401.8 6405.6 6417.2 10:22:13 INFO - PID 5509 | 10:22:13 INFO - PID 5509 | [#5] yui.html Cycles:180 Average:18046.46 Median:25462.99 stddev:23027.80 (90.4%) stddev-sans-first:23056.08 10:22:13 INFO - PID 5509 | Values: 823.0 861.2 864.6 867.4 867.9 15444.0 15919.1 15962.4 16419.2 17171.7 13420.8 14071.2 14178.4 14213.2 14321.4 717.4 926.3 936.9 1005.0 1006.9 993.8 995.7 998.1 998.9 1002.5 1044.9 1047.7 1049.4 1049.6 1049.7 1037.3 1044.9 1046.5 1046.5 1046.7 517.0 521.9 534.2 730.6 758.6 17682.6 17771.8 17779.3 17968.5 17980.3 18290.8 18618.1 19064.8 19335.6 19453.9 14903.2 15199.5 15303.8 15327.3 15462.6 3397.1 3433.0 3438.0 3438.3 3441.7 76710.0 87080.6 91821.0 91979.0 94714.5 14857.9 15066.2 15131.8 15171.9 15237.8 25115.9 25218.9 25265.2 25454.9 25471.1 8342.9 8360.4 8461.7 8463.6 8512.2 3673.6 3720.9 3750.0 3758.5 3774.9 4531.8 4627.4 4632.1 4632.9 4658.7 902.3 906.8 913.0 920.1 925.2 610.7 618.7 639.9 640.5 656.8 10078.9 10177.7 10496.5 11041.4 11229.3 650.2 680.1 690.3 692.5 706.5 4621.6 4695.5 4761.8 4831.1 5225.0 81822.0 85243.0 86236.0 89129.0 89279.6 65185.3 71203.0 72613.6 72736.6 76063.6 60554.7 61680.0 62723.0 64150.7 67203.0 10080.2 10615.0 10662.6 10917.8 11097.4 27804.3 29118.9 29737.1 29985.4 30232.1 36805.6 36832.6 37271.4 38305.8 38453.8 13249.1 13993.7 14027.9 14141.4 14143.0 15975.3 16374.3 16412.9 16427.1 16592.6 14413.9 14455.6 14503.7 14571.3 14672.0 14793.0 14886.4 15198.3 15216.8 15431.2 13738.9 14071.0 14254.9 14491.8 14670.5 9849.5 10508.2 11004.3 11176.3 11266.4 10718.2 11410.3 11504.3 11850.3 12312.4 10:22:13 INFO - PID 5509 | -------- Summary: end -------- 10:22:13 INFO - PID 5509 | 10:22:14 INFO - TEST-INFO | 5509: exit 0 10:22:14 INFO - TEST-OK | dromaeo_css | took 1143231ms 10:22:14 INFO - TEST-START | kraken 10:22:14 INFO - operating with platform_type : linux_ 10:22:14 INFO - Initialising browser for kraken test... 10:22:14 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:35747/getInfo.html -profile /tmp/tmp8dxUq0/profile 10:22:14 INFO - TEST-INFO | started process 5919 (/builds/slave/test/build/application/firefox/firefox http://localhost:35747/getInfo.html) 10:22:49 INFO - TEST-INFO | 5919: killed by SIGTERM 10:22:49 INFO - Browser initialized. 10:22:49 INFO - Running cycle 1/1 for kraken test... 10:22:49 INFO - TEST-INFO | started process 6126 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8dxUq0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:23:01 INFO - PID 6126 | RSS: Main: 183754752 10:23:01 INFO - PID 6126 | 10:23:03 INFO - PID 6126 | Cycle 1(1): loaded http://localhost:35747/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35747/tests/kraken/driver.html?testName=audio-beat-detection) 10:23:04 INFO - PID 6126 | RSS: Main: 186298368 10:23:04 INFO - PID 6126 | 10:23:07 INFO - PID 6126 | Cycle 1(1): loaded http://localhost:35747/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35747/tests/kraken/driver.html?testName=audio-dft) 10:23:07 INFO - PID 6126 | RSS: Main: 187445248 10:23:07 INFO - PID 6126 | 10:23:10 INFO - PID 6126 | Cycle 1(1): loaded http://localhost:35747/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35747/tests/kraken/driver.html?testName=audio-fft) 10:23:11 INFO - PID 6126 | RSS: Main: 183037952 10:23:11 INFO - PID 6126 | 10:23:13 INFO - PID 6126 | Cycle 1(1): loaded http://localhost:35747/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35747/tests/kraken/driver.html?testName=audio-oscillator) 10:23:14 INFO - PID 6126 | RSS: Main: 184381440 10:23:14 INFO - PID 6126 | 10:23:16 INFO - PID 6126 | Cycle 1(1): loaded http://localhost:35747/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35747/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:23:17 INFO - PID 6126 | RSS: Main: 184397824 10:23:17 INFO - PID 6126 | 10:23:20 INFO - PID 6126 | Cycle 1(1): loaded http://localhost:35747/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35747/tests/kraken/driver.html?testName=imaging-darkroom) 10:23:20 INFO - PID 6126 | RSS: Main: 185655296 10:23:20 INFO - PID 6126 | 10:23:24 INFO - PID 6126 | Cycle 1(1): loaded http://localhost:35747/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35747/tests/kraken/driver.html?testName=imaging-desaturate) 10:23:24 INFO - PID 6126 | RSS: Main: 187166720 10:23:24 INFO - PID 6126 | 10:23:27 INFO - PID 6126 | Cycle 1(1): loaded http://localhost:35747/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35747/tests/kraken/driver.html?testName=json-parse-financial) 10:23:28 INFO - PID 6126 | RSS: Main: 186052608 10:23:28 INFO - PID 6126 | 10:23:29 INFO - PID 6126 | Cycle 1(1): loaded http://localhost:35747/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35747/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:23:30 INFO - PID 6126 | RSS: Main: 186105856 10:23:30 INFO - PID 6126 | 10:23:32 INFO - PID 6126 | Cycle 1(1): loaded http://localhost:35747/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35747/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:23:32 INFO - PID 6126 | RSS: Main: 185958400 10:23:32 INFO - PID 6126 | 10:23:35 INFO - PID 6126 | Cycle 1(1): loaded http://localhost:35747/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35747/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:23:35 INFO - PID 6126 | RSS: Main: 186163200 10:23:35 INFO - PID 6126 | 10:23:38 INFO - PID 6126 | Cycle 1(1): loaded http://localhost:35747/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35747/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:23:39 INFO - PID 6126 | RSS: Main: 186298368 10:23:39 INFO - PID 6126 | 10:23:42 INFO - PID 6126 | Cycle 1(1): loaded http://localhost:35747/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35747/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:23:42 INFO - PID 6126 | RSS: Main: 186052608 10:23:42 INFO - PID 6126 | 10:23:44 INFO - PID 6126 | Cycle 1(1): loaded http://localhost:35747/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35747/tests/kraken/driver.html?testName=ai-astar) 10:23:44 INFO - PID 6126 | RSS: Main: 187396096 10:23:44 INFO - PID 6126 | 10:23:44 INFO - PID 6126 | __start_tp_report 10:23:44 INFO - PID 6126 | _x_x_mozilla_page_load 10:23:44 INFO - PID 6126 | _x_x_mozilla_page_load_details 10:23:44 INFO - PID 6126 | |i|pagename|runs| 10:23:44 INFO - PID 6126 | |0;ai-astar;104;109;110;109;115;113;109;111;112;115 10:23:44 INFO - PID 6126 | |1;audio-beat-detection;155;133;150;164;120;147;159;122;172;122 10:23:44 INFO - PID 6126 | |2;audio-dft;164;167;163;162;164;174;168;170;168;163 10:23:44 INFO - PID 6126 | |3;audio-fft;74;78;74;161;74;74;73;76;100;73 10:23:44 INFO - PID 6126 | |4;audio-oscillator;82;84;130;84;92;83;134;83;88;137 10:23:44 INFO - PID 6126 | |5;imaging-gaussian-blur;113;115;116;114;115;114;114;114;114;121 10:23:44 INFO - PID 6126 | |6;imaging-darkroom;150;152;150;151;152;155;151;150;150;151 10:23:44 INFO - PID 6126 | |7;imaging-desaturate;95;95;95;94;95;94;95;99;94;94 10:23:44 INFO - PID 6126 | |8;json-parse-financial;57;54;56;54;53;53;56;57;54;53 10:23:44 INFO - PID 6126 | |9;json-stringify-tinderbox;55;55;56;56;63;56;55;56;55;56 10:23:44 INFO - PID 6126 | |10;stanford-crypto-aes;85;84;82;84;83;81;82;82;107;83 10:23:44 INFO - PID 6126 | |11;stanford-crypto-ccm;134;142;137;134;132;136;128;130;133;134 10:23:44 INFO - PID 6126 | |12;stanford-crypto-pbkdf2;203;202;184;184;186;186;185;198;187;185 10:23:44 INFO - PID 6126 | |13;stanford-crypto-sha256-iterative;75;78;71;70;70;72;69;69;70;70 10:23:44 INFO - PID 6126 | __end_tp_report 10:23:44 INFO - PID 6126 | __start_cc_report 10:23:44 INFO - PID 6126 | _x_x_mozilla_cycle_collect,957 10:23:44 INFO - PID 6126 | __end_cc_report 10:23:44 INFO - PID 6126 | __startTimestamp1496942624890__endTimestamp 10:23:44 INFO - PID 6126 | 10:23:44 INFO - PID 6126 | ------- Summary: start ------- 10:23:44 INFO - PID 6126 | Number of tests: 14 10:23:44 INFO - PID 6126 | 10:23:44 INFO - PID 6126 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.50 stddev:3.30 (3.0%) stddev-sans-first:2.46 10:23:44 INFO - PID 6126 | Values: 104.0 109.0 110.0 109.0 115.0 113.0 109.0 111.0 112.0 115.0 10:23:44 INFO - PID 6126 | 10:23:44 INFO - PID 6126 | [#1] audio-beat-detection Cycles:10 Average:144.40 Median:152.50 stddev:18.97 (12.4%) stddev-sans-first:19.73 10:23:44 INFO - PID 6126 | Values: 155.0 133.0 150.0 164.0 120.0 147.0 159.0 122.0 172.0 122.0 10:23:44 INFO - PID 6126 | 10:23:44 INFO - PID 6126 | [#2] audio-dft Cycles:10 Average:166.30 Median:167.50 stddev:3.80 (2.3%) stddev-sans-first:3.94 10:23:44 INFO - PID 6126 | Values: 164.0 167.0 163.0 162.0 164.0 174.0 168.0 170.0 168.0 163.0 10:23:44 INFO - PID 6126 | 10:23:44 INFO - PID 6126 | [#3] audio-fft Cycles:10 Average:85.70 Median:74.00 stddev:27.68 (37.4%) stddev-sans-first:29.04 10:23:44 INFO - PID 6126 | Values: 74.0 78.0 74.0 161.0 74.0 74.0 73.0 76.0 100.0 73.0 10:23:44 INFO - PID 6126 | 10:23:44 INFO - PID 6126 | [#4] audio-oscillator Cycles:10 Average:99.70 Median:83.50 stddev:23.68 (28.4%) stddev-sans-first:24.23 10:23:44 INFO - PID 6126 | Values: 82.0 84.0 130.0 84.0 92.0 83.0 134.0 83.0 88.0 137.0 10:23:44 INFO - PID 6126 | 10:23:44 INFO - PID 6126 | [#5] imaging-gaussian-blur Cycles:10 Average:115.00 Median:114.50 stddev:2.26 (2.0%) stddev-sans-first:2.28 10:23:44 INFO - PID 6126 | Values: 113.0 115.0 116.0 114.0 115.0 114.0 114.0 114.0 114.0 121.0 10:23:44 INFO - PID 6126 | 10:23:44 INFO - PID 6126 | [#6] imaging-darkroom Cycles:10 Average:151.20 Median:151.00 stddev:1.55 (1.0%) stddev-sans-first:1.58 10:23:44 INFO - PID 6126 | Values: 150.0 152.0 150.0 151.0 152.0 155.0 151.0 150.0 150.0 151.0 10:23:44 INFO - PID 6126 | 10:23:44 INFO - PID 6126 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:1.49 (1.6%) stddev-sans-first:1.58 10:23:44 INFO - PID 6126 | Values: 95.0 95.0 95.0 94.0 95.0 94.0 95.0 99.0 94.0 94.0 10:23:44 INFO - PID 6126 | 10:23:44 INFO - PID 6126 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.00 stddev:1.64 (3.0%) stddev-sans-first:1.51 10:23:44 INFO - PID 6126 | Values: 57.0 54.0 56.0 54.0 53.0 53.0 56.0 57.0 54.0 53.0 10:23:44 INFO - PID 6126 | 10:23:44 INFO - PID 6126 | [#9] json-stringify-tinderbox Cycles:10 Average:56.30 Median:56.00 stddev:2.41 (4.3%) stddev-sans-first:2.51 10:23:44 INFO - PID 6126 | Values: 55.0 55.0 56.0 56.0 63.0 56.0 55.0 56.0 55.0 56.0 10:23:44 INFO - PID 6126 | 10:23:44 INFO - PID 6126 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:83.00 stddev:7.72 (9.3%) stddev-sans-first:8.19 10:23:44 INFO - PID 6126 | Values: 85.0 84.0 82.0 84.0 83.0 81.0 82.0 82.0 107.0 83.0 10:23:44 INFO - PID 6126 | 10:23:44 INFO - PID 6126 | [#11] stanford-crypto-ccm Cycles:10 Average:134.00 Median:134.00 stddev:3.86 (2.9%) stddev-sans-first:4.09 10:23:44 INFO - PID 6126 | Values: 134.0 142.0 137.0 134.0 132.0 136.0 128.0 130.0 133.0 134.0 10:23:44 INFO - PID 6126 | 10:23:44 INFO - PID 6126 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.00 Median:186.50 stddev:7.75 (4.2%) stddev-sans-first:6.64 10:23:44 INFO - PID 6126 | Values: 203.0 202.0 184.0 184.0 186.0 186.0 185.0 198.0 187.0 185.0 10:23:44 INFO - PID 6126 | 10:23:44 INFO - PID 6126 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:70.50 stddev:2.91 (4.1%) stddev-sans-first:2.78 10:23:44 INFO - PID 6126 | Values: 75.0 78.0 71.0 70.0 70.0 72.0 69.0 69.0 70.0 70.0 10:23:44 INFO - PID 6126 | -------- Summary: end -------- 10:23:44 INFO - PID 6126 | 10:23:46 INFO - TEST-INFO | 6126: exit 0 10:23:46 INFO - TEST-OK | kraken | took 91556ms 10:23:46 INFO - SUITE-END | took 1234s 10:23:46 INFO - Completed test suite (00:20:35) 10:23:46 INFO - javascript benchmark 10:23:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7612.270752628381, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3024.7731420143496, 3056.5873607063045, 3093.1493839194227, 3104.4567200739866, 3134.185111870913, 5877.58856880018, 5889.352171261158, 5892.911606325909, 5942.881142377155, 5944.048952167654, 5861.413858614136, 5877.823665290048, 5912.645241285526, 5935.881282374361, 5943.940560594393, 5421.918671219935, 5469.535089517396, 5476.4249753775875, 5508.807191748289, 5575.888482230353, 5553.555715542767, 5559.221708960748, 5589.496945274925, 5590.301212348457, 5597.160425936101, 5546.0, 5546.029444847156, 5563.805266815662, 5565.276514053187, 5577.358603760558, 5527.889442211153, 5538.6122971392015, 5567.387587365387, 5568.276124103861, 5585.525230355384, 5443.164473258983, 5462.371827239878, 5527.640703354269, 5555.333359996826, 5563.471470210324, 5919.230500035011, 5940.227770389865, 5983.491403230731, 6010.75956961721, 6030.879382412371, 6159.692015399212, 6264.373562643745, 6296.842578935563, 6358.427741503287, 6396.39234272748, 6251.843703907393, 6253.874922501524, 6254.8123556293385, 6260.342664020258, 6261.686915654244, 5773.538116950634, 5855.443732845373, 5861.238039054938, 5861.325947516005, 5918.112283157518, 5079.492050794891, 6419.2296924369375, 6423.164988551458, 6426.518011149183, 6556.541042127005, 6203.069539569101, 6206.472449841724, 6260.530460215502, 6261.7182226799905, 6264.37356264379, 6216.4405203531, 6309.842253943596, 6355.269144048401, 6365.172527571386, 6368.968155159288, 6202.100695399232, 6239.376062393815, 6306.842328941813, 6331.936680633226, 6334.366563343721, 5409.864753381118, 6317.684115794192, 6340.144080549159, 6344.714487848058, 6355.872882542323, 5077.416097148875, 5112.718800465936, 5141.897162056738, 5165.354330708661, 5208.635395522277, 4391.077873646506, 4422.159789639958, 4442.2892337225885, 4454.57681520255, 4461.063176732922, 5440.836774896759, 5480.479354461319, 5501.862453438696, 5519.199716041152, 5534.252875861707, 6346.0, 6352.555321127569, 6362.968185159045, 6366.904496432558, 6372.490200783926, 5476.123820188751, 5548.334199896039, 5549.38956714761, 5557.833265002057, 5567.832965011056, 5544.972275138599, 5686.943130568641, 5699.173619825185, 5720.227769251181, 5724.513416359573, 6073.0, 6112.381899552462, 6250.812475625738, 6307.684615769285, 6312.747490100436, 6365.554411191358, 6406.711697973696, 6416.101745755691, 6419.101325814483, 6448.5486015980305, 4821.855344339535, 6149.292831324276, 6177.876442471035, 6180.567360284737, 6188.783392581238, 6326.145970293951, 6327.335629758809, 6328.588641738273, 6334.904976425265, 6335.524835637438, 6448.097266382804, 6453.1610890583925, 6460.095586617971, 6462.321456247214, 6463.418292353711, 6143.32423433413, 6181.96909015452, 6255.812325630239, 6256.562040657111, 6279.372062793684, 6163.35284795108, 6188.412100850412, 6203.7828675996125, 6206.255249370104, 6210.068489726577, 6087.969560152171, 6137.631742095488, 6140.228185505611, 6149.538784591263, 6156.815295541141, 5050.823221187241, 6233.252009758858, 6306.495480361652, 6310.6844657766005, 6311.053341998737, 6142.232220972379, 6149.44654981036, 6159.29168145669, 6162.414570615784, 6165.753369865334], "value": 5798.153954827625, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [772.2817779465099, 790.6995341770127, 1049.55393957568, 1133.5635780224611, 1140.2474366917836, 35241.47137792935, 36279.81860090696, 36456.088597785034, 36486.81756591213, 36577.26845463089, 34648.30703385931, 35165.47251791219, 35208.823955880245, 35298.823505882436, 35305.2938941221, 6706.932930670704, 6838.487113466497, 6944.583325000516, 6953.096097507342, 6961.512694111414, 6844.1444819397575, 7356.043714317131, 7358.043454350927, 7360.558366498, 7433.219511951248, 7317.085364329459, 7375.668094935714, 7391.0761154855645, 7415.814604634873, 7445.143808462015, 7387.7783666490095, 7396.519226250277, 7398.371138453238, 7401.62991850408, 7434.814129646775, 7186.317299856505, 7315.30504602062, 7319.085114360705, 7330.193678695393, 7335.669894854691, 34941.47587786185, 34957.47563786545, 35010.12474688128, 35206.82396588001, 35308.82345588281, 3441.827908604585, 3479.6694314040124, 3481.3559491494157, 3482.407990641597, 3482.878099266539, 26927.32681682954, 27139.86430067837, 27160.320991975357, 27183.320416989536, 27266.591001135, 3469.271452994874, 3483.512308276843, 3490.581130264359, 3510.824458777051, 3543.0, 167093.0, 167613.0, 168593.0, 168845.0, 169988.0, 36444.27111457756, 36729.26541469209, 36828.0, 36936.815315923246, 37021.25957480889, 37816.43275350872, 42456.15087698229, 44595.777021114685, 44750.77624611856, 44823.77588112038, 13858.16850988944, 13922.86077139236, 14038.649033774032, 14040.578782636538, 14063.226522541358, 10396.0, 10533.525991330409, 11350.0, 11422.885771142348, 11516.884831151581, 13361.866381336256, 13488.662783430493, 13498.257595832323, 13544.322783860966, 13684.178949263076, 5663.292088488939, 5666.2350582670815, 5729.5702822288495, 5729.7708091676695, 5784.7107644618445, 973.3527204408989, 981.4503877828439, 985.1923801217239, 1019.0726438940528, 1031.5358088860044, 21557.0, 21809.56380872374, 21835.15235320269, 22257.55484890293, 22363.0, 1061.103367654331, 1070.1545778834634, 1075.7794652096302, 1090.7436752363187, 1120.0647459371353, 11447.54209831614, 11478.540858365572, 11540.884591154148, 11932.343721095423, 12150.878491215151, 211702.0, 212133.0, 214124.0, 214166.0, 214224.0, 44720.0, 44777.0, 45021.32468012982, 45096.54903450989, 45183.322250166275, 1379.0966916669597, 1417.149710173908, 1435.0887186636562, 1435.842057373688, 1442.7475191841595, 20000.899995500513, 21761.782382175974, 21771.56456870822, 21777.23779667704, 22531.5493690122, 33948.49077263794, 34039.31921361509, 34241.82879085688, 34306.14234644154, 34348.48477272793, 178978.0, 179445.1027744853, 179795.0, 179830.0, 180579.0, 25615.87192064028, 26312.605310920735, 28947.565786512798, 29213.561796572645, 29263.85368073146, 32234.194145145622, 35596.466053008706, 35792.64207357893, 35800.28399432049, 38321.0, 27632.309192270353, 29071.709282907745, 29359.0, 29772.10683679493, 30356.544651829798, 29180.124596262147, 29261.561076583443, 29469.705302946695, 30327.848360758057, 30482.0, 32439.351212975136, 32666.0, 33158.83420582882, 33451.0, 34384.0, 27280.590791138548, 27948.580771288853, 28511.28721781972, 29521.81912723467, 30143.397132057675, 21997.340079797632, 23325.88337058304, 23691.763082368954, 23788.453750506163, 23966.28101156968], "value": 15592.335057654054, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [458.37660781337377, 458.9931151032733, 467.16610849633406, 471.55202557570294, 487.16937621355595, 14260.286985650728, 19526.121324540396, 20177.0, 20217.0, 20222.0, 16896.662066758687, 16959.660806783857, 17068.402605908796, 17155.056471894073, 17426.3900763473, 3556.662117098878, 3668.248009158116, 3672.0, 6164.537659675542, 6172.321044685081, 5954.880902381949, 5993.160957465958, 6061.151438798572, 6070.392960703938, 6077.39226077391, 6043.969780151093, 6047.334793172748, 6048.790241951605, 6054.212952316193, 6064.181335519715, 5975.462208401243, 5983.6409815411, 5996.610220335708, 6022.397760223965, 6031.065184896348, 3291.8518666660057, 3454.084667563098, 3454.1537323355938, 5278.0, 5480.7533660985355, 25064.0, 25093.24720258377, 25107.0, 25117.37206569832, 25292.620610690854, 1927.739755133067, 1954.99022504888, 1955.6577598920273, 1956.2175129947993, 1957.1388589020785, 16346.918265408716, 16846.83153168465, 16859.0, 16862.662746745118, 16906.492805215865, 2003.5492014296813, 2112.8379391334856, 2148.8818115003824, 2161.9027143778567, 2168.967465488019, 101305.0, 104600.47699761452, 104658.47670761673, 104713.99999999924, 113381.0, 11349.886501135048, 12526.561570344995, 12601.558945436866, 12922.741545169043, 13354.465821367037, 18432.723509147374, 18509.0, 18526.722099168524, 18553.721694174597, 18625.53436164107, 8337.708180213664, 8473.915260847436, 8861.335399845037, 8901.51041692713, 9112.134347237003, 7642.770716878503, 7673.386129109658, 7935.365170786324, 8060.073091594424, 8221.79445513855, 7922.088959769585, 8012.839743205103, 8101.594920253964, 8173.877391839127, 8283.544405057779, 2312.433453803795, 2330.6970093887685, 2344.6365813298626, 2402.4354276744953, 2548.2610043087666, 930.9534523273809, 959.1128206409044, 966.6326795817545, 995.1590905684685, 1011.7217765114506, 17691.908506646556, 17918.820811791717, 17954.0, 18355.265789368543, 18632.81367186338, 958.5830163878735, 972.2173650211647, 973.7273563402259, 990.3513198854762, 1006.8942761009988, 9728.951355243178, 9847.704568862946, 10069.79860402788, 10071.0, 10097.0, 355572.0, 357122.0, 363943.0, 368985.0, 372891.0, 84936.57531712302, 88937.0, 89374.0, 89522.55238723895, 89993.55003224942, 999.7950420163849, 1017.2574020964737, 1124.3310230412892, 1136.9431528423545, 1138.703936976392, 14837.554873353816, 18078.638427231646, 18297.176627052082, 18422.90788546049, 18749.250029998646, 43450.565494345916, 47378.52621473741, 47461.7626911877, 48002.27996579984, 48219.0, 58179.0, 58246.12630810626, 59185.70407147937, 59187.0, 59218.111728323245, 10785.245032847626, 10976.396298203355, 11011.504482298476, 11050.115990720884, 11093.5562577496, 16509.0, 16541.090240036912, 16563.42028029013, 16603.584910377336, 16665.91667041657, 13235.139715918434, 13357.13178643385, 13544.32278386057, 14262.714745705236, 14302.284885755878, 12331.568395106127, 12532.310722910328, 12662.683432914251, 12682.682932926751, 13022.958163347099, 13757.931210343884, 14451.710965780836, 14666.193359365338, 14721.92639036798, 14730.705385892008, 10580.894191058298, 10902.836457453303, 10922.235443518877, 10933.343999360064, 11249.381284029458, 13887.513937012156, 13903.374348154559, 13950.302484875918, 14216.289185540889, 14242.0], "value": 9924.987327047585, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1262.5896583610327, 1350.189886068359, 1351.8580549042351, 1367.7811550151978, 1368.5757415201288, 11585.53657853686, 12152.0, 12197.51209951602, 12199.756004879908, 12200.51197952083, 11876.406179691003, 12370.07224458167, 12733.426995785188, 12747.235165890053, 12759.872401275985, 2399.1363109280646, 2449.644801503781, 2475.084218839032, 2477.170148000422, 2485.5898776701824, 2427.854328740272, 2469.0494159748537, 2471.0486462711897, 2480.3675062858947, 2480.7395223501544, 2363.775441333071, 2395.125779090628, 2408.4821763320883, 2411.1922505960524, 2417.6494408310787, 2297.058206135476, 2335.065973610552, 2337.6610391493223, 2338.7427382987858, 2342.390978345625, 2310.514791893704, 2311.93064208074, 2313.90744370225, 2314.525522267931, 2320.3155069254612, 11719.414029298587, 11821.290722556674, 12014.69963250917, 12029.218100823418, 12041.337726425043, 6757.189137303555, 6913.308669133096, 7004.299570043006, 7029.82425439363, 7037.824054398629, 3815.8855234343014, 3999.680025597945, 4087.448194493735, 4097.918041639151, 4131.958680413218, 1376.9862301376959, 1379.1518216297006, 1383.6955869708647, 1403.9578812635636, 1404.7611905975907, 16559.83440165595, 17507.38724144649, 18419.815801841945, 18564.0, 18579.628407431912, 5174.275601415805, 5765.4522820332, 5891.263592050994, 5967.254093238345, 6051.152838602599, 13553.525626603021, 13644.454221831214, 13666.52167174144, 13673.111247768864, 13676.931615342059, 6870.141232345957, 6907.34380233877, 6908.792736217922, 6910.965445172843, 6950.339717726808, 6442.6778661066755, 6501.219853617502, 6517.4460170886005, 6529.0, 6584.374484423972, 4520.367148599199, 4567.862964111082, 4599.67802253839, 4614.315774742195, 4627.0514544518965, 1264.0582765839508, 1282.5639282643947, 1295.6760809797552, 1303.5372442782866, 1321.669582604349, 809.1059379385812, 818.2431251092715, 824.6000689665508, 842.4902933725131, 843.6541018182515, 6192.81421557354, 7177.784666460015, 7279.89080163798, 7327.963360183165, 7510.84978300431, 893.7944272817158, 946.0284883578961, 960.4957397366298, 979.9657012004545, 983.6704703924122, 3962.821673024721, 4036.5963403659985, 4127.9587204128175, 4397.406350142754, 4441.089576636782, 15179.924100379427, 15516.45692400783, 16038.839611603968, 16076.839231607533, 16131.0, 15431.305591248421, 15436.768448473282, 15704.921475392779, 15811.841881581267, 15884.60288492797, 9709.5145242739, 9726.0, 9773.462459564793, 9792.951035244778, 9803.117719405287, 6377.2984971654005, 6624.0, 6682.966585167043, 6852.5203235773015, 6927.930720692729, 13634.795478068036, 14220.644483887572, 14252.429902803771, 14439.0, 14920.253987300375, 13586.524471643444, 14462.91528135373, 14859.777103343675, 15090.849091509384, 15121.714654254072, 9038.909610903807, 9278.768030799283, 9281.953590232006, 9293.488858112869, 9297.256219502287, 10496.947515262375, 10544.26190166681, 10587.788244234918, 10621.362718236931, 10626.36241825493, 9231.76920576991, 9373.1564159226, 9721.659741909, 9726.562304696447, 9838.163756080814, 8916.598753056258, 9349.672761453316, 9446.763830904283, 9653.806923861343, 9777.80444391094, 8161.673533058849, 8245.546494942835, 8300.460470069425, 8300.916990830256, 8311.044229913638, 5769.30768307789, 5892.6759028252145, 5915.053591425351, 5953.404659534012, 6060.757569697163, 5863.2670916135485, 5992.250968628921, 6068.6965651716355, 6103.877922441615, 6180.412860778219], "value": 5537.252980883742, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.5575756062234, 432.9862177613522, 440.59465291931417, 450.31327225980397, 460.5003571125327, 6032.1554982302405, 6277.058441233818, 6280.697722060392, 6322.241331040276, 6363.300036995933, 6011.128386383972, 6027.909581356273, 6045.516358691305, 6054.757809687607, 6071.666058366788, 4912.691035213453, 5042.722650254234, 5109.872253193663, 5110.974445127769, 5136.486351364871, 5104.157813960692, 5112.616553758483, 5115.872103197413, 5131.717755523445, 5136.897262054776, 5061.848144555669, 5082.695038297696, 5088.982203559284, 5093.26147708582, 5107.208382700669, 5001.674891132065, 5019.222020586815, 5028.6171302891635, 5050.141475949061, 5056.620753443506, 4371.169477799208, 4442.466903971512, 4620.907581848344, 4628.0, 4630.8147674093, 5785.710714464302, 5990.131430942489, 5994.0, 6038.456538911475, 6068.6358818471035, 5763.625364351304, 5771.394003629643, 5771.864410168223, 5772.134179873011, 5784.508316793078, 6515.315891831337, 6551.213854337462, 6553.442957348631, 6579.47364210862, 6584.407403333723, 4961.05739909416, 5004.948960718217, 5022.221555658879, 5037.823676171353, 5039.370078740158, 6777.220619628707, 6787.083743694637, 6794.388505034522, 6798.592084474898, 6800.795976120724, 5198.090334191501, 5202.595299269176, 5206.375234971828, 5227.895442091137, 5231.97976394607, 5225.928684619644, 5229.529342359206, 5239.449857764956, 5246.950609878039, 5271.446498117719, 5796.94203057964, 5812.273465816773, 5814.0, 5817.156512305776, 5824.94175058244, 6564.113844631009, 6594.604323740495, 6602.7689030883685, 6606.86786264272, 6645.06969024337, 1852.7128295114278, 1854.7959724430302, 1859.907004649762, 1862.3016368861677, 1866.234843714098, 1159.4202898550725, 1299.4217573180033, 1320.4982106799355, 1321.9801702974464, 1334.159479527891, 5790.6681463263685, 5792.623479473821, 5801.9129713054335, 5819.447152520504, 5845.824625261249, 6705.094812200388, 6730.687515934345, 6737.3599508046655, 6757.155355580552, 6765.221999470025, 5700.23046888673, 5719.885602287931, 5734.340550836624, 5743.368229494752, 5793.826185214451, 3425.2293234022145, 3509.94735078974, 3527.206378564854, 3529.1530032791943, 3536.381133301662, 6237.688115594202, 6382.234131904108, 6399.968000159969, 6531.83984652129, 6566.376194261537, 6800.455963522906, 6812.761553345609, 6838.316168383122, 6864.38220560152, 6885.483588730865, 6512.446442052384, 6527.445167160845, 6544.2474115475425, 6548.672566371758, 6553.377429144223, 6643.800685979429, 6683.565568238049, 6688.565243259172, 6699.564528305645, 6714.563553369016, 6647.634380109141, 6655.334466553306, 6676.6661666917435, 6684.83287917806, 6689.127044427568, 6509.103448965165, 6512.837179070561, 6514.902276465762, 6523.282438931618, 6525.1517302750335, 5155.355580552431, 5173.63784535079, 5181.481851814789, 5191.351081114861, 5199.610029247746, 6734.966325168343, 6777.593344399352, 6781.728730850711, 6807.421369183675, 6827.829304267433, 6163.445289923929, 6560.540762146604, 6570.5729127608465, 6574.967125164344, 6593.142891424084, 6143.723532440961, 6472.546921715435, 6530.444912182517, 6531.11829902957, 6547.770828020996, 6420.6147631142285, 6447.323031081669, 6480.25477070143, 6482.611043337415, 6501.609903405811, 6458.354164583692, 6581.769638062645, 6584.144061272004, 6607.141071660653, 6611.933880661324, 6396.168498095404, 6396.32838551964, 6401.807945761635, 6405.551611387158, 6417.2299324081405], "value": 5078.3839053741995, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [823.0, 861.194782878009, 864.5633954852794, 867.4318321499418, 867.9088695686953, 15444.0, 15919.124448155375, 15962.361505539793, 16419.179041047944, 17171.65656686867, 13420.798688019688, 14071.155730656143, 14178.43286268548, 14213.218272994982, 14321.355539000744, 717.411722387641, 926.3191554207652, 936.8828896387952, 1005.0452070532987, 1006.8691070160905, 993.8360170571847, 995.7311525888006, 998.0518507417946, 998.9001099890025, 1002.4887307473205, 1044.8589440425521, 1047.6647472808704, 1049.3913530152493, 1049.6168898352123, 1049.716576524338, 1037.3101887244973, 1044.9111825494842, 1046.466302185887, 1046.5499835070916, 1046.6964580271713, 517.0254071076012, 521.8590980435299, 534.2360424592831, 730.5543618392776, 758.6131073152677, 17682.646347073114, 17771.822281777277, 17779.288828446846, 17968.460946171635, 17980.280788768432, 18290.817091829045, 18618.069096545252, 19064.80935190658, 19335.613287734308, 19453.9027304864, 14903.180325082116, 15199.468018619295, 15303.846961530353, 15327.31027103783, 15462.61343466411, 3397.0827876473213, 3433.0215888471917, 3438.0, 3438.2607739336163, 3441.7074548663145, 76710.0, 87080.56459717725, 91821.0, 91979.0, 94714.52642736811, 14857.851421485862, 15066.171360575274, 15131.848681513044, 15171.924140379228, 15237.771433428508, 25115.874420628144, 25218.87390563072, 25265.242042738748, 25454.872725636622, 25471.10851120202, 8342.916570834213, 8360.414770966096, 8461.661533538712, 8463.619137138843, 8512.233898949124, 3673.6326367363586, 3720.925581488355, 3750.0249935016545, 3758.5489741231227, 3774.9056273592832, 4531.750753708512, 4627.3521706961055, 4632.073585282957, 4632.930506042412, 4658.650601204923, 902.3187493442409, 906.7587567834238, 913.0321858829661, 920.1120918313859, 925.2135684668112, 610.7404353149893, 618.6844709198341, 639.8976163813768, 640.5068097564849, 656.8226578823691, 10078.949605252074, 10177.694669159937, 10496.527656255486, 11041.39272340013, 11229.3262404256, 650.1807722269974, 680.1124532485055, 690.2993461636443, 692.5048590257888, 706.5301574453034, 4621.584057434847, 4695.5069717679835, 4761.785719642625, 4831.0820944020525, 5225.0, 81822.0, 85243.0, 86236.0, 89129.0, 89279.55360223158, 65185.34814651793, 71203.0, 72613.63693181501, 72736.63631681808, 76063.61968190124, 60554.697226514465, 61680.0, 62723.0, 64150.67924660347, 67202.99195512071, 10080.243981701255, 10615.0, 10662.626808061681, 10917.781644367227, 11097.445127743742, 27804.30489237785, 29118.854405727834, 29737.10788676343, 29985.400291994476, 30232.09303720804, 36805.63194368022, 36832.63167368292, 37271.44092838556, 38305.80847095747, 38453.80773096117, 13249.13880597758, 13993.720125597227, 14027.859721402656, 14141.43434262618, 14143.0, 15975.28111234974, 16374.345026199295, 16412.917935410245, 16427.09650969208, 16592.585185370463, 14413.85586144125, 14455.638609034437, 14503.709925801635, 14571.344289506786, 14672.046316989361, 14793.0, 14886.404543818126, 15198.316075776396, 15216.771748424004, 15431.15128667889, 13738.86261137376, 14071.0, 14254.928725356722, 14491.78262326045, 14670.486532971296, 9849.45827979468, 10508.159347252355, 11004.294334377864, 11176.273542220055, 11266.380349080551, 10718.19613529004, 11410.315381077162, 11504.25222360544, 11850.348230847041, 12312.445939932546], "value": 7710.989966583981, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1559.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 109.0, 110.0, 109.0, 115.0, 113.0, 109.0, 111.0, 112.0, 115.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 133.0, 150.0, 164.0, 120.0, 147.0, 159.0, 122.0, 172.0, 122.0], "value": 144.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 167.0, 163.0, 162.0, 164.0, 174.0, 168.0, 170.0, 168.0, 163.0], "value": 166.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 78.0, 74.0, 161.0, 74.0, 74.0, 73.0, 76.0, 100.0, 73.0], "value": 85.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 130.0, 84.0, 92.0, 83.0, 134.0, 83.0, 88.0, 137.0], "value": 99.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 116.0, 114.0, 115.0, 114.0, 114.0, 114.0, 114.0, 121.0], "value": 115.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 152.0, 150.0, 151.0, 152.0, 155.0, 151.0, 150.0, 150.0, 151.0], "value": 151.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 99.0, 94.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 56.0, 54.0, 53.0, 53.0, 56.0, 57.0, 54.0, 53.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 56.0, 63.0, 56.0, 55.0, 56.0, 55.0, 56.0], "value": 56.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 82.0, 84.0, 83.0, 81.0, 82.0, 82.0, 107.0, 83.0], "value": 85.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 142.0, 137.0, 134.0, 132.0, 136.0, 128.0, 130.0, 133.0, 134.0], "value": 134.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 202.0, 184.0, 184.0, 186.0, 186.0, 185.0, 198.0, 187.0, 185.0], "value": 190.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 71.0, 70.0, 70.0, 72.0, 69.0, 69.0, 70.0, 70.0], "value": 71.4, "unit": "score"}]}]} 10:23:46 INFO - Return code: 0 10:23:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:23:46 INFO - # TBPL SUCCESS # 10:23:46 INFO - Running post-action listener: _resource_record_post_action 10:23:46 INFO - [mozharness: 2017-06-08 17:23:46.788039Z] Finished run-tests step (success) 10:23:46 INFO - Running post-run listener: _resource_record_post_run 10:23:46 INFO - Total resource usage - Wall time: 1252s; CPU: 13.0%; Read bytes: 0; Write bytes: 426450944; Read time: 0; Write time: 339756 10:23:46 INFO - TinderboxPrint: CPU usage
12.6% 10:23:46 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 10:23:46 INFO - TinderboxPrint: I/O write bytes / time
426,450,944 / 339,756 10:23:46 INFO - TinderboxPrint: CPU idle
8,727.8 (87.3%) 10:23:46 INFO - TinderboxPrint: CPU user
1,210.6 (12.1%) 10:23:46 INFO - TinderboxPrint: Swap in / out
0 / 0 10:23:46 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 98365440; Read time: 0; Write time: 86172 10:23:46 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 10:23:46 INFO - run-tests - Wall time: 1236s; CPU: 13.0%; Read bytes: 0; Write bytes: 328085504; Read time: 0; Write time: 253584 10:23:47 INFO - Running post-run listener: _upload_blobber_files 10:23:47 INFO - Blob upload gear active. 10:23:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:23:47 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:23:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:23:47 INFO - (blobuploader) - INFO - Open directory for files ... 10:23:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:23:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:23:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:23:48 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:23:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:23:48 INFO - (blobuploader) - INFO - Done attempting. 10:23:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:23:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:23:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:23:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:23:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:23:53 INFO - (blobuploader) - INFO - Done attempting. 10:23:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:23:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:23:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:23:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:23:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:23:54 INFO - (blobuploader) - INFO - Done attempting. 10:23:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:23:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:23:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:23:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:23:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:23:55 INFO - (blobuploader) - INFO - Done attempting. 10:23:55 INFO - (blobuploader) - INFO - Iteration through files over. 10:23:55 INFO - Return code: 0 10:23:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:23:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:23:55 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1fbabcabbff2d7a2d0c1092c669f459d35c907a8547cd2b399b98acf36de26945413b24f89b1d88abccc66d2382af6cf105b4a918ce98d84b21c306f222273be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aa065437c359fbd4a43665b748d989e446ce88c76371f55993d2a890748ef06deac143c91b22f9264ba926ebc45195015dd74c836c90a3f0f8ee65e60699d1f1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9b08bb784bc979c963f22932a2d2fec5b993e7e61e815c8b18aca0ea4424b9cc3b823f91d869bad740af4994adcb5a5cd835b75fb14c06904d08903ba524fb9a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dfcc43a67a6d912c5d461162b55664bafba167987f40a04640933bb828095e163e046e75e2bc630ac456cf81d30106dd39a3a47fa345b12e0aab04381aaa66b6"} 10:23:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:23:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:23:55 INFO - Contents: 10:23:55 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1fbabcabbff2d7a2d0c1092c669f459d35c907a8547cd2b399b98acf36de26945413b24f89b1d88abccc66d2382af6cf105b4a918ce98d84b21c306f222273be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aa065437c359fbd4a43665b748d989e446ce88c76371f55993d2a890748ef06deac143c91b22f9264ba926ebc45195015dd74c836c90a3f0f8ee65e60699d1f1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9b08bb784bc979c963f22932a2d2fec5b993e7e61e815c8b18aca0ea4424b9cc3b823f91d869bad740af4994adcb5a5cd835b75fb14c06904d08903ba524fb9a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dfcc43a67a6d912c5d461162b55664bafba167987f40a04640933bb828095e163e046e75e2bc630ac456cf81d30106dd39a3a47fa345b12e0aab04381aaa66b6"} 10:23:55 INFO - Running post-run listener: copy_logs_to_upload_dir 10:23:55 INFO - Copying logs to upload dir... 10:23:55 INFO - mkdir: /builds/slave/test/build/upload/logs 10:23:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1311.682226 ========= master_lag: -0.11 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 51 secs) (at 2017-06-08 10:23:50.881935) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-08 10:23:50.889596) ========= 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=9bfb7e13875ed353a705960e000001c0-1496931357.65609-362803370 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-Non-PGO/sha512/1fbabcabbff2d7a2d0c1092c669f459d35c907a8547cd2b399b98acf36de26945413b24f89b1d88abccc66d2382af6cf105b4a918ce98d84b21c306f222273be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aa065437c359fbd4a43665b748d989e446ce88c76371f55993d2a890748ef06deac143c91b22f9264ba926ebc45195015dd74c836c90a3f0f8ee65e60699d1f1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9b08bb784bc979c963f22932a2d2fec5b993e7e61e815c8b18aca0ea4424b9cc3b823f91d869bad740af4994adcb5a5cd835b75fb14c06904d08903ba524fb9a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dfcc43a67a6d912c5d461162b55664bafba167987f40a04640933bb828095e163e046e75e2bc630ac456cf81d30106dd39a3a47fa345b12e0aab04381aaa66b6"} build_url:https://queue.taskcluster.net/v1/task/bpIrWjRKQX-5uA_EuI5bMg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011234 build_url: 'https://queue.taskcluster.net/v1/task/bpIrWjRKQX-5uA_EuI5bMg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1fbabcabbff2d7a2d0c1092c669f459d35c907a8547cd2b399b98acf36de26945413b24f89b1d88abccc66d2382af6cf105b4a918ce98d84b21c306f222273be", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aa065437c359fbd4a43665b748d989e446ce88c76371f55993d2a890748ef06deac143c91b22f9264ba926ebc45195015dd74c836c90a3f0f8ee65e60699d1f1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9b08bb784bc979c963f22932a2d2fec5b993e7e61e815c8b18aca0ea4424b9cc3b823f91d869bad740af4994adcb5a5cd835b75fb14c06904d08903ba524fb9a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dfcc43a67a6d912c5d461162b55664bafba167987f40a04640933bb828095e163e046e75e2bc630ac456cf81d30106dd39a3a47fa345b12e0aab04381aaa66b6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-08 10:23:50.916744) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 10:23:50.917066) ========= 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=9bfb7e13875ed353a705960e000001c0-1496931357.65609-362803370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004424 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 10:23:50.999859) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-08 10:23:51.000362) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-08 10:23:51.000662) ========= ========= Total master_lag: 0.05 =========