builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-030 starttime: 1496015182.81 results: success (0) revision: 51d220b260d8d52a41b65aae2c5d74be99c2d59e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-28 16:46:22.809505) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-28 16:46:22.810003) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-28 16:46:22.810283) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-28 16:46:22.826156) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 16:46:22.826513) ========= 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=3836458cccd887f2d2de3cf1000001de-1496015182.286408-1570331901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-28 16:46:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.2M=0s 2017-05-28 16:46:23 (69.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.356814 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 16:46:23.196828) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 16:46:23.197187) ========= 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=3836458cccd887f2d2de3cf1000001de-1496015182.286408-1570331901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019818 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 16:46:23.246644) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 16:46:23.247007) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 51d220b260d8d52a41b65aae2c5d74be99c2d59e --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 51d220b260d8d52a41b65aae2c5d74be99c2d59e --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=3836458cccd887f2d2de3cf1000001de-1496015182.286408-1570331901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-28 16:46:23,244 truncating revision to first 12 chars 2017-05-28 16:46:23,244 Setting DEBUG logging. 2017-05-28 16:46:23,244 attempt 1/10 2017-05-28 16:46:23,244 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/51d220b260d8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-28 16:46:23,696 unpacking tar archive at: mozilla-central-51d220b260d8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.823408 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 16:46:24.082674) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-28 16:46:24.083014) ========= script_repo_revision: 51d220b260d8d52a41b65aae2c5d74be99c2d59e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-28 16:46:24.083387) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-28 16:46:24.083675) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-28 16:46:24.090666) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2017-05-28 16:46:24.090955) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3836458cccd887f2d2de3cf1000001de-1496015182.286408-1570331901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:46:24 INFO - MultiFileLogger online at 20170528 16:46:24 in /builds/slave/test 16:46:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 16:46:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:46:24 INFO - {'append_to_log': False, 16:46:24 INFO - 'base_work_dir': '/builds/slave/test', 16:46:24 INFO - 'blob_upload_branch': 'Firefox', 16:46:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:46:24 INFO - 'branch': 'Firefox', 16:46:24 INFO - 'buildbot_json_path': 'buildprops.json', 16:46:24 INFO - 'config_files': ('talos/linux_config.py',), 16:46:24 INFO - 'default_actions': ('clobber', 16:46:24 INFO - 'read-buildbot-config', 16:46:24 INFO - 'download-and-extract', 16:46:24 INFO - 'populate-webroot', 16:46:24 INFO - 'create-virtualenv', 16:46:24 INFO - 'install', 16:46:24 INFO - 'setup-mitmproxy', 16:46:24 INFO - 'run-tests'), 16:46:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:46:24 INFO - 'download_minidump_stackwalk': True, 16:46:24 INFO - 'download_symbols': 'ondemand', 16:46:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:46:24 INFO - 'tooltool.py': '/tools/tooltool.py', 16:46:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:46:24 INFO - '/tools/misc-python/virtualenv.py')}, 16:46:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:46:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:46:24 INFO - 'gecko_profile': False, 16:46:24 INFO - 'gecko_profile_interval': 0, 16:46:24 INFO - 'installer_path': 'installer.exe', 16:46:24 INFO - 'log_level': 'info', 16:46:24 INFO - 'log_name': 'talos', 16:46:24 INFO - 'log_to_console': True, 16:46:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:46:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:46:24 INFO - 'opt_config_files': (), 16:46:24 INFO - 'pip_index': False, 16:46:24 INFO - 'suite': 'dromaeojs-e10s', 16:46:24 INFO - 'system_bits': '32', 16:46:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:46:24 INFO - 'title': 'talos-linux64-ix-030', 16:46:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:46:24 INFO - 'use_talos_json': True, 16:46:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:46:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:46:24 INFO - 'work_dir': 'build'} 16:46:24 INFO - [mozharness: 2017-05-28 23:46:24.185945Z] Running clobber step. 16:46:24 INFO - Running pre-action listener: _resource_record_pre_action 16:46:24 INFO - Running main action method: clobber 16:46:24 INFO - rmtree: /builds/slave/test/build 16:46:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:46:25 INFO - Running post-action listener: _resource_record_post_action 16:46:25 INFO - [mozharness: 2017-05-28 23:46:25.200285Z] Finished clobber step (success) 16:46:25 INFO - [mozharness: 2017-05-28 23:46:25.200387Z] Running read-buildbot-config step. 16:46:25 INFO - Running pre-action listener: _resource_record_pre_action 16:46:25 INFO - Running main action method: read_buildbot_config 16:46:25 INFO - Using buildbot properties: 16:46:25 INFO - { 16:46:25 INFO - "project": "", 16:46:25 INFO - "product": "firefox", 16:46:25 INFO - "who": "archaeopteryx@coole-files.de", 16:46:25 INFO - "installer_path": "public/build/target.tar.bz2", 16:46:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 16:46:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 16:46:25 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 16:46:25 INFO - "stage_platform": "linux64-stylosequential", 16:46:25 INFO - "basedir": "/builds/slave/test", 16:46:25 INFO - "buildnumber": 28, 16:46:25 INFO - "platform": "ubuntu64_hw_styloseq", 16:46:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:46:25 INFO - "slavebuilddir": "test", 16:46:25 INFO - "taskId": "ceWho-8MQhSUDWI1WK9CRg", 16:46:25 INFO - "branch": "mozilla-central", 16:46:25 INFO - "script_repo_revision": "production", 16:46:25 INFO - "revision": "51d220b260d8d52a41b65aae2c5d74be99c2d59e", 16:46:25 INFO - "slavename": "talos-linux64-ix-030", 16:46:25 INFO - "repo_path": "mozilla-central" 16:46:25 INFO - } 16:46:25 INFO - Finding installer, test and symbols from parent task. 16:46:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ceWho-8MQhSUDWI1WK9CRg'}, attempt #1 16:46:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ceWho-8MQhSUDWI1WK9CRg'}, attempt #1 16:46:26 INFO - Task dependencies: f7sj5ddSS_i0aPQv11q_Cg 16:46:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg'}, attempt #1 16:46:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.tar.bz2 16:46:26 INFO - Set test_url: https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/test_packages.json 16:46:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.crashreporter-symbols.zip 16:46:26 INFO - Running post-action listener: _resource_record_post_action 16:46:26 INFO - [mozharness: 2017-05-28 23:46:26.551448Z] Finished read-buildbot-config step (success) 16:46:26 INFO - [mozharness: 2017-05-28 23:46:26.551670Z] Running download-and-extract step. 16:46:26 INFO - Running pre-action listener: _resource_record_pre_action 16:46:26 INFO - Running main action method: download_and_extract 16:46:26 INFO - mkdir: /builds/slave/test/build/tests 16:46:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:46:26 INFO - trying https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.test_packages.json 16:46:26 INFO - Downloading https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:46:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:46:27 INFO - Downloaded 986 bytes. 16:46:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:46:27 INFO - Using the following test package requirements: 16:46:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:46:27 INFO - u'common': [u'target.common.tests.zip'], 16:46:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:46:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:46:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:46:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:46:27 INFO - u'mozbase': [u'target.common.tests.zip'], 16:46:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:46:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:46:27 INFO - u'web-platform': [u'target.common.tests.zip', 16:46:27 INFO - u'target.web-platform.tests.zip'], 16:46:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:46:27 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:46:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.common.tests.zip 16:46:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:46:27 INFO - Fetch https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.common.tests.zip into memory 16:46:28 INFO - Content-Length response header: 63527020 16:46:28 INFO - Bytes received: 63527020 16:46:38 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:46:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.common.tests.zip 16:46:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:46:38 INFO - Fetch https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.common.tests.zip into memory 16:46:41 INFO - Content-Length response header: 63527020 16:46:41 INFO - Bytes received: 63527020 16:46:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.talos.tests.zip 16:46:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:46:53 INFO - Fetch https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.talos.tests.zip into memory 16:46:54 INFO - Content-Length response header: 14447425 16:46:54 INFO - Bytes received: 14447425 16:46:54 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')]} 16:46:54 INFO - trying https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.tar.bz2 16:46:54 INFO - Downloading https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:46:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:46:55 INFO - Downloaded 55816609 bytes. 16:46:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.tar.bz2 16:46:55 INFO - mkdir: /builds/slave/test/properties 16:46:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:46:55 INFO - Writing to file /builds/slave/test/properties/build_url 16:46:55 INFO - Contents: 16:46:55 INFO - build_url:https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.tar.bz2 16:46:55 INFO - Running post-action listener: _resource_record_post_action 16:46:55 INFO - Running post-action listener: set_extra_try_arguments 16:46:55 INFO - [mozharness: 2017-05-28 23:46:55.742465Z] Finished download-and-extract step (success) 16:46:55 INFO - [mozharness: 2017-05-28 23:46:55.742561Z] Running populate-webroot step. 16:46:55 INFO - Running pre-action listener: _resource_record_pre_action 16:46:55 INFO - Running main action method: populate_webroot 16:46:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:46:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:46:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:46:55 INFO - '--tppagecycles', 16:46:55 INFO - '7'], 16:46:55 INFO - 'tests': ['tsvgm']}}, 16:46:55 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:46:55 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:46:55 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:46:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:46:55 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:46:55 INFO - 'talos_options': ['--disable-e10s'], 16:46:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:46:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:46:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:46:55 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:46:55 INFO - 'talos_options': ['--disable-e10s'], 16:46:55 INFO - 'tests': ['damp', 'tps']}, 16:46:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:46:55 INFO - 'tests': ['damp', 'tps']}, 16:46:55 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:46:55 INFO - 'tests': ['dromaeo_dom']}, 16:46:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:46:55 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:46:55 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:46:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:46:55 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:46:55 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:46:55 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:46:55 INFO - 'tests': ['a11yr', 16:46:55 INFO - 'ts_paint', 16:46:55 INFO - 'tpaint', 16:46:55 INFO - 'sessionrestore', 16:46:55 INFO - 'sessionrestore_no_auto_restore', 16:46:55 INFO - 'tabpaint']}, 16:46:55 INFO - 'other-e10s': {'tests': ['a11yr', 16:46:55 INFO - 'ts_paint', 16:46:55 INFO - 'tpaint', 16:46:55 INFO - 'sessionrestore', 16:46:55 INFO - 'sessionrestore_no_auto_restore', 16:46:55 INFO - 'tabpaint']}, 16:46:55 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:46:55 INFO - 'ts_paint', 16:46:55 INFO - 'tpaint', 16:46:55 INFO - 'sessionrestore', 16:46:55 INFO - 'sessionrestore_no_auto_restore', 16:46:55 INFO - 'tabpaint']}, 16:46:55 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:46:55 INFO - 'ts_paint', 16:46:55 INFO - 'tpaint', 16:46:55 INFO - 'sessionrestore', 16:46:55 INFO - 'sessionrestore_no_auto_restore', 16:46:55 INFO - 'tabpaint']}, 16:46:55 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:46:55 INFO - 'tests': ['a11yr', 16:46:55 INFO - 'ts_paint', 16:46:55 INFO - 'tpaint', 16:46:55 INFO - 'sessionrestore', 16:46:55 INFO - 'sessionrestore_no_auto_restore', 16:46:55 INFO - 'tabpaint']}, 16:46:55 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:46:55 INFO - 'tests': ['a11yr', 16:46:55 INFO - 'ts_paint', 16:46:55 INFO - 'tpaint', 16:46:55 INFO - 'sessionrestore', 16:46:55 INFO - 'sessionrestore_no_auto_restore', 16:46:55 INFO - 'tabpaint']}, 16:46:55 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 16:46:55 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 16:46:55 INFO - 'bloom_basic_ref']}, 16:46:55 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 16:46:55 INFO - 'talos_options': ['--mitmproxy', 16:46:55 INFO - 'mitmproxy-recording-1.mp', 16:46:55 INFO - '--firstNonBlankPaint'], 16:46:55 INFO - 'tests': ['Quantum_1']}, 16:46:55 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:46:55 INFO - 'tests': ['tsvgx', 16:46:55 INFO - 'tsvgr_opacity', 16:46:55 INFO - 'tart', 16:46:55 INFO - 'tscrollx', 16:46:55 INFO - 'cart', 16:46:55 INFO - 'tsvg_static']}, 16:46:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:46:55 INFO - 'tsvgr_opacity', 16:46:55 INFO - 'tart', 16:46:55 INFO - 'tscrollx', 16:46:55 INFO - 'cart', 16:46:55 INFO - 'tsvg_static']}, 16:46:55 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:46:55 INFO - 'talos_options': ['--disable-e10s'], 16:46:55 INFO - 'tests': ['tp5o']}, 16:46:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:46:55 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:46:55 INFO - 'talos_options': ['--disable-e10s', 16:46:55 INFO - '--xperf_path', 16:46:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:46:55 INFO - 'tests': ['tp5n']}, 16:46:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:46:55 INFO - 'talos_options': ['--xperf_path', 16:46:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:46:55 INFO - 'tests': ['tp5n']}}, 16:46:55 INFO - 'talos.zip': {'path': '', 16:46:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:46:55 INFO - Running post-action listener: _resource_record_post_action 16:46:55 INFO - [mozharness: 2017-05-28 23:46:55.756876Z] Finished populate-webroot step (success) 16:46:55 INFO - [mozharness: 2017-05-28 23:46:55.756965Z] Running create-virtualenv step. 16:46:55 INFO - Running pre-action listener: _resource_record_pre_action 16:46:55 INFO - Running main action method: create_virtualenv 16:46:55 INFO - Creating virtualenv /builds/slave/test/build/venv 16:46:55 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 16:46:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:46:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:46:55 INFO - Using real prefix '/usr' 16:46:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:46:56 INFO - Installing distribute.............................................................................................................................................................................................done. 16:46:58 INFO - Installing pip.................done. 16:46:58 INFO - Return code: 0 16:46:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:46:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:46:58 INFO - Reading from file tmpfile_stdout 16:46:58 INFO - Output received: 16:46:58 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) 16:46:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:46:58 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')]} 16:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:46:58 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')]} 16:46:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:46:58 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 0x23733b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f0ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ede40>, '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 0x26eefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ef440>, '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': '3836458cccd887f2d2de3cf1000001de-1496015182.286408-1570331901', '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 16:46:58 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 16:46:58 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 16:46:58 INFO - Using env: {'DISPLAY': ':0', 16:46:58 INFO - 'HOME': '/home/cltbld', 16:46:58 INFO - 'LANG': 'en_US.UTF-8', 16:46:58 INFO - 'LANGUAGE': 'en_US:en', 16:46:58 INFO - 'LOGNAME': 'cltbld', 16:46:58 INFO - 'MAIL': '/var/mail/cltbld', 16:46:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:58 INFO - 'MOZ_NO_REMOTE': '1', 16:46:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:58 INFO - 'NO_EM_RESTART': '1', 16:46:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:46:58 INFO - 'PWD': '/builds/slave/test', 16:46:58 INFO - 'SHELL': '/bin/bash', 16:46:58 INFO - 'SHLVL': '1', 16:46:58 INFO - 'TERM': 'linux', 16:46:58 INFO - 'TMOUT': '86400', 16:46:58 INFO - 'USER': 'cltbld', 16:46:58 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1496015182.286408-1570331901', 16:46:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:58 INFO - '_': '/tools/buildbot/bin/python'} 16:46:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:46:58 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 16:46:58 INFO - Cleaning up... 16:46:58 INFO - Return code: 0 16:46:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:46:58 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')]} 16:46:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:46:58 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')]} 16:46:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:46:58 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 0x23733b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f0ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ede40>, '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 0x26eefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ef440>, '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': '3836458cccd887f2d2de3cf1000001de-1496015182.286408-1570331901', '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 16:46:58 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 16:46:58 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 16:46:58 INFO - Using env: {'DISPLAY': ':0', 16:46:58 INFO - 'HOME': '/home/cltbld', 16:46:58 INFO - 'LANG': 'en_US.UTF-8', 16:46:58 INFO - 'LANGUAGE': 'en_US:en', 16:46:58 INFO - 'LOGNAME': 'cltbld', 16:46:58 INFO - 'MAIL': '/var/mail/cltbld', 16:46:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:58 INFO - 'MOZ_NO_REMOTE': '1', 16:46:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:58 INFO - 'NO_EM_RESTART': '1', 16:46:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:46:58 INFO - 'PWD': '/builds/slave/test', 16:46:58 INFO - 'SHELL': '/bin/bash', 16:46:58 INFO - 'SHLVL': '1', 16:46:58 INFO - 'TERM': 'linux', 16:46:58 INFO - 'TMOUT': '86400', 16:46:58 INFO - 'USER': 'cltbld', 16:46:58 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1496015182.286408-1570331901', 16:46:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:58 INFO - '_': '/tools/buildbot/bin/python'} 16:46:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:46:58 INFO - Downloading/unpacking psutil>=3.1.1 16:46:58 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 16:46:58 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 16:46:58 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 16:46:58 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 16:47:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:47:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:47:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:47:00 INFO - Installing collected packages: psutil 16:47:00 INFO - Running setup.py install for psutil 16:47:00 INFO - building 'psutil._psutil_linux' extension 16:47:00 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 16:47:00 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 16:47:00 INFO - building 'psutil._psutil_posix' extension 16:47:00 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 16:47:00 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 16:47:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:47:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:47:00 INFO - Successfully installed psutil 16:47:00 INFO - Cleaning up... 16:47:00 INFO - Return code: 0 16:47:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:47:00 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')]} 16:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:00 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')]} 16:47:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:00 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 0x23733b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f0ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ede40>, '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 0x26eefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ef440>, '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': '3836458cccd887f2d2de3cf1000001de-1496015182.286408-1570331901', '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 16:47:00 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 16:47:00 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 16:47:00 INFO - Using env: {'DISPLAY': ':0', 16:47:00 INFO - 'HOME': '/home/cltbld', 16:47:00 INFO - 'LANG': 'en_US.UTF-8', 16:47:00 INFO - 'LANGUAGE': 'en_US:en', 16:47:00 INFO - 'LOGNAME': 'cltbld', 16:47:00 INFO - 'MAIL': '/var/mail/cltbld', 16:47:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:00 INFO - 'MOZ_NO_REMOTE': '1', 16:47:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:00 INFO - 'NO_EM_RESTART': '1', 16:47:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:00 INFO - 'PWD': '/builds/slave/test', 16:47:00 INFO - 'SHELL': '/bin/bash', 16:47:00 INFO - 'SHLVL': '1', 16:47:00 INFO - 'TERM': 'linux', 16:47:00 INFO - 'TMOUT': '86400', 16:47:00 INFO - 'USER': 'cltbld', 16:47:00 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1496015182.286408-1570331901', 16:47:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:00 INFO - '_': '/tools/buildbot/bin/python'} 16:47:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:47:00 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 16:47:00 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 16:47:00 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 16:47:00 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 16:47:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:47:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:47:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:47:02 INFO - Installing collected packages: mozsystemmonitor 16:47:02 INFO - Running setup.py install for mozsystemmonitor 16:47:02 INFO - Successfully installed mozsystemmonitor 16:47:02 INFO - Cleaning up... 16:47:02 INFO - Return code: 0 16:47:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:47: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')]} 16:47:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47: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')]} 16:47:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:02 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 0x23733b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f0ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ede40>, '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 0x26eefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ef440>, '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': '3836458cccd887f2d2de3cf1000001de-1496015182.286408-1570331901', '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 16:47:02 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 16:47:02 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 16:47:02 INFO - Using env: {'DISPLAY': ':0', 16:47:02 INFO - 'HOME': '/home/cltbld', 16:47:02 INFO - 'LANG': 'en_US.UTF-8', 16:47:02 INFO - 'LANGUAGE': 'en_US:en', 16:47:02 INFO - 'LOGNAME': 'cltbld', 16:47:02 INFO - 'MAIL': '/var/mail/cltbld', 16:47:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:02 INFO - 'MOZ_NO_REMOTE': '1', 16:47:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:02 INFO - 'NO_EM_RESTART': '1', 16:47:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:02 INFO - 'PWD': '/builds/slave/test', 16:47:02 INFO - 'SHELL': '/bin/bash', 16:47:02 INFO - 'SHLVL': '1', 16:47:02 INFO - 'TERM': 'linux', 16:47:02 INFO - 'TMOUT': '86400', 16:47:02 INFO - 'USER': 'cltbld', 16:47:02 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1496015182.286408-1570331901', 16:47:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:02 INFO - '_': '/tools/buildbot/bin/python'} 16:47:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:02 INFO - Downloading/unpacking jsonschema==2.5.1 16:47:02 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 16:47:02 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 16:47:02 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 16:47:02 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 16:47:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:47:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:47:03 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 16:47:03 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 16:47:03 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 16:47:03 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 16:47:03 INFO - Downloading functools32-3.2.3-2.tar.gz 16:47:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:47:03 INFO - warning: no files found matching '*.txt' 16:47:03 INFO - no previously-included directories found matching 'build' 16:47:03 INFO - no previously-included directories found matching 'dist' 16:47:03 INFO - no previously-included directories found matching '.git*' 16:47:03 INFO - Installing collected packages: jsonschema, functools32 16:47:03 INFO - Running setup.py install for functools32 16:47:03 INFO - warning: no files found matching '*.txt' 16:47:03 INFO - no previously-included directories found matching 'build' 16:47:03 INFO - no previously-included directories found matching 'dist' 16:47:03 INFO - no previously-included directories found matching '.git*' 16:47:03 INFO - Successfully installed jsonschema functools32 16:47:03 INFO - Cleaning up... 16:47:03 INFO - Return code: 0 16:47:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:47:03 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')]} 16:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:03 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')]} 16:47:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:03 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 0x23733b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f0ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ede40>, '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 0x26eefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ef440>, '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': '3836458cccd887f2d2de3cf1000001de-1496015182.286408-1570331901', '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 16:47:03 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 16:47:03 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 16:47:03 INFO - Using env: {'DISPLAY': ':0', 16:47:03 INFO - 'HOME': '/home/cltbld', 16:47:03 INFO - 'LANG': 'en_US.UTF-8', 16:47:03 INFO - 'LANGUAGE': 'en_US:en', 16:47:03 INFO - 'LOGNAME': 'cltbld', 16:47:03 INFO - 'MAIL': '/var/mail/cltbld', 16:47:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:03 INFO - 'MOZ_NO_REMOTE': '1', 16:47:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:03 INFO - 'NO_EM_RESTART': '1', 16:47:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:03 INFO - 'PWD': '/builds/slave/test', 16:47:03 INFO - 'SHELL': '/bin/bash', 16:47:03 INFO - 'SHLVL': '1', 16:47:03 INFO - 'TERM': 'linux', 16:47:03 INFO - 'TMOUT': '86400', 16:47:03 INFO - 'USER': 'cltbld', 16:47:03 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1496015182.286408-1570331901', 16:47:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:03 INFO - '_': '/tools/buildbot/bin/python'} 16:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:47:04 INFO - Cleaning up... 16:47:04 INFO - Return code: 0 16:47:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:47:04 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')]} 16:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:04 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')]} 16:47:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:04 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 0x23733b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f0ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ede40>, '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 0x26eefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ef440>, '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': '3836458cccd887f2d2de3cf1000001de-1496015182.286408-1570331901', '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 16:47:04 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 16:47:04 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 16:47:04 INFO - Using env: {'DISPLAY': ':0', 16:47:04 INFO - 'HOME': '/home/cltbld', 16:47:04 INFO - 'LANG': 'en_US.UTF-8', 16:47:04 INFO - 'LANGUAGE': 'en_US:en', 16:47:04 INFO - 'LOGNAME': 'cltbld', 16:47:04 INFO - 'MAIL': '/var/mail/cltbld', 16:47:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:04 INFO - 'MOZ_NO_REMOTE': '1', 16:47:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:04 INFO - 'NO_EM_RESTART': '1', 16:47:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:04 INFO - 'PWD': '/builds/slave/test', 16:47:04 INFO - 'SHELL': '/bin/bash', 16:47:04 INFO - 'SHLVL': '1', 16:47:04 INFO - 'TERM': 'linux', 16:47:04 INFO - 'TMOUT': '86400', 16:47:04 INFO - 'USER': 'cltbld', 16:47:04 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1496015182.286408-1570331901', 16:47:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:04 INFO - '_': '/tools/buildbot/bin/python'} 16:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:04 INFO - Downloading/unpacking blobuploader==1.2.4 16:47:04 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 16:47:04 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 16:47:04 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 16:47:04 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 16:47:05 INFO - Downloading blobuploader-1.2.4.tar.gz 16:47:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:47:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:47:05 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 16:47:05 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 16:47:05 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 16:47:05 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 16:47:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:47:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:47:05 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 16:47:05 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 16:47:05 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 16:47:05 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 16:47:06 INFO - Downloading docopt-0.6.1.tar.gz 16:47:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:47:06 INFO - Installing collected packages: blobuploader, requests, docopt 16:47:06 INFO - Running setup.py install for blobuploader 16:47:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:47:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:47:06 INFO - Running setup.py install for requests 16:47:06 INFO - Running setup.py install for docopt 16:47:06 INFO - Successfully installed blobuploader requests docopt 16:47:06 INFO - Cleaning up... 16:47:06 INFO - Return code: 0 16:47:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:47:06 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')]} 16:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:06 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')]} 16:47:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:06 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 0x23733b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f0ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ede40>, '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 0x26eefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ef440>, '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': '3836458cccd887f2d2de3cf1000001de-1496015182.286408-1570331901', '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 16:47:06 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 16:47:06 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 16:47:06 INFO - Using env: {'DISPLAY': ':0', 16:47:06 INFO - 'HOME': '/home/cltbld', 16:47:06 INFO - 'LANG': 'en_US.UTF-8', 16:47:06 INFO - 'LANGUAGE': 'en_US:en', 16:47:06 INFO - 'LOGNAME': 'cltbld', 16:47:06 INFO - 'MAIL': '/var/mail/cltbld', 16:47:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:06 INFO - 'MOZ_NO_REMOTE': '1', 16:47:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:06 INFO - 'NO_EM_RESTART': '1', 16:47:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:06 INFO - 'PWD': '/builds/slave/test', 16:47:06 INFO - 'SHELL': '/bin/bash', 16:47:06 INFO - 'SHLVL': '1', 16:47:06 INFO - 'TERM': 'linux', 16:47:06 INFO - 'TMOUT': '86400', 16:47:06 INFO - 'USER': 'cltbld', 16:47:06 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1496015182.286408-1570331901', 16:47:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:06 INFO - '_': '/tools/buildbot/bin/python'} 16:47:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:47:07 INFO - Running setup.py (path:/tmp/pip-y3Y82z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:47:07 INFO - Running setup.py (path:/tmp/pip-KAjNUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:47:07 INFO - Running setup.py (path:/tmp/pip-7IxIBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:47:07 INFO - Running setup.py (path:/tmp/pip-nP1iUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:47:07 INFO - Running setup.py (path:/tmp/pip-sJNndM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:47:07 INFO - Running setup.py (path:/tmp/pip-fq8f7e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:47:07 INFO - Running setup.py (path:/tmp/pip-Juep7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:47:07 INFO - Running setup.py (path:/tmp/pip-jJpXdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:47:07 INFO - Running setup.py (path:/tmp/pip-ILG205-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:47:07 INFO - Running setup.py (path:/tmp/pip-EHDoRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:47:07 INFO - Running setup.py (path:/tmp/pip-D9zGL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:47:07 INFO - Running setup.py (path:/tmp/pip-r_IDIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:47:07 INFO - Running setup.py (path:/tmp/pip-2NZBWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:47:07 INFO - Running setup.py (path:/tmp/pip-nFi8vP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:47:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:47:07 INFO - Running setup.py (path:/tmp/pip-Fg8eZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:47:08 INFO - Running setup.py (path:/tmp/pip-62sulT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:47:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:47:08 INFO - Running setup.py (path:/tmp/pip-9ckfPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:47:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:47:08 INFO - Running setup.py install for manifestparser 16:47:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:47:08 INFO - Running setup.py install for mozcrash 16:47:08 INFO - Running setup.py install for mozdebug 16:47:08 INFO - Running setup.py install for mozdevice 16:47:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:47:08 INFO - Running setup.py install for mozfile 16:47:08 INFO - Running setup.py install for mozhttpd 16:47:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:47:08 INFO - Running setup.py install for mozinfo 16:47:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:47:08 INFO - Running setup.py install for mozInstall 16:47:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:47:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:47:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:47:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:47:08 INFO - Running setup.py install for mozleak 16:47:09 INFO - Running setup.py install for mozlog 16:47:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:47:09 INFO - Running setup.py install for moznetwork 16:47:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:47:09 INFO - Running setup.py install for mozprocess 16:47:09 INFO - Running setup.py install for mozprofile 16:47:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:47:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:47:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:47:09 INFO - Running setup.py install for mozrunner 16:47:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:47:09 INFO - Running setup.py install for mozscreenshot 16:47:09 INFO - Running setup.py install for moztest 16:47:09 INFO - Running setup.py install for mozversion 16:47:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:47:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:47:09 INFO - Cleaning up... 16:47:09 INFO - Return code: 0 16:47:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:47:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:09 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 0x23733b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f0ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ede40>, '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 0x26eefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ef440>, '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': '3836458cccd887f2d2de3cf1000001de-1496015182.286408-1570331901', '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 16:47:09 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 16:47:09 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 16:47:09 INFO - Using env: {'DISPLAY': ':0', 16:47:09 INFO - 'HOME': '/home/cltbld', 16:47:09 INFO - 'LANG': 'en_US.UTF-8', 16:47:09 INFO - 'LANGUAGE': 'en_US:en', 16:47:09 INFO - 'LOGNAME': 'cltbld', 16:47:09 INFO - 'MAIL': '/var/mail/cltbld', 16:47:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:09 INFO - 'MOZ_NO_REMOTE': '1', 16:47:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:09 INFO - 'NO_EM_RESTART': '1', 16:47:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:09 INFO - 'PWD': '/builds/slave/test', 16:47:09 INFO - 'SHELL': '/bin/bash', 16:47:09 INFO - 'SHLVL': '1', 16:47:09 INFO - 'TERM': 'linux', 16:47:09 INFO - 'TMOUT': '86400', 16:47:09 INFO - 'USER': 'cltbld', 16:47:09 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1496015182.286408-1570331901', 16:47:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:09 INFO - '_': '/tools/buildbot/bin/python'} 16:47:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:47:10 INFO - Running setup.py (path:/tmp/pip-XMHazf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:47:10 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)) 16:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:47:10 INFO - Running setup.py (path:/tmp/pip-h9gZgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:47:10 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)) 16:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:47:10 INFO - Running setup.py (path:/tmp/pip-TfYz4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:47:10 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)) 16:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:47:10 INFO - Running setup.py (path:/tmp/pip-sFbjPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:47:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:47:10 INFO - Running setup.py (path:/tmp/pip-JKWYfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:47:10 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)) 16:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:47:10 INFO - Running setup.py (path:/tmp/pip-zfhAPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:47:10 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)) 16:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:47:10 INFO - Running setup.py (path:/tmp/pip-zG7heG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:47:10 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)) 16:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:47:10 INFO - Running setup.py (path:/tmp/pip-dlXTvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:47:10 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)) 16:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:47:10 INFO - Running setup.py (path:/tmp/pip-ZDtrVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:47:10 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)) 16:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:47:10 INFO - Running setup.py (path:/tmp/pip-KiPtIT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:47:10 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)) 16:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:47:10 INFO - Running setup.py (path:/tmp/pip-49kft5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:47:10 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)) 16:47:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:47:10 INFO - Running setup.py (path:/tmp/pip-XU2MGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:47:11 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)) 16:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:47:11 INFO - Running setup.py (path:/tmp/pip-cJAY1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:47:11 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)) 16:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:47:11 INFO - Running setup.py (path:/tmp/pip-dnHaUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:47:11 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)) 16:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:47:11 INFO - Running setup.py (path:/tmp/pip-FfEpwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:47:11 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)) 16:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:47:11 INFO - Running setup.py (path:/tmp/pip-fuJOFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:47:11 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)) 16:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:47:11 INFO - Running setup.py (path:/tmp/pip-y4sRSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:47:11 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)) 16:47:11 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)) 16:47:11 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)) 16:47:11 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)) 16:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:47:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:47:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:47:11 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 16:47:11 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 16:47:11 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 16:47:11 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 16:47:12 INFO - Downloading blessings-1.6.tar.gz 16:47:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:47:12 INFO - Installing collected packages: blessings 16:47:12 INFO - Running setup.py install for blessings 16:47:12 INFO - Successfully installed blessings 16:47:12 INFO - Cleaning up... 16:47:12 INFO - Return code: 0 16:47:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:47:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:47:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:47:12 INFO - Reading from file tmpfile_stdout 16:47:12 INFO - Current package versions: 16:47:12 INFO - argparse == 1.2.1 16:47:12 INFO - blessings == 1.6 16:47:12 INFO - blobuploader == 1.2.4 16:47:12 INFO - docopt == 0.6.1 16:47:12 INFO - functools32 == 3.2.3-2 16:47:12 INFO - jsonschema == 2.5.1 16:47:12 INFO - manifestparser == 1.1 16:47:12 INFO - mozInstall == 1.12 16:47:12 INFO - mozcrash == 1.0 16:47:12 INFO - mozdebug == 0.1 16:47:12 INFO - mozdevice == 0.51 16:47:12 INFO - mozfile == 1.2 16:47:12 INFO - mozhttpd == 0.7 16:47:12 INFO - mozinfo == 0.9 16:47:12 INFO - mozleak == 0.1 16:47:12 INFO - mozlog == 3.4 16:47:12 INFO - moznetwork == 0.27 16:47:12 INFO - mozprocess == 0.25 16:47:12 INFO - mozprofile == 0.28 16:47:12 INFO - mozrunner == 6.13 16:47:12 INFO - mozscreenshot == 0.1 16:47:12 INFO - mozsystemmonitor == 0.3 16:47:12 INFO - moztest == 0.8 16:47:12 INFO - mozversion == 1.4 16:47:12 INFO - psutil == 3.1.1 16:47:12 INFO - requests == 1.2.3 16:47:12 INFO - wsgiref == 0.1.2 16:47:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:47:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:12 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 0x23733b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f0ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ede40>, '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 0x26eefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ef440>, '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': '3836458cccd887f2d2de3cf1000001de-1496015182.286408-1570331901', '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 16:47:12 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 16:47:12 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 16:47:12 INFO - Using env: {'DISPLAY': ':0', 16:47:12 INFO - 'HOME': '/home/cltbld', 16:47:12 INFO - 'LANG': 'en_US.UTF-8', 16:47:12 INFO - 'LANGUAGE': 'en_US:en', 16:47:12 INFO - 'LOGNAME': 'cltbld', 16:47:12 INFO - 'MAIL': '/var/mail/cltbld', 16:47:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:12 INFO - 'MOZ_NO_REMOTE': '1', 16:47:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:12 INFO - 'NO_EM_RESTART': '1', 16:47:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:12 INFO - 'PWD': '/builds/slave/test', 16:47:12 INFO - 'SHELL': '/bin/bash', 16:47:12 INFO - 'SHLVL': '1', 16:47:12 INFO - 'TERM': 'linux', 16:47:12 INFO - 'TMOUT': '86400', 16:47:12 INFO - 'USER': 'cltbld', 16:47:12 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1496015182.286408-1570331901', 16:47:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:12 INFO - '_': '/tools/buildbot/bin/python'} 16:47:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:13 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)) 16:47:13 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)) 16:47:13 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)) 16:47:13 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)) 16:47:13 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)) 16:47:13 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)) 16:47:13 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)) 16:47:13 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)) 16:47:13 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)) 16:47:13 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:47:13 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 16:47:13 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 16:47:13 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 16:47:13 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 16:47:14 INFO - Downloading marionette_driver-1.4.0.tar.gz 16:47:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 16:47:14 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)) 16:47:14 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)) 16:47:14 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)) 16:47:14 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)) 16:47:14 INFO - Installing collected packages: marionette-driver 16:47:14 INFO - Running setup.py install for marionette-driver 16:47:14 INFO - Successfully installed marionette-driver 16:47:14 INFO - Cleaning up... 16:47:14 INFO - Return code: 0 16:47:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:47:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:47:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23733b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f0ef0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26ede40>, '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 0x26eefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ef440>, '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': '3836458cccd887f2d2de3cf1000001de-1496015182.286408-1570331901', '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 16:47:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:47:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:47:14 INFO - Using env: {'DISPLAY': ':0', 16:47:14 INFO - 'HOME': '/home/cltbld', 16:47:14 INFO - 'LANG': 'en_US.UTF-8', 16:47:14 INFO - 'LANGUAGE': 'en_US:en', 16:47:14 INFO - 'LOGNAME': 'cltbld', 16:47:14 INFO - 'MAIL': '/var/mail/cltbld', 16:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:14 INFO - 'MOZ_NO_REMOTE': '1', 16:47:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:14 INFO - 'NO_EM_RESTART': '1', 16:47:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:14 INFO - 'PWD': '/builds/slave/test', 16:47:14 INFO - 'SHELL': '/bin/bash', 16:47:14 INFO - 'SHLVL': '1', 16:47:14 INFO - 'TERM': 'linux', 16:47:14 INFO - 'TMOUT': '86400', 16:47:14 INFO - 'USER': 'cltbld', 16:47:14 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1496015182.286408-1570331901', 16:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:14 INFO - '_': '/tools/buildbot/bin/python'} 16:47:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:47:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:47:14 INFO - Cleaning up... 16:47:14 INFO - Return code: 0 16:47:14 INFO - Running post-action listener: _resource_record_post_action 16:47:14 INFO - Running post-action listener: _start_resource_monitoring 16:47:14 INFO - Starting resource monitoring. 16:47:14 INFO - [mozharness: 2017-05-28 23:47:14.762811Z] Finished create-virtualenv step (success) 16:47:14 INFO - [mozharness: 2017-05-28 23:47:14.763329Z] Running install step. 16:47:14 INFO - Running pre-action listener: _resource_record_pre_action 16:47:14 INFO - Running main action method: install 16:47:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:47:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:47:14 INFO - Reading from file tmpfile_stdout 16:47:14 INFO - Detecting whether we're running mozinstall >=1.0... 16:47:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:47:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:47:15 INFO - Reading from file tmpfile_stdout 16:47:15 INFO - Output received: 16:47:15 INFO - Usage: mozinstall [options] installer 16:47:15 INFO - Options: 16:47:15 INFO - -h, --help show this help message and exit 16:47:15 INFO - -d DEST, --destination=DEST 16:47:15 INFO - Directory to install application into. [default: 16:47:15 INFO - "/builds/slave/test"] 16:47:15 INFO - --app=APP Application being installed. [default: firefox] 16:47:15 INFO - mkdir: /builds/slave/test/build/application 16:47:15 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'] 16:47:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:47:31 INFO - Reading from file tmpfile_stdout 16:47:31 INFO - Output received: 16:47:31 INFO - /builds/slave/test/build/application/firefox/firefox 16:47:31 INFO - Running post-action listener: _resource_record_post_action 16:47:31 INFO - [mozharness: 2017-05-28 23:47:31.085259Z] Finished install step (success) 16:47:31 INFO - [mozharness: 2017-05-28 23:47:31.085415Z] Running setup-mitmproxy step. 16:47:31 INFO - Running pre-action listener: _resource_record_pre_action 16:47:31 INFO - Running main action method: setup_mitmproxy 16:47:31 INFO - Skipping: mitmproxy is not required 16:47:31 INFO - Running post-action listener: _resource_record_post_action 16:47:31 INFO - [mozharness: 2017-05-28 23:47:31.086539Z] Finished setup-mitmproxy step (success) 16:47:31 INFO - [mozharness: 2017-05-28 23:47:31.086757Z] Running run-tests step. 16:47:31 INFO - Running pre-action listener: _resource_record_pre_action 16:47:31 INFO - Running main action method: run_tests 16:47:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:47:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:47:31 INFO - Python 2.7.3 16:47:31 INFO - Return code: 0 16:47:31 INFO - grabbing minidump binary from tooltool 16:47:31 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')]} 16:47:31 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 0x26ede40>, '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 0x26eefb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26ef440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:47:31 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 16:47:31 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 16:47:31 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 16:47:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:47:31 INFO - Return code: 0 16:47:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:47:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:47:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:47:31 INFO - ENV: RUST_BACKTRACE is now 1 16:47:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:47:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:47:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 16:47:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 16:47:31 INFO - Using env: {'DISPLAY': ':0', 16:47:31 INFO - 'HOME': '/home/cltbld', 16:47:31 INFO - 'LANG': 'en_US.UTF-8', 16:47:31 INFO - 'LANGUAGE': 'en_US:en', 16:47:31 INFO - 'LOGNAME': 'cltbld', 16:47:31 INFO - 'MAIL': '/var/mail/cltbld', 16:47:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:47:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:47:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:47:31 INFO - 'MOZ_NO_REMOTE': '1', 16:47:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:47:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:47:31 INFO - 'NO_EM_RESTART': '1', 16:47:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:47:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:47:31 INFO - 'PWD': '/builds/slave/test', 16:47:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:47:31 INFO - 'RUST_BACKTRACE': '1', 16:47:31 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:47:31 INFO - 'SHELL': '/bin/bash', 16:47:31 INFO - 'SHLVL': '1', 16:47:31 INFO - 'TERM': 'linux', 16:47:31 INFO - 'TMOUT': '86400', 16:47:31 INFO - 'USER': 'cltbld', 16:47:31 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1496015182.286408-1570331901', 16:47:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:47:31 INFO - '_': '/tools/buildbot/bin/python'} 16:47:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 16:47:31 INFO - mozversion application_buildid: 20170528224948 16:47:31 INFO - mozversion application_changeset: 51d220b260d8d52a41b65aae2c5d74be99c2d59e 16:47:31 INFO - mozversion application_display_name: Nightly 16:47:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:47:31 INFO - mozversion application_name: Firefox 16:47:31 INFO - mozversion application_remotingname: firefox 16:47:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:47:31 INFO - mozversion application_vendor: Mozilla 16:47:31 INFO - mozversion application_version: 55.0a1 16:47:31 INFO - mozversion platform_buildid: 20170528224948 16:47:31 INFO - mozversion platform_changeset: 51d220b260d8d52a41b65aae2c5d74be99c2d59e 16:47:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:47:31 INFO - mozversion platform_version: 55.0a1 16:47:31 INFO - using testdate: 1496015251 16:47:31 INFO - actual date: 1496015251 16:47:31 INFO - starting webserver on 'localhost:42800' 16:47:31 INFO - SUITE-START | Running 2 tests 16:47:31 INFO - TEST-START | dromaeo_css 16:47:31 INFO - operating with platform_type : linux_ 16:47:31 INFO - Initialising browser for dromaeo_css test... 16:47:31 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42800/getInfo.html -profile /tmp/tmpaRw3vB/profile 16:47:31 INFO - TEST-INFO | started process 7365 (/builds/slave/test/build/application/firefox/firefox http://localhost:42800/getInfo.html) 16:48:06 INFO - TEST-INFO | 7365: killed by SIGTERM 16:48:06 INFO - Browser initialized. 16:48:06 INFO - Running cycle 1/1 for dromaeo_css test... 16:48:06 INFO - TEST-INFO | started process 7589 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaRw3vB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:48:18 INFO - PID 7589 | RSS: Main: 187084800 16:48:18 INFO - PID 7589 | 16:51:23 INFO - PID 7589 | Cycle 1(1): loaded http://localhost:42800/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42800/tests/dromaeo/cssquery-ext.html) 16:51:25 INFO - PID 7589 | RSS: Main: 182255616 16:51:25 INFO - PID 7589 | 16:54:27 INFO - PID 7589 | Cycle 1(1): loaded http://localhost:42800/tests/dromaeo/cssquery-ext.html (next: http://localhost:42800/tests/dromaeo/cssquery-jquery.html) 16:54:27 INFO - PID 7589 | RSS: Main: 187744256 16:54:27 INFO - PID 7589 | 16:57:29 INFO - PID 7589 | Cycle 1(1): loaded http://localhost:42800/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42800/tests/dromaeo/cssquery-mootools.html) 16:57:30 INFO - PID 7589 | RSS: Main: 185552896 16:57:30 INFO - PID 7589 | 17:00:32 INFO - PID 7589 | Cycle 1(1): loaded http://localhost:42800/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42800/tests/dromaeo/cssquery-prototype.html) 17:00:32 INFO - PID 7589 | RSS: Main: 189722624 17:00:32 INFO - PID 7589 | 17:03:35 INFO - PID 7589 | Cycle 1(1): loaded http://localhost:42800/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42800/tests/dromaeo/cssquery-yui.html) 17:03:36 INFO - PID 7589 | RSS: Main: 188194816 17:03:36 INFO - PID 7589 | 17:06:37 INFO - PID 7589 | Cycle 1(1): loaded http://localhost:42800/tests/dromaeo/cssquery-yui.html (next: http://localhost:42800/tests/dromaeo/cssquery-dojo.html) 17:06:38 INFO - PID 7589 | RSS: Main: 185958400 17:06:38 INFO - PID 7589 | 17:06:38 INFO - PID 7589 | __start_tp_report 17:06:38 INFO - PID 7589 | _x_x_mozilla_page_load 17:06:38 INFO - PID 7589 | _x_x_mozilla_page_load_details 17:06:38 INFO - PID 7589 | |i|pagename|runs| 17:06:38 INFO - PID 7589 | |0;dojo.html;2743.163335182769;2769.543025400809;2781.1378472673473;2784.8189867658602;2808.9016884409048;5092.898142037157;5198.766055527501;5214.243934629481;5262.81580144695;5281.260623512707;5082.567981721549;5151.922721159186;5168.896622067566;5233.633645644806;5245.10833158363;4643.489216186217;4644;4671.299305104245;4674.11191873543;4718.716876987374;4634.374359461463;4673.83641572545;4730.574248317651;4748.762561871893;4778.426588809348;4612.192866248427;4662.6269898408045;4677.695949763289;4733.668643194977;4742.478327383985;4607.815687372501;4688.273317635738;4689.273162659793;4719;4735.83424580138;4615.5845973862515;4631.1895418301665;4639.652026098022;4645.581897629229;4696.9530304696855;5073.213651883964;5148.073346797575;5195.428502864682;5196.376434827807;5202.531772140488;5566.721663916828;5587.972060139714;5592.4407559244155;5693.003724348223;5705.400932902027;5684.459976302286;5708.257926469574;5742.770289188427;5754.4533269339345;5768;5282.867928301785;5297.364316282071;5298.788048478018;5300.390455097636;5302.257683924254;5635.1828984796975;5714.228579141846;5821.941780582225;5822.071287010384;5892.440218179266;5476.808311709071;5528.75120619573;5577.9163312550345;5620.072688006433;5622.746976385991;5580.776768929279;5677.261955945701;5679.971600142056;5680.943190568124;5692.6015178937905;5473.917891231635;5629.155626656035;5645.125005624135;5646.265985421869;5649.0396632572565;5458.099413596712;5537.141743029756;5597.412271711493;5612.07400778875;5627.831165064973;4608.746518941423;4612.146752850666;4620.653450991122;4628.0281140960105;4653.674242803039;3982.2234664240773;3989.082511022481;3994.660453861396;4022.8390864365683;4053.9594604054173;4614;4673.205555055649;4700.929486057712;4726.550977657117;4740.715557066587;5660.462256085665;5665.12190610456;5683.318001839806;5696.3449203341315;5707.828765137053;4749.26386410107;4753.738544380092;4756.571908528249;4757.643176761757;4797.136515427256;4783.306420568998;4842.878928026898;4857.344258525195;4946.282788995575;4952.133376659071;5264.210368444764;5287.180487024518;5292.285541451854;5305.495977882095;5309.203619457112;5535.975844468786;5587.497125258747;5590.636608620427;5591.4688104629995;5630.831075067755;5270.393904701008;5319.46805319465;5349.384820745664;5361.383440904346;5362.3833259174135;5442.183672449006;5611.410801865745;5623.044082505902;5626.240457538343;5626.409227031267;5602.047651899105;5692.117721753135;5701.087825947829;5724.341700704473;5740.512056475246;5512.3385193777;5513.779448822002;5527.5577953764405;5540.252065971043;5556.222128902038;5489.752961116839;5493.752781124939;5496.450354964471;5503.009458297384;5527.226188333556;5293.867653308698;5340.519353258225;5361.195820626937;5369.838904832861;5452.536534394462;5515.779368825362;5517.944820551743;5558.499735023867;5563.332400112013;5564.638298510584;5352.116900711495;5354.866128346823;5357;5360.597955153457;5370.650907690988 17:06:38 INFO - PID 7589 | |1;ext.html;723.8009547374471;743.7248218159281;1061.3631820907456;1078.3529882070754;1158.2760774515928;31420.214494637617;31877.521837172433;32356.514652280206;32382.676173238262;32490.512642310383;30266.546001809937;30347.813479584656;30375;30456.695433045665;30612.387752245;6435.517336199792;6599.142111525495;6606.14120164378;6806.285340039299;6810.897836532456;6703.597784132968;6787.660616969157;6787.9321206788045;6801.829954251134;6818.795436136899;6748;6796.864062718742;6809.557378770389;6823.454123670094;6826.48801339899;6754.324567543231;6787.626680532569;6792.524523283397;6792.694328755218;6797.1843378794365;6674.966625166843;6703.1285932828905;6709.959956206796;6712.731490740364;6719.2944740802;30648;30680.69319306823;30696.693033069605;30706.38587228265;30807.537886931714;2942.926426839325;2962.918534734806;2966.1842993176833;2982.746466550324;2988.656304524986;23852.52294954091;23864.64203036956;23884.28347149571;24005;24009.519809603884;3003.6695963444004;3054.9847250763605;3055.618047744032;3059.03640353288;3110.5178697301953;148995.2550237242;149835;150101;150110;150375.24812375978;30674.233144171576;31018.379632407225;37011.259774804894;37486.25027499489;38825;39101.6089839098;39174;39288.41067383991;39319;39399.80300098481;11755.05959523236;11841.289522628498;11850.76298474043;11859.288442693465;11891;9253.814923701488;9268.212201962773;9304.395214311047;9346.626134954662;9425.2931030173;12070.672226055127;12145;12178.878211217952;12183.02535797134;12328.19866708679;4979.875503112378;5045.318881950963;5051.217061355495;5197.090509160882;5238.135707608202;838.5094719589109;862.3661608717588;877.8419884420865;886.4902680958346;905.3119629081945;19960.401187964384;20329.288474903602;20754.169833206804;21055;21183.576328473344;923.3721069672687;936.2322895225849;960.9759756006156;961.5769061613008;964.6816550538306;10609.787804244026;10852.348859068481;10889.183311251687;10952.890471095187;11140.164487663458;173207;174261;174606;174625;175211;37839.81080094637;37880.242395151945;38314.42528362077;38334.6166538331;38447;1155.5782139519183;1191.9106067045007;1195.988040119605;1198.3888217009387;1199.424276347358;19139.712904306725;19587;20394.08226629835;20485.59028819445;20636.380908572766;28755.5686664696;28830.855845720638;28865.134045978655;29013.85493072521;29069.709302907548;148248;149140;149154;149483;150022;22510.437239069153;22939.541209176055;24927.252182434557;27266.318342041606;27400.725992740616;29047.12858614245;29656;29725.405491889607;29790.702092978794;30112.54831177578;23218.3034508965;23322;23467.64798527989;23788.405289867893;23947.16184933519;23572.174973875834;23633.40916477102;23788.405289867893;24195;24372.903219354816;25669.871650641628;26013;26039.479210416066;26042;26190.34524136912;22137.65045762959;23112.30663080043;23114.53770924606;23208.3037508875;23489.295321140395;18430.35493757712;19613.50966225856;19623.803761962197;19740.210391584176;19741.804973567552 17:06:38 INFO - PID 7589 | |2;jquery.html;406.7579790024934;410.4458980376492;414.48810718762326;426.88687497813083;427.07538179840645;12371.13402061856;12378.257304561732;16844.74732879008;17563.47309580713;17690.3808366707;12936.611901642966;17674.11629418527;17867.463976080708;17906.910465447654;17932.37236696716;5363.865903352408;5623.690697011662;5632.04255276604;5634.746436410372;5640.210370548127;5062.493750624926;5283.603729720267;5366.356037275533;5451.291332126838;5463.180522921554;5278.630495865291;5280.788768449276;5289.735513224343;5290.2064690296575;5301.0988132017455;5105;5258.421573626898;5276.12943864262;5278.894422111555;5289.576833853302;4734.384530011111;4739;4754.833580824689;4755.334253204554;4769.499202583748;22119.225827095976;22338.21816236424;22403.32790016302;22478.88760556203;22621.773782262295;1623.9512814615462;1641.7783599214072;1679.8824082314243;1683.0743091299857;1684.174754370362;14401.495947641886;14555.854441455556;14721.263936803223;14825;14829.77755333671;2005.1979208316643;2061.742282214723;2092.79072092791;2099.496120930981;2113.5350222950924;91580;94890.52554737251;95583;95863.52068239613;99215;10680.305780124267;10742.677719668422;10871.728206794893;11175.608853690082;11349.375784331776;14742.125285569211;15367.385304587691;15406.614834629225;15424.151671657943;15446.768298475532;7439.628018599048;7442.627868606548;7534.397248220239;7607.505512141693;7645.732399365996;6849.726010959605;6862.044317369526;6980;7003.614801185881;7011.6844741985715;6844.247132815386;6916.965415172993;6954.9304506955295;6993.790186294419;7007.369336759716;1987.2647120565484;2024.6962955556785;2024.7064175694443;2039.836813054952;2206.6579680149603;738.3023043224209;799.8881554639056;840.3193413335218;842.6671464771381;852;16618.169091545373;16855.83144168567;16864.494065178063;16930.238139283763;17459.30162793474;849.6558893648082;850.6129710981612;856.6830272799104;859.3468963587718;860.595520105562;9132.086791320815;9178.357514973888;9358.204552612968;9436.150746432853;9450.385724927857;366088;371329;373079;373873;374724;79254;79548.60225698835;79950.60024699956;83627;85600.57199713962;1039.153090231459;1040.8855025947291;1083.6803143072812;1090.8636420447444;1093.9179561532917;17137;17514.036727979576;17903.283868645107;18117.637647247244;18477.260909563465;41489.170216594895;41705.58294417139;42724.1455170901;42818;43488.13023739444;51514;51989;52804.73597632141;53005.7349713249;53283.46716532785;8397.244248017463;8401.537915414467;8428.325733941392;8646.740597782076;8868.049029213562;12750.553730619384;12776.169548979287;13026;13104.148230364995;13190.340482976006;10982.835257471304;11102.222844400814;11217.439128043728;11343.092552595608;11750.58872939443;10280.485975701335;10500.894991050298;10635.680929572125;10643.095336896451;10660.307080039773;11019.393933333744;11189.216754827085;11292.15308851823;11339.206255562032;11447.427628618703;8112.432129751097;8193.631286592237;8282.17178282191;8327.375446841632;8364.205400486944;11079.446027698745;11080.778384432428;11151.776964460827;11212.775744484901;11458.08335333188 17:06:38 INFO - PID 7589 | |3;mootools.html;1211.1219365959678;1248.282237713315;1261.5143169879593;1268.0679700420196;1274.4201388368294;9817.607295708172;10190.59237630494;10251.33366331188;10287.794244115123;10536.473176341191;10236.590536378555;10459.110975567086;10459.68620941371;10477.8428323575;10485.633002844901;2145.731783527059;2186.9890650546727;2193.649016157407;2198.2416066457045;2208.182972300251;2103.0746471552543;2134.5410736691606;2136.113512892148;2146.066461089431;2160.8487405881597;2028.3914825552276;2060.1450398084776;2062.16482324658;2065.865718728285;2071;2042.714020037196;2042.8467864910042;2044.7239622650975;2052.220156340596;2055.732754741874;1847.1687740516686;1905.8380037696813;1983.1274239334646;2061.8247448966854;2067.24545540878;10079.5464204111;10150.847737283946;10150.847737283946;10157.949210253975;10168.745781355452;5306.3632364116165;5524.751386187631;5525.751341189616;5530.253415788858;5532.3914369419335;3198.712115909579;3288.2108294009267;3344.8996530104137;3347.2134048498583;3358.177246574605;1100.6532942123285;1108.0802933565121;1112.777444511101;1113.9275947063416;1135.9204855660107;14911.254437278201;15213.239338033165;15217;15217.695646087017;15223.695526089416;4417.271150260171;4489.393931819228;4593.425821772278;4627.537246275346;4671.719696818202;10713.410762407986;10742.838857417146;10764.515596798163;10771.084457821016;10802;5240.423553409122;5362.812301569426;5377.677339359651;5397.946020539823;5407.270018547446;4944.406671199479;4989.476105008922;5011.949880501221;5012.398512178562;5017.172166592544;3877.43777152317;3896.08442016126;3925.4111883217174;3960.7029472789654;4005.0387906902133;1122.8708698499777;1130.5534313945946;1142.1662186603826;1151.3207207747469;1161.2045748662194;651.5146216068964;669.334012657409;680.1566058087935;685.1333063674456;696.9581825090511;5032.270320803463;5062.215356619729;5118.488151184852;5251.0548101341365;5699.629524080921;809.995950020258;815.152241668658;822.2558584481054;827.1728271728272;845.7209120990182;3273.2798784267425;3406.267652454734;3453.1367158210446;3468.0809585459874;3600;13290.800637990438;13543.661408464866;13904.51334203298;13925.303734813218;13963.441462341392;13474;13535.05254632186;13558.661033474242;13774.862251377559;13913.930430347986;7116.608586527687;7545.471816972759;7622.199669034782;7693.4614576979075;7790.220977902278;5604.439556044363;5628.915566266427;5646.971765141148;5662.235598194191;5920.526357891445;11906.166568340133;12012.459439325077;12021.158518903943;12027.158098933342;12056.63830085099;12279.386030698608;12370.505179792708;12415.193012454161;12603;12636.810447843105;7976;8315.251627353568;8340.332773378237;8349.624266908126;8380.790480238044;9517.095875891779;9630.759231019001;9643.855342170013;9676.322657414195;9685.661001865183;7774.339181169437;7862.213778622092;7965.362770978424;7975.162607926084;8172.591370431336;7792.493487923267;7805.684693114708;7846;7951.840963180588;8134.389920755849;7057.7176912922905;7206.171290301682;7207.783766486804;7208.819779505554;7216.494845360774;4714.717116972993;4757.548032936866;4764.547368000173;4800.591949684176;4871.95128048715;4888.169011268022;4912.48418916023;4935.432425271139;4946.3817022872145;4967.503249675004 17:06:38 INFO - PID 7589 | |4;prototype.html;354.27727436030494;368.966792988631;377.86208034067556;381.8377189694379;385.28914153387007;5439.619226654136;5444.183372494128;5450.345958484977;5451.2640793492865;5470.234167216588;5086.389633244006;5354.678719276846;5361.892762144755;5362.624616276862;5371.140617501201;3983.5659162701404;4020.5778393268724;4020.9798951005205;4026.6376026157714;4030.1133750574827;4019.9900049975013;4039.353703407455;4045.1707399982934;4048.9595104049026;4074.9185016299803;3962.2273656636967;3962.5046869141356;3995.2009598080353;4009.498812648419;4021.3364794808967;3936.724429289951;3975.5428125765616;3980.960190398088;4009.959900400988;4020.7989600520004;3469.1673998240494;3480.773749706261;3482.199094208346;3488.6511348865165;3496.580410350749;5150.141671372387;5181.559567436772;5193.324867767204;5201.817936372247;5220;4565.493387182222;4726.692764970266;4727.598154156901;4751.263554149113;4774.618030557547;5623.634463759842;5652.74562644682;5652.886942261173;5661.433856614306;5670.206171136044;3988.8005599720186;4004.2592120457807;4004.4994375703036;4005.73962692427;4012.3981402789814;5898.380670029628;5968.1803645666805;5985.760569577255;6009.338972712998;6060.333363329986;4081.8774237396983;4086.1827634473225;4089.734167279117;4093.97953010239;4098.323776576832;4128.174365126986;4137.81379837908;4141.109661422808;4144.626983571493;4157.937630935538;4559.635229181657;4755.548222918817;4773.856784296477;4784.521547845187;4797.904041919142;5724.3130824300515;5775.537956963432;5777.104548794943;5780.913286300624;5796.710164491758;1412.1527083749668;1422.6372275069791;1424.7150569885857;1430.9499167529086;1432.8208973878266;939.572494514994;958.2142643032646;972.5720682899642;976.1117383181271;983.7688143286322;4943.653944223942;4949.529794669501;4951.192814622636;4978;4978.701277923336;5878.441548052928;5905.970470147708;5929.851753706192;5942.64344139353;5949.583529153005;4802.975985120122;4822.614190864722;4829;4901.803927842846;4973.701577905337;3056.801307914978;3101.3332133591384;3105.1305634422397;3106.819408624753;3123.5002399616405;5480.766827463789;5503.9174412383845;5511;5541.667499950016;5573.470520300565;5837.795677151279;6004.819855404345;6024.849378765478;6035.305939816977;6041.607295525777;5512.862178445571;5516.227728118067;5547.306586676666;5551.666899985933;5556.555475561945;5877.000909845251;5892.175095486721;5913.319968203712;5913.58604897653;5923.378045305181;5565.38780734127;5753.539716822561;5807.245058142584;5828.125781132864;5828.854278643068;5538.806141785019;5539.695316757617;5558;5576.275084239023;5590.440955904377;4017.2568074906235;4045.1707399982342;4074.144429669684;4078.9796051019557;4107.096438783463;5940.495057920125;5961.105834124916;5967.6419414835245;5995.5803093783015;6028.608140470856;5755.53955683536;5768.221290125779;5769.259601689164;5769.394213607511;5812.854678633068;5481.068218402801;5746.620811005412;5748.48263656273;5748.626339287933;5778.613132848171;5658.236138121301;5660.462256085665;5673.404292549223;5674.226639284994;5681.204631351531;5684.403137670485;5817.301923769175;5819.185314055951;5827.650340979555;5834.416558344132;5591.4688104629995;5591.720413979204;5596.720163991703;5601.579881508822;5629.521490673339 17:06:38 INFO - PID 7589 | |5;yui.html;665.8202285382947;666.7699643622948;707.7628994286914;711.1466240511386;722.7651013420638;12502.937485312572;12791.552295669653;12806.039547033975;13181.736365272689;14854;15721.13533755643;15975.520734377958;15984.280707368167;16015.599610009756;16029.438969636065;743.0266351080089;753.3069575990103;759.5632511306021;759.7644730133676;759.9506032107923;743.1602289412956;777.0752804163028;779.7270955165703;781.820181358288;788.8422315536886;822.2394285286116;824.0811495182858;824.2169938558363;825.4263287015526;826.396730386815;824.8968878890139;827.1893544326593;827.4001349021971;828.130463013833;828.1883753921161;599.865030368168;600.8437806170383;604.6493034040246;605.8364241654729;606.9787557435512;14137.505187318497;14448.783268250985;14454.205018723966;14475.98668093234;14500.347484363228;15332.463363782213;15973.600659983476;16108.194590270557;16116.355345786154;16138.677226455406;12488.625341239778;12668.493260269579;12886.484540618365;12987.155834870704;13003;3030.848457577112;3052.6336839579394;3058.021433141396;3061.6172978377704;3064.6169228846393;77861.22138778596;80078.59960700218;80210;80816.59591702063;80886.59556702238;12601;12696.174748641493;12839.358032098544;12852.614421567368;12878.227306361461;21138.788612113683;21347.893260533598;21712.240071597418;21840.672389914165;22215.22246721357;6409.903851442139;6616.933830661632;6625.17185351831;6646;6646.734130634817;2955;3073.9077827665205;3080.5687203791485;3101.58128652629;3172.888948886778;3464.6188919218866;3551.3252482028333;3572.7141828653644;3572.732045096628;3589.5692516897616;706.4060383201024;719.8380364418069;728.8979542864004;731.5391303478774;732.5128789355126;573.280532931177;586.2408181405091;601.8254706135172;612.574260888687;617.7745123030062;9567;9596.9040309596;9971.102600765966;9972.351797133308;10443.268971171945;525.8869343091177;534.9063913815066;544.6133245395735;552.5027475272287;558.7150553217888;4299.828006879752;4389.868303950887;4481.484629267611;4494;4579.95420045802;85034.57482712671;85289;86874;87064.56467717748;87119.56440217758;74980.62509687526;75546.24453755502;76306.23693763102;77051.22948770552;77357;65344;67318.99021514681;67564.6621766888;68480.6575967117;68831.65584172147;8864.512451814953;8925.9645464024;8986.460812351279;9189.724308270495;9259.814803703754;28838.42323153567;29899.103026909226;30026.849865751406;30942.22644433907;31289.68710312959;37262;37546;37608.623913760515;38277.23445531018;38396.232075358894;11452.65642030707;11459.507785531378;11655.766884662089;11739.765204696028;11859.288442693465;12146.939265303618;12310.569130080405;12440.19138755978;12584.05619578517;12697.301648409057;12686.365681715693;12832.55086071983;13019.934900325437;13136.60590182296;13217.933910330386;12623.179493332904;13021.804672929724;13105.427348718214;13140.868591313965;13370.398332074885;11761.235519691192;12055.81916271239;12082.516699331929;12215.572454964034;12227.816582751444;8903.243224326005;9099.863502047607;9255.25957923378;9263.814723705624;9457.763555911157;9458.101480359355;9585.233181345615;9602.32783705134;9608.9039109608;10393.324433911772 17:06:38 INFO - PID 7589 | __end_tp_report 17:06:38 INFO - PID 7589 | __start_cc_report 17:06:38 INFO - PID 7589 | _x_x_mozilla_cycle_collect,384 17:06:38 INFO - PID 7589 | __end_cc_report 17:06:38 INFO - PID 7589 | __startTimestamp1496016398136__endTimestamp 17:06:38 INFO - PID 7589 | 17:06:38 INFO - PID 7589 | ------- Summary: start ------- 17:06:38 INFO - PID 7589 | Number of tests: 6 17:06:38 INFO - PID 7589 | 17:06:38 INFO - PID 7589 | [#0] dojo.html Cycles:165 Average:5151.56 Median:5319.47 stddev:608.48 (11.4%) stddev-sans-first:580.27 17:06:38 INFO - PID 7589 | Values: 2743.2 2769.5 2781.1 2784.8 2808.9 5092.9 5198.8 5214.2 5262.8 5281.3 5082.6 5151.9 5168.9 5233.6 5245.1 4643.5 4644.0 4671.3 4674.1 4718.7 4634.4 4673.8 4730.6 4748.8 4778.4 4612.2 4662.6 4677.7 4733.7 4742.5 4607.8 4688.3 4689.3 4719.0 4735.8 4615.6 4631.2 4639.7 4645.6 4697.0 5073.2 5148.1 5195.4 5196.4 5202.5 5566.7 5588.0 5592.4 5693.0 5705.4 5684.5 5708.3 5742.8 5754.5 5768.0 5282.9 5297.4 5298.8 5300.4 5302.3 5635.2 5714.2 5821.9 5822.1 5892.4 5476.8 5528.8 5577.9 5620.1 5622.7 5580.8 5677.3 5680.0 5680.9 5692.6 5473.9 5629.2 5645.1 5646.3 5649.0 5458.1 5537.1 5597.4 5612.1 5627.8 4608.7 4612.1 4620.7 4628.0 4653.7 3982.2 3989.1 3994.7 4022.8 4054.0 4614.0 4673.2 4700.9 4726.6 4740.7 5660.5 5665.1 5683.3 5696.3 5707.8 4749.3 4753.7 4756.6 4757.6 4797.1 4783.3 4842.9 4857.3 4946.3 4952.1 5264.2 5287.2 5292.3 5305.5 5309.2 5536.0 5587.5 5590.6 5591.5 5630.8 5270.4 5319.5 5349.4 5361.4 5362.4 5442.2 5611.4 5623.0 5626.2 5626.4 5602.0 5692.1 5701.1 5724.3 5740.5 5512.3 5513.8 5527.6 5540.3 5556.2 5489.8 5493.8 5496.5 5503.0 5527.2 5293.9 5340.5 5361.2 5369.8 5452.5 5515.8 5517.9 5558.5 5563.3 5564.6 5352.1 5354.9 5357.0 5360.6 5370.7 17:06:38 INFO - PID 7589 | 17:06:38 INFO - PID 7589 | [#1] ext.html Cycles:180 Average:28785.29 Median:16309.46 stddev:40825.64 (250.3%) stddev-sans-first:40885.80 17:06:38 INFO - PID 7589 | Values: 723.8 743.7 1061.4 1078.4 1158.3 31420.2 31877.5 32356.5 32382.7 32490.5 30266.5 30347.8 30375.0 30456.7 30612.4 6435.5 6599.1 6606.1 6806.3 6810.9 6703.6 6787.7 6787.9 6801.8 6818.8 6748.0 6796.9 6809.6 6823.5 6826.5 6754.3 6787.6 6792.5 6792.7 6797.2 6675.0 6703.1 6710.0 6712.7 6719.3 30648.0 30680.7 30696.7 30706.4 30807.5 2942.9 2962.9 2966.2 2982.7 2988.7 23852.5 23864.6 23884.3 24005.0 24009.5 3003.7 3055.0 3055.6 3059.0 3110.5 148995.3 149835.0 150101.0 150110.0 150375.2 30674.2 31018.4 37011.3 37486.3 38825.0 39101.6 39174.0 39288.4 39319.0 39399.8 11755.1 11841.3 11850.8 11859.3 11891.0 9253.8 9268.2 9304.4 9346.6 9425.3 12070.7 12145.0 12178.9 12183.0 12328.2 4979.9 5045.3 5051.2 5197.1 5238.1 838.5 862.4 877.8 886.5 905.3 19960.4 20329.3 20754.2 21055.0 21183.6 923.4 936.2 961.0 961.6 964.7 10609.8 10852.3 10889.2 10952.9 11140.2 173207.0 174261.0 174606.0 174625.0 175211.0 37839.8 37880.2 38314.4 38334.6 38447.0 1155.6 1191.9 1196.0 1198.4 1199.4 19139.7 19587.0 20394.1 20485.6 20636.4 28755.6 28830.9 28865.1 29013.9 29069.7 148248.0 149140.0 149154.0 149483.0 150022.0 22510.4 22939.5 24927.3 27266.3 27400.7 29047.1 29656.0 29725.4 29790.7 30112.5 23218.3 23322.0 23467.6 23788.4 23947.2 23572.2 23633.4 23788.4 24195.0 24372.9 25669.9 26013.0 26039.5 26042.0 26190.3 22137.7 23112.3 23114.5 23208.3 23489.3 18430.4 19613.5 19623.8 19740.2 19741.8 17:06:38 INFO - PID 7589 | 17:06:38 INFO - PID 7589 | [#2] jquery.html Cycles:180 Average:25389.74 Median:408.60 stddev:62263.35 (15238.1%) stddev-sans-first:62409.76 17:06:38 INFO - PID 7589 | Values: 406.8 410.4 414.5 426.9 427.1 12371.1 12378.3 16844.7 17563.5 17690.4 12936.6 17674.1 17867.5 17906.9 17932.4 5363.9 5623.7 5632.0 5634.7 5640.2 5062.5 5283.6 5366.4 5451.3 5463.2 5278.6 5280.8 5289.7 5290.2 5301.1 5105.0 5258.4 5276.1 5278.9 5289.6 4734.4 4739.0 4754.8 4755.3 4769.5 22119.2 22338.2 22403.3 22478.9 22621.8 1624.0 1641.8 1679.9 1683.1 1684.2 14401.5 14555.9 14721.3 14825.0 14829.8 2005.2 2061.7 2092.8 2099.5 2113.5 91580.0 94890.5 95583.0 95863.5 99215.0 10680.3 10742.7 10871.7 11175.6 11349.4 14742.1 15367.4 15406.6 15424.2 15446.8 7439.6 7442.6 7534.4 7607.5 7645.7 6849.7 6862.0 6980.0 7003.6 7011.7 6844.2 6917.0 6954.9 6993.8 7007.4 1987.3 2024.7 2024.7 2039.8 2206.7 738.3 799.9 840.3 842.7 852.0 16618.2 16855.8 16864.5 16930.2 17459.3 849.7 850.6 856.7 859.3 860.6 9132.1 9178.4 9358.2 9436.2 9450.4 366088.0 371329.0 373079.0 373873.0 374724.0 79254.0 79548.6 79950.6 83627.0 85600.6 1039.2 1040.9 1083.7 1090.9 1093.9 17137.0 17514.0 17903.3 18117.6 18477.3 41489.2 41705.6 42724.1 42818.0 43488.1 51514.0 51989.0 52804.7 53005.7 53283.5 8397.2 8401.5 8428.3 8646.7 8868.0 12750.6 12776.2 13026.0 13104.1 13190.3 10982.8 11102.2 11217.4 11343.1 11750.6 10280.5 10500.9 10635.7 10643.1 10660.3 11019.4 11189.2 11292.2 11339.2 11447.4 8112.4 8193.6 8282.2 8327.4 8364.2 11079.4 11080.8 11151.8 11212.8 11458.1 17:06:38 INFO - PID 7589 | 17:06:38 INFO - PID 7589 | [#3] mootools.html Cycles:180 Average:6226.56 Median:3429.70 stddev:4135.76 (120.6%) stddev-sans-first:4130.20 17:06:38 INFO - PID 7589 | Values: 1211.1 1248.3 1261.5 1268.1 1274.4 9817.6 10190.6 10251.3 10287.8 10536.5 10236.6 10459.1 10459.7 10477.8 10485.6 2145.7 2187.0 2193.6 2198.2 2208.2 2103.1 2134.5 2136.1 2146.1 2160.8 2028.4 2060.1 2062.2 2065.9 2071.0 2042.7 2042.8 2044.7 2052.2 2055.7 1847.2 1905.8 1983.1 2061.8 2067.2 10079.5 10150.8 10150.8 10157.9 10168.7 5306.4 5524.8 5525.8 5530.3 5532.4 3198.7 3288.2 3344.9 3347.2 3358.2 1100.7 1108.1 1112.8 1113.9 1135.9 14911.3 15213.2 15217.0 15217.7 15223.7 4417.3 4489.4 4593.4 4627.5 4671.7 10713.4 10742.8 10764.5 10771.1 10802.0 5240.4 5362.8 5377.7 5397.9 5407.3 4944.4 4989.5 5011.9 5012.4 5017.2 3877.4 3896.1 3925.4 3960.7 4005.0 1122.9 1130.6 1142.2 1151.3 1161.2 651.5 669.3 680.2 685.1 697.0 5032.3 5062.2 5118.5 5251.1 5699.6 810.0 815.2 822.3 827.2 845.7 3273.3 3406.3 3453.1 3468.1 3600.0 13290.8 13543.7 13904.5 13925.3 13963.4 13474.0 13535.1 13558.7 13774.9 13913.9 7116.6 7545.5 7622.2 7693.5 7790.2 5604.4 5628.9 5647.0 5662.2 5920.5 11906.2 12012.5 12021.2 12027.2 12056.6 12279.4 12370.5 12415.2 12603.0 12636.8 7976.0 8315.3 8340.3 8349.6 8380.8 9517.1 9630.8 9643.9 9676.3 9685.7 7774.3 7862.2 7965.4 7975.2 8172.6 7792.5 7805.7 7846.0 7951.8 8134.4 7057.7 7206.2 7207.8 7208.8 7216.5 4714.7 4757.5 4764.5 4800.6 4872.0 4888.2 4912.5 4935.4 4946.4 4967.5 17:06:38 INFO - PID 7589 | 17:06:38 INFO - PID 7589 | [#4] prototype.html Cycles:180 Average:4695.04 Median:5441.90 stddev:1403.75 (25.8%) stddev-sans-first:1369.36 17:06:38 INFO - PID 7589 | Values: 354.3 369.0 377.9 381.8 385.3 5439.6 5444.2 5450.3 5451.3 5470.2 5086.4 5354.7 5361.9 5362.6 5371.1 3983.6 4020.6 4021.0 4026.6 4030.1 4020.0 4039.4 4045.2 4049.0 4074.9 3962.2 3962.5 3995.2 4009.5 4021.3 3936.7 3975.5 3981.0 4010.0 4020.8 3469.2 3480.8 3482.2 3488.7 3496.6 5150.1 5181.6 5193.3 5201.8 5220.0 4565.5 4726.7 4727.6 4751.3 4774.6 5623.6 5652.7 5652.9 5661.4 5670.2 3988.8 4004.3 4004.5 4005.7 4012.4 5898.4 5968.2 5985.8 6009.3 6060.3 4081.9 4086.2 4089.7 4094.0 4098.3 4128.2 4137.8 4141.1 4144.6 4157.9 4559.6 4755.5 4773.9 4784.5 4797.9 5724.3 5775.5 5777.1 5780.9 5796.7 1412.2 1422.6 1424.7 1430.9 1432.8 939.6 958.2 972.6 976.1 983.8 4943.7 4949.5 4951.2 4978.0 4978.7 5878.4 5906.0 5929.9 5942.6 5949.6 4803.0 4822.6 4829.0 4901.8 4973.7 3056.8 3101.3 3105.1 3106.8 3123.5 5480.8 5503.9 5511.0 5541.7 5573.5 5837.8 6004.8 6024.8 6035.3 6041.6 5512.9 5516.2 5547.3 5551.7 5556.6 5877.0 5892.2 5913.3 5913.6 5923.4 5565.4 5753.5 5807.2 5828.1 5828.9 5538.8 5539.7 5558.0 5576.3 5590.4 4017.3 4045.2 4074.1 4079.0 4107.1 5940.5 5961.1 5967.6 5995.6 6028.6 5755.5 5768.2 5769.3 5769.4 5812.9 5481.1 5746.6 5748.5 5748.6 5778.6 5658.2 5660.5 5673.4 5674.2 5681.2 5684.4 5817.3 5819.2 5827.7 5834.4 5591.5 5591.7 5596.7 5601.6 5629.5 17:06:38 INFO - PID 7589 | 17:06:38 INFO - PID 7589 | [#5] yui.html Cycles:180 Average:16996.51 Median:4536.98 stddev:23085.12 (508.8%) stddev-sans-first:23117.31 17:06:38 INFO - PID 7589 | Values: 665.8 666.8 707.8 711.1 722.8 12502.9 12791.6 12806.0 13181.7 14854.0 15721.1 15975.5 15984.3 16015.6 16029.4 743.0 753.3 759.6 759.8 760.0 743.2 777.1 779.7 781.8 788.8 822.2 824.1 824.2 825.4 826.4 824.9 827.2 827.4 828.1 828.2 599.9 600.8 604.6 605.8 607.0 14137.5 14448.8 14454.2 14476.0 14500.3 15332.5 15973.6 16108.2 16116.4 16138.7 12488.6 12668.5 12886.5 12987.2 13003.0 3030.8 3052.6 3058.0 3061.6 3064.6 77861.2 80078.6 80210.0 80816.6 80886.6 12601.0 12696.2 12839.4 12852.6 12878.2 21138.8 21347.9 21712.2 21840.7 22215.2 6409.9 6616.9 6625.2 6646.0 6646.7 2955.0 3073.9 3080.6 3101.6 3172.9 3464.6 3551.3 3572.7 3572.7 3589.6 706.4 719.8 728.9 731.5 732.5 573.3 586.2 601.8 612.6 617.8 9567.0 9596.9 9971.1 9972.4 10443.3 525.9 534.9 544.6 552.5 558.7 4299.8 4389.9 4481.5 4494.0 4580.0 85034.6 85289.0 86874.0 87064.6 87119.6 74980.6 75546.2 76306.2 77051.2 77357.0 65344.0 67319.0 67564.7 68480.7 68831.7 8864.5 8926.0 8986.5 9189.7 9259.8 28838.4 29899.1 30026.8 30942.2 31289.7 37262.0 37546.0 37608.6 38277.2 38396.2 11452.7 11459.5 11655.8 11739.8 11859.3 12146.9 12310.6 12440.2 12584.1 12697.3 12686.4 12832.6 13019.9 13136.6 13217.9 12623.2 13021.8 13105.4 13140.9 13370.4 11761.2 12055.8 12082.5 12215.6 12227.8 8903.2 9099.9 9255.3 9263.8 9457.8 9458.1 9585.2 9602.3 9608.9 10393.3 17:06:38 INFO - PID 7589 | -------- Summary: end -------- 17:06:38 INFO - PID 7589 | 17:06:39 INFO - TEST-INFO | 7589: exit 0 17:06:39 INFO - TEST-OK | dromaeo_css | took 1147676ms 17:06:39 INFO - TEST-START | kraken 17:06:39 INFO - operating with platform_type : linux_ 17:06:39 INFO - Initialising browser for kraken test... 17:06:39 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42800/getInfo.html -profile /tmp/tmpHYYUUP/profile 17:06:39 INFO - TEST-INFO | started process 8021 (/builds/slave/test/build/application/firefox/firefox http://localhost:42800/getInfo.html) 17:07:14 INFO - TEST-INFO | 8021: killed by SIGTERM 17:07:14 INFO - Browser initialized. 17:07:14 INFO - Running cycle 1/1 for kraken test... 17:07:14 INFO - TEST-INFO | started process 8241 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHYYUUP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:07:26 INFO - PID 8241 | RSS: Main: 187031552 17:07:26 INFO - PID 8241 | 17:07:29 INFO - PID 8241 | Cycle 1(1): loaded http://localhost:42800/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42800/tests/kraken/driver.html?testName=audio-beat-detection) 17:07:30 INFO - PID 8241 | RSS: Main: 190664704 17:07:30 INFO - PID 8241 | 17:07:32 INFO - PID 8241 | Cycle 1(1): loaded http://localhost:42800/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42800/tests/kraken/driver.html?testName=audio-dft) 17:07:33 INFO - PID 8241 | RSS: Main: 189501440 17:07:33 INFO - PID 8241 | 17:07:36 INFO - PID 8241 | Cycle 1(1): loaded http://localhost:42800/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42800/tests/kraken/driver.html?testName=audio-fft) 17:07:37 INFO - PID 8241 | RSS: Main: 185905152 17:07:37 INFO - PID 8241 | 17:07:39 INFO - PID 8241 | Cycle 1(1): loaded http://localhost:42800/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42800/tests/kraken/driver.html?testName=audio-oscillator) 17:07:39 INFO - PID 8241 | RSS: Main: 186179584 17:07:39 INFO - PID 8241 | 17:07:41 INFO - PID 8241 | Cycle 1(1): loaded http://localhost:42800/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42800/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:07:42 INFO - PID 8241 | RSS: Main: 186531840 17:07:42 INFO - PID 8241 | 17:07:45 INFO - PID 8241 | Cycle 1(1): loaded http://localhost:42800/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42800/tests/kraken/driver.html?testName=imaging-darkroom) 17:07:46 INFO - PID 8241 | RSS: Main: 190693376 17:07:46 INFO - PID 8241 | 17:07:49 INFO - PID 8241 | Cycle 1(1): loaded http://localhost:42800/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42800/tests/kraken/driver.html?testName=imaging-desaturate) 17:07:50 INFO - PID 8241 | RSS: Main: 187072512 17:07:50 INFO - PID 8241 | 17:07:53 INFO - PID 8241 | Cycle 1(1): loaded http://localhost:42800/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42800/tests/kraken/driver.html?testName=json-parse-financial) 17:07:54 INFO - PID 8241 | RSS: Main: 187482112 17:07:54 INFO - PID 8241 | 17:07:55 INFO - PID 8241 | Cycle 1(1): loaded http://localhost:42800/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42800/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:07:56 INFO - PID 8241 | RSS: Main: 187764736 17:07:56 INFO - PID 8241 | 17:07:58 INFO - PID 8241 | Cycle 1(1): loaded http://localhost:42800/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42800/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:07:58 INFO - PID 8241 | RSS: Main: 187269120 17:07:58 INFO - PID 8241 | 17:08:01 INFO - PID 8241 | Cycle 1(1): loaded http://localhost:42800/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42800/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:08:01 INFO - PID 8241 | RSS: Main: 187510784 17:08:01 INFO - PID 8241 | 17:08:04 INFO - PID 8241 | Cycle 1(1): loaded http://localhost:42800/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42800/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:08:05 INFO - PID 8241 | RSS: Main: 187650048 17:08:05 INFO - PID 8241 | 17:08:08 INFO - PID 8241 | Cycle 1(1): loaded http://localhost:42800/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42800/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:08:09 INFO - PID 8241 | RSS: Main: 187469824 17:08:09 INFO - PID 8241 | 17:08:10 INFO - PID 8241 | Cycle 1(1): loaded http://localhost:42800/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42800/tests/kraken/driver.html?testName=ai-astar) 17:08:11 INFO - PID 8241 | RSS: Main: 189104128 17:08:11 INFO - PID 8241 | 17:08:11 INFO - PID 8241 | __start_tp_report 17:08:11 INFO - PID 8241 | _x_x_mozilla_page_load 17:08:11 INFO - PID 8241 | _x_x_mozilla_page_load_details 17:08:11 INFO - PID 8241 | |i|pagename|runs| 17:08:11 INFO - PID 8241 | |0;ai-astar;102;112;118;113;112;113;110;110;110;110 17:08:11 INFO - PID 8241 | |1;audio-beat-detection;156;128;131;172;123;123;124;123;143;123 17:08:11 INFO - PID 8241 | |2;audio-dft;164;164;165;168;170;169;162;167;165;162 17:08:11 INFO - PID 8241 | |3;audio-fft;76;74;75;123;76;75;76;75;93;76 17:08:11 INFO - PID 8241 | |4;audio-oscillator;83;83;107;85;83;83;97;85;85;103 17:08:11 INFO - PID 8241 | |5;imaging-gaussian-blur;114;117;114;114;114;113;115;113;114;113 17:08:11 INFO - PID 8241 | |6;imaging-darkroom;151;150;153;150;150;150;151;149;150;150 17:08:11 INFO - PID 8241 | |7;imaging-desaturate;95;95;95;93;95;94;94;95;95;95 17:08:11 INFO - PID 8241 | |8;json-parse-financial;54;57;57;56;57;57;60;55;55;55 17:08:11 INFO - PID 8241 | |9;json-stringify-tinderbox;56;56;56;56;56;55;56;56;57;57 17:08:11 INFO - PID 8241 | |10;stanford-crypto-aes;87;89;86;86;90;86;88;87;122;86 17:08:11 INFO - PID 8241 | |11;stanford-crypto-ccm;138;138;142;136;133;144;143;135;139;132 17:08:11 INFO - PID 8241 | |12;stanford-crypto-pbkdf2;197;196;193;212;193;193;204;194;194;200 17:08:11 INFO - PID 8241 | |13;stanford-crypto-sha256-iterative;74;73;72;70;78;72;74;72;73;78 17:08:11 INFO - PID 8241 | __end_tp_report 17:08:11 INFO - PID 8241 | __start_cc_report 17:08:11 INFO - PID 8241 | _x_x_mozilla_cycle_collect,1026 17:08:11 INFO - PID 8241 | __end_cc_report 17:08:11 INFO - PID 8241 | __startTimestamp1496016491127__endTimestamp 17:08:11 INFO - PID 8241 | 17:08:11 INFO - PID 8241 | ------- Summary: start ------- 17:08:11 INFO - PID 8241 | Number of tests: 14 17:08:11 INFO - PID 8241 | 17:08:11 INFO - PID 8241 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:4.00 (3.6%) stddev-sans-first:2.60 17:08:11 INFO - PID 8241 | Values: 102.0 112.0 118.0 113.0 112.0 113.0 110.0 110.0 110.0 110.0 17:08:11 INFO - PID 8241 | 17:08:11 INFO - PID 8241 | [#1] audio-beat-detection Cycles:10 Average:134.60 Median:129.50 stddev:17.11 (13.2%) stddev-sans-first:16.30 17:08:11 INFO - PID 8241 | Values: 156.0 128.0 131.0 172.0 123.0 123.0 124.0 123.0 143.0 123.0 17:08:11 INFO - PID 8241 | 17:08:11 INFO - PID 8241 | [#2] audio-dft Cycles:10 Average:165.60 Median:166.00 stddev:2.80 (1.7%) stddev-sans-first:2.91 17:08:11 INFO - PID 8241 | Values: 164.0 164.0 165.0 168.0 170.0 169.0 162.0 167.0 165.0 162.0 17:08:11 INFO - PID 8241 | 17:08:11 INFO - PID 8241 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:15.48 (20.4%) stddev-sans-first:16.27 17:08:11 INFO - PID 8241 | Values: 76.0 74.0 75.0 123.0 76.0 75.0 76.0 75.0 93.0 76.0 17:08:11 INFO - PID 8241 | 17:08:11 INFO - PID 8241 | [#4] audio-oscillator Cycles:10 Average:89.40 Median:84.00 stddev:9.28 (11.0%) stddev-sans-first:9.55 17:08:11 INFO - PID 8241 | Values: 83.0 83.0 107.0 85.0 83.0 83.0 97.0 85.0 85.0 103.0 17:08:11 INFO - PID 8241 | 17:08:11 INFO - PID 8241 | [#5] imaging-gaussian-blur Cycles:10 Average:114.10 Median:114.00 stddev:1.20 (1.1%) stddev-sans-first:1.27 17:08:11 INFO - PID 8241 | Values: 114.0 117.0 114.0 114.0 114.0 113.0 115.0 113.0 114.0 113.0 17:08:11 INFO - PID 8241 | 17:08:11 INFO - PID 8241 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:150.00 stddev:1.07 (0.7%) stddev-sans-first:1.12 17:08:11 INFO - PID 8241 | Values: 151.0 150.0 153.0 150.0 150.0 150.0 151.0 149.0 150.0 150.0 17:08:11 INFO - PID 8241 | 17:08:11 INFO - PID 8241 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 17:08:11 INFO - PID 8241 | Values: 95.0 95.0 95.0 93.0 95.0 94.0 94.0 95.0 95.0 95.0 17:08:11 INFO - PID 8241 | 17:08:11 INFO - PID 8241 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:57.00 stddev:1.70 (3.0%) stddev-sans-first:1.59 17:08:11 INFO - PID 8241 | Values: 54.0 57.0 57.0 56.0 57.0 57.0 60.0 55.0 55.0 55.0 17:08:11 INFO - PID 8241 | 17:08:11 INFO - PID 8241 | [#9] json-stringify-tinderbox Cycles:10 Average:56.10 Median:56.00 stddev:0.57 (1.0%) stddev-sans-first:0.60 17:08:11 INFO - PID 8241 | Values: 56.0 56.0 56.0 56.0 56.0 55.0 56.0 56.0 57.0 57.0 17:08:11 INFO - PID 8241 | 17:08:11 INFO - PID 8241 | [#10] stanford-crypto-aes Cycles:10 Average:90.70 Median:87.00 stddev:11.09 (12.7%) stddev-sans-first:11.68 17:08:11 INFO - PID 8241 | Values: 87.0 89.0 86.0 86.0 90.0 86.0 88.0 87.0 122.0 86.0 17:08:11 INFO - PID 8241 | 17:08:11 INFO - PID 8241 | [#11] stanford-crypto-ccm Cycles:10 Average:138.00 Median:138.50 stddev:4.11 (3.0%) stddev-sans-first:4.36 17:08:11 INFO - PID 8241 | Values: 138.0 138.0 142.0 136.0 133.0 144.0 143.0 135.0 139.0 132.0 17:08:11 INFO - PID 8241 | 17:08:11 INFO - PID 8241 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.60 Median:196.50 stddev:6.20 (3.2%) stddev-sans-first:6.58 17:08:11 INFO - PID 8241 | Values: 197.0 196.0 193.0 212.0 193.0 193.0 204.0 194.0 194.0 200.0 17:08:11 INFO - PID 8241 | 17:08:11 INFO - PID 8241 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.60 Median:73.50 stddev:2.59 (3.5%) stddev-sans-first:2.74 17:08:11 INFO - PID 8241 | Values: 74.0 73.0 72.0 70.0 78.0 72.0 74.0 72.0 73.0 78.0 17:08:11 INFO - PID 8241 | -------- Summary: end -------- 17:08:11 INFO - PID 8241 | 17:08:12 INFO - TEST-INFO | 8241: exit 0 17:08:12 INFO - TEST-OK | kraken | took 93285ms 17:08:12 INFO - SUITE-END | took 1240s 17:08:12 INFO - Completed test suite (00:20:41) 17:08:12 INFO - javascript benchmark 17:08:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6590.830631118891, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2743.163335182769, 2769.543025400809, 2781.1378472673473, 2784.8189867658602, 2808.9016884409048, 5092.898142037157, 5198.766055527501, 5214.243934629481, 5262.81580144695, 5281.260623512707, 5082.567981721549, 5151.922721159186, 5168.896622067566, 5233.633645644806, 5245.10833158363, 4643.489216186217, 4644.0, 4671.299305104245, 4674.11191873543, 4718.716876987374, 4634.374359461463, 4673.83641572545, 4730.574248317651, 4748.762561871893, 4778.426588809348, 4612.192866248427, 4662.6269898408045, 4677.695949763289, 4733.668643194977, 4742.478327383985, 4607.815687372501, 4688.273317635738, 4689.273162659793, 4719.0, 4735.83424580138, 4615.5845973862515, 4631.1895418301665, 4639.652026098022, 4645.581897629229, 4696.9530304696855, 5073.213651883964, 5148.073346797575, 5195.428502864682, 5196.376434827807, 5202.531772140488, 5566.721663916828, 5587.972060139714, 5592.4407559244155, 5693.003724348223, 5705.400932902027, 5684.459976302286, 5708.257926469574, 5742.770289188427, 5754.4533269339345, 5768.0, 5282.867928301785, 5297.364316282071, 5298.788048478018, 5300.390455097636, 5302.257683924254, 5635.1828984796975, 5714.228579141846, 5821.941780582225, 5822.071287010384, 5892.440218179266, 5476.808311709071, 5528.75120619573, 5577.9163312550345, 5620.072688006433, 5622.746976385991, 5580.776768929279, 5677.261955945701, 5679.971600142056, 5680.943190568124, 5692.6015178937905, 5473.917891231635, 5629.155626656035, 5645.125005624135, 5646.265985421869, 5649.0396632572565, 5458.099413596712, 5537.141743029756, 5597.412271711493, 5612.07400778875, 5627.831165064973, 4608.746518941423, 4612.146752850666, 4620.653450991122, 4628.0281140960105, 4653.674242803039, 3982.2234664240773, 3989.082511022481, 3994.660453861396, 4022.8390864365683, 4053.9594604054173, 4614.0, 4673.205555055649, 4700.929486057712, 4726.550977657117, 4740.715557066587, 5660.462256085665, 5665.12190610456, 5683.318001839806, 5696.3449203341315, 5707.828765137053, 4749.26386410107, 4753.738544380092, 4756.571908528249, 4757.643176761757, 4797.136515427256, 4783.306420568998, 4842.878928026898, 4857.344258525195, 4946.282788995575, 4952.133376659071, 5264.210368444764, 5287.180487024518, 5292.285541451854, 5305.495977882095, 5309.203619457112, 5535.975844468786, 5587.497125258747, 5590.636608620427, 5591.4688104629995, 5630.831075067755, 5270.393904701008, 5319.46805319465, 5349.384820745664, 5361.383440904346, 5362.3833259174135, 5442.183672449006, 5611.410801865745, 5623.044082505902, 5626.240457538343, 5626.409227031267, 5602.047651899105, 5692.117721753135, 5701.087825947829, 5724.341700704473, 5740.512056475246, 5512.3385193777, 5513.779448822002, 5527.5577953764405, 5540.252065971043, 5556.222128902038, 5489.752961116839, 5493.752781124939, 5496.450354964471, 5503.009458297384, 5527.226188333556, 5293.867653308698, 5340.519353258225, 5361.195820626937, 5369.838904832861, 5452.536534394462, 5515.779368825362, 5517.944820551743, 5558.499735023867, 5563.332400112013, 5564.638298510584, 5352.116900711495, 5354.866128346823, 5357.0, 5360.597955153457, 5370.650907690988], "value": 5107.847796857574, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.8009547374471, 743.7248218159281, 1061.3631820907456, 1078.3529882070754, 1158.2760774515928, 31420.214494637617, 31877.521837172433, 32356.514652280206, 32382.676173238262, 32490.512642310383, 30266.546001809937, 30347.813479584656, 30375.0, 30456.695433045665, 30612.387752245, 6435.517336199792, 6599.142111525495, 6606.14120164378, 6806.285340039299, 6810.897836532456, 6703.597784132968, 6787.660616969157, 6787.9321206788045, 6801.829954251134, 6818.795436136899, 6748.0, 6796.864062718742, 6809.557378770389, 6823.454123670094, 6826.48801339899, 6754.324567543231, 6787.626680532569, 6792.524523283397, 6792.694328755218, 6797.1843378794365, 6674.966625166843, 6703.1285932828905, 6709.959956206796, 6712.731490740364, 6719.2944740802, 30648.0, 30680.69319306823, 30696.693033069605, 30706.38587228265, 30807.537886931714, 2942.926426839325, 2962.918534734806, 2966.1842993176833, 2982.746466550324, 2988.656304524986, 23852.52294954091, 23864.64203036956, 23884.28347149571, 24005.0, 24009.519809603884, 3003.6695963444004, 3054.9847250763605, 3055.618047744032, 3059.03640353288, 3110.5178697301953, 148995.2550237242, 149835.0, 150101.0, 150110.0, 150375.24812375978, 30674.233144171576, 31018.379632407225, 37011.259774804894, 37486.25027499489, 38825.0, 39101.6089839098, 39174.0, 39288.41067383991, 39319.0, 39399.80300098481, 11755.05959523236, 11841.289522628498, 11850.76298474043, 11859.288442693465, 11891.0, 9253.814923701488, 9268.212201962773, 9304.395214311047, 9346.626134954662, 9425.2931030173, 12070.672226055127, 12145.0, 12178.878211217952, 12183.02535797134, 12328.19866708679, 4979.875503112378, 5045.318881950963, 5051.217061355495, 5197.090509160882, 5238.135707608202, 838.5094719589109, 862.3661608717588, 877.8419884420865, 886.4902680958346, 905.3119629081945, 19960.401187964384, 20329.288474903602, 20754.169833206804, 21055.0, 21183.576328473344, 923.3721069672687, 936.2322895225849, 960.9759756006156, 961.5769061613008, 964.6816550538306, 10609.787804244026, 10852.348859068481, 10889.183311251687, 10952.890471095187, 11140.164487663458, 173207.0, 174261.0, 174606.0, 174625.0, 175211.0, 37839.81080094637, 37880.242395151945, 38314.42528362077, 38334.6166538331, 38447.0, 1155.5782139519183, 1191.9106067045007, 1195.988040119605, 1198.3888217009387, 1199.424276347358, 19139.712904306725, 19587.0, 20394.08226629835, 20485.59028819445, 20636.380908572766, 28755.5686664696, 28830.855845720638, 28865.134045978655, 29013.85493072521, 29069.709302907548, 148248.0, 149140.0, 149154.0, 149483.0, 150022.0, 22510.437239069153, 22939.541209176055, 24927.252182434557, 27266.318342041606, 27400.725992740616, 29047.12858614245, 29656.0, 29725.405491889607, 29790.702092978794, 30112.54831177578, 23218.3034508965, 23322.0, 23467.64798527989, 23788.405289867893, 23947.16184933519, 23572.174973875834, 23633.40916477102, 23788.405289867893, 24195.0, 24372.903219354816, 25669.871650641628, 26013.0, 26039.479210416066, 26042.0, 26190.34524136912, 22137.65045762959, 23112.30663080043, 23114.53770924606, 23208.3037508875, 23489.295321140395, 18430.35493757712, 19613.50966225856, 19623.803761962197, 19740.210391584176, 19741.804973567552], "value": 13664.315076042758, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [406.7579790024934, 410.4458980376492, 414.48810718762326, 426.88687497813083, 427.07538179840645, 12371.13402061856, 12378.257304561732, 16844.74732879008, 17563.47309580713, 17690.3808366707, 12936.611901642966, 17674.11629418527, 17867.463976080708, 17906.910465447654, 17932.37236696716, 5363.865903352408, 5623.690697011662, 5632.04255276604, 5634.746436410372, 5640.210370548127, 5062.493750624926, 5283.603729720267, 5366.356037275533, 5451.291332126838, 5463.180522921554, 5278.630495865291, 5280.788768449276, 5289.735513224343, 5290.2064690296575, 5301.0988132017455, 5105.0, 5258.421573626898, 5276.12943864262, 5278.894422111555, 5289.576833853302, 4734.384530011111, 4739.0, 4754.833580824689, 4755.334253204554, 4769.499202583748, 22119.225827095976, 22338.21816236424, 22403.32790016302, 22478.88760556203, 22621.773782262295, 1623.9512814615462, 1641.7783599214072, 1679.8824082314243, 1683.0743091299857, 1684.174754370362, 14401.495947641886, 14555.854441455556, 14721.263936803223, 14825.0, 14829.77755333671, 2005.1979208316643, 2061.742282214723, 2092.79072092791, 2099.496120930981, 2113.5350222950924, 91580.0, 94890.52554737251, 95583.0, 95863.52068239613, 99215.0, 10680.305780124267, 10742.677719668422, 10871.728206794893, 11175.608853690082, 11349.375784331776, 14742.125285569211, 15367.385304587691, 15406.614834629225, 15424.151671657943, 15446.768298475532, 7439.628018599048, 7442.627868606548, 7534.397248220239, 7607.505512141693, 7645.732399365996, 6849.726010959605, 6862.044317369526, 6980.0, 7003.614801185881, 7011.6844741985715, 6844.247132815386, 6916.965415172993, 6954.9304506955295, 6993.790186294419, 7007.369336759716, 1987.2647120565484, 2024.6962955556785, 2024.7064175694443, 2039.836813054952, 2206.6579680149603, 738.3023043224209, 799.8881554639056, 840.3193413335218, 842.6671464771381, 852.0, 16618.169091545373, 16855.83144168567, 16864.494065178063, 16930.238139283763, 17459.30162793474, 849.6558893648082, 850.6129710981612, 856.6830272799104, 859.3468963587718, 860.595520105562, 9132.086791320815, 9178.357514973888, 9358.204552612968, 9436.150746432853, 9450.385724927857, 366088.0, 371329.0, 373079.0, 373873.0, 374724.0, 79254.0, 79548.60225698835, 79950.60024699956, 83627.0, 85600.57199713962, 1039.153090231459, 1040.8855025947291, 1083.6803143072812, 1090.8636420447444, 1093.9179561532917, 17137.0, 17514.036727979576, 17903.283868645107, 18117.637647247244, 18477.260909563465, 41489.170216594895, 41705.58294417139, 42724.1455170901, 42818.0, 43488.13023739444, 51514.0, 51989.0, 52804.73597632141, 53005.7349713249, 53283.46716532785, 8397.244248017463, 8401.537915414467, 8428.325733941392, 8646.740597782076, 8868.049029213562, 12750.553730619384, 12776.169548979287, 13026.0, 13104.148230364995, 13190.340482976006, 10982.835257471304, 11102.222844400814, 11217.439128043728, 11343.092552595608, 11750.58872939443, 10280.485975701335, 10500.894991050298, 10635.680929572125, 10643.095336896451, 10660.307080039773, 11019.393933333744, 11189.216754827085, 11292.15308851823, 11339.206255562032, 11447.427628618703, 8112.432129751097, 8193.631286592237, 8282.17178282191, 8327.375446841632, 8364.205400486944, 11079.446027698745, 11080.778384432428, 11151.776964460827, 11212.775744484901, 11458.08335333188], "value": 8826.861994671164, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1211.1219365959678, 1248.282237713315, 1261.5143169879593, 1268.0679700420196, 1274.4201388368294, 9817.607295708172, 10190.59237630494, 10251.33366331188, 10287.794244115123, 10536.473176341191, 10236.590536378555, 10459.110975567086, 10459.68620941371, 10477.8428323575, 10485.633002844901, 2145.731783527059, 2186.9890650546727, 2193.649016157407, 2198.2416066457045, 2208.182972300251, 2103.0746471552543, 2134.5410736691606, 2136.113512892148, 2146.066461089431, 2160.8487405881597, 2028.3914825552276, 2060.1450398084776, 2062.16482324658, 2065.865718728285, 2071.0, 2042.714020037196, 2042.8467864910042, 2044.7239622650975, 2052.220156340596, 2055.732754741874, 1847.1687740516686, 1905.8380037696813, 1983.1274239334646, 2061.8247448966854, 2067.24545540878, 10079.5464204111, 10150.847737283946, 10150.847737283946, 10157.949210253975, 10168.745781355452, 5306.3632364116165, 5524.751386187631, 5525.751341189616, 5530.253415788858, 5532.3914369419335, 3198.712115909579, 3288.2108294009267, 3344.8996530104137, 3347.2134048498583, 3358.177246574605, 1100.6532942123285, 1108.0802933565121, 1112.777444511101, 1113.9275947063416, 1135.9204855660107, 14911.254437278201, 15213.239338033165, 15217.0, 15217.695646087017, 15223.695526089416, 4417.271150260171, 4489.393931819228, 4593.425821772278, 4627.537246275346, 4671.719696818202, 10713.410762407986, 10742.838857417146, 10764.515596798163, 10771.084457821016, 10802.0, 5240.423553409122, 5362.812301569426, 5377.677339359651, 5397.946020539823, 5407.270018547446, 4944.406671199479, 4989.476105008922, 5011.949880501221, 5012.398512178562, 5017.172166592544, 3877.43777152317, 3896.08442016126, 3925.4111883217174, 3960.7029472789654, 4005.0387906902133, 1122.8708698499777, 1130.5534313945946, 1142.1662186603826, 1151.3207207747469, 1161.2045748662194, 651.5146216068964, 669.334012657409, 680.1566058087935, 685.1333063674456, 696.9581825090511, 5032.270320803463, 5062.215356619729, 5118.488151184852, 5251.0548101341365, 5699.629524080921, 809.995950020258, 815.152241668658, 822.2558584481054, 827.1728271728272, 845.7209120990182, 3273.2798784267425, 3406.267652454734, 3453.1367158210446, 3468.0809585459874, 3600.0, 13290.800637990438, 13543.661408464866, 13904.51334203298, 13925.303734813218, 13963.441462341392, 13474.0, 13535.05254632186, 13558.661033474242, 13774.862251377559, 13913.930430347986, 7116.608586527687, 7545.471816972759, 7622.199669034782, 7693.4614576979075, 7790.220977902278, 5604.439556044363, 5628.915566266427, 5646.971765141148, 5662.235598194191, 5920.526357891445, 11906.166568340133, 12012.459439325077, 12021.158518903943, 12027.158098933342, 12056.63830085099, 12279.386030698608, 12370.505179792708, 12415.193012454161, 12603.0, 12636.810447843105, 7976.0, 8315.251627353568, 8340.332773378237, 8349.624266908126, 8380.790480238044, 9517.095875891779, 9630.759231019001, 9643.855342170013, 9676.322657414195, 9685.661001865183, 7774.339181169437, 7862.213778622092, 7965.362770978424, 7975.162607926084, 8172.591370431336, 7792.493487923267, 7805.684693114708, 7846.0, 7951.840963180588, 8134.389920755849, 7057.7176912922905, 7206.171290301682, 7207.783766486804, 7208.819779505554, 7216.494845360774, 4714.717116972993, 4757.548032936866, 4764.547368000173, 4800.591949684176, 4871.95128048715, 4888.169011268022, 4912.48418916023, 4935.432425271139, 4946.3817022872145, 4967.503249675004], "value": 4638.476383385366, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.27727436030494, 368.966792988631, 377.86208034067556, 381.8377189694379, 385.28914153387007, 5439.619226654136, 5444.183372494128, 5450.345958484977, 5451.2640793492865, 5470.234167216588, 5086.389633244006, 5354.678719276846, 5361.892762144755, 5362.624616276862, 5371.140617501201, 3983.5659162701404, 4020.5778393268724, 4020.9798951005205, 4026.6376026157714, 4030.1133750574827, 4019.9900049975013, 4039.353703407455, 4045.1707399982934, 4048.9595104049026, 4074.9185016299803, 3962.2273656636967, 3962.5046869141356, 3995.2009598080353, 4009.498812648419, 4021.3364794808967, 3936.724429289951, 3975.5428125765616, 3980.960190398088, 4009.959900400988, 4020.7989600520004, 3469.1673998240494, 3480.773749706261, 3482.199094208346, 3488.6511348865165, 3496.580410350749, 5150.141671372387, 5181.559567436772, 5193.324867767204, 5201.817936372247, 5220.0, 4565.493387182222, 4726.692764970266, 4727.598154156901, 4751.263554149113, 4774.618030557547, 5623.634463759842, 5652.74562644682, 5652.886942261173, 5661.433856614306, 5670.206171136044, 3988.8005599720186, 4004.2592120457807, 4004.4994375703036, 4005.73962692427, 4012.3981402789814, 5898.380670029628, 5968.1803645666805, 5985.760569577255, 6009.338972712998, 6060.333363329986, 4081.8774237396983, 4086.1827634473225, 4089.734167279117, 4093.97953010239, 4098.323776576832, 4128.174365126986, 4137.81379837908, 4141.109661422808, 4144.626983571493, 4157.937630935538, 4559.635229181657, 4755.548222918817, 4773.856784296477, 4784.521547845187, 4797.904041919142, 5724.3130824300515, 5775.537956963432, 5777.104548794943, 5780.913286300624, 5796.710164491758, 1412.1527083749668, 1422.6372275069791, 1424.7150569885857, 1430.9499167529086, 1432.8208973878266, 939.572494514994, 958.2142643032646, 972.5720682899642, 976.1117383181271, 983.7688143286322, 4943.653944223942, 4949.529794669501, 4951.192814622636, 4978.0, 4978.701277923336, 5878.441548052928, 5905.970470147708, 5929.851753706192, 5942.64344139353, 5949.583529153005, 4802.975985120122, 4822.614190864722, 4829.0, 4901.803927842846, 4973.701577905337, 3056.801307914978, 3101.3332133591384, 3105.1305634422397, 3106.819408624753, 3123.5002399616405, 5480.766827463789, 5503.9174412383845, 5511.0, 5541.667499950016, 5573.470520300565, 5837.795677151279, 6004.819855404345, 6024.849378765478, 6035.305939816977, 6041.607295525777, 5512.862178445571, 5516.227728118067, 5547.306586676666, 5551.666899985933, 5556.555475561945, 5877.000909845251, 5892.175095486721, 5913.319968203712, 5913.58604897653, 5923.378045305181, 5565.38780734127, 5753.539716822561, 5807.245058142584, 5828.125781132864, 5828.854278643068, 5538.806141785019, 5539.695316757617, 5558.0, 5576.275084239023, 5590.440955904377, 4017.2568074906235, 4045.1707399982342, 4074.144429669684, 4078.9796051019557, 4107.096438783463, 5940.495057920125, 5961.105834124916, 5967.6419414835245, 5995.5803093783015, 6028.608140470856, 5755.53955683536, 5768.221290125779, 5769.259601689164, 5769.394213607511, 5812.854678633068, 5481.068218402801, 5746.620811005412, 5748.48263656273, 5748.626339287933, 5778.613132848171, 5658.236138121301, 5660.462256085665, 5673.404292549223, 5674.226639284994, 5681.204631351531, 5684.403137670485, 5817.301923769175, 5819.185314055951, 5827.650340979555, 5834.416558344132, 5591.4688104629995, 5591.720413979204, 5596.720163991703, 5601.579881508822, 5629.521490673339], "value": 4262.161726737523, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [665.8202285382947, 666.7699643622948, 707.7628994286914, 711.1466240511386, 722.7651013420638, 12502.937485312572, 12791.552295669653, 12806.039547033975, 13181.736365272689, 14854.0, 15721.13533755643, 15975.520734377958, 15984.280707368167, 16015.599610009756, 16029.438969636065, 743.0266351080089, 753.3069575990103, 759.5632511306021, 759.7644730133676, 759.9506032107923, 743.1602289412956, 777.0752804163028, 779.7270955165703, 781.820181358288, 788.8422315536886, 822.2394285286116, 824.0811495182858, 824.2169938558363, 825.4263287015526, 826.396730386815, 824.8968878890139, 827.1893544326593, 827.4001349021971, 828.130463013833, 828.1883753921161, 599.865030368168, 600.8437806170383, 604.6493034040246, 605.8364241654729, 606.9787557435512, 14137.505187318497, 14448.783268250985, 14454.205018723966, 14475.98668093234, 14500.347484363228, 15332.463363782213, 15973.600659983476, 16108.194590270557, 16116.355345786154, 16138.677226455406, 12488.625341239778, 12668.493260269579, 12886.484540618365, 12987.155834870704, 13003.0, 3030.848457577112, 3052.6336839579394, 3058.021433141396, 3061.6172978377704, 3064.6169228846393, 77861.22138778596, 80078.59960700218, 80210.0, 80816.59591702063, 80886.59556702238, 12601.0, 12696.174748641493, 12839.358032098544, 12852.614421567368, 12878.227306361461, 21138.788612113683, 21347.893260533598, 21712.240071597418, 21840.672389914165, 22215.22246721357, 6409.903851442139, 6616.933830661632, 6625.17185351831, 6646.0, 6646.734130634817, 2955.0, 3073.9077827665205, 3080.5687203791485, 3101.58128652629, 3172.888948886778, 3464.6188919218866, 3551.3252482028333, 3572.7141828653644, 3572.732045096628, 3589.5692516897616, 706.4060383201024, 719.8380364418069, 728.8979542864004, 731.5391303478774, 732.5128789355126, 573.280532931177, 586.2408181405091, 601.8254706135172, 612.574260888687, 617.7745123030062, 9567.0, 9596.9040309596, 9971.102600765966, 9972.351797133308, 10443.268971171945, 525.8869343091177, 534.9063913815066, 544.6133245395735, 552.5027475272287, 558.7150553217888, 4299.828006879752, 4389.868303950887, 4481.484629267611, 4494.0, 4579.95420045802, 85034.57482712671, 85289.0, 86874.0, 87064.56467717748, 87119.56440217758, 74980.62509687526, 75546.24453755502, 76306.23693763102, 77051.22948770552, 77357.0, 65344.0, 67318.99021514681, 67564.6621766888, 68480.6575967117, 68831.65584172147, 8864.512451814953, 8925.9645464024, 8986.460812351279, 9189.724308270495, 9259.814803703754, 28838.42323153567, 29899.103026909226, 30026.849865751406, 30942.22644433907, 31289.68710312959, 37262.0, 37546.0, 37608.623913760515, 38277.23445531018, 38396.232075358894, 11452.65642030707, 11459.507785531378, 11655.766884662089, 11739.765204696028, 11859.288442693465, 12146.939265303618, 12310.569130080405, 12440.19138755978, 12584.05619578517, 12697.301648409057, 12686.365681715693, 12832.55086071983, 13019.934900325437, 13136.60590182296, 13217.933910330386, 12623.179493332904, 13021.804672929724, 13105.427348718214, 13140.868591313965, 13370.398332074885, 11761.235519691192, 12055.81916271239, 12082.516699331929, 12215.572454964034, 12227.816582751444, 8903.243224326005, 9099.863502047607, 9255.25957923378, 9263.814723705624, 9457.763555911157, 9458.101480359355, 9585.233181345615, 9602.32783705134, 9608.9039109608, 10393.324433911772], "value": 6729.344820526798, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1553.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 118.0, 113.0, 112.0, 113.0, 110.0, 110.0, 110.0, 110.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 128.0, 131.0, 172.0, 123.0, 123.0, 124.0, 123.0, 143.0, 123.0], "value": 134.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 165.0, 168.0, 170.0, 169.0, 162.0, 167.0, 165.0, 162.0], "value": 165.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 123.0, 76.0, 75.0, 76.0, 75.0, 93.0, 76.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 107.0, 85.0, 83.0, 83.0, 97.0, 85.0, 85.0, 103.0], "value": 89.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 117.0, 114.0, 114.0, 114.0, 113.0, 115.0, 113.0, 114.0, 113.0], "value": 114.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 153.0, 150.0, 150.0, 150.0, 151.0, 149.0, 150.0, 150.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 93.0, 95.0, 94.0, 94.0, 95.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 57.0, 56.0, 57.0, 57.0, 60.0, 55.0, 55.0, 55.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 56.0, 56.0, 55.0, 56.0, 56.0, 57.0, 57.0], "value": 56.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 89.0, 86.0, 86.0, 90.0, 86.0, 88.0, 87.0, 122.0, 86.0], "value": 90.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 138.0, 142.0, 136.0, 133.0, 144.0, 143.0, 135.0, 139.0, 132.0], "value": 138.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 196.0, 193.0, 212.0, 193.0, 193.0, 204.0, 194.0, 194.0, 200.0], "value": 197.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 72.0, 70.0, 78.0, 72.0, 74.0, 72.0, 73.0, 78.0], "value": 73.6, "unit": "score"}]}]} 17:08:12 INFO - Return code: 0 17:08:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:08:12 INFO - # TBPL SUCCESS # 17:08:12 INFO - Running post-action listener: _resource_record_post_action 17:08:12 INFO - [mozharness: 2017-05-29 00:08:12.924801Z] Finished run-tests step (success) 17:08:12 INFO - Running post-run listener: _resource_record_post_run 17:08:13 INFO - Total resource usage - Wall time: 1258s; CPU: 13.0%; Read bytes: 495616; Write bytes: 422969344; Read time: 44; Write time: 227324 17:08:13 INFO - TinderboxPrint: CPU usage
12.7% 17:08:13 INFO - TinderboxPrint: I/O read bytes / time
495,616 / 44 17:08:13 INFO - TinderboxPrint: I/O write bytes / time
422,969,344 / 227,324 17:08:13 INFO - TinderboxPrint: CPU idle
8,767.2 (87.3%) 17:08:13 INFO - TinderboxPrint: CPU user
1,221.3 (12.2%) 17:08:13 INFO - TinderboxPrint: Swap in / out
0 / 0 17:08:13 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 112775168; Read time: 0; Write time: 93508 17:08:13 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:08:13 INFO - run-tests - Wall time: 1242s; CPU: 13.0%; Read bytes: 491520; Write bytes: 310194176; Read time: 32; Write time: 133816 17:08:13 INFO - Running post-run listener: _upload_blobber_files 17:08:13 INFO - Blob upload gear active. 17:08:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:08:13 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 17:08:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:08:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:08:14 INFO - (blobuploader) - INFO - Open directory for files ... 17:08:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:08:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:08:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:08:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:08:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:08:17 INFO - (blobuploader) - INFO - Done attempting. 17:08:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:08:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:08:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:08:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:08:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:08:17 INFO - (blobuploader) - INFO - Done attempting. 17:08:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:08:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:08:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:08:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:08:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:08:18 INFO - (blobuploader) - INFO - Done attempting. 17:08:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:08:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:08:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:08:19 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:08:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:08:19 INFO - (blobuploader) - INFO - Done attempting. 17:08:19 INFO - (blobuploader) - INFO - Iteration through files over. 17:08:19 INFO - Return code: 0 17:08:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:08:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:08:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e901cca1a9444efdda05edfad08c2a5353013abc55c177c2882c1956326177ba96268a5977839df90bb9b715ac979fd74c684373da4581c703af91f3e57c8a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f3b1f30e164dc4cf9f30dd8882a964f00ad16386ce6ef6b65016bf80b1a93304eaefec03e9d513daec4655368a5862b54e6e26ff6b2500baff23c3ffbac1cfd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41dc625326b0ca1a8fa1a47e2f5ec093ce2d69ce63270ab88ece153b9e1329fd8f63221ada2322a2ec91bdc5b6b2529dd1950156964372fa66d40b8c897fc87c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66716ccbbf7fe4c4fc45b109858aee90938bea27e8aad610301a8cfefbc48c19b5e8a0387f1668ef88df05a96fc84d84f1b011e40397fa472e992c8153103649"} 17:08:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:08:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:08:19 INFO - Contents: 17:08:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e901cca1a9444efdda05edfad08c2a5353013abc55c177c2882c1956326177ba96268a5977839df90bb9b715ac979fd74c684373da4581c703af91f3e57c8a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f3b1f30e164dc4cf9f30dd8882a964f00ad16386ce6ef6b65016bf80b1a93304eaefec03e9d513daec4655368a5862b54e6e26ff6b2500baff23c3ffbac1cfd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41dc625326b0ca1a8fa1a47e2f5ec093ce2d69ce63270ab88ece153b9e1329fd8f63221ada2322a2ec91bdc5b6b2529dd1950156964372fa66d40b8c897fc87c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66716ccbbf7fe4c4fc45b109858aee90938bea27e8aad610301a8cfefbc48c19b5e8a0387f1668ef88df05a96fc84d84f1b011e40397fa472e992c8153103649"} 17:08:19 INFO - Running post-run listener: copy_logs_to_upload_dir 17:08:19 INFO - Copying logs to upload dir... 17:08:19 INFO - mkdir: /builds/slave/test/build/upload/logs 17:08:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1315.628188 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2017-05-28 17:08:19.743343) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-28 17:08:19.747075) ========= 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=3836458cccd887f2d2de3cf1000001de-1496015182.286408-1570331901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e901cca1a9444efdda05edfad08c2a5353013abc55c177c2882c1956326177ba96268a5977839df90bb9b715ac979fd74c684373da4581c703af91f3e57c8a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f3b1f30e164dc4cf9f30dd8882a964f00ad16386ce6ef6b65016bf80b1a93304eaefec03e9d513daec4655368a5862b54e6e26ff6b2500baff23c3ffbac1cfd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41dc625326b0ca1a8fa1a47e2f5ec093ce2d69ce63270ab88ece153b9e1329fd8f63221ada2322a2ec91bdc5b6b2529dd1950156964372fa66d40b8c897fc87c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66716ccbbf7fe4c4fc45b109858aee90938bea27e8aad610301a8cfefbc48c19b5e8a0387f1668ef88df05a96fc84d84f1b011e40397fa472e992c8153103649"} build_url:https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011418 build_url: 'https://queue.taskcluster.net/v1/task/f7sj5ddSS_i0aPQv11q_Cg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e901cca1a9444efdda05edfad08c2a5353013abc55c177c2882c1956326177ba96268a5977839df90bb9b715ac979fd74c684373da4581c703af91f3e57c8a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f3b1f30e164dc4cf9f30dd8882a964f00ad16386ce6ef6b65016bf80b1a93304eaefec03e9d513daec4655368a5862b54e6e26ff6b2500baff23c3ffbac1cfd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/41dc625326b0ca1a8fa1a47e2f5ec093ce2d69ce63270ab88ece153b9e1329fd8f63221ada2322a2ec91bdc5b6b2529dd1950156964372fa66d40b8c897fc87c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/66716ccbbf7fe4c4fc45b109858aee90938bea27e8aad610301a8cfefbc48c19b5e8a0387f1668ef88df05a96fc84d84f1b011e40397fa472e992c8153103649"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-28 17:08:19.775433) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 17:08:19.776145) ========= 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=3836458cccd887f2d2de3cf1000001de-1496015182.286408-1570331901 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004541 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-28 17:08:19.856347) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-28 17:08:19.856630) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-28 17:08:19.856910) ========= ========= Total master_lag: 0.17 =========