builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-063 starttime: 1495640396.4 results: success (0) revision: e84acaf49a8f5032864a2602c1c61b68ceb1b773 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-24 08:39:56.403829) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-24 08:39:56.404279) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-24 08:39:56.404559) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-24 08:39:56.419980) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 08:39:56.420366) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1495640396.510196-1501590203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-24 08:39:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 26.6M=0s 2017-05-24 08:39:57 (26.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.094269 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 08:39:56.539553) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 08:39:56.539860) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1495640396.510196-1501590203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021222 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 08:39:56.629217) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-24 08:39:56.629678) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e84acaf49a8f5032864a2602c1c61b68ceb1b773 --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 e84acaf49a8f5032864a2602c1c61b68ceb1b773 --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=769a0cfe1e83e11e6f11f5a3000001a8-1495640396.510196-1501590203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-24 08:39:57,465 truncating revision to first 12 chars 2017-05-24 08:39:57,465 Setting DEBUG logging. 2017-05-24 08:39:57,465 attempt 1/10 2017-05-24 08:39:57,465 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e84acaf49a8f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-24 08:39:58,862 unpacking tar archive at: mozilla-central-e84acaf49a8f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.695098 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-24 08:39:58.339261) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-24 08:39:58.339687) ========= script_repo_revision: e84acaf49a8f5032864a2602c1c61b68ceb1b773 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-24 08:39:58.340101) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-24 08:39:58.340395) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-24 08:39:58.349397) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 54 secs) (at 2017-05-24 08:39:58.349837) ========= /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=769a0cfe1e83e11e6f11f5a3000001a8-1495640396.510196-1501590203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:39:59 INFO - MultiFileLogger online at 20170524 08:39:59 in /builds/slave/test 08:39:59 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 08:39:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:39:59 INFO - {'append_to_log': False, 08:39:59 INFO - 'base_work_dir': '/builds/slave/test', 08:39:59 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:39:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:39:59 INFO - 'branch': 'Firefox-Non-PGO', 08:39:59 INFO - 'buildbot_json_path': 'buildprops.json', 08:39:59 INFO - 'config_files': ('talos/linux_config.py',), 08:39:59 INFO - 'default_actions': ('clobber', 08:39:59 INFO - 'read-buildbot-config', 08:39:59 INFO - 'download-and-extract', 08:39:59 INFO - 'populate-webroot', 08:39:59 INFO - 'create-virtualenv', 08:39:59 INFO - 'install', 08:39:59 INFO - 'run-tests'), 08:39:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:39:59 INFO - 'download_minidump_stackwalk': True, 08:39:59 INFO - 'download_symbols': 'ondemand', 08:39:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:39:59 INFO - 'tooltool.py': '/tools/tooltool.py', 08:39:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:39:59 INFO - '/tools/misc-python/virtualenv.py')}, 08:39:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:39:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:39:59 INFO - 'gecko_profile': False, 08:39:59 INFO - 'gecko_profile_interval': 0, 08:39:59 INFO - 'installer_path': 'installer.exe', 08:39:59 INFO - 'log_level': 'info', 08:39:59 INFO - 'log_name': 'talos', 08:39:59 INFO - 'log_to_console': True, 08:39:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:39:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:39:59 INFO - 'opt_config_files': (), 08:39:59 INFO - 'pip_index': False, 08:39:59 INFO - 'suite': 'dromaeojs-e10s', 08:39:59 INFO - 'system_bits': '32', 08:39:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:39:59 INFO - 'title': 'talos-linux64-ix-063', 08:39:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:39:59 INFO - 'use_talos_json': True, 08:39:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:39:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:39:59 INFO - 'work_dir': 'build'} 08:39:59 INFO - [mozharness: 2017-05-24 15:39:59.284625Z] Running clobber step. 08:39:59 INFO - Running pre-action listener: _resource_record_pre_action 08:39:59 INFO - Running main action method: clobber 08:39:59 INFO - rmtree: /builds/slave/test/build 08:39:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:40:00 INFO - Running post-action listener: _resource_record_post_action 08:40:00 INFO - [mozharness: 2017-05-24 15:40:00.851130Z] Finished clobber step (success) 08:40:00 INFO - [mozharness: 2017-05-24 15:40:00.851228Z] Running read-buildbot-config step. 08:40:00 INFO - Running pre-action listener: _resource_record_pre_action 08:40:00 INFO - Running main action method: read_buildbot_config 08:40:00 INFO - Using buildbot properties: 08:40:00 INFO - { 08:40:00 INFO - "project": "", 08:40:00 INFO - "product": "firefox", 08:40:00 INFO - "who": "ffxbld@noreply.mozilla.org", 08:40:00 INFO - "installer_path": "public/build/target.tar.bz2", 08:40:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:40:00 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:40:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:40:00 INFO - "stage_platform": "linux64", 08:40:00 INFO - "basedir": "/builds/slave/test", 08:40:00 INFO - "buildnumber": 899, 08:40:00 INFO - "platform": "ubuntu64_hw", 08:40:00 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:40:00 INFO - "slavebuilddir": "test", 08:40:00 INFO - "taskId": "OXn4EZNeSQaSPzsnGiQjnQ", 08:40:00 INFO - "branch": "mozilla-central", 08:40:00 INFO - "script_repo_revision": "production", 08:40:00 INFO - "revision": "e84acaf49a8f5032864a2602c1c61b68ceb1b773", 08:40:00 INFO - "slavename": "talos-linux64-ix-063", 08:40:00 INFO - "repo_path": "mozilla-central" 08:40:00 INFO - } 08:40:00 INFO - Finding installer, test and symbols from parent task. 08:40:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OXn4EZNeSQaSPzsnGiQjnQ'}, attempt #1 08:40:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OXn4EZNeSQaSPzsnGiQjnQ'}, attempt #1 08:40:01 INFO - Task dependencies: bYhn8c33SxSX5kd1GsJO-Q 08:40:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bYhn8c33SxSX5kd1GsJO-Q'}, attempt #1 08:40:02 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/bYhn8c33SxSX5kd1GsJO-Q/artifacts/public/build/target.tar.bz2 08:40:02 INFO - Set test_url: https://queue.taskcluster.net/v1/task/bYhn8c33SxSX5kd1GsJO-Q/artifacts/public/build/test_packages.json 08:40:02 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/bYhn8c33SxSX5kd1GsJO-Q/artifacts/public/build/target.crashreporter-symbols.zip 08:40:02 INFO - Running post-action listener: _resource_record_post_action 08:40:02 INFO - [mozharness: 2017-05-24 15:40:02.224426Z] Finished read-buildbot-config step (success) 08:40:02 INFO - [mozharness: 2017-05-24 15:40:02.224646Z] Running download-and-extract step. 08:40:02 INFO - Running pre-action listener: _resource_record_pre_action 08:40:02 INFO - Running main action method: download_and_extract 08:40:02 INFO - mkdir: /builds/slave/test/build/tests 08:40:02 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')]} 08:40:02 INFO - trying https://queue.taskcluster.net/v1/task/bYhn8c33SxSX5kd1GsJO-Q/artifacts/public/build/target.test_packages.json 08:40:02 INFO - Downloading https://queue.taskcluster.net/v1/task/bYhn8c33SxSX5kd1GsJO-Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:40:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bYhn8c33SxSX5kd1GsJO-Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:40:02 INFO - Downloaded 986 bytes. 08:40:02 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:40:02 INFO - Using the following test package requirements: 08:40:02 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:40:02 INFO - u'common': [u'target.common.tests.zip'], 08:40:02 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:40:02 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:40:02 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:40:02 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:40:02 INFO - u'mozbase': [u'target.common.tests.zip'], 08:40:02 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:40:02 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:40:02 INFO - u'web-platform': [u'target.common.tests.zip', 08:40:02 INFO - u'target.web-platform.tests.zip'], 08:40:02 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:40:02 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:40:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bYhn8c33SxSX5kd1GsJO-Q/artifacts/public/build/target.common.tests.zip 08:40:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bYhn8c33SxSX5kd1GsJO-Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:40:02 INFO - Fetch https://queue.taskcluster.net/v1/task/bYhn8c33SxSX5kd1GsJO-Q/artifacts/public/build/target.common.tests.zip into memory 08:40:03 INFO - Content-Length response header: 63530558 08:40:03 INFO - Bytes received: 63530558 08:40:14 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:40:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bYhn8c33SxSX5kd1GsJO-Q/artifacts/public/build/target.common.tests.zip 08:40:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bYhn8c33SxSX5kd1GsJO-Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:40:14 INFO - Fetch https://queue.taskcluster.net/v1/task/bYhn8c33SxSX5kd1GsJO-Q/artifacts/public/build/target.common.tests.zip into memory 08:40:16 INFO - Content-Length response header: 63530558 08:40:16 INFO - Bytes received: 63530558 08:40:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bYhn8c33SxSX5kd1GsJO-Q/artifacts/public/build/target.talos.tests.zip 08:40:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bYhn8c33SxSX5kd1GsJO-Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:40:28 INFO - Fetch https://queue.taskcluster.net/v1/task/bYhn8c33SxSX5kd1GsJO-Q/artifacts/public/build/target.talos.tests.zip into memory 08:40:28 INFO - Content-Length response header: 14411859 08:40:28 INFO - Bytes received: 14411859 08:40:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:29 INFO - trying https://queue.taskcluster.net/v1/task/bYhn8c33SxSX5kd1GsJO-Q/artifacts/public/build/target.tar.bz2 08:40:29 INFO - Downloading https://queue.taskcluster.net/v1/task/bYhn8c33SxSX5kd1GsJO-Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:40:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bYhn8c33SxSX5kd1GsJO-Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:40:30 INFO - Downloaded 54864577 bytes. 08:40:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bYhn8c33SxSX5kd1GsJO-Q/artifacts/public/build/target.tar.bz2 08:40:30 INFO - mkdir: /builds/slave/test/properties 08:40:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:40:30 INFO - Writing to file /builds/slave/test/properties/build_url 08:40:30 INFO - Contents: 08:40:30 INFO - build_url:https://queue.taskcluster.net/v1/task/bYhn8c33SxSX5kd1GsJO-Q/artifacts/public/build/target.tar.bz2 08:40:30 INFO - Running post-action listener: _resource_record_post_action 08:40:30 INFO - Running post-action listener: set_extra_try_arguments 08:40:30 INFO - [mozharness: 2017-05-24 15:40:30.175475Z] Finished download-and-extract step (success) 08:40:30 INFO - [mozharness: 2017-05-24 15:40:30.175572Z] Running populate-webroot step. 08:40:30 INFO - Running pre-action listener: _resource_record_pre_action 08:40:30 INFO - Running main action method: populate_webroot 08:40:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:40:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:40:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:40:30 INFO - '--tppagecycles', 08:40:30 INFO - '7'], 08:40:30 INFO - 'tests': ['tsvgm']}}, 08:40:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:40:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:40:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:40:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:40:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:40:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:40:30 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:40:30 INFO - 'talos_options': ['--disable-e10s'], 08:40:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:40:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:30 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:40:30 INFO - 'talos_options': ['--disable-e10s'], 08:40:30 INFO - 'tests': ['damp', 'tps']}, 08:40:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:40:30 INFO - 'tests': ['damp', 'tps']}, 08:40:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:40:30 INFO - 'tests': ['dromaeo_dom']}, 08:40:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:40:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:40:30 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:40:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:40:30 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:40:30 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:40:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:40:30 INFO - 'tests': ['a11yr', 08:40:30 INFO - 'ts_paint', 08:40:30 INFO - 'tpaint', 08:40:30 INFO - 'sessionrestore', 08:40:30 INFO - 'sessionrestore_no_auto_restore', 08:40:30 INFO - 'tabpaint']}, 08:40:30 INFO - 'other-e10s': {'tests': ['a11yr', 08:40:30 INFO - 'ts_paint', 08:40:30 INFO - 'tpaint', 08:40:30 INFO - 'sessionrestore', 08:40:30 INFO - 'sessionrestore_no_auto_restore', 08:40:30 INFO - 'tabpaint']}, 08:40:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:40:30 INFO - 'ts_paint', 08:40:30 INFO - 'tpaint', 08:40:30 INFO - 'sessionrestore', 08:40:30 INFO - 'sessionrestore_no_auto_restore', 08:40:30 INFO - 'tabpaint']}, 08:40:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:40:30 INFO - 'ts_paint', 08:40:30 INFO - 'tpaint', 08:40:30 INFO - 'sessionrestore', 08:40:30 INFO - 'sessionrestore_no_auto_restore', 08:40:30 INFO - 'tabpaint']}, 08:40:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:40:30 INFO - 'tests': ['a11yr', 08:40:30 INFO - 'ts_paint', 08:40:30 INFO - 'tpaint', 08:40:30 INFO - 'sessionrestore', 08:40:30 INFO - 'sessionrestore_no_auto_restore', 08:40:30 INFO - 'tabpaint']}, 08:40:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:40:30 INFO - 'tests': ['a11yr', 08:40:30 INFO - 'ts_paint', 08:40:30 INFO - 'tpaint', 08:40:30 INFO - 'sessionrestore', 08:40:30 INFO - 'sessionrestore_no_auto_restore', 08:40:30 INFO - 'tabpaint']}, 08:40:30 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 08:40:30 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 08:40:30 INFO - 'bloom_basic_ref']}, 08:40:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:40:30 INFO - 'tests': ['tsvgx', 08:40:30 INFO - 'tsvgr_opacity', 08:40:30 INFO - 'tart', 08:40:30 INFO - 'tscrollx', 08:40:30 INFO - 'cart', 08:40:30 INFO - 'tsvg_static']}, 08:40:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:40:30 INFO - 'tsvgr_opacity', 08:40:30 INFO - 'tart', 08:40:30 INFO - 'tscrollx', 08:40:30 INFO - 'cart', 08:40:30 INFO - 'tsvg_static']}, 08:40:30 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:40:30 INFO - 'talos_options': ['--disable-e10s'], 08:40:30 INFO - 'tests': ['tp5o']}, 08:40:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:40:30 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:40:30 INFO - 'talos_options': ['--disable-e10s', 08:40:30 INFO - '--xperf_path', 08:40:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:30 INFO - 'tests': ['tp5n']}, 08:40:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:40:30 INFO - 'talos_options': ['--xperf_path', 08:40:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:30 INFO - 'tests': ['tp5n']}}, 08:40:30 INFO - 'talos.zip': {'path': '', 08:40:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:40:30 INFO - Running post-action listener: _resource_record_post_action 08:40:30 INFO - [mozharness: 2017-05-24 15:40:30.189523Z] Finished populate-webroot step (success) 08:40:30 INFO - [mozharness: 2017-05-24 15:40:30.189612Z] Running create-virtualenv step. 08:40:30 INFO - Running pre-action listener: _resource_record_pre_action 08:40:30 INFO - Running main action method: create_virtualenv 08:40:30 INFO - Creating virtualenv /builds/slave/test/build/venv 08:40:30 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 08:40:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:40:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:40:30 INFO - Using real prefix '/usr' 08:40:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:40:30 INFO - Installing distribute.............................................................................................................................................................................................done. 08:40:32 INFO - Installing pip.................done. 08:40:32 INFO - Return code: 0 08:40:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:40:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:40:32 INFO - Reading from file tmpfile_stdout 08:40:32 INFO - Output received: 08:40:32 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:40:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:40:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x250e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28815c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287e7a0>, '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 0x287f6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287fb30>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1495640396.510196-1501590203', '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 08:40:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:40:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:40:32 INFO - Using env: {'DISPLAY': ':0', 08:40:32 INFO - 'HOME': '/home/cltbld', 08:40:32 INFO - 'LANG': 'en_US.UTF-8', 08:40:32 INFO - 'LANGUAGE': 'en_US:en', 08:40:32 INFO - 'LOGNAME': 'cltbld', 08:40:32 INFO - 'MAIL': '/var/mail/cltbld', 08:40:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:32 INFO - 'MOZ_NO_REMOTE': '1', 08:40:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:32 INFO - 'NO_EM_RESTART': '1', 08:40:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:32 INFO - 'PWD': '/builds/slave/test', 08:40:32 INFO - 'SHELL': '/bin/bash', 08:40:32 INFO - 'SHLVL': '1', 08:40:32 INFO - 'TERM': 'linux', 08:40:32 INFO - 'TMOUT': '86400', 08:40:32 INFO - 'USER': 'cltbld', 08:40:32 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1495640396.510196-1501590203', 08:40:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:32 INFO - '_': '/tools/buildbot/bin/python'} 08:40:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:33 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:40:33 INFO - Cleaning up... 08:40:33 INFO - Return code: 0 08:40:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x250e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28815c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287e7a0>, '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 0x287f6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287fb30>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1495640396.510196-1501590203', '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 08:40:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:40:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:40:33 INFO - Using env: {'DISPLAY': ':0', 08:40:33 INFO - 'HOME': '/home/cltbld', 08:40:33 INFO - 'LANG': 'en_US.UTF-8', 08:40:33 INFO - 'LANGUAGE': 'en_US:en', 08:40:33 INFO - 'LOGNAME': 'cltbld', 08:40:33 INFO - 'MAIL': '/var/mail/cltbld', 08:40:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:33 INFO - 'MOZ_NO_REMOTE': '1', 08:40:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:33 INFO - 'NO_EM_RESTART': '1', 08:40:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:33 INFO - 'PWD': '/builds/slave/test', 08:40:33 INFO - 'SHELL': '/bin/bash', 08:40:33 INFO - 'SHLVL': '1', 08:40:33 INFO - 'TERM': 'linux', 08:40:33 INFO - 'TMOUT': '86400', 08:40:33 INFO - 'USER': 'cltbld', 08:40:33 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1495640396.510196-1501590203', 08:40:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:33 INFO - '_': '/tools/buildbot/bin/python'} 08:40:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:33 INFO - Downloading/unpacking psutil>=3.1.1 08:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:40:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:40:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:40:34 INFO - Installing collected packages: psutil 08:40:34 INFO - Running setup.py install for psutil 08:40:34 INFO - building 'psutil._psutil_linux' extension 08:40:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:40:34 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 08:40:34 INFO - building 'psutil._psutil_posix' extension 08:40:34 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 08:40:35 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:40:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:40:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:40:35 INFO - Successfully installed psutil 08:40:35 INFO - Cleaning up... 08:40:35 INFO - Return code: 0 08:40:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:40:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:35 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 0x250e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28815c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287e7a0>, '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 0x287f6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287fb30>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1495640396.510196-1501590203', '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 08:40:35 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 08:40:35 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 08:40:35 INFO - Using env: {'DISPLAY': ':0', 08:40:35 INFO - 'HOME': '/home/cltbld', 08:40:35 INFO - 'LANG': 'en_US.UTF-8', 08:40:35 INFO - 'LANGUAGE': 'en_US:en', 08:40:35 INFO - 'LOGNAME': 'cltbld', 08:40:35 INFO - 'MAIL': '/var/mail/cltbld', 08:40:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:35 INFO - 'MOZ_NO_REMOTE': '1', 08:40:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:35 INFO - 'NO_EM_RESTART': '1', 08:40:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:35 INFO - 'PWD': '/builds/slave/test', 08:40:35 INFO - 'SHELL': '/bin/bash', 08:40:35 INFO - 'SHLVL': '1', 08:40:35 INFO - 'TERM': 'linux', 08:40:35 INFO - 'TMOUT': '86400', 08:40:35 INFO - 'USER': 'cltbld', 08:40:35 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1495640396.510196-1501590203', 08:40:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:35 INFO - '_': '/tools/buildbot/bin/python'} 08:40:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:40:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:40:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:40:36 INFO - Installing collected packages: mozsystemmonitor 08:40:36 INFO - Running setup.py install for mozsystemmonitor 08:40:36 INFO - Successfully installed mozsystemmonitor 08:40:36 INFO - Cleaning up... 08:40:36 INFO - Return code: 0 08:40:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x250e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28815c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287e7a0>, '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 0x287f6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287fb30>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1495640396.510196-1501590203', '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 08:40:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:40:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:40:36 INFO - Using env: {'DISPLAY': ':0', 08:40:36 INFO - 'HOME': '/home/cltbld', 08:40:36 INFO - 'LANG': 'en_US.UTF-8', 08:40:36 INFO - 'LANGUAGE': 'en_US:en', 08:40:36 INFO - 'LOGNAME': 'cltbld', 08:40:36 INFO - 'MAIL': '/var/mail/cltbld', 08:40:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:36 INFO - 'MOZ_NO_REMOTE': '1', 08:40:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:36 INFO - 'NO_EM_RESTART': '1', 08:40:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:36 INFO - 'PWD': '/builds/slave/test', 08:40:36 INFO - 'SHELL': '/bin/bash', 08:40:36 INFO - 'SHLVL': '1', 08:40:36 INFO - 'TERM': 'linux', 08:40:36 INFO - 'TMOUT': '86400', 08:40:36 INFO - 'USER': 'cltbld', 08:40:36 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1495640396.510196-1501590203', 08:40:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:36 INFO - '_': '/tools/buildbot/bin/python'} 08:40:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:36 INFO - Downloading/unpacking jsonschema==2.5.1 08:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:40:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:40:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:38 INFO - Downloading functools32-3.2.3-2.tar.gz 08:40:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:40:38 INFO - warning: no files found matching '*.txt' 08:40:38 INFO - no previously-included directories found matching 'build' 08:40:38 INFO - no previously-included directories found matching 'dist' 08:40:38 INFO - no previously-included directories found matching '.git*' 08:40:38 INFO - Installing collected packages: jsonschema, functools32 08:40:38 INFO - Running setup.py install for functools32 08:40:38 INFO - warning: no files found matching '*.txt' 08:40:38 INFO - no previously-included directories found matching 'build' 08:40:38 INFO - no previously-included directories found matching 'dist' 08:40:38 INFO - no previously-included directories found matching '.git*' 08:40:38 INFO - Successfully installed jsonschema functools32 08:40:38 INFO - Cleaning up... 08:40:38 INFO - Return code: 0 08:40:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:40: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')]} 08:40:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40: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')]} 08:40:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40: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', '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 0x250e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28815c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287e7a0>, '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 0x287f6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287fb30>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1495640396.510196-1501590203', '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 08:40: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:40: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 functools32==3.2.3-2 08:40:38 INFO - Using env: {'DISPLAY': ':0', 08:40:38 INFO - 'HOME': '/home/cltbld', 08:40:38 INFO - 'LANG': 'en_US.UTF-8', 08:40:38 INFO - 'LANGUAGE': 'en_US:en', 08:40:38 INFO - 'LOGNAME': 'cltbld', 08:40:38 INFO - 'MAIL': '/var/mail/cltbld', 08:40:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:38 INFO - 'MOZ_NO_REMOTE': '1', 08:40:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:38 INFO - 'NO_EM_RESTART': '1', 08:40:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:38 INFO - 'PWD': '/builds/slave/test', 08:40:38 INFO - 'SHELL': '/bin/bash', 08:40:38 INFO - 'SHLVL': '1', 08:40:38 INFO - 'TERM': 'linux', 08:40:38 INFO - 'TMOUT': '86400', 08:40:38 INFO - 'USER': 'cltbld', 08:40:38 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1495640396.510196-1501590203', 08:40:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:38 INFO - '_': '/tools/buildbot/bin/python'} 08:40:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:40:38 INFO - Cleaning up... 08:40:38 INFO - Return code: 0 08:40:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:40: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')]} 08:40:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40: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')]} 08:40:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40: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', '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 0x250e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28815c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287e7a0>, '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 0x287f6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287fb30>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1495640396.510196-1501590203', '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 08:40: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:40: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 blobuploader==1.2.4 08:40:38 INFO - Using env: {'DISPLAY': ':0', 08:40:38 INFO - 'HOME': '/home/cltbld', 08:40:38 INFO - 'LANG': 'en_US.UTF-8', 08:40:38 INFO - 'LANGUAGE': 'en_US:en', 08:40:38 INFO - 'LOGNAME': 'cltbld', 08:40:38 INFO - 'MAIL': '/var/mail/cltbld', 08:40:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:38 INFO - 'MOZ_NO_REMOTE': '1', 08:40:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:38 INFO - 'NO_EM_RESTART': '1', 08:40:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:38 INFO - 'PWD': '/builds/slave/test', 08:40:38 INFO - 'SHELL': '/bin/bash', 08:40:38 INFO - 'SHLVL': '1', 08:40:38 INFO - 'TERM': 'linux', 08:40:38 INFO - 'TMOUT': '86400', 08:40:38 INFO - 'USER': 'cltbld', 08:40:38 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1495640396.510196-1501590203', 08:40:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:38 INFO - '_': '/tools/buildbot/bin/python'} 08:40:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:38 INFO - Downloading/unpacking blobuploader==1.2.4 08:40:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:39 INFO - Downloading blobuploader-1.2.4.tar.gz 08:40:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:40:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:40:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:40:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:40:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:40:40 INFO - Downloading docopt-0.6.1.tar.gz 08:40:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:40:40 INFO - Installing collected packages: blobuploader, requests, docopt 08:40:40 INFO - Running setup.py install for blobuploader 08:40:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:40:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:40:40 INFO - Running setup.py install for requests 08:40:40 INFO - Running setup.py install for docopt 08:40:41 INFO - Successfully installed blobuploader requests docopt 08:40:41 INFO - Cleaning up... 08:40:41 INFO - Return code: 0 08:40:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:40:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x250e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28815c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287e7a0>, '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 0x287f6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287fb30>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1495640396.510196-1501590203', '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 08:40:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:40:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:40:41 INFO - Using env: {'DISPLAY': ':0', 08:40:41 INFO - 'HOME': '/home/cltbld', 08:40:41 INFO - 'LANG': 'en_US.UTF-8', 08:40:41 INFO - 'LANGUAGE': 'en_US:en', 08:40:41 INFO - 'LOGNAME': 'cltbld', 08:40:41 INFO - 'MAIL': '/var/mail/cltbld', 08:40:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:41 INFO - 'MOZ_NO_REMOTE': '1', 08:40:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:41 INFO - 'NO_EM_RESTART': '1', 08:40:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:41 INFO - 'PWD': '/builds/slave/test', 08:40:41 INFO - 'SHELL': '/bin/bash', 08:40:41 INFO - 'SHLVL': '1', 08:40:41 INFO - 'TERM': 'linux', 08:40:41 INFO - 'TMOUT': '86400', 08:40:41 INFO - 'USER': 'cltbld', 08:40:41 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1495640396.510196-1501590203', 08:40:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:41 INFO - '_': '/tools/buildbot/bin/python'} 08:40:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:40:41 INFO - Running setup.py (path:/tmp/pip-RAEfxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:40:41 INFO - Running setup.py (path:/tmp/pip-OI8aWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:40:41 INFO - Running setup.py (path:/tmp/pip-M1Laxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:40:41 INFO - Running setup.py (path:/tmp/pip-R7w5c7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:40:41 INFO - Running setup.py (path:/tmp/pip-rRQa6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:40:41 INFO - Running setup.py (path:/tmp/pip-lpguHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:40:41 INFO - Running setup.py (path:/tmp/pip-Ndz2fY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:40:41 INFO - Running setup.py (path:/tmp/pip-DtApfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:40:41 INFO - Running setup.py (path:/tmp/pip-lzwi1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:40:41 INFO - Running setup.py (path:/tmp/pip-QFQ5q7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:40:42 INFO - Running setup.py (path:/tmp/pip-yDu8ST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:40:42 INFO - Running setup.py (path:/tmp/pip-jAF7AM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:40:42 INFO - Running setup.py (path:/tmp/pip-vYyiQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:40:42 INFO - Running setup.py (path:/tmp/pip-Zgh5kk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:42 INFO - Running setup.py (path:/tmp/pip-dWhwr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:40:42 INFO - Running setup.py (path:/tmp/pip-Tf9I4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:40:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:40:42 INFO - Running setup.py (path:/tmp/pip-Bw5cXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:40:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:40:42 INFO - Running setup.py install for manifestparser 08:40:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:40:42 INFO - Running setup.py install for mozcrash 08:40:42 INFO - Running setup.py install for mozdebug 08:40:42 INFO - Running setup.py install for mozdevice 08:40:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:40:42 INFO - Running setup.py install for mozfile 08:40:43 INFO - Running setup.py install for mozhttpd 08:40:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:40:43 INFO - Running setup.py install for mozinfo 08:40:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:40:43 INFO - Running setup.py install for mozInstall 08:40:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:40:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:40:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:40:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:40:43 INFO - Running setup.py install for mozleak 08:40:43 INFO - Running setup.py install for mozlog 08:40:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:40:43 INFO - Running setup.py install for moznetwork 08:40:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:40:43 INFO - Running setup.py install for mozprocess 08:40:43 INFO - Running setup.py install for mozprofile 08:40:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:40:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:40:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:40:43 INFO - Running setup.py install for mozrunner 08:40:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:40:43 INFO - Running setup.py install for mozscreenshot 08:40:44 INFO - Running setup.py install for moztest 08:40:44 INFO - Running setup.py install for mozversion 08:40:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:40:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:40:44 INFO - Cleaning up... 08:40:44 INFO - Return code: 0 08:40:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:40:44 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')]} 08:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:44 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')]} 08:40:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:44 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 0x250e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28815c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287e7a0>, '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 0x287f6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287fb30>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1495640396.510196-1501590203', '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 08:40:44 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 08:40:44 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 08:40:44 INFO - Using env: {'DISPLAY': ':0', 08:40:44 INFO - 'HOME': '/home/cltbld', 08:40:44 INFO - 'LANG': 'en_US.UTF-8', 08:40:44 INFO - 'LANGUAGE': 'en_US:en', 08:40:44 INFO - 'LOGNAME': 'cltbld', 08:40:44 INFO - 'MAIL': '/var/mail/cltbld', 08:40:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:44 INFO - 'MOZ_NO_REMOTE': '1', 08:40:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:44 INFO - 'NO_EM_RESTART': '1', 08:40:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:44 INFO - 'PWD': '/builds/slave/test', 08:40:44 INFO - 'SHELL': '/bin/bash', 08:40:44 INFO - 'SHLVL': '1', 08:40:44 INFO - 'TERM': 'linux', 08:40:44 INFO - 'TMOUT': '86400', 08:40:44 INFO - 'USER': 'cltbld', 08:40:44 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1495640396.510196-1501590203', 08:40:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:44 INFO - '_': '/tools/buildbot/bin/python'} 08:40:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:40:44 INFO - Running setup.py (path:/tmp/pip-JlkGAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:40:44 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)) 08:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:40:44 INFO - Running setup.py (path:/tmp/pip-Nno1Zd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:40:44 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)) 08:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:40:44 INFO - Running setup.py (path:/tmp/pip-7KbL5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:40:44 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)) 08:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:40:44 INFO - Running setup.py (path:/tmp/pip-seK2Q7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 08:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:40:44 INFO - Running setup.py (path:/tmp/pip-dahtOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:40:44 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)) 08:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:40:44 INFO - Running setup.py (path:/tmp/pip-dVhCHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:40:44 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)) 08:40:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:40:44 INFO - Running setup.py (path:/tmp/pip-srh72a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:40:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 08:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:40:45 INFO - Running setup.py (path:/tmp/pip-tvpqTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:40:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:40:45 INFO - Running setup.py (path:/tmp/pip-7krAtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:40:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:40:45 INFO - Running setup.py (path:/tmp/pip-6ncWiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:40:45 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)) 08:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:40:45 INFO - Running setup.py (path:/tmp/pip-Kli0GP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:40:45 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)) 08:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:40:45 INFO - Running setup.py (path:/tmp/pip-YOpHLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:40:45 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)) 08:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:40:45 INFO - Running setup.py (path:/tmp/pip-gobQkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:40:45 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)) 08:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:40:45 INFO - Running setup.py (path:/tmp/pip-6zPmat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:40:45 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)) 08:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:45 INFO - Running setup.py (path:/tmp/pip-DrFeVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:40:45 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)) 08:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:40:45 INFO - Running setup.py (path:/tmp/pip-CtMVXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:40:45 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)) 08:40:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:40:45 INFO - Running setup.py (path:/tmp/pip-hMalAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:40:45 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)) 08:40:45 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)) 08:40:45 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)) 08:40:45 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)) 08:40:45 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:40:45 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:40:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:40: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 08:40: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 08:40: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 08:40: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 08:40:46 INFO - Downloading blessings-1.6.tar.gz 08:40:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:40:46 INFO - Installing collected packages: blessings 08:40:46 INFO - Running setup.py install for blessings 08:40:47 INFO - Successfully installed blessings 08:40:47 INFO - Cleaning up... 08:40:47 INFO - Return code: 0 08:40:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:40:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:40:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:40:47 INFO - Reading from file tmpfile_stdout 08:40:47 INFO - Current package versions: 08:40:47 INFO - argparse == 1.2.1 08:40:47 INFO - blessings == 1.6 08:40:47 INFO - blobuploader == 1.2.4 08:40:47 INFO - docopt == 0.6.1 08:40:47 INFO - functools32 == 3.2.3-2 08:40:47 INFO - jsonschema == 2.5.1 08:40:47 INFO - manifestparser == 1.1 08:40:47 INFO - mozInstall == 1.12 08:40:47 INFO - mozcrash == 1.0 08:40:47 INFO - mozdebug == 0.1 08:40:47 INFO - mozdevice == 0.50 08:40:47 INFO - mozfile == 1.2 08:40:47 INFO - mozhttpd == 0.7 08:40:47 INFO - mozinfo == 0.9 08:40:47 INFO - mozleak == 0.1 08:40:47 INFO - mozlog == 3.4 08:40:47 INFO - moznetwork == 0.27 08:40:47 INFO - mozprocess == 0.25 08:40:47 INFO - mozprofile == 0.28 08:40:47 INFO - mozrunner == 6.13 08:40:47 INFO - mozscreenshot == 0.1 08:40:47 INFO - mozsystemmonitor == 0.3 08:40:47 INFO - moztest == 0.8 08:40:47 INFO - mozversion == 1.4 08:40:47 INFO - psutil == 3.1.1 08:40:47 INFO - requests == 1.2.3 08:40:47 INFO - wsgiref == 0.1.2 08:40:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:40:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:47 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 0x250e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28815c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287e7a0>, '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 0x287f6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287fb30>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1495640396.510196-1501590203', '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 08:40:47 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 08:40:47 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 08:40:47 INFO - Using env: {'DISPLAY': ':0', 08:40:47 INFO - 'HOME': '/home/cltbld', 08:40:47 INFO - 'LANG': 'en_US.UTF-8', 08:40:47 INFO - 'LANGUAGE': 'en_US:en', 08:40:47 INFO - 'LOGNAME': 'cltbld', 08:40:47 INFO - 'MAIL': '/var/mail/cltbld', 08:40:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:47 INFO - 'MOZ_NO_REMOTE': '1', 08:40:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:47 INFO - 'NO_EM_RESTART': '1', 08:40:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:47 INFO - 'PWD': '/builds/slave/test', 08:40:47 INFO - 'SHELL': '/bin/bash', 08:40:47 INFO - 'SHLVL': '1', 08:40:47 INFO - 'TERM': 'linux', 08:40:47 INFO - 'TMOUT': '86400', 08:40:47 INFO - 'USER': 'cltbld', 08:40:47 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1495640396.510196-1501590203', 08:40:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:47 INFO - '_': '/tools/buildbot/bin/python'} 08:40:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:47 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)) 08:40:47 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)) 08:40:47 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)) 08:40:47 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)) 08:40:47 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)) 08:40:47 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)) 08:40:47 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)) 08:40:47 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)) 08:40:47 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)) 08:40:47 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:40:47 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 08:40:47 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 08:40:47 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 08:40:47 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 08:40:48 INFO - Downloading marionette_driver-1.4.0.tar.gz 08:40:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 08:40:48 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)) 08:40:48 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)) 08:40:48 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)) 08:40:48 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)) 08:40:48 INFO - Installing collected packages: marionette-driver 08:40:48 INFO - Running setup.py install for marionette-driver 08:40:48 INFO - Successfully installed marionette-driver 08:40:48 INFO - Cleaning up... 08:40:48 INFO - Return code: 0 08:40:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:40:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:40:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:40:48 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 0x250e1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26dba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28815c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x287e7a0>, '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 0x287f6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287fb30>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1495640396.510196-1501590203', '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 08:40:48 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 08:40:48 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 08:40:48 INFO - Using env: {'DISPLAY': ':0', 08:40:48 INFO - 'HOME': '/home/cltbld', 08:40:48 INFO - 'LANG': 'en_US.UTF-8', 08:40:48 INFO - 'LANGUAGE': 'en_US:en', 08:40:48 INFO - 'LOGNAME': 'cltbld', 08:40:48 INFO - 'MAIL': '/var/mail/cltbld', 08:40:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:40:48 INFO - 'MOZ_NO_REMOTE': '1', 08:40:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:40:48 INFO - 'NO_EM_RESTART': '1', 08:40:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:40:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:40:48 INFO - 'PWD': '/builds/slave/test', 08:40:48 INFO - 'SHELL': '/bin/bash', 08:40:48 INFO - 'SHLVL': '1', 08:40:48 INFO - 'TERM': 'linux', 08:40:48 INFO - 'TMOUT': '86400', 08:40:48 INFO - 'USER': 'cltbld', 08:40:48 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1495640396.510196-1501590203', 08:40:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:40:48 INFO - '_': '/tools/buildbot/bin/python'} 08:40:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:40:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:40:49 INFO - Cleaning up... 08:40:49 INFO - Return code: 0 08:40:49 INFO - Running post-action listener: _resource_record_post_action 08:40:49 INFO - Running post-action listener: _start_resource_monitoring 08:40:49 INFO - Starting resource monitoring. 08:40:49 INFO - [mozharness: 2017-05-24 15:40:49.096032Z] Finished create-virtualenv step (success) 08:40:49 INFO - [mozharness: 2017-05-24 15:40:49.096489Z] Running install step. 08:40:49 INFO - Running pre-action listener: _resource_record_pre_action 08:40:49 INFO - Running main action method: install 08:40:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:40:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:40:49 INFO - Reading from file tmpfile_stdout 08:40:49 INFO - Detecting whether we're running mozinstall >=1.0... 08:40:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:40:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:40:49 INFO - Reading from file tmpfile_stdout 08:40:49 INFO - Output received: 08:40:49 INFO - Usage: mozinstall [options] installer 08:40:49 INFO - Options: 08:40:49 INFO - -h, --help show this help message and exit 08:40:49 INFO - -d DEST, --destination=DEST 08:40:49 INFO - Directory to install application into. [default: 08:40:49 INFO - "/builds/slave/test"] 08:40:49 INFO - --app=APP Application being installed. [default: firefox] 08:40:49 INFO - mkdir: /builds/slave/test/build/application 08:40:49 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'] 08:40:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:41:05 INFO - Reading from file tmpfile_stdout 08:41:05 INFO - Output received: 08:41:05 INFO - /builds/slave/test/build/application/firefox/firefox 08:41:05 INFO - Running post-action listener: _resource_record_post_action 08:41:05 INFO - [mozharness: 2017-05-24 15:41:05.089599Z] Finished install step (success) 08:41:05 INFO - [mozharness: 2017-05-24 15:41:05.089871Z] Running run-tests step. 08:41:05 INFO - Running pre-action listener: _resource_record_pre_action 08:41:05 INFO - Running main action method: run_tests 08:41:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:41:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:41:05 INFO - Python 2.7.3 08:41:05 INFO - Return code: 0 08:41:05 INFO - grabbing minidump binary from tooltool 08:41: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')]} 08:41:05 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 0x287e7a0>, '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 0x287f6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x287fb30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:41:05 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 08:41:05 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 08:41:05 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 08:41:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:41:05 INFO - Return code: 0 08:41:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:41:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:41:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:41:05 INFO - ENV: RUST_BACKTRACE is now 1 08:41:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:41:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:41:05 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/bYhn8c33SxSX5kd1GsJO-Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 08:41:05 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/bYhn8c33SxSX5kd1GsJO-Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 08:41:05 INFO - Using env: {'DISPLAY': ':0', 08:41:05 INFO - 'HOME': '/home/cltbld', 08:41:05 INFO - 'LANG': 'en_US.UTF-8', 08:41:05 INFO - 'LANGUAGE': 'en_US:en', 08:41:05 INFO - 'LOGNAME': 'cltbld', 08:41:05 INFO - 'MAIL': '/var/mail/cltbld', 08:41:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:41:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:41:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:05 INFO - 'MOZ_NO_REMOTE': '1', 08:41:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:41:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:41:05 INFO - 'NO_EM_RESTART': '1', 08:41:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:41:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:05 INFO - 'PWD': '/builds/slave/test', 08:41:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:41:05 INFO - 'RUST_BACKTRACE': '1', 08:41:05 INFO - 'SHELL': '/bin/bash', 08:41:05 INFO - 'SHLVL': '1', 08:41:05 INFO - 'TERM': 'linux', 08:41:05 INFO - 'TMOUT': '86400', 08:41:05 INFO - 'USER': 'cltbld', 08:41:05 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1495640396.510196-1501590203', 08:41:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:05 INFO - '_': '/tools/buildbot/bin/python'} 08:41:05 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/bYhn8c33SxSX5kd1GsJO-Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 08:41:05 INFO - mozversion application_buildid: 20170524150905 08:41:05 INFO - mozversion application_changeset: e84acaf49a8f5032864a2602c1c61b68ceb1b773 08:41:05 INFO - mozversion application_display_name: Nightly 08:41:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:41:05 INFO - mozversion application_name: Firefox 08:41:05 INFO - mozversion application_remotingname: firefox 08:41:05 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:41:05 INFO - mozversion application_vendor: Mozilla 08:41:05 INFO - mozversion application_version: 55.0a1 08:41:05 INFO - mozversion platform_buildid: 20170524150905 08:41:05 INFO - mozversion platform_changeset: e84acaf49a8f5032864a2602c1c61b68ceb1b773 08:41:05 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:41:05 INFO - mozversion platform_version: 55.0a1 08:41:05 INFO - using testdate: 1495640465 08:41:05 INFO - actual date: 1495640465 08:41:05 INFO - starting webserver on 'localhost:46681' 08:41:05 INFO - SUITE-START | Running 2 tests 08:41:05 INFO - TEST-START | dromaeo_css 08:41:05 INFO - operating with platform_type : linux_ 08:41:05 INFO - Initialising browser for dromaeo_css test... 08:41:05 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46681/getInfo.html -profile /tmp/tmpV3rAv3/profile 08:41:05 INFO - TEST-INFO | started process 17846 (/builds/slave/test/build/application/firefox/firefox http://localhost:46681/getInfo.html) 08:41:40 INFO - TEST-INFO | 17846: killed by SIGTERM 08:41:40 INFO - Browser initialized. 08:41:40 INFO - Running cycle 1/1 for dromaeo_css test... 08:41:40 INFO - TEST-INFO | started process 18044 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV3rAv3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:41:52 INFO - PID 18044 | RSS: Main: 172498944 08:41:52 INFO - PID 18044 | 08:44:56 INFO - PID 18044 | Cycle 1(1): loaded http://localhost:46681/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46681/tests/dromaeo/cssquery-ext.html) 08:44:58 INFO - PID 18044 | RSS: Main: 169799680 08:44:58 INFO - PID 18044 | 08:48:00 INFO - PID 18044 | Cycle 1(1): loaded http://localhost:46681/tests/dromaeo/cssquery-ext.html (next: http://localhost:46681/tests/dromaeo/cssquery-jquery.html) 08:48:00 INFO - PID 18044 | RSS: Main: 176037888 08:48:00 INFO - PID 18044 | 08:51:02 INFO - PID 18044 | Cycle 1(1): loaded http://localhost:46681/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46681/tests/dromaeo/cssquery-mootools.html) 08:51:03 INFO - PID 18044 | RSS: Main: 174415872 08:51:03 INFO - PID 18044 | 08:54:04 INFO - PID 18044 | Cycle 1(1): loaded http://localhost:46681/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46681/tests/dromaeo/cssquery-prototype.html) 08:54:05 INFO - PID 18044 | RSS: Main: 178446336 08:54:05 INFO - PID 18044 | 08:57:08 INFO - PID 18044 | Cycle 1(1): loaded http://localhost:46681/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46681/tests/dromaeo/cssquery-yui.html) 08:57:08 INFO - PID 18044 | RSS: Main: 176668672 08:57:08 INFO - PID 18044 | 09:00:10 INFO - PID 18044 | Cycle 1(1): loaded http://localhost:46681/tests/dromaeo/cssquery-yui.html (next: http://localhost:46681/tests/dromaeo/cssquery-dojo.html) 09:00:10 INFO - PID 18044 | RSS: Main: 173621248 09:00:10 INFO - PID 18044 | 09:00:10 INFO - PID 18044 | __start_tp_report 09:00:10 INFO - PID 18044 | _x_x_mozilla_page_load 09:00:10 INFO - PID 18044 | _x_x_mozilla_page_load_details 09:00:10 INFO - PID 18044 | |i|pagename|runs| 09:00:10 INFO - PID 18044 | |0;dojo.html;2696.7168447313034;2706.8240564363305;2719.9456010879785;2744.5608702607574;2745.1901689001747;5095.312132862063;5223.582113430926;5242.135047717127;5250.789968401259;5288.788448462057;5190.610704197182;5211.218317252414;5271.551918086967;5291.206319052135;5316.175992721134;4663.300504924272;4693.6949098308505;4711.222648263032;4714.269288260308;4756.072565849643;4680.321353403754;4696.882577935562;4774.140654682155;4778.187708089616;4813.759312034402;4567.36056952027;4602.493725690171;4701;4711.0342379812055;4767.308740232682;4671.556202160789;4678.672492925497;4725.598324142452;4730.455997560256;4739.336492890963;4632.652551058684;4674.088552732219;4678.0410015946645;4699.177643912336;4704.1062198182235;5180.145276029489;5261.237120617528;5262.500062494057;5267.28891599633;5301.6818990860675;5498.230247765316;5551.028570000274;5572.7770889164385;5648.3222013358245;5747.885042299173;5730.484256416901;5771.740271687784;5776.075827867521;5819.67991760453;5838.532917366643;5294.311739473844;5304.522592966651;5308.071087559739;5308.708021058879;5346.759395827197;5687.829365119053;5725.1698503716725;5843.620164689281;5850.473457388855;5862.384449632812;5479.698616576126;5521.171824226318;5539.169124631257;5552.167174923713;5578.972105139448;5590.189422533791;5601.831945041656;5614.045612245846;5629.296337957755;5642.520385767174;5491.835244942658;5499.890002200013;5615.101583746581;5621.634593751393;5625.578081643811;5563;5579.525740312038;5593.74828132735;5617.943820561742;5671.602987790898;4795.352627395327;4799.568038876518;4804.567588917014;4804.903901921942;4838.830640927551;4091.590840915944;4092.2838503262406;4092.590740925943;4129.648979836687;4155.439015732837;4637.930431043537;4698.55363740451;4721.055788842245;4745.691530050535;4755.096531658974;5669.688167150764;5690.800821971211;5701.515371193412;5708.343540492813;5713.171590119409;4682.81268749253;4706.717596944194;4707.199776038082;4711.458182309078;4740.857774266778;4896.975515122473;5013.849584512471;5031.572316353077;5044.848654540369;5068.062408454448;5141.048905952411;5147.3308469898675;5163.8192663256605;5173.379194496534;5210.1142805723875;5536.390996990408;5606.915896261477;5733.369329373682;5738.540916726735;5743.6840973745175;5155.252488389237;5191.532762051434;5222.634415590872;5237.188235823453;5240.580753539632;5448.318960129984;5498.45015498463;5535.142052981794;5577.637453565505;5579.442055794388;5565.053940829987;5682.318121825408;5691.7438715257085;5691.914621280767;5734.799282025109;5448.155535891943;5448.237246785374;5486.506214440719;5548.611597188158;5564.944350556604;5520.806771762969;5536.944630553643;5537.446255374431;5537.7784888604;5540.722963851872;5433.402325744244;5447.972760136174;5470.124780035335;5472.261244731911;5518.255035570307;5427.891442171213;5510.228568000563;5512.4211957743855;5534.4742249486235;5624.550035997192;5389.326334208224;5415.729213539386;5425.43032981547;5426.430224826494;5467.45325467466 09:00:10 INFO - PID 18044 | |1;ext.html;601.5458328961633;663.5653646861306;665.810244080437;1158.9304641721492;1174.741556857491;33460.33079338418;34366.14084647885;35271;35342.2931541369;35497.290054198966;35573;35776.10559736008;35964.64035359652;35982;36077.278454430896;6627.370399812022;6783.660816959157;6796.0485532025305;6806.727730890759;6836.213835408942;6703.564268322568;6802.38778509934;6823.420009299216;6832.180138383376;6835.897461538081;6765;6871.175458944934;6877;6881.69032393541;6881.862362752742;6797.592144471348;6820.113385259884;6821.113255276832;6826.726930922757;6875.07186529817;6672.733090676367;6753.898691519631;6756.729730810762;6761.425278851303;6780.321967803229;32399.352012959844;32413.189670258198;32505.51241731376;32593.185170370693;32696.182595435068;3022.2897619059504;3039.8176109433507;3046.695330466958;3056.3428862794385;3062.7856050076502;24822.5035499289;24849.751502484924;24952;24962.50074998508;24996.875015624988;2852.7432531072304;2854.314964408527;2862.842543660098;2865.5701644753244;2877.5539791332376;139390;140450.29774851163;140814;146353;152997.47002529944;38899.053217760076;39384;39425.60574394219;39503.80248098741;39567;40478.595214047484;40781.38827917584;40810.18379632391;40941.79529102395;44035;12595.685107872376;12779.488820447077;12779.936100319625;12826.102172847812;12854.614361569167;10194.184465242763;10204.795904082026;10214.489275536194;10215.336003159771;10217.489125543692;12708.428120734588;12827.358632068359;12844.871551284368;12878.227306361649;12914.870851291555;5312.92030619541;5434.646747961449;5440.3743569489225;5461.044317244467;5470.507654311131;829.6805729794073;891.22463456793;919.3886065766325;927.9768005799774;928.3176865004217;20527.178912843618;21283.36149915505;21448.785512144677;21750.34748957534;22002.44993875134;988.7182153086336;990.9256805739599;1011.8381059030667;1021.7752094539189;1025.108155904368;11059.889401105886;11077.889221107685;11267.267627604344;11338.09295256394;11416.31502109876;172071.13964430348;172965;173734;173971;174667;41072.1785564293;41218;41261.174776504304;41345.58654413478;41421.1715765689;1185.5139392849062;1243.8059462915703;1248.9750204995848;1249.331607589935;1267.7527882063093;20017.699734504284;20131.39605811828;21016.159353625684;21168.835714035875;21255;29335.266618334714;36647;36780.81609591935;36898.631013690596;37070.62929370672;166098;166801;167431;167499;168020.15989919973;29928.70071299259;29991.550126748552;30006;30061.248468788453;30336.39327213399;35127.82436087803;35726.28547429089;35948.4607730879;35968;36045.63954360423;26677;27247.318817029733;27532.17403477899;27783.30541736473;27987.58018629763;26796.464070718866;27479.725202748516;27684.723152768216;28131.57802632921;28736.425271494034;31071.53392699066;31341.373172535965;31369.05892823219;31386.372272554876;31426.371472570878;25770;26204.344891377867;26993.65031748444;27218.455630886874;27410.45179096367;21500.67748983735;22136.66794998044;22304.77695223092;22340.88829555842;22527.66208506841 09:00:10 INFO - PID 18044 | |2;jquery.html;408.5893676854761;418.36617524450446;427.6493275514078;432.753330601557;439.75813302683525;14548.418063277482;14863.925680371583;17361.82638173618;18111.36610218641;18113.456596302116;18439.631207375845;18513.35203267886;18550.165242564082;18656.440306790817;18780.248790048383;5326.786928522864;5351.785928562853;5521.834344969658;5568.916466253009;5575.888482230353;5334.866628334304;5504.366997795245;5513.58648101392;5514.145307477347;5533.170024496318;5202;5385.246065550826;5416.702081385522;5445.754941027663;5478.233047373351;5248.947510524884;5309.734513274321;5317;5348.625596208267;5358.490943360394;4841.595937178214;4871.780769865364;4877.000214955926;4885.120678277908;4891.364122664067;22110.668339974913;22146.335609931728;22420.66369004466;22933.54132917349;23101.884490577606;1596.233807772276;1603.2384617306802;1641.8193998660138;1644.399794075154;1649.5628658405533;14678.92660536701;14771.55685329431;14990.700185996327;15059.096454212782;15080.396784128621;2063.10255039057;2073.429806803141;2079.8336133109465;2103.2428325802853;2107.2940564910773;77546.61226693887;89884.55057724736;89960.10039899583;93157.53421232851;93308.53345733296;11051.2816666918;11130.777384452265;11181.888181118085;11233.775324493465;11426.94286528562;15636;15646.374145034299;15647.765283520755;15682.215889205494;15748.133852638215;7740.445652934518;7765.805854853561;7917.366610671133;7932.246436588515;8086.676532938734;7173.354398104196;7233.638318084075;7449.478536502393;7469.439792015621;7476.5514069156025;6879;6966.5471744336455;6986.44108471321;6987;7024.719011239596;2048.805363490466;2082.8229600483824;2120.660694288906;2134.8612340197838;2155.3964889830872;827.6317038917624;855.4781583234222;871.8212766382876;890.955452227386;898.4250079948838;16910.239039243264;16977.575560611083;17088.572785680208;17582.472525824247;17788.733169002215;868.774118729135;874.8031692869054;878.767126711422;882.3602887906217;898.1333013641867;9258.768530786785;9382.155605995493;9581.520923953914;9690.70927872165;9711.805763884682;362259;369345;375316;381738;382306;71856.28143718495;72572.27427725655;74279;74850.88916552918;77058.6147069261;1026.609888242478;1030.0883717909703;1036.8133735927606;1052.6998508259478;1055.9736006599896;14460.27698615086;14665.413383464542;14704.117752934859;14736.115833050051;15147.848521514643;37255.44116838304;37517.43723844199;37950.43074353942;38573.42139867848;39875.2024959505;47951.5204847947;48485.75757121192;49729.75135124301;49769;50542.74728626334;8304.87542686848;8372.832543349221;8453.66185352579;8470.941132358455;8536.615852286537;12764.42560084817;12942.611721648365;13053.34733263352;13097.607071787861;13103.2138071716;10900.236983411085;11122.833157502806;11146.442677866236;11301.378424186749;11638.301701897914;10487.737806554896;10629.89370106289;10714.517846697074;10723.517441714985;10932.234743567873;11066.612668556561;11122.221444499131;11212;11321.320720756781;11373.31760094397;8316.6673333066;8428.789280268042;8503.787405314917;8569.871451928102;8584.527850968258;10929.453527323443;11019.504122314354;11087.944560277147;11157.944210278896;11496.252743571642 09:00:10 INFO - PID 18044 | |3;mootools.html;1269.086257894316;1312.1208790110625;1314.8356455443075;1320.8811206991368;1329.0364485747832;10371.48142592871;10477.738056548571;10832.133429325655;10859.239853210278;10865.945670271638;10494.790104197911;10704.73238169046;10707.036366726992;10709;10718.571257149724;2242.9663555046686;2260.9321720348416;2273.5680220758004;2274.8293877959136;2275.340151356105;2042.5200077981738;2077.657186564215;2089.2478707665227;2090.289301637443;2105.221068204766;2109;2125.8511904166717;2128.957420851582;2135.1886283212434;2144.067330711138;2055.321743824534;2070.140891530013;2072.6476498995207;2077.802608752166;2081.833453323738;1983.077868791019;1991.930282440122;2037.2054898589563;2043.5810658814908;2184.2464349799293;10641.095506881924;10728.839067413996;10728.839067413996;10732.087772539344;10777.407242601654;5651.463111004448;5871.9412805871825;5873;5882.970585147047;5883.411658834125;3189.122991177445;3312.950305745416;3404.6595340466;3405.6934875861293;3408.727301815849;1019.2406657040478;1030.9175365865885;1065.9893401065967;1117.742919128605;1145.7021174494607;15516.844831551765;15613.609659758484;15615.921920390325;15694.136822474758;15706.293216805272;4623.514530974199;4708.882277943078;4786.2581299898575;4915.11527924977;4963.776630051656;11210.439478026066;11217.3830439325;11261.887381126084;11273.71815704614;11291.830622540669;5493.121100623881;5649.180868774005;5669.376368599451;5683.175939488751;5702.8289151325525;5018.096742586296;5166.715830629276;5215.869603259873;5235.895282094337;5244.082285600005;3818.3317919364554;3938;3944.60553944609;3967.504061992251;3969.980150099231;1124.8087825069758;1140.0708422635525;1152.5101831721486;1153.5904753812445;1158.3281696615943;692.97228110875;704.2359040441179;707.9327463890922;722.2344315025985;733.4242619543633;5684.261046063985;5775.5090817281;5802.332731735904;5868.325142608569;5889.1755154278435;553.1232995701778;576.2278546747378;576.4581293584017;576.8990426675315;580.7357652268208;3355.865765369358;3402.1324562236964;3472.5832900052155;3926.6466018058513;4005.5193376794973;13814.723705526034;13977.091489053179;14277.14337139775;14323.85676143246;14478.565643030726;13542.729145417234;13974.58076257714;14151.363188656534;14167.78748318776;14174.14955102697;7752.341051010727;7950.1254861965135;7974.285528611376;8022.157673444204;8039.236272554098;6474.320196379501;6520.478361731145;6660.600363978177;6682.83292917681;6734.4612431004425;12737.426815793126;12850.678733031375;12853.807192891927;12877;12886.48454061827;13054.869451305365;13060.151090179108;13118.909451981628;13241.470341186245;13275.867241327463;8751.343649226206;8862.64549418016;8917.598708058023;8928.642854285756;8938.68714594986;10000.749981250527;10188.898111018794;10189.490525473548;10202.897971020195;10205.540750666387;8271.751847444586;8417.87373189415;8470.957645211982;8644.308455323684;8707.608157632794;8449.957750211455;8514.020887598006;8626.5255410953;8678.869816952878;8689;7281.1262648482525;7319.597422141834;7329.083864516935;7365.668544915385;7369.226231245856;5575.135853942646;5622.465865742748;5650.63270887391;5676.801311954062;5851.268591426072;5588.357338905916;5645.435456454486;5708.942910571007;5716.5426765859465;5819.63238638911 09:00:10 INFO - PID 18044 | |4;prototype.html;358.6055339126959;364.80482941626235;369.04233514031097;393.7401315132013;396.55981860135256;5406.621536492442;5430.511253987141;5454.372747134081;5465.289512363397;5469.972650136749;5312.760925758341;5350.946490535093;5354.303940487741;5367.704776237305;5380.757865896035;3840.519935008124;4039.7172197946156;4041.333180025292;4195.412642230091;4214.515330736958;4063.167050754588;4072.409500622408;4073.816678249471;4076.7961601919933;4103.8563650272245;4014.237294913957;4014.4179094031347;4020;4038.8788336349808;4041.838326466938;4050.0077481017047;4052.1490486997764;4060.9999999999854;4065.9593404065877;4126.1128857295525;3863.0728625130046;3876.9612303876884;3882.2429626222897;3889.0137608950768;3900.278448487011;5212.400573934008;5220.451852555465;5237.869053273698;5241.3710354757295;5260.10636170982;4822.68652537584;4986.5013498650205;4997.275395067695;5010.123228435009;5032.370953630796;5607.102863541854;5700.429957004267;5731.598788084836;5741.33974592923;5743.798967036176;4322.438083049215;4325.805338759732;4333.371661109153;4340.197063543254;4355.716878402925;5474.42518535552;5908.527317814607;5919.602560962817;6014.96992515039;6123.326434092246;4232.386303985905;4232.513260974965;4247.532771395144;4249.213895429355;4271.765052922057;4340.76125813077;4353.82584696615;4367.62875155609;4377.474703035656;4386.495553011381;4728.078024785203;4793.808247670054;4828.61371090312;4845.1520983828395;4854.635902307341;5695.914561281584;5697.51864515229;5706.771729130788;5710.628809127394;5741.3971532988435;1552.028923267444;1589.6025993501626;1589.6025993501626;1594.115266027366;1599.3842370687369;1081.3674000709516;1143.3654321851452;1156.4160099149876;1158.2818652435544;1159.5825502818977;4839.540243676845;4859.684120532154;4874.707517548887;4876.244182151772;4896.68171568854;5829.329627092939;5840.795572155039;5894.823155305347;5914.763409463573;5933.465988061095;4589.518100599389;4814.903701925942;4842.612590992782;4843.346148270009;4854.563089321978;3094.3965926644087;3112.8754849805755;3113.1438854314792;3113.688631136868;3116.8597413116463;5268.894622107537;5334.359876814807;5345.701348420217;5382.219578161144;5399.811006614749;5744.511716504144;5965.105234214816;5971.9701401493585;5979.910301345483;6005.159277701126;5325.334333208349;5341.973290133525;5361.222622719606;5361.973190134025;5401.432849550819;5849.590528662953;5866.530677545871;5871.035127260706;5886.499647530008;5886.558508111994;5663.32040155184;5785.537157027512;5789.826305210682;5804;5828.300603927556;5363.356397232357;5366;5380.623356365017;5381.48875856793;5384.21928820311;3953.565107838193;4044.5550989390554;4058.504020027721;4062.431259623596;4073.6130067643526;5855.502282305882;5894.882102357843;5926.444133520026;5930.406959304208;5946.316173640087;5684.886302274014;5688.943110568841;5706;5709.172170035405;5770.13447982806;5581.906784955641;5583.827396246671;5601.60788744784;5642.153676948326;5675.814811297598;5612.85967850807;5619.550435965195;5635.182898479779;5636.957162924872;5649.655393011854;5572.136318870582;5720.914186287292;5723.6851973141875;5737.483626473638;5745.6552606843725;5517.951589198039;5538.91691624634;5541.806036788693;5559.832435188656;5566.610337276352 09:00:10 INFO - PID 18044 | |5;yui.html;680.1939701453778;689.8447849233921;693.5318659904566;706.5937086175447;708.8794904866172;13706.588802335946;13725.656858578528;14173.858261417396;14198.14811111334;14441.350139243734;16813.327466901308;17063.40278090267;17066.743998839996;17072.743908841378;17081.40215092472;635.7488791927186;890.4345740454809;907.6732376344544;911.2664305234284;912.5710915869531;658.4962503684685;888.7866911941152;906.0214967834722;914.5884352041575;915.1534830281996;961.2262128986198;964.5900492290783;966.5602151021268;973.2457345557215;976.1702552830109;957.8036502517002;958.0515289863055;960.3133759362055;961.0293603460485;961.6057416459219;701.1936273285711;702.9086218791575;703.1632357494565;706.4101475268158;710.4139085254685;15221.847781522265;15426.614334641723;15534.300956456873;15575.610609734847;15645.061296322257;16536.917315413466;16937.153142342835;17033;17071.23179456915;17078.31686732529;12822.80765788514;13118;13172.736545269137;13190;13223.933880330536;2971.9405611887855;3005.9549106763197;3029.2881172924344;3029.5758593796886;3034.317278612317;78565.60717196435;78760.60619696864;79205.60397198035;79743.60128199322;79872;12295;12586.24482531051;12699.174553653984;12708.491660333668;12713;21416.357509274745;22334.441638959157;23307.18424855122;23397.88301058484;23447.531049379257;6044.667543285162;6120.7551697931585;6151.477124444473;6184.81445556625;6192.164057852222;2656.481986012709;2725.863706814691;2739.6849362323187;2842.6304580404417;2876.266552029219;3415.9658403416147;3479.4780782882262;3490.511328414024;3500.1249687578106;3501.439769636846;731.4002517935348;749.9887501687479;761.1817296406385;761.885717142422;762.7597306848324;566.623195574938;580.1761498671896;591.4558606082414;601.6330038676404;611.1413464082971;9863.605455781688;10392.272540922062;11583.76832463363;11829.053675705924;12442.937785311016;615.5260449453896;615.9106929495288;618.2426527503771;621.8942779727457;641.2945759664332;4618.330342100377;4889.413270407574;4925.75371231437;5042.873928151826;5105.004524117836;75027.62486187644;76833;77749;79229;90799.54600227089;66541.66729166324;68159;68465;69751.65124174448;69834.65082674655;58806.70596647075;60708;61402;61639.6918015416;61645.69177154175;10237.641682541076;10300.536475858455;10519.316244444086;10545.103666188154;11056.557737690402;28049.57925631158;28198.43603127885;28263.71736282693;29358.41283174282;29491.85254073716;35624.64375356213;35778;35826.462603061496;36124.27751445009;36340.27319453543;13039.674008149872;13118.081734278509;13433.529826456028;13502.459901603826;13523.661908451973;15020.09879407239;15077;15153.696926061637;15180.696386072437;15239.238038098272;14041.5085472008;14056.297185140907;14105.647358816112;14200.431982720576;14328.570142895729;13789.448422063006;13929.860701393261;13933.094348867291;13969.371378288204;14249.216293103564;13555.525556605471;13810.585682429542;13877.236751978335;13969.511067112602;13981.510647127301;8820.29437644974;9082.318826087938;9336.579853906725;9349.252059835333;9674.564644591152;10499.370037797757;10510.211734120125;10815.945920270347;10881.401522916;11163.776724465302 09:00:10 INFO - PID 18044 | __end_tp_report 09:00:10 INFO - PID 18044 | __start_cc_report 09:00:10 INFO - PID 18044 | _x_x_mozilla_cycle_collect,352 09:00:10 INFO - PID 18044 | __end_cc_report 09:00:10 INFO - PID 18044 | __startTimestamp1495641610754__endTimestamp 09:00:10 INFO - PID 18044 | 09:00:10 INFO - PID 18044 | ------- Summary: start ------- 09:00:10 INFO - PID 18044 | Number of tests: 6 09:00:10 INFO - PID 18044 | 09:00:10 INFO - PID 18044 | [#0] dojo.html Cycles:165 Average:5167.83 Median:5308.71 stddev:603.84 (11.4%) stddev-sans-first:573.74 09:00:10 INFO - PID 18044 | Values: 2696.7 2706.8 2719.9 2744.6 2745.2 5095.3 5223.6 5242.1 5250.8 5288.8 5190.6 5211.2 5271.6 5291.2 5316.2 4663.3 4693.7 4711.2 4714.3 4756.1 4680.3 4696.9 4774.1 4778.2 4813.8 4567.4 4602.5 4701.0 4711.0 4767.3 4671.6 4678.7 4725.6 4730.5 4739.3 4632.7 4674.1 4678.0 4699.2 4704.1 5180.1 5261.2 5262.5 5267.3 5301.7 5498.2 5551.0 5572.8 5648.3 5747.9 5730.5 5771.7 5776.1 5819.7 5838.5 5294.3 5304.5 5308.1 5308.7 5346.8 5687.8 5725.2 5843.6 5850.5 5862.4 5479.7 5521.2 5539.2 5552.2 5579.0 5590.2 5601.8 5614.0 5629.3 5642.5 5491.8 5499.9 5615.1 5621.6 5625.6 5563.0 5579.5 5593.7 5617.9 5671.6 4795.4 4799.6 4804.6 4804.9 4838.8 4091.6 4092.3 4092.6 4129.6 4155.4 4637.9 4698.6 4721.1 4745.7 4755.1 5669.7 5690.8 5701.5 5708.3 5713.2 4682.8 4706.7 4707.2 4711.5 4740.9 4897.0 5013.8 5031.6 5044.8 5068.1 5141.0 5147.3 5163.8 5173.4 5210.1 5536.4 5606.9 5733.4 5738.5 5743.7 5155.3 5191.5 5222.6 5237.2 5240.6 5448.3 5498.5 5535.1 5577.6 5579.4 5565.1 5682.3 5691.7 5691.9 5734.8 5448.2 5448.2 5486.5 5548.6 5564.9 5520.8 5536.9 5537.4 5537.8 5540.7 5433.4 5448.0 5470.1 5472.3 5518.3 5427.9 5510.2 5512.4 5534.5 5624.6 5389.3 5415.7 5425.4 5426.4 5467.5 09:00:10 INFO - PID 18044 | 09:00:10 INFO - PID 18044 | [#1] ext.html Cycles:180 Average:30829.45 Median:16679.34 stddev:41821.07 (250.7%) stddev-sans-first:41876.79 09:00:10 INFO - PID 18044 | Values: 601.5 663.6 665.8 1158.9 1174.7 33460.3 34366.1 35271.0 35342.3 35497.3 35573.0 35776.1 35964.6 35982.0 36077.3 6627.4 6783.7 6796.0 6806.7 6836.2 6703.6 6802.4 6823.4 6832.2 6835.9 6765.0 6871.2 6877.0 6881.7 6881.9 6797.6 6820.1 6821.1 6826.7 6875.1 6672.7 6753.9 6756.7 6761.4 6780.3 32399.4 32413.2 32505.5 32593.2 32696.2 3022.3 3039.8 3046.7 3056.3 3062.8 24822.5 24849.8 24952.0 24962.5 24996.9 2852.7 2854.3 2862.8 2865.6 2877.6 139390.0 140450.3 140814.0 146353.0 152997.5 38899.1 39384.0 39425.6 39503.8 39567.0 40478.6 40781.4 40810.2 40941.8 44035.0 12595.7 12779.5 12779.9 12826.1 12854.6 10194.2 10204.8 10214.5 10215.3 10217.5 12708.4 12827.4 12844.9 12878.2 12914.9 5312.9 5434.6 5440.4 5461.0 5470.5 829.7 891.2 919.4 928.0 928.3 20527.2 21283.4 21448.8 21750.3 22002.4 988.7 990.9 1011.8 1021.8 1025.1 11059.9 11077.9 11267.3 11338.1 11416.3 172071.1 172965.0 173734.0 173971.0 174667.0 41072.2 41218.0 41261.2 41345.6 41421.2 1185.5 1243.8 1249.0 1249.3 1267.8 20017.7 20131.4 21016.2 21168.8 21255.0 29335.3 36647.0 36780.8 36898.6 37070.6 166098.0 166801.0 167431.0 167499.0 168020.2 29928.7 29991.6 30006.0 30061.2 30336.4 35127.8 35726.3 35948.5 35968.0 36045.6 26677.0 27247.3 27532.2 27783.3 27987.6 26796.5 27479.7 27684.7 28131.6 28736.4 31071.5 31341.4 31369.1 31386.4 31426.4 25770.0 26204.3 26993.7 27218.5 27410.5 21500.7 22136.7 22304.8 22340.9 22527.7 09:00:10 INFO - PID 18044 | 09:00:10 INFO - PID 18044 | [#2] jquery.html Cycles:180 Average:24934.30 Median:209844.22 stddev:62189.18 (29.6%) stddev-sans-first:62336.37 09:00:10 INFO - PID 18044 | Values: 408.6 418.4 427.6 432.8 439.8 14548.4 14863.9 17361.8 18111.4 18113.5 18439.6 18513.4 18550.2 18656.4 18780.2 5326.8 5351.8 5521.8 5568.9 5575.9 5334.9 5504.4 5513.6 5514.1 5533.2 5202.0 5385.2 5416.7 5445.8 5478.2 5248.9 5309.7 5317.0 5348.6 5358.5 4841.6 4871.8 4877.0 4885.1 4891.4 22110.7 22146.3 22420.7 22933.5 23101.9 1596.2 1603.2 1641.8 1644.4 1649.6 14678.9 14771.6 14990.7 15059.1 15080.4 2063.1 2073.4 2079.8 2103.2 2107.3 77546.6 89884.6 89960.1 93157.5 93308.5 11051.3 11130.8 11181.9 11233.8 11426.9 15636.0 15646.4 15647.8 15682.2 15748.1 7740.4 7765.8 7917.4 7932.2 8086.7 7173.4 7233.6 7449.5 7469.4 7476.6 6879.0 6966.5 6986.4 6987.0 7024.7 2048.8 2082.8 2120.7 2134.9 2155.4 827.6 855.5 871.8 891.0 898.4 16910.2 16977.6 17088.6 17582.5 17788.7 868.8 874.8 878.8 882.4 898.1 9258.8 9382.2 9581.5 9690.7 9711.8 362259.0 369345.0 375316.0 381738.0 382306.0 71856.3 72572.3 74279.0 74850.9 77058.6 1026.6 1030.1 1036.8 1052.7 1056.0 14460.3 14665.4 14704.1 14736.1 15147.8 37255.4 37517.4 37950.4 38573.4 39875.2 47951.5 48485.8 49729.8 49769.0 50542.7 8304.9 8372.8 8453.7 8470.9 8536.6 12764.4 12942.6 13053.3 13097.6 13103.2 10900.2 11122.8 11146.4 11301.4 11638.3 10487.7 10629.9 10714.5 10723.5 10932.2 11066.6 11122.2 11212.0 11321.3 11373.3 8316.7 8428.8 8503.8 8569.9 8584.5 10929.5 11019.5 11087.9 11157.9 11496.3 09:00:10 INFO - PID 18044 | 09:00:10 INFO - PID 18044 | [#3] mootools.html Cycles:180 Average:6557.84 Median:3251.04 stddev:4328.73 (133.1%) stddev-sans-first:4322.63 09:00:10 INFO - PID 18044 | Values: 1269.1 1312.1 1314.8 1320.9 1329.0 10371.5 10477.7 10832.1 10859.2 10865.9 10494.8 10704.7 10707.0 10709.0 10718.6 2243.0 2260.9 2273.6 2274.8 2275.3 2042.5 2077.7 2089.2 2090.3 2105.2 2109.0 2125.9 2129.0 2135.2 2144.1 2055.3 2070.1 2072.6 2077.8 2081.8 1983.1 1991.9 2037.2 2043.6 2184.2 10641.1 10728.8 10728.8 10732.1 10777.4 5651.5 5871.9 5873.0 5883.0 5883.4 3189.1 3313.0 3404.7 3405.7 3408.7 1019.2 1030.9 1066.0 1117.7 1145.7 15516.8 15613.6 15615.9 15694.1 15706.3 4623.5 4708.9 4786.3 4915.1 4963.8 11210.4 11217.4 11261.9 11273.7 11291.8 5493.1 5649.2 5669.4 5683.2 5702.8 5018.1 5166.7 5215.9 5235.9 5244.1 3818.3 3938.0 3944.6 3967.5 3970.0 1124.8 1140.1 1152.5 1153.6 1158.3 693.0 704.2 707.9 722.2 733.4 5684.3 5775.5 5802.3 5868.3 5889.2 553.1 576.2 576.5 576.9 580.7 3355.9 3402.1 3472.6 3926.6 4005.5 13814.7 13977.1 14277.1 14323.9 14478.6 13542.7 13974.6 14151.4 14167.8 14174.1 7752.3 7950.1 7974.3 8022.2 8039.2 6474.3 6520.5 6660.6 6682.8 6734.5 12737.4 12850.7 12853.8 12877.0 12886.5 13054.9 13060.2 13118.9 13241.5 13275.9 8751.3 8862.6 8917.6 8928.6 8938.7 10000.7 10188.9 10189.5 10202.9 10205.5 8271.8 8417.9 8471.0 8644.3 8707.6 8450.0 8514.0 8626.5 8678.9 8689.0 7281.1 7319.6 7329.1 7365.7 7369.2 5575.1 5622.5 5650.6 5676.8 5851.3 5588.4 5645.4 5708.9 5716.5 5819.6 09:00:10 INFO - PID 18044 | 09:00:10 INFO - PID 18044 | [#4] prototype.html Cycles:180 Average:4715.36 Median:5290.83 stddev:1341.24 (25.4%) stddev-sans-first:1304.53 09:00:10 INFO - PID 18044 | Values: 358.6 364.8 369.0 393.7 396.6 5406.6 5430.5 5454.4 5465.3 5470.0 5312.8 5350.9 5354.3 5367.7 5380.8 3840.5 4039.7 4041.3 4195.4 4214.5 4063.2 4072.4 4073.8 4076.8 4103.9 4014.2 4014.4 4020.0 4038.9 4041.8 4050.0 4052.1 4061.0 4066.0 4126.1 3863.1 3877.0 3882.2 3889.0 3900.3 5212.4 5220.5 5237.9 5241.4 5260.1 4822.7 4986.5 4997.3 5010.1 5032.4 5607.1 5700.4 5731.6 5741.3 5743.8 4322.4 4325.8 4333.4 4340.2 4355.7 5474.4 5908.5 5919.6 6015.0 6123.3 4232.4 4232.5 4247.5 4249.2 4271.8 4340.8 4353.8 4367.6 4377.5 4386.5 4728.1 4793.8 4828.6 4845.2 4854.6 5695.9 5697.5 5706.8 5710.6 5741.4 1552.0 1589.6 1589.6 1594.1 1599.4 1081.4 1143.4 1156.4 1158.3 1159.6 4839.5 4859.7 4874.7 4876.2 4896.7 5829.3 5840.8 5894.8 5914.8 5933.5 4589.5 4814.9 4842.6 4843.3 4854.6 3094.4 3112.9 3113.1 3113.7 3116.9 5268.9 5334.4 5345.7 5382.2 5399.8 5744.5 5965.1 5972.0 5979.9 6005.2 5325.3 5342.0 5361.2 5362.0 5401.4 5849.6 5866.5 5871.0 5886.5 5886.6 5663.3 5785.5 5789.8 5804.0 5828.3 5363.4 5366.0 5380.6 5381.5 5384.2 3953.6 4044.6 4058.5 4062.4 4073.6 5855.5 5894.9 5926.4 5930.4 5946.3 5684.9 5688.9 5706.0 5709.2 5770.1 5581.9 5583.8 5601.6 5642.2 5675.8 5612.9 5619.6 5635.2 5637.0 5649.7 5572.1 5720.9 5723.7 5737.5 5745.7 5518.0 5538.9 5541.8 5559.8 5566.6 09:00:10 INFO - PID 18044 | 09:00:10 INFO - PID 18044 | [#5] yui.html Cycles:180 Average:16795.62 Median:3484.99 stddev:21437.74 (615.1%) stddev-sans-first:21463.72 09:00:10 INFO - PID 18044 | Values: 680.2 689.8 693.5 706.6 708.9 13706.6 13725.7 14173.9 14198.1 14441.4 16813.3 17063.4 17066.7 17072.7 17081.4 635.7 890.4 907.7 911.3 912.6 658.5 888.8 906.0 914.6 915.2 961.2 964.6 966.6 973.2 976.2 957.8 958.1 960.3 961.0 961.6 701.2 702.9 703.2 706.4 710.4 15221.8 15426.6 15534.3 15575.6 15645.1 16536.9 16937.2 17033.0 17071.2 17078.3 12822.8 13118.0 13172.7 13190.0 13223.9 2971.9 3006.0 3029.3 3029.6 3034.3 78565.6 78760.6 79205.6 79743.6 79872.0 12295.0 12586.2 12699.2 12708.5 12713.0 21416.4 22334.4 23307.2 23397.9 23447.5 6044.7 6120.8 6151.5 6184.8 6192.2 2656.5 2725.9 2739.7 2842.6 2876.3 3416.0 3479.5 3490.5 3500.1 3501.4 731.4 750.0 761.2 761.9 762.8 566.6 580.2 591.5 601.6 611.1 9863.6 10392.3 11583.8 11829.1 12442.9 615.5 615.9 618.2 621.9 641.3 4618.3 4889.4 4925.8 5042.9 5105.0 75027.6 76833.0 77749.0 79229.0 90799.5 66541.7 68159.0 68465.0 69751.7 69834.7 58806.7 60708.0 61402.0 61639.7 61645.7 10237.6 10300.5 10519.3 10545.1 11056.6 28049.6 28198.4 28263.7 29358.4 29491.9 35624.6 35778.0 35826.5 36124.3 36340.3 13039.7 13118.1 13433.5 13502.5 13523.7 15020.1 15077.0 15153.7 15180.7 15239.2 14041.5 14056.3 14105.6 14200.4 14328.6 13789.4 13929.9 13933.1 13969.4 14249.2 13555.5 13810.6 13877.2 13969.5 13981.5 8820.3 9082.3 9336.6 9349.3 9674.6 10499.4 10510.2 10815.9 10881.4 11163.8 09:00:10 INFO - PID 18044 | -------- Summary: end -------- 09:00:10 INFO - PID 18044 | 09:00:11 INFO - TEST-INFO | 18044: exit 0 09:00:11 INFO - TEST-OK | dromaeo_css | took 1146158ms 09:00:11 INFO - TEST-START | kraken 09:00:11 INFO - operating with platform_type : linux_ 09:00:11 INFO - Initialising browser for kraken test... 09:00:11 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46681/getInfo.html -profile /tmp/tmpCPTg8t/profile 09:00:11 INFO - TEST-INFO | started process 18449 (/builds/slave/test/build/application/firefox/firefox http://localhost:46681/getInfo.html) 09:00:46 INFO - TEST-INFO | 18449: killed by SIGTERM 09:00:46 INFO - Browser initialized. 09:00:46 INFO - Running cycle 1/1 for kraken test... 09:00:46 INFO - TEST-INFO | started process 18647 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCPTg8t/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:00:58 INFO - PID 18647 | RSS: Main: 172429312 09:00:58 INFO - PID 18647 | 09:01:00 INFO - PID 18647 | Cycle 1(1): loaded http://localhost:46681/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46681/tests/kraken/driver.html?testName=audio-beat-detection) 09:01:01 INFO - PID 18647 | RSS: Main: 178266112 09:01:01 INFO - PID 18647 | 09:01:04 INFO - PID 18647 | Cycle 1(1): loaded http://localhost:46681/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46681/tests/kraken/driver.html?testName=audio-dft) 09:01:05 INFO - PID 18647 | RSS: Main: 177274880 09:01:05 INFO - PID 18647 | 09:01:08 INFO - PID 18647 | Cycle 1(1): loaded http://localhost:46681/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46681/tests/kraken/driver.html?testName=audio-fft) 09:01:08 INFO - PID 18647 | RSS: Main: 174755840 09:01:08 INFO - PID 18647 | 09:01:10 INFO - PID 18647 | Cycle 1(1): loaded http://localhost:46681/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46681/tests/kraken/driver.html?testName=audio-oscillator) 09:01:11 INFO - PID 18647 | RSS: Main: 175157248 09:01:11 INFO - PID 18647 | 09:01:13 INFO - PID 18647 | Cycle 1(1): loaded http://localhost:46681/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46681/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:01:14 INFO - PID 18647 | RSS: Main: 175378432 09:01:14 INFO - PID 18647 | 09:01:17 INFO - PID 18647 | Cycle 1(1): loaded http://localhost:46681/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46681/tests/kraken/driver.html?testName=imaging-darkroom) 09:01:18 INFO - PID 18647 | RSS: Main: 176377856 09:01:18 INFO - PID 18647 | 09:01:21 INFO - PID 18647 | Cycle 1(1): loaded http://localhost:46681/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46681/tests/kraken/driver.html?testName=imaging-desaturate) 09:01:22 INFO - PID 18647 | RSS: Main: 175423488 09:01:22 INFO - PID 18647 | 09:01:25 INFO - PID 18647 | Cycle 1(1): loaded http://localhost:46681/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46681/tests/kraken/driver.html?testName=json-parse-financial) 09:01:25 INFO - PID 18647 | RSS: Main: 175984640 09:01:25 INFO - PID 18647 | 09:01:27 INFO - PID 18647 | Cycle 1(1): loaded http://localhost:46681/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46681/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:01:27 INFO - PID 18647 | RSS: Main: 175968256 09:01:27 INFO - PID 18647 | 09:01:29 INFO - PID 18647 | Cycle 1(1): loaded http://localhost:46681/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46681/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:01:30 INFO - PID 18647 | RSS: Main: 176017408 09:01:30 INFO - PID 18647 | 09:01:32 INFO - PID 18647 | Cycle 1(1): loaded http://localhost:46681/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46681/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:01:33 INFO - PID 18647 | RSS: Main: 176246784 09:01:33 INFO - PID 18647 | 09:01:36 INFO - PID 18647 | Cycle 1(1): loaded http://localhost:46681/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46681/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:01:36 INFO - PID 18647 | RSS: Main: 176508928 09:01:36 INFO - PID 18647 | 09:01:39 INFO - PID 18647 | Cycle 1(1): loaded http://localhost:46681/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46681/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:01:40 INFO - PID 18647 | RSS: Main: 176201728 09:01:40 INFO - PID 18647 | 09:01:42 INFO - PID 18647 | Cycle 1(1): loaded http://localhost:46681/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46681/tests/kraken/driver.html?testName=ai-astar) 09:01:42 INFO - PID 18647 | RSS: Main: 178040832 09:01:42 INFO - PID 18647 | 09:01:42 INFO - PID 18647 | __start_tp_report 09:01:42 INFO - PID 18647 | _x_x_mozilla_page_load 09:01:42 INFO - PID 18647 | _x_x_mozilla_page_load_details 09:01:42 INFO - PID 18647 | |i|pagename|runs| 09:01:42 INFO - PID 18647 | |0;ai-astar;104;111;111;111;111;111;112;111;111;112 09:01:42 INFO - PID 18647 | |1;audio-beat-detection;150;128;124;168;126;123;123;126;148;127 09:01:42 INFO - PID 18647 | |2;audio-dft;164;165;164;165;169;168;169;165;162;162 09:01:42 INFO - PID 18647 | |3;audio-fft;76;74;75;107;74;76;80;79;99;75 09:01:42 INFO - PID 18647 | |4;audio-oscillator;84;84;114;83;83;83;98;84;83;106 09:01:42 INFO - PID 18647 | |5;imaging-gaussian-blur;115;117;113;114;120;113;113;114;115;115 09:01:42 INFO - PID 18647 | |6;imaging-darkroom;152;152;150;152;151;154;151;151;153;150 09:01:42 INFO - PID 18647 | |7;imaging-desaturate;95;95;95;94;94;95;95;97;95;95 09:01:42 INFO - PID 18647 | |8;json-parse-financial;54;54;53;58;55;56;55;56;55;55 09:01:42 INFO - PID 18647 | |9;json-stringify-tinderbox;58;57;58;58;56;57;58;56;57;57 09:01:42 INFO - PID 18647 | |10;stanford-crypto-aes;88;87;87;88;87;86;88;90;138;87 09:01:42 INFO - PID 18647 | |11;stanford-crypto-ccm;135;132;134;140;135;132;139;145;135;146 09:01:42 INFO - PID 18647 | |12;stanford-crypto-pbkdf2;187;197;198;196;193;197;199;194;195;194 09:01:42 INFO - PID 18647 | |13;stanford-crypto-sha256-iterative;75;73;72;73;73;72;73;72;73;77 09:01:42 INFO - PID 18647 | __end_tp_report 09:01:42 INFO - PID 18647 | __start_cc_report 09:01:42 INFO - PID 18647 | _x_x_mozilla_cycle_collect,921 09:01:42 INFO - PID 18647 | __end_cc_report 09:01:42 INFO - PID 18647 | __startTimestamp1495641702594__endTimestamp 09:01:42 INFO - PID 18647 | 09:01:42 INFO - PID 18647 | ------- Summary: start ------- 09:01:42 INFO - PID 18647 | Number of tests: 14 09:01:42 INFO - PID 18647 | 09:01:42 INFO - PID 18647 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:2.32 (2.1%) stddev-sans-first:0.44 09:01:42 INFO - PID 18647 | Values: 104.0 111.0 111.0 111.0 111.0 111.0 112.0 111.0 111.0 112.0 09:01:42 INFO - PID 18647 | 09:01:42 INFO - PID 18647 | [#1] audio-beat-detection Cycles:10 Average:134.30 Median:127.50 stddev:15.50 (12.2%) stddev-sans-first:15.36 09:01:42 INFO - PID 18647 | Values: 150.0 128.0 124.0 168.0 126.0 123.0 123.0 126.0 148.0 127.0 09:01:42 INFO - PID 18647 | 09:01:42 INFO - PID 18647 | [#2] audio-dft Cycles:10 Average:165.30 Median:165.00 stddev:2.58 (1.6%) stddev-sans-first:2.70 09:01:42 INFO - PID 18647 | Values: 164.0 165.0 164.0 165.0 169.0 168.0 169.0 165.0 162.0 162.0 09:01:42 INFO - PID 18647 | 09:01:42 INFO - PID 18647 | [#3] audio-fft Cycles:10 Average:81.50 Median:76.00 stddev:11.65 (15.3%) stddev-sans-first:12.19 09:01:42 INFO - PID 18647 | Values: 76.0 74.0 75.0 107.0 74.0 76.0 80.0 79.0 99.0 75.0 09:01:42 INFO - PID 18647 | 09:01:42 INFO - PID 18647 | [#4] audio-oscillator Cycles:10 Average:90.20 Median:83.50 stddev:11.55 (13.8%) stddev-sans-first:12.03 09:01:42 INFO - PID 18647 | Values: 84.0 84.0 114.0 83.0 83.0 83.0 98.0 84.0 83.0 106.0 09:01:42 INFO - PID 18647 | 09:01:42 INFO - PID 18647 | [#5] imaging-gaussian-blur Cycles:10 Average:114.90 Median:115.00 stddev:2.18 (1.9%) stddev-sans-first:2.32 09:01:42 INFO - PID 18647 | Values: 115.0 117.0 113.0 114.0 120.0 113.0 113.0 114.0 115.0 115.0 09:01:42 INFO - PID 18647 | 09:01:42 INFO - PID 18647 | [#6] imaging-darkroom Cycles:10 Average:151.60 Median:152.00 stddev:1.26 (0.8%) stddev-sans-first:1.33 09:01:42 INFO - PID 18647 | Values: 152.0 152.0 150.0 152.0 151.0 154.0 151.0 151.0 153.0 150.0 09:01:42 INFO - PID 18647 | 09:01:42 INFO - PID 18647 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 09:01:42 INFO - PID 18647 | Values: 95.0 95.0 95.0 94.0 94.0 95.0 95.0 97.0 95.0 95.0 09:01:42 INFO - PID 18647 | 09:01:42 INFO - PID 18647 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.00 stddev:1.37 (2.5%) stddev-sans-first:1.39 09:01:42 INFO - PID 18647 | Values: 54.0 54.0 53.0 58.0 55.0 56.0 55.0 56.0 55.0 55.0 09:01:42 INFO - PID 18647 | 09:01:42 INFO - PID 18647 | [#9] json-stringify-tinderbox Cycles:10 Average:57.20 Median:57.50 stddev:0.79 (1.4%) stddev-sans-first:0.78 09:01:42 INFO - PID 18647 | Values: 58.0 57.0 58.0 58.0 56.0 57.0 58.0 56.0 57.0 57.0 09:01:42 INFO - PID 18647 | 09:01:42 INFO - PID 18647 | [#10] stanford-crypto-aes Cycles:10 Average:92.60 Median:87.50 stddev:15.99 (18.3%) stddev-sans-first:16.87 09:01:42 INFO - PID 18647 | Values: 88.0 87.0 87.0 88.0 87.0 86.0 88.0 90.0 138.0 87.0 09:01:42 INFO - PID 18647 | 09:01:42 INFO - PID 18647 | [#11] stanford-crypto-ccm Cycles:10 Average:137.30 Median:137.00 stddev:5.03 (3.7%) stddev-sans-first:5.27 09:01:42 INFO - PID 18647 | Values: 135.0 132.0 134.0 140.0 135.0 132.0 139.0 145.0 135.0 146.0 09:01:42 INFO - PID 18647 | 09:01:42 INFO - PID 18647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.00 Median:196.50 stddev:3.40 (1.7%) stddev-sans-first:2.03 09:01:42 INFO - PID 18647 | Values: 187.0 197.0 198.0 196.0 193.0 197.0 199.0 194.0 195.0 194.0 09:01:42 INFO - PID 18647 | 09:01:42 INFO - PID 18647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:73.00 stddev:1.57 (2.1%) stddev-sans-first:1.54 09:01:42 INFO - PID 18647 | Values: 75.0 73.0 72.0 73.0 73.0 72.0 73.0 72.0 73.0 77.0 09:01:42 INFO - PID 18647 | -------- Summary: end -------- 09:01:42 INFO - PID 18647 | 09:01:43 INFO - TEST-INFO | 18647: exit 0 09:01:43 INFO - TEST-OK | kraken | took 92178ms 09:01:43 INFO - SUITE-END | took 1238s 09:01:43 INFO - Completed test suite (00:20:38) 09:01:43 INFO - javascript benchmark 09:01:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6777.563217370962, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2696.7168447313034, 2706.8240564363305, 2719.9456010879785, 2744.5608702607574, 2745.1901689001747, 5095.312132862063, 5223.582113430926, 5242.135047717127, 5250.789968401259, 5288.788448462057, 5190.610704197182, 5211.218317252414, 5271.551918086967, 5291.206319052135, 5316.175992721134, 4663.300504924272, 4693.6949098308505, 4711.222648263032, 4714.269288260308, 4756.072565849643, 4680.321353403754, 4696.882577935562, 4774.140654682155, 4778.187708089616, 4813.759312034402, 4567.36056952027, 4602.493725690171, 4701.0, 4711.0342379812055, 4767.308740232682, 4671.556202160789, 4678.672492925497, 4725.598324142452, 4730.455997560256, 4739.336492890963, 4632.652551058684, 4674.088552732219, 4678.0410015946645, 4699.177643912336, 4704.1062198182235, 5180.145276029489, 5261.237120617528, 5262.500062494057, 5267.28891599633, 5301.6818990860675, 5498.230247765316, 5551.028570000274, 5572.7770889164385, 5648.3222013358245, 5747.885042299173, 5730.484256416901, 5771.740271687784, 5776.075827867521, 5819.67991760453, 5838.532917366643, 5294.311739473844, 5304.522592966651, 5308.071087559739, 5308.708021058879, 5346.759395827197, 5687.829365119053, 5725.1698503716725, 5843.620164689281, 5850.473457388855, 5862.384449632812, 5479.698616576126, 5521.171824226318, 5539.169124631257, 5552.167174923713, 5578.972105139448, 5590.189422533791, 5601.831945041656, 5614.045612245846, 5629.296337957755, 5642.520385767174, 5491.835244942658, 5499.890002200013, 5615.101583746581, 5621.634593751393, 5625.578081643811, 5563.0, 5579.525740312038, 5593.74828132735, 5617.943820561742, 5671.602987790898, 4795.352627395327, 4799.568038876518, 4804.567588917014, 4804.903901921942, 4838.830640927551, 4091.590840915944, 4092.2838503262406, 4092.590740925943, 4129.648979836687, 4155.439015732837, 4637.930431043537, 4698.55363740451, 4721.055788842245, 4745.691530050535, 4755.096531658974, 5669.688167150764, 5690.800821971211, 5701.515371193412, 5708.343540492813, 5713.171590119409, 4682.81268749253, 4706.717596944194, 4707.199776038082, 4711.458182309078, 4740.857774266778, 4896.975515122473, 5013.849584512471, 5031.572316353077, 5044.848654540369, 5068.062408454448, 5141.048905952411, 5147.3308469898675, 5163.8192663256605, 5173.379194496534, 5210.1142805723875, 5536.390996990408, 5606.915896261477, 5733.369329373682, 5738.540916726735, 5743.6840973745175, 5155.252488389237, 5191.532762051434, 5222.634415590872, 5237.188235823453, 5240.580753539632, 5448.318960129984, 5498.45015498463, 5535.142052981794, 5577.637453565505, 5579.442055794388, 5565.053940829987, 5682.318121825408, 5691.7438715257085, 5691.914621280767, 5734.799282025109, 5448.155535891943, 5448.237246785374, 5486.506214440719, 5548.611597188158, 5564.944350556604, 5520.806771762969, 5536.944630553643, 5537.446255374431, 5537.7784888604, 5540.722963851872, 5433.402325744244, 5447.972760136174, 5470.124780035335, 5472.261244731911, 5518.255035570307, 5427.891442171213, 5510.228568000563, 5512.4211957743855, 5534.4742249486235, 5624.550035997192, 5389.326334208224, 5415.729213539386, 5425.43032981547, 5426.430224826494, 5467.45325467466], "value": 5124.124860687628, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.5458328961633, 663.5653646861306, 665.810244080437, 1158.9304641721492, 1174.741556857491, 33460.33079338418, 34366.14084647885, 35271.0, 35342.2931541369, 35497.290054198966, 35573.0, 35776.10559736008, 35964.64035359652, 35982.0, 36077.278454430896, 6627.370399812022, 6783.660816959157, 6796.0485532025305, 6806.727730890759, 6836.213835408942, 6703.564268322568, 6802.38778509934, 6823.420009299216, 6832.180138383376, 6835.897461538081, 6765.0, 6871.175458944934, 6877.0, 6881.69032393541, 6881.862362752742, 6797.592144471348, 6820.113385259884, 6821.113255276832, 6826.726930922757, 6875.07186529817, 6672.733090676367, 6753.898691519631, 6756.729730810762, 6761.425278851303, 6780.321967803229, 32399.352012959844, 32413.189670258198, 32505.51241731376, 32593.185170370693, 32696.182595435068, 3022.2897619059504, 3039.8176109433507, 3046.695330466958, 3056.3428862794385, 3062.7856050076502, 24822.5035499289, 24849.751502484924, 24952.0, 24962.50074998508, 24996.875015624988, 2852.7432531072304, 2854.314964408527, 2862.842543660098, 2865.5701644753244, 2877.5539791332376, 139390.0, 140450.29774851163, 140814.0, 146353.0, 152997.47002529944, 38899.053217760076, 39384.0, 39425.60574394219, 39503.80248098741, 39567.0, 40478.595214047484, 40781.38827917584, 40810.18379632391, 40941.79529102395, 44035.0, 12595.685107872376, 12779.488820447077, 12779.936100319625, 12826.102172847812, 12854.614361569167, 10194.184465242763, 10204.795904082026, 10214.489275536194, 10215.336003159771, 10217.489125543692, 12708.428120734588, 12827.358632068359, 12844.871551284368, 12878.227306361649, 12914.870851291555, 5312.92030619541, 5434.646747961449, 5440.3743569489225, 5461.044317244467, 5470.507654311131, 829.6805729794073, 891.22463456793, 919.3886065766325, 927.9768005799774, 928.3176865004217, 20527.178912843618, 21283.36149915505, 21448.785512144677, 21750.34748957534, 22002.44993875134, 988.7182153086336, 990.9256805739599, 1011.8381059030667, 1021.7752094539189, 1025.108155904368, 11059.889401105886, 11077.889221107685, 11267.267627604344, 11338.09295256394, 11416.31502109876, 172071.13964430348, 172965.0, 173734.0, 173971.0, 174667.0, 41072.1785564293, 41218.0, 41261.174776504304, 41345.58654413478, 41421.1715765689, 1185.5139392849062, 1243.8059462915703, 1248.9750204995848, 1249.331607589935, 1267.7527882063093, 20017.699734504284, 20131.39605811828, 21016.159353625684, 21168.835714035875, 21255.0, 29335.266618334714, 36647.0, 36780.81609591935, 36898.631013690596, 37070.62929370672, 166098.0, 166801.0, 167431.0, 167499.0, 168020.15989919973, 29928.70071299259, 29991.550126748552, 30006.0, 30061.248468788453, 30336.39327213399, 35127.82436087803, 35726.28547429089, 35948.4607730879, 35968.0, 36045.63954360423, 26677.0, 27247.318817029733, 27532.17403477899, 27783.30541736473, 27987.58018629763, 26796.464070718866, 27479.725202748516, 27684.723152768216, 28131.57802632921, 28736.425271494034, 31071.53392699066, 31341.373172535965, 31369.05892823219, 31386.372272554876, 31426.371472570878, 25770.0, 26204.344891377867, 26993.65031748444, 27218.455630886874, 27410.45179096367, 21500.67748983735, 22136.66794998044, 22304.77695223092, 22340.88829555842, 22527.66208506841], "value": 14607.086349858904, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [408.5893676854761, 418.36617524450446, 427.6493275514078, 432.753330601557, 439.75813302683525, 14548.418063277482, 14863.925680371583, 17361.82638173618, 18111.36610218641, 18113.456596302116, 18439.631207375845, 18513.35203267886, 18550.165242564082, 18656.440306790817, 18780.248790048383, 5326.786928522864, 5351.785928562853, 5521.834344969658, 5568.916466253009, 5575.888482230353, 5334.866628334304, 5504.366997795245, 5513.58648101392, 5514.145307477347, 5533.170024496318, 5202.0, 5385.246065550826, 5416.702081385522, 5445.754941027663, 5478.233047373351, 5248.947510524884, 5309.734513274321, 5317.0, 5348.625596208267, 5358.490943360394, 4841.595937178214, 4871.780769865364, 4877.000214955926, 4885.120678277908, 4891.364122664067, 22110.668339974913, 22146.335609931728, 22420.66369004466, 22933.54132917349, 23101.884490577606, 1596.233807772276, 1603.2384617306802, 1641.8193998660138, 1644.399794075154, 1649.5628658405533, 14678.92660536701, 14771.55685329431, 14990.700185996327, 15059.096454212782, 15080.396784128621, 2063.10255039057, 2073.429806803141, 2079.8336133109465, 2103.2428325802853, 2107.2940564910773, 77546.61226693887, 89884.55057724736, 89960.10039899583, 93157.53421232851, 93308.53345733296, 11051.2816666918, 11130.777384452265, 11181.888181118085, 11233.775324493465, 11426.94286528562, 15636.0, 15646.374145034299, 15647.765283520755, 15682.215889205494, 15748.133852638215, 7740.445652934518, 7765.805854853561, 7917.366610671133, 7932.246436588515, 8086.676532938734, 7173.354398104196, 7233.638318084075, 7449.478536502393, 7469.439792015621, 7476.5514069156025, 6879.0, 6966.5471744336455, 6986.44108471321, 6987.0, 7024.719011239596, 2048.805363490466, 2082.8229600483824, 2120.660694288906, 2134.8612340197838, 2155.3964889830872, 827.6317038917624, 855.4781583234222, 871.8212766382876, 890.955452227386, 898.4250079948838, 16910.239039243264, 16977.575560611083, 17088.572785680208, 17582.472525824247, 17788.733169002215, 868.774118729135, 874.8031692869054, 878.767126711422, 882.3602887906217, 898.1333013641867, 9258.768530786785, 9382.155605995493, 9581.520923953914, 9690.70927872165, 9711.805763884682, 362259.0, 369345.0, 375316.0, 381738.0, 382306.0, 71856.28143718495, 72572.27427725655, 74279.0, 74850.88916552918, 77058.6147069261, 1026.609888242478, 1030.0883717909703, 1036.8133735927606, 1052.6998508259478, 1055.9736006599896, 14460.27698615086, 14665.413383464542, 14704.117752934859, 14736.115833050051, 15147.848521514643, 37255.44116838304, 37517.43723844199, 37950.43074353942, 38573.42139867848, 39875.2024959505, 47951.5204847947, 48485.75757121192, 49729.75135124301, 49769.0, 50542.74728626334, 8304.87542686848, 8372.832543349221, 8453.66185352579, 8470.941132358455, 8536.615852286537, 12764.42560084817, 12942.611721648365, 13053.34733263352, 13097.607071787861, 13103.2138071716, 10900.236983411085, 11122.833157502806, 11146.442677866236, 11301.378424186749, 11638.301701897914, 10487.737806554896, 10629.89370106289, 10714.517846697074, 10723.517441714985, 10932.234743567873, 11066.612668556561, 11122.221444499131, 11212.0, 11321.320720756781, 11373.31760094397, 8316.6673333066, 8428.789280268042, 8503.787405314917, 8569.871451928102, 8584.527850968258, 10929.453527323443, 11019.504122314354, 11087.944560277147, 11157.944210278896, 11496.252743571642], "value": 8839.3156121492, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1269.086257894316, 1312.1208790110625, 1314.8356455443075, 1320.8811206991368, 1329.0364485747832, 10371.48142592871, 10477.738056548571, 10832.133429325655, 10859.239853210278, 10865.945670271638, 10494.790104197911, 10704.73238169046, 10707.036366726992, 10709.0, 10718.571257149724, 2242.9663555046686, 2260.9321720348416, 2273.5680220758004, 2274.8293877959136, 2275.340151356105, 2042.5200077981738, 2077.657186564215, 2089.2478707665227, 2090.289301637443, 2105.221068204766, 2109.0, 2125.8511904166717, 2128.957420851582, 2135.1886283212434, 2144.067330711138, 2055.321743824534, 2070.140891530013, 2072.6476498995207, 2077.802608752166, 2081.833453323738, 1983.077868791019, 1991.930282440122, 2037.2054898589563, 2043.5810658814908, 2184.2464349799293, 10641.095506881924, 10728.839067413996, 10728.839067413996, 10732.087772539344, 10777.407242601654, 5651.463111004448, 5871.9412805871825, 5873.0, 5882.970585147047, 5883.411658834125, 3189.122991177445, 3312.950305745416, 3404.6595340466, 3405.6934875861293, 3408.727301815849, 1019.2406657040478, 1030.9175365865885, 1065.9893401065967, 1117.742919128605, 1145.7021174494607, 15516.844831551765, 15613.609659758484, 15615.921920390325, 15694.136822474758, 15706.293216805272, 4623.514530974199, 4708.882277943078, 4786.2581299898575, 4915.11527924977, 4963.776630051656, 11210.439478026066, 11217.3830439325, 11261.887381126084, 11273.71815704614, 11291.830622540669, 5493.121100623881, 5649.180868774005, 5669.376368599451, 5683.175939488751, 5702.8289151325525, 5018.096742586296, 5166.715830629276, 5215.869603259873, 5235.895282094337, 5244.082285600005, 3818.3317919364554, 3938.0, 3944.60553944609, 3967.504061992251, 3969.980150099231, 1124.8087825069758, 1140.0708422635525, 1152.5101831721486, 1153.5904753812445, 1158.3281696615943, 692.97228110875, 704.2359040441179, 707.9327463890922, 722.2344315025985, 733.4242619543633, 5684.261046063985, 5775.5090817281, 5802.332731735904, 5868.325142608569, 5889.1755154278435, 553.1232995701778, 576.2278546747378, 576.4581293584017, 576.8990426675315, 580.7357652268208, 3355.865765369358, 3402.1324562236964, 3472.5832900052155, 3926.6466018058513, 4005.5193376794973, 13814.723705526034, 13977.091489053179, 14277.14337139775, 14323.85676143246, 14478.565643030726, 13542.729145417234, 13974.58076257714, 14151.363188656534, 14167.78748318776, 14174.14955102697, 7752.341051010727, 7950.1254861965135, 7974.285528611376, 8022.157673444204, 8039.236272554098, 6474.320196379501, 6520.478361731145, 6660.600363978177, 6682.83292917681, 6734.4612431004425, 12737.426815793126, 12850.678733031375, 12853.807192891927, 12877.0, 12886.48454061827, 13054.869451305365, 13060.151090179108, 13118.909451981628, 13241.470341186245, 13275.867241327463, 8751.343649226206, 8862.64549418016, 8917.598708058023, 8928.642854285756, 8938.68714594986, 10000.749981250527, 10188.898111018794, 10189.490525473548, 10202.897971020195, 10205.540750666387, 8271.751847444586, 8417.87373189415, 8470.957645211982, 8644.308455323684, 8707.608157632794, 8449.957750211455, 8514.020887598006, 8626.5255410953, 8678.869816952878, 8689.0, 7281.1262648482525, 7319.597422141834, 7329.083864516935, 7365.668544915385, 7369.226231245856, 5575.135853942646, 5622.465865742748, 5650.63270887391, 5676.801311954062, 5851.268591426072, 5588.357338905916, 5645.435456454486, 5708.942910571007, 5716.5426765859465, 5819.63238638911], "value": 4815.7071558913085, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.6055339126959, 364.80482941626235, 369.04233514031097, 393.7401315132013, 396.55981860135256, 5406.621536492442, 5430.511253987141, 5454.372747134081, 5465.289512363397, 5469.972650136749, 5312.760925758341, 5350.946490535093, 5354.303940487741, 5367.704776237305, 5380.757865896035, 3840.519935008124, 4039.7172197946156, 4041.333180025292, 4195.412642230091, 4214.515330736958, 4063.167050754588, 4072.409500622408, 4073.816678249471, 4076.7961601919933, 4103.8563650272245, 4014.237294913957, 4014.4179094031347, 4020.0, 4038.8788336349808, 4041.838326466938, 4050.0077481017047, 4052.1490486997764, 4060.9999999999854, 4065.9593404065877, 4126.1128857295525, 3863.0728625130046, 3876.9612303876884, 3882.2429626222897, 3889.0137608950768, 3900.278448487011, 5212.400573934008, 5220.451852555465, 5237.869053273698, 5241.3710354757295, 5260.10636170982, 4822.68652537584, 4986.5013498650205, 4997.275395067695, 5010.123228435009, 5032.370953630796, 5607.102863541854, 5700.429957004267, 5731.598788084836, 5741.33974592923, 5743.798967036176, 4322.438083049215, 4325.805338759732, 4333.371661109153, 4340.197063543254, 4355.716878402925, 5474.42518535552, 5908.527317814607, 5919.602560962817, 6014.96992515039, 6123.326434092246, 4232.386303985905, 4232.513260974965, 4247.532771395144, 4249.213895429355, 4271.765052922057, 4340.76125813077, 4353.82584696615, 4367.62875155609, 4377.474703035656, 4386.495553011381, 4728.078024785203, 4793.808247670054, 4828.61371090312, 4845.1520983828395, 4854.635902307341, 5695.914561281584, 5697.51864515229, 5706.771729130788, 5710.628809127394, 5741.3971532988435, 1552.028923267444, 1589.6025993501626, 1589.6025993501626, 1594.115266027366, 1599.3842370687369, 1081.3674000709516, 1143.3654321851452, 1156.4160099149876, 1158.2818652435544, 1159.5825502818977, 4839.540243676845, 4859.684120532154, 4874.707517548887, 4876.244182151772, 4896.68171568854, 5829.329627092939, 5840.795572155039, 5894.823155305347, 5914.763409463573, 5933.465988061095, 4589.518100599389, 4814.903701925942, 4842.612590992782, 4843.346148270009, 4854.563089321978, 3094.3965926644087, 3112.8754849805755, 3113.1438854314792, 3113.688631136868, 3116.8597413116463, 5268.894622107537, 5334.359876814807, 5345.701348420217, 5382.219578161144, 5399.811006614749, 5744.511716504144, 5965.105234214816, 5971.9701401493585, 5979.910301345483, 6005.159277701126, 5325.334333208349, 5341.973290133525, 5361.222622719606, 5361.973190134025, 5401.432849550819, 5849.590528662953, 5866.530677545871, 5871.035127260706, 5886.499647530008, 5886.558508111994, 5663.32040155184, 5785.537157027512, 5789.826305210682, 5804.0, 5828.300603927556, 5363.356397232357, 5366.0, 5380.623356365017, 5381.48875856793, 5384.21928820311, 3953.565107838193, 4044.5550989390554, 4058.504020027721, 4062.431259623596, 4073.6130067643526, 5855.502282305882, 5894.882102357843, 5926.444133520026, 5930.406959304208, 5946.316173640087, 5684.886302274014, 5688.943110568841, 5706.0, 5709.172170035405, 5770.13447982806, 5581.906784955641, 5583.827396246671, 5601.60788744784, 5642.153676948326, 5675.814811297598, 5612.85967850807, 5619.550435965195, 5635.182898479779, 5636.957162924872, 5649.655393011854, 5572.136318870582, 5720.914186287292, 5723.6851973141875, 5737.483626473638, 5745.6552606843725, 5517.951589198039, 5538.91691624634, 5541.806036788693, 5559.832435188656, 5566.610337276352], "value": 4315.93319488908, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [680.1939701453778, 689.8447849233921, 693.5318659904566, 706.5937086175447, 708.8794904866172, 13706.588802335946, 13725.656858578528, 14173.858261417396, 14198.14811111334, 14441.350139243734, 16813.327466901308, 17063.40278090267, 17066.743998839996, 17072.743908841378, 17081.40215092472, 635.7488791927186, 890.4345740454809, 907.6732376344544, 911.2664305234284, 912.5710915869531, 658.4962503684685, 888.7866911941152, 906.0214967834722, 914.5884352041575, 915.1534830281996, 961.2262128986198, 964.5900492290783, 966.5602151021268, 973.2457345557215, 976.1702552830109, 957.8036502517002, 958.0515289863055, 960.3133759362055, 961.0293603460485, 961.6057416459219, 701.1936273285711, 702.9086218791575, 703.1632357494565, 706.4101475268158, 710.4139085254685, 15221.847781522265, 15426.614334641723, 15534.300956456873, 15575.610609734847, 15645.061296322257, 16536.917315413466, 16937.153142342835, 17033.0, 17071.23179456915, 17078.31686732529, 12822.80765788514, 13118.0, 13172.736545269137, 13190.0, 13223.933880330536, 2971.9405611887855, 3005.9549106763197, 3029.2881172924344, 3029.5758593796886, 3034.317278612317, 78565.60717196435, 78760.60619696864, 79205.60397198035, 79743.60128199322, 79872.0, 12295.0, 12586.24482531051, 12699.174553653984, 12708.491660333668, 12713.0, 21416.357509274745, 22334.441638959157, 23307.18424855122, 23397.88301058484, 23447.531049379257, 6044.667543285162, 6120.7551697931585, 6151.477124444473, 6184.81445556625, 6192.164057852222, 2656.481986012709, 2725.863706814691, 2739.6849362323187, 2842.6304580404417, 2876.266552029219, 3415.9658403416147, 3479.4780782882262, 3490.511328414024, 3500.1249687578106, 3501.439769636846, 731.4002517935348, 749.9887501687479, 761.1817296406385, 761.885717142422, 762.7597306848324, 566.623195574938, 580.1761498671896, 591.4558606082414, 601.6330038676404, 611.1413464082971, 9863.605455781688, 10392.272540922062, 11583.76832463363, 11829.053675705924, 12442.937785311016, 615.5260449453896, 615.9106929495288, 618.2426527503771, 621.8942779727457, 641.2945759664332, 4618.330342100377, 4889.413270407574, 4925.75371231437, 5042.873928151826, 5105.004524117836, 75027.62486187644, 76833.0, 77749.0, 79229.0, 90799.54600227089, 66541.66729166324, 68159.0, 68465.0, 69751.65124174448, 69834.65082674655, 58806.70596647075, 60708.0, 61402.0, 61639.6918015416, 61645.69177154175, 10237.641682541076, 10300.536475858455, 10519.316244444086, 10545.103666188154, 11056.557737690402, 28049.57925631158, 28198.43603127885, 28263.71736282693, 29358.41283174282, 29491.85254073716, 35624.64375356213, 35778.0, 35826.462603061496, 36124.27751445009, 36340.27319453543, 13039.674008149872, 13118.081734278509, 13433.529826456028, 13502.459901603826, 13523.661908451973, 15020.09879407239, 15077.0, 15153.696926061637, 15180.696386072437, 15239.238038098272, 14041.5085472008, 14056.297185140907, 14105.647358816112, 14200.431982720576, 14328.570142895729, 13789.448422063006, 13929.860701393261, 13933.094348867291, 13969.371378288204, 14249.216293103564, 13555.525556605471, 13810.585682429542, 13877.236751978335, 13969.511067112602, 13981.510647127301, 8820.29437644974, 9082.318826087938, 9336.579853906725, 9349.252059835333, 9674.564644591152, 10499.370037797757, 10510.211734120125, 10815.945920270347, 10881.401522916, 11163.776724465302], "value": 7048.118072731453, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1553.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 111.0, 111.0, 111.0, 111.0, 112.0, 111.0, 111.0, 112.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 128.0, 124.0, 168.0, 126.0, 123.0, 123.0, 126.0, 148.0, 127.0], "value": 134.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 164.0, 165.0, 169.0, 168.0, 169.0, 165.0, 162.0, 162.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 107.0, 74.0, 76.0, 80.0, 79.0, 99.0, 75.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 114.0, 83.0, 83.0, 83.0, 98.0, 84.0, 83.0, 106.0], "value": 90.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 117.0, 113.0, 114.0, 120.0, 113.0, 113.0, 114.0, 115.0, 115.0], "value": 114.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 152.0, 150.0, 152.0, 151.0, 154.0, 151.0, 151.0, 153.0, 150.0], "value": 151.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 97.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 53.0, 58.0, 55.0, 56.0, 55.0, 56.0, 55.0, 55.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 58.0, 58.0, 56.0, 57.0, 58.0, 56.0, 57.0, 57.0], "value": 57.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 87.0, 88.0, 87.0, 86.0, 88.0, 90.0, 138.0, 87.0], "value": 92.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 132.0, 134.0, 140.0, 135.0, 132.0, 139.0, 145.0, 135.0, 146.0], "value": 137.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 197.0, 198.0, 196.0, 193.0, 197.0, 199.0, 194.0, 195.0, 194.0], "value": 195.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 72.0, 73.0, 73.0, 72.0, 73.0, 72.0, 73.0, 77.0], "value": 73.3, "unit": "score"}]}]} 09:01:43 INFO - Return code: 0 09:01:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:01:43 INFO - # TBPL SUCCESS # 09:01:43 INFO - Running post-action listener: _resource_record_post_action 09:01:43 INFO - [mozharness: 2017-05-24 16:01:43.905835Z] Finished run-tests step (success) 09:01:43 INFO - Running post-run listener: _resource_record_post_run 09:01:43 INFO - Total resource usage - Wall time: 1254s; CPU: 13.0%; Read bytes: 0; Write bytes: 402538496; Read time: 0; Write time: 232864 09:01:43 INFO - TinderboxPrint: CPU usage
12.8% 09:01:43 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:01:43 INFO - TinderboxPrint: I/O write bytes / time
402,538,496 / 232,864 09:01:43 INFO - TinderboxPrint: CPU idle
8,731.6 (87.2%) 09:01:43 INFO - TinderboxPrint: CPU user
1,226.0 (12.2%) 09:01:43 INFO - TinderboxPrint: Swap in / out
0 / 0 09:01:43 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 92422144; Read time: 0; Write time: 55532 09:01:44 INFO - run-tests - Wall time: 1239s; CPU: 13.0%; Read bytes: 0; Write bytes: 309719040; Read time: 0; Write time: 177312 09:01:44 INFO - Running post-run listener: _upload_blobber_files 09:01:44 INFO - Blob upload gear active. 09:01:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:01:44 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:01:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:01:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:01:45 INFO - (blobuploader) - INFO - Open directory for files ... 09:01:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:01:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:45 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:01:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:45 INFO - (blobuploader) - INFO - Done attempting. 09:01:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:01:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:01:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:46 INFO - (blobuploader) - INFO - Done attempting. 09:01:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:01:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:01:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:47 INFO - (blobuploader) - INFO - Done attempting. 09:01:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:01:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:01:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:53 INFO - (blobuploader) - INFO - Done attempting. 09:01:53 INFO - (blobuploader) - INFO - Iteration through files over. 09:01:53 INFO - Return code: 0 09:01:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:01:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:01:53 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7fd7fe21c9f93e04b44d44fd22062adcf66602eafae2a70c4b71aaff4317d71470e499aaba7081aac6480aaabb0680f94f5ded01c5a495e2fb9e89211a534c5c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b38f1d8ceadc0f12f499a4af0df3a56a8c4cde66b2fb7cd8ec549b1b222c2af033c7f4259d5fab19689bc84e15c40006396569f27d65b106045f3327f9730b97", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0ca5ecac94e644fc12d79fb3082b46e7fd0e56c755a5cc7b0da7e43ecffbfe741848b2b186b95f98ca950f0a2dc913fa94a4fc19f2fe48e885f929e49dfb9f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e2798020a71320b18d82e773247ffe89da46121fec2680c2584b098978a4cdca1238e29ad6d25c0969cb9252638f30cade2ae5ca4c102e425f98836b79356ae9"} 09:01:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:01:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:01:53 INFO - Contents: 09:01:53 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7fd7fe21c9f93e04b44d44fd22062adcf66602eafae2a70c4b71aaff4317d71470e499aaba7081aac6480aaabb0680f94f5ded01c5a495e2fb9e89211a534c5c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b38f1d8ceadc0f12f499a4af0df3a56a8c4cde66b2fb7cd8ec549b1b222c2af033c7f4259d5fab19689bc84e15c40006396569f27d65b106045f3327f9730b97", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0ca5ecac94e644fc12d79fb3082b46e7fd0e56c755a5cc7b0da7e43ecffbfe741848b2b186b95f98ca950f0a2dc913fa94a4fc19f2fe48e885f929e49dfb9f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e2798020a71320b18d82e773247ffe89da46121fec2680c2584b098978a4cdca1238e29ad6d25c0969cb9252638f30cade2ae5ca4c102e425f98836b79356ae9"} 09:01:53 INFO - Running post-run listener: copy_logs_to_upload_dir 09:01:53 INFO - Copying logs to upload dir... 09:01:53 INFO - mkdir: /builds/slave/test/build/upload/logs 09:01:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1314.137437 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 54 secs) (at 2017-05-24 09:01:52.505046) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-24 09:01:52.508812) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1495640396.510196-1501590203 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/7fd7fe21c9f93e04b44d44fd22062adcf66602eafae2a70c4b71aaff4317d71470e499aaba7081aac6480aaabb0680f94f5ded01c5a495e2fb9e89211a534c5c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b38f1d8ceadc0f12f499a4af0df3a56a8c4cde66b2fb7cd8ec549b1b222c2af033c7f4259d5fab19689bc84e15c40006396569f27d65b106045f3327f9730b97", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0ca5ecac94e644fc12d79fb3082b46e7fd0e56c755a5cc7b0da7e43ecffbfe741848b2b186b95f98ca950f0a2dc913fa94a4fc19f2fe48e885f929e49dfb9f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e2798020a71320b18d82e773247ffe89da46121fec2680c2584b098978a4cdca1238e29ad6d25c0969cb9252638f30cade2ae5ca4c102e425f98836b79356ae9"} build_url:https://queue.taskcluster.net/v1/task/bYhn8c33SxSX5kd1GsJO-Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011340 build_url: 'https://queue.taskcluster.net/v1/task/bYhn8c33SxSX5kd1GsJO-Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7fd7fe21c9f93e04b44d44fd22062adcf66602eafae2a70c4b71aaff4317d71470e499aaba7081aac6480aaabb0680f94f5ded01c5a495e2fb9e89211a534c5c", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/b38f1d8ceadc0f12f499a4af0df3a56a8c4cde66b2fb7cd8ec549b1b222c2af033c7f4259d5fab19689bc84e15c40006396569f27d65b106045f3327f9730b97", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0ca5ecac94e644fc12d79fb3082b46e7fd0e56c755a5cc7b0da7e43ecffbfe741848b2b186b95f98ca950f0a2dc913fa94a4fc19f2fe48e885f929e49dfb9f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e2798020a71320b18d82e773247ffe89da46121fec2680c2584b098978a4cdca1238e29ad6d25c0969cb9252638f30cade2ae5ca4c102e425f98836b79356ae9"}' ========= master_lag: 0.06 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-24 09:01:52.577335) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 09:01:52.577857) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1495640396.510196-1501590203 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004485 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 09:01:52.594021) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-24 09:01:52.594374) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-24 09:01:52.594732) ========= ========= Total master_lag: 0.19 =========