builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-024 starttime: 1497051055.51 results: success (0) revision: c4e74cfbf7e9d8e297e214478d25e3456f858cea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-09 16:30:55.514354) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-09 16:30:55.514863) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-09 16:30:55.515195) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-09 16:30:55.544869) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-09 16:30:55.545239) ========= 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=41a7e32711b8e08598a63237000001d6-1497045106.932687-980759909 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-09 16:30:55-- 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% 42.6M=0s 2017-06-09 16:30:55 (42.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.076237 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-09 16:30:55.647752) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-09 16:30:55.648202) ========= 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=41a7e32711b8e08598a63237000001d6-1497045106.932687-980759909 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023291 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-09 16:30:55.709185) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-09 16:30:55.709519) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c4e74cfbf7e9d8e297e214478d25e3456f858cea --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 c4e74cfbf7e9d8e297e214478d25e3456f858cea --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=41a7e32711b8e08598a63237000001d6-1497045106.932687-980759909 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-09 16:30:56,062 truncating revision to first 12 chars 2017-06-09 16:30:56,062 Setting DEBUG logging. 2017-06-09 16:30:56,062 attempt 1/10 2017-06-09 16:30:56,062 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c4e74cfbf7e9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-09 16:30:57,212 unpacking tar archive at: mozilla-central-c4e74cfbf7e9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.549046 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-09 16:30:57.274832) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-09 16:30:57.278277) ========= script_repo_revision: c4e74cfbf7e9d8e297e214478d25e3456f858cea ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-09 16:30:57.278741) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-09 16:30:57.279028) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-09 16:30:57.288473) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 51 secs) (at 2017-06-09 16:30:57.288833) ========= /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=41a7e32711b8e08598a63237000001d6-1497045106.932687-980759909 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:30:57 INFO - MultiFileLogger online at 20170609 16:30:57 in /builds/slave/test 16:30:57 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:30:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:30:57 INFO - {'append_to_log': False, 16:30:57 INFO - 'base_work_dir': '/builds/slave/test', 16:30:57 INFO - 'blob_upload_branch': 'Firefox', 16:30:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:30:57 INFO - 'branch': 'Firefox', 16:30:57 INFO - 'buildbot_json_path': 'buildprops.json', 16:30:57 INFO - 'config_files': ('talos/linux_config.py',), 16:30:57 INFO - 'default_actions': ('clobber', 16:30:57 INFO - 'read-buildbot-config', 16:30:57 INFO - 'download-and-extract', 16:30:57 INFO - 'populate-webroot', 16:30:57 INFO - 'create-virtualenv', 16:30:57 INFO - 'install', 16:30:57 INFO - 'setup-mitmproxy', 16:30:57 INFO - 'run-tests'), 16:30:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:30:57 INFO - 'download_minidump_stackwalk': True, 16:30:57 INFO - 'download_symbols': 'ondemand', 16:30:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:30:57 INFO - 'tooltool.py': '/tools/tooltool.py', 16:30:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:30:57 INFO - '/tools/misc-python/virtualenv.py')}, 16:30:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:30:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:30:57 INFO - 'gecko_profile': False, 16:30:57 INFO - 'gecko_profile_interval': 0, 16:30:57 INFO - 'installer_path': 'installer.exe', 16:30:57 INFO - 'log_level': 'info', 16:30:57 INFO - 'log_name': 'talos', 16:30:57 INFO - 'log_to_console': True, 16:30:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:30:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:30:57 INFO - 'opt_config_files': (), 16:30:57 INFO - 'pip_index': False, 16:30:57 INFO - 'suite': 'dromaeojs-e10s', 16:30:57 INFO - 'system_bits': '32', 16:30:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:30:57 INFO - 'title': 'talos-linux64-ix-024', 16:30:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:30:57 INFO - 'use_talos_json': True, 16:30:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:30:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:30:57 INFO - 'work_dir': 'build'} 16:30:57 INFO - [mozharness: 2017-06-09 23:30:57.737258Z] Running clobber step. 16:30:57 INFO - Running pre-action listener: _resource_record_pre_action 16:30:57 INFO - Running main action method: clobber 16:30:57 INFO - rmtree: /builds/slave/test/build 16:30:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:30:59 INFO - Running post-action listener: _resource_record_post_action 16:30:59 INFO - [mozharness: 2017-06-09 23:30:59.283078Z] Finished clobber step (success) 16:30:59 INFO - [mozharness: 2017-06-09 23:30:59.283178Z] Running read-buildbot-config step. 16:30:59 INFO - Running pre-action listener: _resource_record_pre_action 16:30:59 INFO - Running main action method: read_buildbot_config 16:30:59 INFO - Using buildbot properties: 16:30:59 INFO - { 16:30:59 INFO - "project": "", 16:30:59 INFO - "product": "firefox", 16:30:59 INFO - "who": "kwierso@gmail.com", 16:30:59 INFO - "installer_path": "public/build/target.tar.bz2", 16:30:59 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 16:30:59 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 16:30:59 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 16:30:59 INFO - "stage_platform": "linux64-stylo", 16:30:59 INFO - "basedir": "/builds/slave/test", 16:30:59 INFO - "buildnumber": 133, 16:30:59 INFO - "platform": "ubuntu64_hw_stylo", 16:30:59 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:30:59 INFO - "slavebuilddir": "test", 16:30:59 INFO - "taskId": "HY3RTTBrQsW0Bss8UpLAFA", 16:30:59 INFO - "branch": "mozilla-central", 16:30:59 INFO - "script_repo_revision": "production", 16:30:59 INFO - "revision": "c4e74cfbf7e9d8e297e214478d25e3456f858cea", 16:30:59 INFO - "slavename": "talos-linux64-ix-024", 16:30:59 INFO - "repo_path": "mozilla-central" 16:30:59 INFO - } 16:30:59 INFO - Finding installer, test and symbols from parent task. 16:30:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HY3RTTBrQsW0Bss8UpLAFA'}, attempt #1 16:30:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HY3RTTBrQsW0Bss8UpLAFA'}, attempt #1 16:31:00 INFO - Task dependencies: Wzsoh7TER1GYtnPFPVfXew 16:31:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wzsoh7TER1GYtnPFPVfXew'}, attempt #1 16:31:00 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Wzsoh7TER1GYtnPFPVfXew/artifacts/public/build/target.tar.bz2 16:31:00 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Wzsoh7TER1GYtnPFPVfXew/artifacts/public/build/test_packages.json 16:31:00 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Wzsoh7TER1GYtnPFPVfXew/artifacts/public/build/target.crashreporter-symbols.zip 16:31:00 INFO - Running post-action listener: _resource_record_post_action 16:31:00 INFO - [mozharness: 2017-06-09 23:31:00.659594Z] Finished read-buildbot-config step (success) 16:31:00 INFO - [mozharness: 2017-06-09 23:31:00.659816Z] Running download-and-extract step. 16:31:00 INFO - Running pre-action listener: _resource_record_pre_action 16:31:00 INFO - Running main action method: download_and_extract 16:31:00 INFO - mkdir: /builds/slave/test/build/tests 16:31: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:31:00 INFO - trying https://queue.taskcluster.net/v1/task/Wzsoh7TER1GYtnPFPVfXew/artifacts/public/build/target.test_packages.json 16:31:00 INFO - Downloading https://queue.taskcluster.net/v1/task/Wzsoh7TER1GYtnPFPVfXew/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:31:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wzsoh7TER1GYtnPFPVfXew/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:31:01 INFO - Downloaded 989 bytes. 16:31:01 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:31:01 INFO - Using the following test package requirements: 16:31:01 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:31:01 INFO - u'common': [u'target.common.tests.zip'], 16:31:01 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:31:01 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:31:01 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:31:01 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:31:01 INFO - u'mozbase': [u'target.common.tests.zip'], 16:31:01 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:31:01 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:31:01 INFO - u'web-platform': [u'target.common.tests.zip', 16:31:01 INFO - u'target.web-platform.tests.tar.gz'], 16:31:01 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:31:01 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:31:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Wzsoh7TER1GYtnPFPVfXew/artifacts/public/build/target.common.tests.zip 16:31:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wzsoh7TER1GYtnPFPVfXew/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:31:01 INFO - Fetch https://queue.taskcluster.net/v1/task/Wzsoh7TER1GYtnPFPVfXew/artifacts/public/build/target.common.tests.zip into memory 16:31:02 INFO - Content-Length response header: 67876733 16:31:02 INFO - Bytes received: 67876733 16:31:13 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:31:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Wzsoh7TER1GYtnPFPVfXew/artifacts/public/build/target.common.tests.zip 16:31:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wzsoh7TER1GYtnPFPVfXew/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:31:13 INFO - Fetch https://queue.taskcluster.net/v1/task/Wzsoh7TER1GYtnPFPVfXew/artifacts/public/build/target.common.tests.zip into memory 16:31:14 INFO - Content-Length response header: 67876733 16:31:14 INFO - Bytes received: 67876733 16:31:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Wzsoh7TER1GYtnPFPVfXew/artifacts/public/build/target.talos.tests.zip 16:31:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wzsoh7TER1GYtnPFPVfXew/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:31:26 INFO - Fetch https://queue.taskcluster.net/v1/task/Wzsoh7TER1GYtnPFPVfXew/artifacts/public/build/target.talos.tests.zip into memory 16:31:27 INFO - Content-Length response header: 14449999 16:31:27 INFO - Bytes received: 14449999 16:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:27 INFO - trying https://queue.taskcluster.net/v1/task/Wzsoh7TER1GYtnPFPVfXew/artifacts/public/build/target.tar.bz2 16:31:27 INFO - Downloading https://queue.taskcluster.net/v1/task/Wzsoh7TER1GYtnPFPVfXew/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:31:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wzsoh7TER1GYtnPFPVfXew/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:31:28 INFO - Downloaded 61206145 bytes. 16:31:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Wzsoh7TER1GYtnPFPVfXew/artifacts/public/build/target.tar.bz2 16:31:28 INFO - mkdir: /builds/slave/test/properties 16:31:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:31:28 INFO - Writing to file /builds/slave/test/properties/build_url 16:31:28 INFO - Contents: 16:31:28 INFO - build_url:https://queue.taskcluster.net/v1/task/Wzsoh7TER1GYtnPFPVfXew/artifacts/public/build/target.tar.bz2 16:31:28 INFO - Running post-action listener: _resource_record_post_action 16:31:28 INFO - Running post-action listener: set_extra_try_arguments 16:31:28 INFO - [mozharness: 2017-06-09 23:31:28.966943Z] Finished download-and-extract step (success) 16:31:28 INFO - [mozharness: 2017-06-09 23:31:28.967040Z] Running populate-webroot step. 16:31:28 INFO - Running pre-action listener: _resource_record_pre_action 16:31:28 INFO - Running main action method: populate_webroot 16:31:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:31:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:31:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:31:28 INFO - '--tppagecycles', 16:31:28 INFO - '7'], 16:31:28 INFO - 'tests': ['tsvgm']}}, 16:31:28 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:31:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:31:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:31:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:31:28 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:31:28 INFO - 'talos_options': ['--disable-e10s'], 16:31:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:31:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:31:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:31:28 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:31:28 INFO - 'talos_options': ['--disable-e10s'], 16:31:28 INFO - 'tests': ['damp', 'tps']}, 16:31:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:31:28 INFO - 'tests': ['damp', 'tps']}, 16:31:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:31:28 INFO - 'tests': ['dromaeo_dom']}, 16:31:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:31:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:31:28 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:31:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:31:28 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 16:31:28 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 16:31:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:31:28 INFO - 'tests': ['a11yr', 16:31:28 INFO - 'ts_paint', 16:31:28 INFO - 'tpaint', 16:31:28 INFO - 'sessionrestore', 16:31:28 INFO - 'sessionrestore_no_auto_restore', 16:31:28 INFO - 'tabpaint']}, 16:31:28 INFO - 'other-e10s': {'tests': ['a11yr', 16:31:28 INFO - 'ts_paint', 16:31:28 INFO - 'tpaint', 16:31:28 INFO - 'sessionrestore', 16:31:28 INFO - 'sessionrestore_no_auto_restore', 16:31:28 INFO - 'tabpaint']}, 16:31:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:31:28 INFO - 'ts_paint', 16:31:28 INFO - 'tpaint', 16:31:28 INFO - 'sessionrestore', 16:31:28 INFO - 'sessionrestore_no_auto_restore', 16:31:28 INFO - 'tabpaint']}, 16:31:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:31:28 INFO - 'ts_paint', 16:31:28 INFO - 'tpaint', 16:31:28 INFO - 'sessionrestore', 16:31:28 INFO - 'sessionrestore_no_auto_restore', 16:31:28 INFO - 'tabpaint']}, 16:31:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:31:28 INFO - 'tests': ['a11yr', 16:31:28 INFO - 'ts_paint', 16:31:28 INFO - 'tpaint', 16:31:28 INFO - 'sessionrestore', 16:31:28 INFO - 'sessionrestore_no_auto_restore', 16:31:28 INFO - 'tabpaint']}, 16:31:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:31:28 INFO - 'tests': ['a11yr', 16:31:28 INFO - 'ts_paint', 16:31:28 INFO - 'tpaint', 16:31:28 INFO - 'sessionrestore', 16:31:28 INFO - 'sessionrestore_no_auto_restore', 16:31:28 INFO - 'tabpaint']}, 16:31:28 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 16:31:28 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 16:31:28 INFO - 'bloom_basic_ref']}, 16:31:28 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 16:31:28 INFO - 'talos_options': ['--mitmproxy', 16:31:28 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 16:31:28 INFO - '--firstNonBlankPaint'], 16:31:28 INFO - 'tests': ['quantum_pageload_google', 16:31:28 INFO - 'quantum_pageload_youtube', 16:31:28 INFO - 'quantum_pageload_amazon', 16:31:28 INFO - 'quantum_pageload_facebook']}, 16:31:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:31:28 INFO - 'tests': ['tsvgx', 16:31:28 INFO - 'tsvgr_opacity', 16:31:28 INFO - 'tart', 16:31:28 INFO - 'tscrollx', 16:31:28 INFO - 'cart', 16:31:28 INFO - 'tsvg_static']}, 16:31:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:31:28 INFO - 'tsvgr_opacity', 16:31:28 INFO - 'tart', 16:31:28 INFO - 'tscrollx', 16:31:28 INFO - 'cart', 16:31:28 INFO - 'tsvg_static']}, 16:31:28 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:31:28 INFO - 'talos_options': ['--disable-e10s'], 16:31:28 INFO - 'tests': ['tp5o']}, 16:31:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:31:28 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:31:28 INFO - 'talos_options': ['--disable-e10s', 16:31:28 INFO - '--xperf_path', 16:31:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:31:28 INFO - 'tests': ['tp5n']}, 16:31:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:31:28 INFO - 'talos_options': ['--xperf_path', 16:31:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:31:28 INFO - 'tests': ['tp5n']}}, 16:31:28 INFO - 'talos.zip': {'path': '', 16:31:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:31:28 INFO - Running post-action listener: _resource_record_post_action 16:31:28 INFO - [mozharness: 2017-06-09 23:31:28.981812Z] Finished populate-webroot step (success) 16:31:28 INFO - [mozharness: 2017-06-09 23:31:28.981901Z] Running create-virtualenv step. 16:31:28 INFO - Running pre-action listener: _resource_record_pre_action 16:31:28 INFO - Running main action method: create_virtualenv 16:31:28 INFO - Creating virtualenv /builds/slave/test/build/venv 16:31:28 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:31:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:31:28 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 16:31:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:31:29 INFO - Using real prefix '/usr' 16:31:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:31:29 INFO - Installing distribute.............................................................................................................................................................................................done. 16:31:31 INFO - Installing pip.................done. 16:31:31 INFO - Return code: 0 16:31:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:31:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:31:31 INFO - Reading from file tmpfile_stdout 16:31:31 INFO - Output received: 16:31:31 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:31:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:31: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:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31: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:31:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:31 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 0x1e083b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21869a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2184140>, '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 0x2184a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2184ed0>, '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': '41a7e32711b8e08598a63237000001d6-1497045106.932687-980759909', '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:31:31 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:31:31 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:31:31 INFO - Using env: {'DISPLAY': ':0', 16:31:31 INFO - 'HOME': '/home/cltbld', 16:31:31 INFO - 'LANG': 'en_US.UTF-8', 16:31:31 INFO - 'LANGUAGE': 'en_US:en', 16:31:31 INFO - 'LOGNAME': 'cltbld', 16:31:31 INFO - 'MAIL': '/var/mail/cltbld', 16:31:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:31 INFO - 'MOZ_NO_REMOTE': '1', 16:31:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:31 INFO - 'NO_EM_RESTART': '1', 16:31:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:31 INFO - 'PWD': '/builds/slave/test', 16:31:31 INFO - 'SHELL': '/bin/bash', 16:31:31 INFO - 'SHLVL': '1', 16:31:31 INFO - 'TERM': 'linux', 16:31:31 INFO - 'TMOUT': '86400', 16:31:31 INFO - 'USER': 'cltbld', 16:31:31 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1497045106.932687-980759909', 16:31:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:31 INFO - '_': '/tools/buildbot/bin/python'} 16:31:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:31 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:31:31 INFO - Cleaning up... 16:31:32 INFO - Return code: 0 16:31:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1e083b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21869a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2184140>, '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 0x2184a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2184ed0>, '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': '41a7e32711b8e08598a63237000001d6-1497045106.932687-980759909', '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:31:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 16:31:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 16:31:32 INFO - Using env: {'DISPLAY': ':0', 16:31:32 INFO - 'HOME': '/home/cltbld', 16:31:32 INFO - 'LANG': 'en_US.UTF-8', 16:31:32 INFO - 'LANGUAGE': 'en_US:en', 16:31:32 INFO - 'LOGNAME': 'cltbld', 16:31:32 INFO - 'MAIL': '/var/mail/cltbld', 16:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:32 INFO - 'MOZ_NO_REMOTE': '1', 16:31:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:32 INFO - 'NO_EM_RESTART': '1', 16:31:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:32 INFO - 'PWD': '/builds/slave/test', 16:31:32 INFO - 'SHELL': '/bin/bash', 16:31:32 INFO - 'SHLVL': '1', 16:31:32 INFO - 'TERM': 'linux', 16:31:32 INFO - 'TMOUT': '86400', 16:31:32 INFO - 'USER': 'cltbld', 16:31:32 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1497045106.932687-980759909', 16:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:32 INFO - '_': '/tools/buildbot/bin/python'} 16:31:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:32 INFO - Downloading/unpacking psutil>=3.1.1 16:31:32 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:31:32 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:31:32 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:31:32 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:31:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:31:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:31:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:31:33 INFO - Installing collected packages: psutil 16:31:33 INFO - Running setup.py install for psutil 16:31:33 INFO - building 'psutil._psutil_linux' extension 16:31:33 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:31:33 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:31:33 INFO - building 'psutil._psutil_posix' extension 16:31:33 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:31:33 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:31:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:31:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:31:33 INFO - Successfully installed psutil 16:31:33 INFO - Cleaning up... 16:31:33 INFO - Return code: 0 16:31:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e083b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21869a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2184140>, '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 0x2184a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2184ed0>, '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': '41a7e32711b8e08598a63237000001d6-1497045106.932687-980759909', '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:31:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:31:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:31:33 INFO - Using env: {'DISPLAY': ':0', 16:31:33 INFO - 'HOME': '/home/cltbld', 16:31:33 INFO - 'LANG': 'en_US.UTF-8', 16:31:33 INFO - 'LANGUAGE': 'en_US:en', 16:31:33 INFO - 'LOGNAME': 'cltbld', 16:31:33 INFO - 'MAIL': '/var/mail/cltbld', 16:31:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:33 INFO - 'MOZ_NO_REMOTE': '1', 16:31:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:33 INFO - 'NO_EM_RESTART': '1', 16:31:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:33 INFO - 'PWD': '/builds/slave/test', 16:31:33 INFO - 'SHELL': '/bin/bash', 16:31:33 INFO - 'SHLVL': '1', 16:31:33 INFO - 'TERM': 'linux', 16:31:33 INFO - 'TMOUT': '86400', 16:31:33 INFO - 'USER': 'cltbld', 16:31:33 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1497045106.932687-980759909', 16:31:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:33 INFO - '_': '/tools/buildbot/bin/python'} 16:31:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:31:34 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:31:34 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:31:34 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:31:34 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:31:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:31:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:31:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:31:35 INFO - Installing collected packages: mozsystemmonitor 16:31:35 INFO - Running setup.py install for mozsystemmonitor 16:31:35 INFO - Successfully installed mozsystemmonitor 16:31:35 INFO - Cleaning up... 16:31:35 INFO - Return code: 0 16:31:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1e083b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21869a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2184140>, '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 0x2184a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2184ed0>, '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': '41a7e32711b8e08598a63237000001d6-1497045106.932687-980759909', '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:31:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:31:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:31:35 INFO - Using env: {'DISPLAY': ':0', 16:31:35 INFO - 'HOME': '/home/cltbld', 16:31:35 INFO - 'LANG': 'en_US.UTF-8', 16:31:35 INFO - 'LANGUAGE': 'en_US:en', 16:31:35 INFO - 'LOGNAME': 'cltbld', 16:31:35 INFO - 'MAIL': '/var/mail/cltbld', 16:31:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:35 INFO - 'MOZ_NO_REMOTE': '1', 16:31:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:35 INFO - 'NO_EM_RESTART': '1', 16:31:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:35 INFO - 'PWD': '/builds/slave/test', 16:31:35 INFO - 'SHELL': '/bin/bash', 16:31:35 INFO - 'SHLVL': '1', 16:31:35 INFO - 'TERM': 'linux', 16:31:35 INFO - 'TMOUT': '86400', 16:31:35 INFO - 'USER': 'cltbld', 16:31:35 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1497045106.932687-980759909', 16:31:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:35 INFO - '_': '/tools/buildbot/bin/python'} 16:31:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:35 INFO - Downloading/unpacking jsonschema==2.5.1 16:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:31:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:36 INFO - Downloading functools32-3.2.3-2.tar.gz 16:31:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:31:36 INFO - warning: no files found matching '*.txt' 16:31:36 INFO - no previously-included directories found matching 'build' 16:31:36 INFO - no previously-included directories found matching 'dist' 16:31:36 INFO - no previously-included directories found matching '.git*' 16:31:36 INFO - Installing collected packages: jsonschema, functools32 16:31:36 INFO - Running setup.py install for functools32 16:31:37 INFO - warning: no files found matching '*.txt' 16:31:37 INFO - no previously-included directories found matching 'build' 16:31:37 INFO - no previously-included directories found matching 'dist' 16:31:37 INFO - no previously-included directories found matching '.git*' 16:31:37 INFO - Successfully installed jsonschema functools32 16:31:37 INFO - Cleaning up... 16:31:37 INFO - Return code: 0 16:31:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1e083b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21869a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2184140>, '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 0x2184a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2184ed0>, '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': '41a7e32711b8e08598a63237000001d6-1497045106.932687-980759909', '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:31:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:31:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:31:37 INFO - Using env: {'DISPLAY': ':0', 16:31:37 INFO - 'HOME': '/home/cltbld', 16:31:37 INFO - 'LANG': 'en_US.UTF-8', 16:31:37 INFO - 'LANGUAGE': 'en_US:en', 16:31:37 INFO - 'LOGNAME': 'cltbld', 16:31:37 INFO - 'MAIL': '/var/mail/cltbld', 16:31:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:37 INFO - 'MOZ_NO_REMOTE': '1', 16:31:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:37 INFO - 'NO_EM_RESTART': '1', 16:31:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:37 INFO - 'PWD': '/builds/slave/test', 16:31:37 INFO - 'SHELL': '/bin/bash', 16:31:37 INFO - 'SHLVL': '1', 16:31:37 INFO - 'TERM': 'linux', 16:31:37 INFO - 'TMOUT': '86400', 16:31:37 INFO - 'USER': 'cltbld', 16:31:37 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1497045106.932687-980759909', 16:31:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:37 INFO - '_': '/tools/buildbot/bin/python'} 16:31:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:31:37 INFO - Cleaning up... 16:31:37 INFO - Return code: 0 16:31:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1e083b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21869a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2184140>, '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 0x2184a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2184ed0>, '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': '41a7e32711b8e08598a63237000001d6-1497045106.932687-980759909', '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:31:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:31:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:31:37 INFO - Using env: {'DISPLAY': ':0', 16:31:37 INFO - 'HOME': '/home/cltbld', 16:31:37 INFO - 'LANG': 'en_US.UTF-8', 16:31:37 INFO - 'LANGUAGE': 'en_US:en', 16:31:37 INFO - 'LOGNAME': 'cltbld', 16:31:37 INFO - 'MAIL': '/var/mail/cltbld', 16:31:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:37 INFO - 'MOZ_NO_REMOTE': '1', 16:31:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:37 INFO - 'NO_EM_RESTART': '1', 16:31:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:37 INFO - 'PWD': '/builds/slave/test', 16:31:37 INFO - 'SHELL': '/bin/bash', 16:31:37 INFO - 'SHLVL': '1', 16:31:37 INFO - 'TERM': 'linux', 16:31:37 INFO - 'TMOUT': '86400', 16:31:37 INFO - 'USER': 'cltbld', 16:31:37 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1497045106.932687-980759909', 16:31:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:37 INFO - '_': '/tools/buildbot/bin/python'} 16:31:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:37 INFO - Downloading/unpacking blobuploader==1.2.4 16:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:38 INFO - Downloading blobuploader-1.2.4.tar.gz 16:31:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:31:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:31:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:39 INFO - Downloading docopt-0.6.1.tar.gz 16:31:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:31:39 INFO - Installing collected packages: blobuploader, requests, docopt 16:31:39 INFO - Running setup.py install for blobuploader 16:31:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:31:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:31:39 INFO - Running setup.py install for requests 16:31:39 INFO - Running setup.py install for docopt 16:31:39 INFO - Successfully installed blobuploader requests docopt 16:31:39 INFO - Cleaning up... 16:31:39 INFO - Return code: 0 16:31:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:31:39 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:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:39 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:31:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:39 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 0x1e083b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21869a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2184140>, '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 0x2184a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2184ed0>, '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': '41a7e32711b8e08598a63237000001d6-1497045106.932687-980759909', '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:31:39 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:31:39 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:31:39 INFO - Using env: {'DISPLAY': ':0', 16:31:39 INFO - 'HOME': '/home/cltbld', 16:31:39 INFO - 'LANG': 'en_US.UTF-8', 16:31:39 INFO - 'LANGUAGE': 'en_US:en', 16:31:39 INFO - 'LOGNAME': 'cltbld', 16:31:39 INFO - 'MAIL': '/var/mail/cltbld', 16:31:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:39 INFO - 'MOZ_NO_REMOTE': '1', 16:31:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:39 INFO - 'NO_EM_RESTART': '1', 16:31:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:39 INFO - 'PWD': '/builds/slave/test', 16:31:39 INFO - 'SHELL': '/bin/bash', 16:31:39 INFO - 'SHLVL': '1', 16:31:39 INFO - 'TERM': 'linux', 16:31:39 INFO - 'TMOUT': '86400', 16:31:39 INFO - 'USER': 'cltbld', 16:31:39 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1497045106.932687-980759909', 16:31:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:39 INFO - '_': '/tools/buildbot/bin/python'} 16:31:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:31:40 INFO - Running setup.py (path:/tmp/pip-J0bQb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:31:40 INFO - Running setup.py (path:/tmp/pip-umYsAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:31:40 INFO - Running setup.py (path:/tmp/pip-8xPwmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:31:40 INFO - Running setup.py (path:/tmp/pip-1ssDrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:31:40 INFO - Running setup.py (path:/tmp/pip-eOrTiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:31:40 INFO - Running setup.py (path:/tmp/pip-s5Fq2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:31:40 INFO - Running setup.py (path:/tmp/pip-izi9gb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:31:40 INFO - Running setup.py (path:/tmp/pip-Oh4bk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:31:40 INFO - Running setup.py (path:/tmp/pip-chAqcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:31:40 INFO - Running setup.py (path:/tmp/pip-n8LCar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:31:40 INFO - Running setup.py (path:/tmp/pip-tLJ_IP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:31:40 INFO - Running setup.py (path:/tmp/pip-7_pW90-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:31:40 INFO - Running setup.py (path:/tmp/pip-lreXDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:31:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:31:40 INFO - Running setup.py (path:/tmp/pip-bgXOl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:41 INFO - Running setup.py (path:/tmp/pip-fdTkj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:31:41 INFO - Running setup.py (path:/tmp/pip-AOgy1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:31:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:31:41 INFO - Running setup.py (path:/tmp/pip-fuoZqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:31:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:31:41 INFO - Running setup.py install for manifestparser 16:31:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:31:41 INFO - Running setup.py install for mozcrash 16:31:41 INFO - Running setup.py install for mozdebug 16:31:41 INFO - Running setup.py install for mozdevice 16:31:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:31:41 INFO - Running setup.py install for mozfile 16:31:41 INFO - Running setup.py install for mozhttpd 16:31:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:31:41 INFO - Running setup.py install for mozinfo 16:31:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:31:41 INFO - Running setup.py install for mozInstall 16:31:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:31:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:31:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:31:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:31:42 INFO - Running setup.py install for mozleak 16:31:42 INFO - Running setup.py install for mozlog 16:31:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:31:42 INFO - Running setup.py install for moznetwork 16:31:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:31:42 INFO - Running setup.py install for mozprocess 16:31:42 INFO - Running setup.py install for mozprofile 16:31:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:31:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:31:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:31:42 INFO - Running setup.py install for mozrunner 16:31:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:31:42 INFO - Running setup.py install for mozscreenshot 16:31:42 INFO - Running setup.py install for moztest 16:31:42 INFO - Running setup.py install for mozversion 16:31:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:31:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:31:43 INFO - Cleaning up... 16:31:43 INFO - Return code: 0 16:31:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:43 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 0x1e083b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21869a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2184140>, '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 0x2184a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2184ed0>, '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': '41a7e32711b8e08598a63237000001d6-1497045106.932687-980759909', '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:31:43 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:31:43 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:31:43 INFO - Using env: {'DISPLAY': ':0', 16:31:43 INFO - 'HOME': '/home/cltbld', 16:31:43 INFO - 'LANG': 'en_US.UTF-8', 16:31:43 INFO - 'LANGUAGE': 'en_US:en', 16:31:43 INFO - 'LOGNAME': 'cltbld', 16:31:43 INFO - 'MAIL': '/var/mail/cltbld', 16:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:43 INFO - 'MOZ_NO_REMOTE': '1', 16:31:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:43 INFO - 'NO_EM_RESTART': '1', 16:31:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:43 INFO - 'PWD': '/builds/slave/test', 16:31:43 INFO - 'SHELL': '/bin/bash', 16:31:43 INFO - 'SHLVL': '1', 16:31:43 INFO - 'TERM': 'linux', 16:31:43 INFO - 'TMOUT': '86400', 16:31:43 INFO - 'USER': 'cltbld', 16:31:43 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1497045106.932687-980759909', 16:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:43 INFO - '_': '/tools/buildbot/bin/python'} 16:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:31:43 INFO - Running setup.py (path:/tmp/pip-bIYK57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:31:43 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:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:31:43 INFO - Running setup.py (path:/tmp/pip-y7R65L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:31:43 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:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:31:43 INFO - Running setup.py (path:/tmp/pip-6SGa_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:31:43 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:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:31:43 INFO - Running setup.py (path:/tmp/pip-hVHshK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:31:43 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:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:31:43 INFO - Running setup.py (path:/tmp/pip-ZtsO2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:31:43 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:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:31:43 INFO - Running setup.py (path:/tmp/pip-7MGVw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:31:43 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:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:31:43 INFO - Running setup.py (path:/tmp/pip-iWyX1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:31:43 INFO - Running setup.py (path:/tmp/pip-CPWtzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:31:43 INFO - Running setup.py (path:/tmp/pip-yUCLsm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:31:43 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:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:31:43 INFO - Running setup.py (path:/tmp/pip-R9R_Gp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:31:44 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:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:31:44 INFO - Running setup.py (path:/tmp/pip-ZdtiS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:31:44 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:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:31:44 INFO - Running setup.py (path:/tmp/pip-LmLxfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:31:44 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:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:31:44 INFO - Running setup.py (path:/tmp/pip-u5uKE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:31:44 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:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:31:44 INFO - Running setup.py (path:/tmp/pip-SuJ0nV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:31:44 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:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:44 INFO - Running setup.py (path:/tmp/pip-e3Bhat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:44 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:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:31:44 INFO - Running setup.py (path:/tmp/pip-qI2V22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:31:44 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:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:31:44 INFO - Running setup.py (path:/tmp/pip-04cE1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:31:44 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:31:44 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:31:44 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:31:44 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:31:44 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:31:44 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:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:31:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:45 INFO - Downloading blessings-1.6.tar.gz 16:31:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:31:45 INFO - Installing collected packages: blessings 16:31:45 INFO - Running setup.py install for blessings 16:31:45 INFO - Successfully installed blessings 16:31:45 INFO - Cleaning up... 16:31:45 INFO - Return code: 0 16:31:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:31:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:31:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:31:46 INFO - Reading from file tmpfile_stdout 16:31:46 INFO - Current package versions: 16:31:46 INFO - argparse == 1.2.1 16:31:46 INFO - blessings == 1.6 16:31:46 INFO - blobuploader == 1.2.4 16:31:46 INFO - docopt == 0.6.1 16:31:46 INFO - functools32 == 3.2.3-2 16:31:46 INFO - jsonschema == 2.5.1 16:31:46 INFO - manifestparser == 1.1 16:31:46 INFO - mozInstall == 1.13 16:31:46 INFO - mozcrash == 1.0 16:31:46 INFO - mozdebug == 0.1 16:31:46 INFO - mozdevice == 0.51 16:31:46 INFO - mozfile == 1.2 16:31:46 INFO - mozhttpd == 0.7 16:31:46 INFO - mozinfo == 0.10 16:31:46 INFO - mozleak == 0.1 16:31:46 INFO - mozlog == 3.4 16:31:46 INFO - moznetwork == 0.27 16:31:46 INFO - mozprocess == 0.25 16:31:46 INFO - mozprofile == 0.28 16:31:46 INFO - mozrunner == 6.13 16:31:46 INFO - mozscreenshot == 0.1 16:31:46 INFO - mozsystemmonitor == 0.3 16:31:46 INFO - moztest == 0.8 16:31:46 INFO - mozversion == 1.4 16:31:46 INFO - psutil == 3.1.1 16:31:46 INFO - requests == 1.2.3 16:31:46 INFO - wsgiref == 0.1.2 16:31:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:31:46 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:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:46 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:31:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:46 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 0x1e083b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21869a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2184140>, '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 0x2184a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2184ed0>, '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': '41a7e32711b8e08598a63237000001d6-1497045106.932687-980759909', '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:31:46 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:31:46 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:31:46 INFO - Using env: {'DISPLAY': ':0', 16:31:46 INFO - 'HOME': '/home/cltbld', 16:31:46 INFO - 'LANG': 'en_US.UTF-8', 16:31:46 INFO - 'LANGUAGE': 'en_US:en', 16:31:46 INFO - 'LOGNAME': 'cltbld', 16:31:46 INFO - 'MAIL': '/var/mail/cltbld', 16:31:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:46 INFO - 'MOZ_NO_REMOTE': '1', 16:31:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:46 INFO - 'NO_EM_RESTART': '1', 16:31:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:46 INFO - 'PWD': '/builds/slave/test', 16:31:46 INFO - 'SHELL': '/bin/bash', 16:31:46 INFO - 'SHLVL': '1', 16:31:46 INFO - 'TERM': 'linux', 16:31:46 INFO - 'TMOUT': '86400', 16:31:46 INFO - 'USER': 'cltbld', 16:31:46 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1497045106.932687-980759909', 16:31:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:46 INFO - '_': '/tools/buildbot/bin/python'} 16:31:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:46 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:31:46 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:31:46 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:31:46 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:31:46 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:31:46 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:31:46 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:31:46 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:31:46 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:31:46 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 16:31:46 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:31:46 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:31:46 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:31:46 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:31:47 INFO - Downloading marionette_driver-1.4.0.tar.gz 16:31:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 16:31:47 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:31:47 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:31:47 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:31:47 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:31:47 INFO - Installing collected packages: marionette-driver 16:31:47 INFO - Running setup.py install for marionette-driver 16:31:47 INFO - Successfully installed marionette-driver 16:31:47 INFO - Cleaning up... 16:31:47 INFO - Return code: 0 16:31:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:47 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 0x1e083b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe2a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21869a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2184140>, '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 0x2184a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2184ed0>, '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': '41a7e32711b8e08598a63237000001d6-1497045106.932687-980759909', '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:31:47 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:31:47 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:31:47 INFO - Using env: {'DISPLAY': ':0', 16:31:47 INFO - 'HOME': '/home/cltbld', 16:31:47 INFO - 'LANG': 'en_US.UTF-8', 16:31:47 INFO - 'LANGUAGE': 'en_US:en', 16:31:47 INFO - 'LOGNAME': 'cltbld', 16:31:47 INFO - 'MAIL': '/var/mail/cltbld', 16:31:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:47 INFO - 'MOZ_NO_REMOTE': '1', 16:31:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:47 INFO - 'NO_EM_RESTART': '1', 16:31:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:47 INFO - 'PWD': '/builds/slave/test', 16:31:47 INFO - 'SHELL': '/bin/bash', 16:31:47 INFO - 'SHLVL': '1', 16:31:47 INFO - 'TERM': 'linux', 16:31:47 INFO - 'TMOUT': '86400', 16:31:47 INFO - 'USER': 'cltbld', 16:31:47 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1497045106.932687-980759909', 16:31:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:47 INFO - '_': '/tools/buildbot/bin/python'} 16:31:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:31:47 INFO - Cleaning up... 16:31:47 INFO - Return code: 0 16:31:47 INFO - Running post-action listener: _resource_record_post_action 16:31:47 INFO - Running post-action listener: _start_resource_monitoring 16:31:47 INFO - Starting resource monitoring. 16:31:47 INFO - [mozharness: 2017-06-09 23:31:47.896363Z] Finished create-virtualenv step (success) 16:31:47 INFO - [mozharness: 2017-06-09 23:31:47.896865Z] Running install step. 16:31:47 INFO - Running pre-action listener: _resource_record_pre_action 16:31:47 INFO - Running main action method: install 16:31:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:31:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:31:48 INFO - Reading from file tmpfile_stdout 16:31:48 INFO - Detecting whether we're running mozinstall >=1.0... 16:31:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:31:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:31:48 INFO - Reading from file tmpfile_stdout 16:31:48 INFO - Output received: 16:31:48 INFO - Usage: mozinstall [options] installer 16:31:48 INFO - Options: 16:31:48 INFO - -h, --help show this help message and exit 16:31:48 INFO - -d DEST, --destination=DEST 16:31:48 INFO - Directory to install application into. [default: 16:31:48 INFO - "/builds/slave/test"] 16:31:48 INFO - --app=APP Application being installed. [default: firefox] 16:31:48 INFO - mkdir: /builds/slave/test/build/application 16:31:48 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:31:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:32:05 INFO - Reading from file tmpfile_stdout 16:32:05 INFO - Output received: 16:32:05 INFO - /builds/slave/test/build/application/firefox/firefox 16:32:05 INFO - Running post-action listener: _resource_record_post_action 16:32:05 INFO - [mozharness: 2017-06-09 23:32:05.985164Z] Finished install step (success) 16:32:05 INFO - [mozharness: 2017-06-09 23:32:05.985442Z] Running setup-mitmproxy step. 16:32:05 INFO - Running pre-action listener: _resource_record_pre_action 16:32:05 INFO - Running main action method: setup_mitmproxy 16:32:05 INFO - Skipping: mitmproxy is not required 16:32:05 INFO - Running post-action listener: _resource_record_post_action 16:32:05 INFO - [mozharness: 2017-06-09 23:32:05.986551Z] Finished setup-mitmproxy step (success) 16:32:05 INFO - [mozharness: 2017-06-09 23:32:05.986782Z] Running run-tests step. 16:32:05 INFO - Running pre-action listener: _resource_record_pre_action 16:32:05 INFO - Running main action method: run_tests 16:32:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:32:05 INFO - Python 2.7.3 16:32:05 INFO - Return code: 0 16:32:05 INFO - grabbing minidump binary from tooltool 16:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:32:05 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2184140>, '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 0x2184a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2184ed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:32:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:32:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:32:05 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:32:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:32:06 INFO - Return code: 0 16:32:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:32:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:32:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:32:06 INFO - ENV: RUST_BACKTRACE is now 1 16:32:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:32:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:32:06 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/Wzsoh7TER1GYtnPFPVfXew/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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:32:06 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/Wzsoh7TER1GYtnPFPVfXew/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-024 --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:32:06 INFO - Using env: {'DISPLAY': ':0', 16:32:06 INFO - 'HOME': '/home/cltbld', 16:32:06 INFO - 'LANG': 'en_US.UTF-8', 16:32:06 INFO - 'LANGUAGE': 'en_US:en', 16:32:06 INFO - 'LOGNAME': 'cltbld', 16:32:06 INFO - 'MAIL': '/var/mail/cltbld', 16:32:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:32:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:06 INFO - 'MOZ_NO_REMOTE': '1', 16:32:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:32:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:06 INFO - 'NO_EM_RESTART': '1', 16:32:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:06 INFO - 'PWD': '/builds/slave/test', 16:32:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:32:06 INFO - 'RUST_BACKTRACE': '1', 16:32:06 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 16:32:06 INFO - 'SHELL': '/bin/bash', 16:32:06 INFO - 'SHLVL': '1', 16:32:06 INFO - 'TERM': 'linux', 16:32:06 INFO - 'TMOUT': '86400', 16:32:06 INFO - 'USER': 'cltbld', 16:32:06 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1497045106.932687-980759909', 16:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:06 INFO - '_': '/tools/buildbot/bin/python'} 16:32:06 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/Wzsoh7TER1GYtnPFPVfXew/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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:32:06 INFO - mozversion application_buildid: 20170609224820 16:32:06 INFO - mozversion application_changeset: c4e74cfbf7e9d8e297e214478d25e3456f858cea 16:32:06 INFO - mozversion application_display_name: Nightly 16:32:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:32:06 INFO - mozversion application_name: Firefox 16:32:06 INFO - mozversion application_remotingname: firefox 16:32:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:32:06 INFO - mozversion application_vendor: Mozilla 16:32:06 INFO - mozversion application_version: 55.0a1 16:32:06 INFO - mozversion platform_buildid: 20170609224820 16:32:06 INFO - mozversion platform_changeset: c4e74cfbf7e9d8e297e214478d25e3456f858cea 16:32:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:32:06 INFO - mozversion platform_version: 55.0a1 16:32:06 INFO - using testdate: 1497051126 16:32:06 INFO - actual date: 1497051126 16:32:06 INFO - starting webserver on 'localhost:60799' 16:32:06 INFO - SUITE-START | Running 2 tests 16:32:06 INFO - TEST-START | dromaeo_css 16:32:06 INFO - operating with platform_type : linux_ 16:32:06 INFO - Initialising browser for dromaeo_css test... 16:32:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60799/getInfo.html -profile /tmp/tmp8lPodS/profile 16:32:06 INFO - TEST-INFO | started process 939 (/builds/slave/test/build/application/firefox/firefox http://localhost:60799/getInfo.html) 16:32:41 INFO - TEST-INFO | 939: killed by SIGTERM 16:32:41 INFO - Browser initialized. 16:32:41 INFO - Running cycle 1/1 for dromaeo_css test... 16:32:41 INFO - TEST-INFO | started process 1251 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8lPodS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:32:53 INFO - PID 1251 | RSS: Main: 188112896 16:32:53 INFO - PID 1251 | 16:35:54 INFO - PID 1251 | Cycle 1(1): loaded http://localhost:60799/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60799/tests/dromaeo/cssquery-ext.html) 16:35:55 INFO - PID 1251 | RSS: Main: 183783424 16:35:55 INFO - PID 1251 | 16:38:57 INFO - PID 1251 | Cycle 1(1): loaded http://localhost:60799/tests/dromaeo/cssquery-ext.html (next: http://localhost:60799/tests/dromaeo/cssquery-jquery.html) 16:38:57 INFO - PID 1251 | RSS: Main: 189886464 16:38:57 INFO - PID 1251 | 16:41:59 INFO - PID 1251 | Cycle 1(1): loaded http://localhost:60799/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60799/tests/dromaeo/cssquery-mootools.html) 16:42:00 INFO - PID 1251 | RSS: Main: 187846656 16:42:00 INFO - PID 1251 | 16:45:02 INFO - PID 1251 | Cycle 1(1): loaded http://localhost:60799/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60799/tests/dromaeo/cssquery-prototype.html) 16:45:02 INFO - PID 1251 | RSS: Main: 191459328 16:45:02 INFO - PID 1251 | 16:48:05 INFO - PID 1251 | Cycle 1(1): loaded http://localhost:60799/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60799/tests/dromaeo/cssquery-yui.html) 16:48:06 INFO - PID 1251 | RSS: Main: 188424192 16:48:06 INFO - PID 1251 | 16:51:07 INFO - PID 1251 | Cycle 1(1): loaded http://localhost:60799/tests/dromaeo/cssquery-yui.html (next: http://localhost:60799/tests/dromaeo/cssquery-dojo.html) 16:51:08 INFO - PID 1251 | RSS: Main: 190201856 16:51:08 INFO - PID 1251 | 16:51:08 INFO - PID 1251 | __start_tp_report 16:51:08 INFO - PID 1251 | _x_x_mozilla_page_load 16:51:08 INFO - PID 1251 | _x_x_mozilla_page_load_details 16:51:08 INFO - PID 1251 | |i|pagename|runs| 16:51:08 INFO - PID 1251 | |0;dojo.html;3013.3973205358925;3033.074912151793;3052.0538633023766;3058.6329640443137;3058.6635470098286;5771.076627739562;5899.380565040673;5901.85245368866;5921.111833225018;5937.4062593740655;5835.299764028323;5907.468327850493;5911.556633252501;5918.792842250522;5977.163197152402;5247.921281180786;5406.378266499344;5423.023855705971;5423.538999185074;5511.22842802006;5533.031719449101;5536.335639723239;5547;5560.610757246995;5571.916421253684;5288.444713305086;5354;5361.35663720356;5464.508194262516;5488.780448782044;5436.429174936654;5447.972760136214;5449.7275136243425;5467.835964921019;5497;5385.623006389555;5418.485243901823;5422.75597598109;5423.538999185034;5427.891442171134;5748.5975981681295;5811.6803575803315;5871.060630299175;5871.5596330274975;5888.116782482619;6215.409536094064;6271.560990730651;6298.2442106947;6299.118123462719;6326.715297811609;6383.936160638381;6397.264314603834;6400.199975003125;6405.29541750407;6418.903716444257;5786.045302525036;5920.703964801743;5923.674197919156;5943.55423343251;5948;6165.8458538536;6255.343188965184;6268.373162683786;6287.842803929939;6434.935650643433;6069.423404776539;6091.964366057781;6149.354317796657;6190.783322583688;6225.844353891189;6285.8742825143245;6289.088082228142;6298.212723409574;6302.338254483305;6316.178896743394;6033.9698301508215;6250.781222657185;6271.05934109878;6286.9056964145575;6292.2134733158355;6265.310815810257;6268.310485846553;6314.71583778731;6348.396902294275;6372.808815735535;5123.795048198105;5128.512791284822;5145.845624631267;5150.072986862401;5165.638405311592;4388.451443569554;4399.714018588781;4401.713888597231;4414.624756895636;4421.38100665907;5382.703951282717;5455.236266922634;5467.507924286833;5489.780408783604;5554.361248456398;6343.365663433712;6346.555741098171;6383.585066970632;6385.712642931079;6415.582987105823;5472;5479.835604931858;5483.698396588226;5486.286782718221;5514.338279406497;5497.917531237034;5566.471185237396;5576.052071147915;5593.244911936837;5600.411956744565;6028.487578555872;6118.741008805849;6123.693815309217;6126.693665316806;6144.341027922525;6399.8080057598345;6410.230772307353;6414.10202571631;6415.775447859302;6418.1656384669695;6176.567640265138;6178.5366097543765;6183.721732521957;6199.1011303361665;6205.131281620667;6088.847778805565;6137.62214577108;6168.383161683975;6253.562250642593;6258.12386265914;6283.2460104787715;6363.427291543783;6364.840878978062;6371.840703982252;6382.9149044663445;5970.134330522137;6111.480524155319;6134.78528251509;6137.815865524041;6161.322254552086;6026.789062382971;6143.631382117087;6184.103305020657;6201;6244.0321750128805;5906.852328691817;6162.506999439945;6164.291106522807;6171.012637977902;6173.32093469709;6037.849053773691;6059;6080.179175811209;6112.449879510866;6119.045604113885;5922.555808314308;5925.081612350093;5936.436038576328;5939.762409503572;5961.731722072431 16:51:08 INFO - PID 1251 | |1;ext.html;728.8724473217186;771.1941021632393;792.2038351456785;1108.4457771114444;1113.899749022588;35653;36636.63363366365;36637.816810915974;36653;36787.632123678755;38805.80597097018;39023.414648780294;39204.80397598008;39399.40900886489;39565.80217098918;7147.178074521418;7212.423006159508;7303.415726741874;7313.89029164563;7374.926250737504;7336.963315183443;7433.9256607434045;7441.069866266716;7441.55350678961;7473.9252607474045;7393.445491588125;7400.185979542273;7449.553026818381;7452.06849143857;7456.925430745678;7386.372158366546;7423.628818559077;7435.51669141504;7459.776206713807;7470.850582988364;7319.377852882511;7348;7372.189059203483;7384.1877393486675;7404.925950740531;34827;35010.649893500995;35116.648833511594;35151.64848351509;35292.82353588241;3487.825608719579;3505.1061979195397;3516.8241587920757;3519.9296014079573;3523.5419395478425;27399.178024659293;27497.17508474749;27532.724672753215;27552.586711199347;27705.307367315778;3596.28074385124;3615.5661320641693;3619.1133172372674;3627.075095850568;3649.3248748981523;167809;168164.15917920455;179398;185006.07496962562;185468;42609.36085958651;42649.36025959613;42759.57240427618;42950.78524607357;43069.569304306555;45256.32115518204;45288.3206751899;50201;50953;51475.48524514707;13707;13748.106373085717;13772.03595748308;13779.517716879862;13811.792823107662;10892.727681807859;10917.290376125526;10967.725806854733;10980;11009;14123.223222722643;14317.928410357881;14324.14055156694;14419.279036048156;14544.418223271163;5654.97172514143;5708.257926469615;5711.200431939532;5813.186153938452;5882.764689412461;973.4597298499259;980.4509474694194;1000.3297790480395;1014.761531040205;1015.8730158730159;21476.89261553682;22411.43971400728;22491.325260242218;22787.430314241945;22828.086876524754;1066.424130969268;1080.4975686305906;1081.4700796609604;1103.862017247844;1104.4312179227704;11768.94115529434;11790;12189.390530473442;12373.505059797688;12783.744325113446;200350;202103;202157;202254;202352;48758.75620621874;48806.26790598144;48965.265521017216;49002.26496602554;49185.754071229414;1405.6485878530368;1452.651363672732;1454.847241039718;1455.1269238457053;1461.123326004389;21384.46538836479;21874.23440179586;22897.88551057234;22904.427389315402;23161.3051608452;35035;35301.47047794234;35381.1154721134;35381.29237415289;35706.28587428289;160898;161984;162540;162593;162598.18700906893;33222.335553288314;34659.82670086633;34826.47760283649;34946.47580286348;35028;40504.392434112924;40778;41446;41749;41930.790346048074;29600.703992960654;30390.088297351114;31234;31772.364552708354;32153.678463216005;29706.405871882875;29812;29821;30644;31521;33472.16319592029;34176;34208.65791342154;34305.14237144091;34395.4840677385;28113.676519030705;28803.56794648124;30072.69927300699;30174.84912575423;31142;22252;24213.87893060594;24264;24315.878420607783;24624.50750985006 16:51:08 INFO - PID 1251 | |2;jquery.html;480.4354883012459;487.8803146778146;489.938757655293;513.9691618502887;514.4983640950073;19573.902130489347;20211.292604758855;20328.796712032876;20635.793642063574;23073.077076916947;23013.309600711964;23693.881530592367;23715.051397944106;23722.406939826513;23801.16695915643;6194.008958566642;6328.84177895554;6329.651869147195;6330.936690633103;6338.461230795388;5405.37838148614;5849.532037437016;5891.263592050994;6233.532485063615;6295.43341099301;5858.88282234355;5863.677497737623;5877.617954832944;5885.764569417218;5899.262592175978;5847.619904706202;5854.385289544601;5871.500922421556;5878;5893.499052580536;5448.91826622601;5452.645578037414;5463.371712253102;5467.316585426822;5467.45325467454;26030.6095408569;26067.608985865227;26225.213243602724;26839.194824155307;26944.73055269442;1920.2990908318363;1936.6223586400658;1940.5439721665398;1944.9027548622653;1947.4449781812257;17136.48590542273;17530;17554.03452810095;17653.20560574777;17714.025728584922;2127.2022991378235;2174.097749433983;2211.756706762255;2237.0604346174646;2247.6516139998325;112896;116899;117140;117471;117471.4126429371;12351.629451116482;12934.741305173844;12949.223046617233;13070.607881763563;13250;19848.305309314106;19873;19940.102695378744;19950.401487955383;19972;8870.645174193089;8976.775580610538;9067.138621830916;9165.129312715282;9199.35604507678;7594.392448604099;8135.064467586185;8145.06331771842;8318.916810831814;8435.915640843636;8315.584220788936;8511;8557.187067228604;8647.654093836301;8693.565321733888;2468.271859801363;2475.913343033021;2481.2656951288195;2503.4492411669403;2594.7664710176173;926.6988228825659;945.2438049560325;961.2622790724334;991.613270824379;1000.4497526360473;18900.432987010136;19519.121639526256;20178.596428071356;20222.393328200178;20691.379258622266;972.6449845806371;1025.707673313117;1028.2031425645184;1041.4688508860536;1051.2851261142343;10297.794044119075;10680.572777088984;10768.300060496043;10854.891451085547;10936.835947460795;415048;415848;419644;429270;429967;98582.50708746554;99176.50411747895;100215;100308;100904.49547752214;1150.2121047082608;1160.7794519041356;1166.8016437205695;1171.8066519024435;1185.5435657272012;15870.444534441702;16522.678185745353;16904.830951690325;17369;17983.64032719312;46863;48140.518594813606;50251;50290.2456463146;50499.242511363096;59845;59931.70034149801;60594;60753.39246607654;60839;11233.606823761129;11388.37363944991;11469.713257168638;11470.369129697947;11581;17259.3959211432;17427.912860435616;17540.82459175392;17598.472045838644;17743.11284435747;14221.14673119616;14707.779383309045;15453.690926181638;15553;15581.29884155193;12426.5650702225;13319.334033298102;13940.512082077079;14111.153330800185;14151.504697335544;13766.380512876744;13809.309534523032;14051.648708782363;14064.08583442073;14065.296735163405;11388.37363944991;11615.419229038345;11619.709507262387;11711.590094346657;11776.116791240862;13893.58319250424;13981.720365592428;14380.856191437952;15100.093994360373;15350.539483815503 16:51:08 INFO - PID 1251 | |3;mootools.html;1313.4089659653155;1360.2654566534059;1367.3368416318085;1375.7523645743768;1383.9758578651802;11318.943405282973;11687.065034797217;11815.763684726311;11832.645020649383;12668.556600518983;12051.51793928244;12195.207311524744;12286.385680715974;12307.446164922578;12310.38448077597;2497.5754121799337;2533.429978254887;2546.2870396289068;2554.7098715148823;2559.4497183105627;2446.5351583199226;2491;2492.0530198524534;2492.8753562321904;2506.223070848043;2358.127492827656;2387.4747555537756;2395.7484464131276;2398.0767404549288;2398.37642213025;2266.3540890846193;2339.1579031548713;2344.4138965258685;2346.483773569812;2363.4564050268364;1975.101328895349;2057.2902348689677;2299.4251437140715;2305.4927915858484;2404.507076049406;11955.521779128825;12076.335801530913;12079.93960030203;12095.395230238453;12104.092193085553;6685.398314151701;6878.209005964278;6933.479989000794;6943.340382663639;6955.095837541138;4070.348744200943;4186.790660466964;4297.634701050414;4299.806508707115;4314.82740690372;1391.568613729747;1392.1368751374214;1411.350778641826;1426.2155814302093;1433;17675.646487070186;17766;17858.91070544639;17933.7309940351;17967.820321796746;5652.85867853307;5692.7722891083895;5702.942970570324;5848.298204215522;5877.265341832271;12963.351832408342;13014.739705206031;13058.15122017066;13080.28058456775;13094.934525327502;6461.547691661633;6535.379138981789;6535.934640653532;6545.21457425112;6616.536842420985;6107.083937409424;6140.8771824563255;6149.262088549313;6158;6180.598261113013;4345.39220488415;4449.1991441540185;4464.196444639996;4503.121891231179;4509.436320459942;1306.882380585752;1336.1448672849385;1341.6578772412972;1349.3657980749033;1355.1801160297878;848.2323497234889;864.4208380385157;875.4309698695771;882.6601758323092;907.0068275238604;6092.634441933498;6233.096201050822;6490.545661803629;6497.090407342976;6503.171120562571;693.5526585352419;696.2654399608462;698.2842586349033;698.4028655499576;720.9170945341248;4014.1770936957855;4215.367694845798;4333.934990975138;5049.6212784041345;5265.631405801557;15453.845461545465;15850.44523441674;15856.365745370287;15880.285387157606;15886.682266354608;14653.92673036628;15167.924160379127;15255.694886102216;15285.541433757006;15291.617709557127;9084.091590840862;9276.07239276067;9276.953615231881;9277.350585459088;9279.72160835176;6848.14398200225;6915.9345047922925;7531.849363012819;7537.660805263886;7712.652930618248;14074.507392241223;14079.648008799863;14090.577282681126;14091.436342546183;14161.645958850699;14186.574402767934;14350;14384.496542620958;14467.421303147756;14514.927425362806;11121.110311175249;11260.436978151223;11298.717532061764;11351.943240283746;11357.716057098638;11216;11281.153913456359;11410.543578256777;11414.771704565695;11425.657230283105;8722.956385218033;8729.956350218208;8916.86624700617;9077.863832042392;9358.204552612831;8728.039915609404;8844.380893337404;8860.069692682175;8932.28541716648;9136.086391361077;7865.174156713462;7906.52560846351;7912.0901096374655;7969.442139050211;7999.84000320002;5768.480836724715;5785.971070144622;5799.652020878761;5806.165689843133;6040.607360521552;5314.441983591667;5519.227308176939;5532.446755324436;5608.298962629671;6000.189974353581 16:51:08 INFO - PID 1251 | |4;prototype.html;441.98895027624303;443.6628162596427;453.77764895201364;454.6544626084173;454.84535258012266;6009.402806852761;6230.968845155768;6249.531285153609;6319.146915166451;6326.4938804895555;5946.435088666581;6043.274807023153;6063.272407311118;6081.726322315495;6083.908741368872;4769.427668679763;4831.202851529511;4860.854174374775;4868.148074087029;4876.878078048059;4916.729579873106;4919.483454237307;4932.96407754372;4933.705826790541;4935.014316338599;4836.564709176174;4846.830360937368;4858.975705121469;4860.489648586883;4880.193449109683;4867.683600565952;4877.268409738532;4879.585235255007;4888.266759985995;4901.534354236342;4325.178216138924;4325.632321252698;4339.761313127777;4348.326009468537;4358.869233922987;6038.939610603882;6068;6100.633961962252;6106.358832322587;6125.173101631267;5557.3886872444;5580.972095139539;5582.6043489127715;5590.413006634286;5627.634203776742;6496.5127615428555;6517.250516190651;6531.379518945692;6547.279799222082;6577.572457790228;4709.858704238878;4716.740579268139;4724.692894961817;4738.076075165344;4743.193657078305;6437.774677886251;6754.45964322853;6875.140607424072;6917.9308206917785;6920.515563910478;4733.763311834395;4753.762311884392;4790.688605240648;4795.160846851787;4797.160496913027;4827.42070951488;4835.782389792468;4848.75756212195;4861.732604706775;4873.561379475864;5374.5700343972385;5501.119820828728;5515.558755299567;5533.944660553423;5547.195656629847;6527.640979746065;6538.346165383518;6545.214574251025;6559.967200164064;6564.507661925375;1674.9581260468585;1675.9245833937503;1681.1510187355307;1681.7393304037894;1684.9157542122846;1102.6251074634663;1140.5380820767602;1151.4300421291514;1151.792677318074;1160.3791971295486;5669.06460434032;5683.772649094072;5749.9712501437225;5754.705191332;5770.365259821417;6723.394894459522;6761.290064543152;6772.661366931634;6789;6792.252852186256;5688.516476099495;5701.116326969326;5703.657780533098;5722.885542289131;5728.484436400744;3562.608113107556;3573.4997100405963;3591.1505574629086;3597.388443964532;3615.837287322077;6493.383128602775;6519.445847102955;6521.347865213441;6533.738650454024;6542.6401547914365;6848.520603557703;6852.6916288767125;6867.416269617139;6871.072405225231;6873.725050998004;6458.257300410419;6510.925697260089;6536.477081833537;6537.444317232993;6542.967285163544;6708.664566771739;6723.226828914738;6743.549257490033;6771.729130834909;6780.72877084911;6661.16735408074;6678.866422671616;6691.76578819739;6697.129373181455;6729.629870357177;5960.284765828128;6278.277998030285;6467.935320646733;6511.120998665309;6519.511036672174;5198.766055527586;5205.479452054764;5219.243209734643;5244.868878278074;5259.105951988247;6646.60120392778;6647.767328143492;6713.160854893138;6721.428678562377;6744.898826517704;6321.45124444514;6466.676666166767;6478.773242936474;6503.512236582181;6556.868862622626;6539.705713243011;6549.24683661385;6553.180852393451;6567.9671601641685;6577.868442631217;6477.77327793525;6479.505390424626;6480;6491;6505.674716264262;6384.106225128578;6390.840228994312;6394.1687580614225;6414.134091897534;6426.614403135827;6179.837057030004;6181.35095814933;6210.7515699373325;6211.751529938751;6230.626162430269 16:51:08 INFO - PID 1251 | |5;yui.html;820.8153165537755;823.4647479138555;836.9581520923956;839.2362949715758;848.6520526584102;16855.072970986606;17152.91423542882;17169.399071032516;17762.289508419646;18868.43394698158;17944.10279486024;18309.08454577269;18551.165197566108;18582.163802628882;18587.90706046468;940.3746508571792;979.2851218610383;979.4661909259471;980.1570649241646;983.4246965525176;895.6148855991921;989.8168838764816;989.9356541824794;991.0386924683082;992.5979978108842;1036.445501656614;1049.5014867937707;1050.2018465965882;1050.8528805967171;1051.6056478820442;1032.117539503721;1041.463646222196;1041.630221271449;1041.8489319048695;1043.139409986764;756.5498528375608;756.765402725157;756.9024913874848;758.4008633179782;761.0524896503833;17065.7440138398;17447.563810904703;17569.472915812545;17656.028918409484;17943.910280448647;18711.251549938122;19116.713249301272;19156.329528466576;19209.03954802254;19307;14364.497242596459;14884.925575372054;14891;14900.478483253142;14904.329305181293;3393;3465;3473.6700013498676;3485.0590340607896;3494.336076145524;78425.21574784293;80355.19644803535;80599;80658;80873.59563202206;14034.36845341962;14257;14291.785623215661;14353;14407.42370305176;25237.62143567848;25590;25597.488050239263;25983.870080649853;26311.079112231364;8024.638891249908;8082.757517274491;8268.627911743986;8310.252077312949;8312.625931832961;3969.226000929791;4027.932597861569;4043.7978101094827;4064.5935406459116;4068.613481719232;4502.851772797915;4563.885902852388;4589.311603259538;4598.011427543094;4613.907721845544;857.4212406625503;876.9210771030638;877.7849426890452;879.5821984557411;883.0286684646966;667.5093806052547;682.1643486728717;697.4803771190495;725.4522835259451;727.7780277015455;10746.301490403099;11273.436328183558;11326.207165498336;11665.825012624817;12111.939440302742;691.560858854631;698.5703792167882;701.7368486817444;717.9102612173479;730.7223255163004;5167.741612919339;5258.368995720538;5347.598930080259;5363.892722145535;5394.62237643369;79418.20581794223;81113;83266;90450.54774726085;93454;71753.64123179455;72247;73461.6326918362;74276.25723742801;75649.24350756532;64938;65051.349486505474;66237.33762662312;66241.66879165573;68345.31654683489;11269.323840569592;12009.699757505783;12176.269423834598;12209.69475763113;12335.3832308386;30876.22809429782;31264.21839454032;31282.21794455157;31570.36859262756;31747.20631984219;38451.615483845926;38548.6145138545;38593.22813543657;38886.41670375003;39917.800410997756;16449.09529975863;16466.09436481005;16626.334946602;16742.07918564442;16908.66182676315;19012.524686882385;19362;19498.122584483448;19643.803561964196;19801;16746.49760507187;17198.484045478657;17576;17760.55598610045;17776.466705998842;17231.3969011084;17295;17443.651126977642;17546;17864.19611117529;16910.492685219462;16913;17029.91485042567;17408.82591174072;17499.650006999535;10309.48452577353;10514.369137851754;10734.624288149877;11036.724081897695;11046.668599942015;12573.685657858627;12754.48982040708;13550.119242249222;13607.727845442838;13806.516771912935 16:51:08 INFO - PID 1251 | __end_tp_report 16:51:08 INFO - PID 1251 | __start_cc_report 16:51:08 INFO - PID 1251 | _x_x_mozilla_cycle_collect,390 16:51:08 INFO - PID 1251 | __end_cc_report 16:51:08 INFO - PID 1251 | __startTimestamp1497052268210__endTimestamp 16:51:08 INFO - PID 1251 | 16:51:08 INFO - PID 1251 | ------- Summary: start ------- 16:51:08 INFO - PID 1251 | Number of tests: 6 16:51:08 INFO - PID 1251 | 16:51:08 INFO - PID 1251 | [#0] dojo.html Cycles:165 Average:5813.30 Median:6026.79 stddev:664.05 (11.0%) stddev-sans-first:628.71 16:51:08 INFO - PID 1251 | Values: 3013.4 3033.1 3052.1 3058.6 3058.7 5771.1 5899.4 5901.9 5921.1 5937.4 5835.3 5907.5 5911.6 5918.8 5977.2 5247.9 5406.4 5423.0 5423.5 5511.2 5533.0 5536.3 5547.0 5560.6 5571.9 5288.4 5354.0 5361.4 5464.5 5488.8 5436.4 5448.0 5449.7 5467.8 5497.0 5385.6 5418.5 5422.8 5423.5 5427.9 5748.6 5811.7 5871.1 5871.6 5888.1 6215.4 6271.6 6298.2 6299.1 6326.7 6383.9 6397.3 6400.2 6405.3 6418.9 5786.0 5920.7 5923.7 5943.6 5948.0 6165.8 6255.3 6268.4 6287.8 6434.9 6069.4 6092.0 6149.4 6190.8 6225.8 6285.9 6289.1 6298.2 6302.3 6316.2 6034.0 6250.8 6271.1 6286.9 6292.2 6265.3 6268.3 6314.7 6348.4 6372.8 5123.8 5128.5 5145.8 5150.1 5165.6 4388.5 4399.7 4401.7 4414.6 4421.4 5382.7 5455.2 5467.5 5489.8 5554.4 6343.4 6346.6 6383.6 6385.7 6415.6 5472.0 5479.8 5483.7 5486.3 5514.3 5497.9 5566.5 5576.1 5593.2 5600.4 6028.5 6118.7 6123.7 6126.7 6144.3 6399.8 6410.2 6414.1 6415.8 6418.2 6176.6 6178.5 6183.7 6199.1 6205.1 6088.8 6137.6 6168.4 6253.6 6258.1 6283.2 6363.4 6364.8 6371.8 6382.9 5970.1 6111.5 6134.8 6137.8 6161.3 6026.8 6143.6 6184.1 6201.0 6244.0 5906.9 6162.5 6164.3 6171.0 6173.3 6037.8 6059.0 6080.2 6112.4 6119.0 5922.6 5925.1 5936.4 5939.8 5961.7 16:51:08 INFO - PID 1251 | 16:51:08 INFO - PID 1251 | [#1] ext.html Cycles:180 Average:34176.75 Median:34527.66 stddev:46837.89 (135.7%) stddev-sans-first:46901.94 16:51:08 INFO - PID 1251 | Values: 728.9 771.2 792.2 1108.4 1113.9 35653.0 36636.6 36637.8 36653.0 36787.6 38805.8 39023.4 39204.8 39399.4 39565.8 7147.2 7212.4 7303.4 7313.9 7374.9 7337.0 7433.9 7441.1 7441.6 7473.9 7393.4 7400.2 7449.6 7452.1 7456.9 7386.4 7423.6 7435.5 7459.8 7470.9 7319.4 7348.0 7372.2 7384.2 7404.9 34827.0 35010.6 35116.6 35151.6 35292.8 3487.8 3505.1 3516.8 3519.9 3523.5 27399.2 27497.2 27532.7 27552.6 27705.3 3596.3 3615.6 3619.1 3627.1 3649.3 167809.0 168164.2 179398.0 185006.1 185468.0 42609.4 42649.4 42759.6 42950.8 43069.6 45256.3 45288.3 50201.0 50953.0 51475.5 13707.0 13748.1 13772.0 13779.5 13811.8 10892.7 10917.3 10967.7 10980.0 11009.0 14123.2 14317.9 14324.1 14419.3 14544.4 5655.0 5708.3 5711.2 5813.2 5882.8 973.5 980.5 1000.3 1014.8 1015.9 21476.9 22411.4 22491.3 22787.4 22828.1 1066.4 1080.5 1081.5 1103.9 1104.4 11768.9 11790.0 12189.4 12373.5 12783.7 200350.0 202103.0 202157.0 202254.0 202352.0 48758.8 48806.3 48965.3 49002.3 49185.8 1405.6 1452.7 1454.8 1455.1 1461.1 21384.5 21874.2 22897.9 22904.4 23161.3 35035.0 35301.5 35381.1 35381.3 35706.3 160898.0 161984.0 162540.0 162593.0 162598.2 33222.3 34659.8 34826.5 34946.5 35028.0 40504.4 40778.0 41446.0 41749.0 41930.8 29600.7 30390.1 31234.0 31772.4 32153.7 29706.4 29812.0 29821.0 30644.0 31521.0 33472.2 34176.0 34208.7 34305.1 34395.5 28113.7 28803.6 30072.7 30174.8 31142.0 22252.0 24213.9 24264.0 24315.9 24624.5 16:51:08 INFO - PID 1251 | 16:51:08 INFO - PID 1251 | [#2] jquery.html Cycles:180 Average:29990.25 Median:20663.59 stddev:70997.82 (343.6%) stddev-sans-first:71162.41 16:51:08 INFO - PID 1251 | Values: 480.4 487.9 489.9 514.0 514.5 19573.9 20211.3 20328.8 20635.8 23073.1 23013.3 23693.9 23715.1 23722.4 23801.2 6194.0 6328.8 6329.7 6330.9 6338.5 5405.4 5849.5 5891.3 6233.5 6295.4 5858.9 5863.7 5877.6 5885.8 5899.3 5847.6 5854.4 5871.5 5878.0 5893.5 5448.9 5452.6 5463.4 5467.3 5467.5 26030.6 26067.6 26225.2 26839.2 26944.7 1920.3 1936.6 1940.5 1944.9 1947.4 17136.5 17530.0 17554.0 17653.2 17714.0 2127.2 2174.1 2211.8 2237.1 2247.7 112896.0 116899.0 117140.0 117471.0 117471.4 12351.6 12934.7 12949.2 13070.6 13250.0 19848.3 19873.0 19940.1 19950.4 19972.0 8870.6 8976.8 9067.1 9165.1 9199.4 7594.4 8135.1 8145.1 8318.9 8435.9 8315.6 8511.0 8557.2 8647.7 8693.6 2468.3 2475.9 2481.3 2503.4 2594.8 926.7 945.2 961.3 991.6 1000.4 18900.4 19519.1 20178.6 20222.4 20691.4 972.6 1025.7 1028.2 1041.5 1051.3 10297.8 10680.6 10768.3 10854.9 10936.8 415048.0 415848.0 419644.0 429270.0 429967.0 98582.5 99176.5 100215.0 100308.0 100904.5 1150.2 1160.8 1166.8 1171.8 1185.5 15870.4 16522.7 16904.8 17369.0 17983.6 46863.0 48140.5 50251.0 50290.2 50499.2 59845.0 59931.7 60594.0 60753.4 60839.0 11233.6 11388.4 11469.7 11470.4 11581.0 17259.4 17427.9 17540.8 17598.5 17743.1 14221.1 14707.8 15453.7 15553.0 15581.3 12426.6 13319.3 13940.5 14111.2 14151.5 13766.4 13809.3 14051.6 14064.1 14065.3 11388.4 11615.4 11619.7 11711.6 11776.1 13893.6 13981.7 14380.9 15100.1 15350.5 16:51:08 INFO - PID 1251 | 16:51:08 INFO - PID 1251 | [#3] mootools.html Cycles:180 Average:7372.90 Median:2519.83 stddev:4815.79 (191.1%) stddev-sans-first:4807.78 16:51:08 INFO - PID 1251 | Values: 1313.4 1360.3 1367.3 1375.8 1384.0 11318.9 11687.1 11815.8 11832.6 12668.6 12051.5 12195.2 12286.4 12307.4 12310.4 2497.6 2533.4 2546.3 2554.7 2559.4 2446.5 2491.0 2492.1 2492.9 2506.2 2358.1 2387.5 2395.7 2398.1 2398.4 2266.4 2339.2 2344.4 2346.5 2363.5 1975.1 2057.3 2299.4 2305.5 2404.5 11955.5 12076.3 12079.9 12095.4 12104.1 6685.4 6878.2 6933.5 6943.3 6955.1 4070.3 4186.8 4297.6 4299.8 4314.8 1391.6 1392.1 1411.4 1426.2 1433.0 17675.6 17766.0 17858.9 17933.7 17967.8 5652.9 5692.8 5702.9 5848.3 5877.3 12963.4 13014.7 13058.2 13080.3 13094.9 6461.5 6535.4 6535.9 6545.2 6616.5 6107.1 6140.9 6149.3 6158.0 6180.6 4345.4 4449.2 4464.2 4503.1 4509.4 1306.9 1336.1 1341.7 1349.4 1355.2 848.2 864.4 875.4 882.7 907.0 6092.6 6233.1 6490.5 6497.1 6503.2 693.6 696.3 698.3 698.4 720.9 4014.2 4215.4 4333.9 5049.6 5265.6 15453.8 15850.4 15856.4 15880.3 15886.7 14653.9 15167.9 15255.7 15285.5 15291.6 9084.1 9276.1 9277.0 9277.4 9279.7 6848.1 6915.9 7531.8 7537.7 7712.7 14074.5 14079.6 14090.6 14091.4 14161.6 14186.6 14350.0 14384.5 14467.4 14514.9 11121.1 11260.4 11298.7 11351.9 11357.7 11216.0 11281.2 11410.5 11414.8 11425.7 8723.0 8730.0 8916.9 9077.9 9358.2 8728.0 8844.4 8860.1 8932.3 9136.1 7865.2 7906.5 7912.1 7969.4 7999.8 5768.5 5786.0 5799.7 5806.2 6040.6 5314.4 5519.2 5532.4 5608.3 6000.2 16:51:08 INFO - PID 1251 | 16:51:08 INFO - PID 1251 | [#4] prototype.html Cycles:180 Average:5452.34 Median:6065.64 stddev:1562.37 (25.8%) stddev-sans-first:1520.82 16:51:08 INFO - PID 1251 | Values: 442.0 443.7 453.8 454.7 454.8 6009.4 6231.0 6249.5 6319.1 6326.5 5946.4 6043.3 6063.3 6081.7 6083.9 4769.4 4831.2 4860.9 4868.1 4876.9 4916.7 4919.5 4933.0 4933.7 4935.0 4836.6 4846.8 4859.0 4860.5 4880.2 4867.7 4877.3 4879.6 4888.3 4901.5 4325.2 4325.6 4339.8 4348.3 4358.9 6038.9 6068.0 6100.6 6106.4 6125.2 5557.4 5581.0 5582.6 5590.4 5627.6 6496.5 6517.3 6531.4 6547.3 6577.6 4709.9 4716.7 4724.7 4738.1 4743.2 6437.8 6754.5 6875.1 6917.9 6920.5 4733.8 4753.8 4790.7 4795.2 4797.2 4827.4 4835.8 4848.8 4861.7 4873.6 5374.6 5501.1 5515.6 5533.9 5547.2 6527.6 6538.3 6545.2 6560.0 6564.5 1675.0 1675.9 1681.2 1681.7 1684.9 1102.6 1140.5 1151.4 1151.8 1160.4 5669.1 5683.8 5750.0 5754.7 5770.4 6723.4 6761.3 6772.7 6789.0 6792.3 5688.5 5701.1 5703.7 5722.9 5728.5 3562.6 3573.5 3591.2 3597.4 3615.8 6493.4 6519.4 6521.3 6533.7 6542.6 6848.5 6852.7 6867.4 6871.1 6873.7 6458.3 6510.9 6536.5 6537.4 6543.0 6708.7 6723.2 6743.5 6771.7 6780.7 6661.2 6678.9 6691.8 6697.1 6729.6 5960.3 6278.3 6467.9 6511.1 6519.5 5198.8 5205.5 5219.2 5244.9 5259.1 6646.6 6647.8 6713.2 6721.4 6744.9 6321.5 6466.7 6478.8 6503.5 6556.9 6539.7 6549.2 6553.2 6568.0 6577.9 6477.8 6479.5 6480.0 6491.0 6505.7 6384.1 6390.8 6394.2 6414.1 6426.6 6179.8 6181.4 6210.8 6211.8 6230.6 16:51:08 INFO - PID 1251 | 16:51:08 INFO - PID 1251 | [#5] yui.html Cycles:180 Average:18667.30 Median:31070.22 stddev:22540.10 (72.5%) stddev-sans-first:22563.49 16:51:08 INFO - PID 1251 | Values: 820.8 823.5 837.0 839.2 848.7 16855.1 17152.9 17169.4 17762.3 18868.4 17944.1 18309.1 18551.2 18582.2 18587.9 940.4 979.3 979.5 980.2 983.4 895.6 989.8 989.9 991.0 992.6 1036.4 1049.5 1050.2 1050.9 1051.6 1032.1 1041.5 1041.6 1041.8 1043.1 756.5 756.8 756.9 758.4 761.1 17065.7 17447.6 17569.5 17656.0 17943.9 18711.3 19116.7 19156.3 19209.0 19307.0 14364.5 14884.9 14891.0 14900.5 14904.3 3393.0 3465.0 3473.7 3485.1 3494.3 78425.2 80355.2 80599.0 80658.0 80873.6 14034.4 14257.0 14291.8 14353.0 14407.4 25237.6 25590.0 25597.5 25983.9 26311.1 8024.6 8082.8 8268.6 8310.3 8312.6 3969.2 4027.9 4043.8 4064.6 4068.6 4502.9 4563.9 4589.3 4598.0 4613.9 857.4 876.9 877.8 879.6 883.0 667.5 682.2 697.5 725.5 727.8 10746.3 11273.4 11326.2 11665.8 12111.9 691.6 698.6 701.7 717.9 730.7 5167.7 5258.4 5347.6 5363.9 5394.6 79418.2 81113.0 83266.0 90450.5 93454.0 71753.6 72247.0 73461.6 74276.3 75649.2 64938.0 65051.3 66237.3 66241.7 68345.3 11269.3 12009.7 12176.3 12209.7 12335.4 30876.2 31264.2 31282.2 31570.4 31747.2 38451.6 38548.6 38593.2 38886.4 39917.8 16449.1 16466.1 16626.3 16742.1 16908.7 19012.5 19362.0 19498.1 19643.8 19801.0 16746.5 17198.5 17576.0 17760.6 17776.5 17231.4 17295.0 17443.7 17546.0 17864.2 16910.5 16913.0 17029.9 17408.8 17499.7 10309.5 10514.4 10734.6 11036.7 11046.7 12573.7 12754.5 13550.1 13607.7 13806.5 16:51:08 INFO - PID 1251 | -------- Summary: end -------- 16:51:08 INFO - PID 1251 | 16:51:09 INFO - TEST-INFO | 1251: exit 0 16:51:09 INFO - TEST-OK | dromaeo_css | took 1142900ms 16:51:09 INFO - TEST-START | kraken 16:51:09 INFO - operating with platform_type : linux_ 16:51:09 INFO - Initialising browser for kraken test... 16:51:09 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:60799/getInfo.html -profile /tmp/tmpbNVdge/profile 16:51:09 INFO - TEST-INFO | started process 1688 (/builds/slave/test/build/application/firefox/firefox http://localhost:60799/getInfo.html) 16:51:44 INFO - TEST-INFO | 1688: killed by SIGTERM 16:51:44 INFO - Browser initialized. 16:51:44 INFO - Running cycle 1/1 for kraken test... 16:51:44 INFO - TEST-INFO | started process 1919 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbNVdge/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:51:56 INFO - PID 1919 | RSS: Main: 188362752 16:51:56 INFO - PID 1919 | 16:51:58 INFO - PID 1919 | Cycle 1(1): loaded http://localhost:60799/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60799/tests/kraken/driver.html?testName=audio-beat-detection) 16:51:59 INFO - PID 1919 | RSS: Main: 193626112 16:51:59 INFO - PID 1919 | 16:52:02 INFO - PID 1919 | Cycle 1(1): loaded http://localhost:60799/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60799/tests/kraken/driver.html?testName=audio-dft) 16:52:02 INFO - PID 1919 | RSS: Main: 192008192 16:52:02 INFO - PID 1919 | 16:52:05 INFO - PID 1919 | Cycle 1(1): loaded http://localhost:60799/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60799/tests/kraken/driver.html?testName=audio-fft) 16:52:06 INFO - PID 1919 | RSS: Main: 187490304 16:52:06 INFO - PID 1919 | 16:52:08 INFO - PID 1919 | Cycle 1(1): loaded http://localhost:60799/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60799/tests/kraken/driver.html?testName=audio-oscillator) 16:52:09 INFO - PID 1919 | RSS: Main: 188596224 16:52:09 INFO - PID 1919 | 16:52:11 INFO - PID 1919 | Cycle 1(1): loaded http://localhost:60799/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60799/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:52:12 INFO - PID 1919 | RSS: Main: 188354560 16:52:12 INFO - PID 1919 | 16:52:15 INFO - PID 1919 | Cycle 1(1): loaded http://localhost:60799/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60799/tests/kraken/driver.html?testName=imaging-darkroom) 16:52:15 INFO - PID 1919 | RSS: Main: 189812736 16:52:15 INFO - PID 1919 | 16:52:19 INFO - PID 1919 | Cycle 1(1): loaded http://localhost:60799/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60799/tests/kraken/driver.html?testName=imaging-desaturate) 16:52:19 INFO - PID 1919 | RSS: Main: 188801024 16:52:19 INFO - PID 1919 | 16:52:22 INFO - PID 1919 | Cycle 1(1): loaded http://localhost:60799/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60799/tests/kraken/driver.html?testName=json-parse-financial) 16:52:23 INFO - PID 1919 | RSS: Main: 189403136 16:52:23 INFO - PID 1919 | 16:52:25 INFO - PID 1919 | Cycle 1(1): loaded http://localhost:60799/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60799/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:52:25 INFO - PID 1919 | RSS: Main: 189759488 16:52:25 INFO - PID 1919 | 16:52:27 INFO - PID 1919 | Cycle 1(1): loaded http://localhost:60799/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60799/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:52:28 INFO - PID 1919 | RSS: Main: 189591552 16:52:28 INFO - PID 1919 | 16:52:30 INFO - PID 1919 | Cycle 1(1): loaded http://localhost:60799/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60799/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:52:31 INFO - PID 1919 | RSS: Main: 189603840 16:52:31 INFO - PID 1919 | 16:52:33 INFO - PID 1919 | Cycle 1(1): loaded http://localhost:60799/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60799/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:52:34 INFO - PID 1919 | RSS: Main: 189607936 16:52:34 INFO - PID 1919 | 16:52:37 INFO - PID 1919 | Cycle 1(1): loaded http://localhost:60799/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60799/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:52:38 INFO - PID 1919 | RSS: Main: 189722624 16:52:38 INFO - PID 1919 | 16:52:39 INFO - PID 1919 | Cycle 1(1): loaded http://localhost:60799/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60799/tests/kraken/driver.html?testName=ai-astar) 16:52:40 INFO - PID 1919 | RSS: Main: 190951424 16:52:40 INFO - PID 1919 | 16:52:40 INFO - PID 1919 | __start_tp_report 16:52:40 INFO - PID 1919 | _x_x_mozilla_page_load 16:52:40 INFO - PID 1919 | _x_x_mozilla_page_load_details 16:52:40 INFO - PID 1919 | |i|pagename|runs| 16:52:40 INFO - PID 1919 | |0;ai-astar;101;110;104;110;110;113;110;101;110;110 16:52:40 INFO - PID 1919 | |1;audio-beat-detection;155;121;152;185;120;158;156;122;166;123 16:52:40 INFO - PID 1919 | |2;audio-dft;166;164;163;162;162;165;172;175;167;162 16:52:40 INFO - PID 1919 | |3;audio-fft;73;74;80;171;76;75;76;76;155;75 16:52:40 INFO - PID 1919 | |4;audio-oscillator;83;83;139;82;82;82;134;82;82;145 16:52:40 INFO - PID 1919 | |5;imaging-gaussian-blur;114;113;114;114;114;114;115;114;114;113 16:52:40 INFO - PID 1919 | |6;imaging-darkroom;150;150;150;151;151;150;150;150;152;150 16:52:40 INFO - PID 1919 | |7;imaging-desaturate;94;95;94;95;99;95;94;95;94;94 16:52:40 INFO - PID 1919 | |8;json-parse-financial;53;54;55;52;53;55;52;53;52;54 16:52:40 INFO - PID 1919 | |9;json-stringify-tinderbox;56;57;57;56;56;56;56;57;57;58 16:52:40 INFO - PID 1919 | |10;stanford-crypto-aes;84;86;90;82;89;82;82;83;104;84 16:52:40 INFO - PID 1919 | |11;stanford-crypto-ccm;138;130;130;130;132;136;138;131;138;130 16:52:40 INFO - PID 1919 | |12;stanford-crypto-pbkdf2;201;190;187;185;178;181;186;191;199;180 16:52:40 INFO - PID 1919 | |13;stanford-crypto-sha256-iterative;71;71;73;71;71;71;69;70;73;71 16:52:40 INFO - PID 1919 | __end_tp_report 16:52:40 INFO - PID 1919 | __start_cc_report 16:52:40 INFO - PID 1919 | _x_x_mozilla_cycle_collect,1010 16:52:40 INFO - PID 1919 | __end_cc_report 16:52:40 INFO - PID 1919 | __startTimestamp1497052360076__endTimestamp 16:52:40 INFO - PID 1919 | 16:52:40 INFO - PID 1919 | ------- Summary: start ------- 16:52:40 INFO - PID 1919 | Number of tests: 14 16:52:40 INFO - PID 1919 | 16:52:40 INFO - PID 1919 | [#0] ai-astar Cycles:10 Average:107.90 Median:110.00 stddev:4.25 (3.9%) stddev-sans-first:3.71 16:52:40 INFO - PID 1919 | Values: 101.0 110.0 104.0 110.0 110.0 113.0 110.0 101.0 110.0 110.0 16:52:40 INFO - PID 1919 | 16:52:40 INFO - PID 1919 | [#1] audio-beat-detection Cycles:10 Average:145.80 Median:155.50 stddev:22.82 (14.7%) stddev-sans-first:23.96 16:52:40 INFO - PID 1919 | Values: 155.0 121.0 152.0 185.0 120.0 158.0 156.0 122.0 166.0 123.0 16:52:40 INFO - PID 1919 | 16:52:40 INFO - PID 1919 | [#2] audio-dft Cycles:10 Average:165.80 Median:165.50 stddev:4.47 (2.7%) stddev-sans-first:4.74 16:52:40 INFO - PID 1919 | Values: 166.0 164.0 163.0 162.0 162.0 165.0 172.0 175.0 167.0 162.0 16:52:40 INFO - PID 1919 | 16:52:40 INFO - PID 1919 | [#3] audio-fft Cycles:10 Average:93.10 Median:75.50 stddev:37.08 (49.1%) stddev-sans-first:38.61 16:52:40 INFO - PID 1919 | Values: 73.0 74.0 80.0 171.0 76.0 75.0 76.0 76.0 155.0 75.0 16:52:40 INFO - PID 1919 | 16:52:40 INFO - PID 1919 | [#4] audio-oscillator Cycles:10 Average:99.40 Median:82.00 stddev:27.68 (33.8%) stddev-sans-first:28.72 16:52:40 INFO - PID 1919 | Values: 83.0 83.0 139.0 82.0 82.0 82.0 134.0 82.0 82.0 145.0 16:52:40 INFO - PID 1919 | 16:52:40 INFO - PID 1919 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 16:52:40 INFO - PID 1919 | Values: 114.0 113.0 114.0 114.0 114.0 114.0 115.0 114.0 114.0 113.0 16:52:40 INFO - PID 1919 | 16:52:40 INFO - PID 1919 | [#6] imaging-darkroom Cycles:10 Average:150.40 Median:150.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 16:52:40 INFO - PID 1919 | Values: 150.0 150.0 150.0 151.0 151.0 150.0 150.0 150.0 152.0 150.0 16:52:40 INFO - PID 1919 | 16:52:40 INFO - PID 1919 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:1.52 (1.6%) stddev-sans-first:1.58 16:52:40 INFO - PID 1919 | Values: 94.0 95.0 94.0 95.0 99.0 95.0 94.0 95.0 94.0 94.0 16:52:40 INFO - PID 1919 | 16:52:40 INFO - PID 1919 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:53.50 stddev:1.16 (2.2%) stddev-sans-first:1.22 16:52:40 INFO - PID 1919 | Values: 53.0 54.0 55.0 52.0 53.0 55.0 52.0 53.0 52.0 54.0 16:52:40 INFO - PID 1919 | 16:52:40 INFO - PID 1919 | [#9] json-stringify-tinderbox Cycles:10 Average:56.60 Median:57.00 stddev:0.70 (1.2%) stddev-sans-first:0.71 16:52:40 INFO - PID 1919 | Values: 56.0 57.0 57.0 56.0 56.0 56.0 56.0 57.0 57.0 58.0 16:52:40 INFO - PID 1919 | 16:52:40 INFO - PID 1919 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:84.00 stddev:6.75 (8.0%) stddev-sans-first:7.10 16:52:40 INFO - PID 1919 | Values: 84.0 86.0 90.0 82.0 89.0 82.0 82.0 83.0 104.0 84.0 16:52:40 INFO - PID 1919 | 16:52:40 INFO - PID 1919 | [#11] stanford-crypto-ccm Cycles:10 Average:133.30 Median:134.00 stddev:3.71 (2.8%) stddev-sans-first:3.53 16:52:40 INFO - PID 1919 | Values: 138.0 130.0 130.0 130.0 132.0 136.0 138.0 131.0 138.0 130.0 16:52:40 INFO - PID 1919 | 16:52:40 INFO - PID 1919 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.80 Median:188.50 stddev:7.67 (4.1%) stddev-sans-first:6.48 16:52:40 INFO - PID 1919 | Values: 201.0 190.0 187.0 185.0 178.0 181.0 186.0 191.0 199.0 180.0 16:52:40 INFO - PID 1919 | 16:52:40 INFO - PID 1919 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:71.00 stddev:1.20 (1.7%) stddev-sans-first:1.27 16:52:40 INFO - PID 1919 | Values: 71.0 71.0 73.0 71.0 71.0 71.0 69.0 70.0 73.0 71.0 16:52:40 INFO - PID 1919 | -------- Summary: end -------- 16:52:40 INFO - PID 1919 | 16:52:41 INFO - TEST-INFO | 1919: exit 0 16:52:41 INFO - TEST-OK | kraken | took 92197ms 16:52:41 INFO - SUITE-END | took 1235s 16:52:41 INFO - Completed test suite (00:20:35) 16:52:41 INFO - javascript benchmark 16:52:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7759.326901357174, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3013.3973205358925, 3033.074912151793, 3052.0538633023766, 3058.6329640443137, 3058.6635470098286, 5771.076627739562, 5899.380565040673, 5901.85245368866, 5921.111833225018, 5937.4062593740655, 5835.299764028323, 5907.468327850493, 5911.556633252501, 5918.792842250522, 5977.163197152402, 5247.921281180786, 5406.378266499344, 5423.023855705971, 5423.538999185074, 5511.22842802006, 5533.031719449101, 5536.335639723239, 5547.0, 5560.610757246995, 5571.916421253684, 5288.444713305086, 5354.0, 5361.35663720356, 5464.508194262516, 5488.780448782044, 5436.429174936654, 5447.972760136214, 5449.7275136243425, 5467.835964921019, 5497.0, 5385.623006389555, 5418.485243901823, 5422.75597598109, 5423.538999185034, 5427.891442171134, 5748.5975981681295, 5811.6803575803315, 5871.060630299175, 5871.5596330274975, 5888.116782482619, 6215.409536094064, 6271.560990730651, 6298.2442106947, 6299.118123462719, 6326.715297811609, 6383.936160638381, 6397.264314603834, 6400.199975003125, 6405.29541750407, 6418.903716444257, 5786.045302525036, 5920.703964801743, 5923.674197919156, 5943.55423343251, 5948.0, 6165.8458538536, 6255.343188965184, 6268.373162683786, 6287.842803929939, 6434.935650643433, 6069.423404776539, 6091.964366057781, 6149.354317796657, 6190.783322583688, 6225.844353891189, 6285.8742825143245, 6289.088082228142, 6298.212723409574, 6302.338254483305, 6316.178896743394, 6033.9698301508215, 6250.781222657185, 6271.05934109878, 6286.9056964145575, 6292.2134733158355, 6265.310815810257, 6268.310485846553, 6314.71583778731, 6348.396902294275, 6372.808815735535, 5123.795048198105, 5128.512791284822, 5145.845624631267, 5150.072986862401, 5165.638405311592, 4388.451443569554, 4399.714018588781, 4401.713888597231, 4414.624756895636, 4421.38100665907, 5382.703951282717, 5455.236266922634, 5467.507924286833, 5489.780408783604, 5554.361248456398, 6343.365663433712, 6346.555741098171, 6383.585066970632, 6385.712642931079, 6415.582987105823, 5472.0, 5479.835604931858, 5483.698396588226, 5486.286782718221, 5514.338279406497, 5497.917531237034, 5566.471185237396, 5576.052071147915, 5593.244911936837, 5600.411956744565, 6028.487578555872, 6118.741008805849, 6123.693815309217, 6126.693665316806, 6144.341027922525, 6399.8080057598345, 6410.230772307353, 6414.10202571631, 6415.775447859302, 6418.1656384669695, 6176.567640265138, 6178.5366097543765, 6183.721732521957, 6199.1011303361665, 6205.131281620667, 6088.847778805565, 6137.62214577108, 6168.383161683975, 6253.562250642593, 6258.12386265914, 6283.2460104787715, 6363.427291543783, 6364.840878978062, 6371.840703982252, 6382.9149044663445, 5970.134330522137, 6111.480524155319, 6134.78528251509, 6137.815865524041, 6161.322254552086, 6026.789062382971, 6143.631382117087, 6184.103305020657, 6201.0, 6244.0321750128805, 5906.852328691817, 6162.506999439945, 6164.291106522807, 6171.012637977902, 6173.32093469709, 6037.849053773691, 6059.0, 6080.179175811209, 6112.449879510866, 6119.045604113885, 5922.555808314308, 5925.081612350093, 5936.436038576328, 5939.762409503572, 5961.731722072431], "value": 5765.166504698501, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.8724473217186, 771.1941021632393, 792.2038351456785, 1108.4457771114444, 1113.899749022588, 35653.0, 36636.63363366365, 36637.816810915974, 36653.0, 36787.632123678755, 38805.80597097018, 39023.414648780294, 39204.80397598008, 39399.40900886489, 39565.80217098918, 7147.178074521418, 7212.423006159508, 7303.415726741874, 7313.89029164563, 7374.926250737504, 7336.963315183443, 7433.9256607434045, 7441.069866266716, 7441.55350678961, 7473.9252607474045, 7393.445491588125, 7400.185979542273, 7449.553026818381, 7452.06849143857, 7456.925430745678, 7386.372158366546, 7423.628818559077, 7435.51669141504, 7459.776206713807, 7470.850582988364, 7319.377852882511, 7348.0, 7372.189059203483, 7384.1877393486675, 7404.925950740531, 34827.0, 35010.649893500995, 35116.648833511594, 35151.64848351509, 35292.82353588241, 3487.825608719579, 3505.1061979195397, 3516.8241587920757, 3519.9296014079573, 3523.5419395478425, 27399.178024659293, 27497.17508474749, 27532.724672753215, 27552.586711199347, 27705.307367315778, 3596.28074385124, 3615.5661320641693, 3619.1133172372674, 3627.075095850568, 3649.3248748981523, 167809.0, 168164.15917920455, 179398.0, 185006.07496962562, 185468.0, 42609.36085958651, 42649.36025959613, 42759.57240427618, 42950.78524607357, 43069.569304306555, 45256.32115518204, 45288.3206751899, 50201.0, 50953.0, 51475.48524514707, 13707.0, 13748.106373085717, 13772.03595748308, 13779.517716879862, 13811.792823107662, 10892.727681807859, 10917.290376125526, 10967.725806854733, 10980.0, 11009.0, 14123.223222722643, 14317.928410357881, 14324.14055156694, 14419.279036048156, 14544.418223271163, 5654.97172514143, 5708.257926469615, 5711.200431939532, 5813.186153938452, 5882.764689412461, 973.4597298499259, 980.4509474694194, 1000.3297790480395, 1014.761531040205, 1015.8730158730159, 21476.89261553682, 22411.43971400728, 22491.325260242218, 22787.430314241945, 22828.086876524754, 1066.424130969268, 1080.4975686305906, 1081.4700796609604, 1103.862017247844, 1104.4312179227704, 11768.94115529434, 11790.0, 12189.390530473442, 12373.505059797688, 12783.744325113446, 200350.0, 202103.0, 202157.0, 202254.0, 202352.0, 48758.75620621874, 48806.26790598144, 48965.265521017216, 49002.26496602554, 49185.754071229414, 1405.6485878530368, 1452.651363672732, 1454.847241039718, 1455.1269238457053, 1461.123326004389, 21384.46538836479, 21874.23440179586, 22897.88551057234, 22904.427389315402, 23161.3051608452, 35035.0, 35301.47047794234, 35381.1154721134, 35381.29237415289, 35706.28587428289, 160898.0, 161984.0, 162540.0, 162593.0, 162598.18700906893, 33222.335553288314, 34659.82670086633, 34826.47760283649, 34946.47580286348, 35028.0, 40504.392434112924, 40778.0, 41446.0, 41749.0, 41930.790346048074, 29600.703992960654, 30390.088297351114, 31234.0, 31772.364552708354, 32153.678463216005, 29706.405871882875, 29812.0, 29821.0, 30644.0, 31521.0, 33472.16319592029, 34176.0, 34208.65791342154, 34305.14237144091, 34395.4840677385, 28113.676519030705, 28803.56794648124, 30072.69927300699, 30174.84912575423, 31142.0, 22252.0, 24213.87893060594, 24264.0, 24315.878420607783, 24624.50750985006], "value": 16106.569715642632, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [480.4354883012459, 487.8803146778146, 489.938757655293, 513.9691618502887, 514.4983640950073, 19573.902130489347, 20211.292604758855, 20328.796712032876, 20635.793642063574, 23073.077076916947, 23013.309600711964, 23693.881530592367, 23715.051397944106, 23722.406939826513, 23801.16695915643, 6194.008958566642, 6328.84177895554, 6329.651869147195, 6330.936690633103, 6338.461230795388, 5405.37838148614, 5849.532037437016, 5891.263592050994, 6233.532485063615, 6295.43341099301, 5858.88282234355, 5863.677497737623, 5877.617954832944, 5885.764569417218, 5899.262592175978, 5847.619904706202, 5854.385289544601, 5871.500922421556, 5878.0, 5893.499052580536, 5448.91826622601, 5452.645578037414, 5463.371712253102, 5467.316585426822, 5467.45325467454, 26030.6095408569, 26067.608985865227, 26225.213243602724, 26839.194824155307, 26944.73055269442, 1920.2990908318363, 1936.6223586400658, 1940.5439721665398, 1944.9027548622653, 1947.4449781812257, 17136.48590542273, 17530.0, 17554.03452810095, 17653.20560574777, 17714.025728584922, 2127.2022991378235, 2174.097749433983, 2211.756706762255, 2237.0604346174646, 2247.6516139998325, 112896.0, 116899.0, 117140.0, 117471.0, 117471.4126429371, 12351.629451116482, 12934.741305173844, 12949.223046617233, 13070.607881763563, 13250.0, 19848.305309314106, 19873.0, 19940.102695378744, 19950.401487955383, 19972.0, 8870.645174193089, 8976.775580610538, 9067.138621830916, 9165.129312715282, 9199.35604507678, 7594.392448604099, 8135.064467586185, 8145.06331771842, 8318.916810831814, 8435.915640843636, 8315.584220788936, 8511.0, 8557.187067228604, 8647.654093836301, 8693.565321733888, 2468.271859801363, 2475.913343033021, 2481.2656951288195, 2503.4492411669403, 2594.7664710176173, 926.6988228825659, 945.2438049560325, 961.2622790724334, 991.613270824379, 1000.4497526360473, 18900.432987010136, 19519.121639526256, 20178.596428071356, 20222.393328200178, 20691.379258622266, 972.6449845806371, 1025.707673313117, 1028.2031425645184, 1041.4688508860536, 1051.2851261142343, 10297.794044119075, 10680.572777088984, 10768.300060496043, 10854.891451085547, 10936.835947460795, 415048.0, 415848.0, 419644.0, 429270.0, 429967.0, 98582.50708746554, 99176.50411747895, 100215.0, 100308.0, 100904.49547752214, 1150.2121047082608, 1160.7794519041356, 1166.8016437205695, 1171.8066519024435, 1185.5435657272012, 15870.444534441702, 16522.678185745353, 16904.830951690325, 17369.0, 17983.64032719312, 46863.0, 48140.518594813606, 50251.0, 50290.2456463146, 50499.242511363096, 59845.0, 59931.70034149801, 60594.0, 60753.39246607654, 60839.0, 11233.606823761129, 11388.37363944991, 11469.713257168638, 11470.369129697947, 11581.0, 17259.3959211432, 17427.912860435616, 17540.82459175392, 17598.472045838644, 17743.11284435747, 14221.14673119616, 14707.779383309045, 15453.690926181638, 15553.0, 15581.29884155193, 12426.5650702225, 13319.334033298102, 13940.512082077079, 14111.153330800185, 14151.504697335544, 13766.380512876744, 13809.309534523032, 14051.648708782363, 14064.08583442073, 14065.296735163405, 11388.37363944991, 11615.419229038345, 11619.709507262387, 11711.590094346657, 11776.116791240862, 13893.58319250424, 13981.720365592428, 14380.856191437952, 15100.093994360373, 15350.539483815503], "value": 10598.111480492138, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1313.4089659653155, 1360.2654566534059, 1367.3368416318085, 1375.7523645743768, 1383.9758578651802, 11318.943405282973, 11687.065034797217, 11815.763684726311, 11832.645020649383, 12668.556600518983, 12051.51793928244, 12195.207311524744, 12286.385680715974, 12307.446164922578, 12310.38448077597, 2497.5754121799337, 2533.429978254887, 2546.2870396289068, 2554.7098715148823, 2559.4497183105627, 2446.5351583199226, 2491.0, 2492.0530198524534, 2492.8753562321904, 2506.223070848043, 2358.127492827656, 2387.4747555537756, 2395.7484464131276, 2398.0767404549288, 2398.37642213025, 2266.3540890846193, 2339.1579031548713, 2344.4138965258685, 2346.483773569812, 2363.4564050268364, 1975.101328895349, 2057.2902348689677, 2299.4251437140715, 2305.4927915858484, 2404.507076049406, 11955.521779128825, 12076.335801530913, 12079.93960030203, 12095.395230238453, 12104.092193085553, 6685.398314151701, 6878.209005964278, 6933.479989000794, 6943.340382663639, 6955.095837541138, 4070.348744200943, 4186.790660466964, 4297.634701050414, 4299.806508707115, 4314.82740690372, 1391.568613729747, 1392.1368751374214, 1411.350778641826, 1426.2155814302093, 1433.0, 17675.646487070186, 17766.0, 17858.91070544639, 17933.7309940351, 17967.820321796746, 5652.85867853307, 5692.7722891083895, 5702.942970570324, 5848.298204215522, 5877.265341832271, 12963.351832408342, 13014.739705206031, 13058.15122017066, 13080.28058456775, 13094.934525327502, 6461.547691661633, 6535.379138981789, 6535.934640653532, 6545.21457425112, 6616.536842420985, 6107.083937409424, 6140.8771824563255, 6149.262088549313, 6158.0, 6180.598261113013, 4345.39220488415, 4449.1991441540185, 4464.196444639996, 4503.121891231179, 4509.436320459942, 1306.882380585752, 1336.1448672849385, 1341.6578772412972, 1349.3657980749033, 1355.1801160297878, 848.2323497234889, 864.4208380385157, 875.4309698695771, 882.6601758323092, 907.0068275238604, 6092.634441933498, 6233.096201050822, 6490.545661803629, 6497.090407342976, 6503.171120562571, 693.5526585352419, 696.2654399608462, 698.2842586349033, 698.4028655499576, 720.9170945341248, 4014.1770936957855, 4215.367694845798, 4333.934990975138, 5049.6212784041345, 5265.631405801557, 15453.845461545465, 15850.44523441674, 15856.365745370287, 15880.285387157606, 15886.682266354608, 14653.92673036628, 15167.924160379127, 15255.694886102216, 15285.541433757006, 15291.617709557127, 9084.091590840862, 9276.07239276067, 9276.953615231881, 9277.350585459088, 9279.72160835176, 6848.14398200225, 6915.9345047922925, 7531.849363012819, 7537.660805263886, 7712.652930618248, 14074.507392241223, 14079.648008799863, 14090.577282681126, 14091.436342546183, 14161.645958850699, 14186.574402767934, 14350.0, 14384.496542620958, 14467.421303147756, 14514.927425362806, 11121.110311175249, 11260.436978151223, 11298.717532061764, 11351.943240283746, 11357.716057098638, 11216.0, 11281.153913456359, 11410.543578256777, 11414.771704565695, 11425.657230283105, 8722.956385218033, 8729.956350218208, 8916.86624700617, 9077.863832042392, 9358.204552612831, 8728.039915609404, 8844.380893337404, 8860.069692682175, 8932.28541716648, 9136.086391361077, 7865.174156713462, 7906.52560846351, 7912.0901096374655, 7969.442139050211, 7999.84000320002, 5768.480836724715, 5785.971070144622, 5799.652020878761, 5806.165689843133, 6040.607360521552, 5314.441983591667, 5519.227308176939, 5532.446755324436, 5608.298962629671, 6000.189974353581], "value": 5473.459843731329, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [441.98895027624303, 443.6628162596427, 453.77764895201364, 454.6544626084173, 454.84535258012266, 6009.402806852761, 6230.968845155768, 6249.531285153609, 6319.146915166451, 6326.4938804895555, 5946.435088666581, 6043.274807023153, 6063.272407311118, 6081.726322315495, 6083.908741368872, 4769.427668679763, 4831.202851529511, 4860.854174374775, 4868.148074087029, 4876.878078048059, 4916.729579873106, 4919.483454237307, 4932.96407754372, 4933.705826790541, 4935.014316338599, 4836.564709176174, 4846.830360937368, 4858.975705121469, 4860.489648586883, 4880.193449109683, 4867.683600565952, 4877.268409738532, 4879.585235255007, 4888.266759985995, 4901.534354236342, 4325.178216138924, 4325.632321252698, 4339.761313127777, 4348.326009468537, 4358.869233922987, 6038.939610603882, 6068.0, 6100.633961962252, 6106.358832322587, 6125.173101631267, 5557.3886872444, 5580.972095139539, 5582.6043489127715, 5590.413006634286, 5627.634203776742, 6496.5127615428555, 6517.250516190651, 6531.379518945692, 6547.279799222082, 6577.572457790228, 4709.858704238878, 4716.740579268139, 4724.692894961817, 4738.076075165344, 4743.193657078305, 6437.774677886251, 6754.45964322853, 6875.140607424072, 6917.9308206917785, 6920.515563910478, 4733.763311834395, 4753.762311884392, 4790.688605240648, 4795.160846851787, 4797.160496913027, 4827.42070951488, 4835.782389792468, 4848.75756212195, 4861.732604706775, 4873.561379475864, 5374.5700343972385, 5501.119820828728, 5515.558755299567, 5533.944660553423, 5547.195656629847, 6527.640979746065, 6538.346165383518, 6545.214574251025, 6559.967200164064, 6564.507661925375, 1674.9581260468585, 1675.9245833937503, 1681.1510187355307, 1681.7393304037894, 1684.9157542122846, 1102.6251074634663, 1140.5380820767602, 1151.4300421291514, 1151.792677318074, 1160.3791971295486, 5669.06460434032, 5683.772649094072, 5749.9712501437225, 5754.705191332, 5770.365259821417, 6723.394894459522, 6761.290064543152, 6772.661366931634, 6789.0, 6792.252852186256, 5688.516476099495, 5701.116326969326, 5703.657780533098, 5722.885542289131, 5728.484436400744, 3562.608113107556, 3573.4997100405963, 3591.1505574629086, 3597.388443964532, 3615.837287322077, 6493.383128602775, 6519.445847102955, 6521.347865213441, 6533.738650454024, 6542.6401547914365, 6848.520603557703, 6852.6916288767125, 6867.416269617139, 6871.072405225231, 6873.725050998004, 6458.257300410419, 6510.925697260089, 6536.477081833537, 6537.444317232993, 6542.967285163544, 6708.664566771739, 6723.226828914738, 6743.549257490033, 6771.729130834909, 6780.72877084911, 6661.16735408074, 6678.866422671616, 6691.76578819739, 6697.129373181455, 6729.629870357177, 5960.284765828128, 6278.277998030285, 6467.935320646733, 6511.120998665309, 6519.511036672174, 5198.766055527586, 5205.479452054764, 5219.243209734643, 5244.868878278074, 5259.105951988247, 6646.60120392778, 6647.767328143492, 6713.160854893138, 6721.428678562377, 6744.898826517704, 6321.45124444514, 6466.676666166767, 6478.773242936474, 6503.512236582181, 6556.868862622626, 6539.705713243011, 6549.24683661385, 6553.180852393451, 6567.9671601641685, 6577.868442631217, 6477.77327793525, 6479.505390424626, 6480.0, 6491.0, 6505.674716264262, 6384.106225128578, 6390.840228994312, 6394.1687580614225, 6414.134091897534, 6426.614403135827, 6179.837057030004, 6181.35095814933, 6210.7515699373325, 6211.751529938751, 6230.626162430269], "value": 4973.390150185699, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [820.8153165537755, 823.4647479138555, 836.9581520923956, 839.2362949715758, 848.6520526584102, 16855.072970986606, 17152.91423542882, 17169.399071032516, 17762.289508419646, 18868.43394698158, 17944.10279486024, 18309.08454577269, 18551.165197566108, 18582.163802628882, 18587.90706046468, 940.3746508571792, 979.2851218610383, 979.4661909259471, 980.1570649241646, 983.4246965525176, 895.6148855991921, 989.8168838764816, 989.9356541824794, 991.0386924683082, 992.5979978108842, 1036.445501656614, 1049.5014867937707, 1050.2018465965882, 1050.8528805967171, 1051.6056478820442, 1032.117539503721, 1041.463646222196, 1041.630221271449, 1041.8489319048695, 1043.139409986764, 756.5498528375608, 756.765402725157, 756.9024913874848, 758.4008633179782, 761.0524896503833, 17065.7440138398, 17447.563810904703, 17569.472915812545, 17656.028918409484, 17943.910280448647, 18711.251549938122, 19116.713249301272, 19156.329528466576, 19209.03954802254, 19307.0, 14364.497242596459, 14884.925575372054, 14891.0, 14900.478483253142, 14904.329305181293, 3393.0, 3465.0, 3473.6700013498676, 3485.0590340607896, 3494.336076145524, 78425.21574784293, 80355.19644803535, 80599.0, 80658.0, 80873.59563202206, 14034.36845341962, 14257.0, 14291.785623215661, 14353.0, 14407.42370305176, 25237.62143567848, 25590.0, 25597.488050239263, 25983.870080649853, 26311.079112231364, 8024.638891249908, 8082.757517274491, 8268.627911743986, 8310.252077312949, 8312.625931832961, 3969.226000929791, 4027.932597861569, 4043.7978101094827, 4064.5935406459116, 4068.613481719232, 4502.851772797915, 4563.885902852388, 4589.311603259538, 4598.011427543094, 4613.907721845544, 857.4212406625503, 876.9210771030638, 877.7849426890452, 879.5821984557411, 883.0286684646966, 667.5093806052547, 682.1643486728717, 697.4803771190495, 725.4522835259451, 727.7780277015455, 10746.301490403099, 11273.436328183558, 11326.207165498336, 11665.825012624817, 12111.939440302742, 691.560858854631, 698.5703792167882, 701.7368486817444, 717.9102612173479, 730.7223255163004, 5167.741612919339, 5258.368995720538, 5347.598930080259, 5363.892722145535, 5394.62237643369, 79418.20581794223, 81113.0, 83266.0, 90450.54774726085, 93454.0, 71753.64123179455, 72247.0, 73461.6326918362, 74276.25723742801, 75649.24350756532, 64938.0, 65051.349486505474, 66237.33762662312, 66241.66879165573, 68345.31654683489, 11269.323840569592, 12009.699757505783, 12176.269423834598, 12209.69475763113, 12335.3832308386, 30876.22809429782, 31264.21839454032, 31282.21794455157, 31570.36859262756, 31747.20631984219, 38451.615483845926, 38548.6145138545, 38593.22813543657, 38886.41670375003, 39917.800410997756, 16449.09529975863, 16466.09436481005, 16626.334946602, 16742.07918564442, 16908.66182676315, 19012.524686882385, 19362.0, 19498.122584483448, 19643.803561964196, 19801.0, 16746.49760507187, 17198.484045478657, 17576.0, 17760.55598610045, 17776.466705998842, 17231.3969011084, 17295.0, 17443.651126977642, 17546.0, 17864.19611117529, 16910.492685219462, 16913.0, 17029.91485042567, 17408.82591174072, 17499.650006999535, 10309.48452577353, 10514.369137851754, 10734.624288149877, 11036.724081897695, 11046.668599942015, 12573.685657858627, 12754.48982040708, 13550.119242249222, 13607.727845442838, 13806.516771912935], "value": 8146.273939011532, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1559.8999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 104.0, 110.0, 110.0, 113.0, 110.0, 101.0, 110.0, 110.0], "value": 107.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 121.0, 152.0, 185.0, 120.0, 158.0, 156.0, 122.0, 166.0, 123.0], "value": 145.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 163.0, 162.0, 162.0, 165.0, 172.0, 175.0, 167.0, 162.0], "value": 165.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 80.0, 171.0, 76.0, 75.0, 76.0, 76.0, 155.0, 75.0], "value": 93.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 139.0, 82.0, 82.0, 82.0, 134.0, 82.0, 82.0, 145.0], "value": 99.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 114.0, 113.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 150.0, 151.0, 151.0, 150.0, 150.0, 150.0, 152.0, 150.0], "value": 150.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 95.0, 99.0, 95.0, 94.0, 95.0, 94.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 55.0, 52.0, 53.0, 55.0, 52.0, 53.0, 52.0, 54.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 57.0, 56.0, 56.0, 56.0, 56.0, 57.0, 57.0, 58.0], "value": 56.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 90.0, 82.0, 89.0, 82.0, 82.0, 83.0, 104.0, 84.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 130.0, 130.0, 130.0, 132.0, 136.0, 138.0, 131.0, 138.0, 130.0], "value": 133.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 190.0, 187.0, 185.0, 178.0, 181.0, 186.0, 191.0, 199.0, 180.0], "value": 187.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 73.0, 71.0, 71.0, 71.0, 69.0, 70.0, 73.0, 71.0], "value": 71.1, "unit": "score"}]}]} 16:52:41 INFO - Return code: 0 16:52:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:52:41 INFO - # TBPL SUCCESS # 16:52:41 INFO - Running post-action listener: _resource_record_post_action 16:52:41 INFO - [mozharness: 2017-06-09 23:52:41.945092Z] Finished run-tests step (success) 16:52:41 INFO - Running post-run listener: _resource_record_post_run 16:52:42 INFO - Total resource usage - Wall time: 1253s; CPU: 13.0%; Read bytes: 4096; Write bytes: 434696192; Read time: 16; Write time: 368612 16:52:42 INFO - TinderboxPrint: CPU usage
12.7% 16:52:42 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 16:52:42 INFO - TinderboxPrint: I/O write bytes / time
434,696,192 / 368,612 16:52:42 INFO - TinderboxPrint: CPU idle
8,733.1 (87.3%) 16:52:42 INFO - TinderboxPrint: CPU user
1,211.9 (12.1%) 16:52:42 INFO - TinderboxPrint: Swap in / out
0 / 0 16:52:42 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 104669184; Read time: 0; Write time: 113532 16:52:42 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 16:52:42 INFO - run-tests - Wall time: 1236s; CPU: 13.0%; Read bytes: 0; Write bytes: 329207808; Read time: 0; Write time: 255036 16:52:42 INFO - Running post-run listener: _upload_blobber_files 16:52:42 INFO - Blob upload gear active. 16:52:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:52:42 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 16:52:42 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'] 16:52:42 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 16:52:43 INFO - (blobuploader) - INFO - Open directory for files ... 16:52:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:52:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:52:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:52:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:52:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:52:43 INFO - (blobuploader) - INFO - Done attempting. 16:52:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:52:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:52:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:52:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:52:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:52:47 INFO - (blobuploader) - INFO - Done attempting. 16:52:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:52:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:52:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:52:48 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:52:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:52:48 INFO - (blobuploader) - INFO - Done attempting. 16:52:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:52:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:52:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:52:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:52:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:52:48 INFO - (blobuploader) - INFO - Done attempting. 16:52:48 INFO - (blobuploader) - INFO - Iteration through files over. 16:52:48 INFO - Return code: 0 16:52:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:52:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:52:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/856fabd2f9eff7df25efdd9927096f1bb3b5104e83d57519fd51d5881166d52f65ee258aa1efccb6ae985bc71fb0ded2facfa26ae3d59720c4c091af1a77658f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5b19b1ca352115f1cf0124fd04df89ba91a08940bc4407a6a8d675748fff1b4456751e839a022258f197e37c46c5b28b7ec552afcf607d1f1bd89eed795dfdf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7eaf8bba29f8f4b43814af8ac201afe5bde7e5d2abd6651d31e3e9e3fbab9ef300713e70885389cffb93b88f74caf9547c893d9ae9e0ef18d7b652a022620551", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51fd626c27bdfd9a5a800d08252de0ddbe5a019ea1d96b46211039f865b4b9662c9697060499cfe8c6ad75d64f19ab4fa09bf3c5ad858a359ef077f0c088ff42"} 16:52:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:52:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:52:48 INFO - Contents: 16:52:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/856fabd2f9eff7df25efdd9927096f1bb3b5104e83d57519fd51d5881166d52f65ee258aa1efccb6ae985bc71fb0ded2facfa26ae3d59720c4c091af1a77658f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5b19b1ca352115f1cf0124fd04df89ba91a08940bc4407a6a8d675748fff1b4456751e839a022258f197e37c46c5b28b7ec552afcf607d1f1bd89eed795dfdf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7eaf8bba29f8f4b43814af8ac201afe5bde7e5d2abd6651d31e3e9e3fbab9ef300713e70885389cffb93b88f74caf9547c893d9ae9e0ef18d7b652a022620551", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51fd626c27bdfd9a5a800d08252de0ddbe5a019ea1d96b46211039f865b4b9662c9697060499cfe8c6ad75d64f19ab4fa09bf3c5ad858a359ef077f0c088ff42"} 16:52:48 INFO - Running post-run listener: copy_logs_to_upload_dir 16:52:48 INFO - Copying logs to upload dir... 16:52:48 INFO - mkdir: /builds/slave/test/build/upload/logs 16:52:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1311.396809 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 51 secs) (at 2017-06-09 16:52:48.715379) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-09 16:52:48.720387) ========= 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=41a7e32711b8e08598a63237000001d6-1497045106.932687-980759909 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/856fabd2f9eff7df25efdd9927096f1bb3b5104e83d57519fd51d5881166d52f65ee258aa1efccb6ae985bc71fb0ded2facfa26ae3d59720c4c091af1a77658f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5b19b1ca352115f1cf0124fd04df89ba91a08940bc4407a6a8d675748fff1b4456751e839a022258f197e37c46c5b28b7ec552afcf607d1f1bd89eed795dfdf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7eaf8bba29f8f4b43814af8ac201afe5bde7e5d2abd6651d31e3e9e3fbab9ef300713e70885389cffb93b88f74caf9547c893d9ae9e0ef18d7b652a022620551", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51fd626c27bdfd9a5a800d08252de0ddbe5a019ea1d96b46211039f865b4b9662c9697060499cfe8c6ad75d64f19ab4fa09bf3c5ad858a359ef077f0c088ff42"} build_url:https://queue.taskcluster.net/v1/task/Wzsoh7TER1GYtnPFPVfXew/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011350 build_url: 'https://queue.taskcluster.net/v1/task/Wzsoh7TER1GYtnPFPVfXew/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/856fabd2f9eff7df25efdd9927096f1bb3b5104e83d57519fd51d5881166d52f65ee258aa1efccb6ae985bc71fb0ded2facfa26ae3d59720c4c091af1a77658f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e5b19b1ca352115f1cf0124fd04df89ba91a08940bc4407a6a8d675748fff1b4456751e839a022258f197e37c46c5b28b7ec552afcf607d1f1bd89eed795dfdf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7eaf8bba29f8f4b43814af8ac201afe5bde7e5d2abd6651d31e3e9e3fbab9ef300713e70885389cffb93b88f74caf9547c893d9ae9e0ef18d7b652a022620551", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/51fd626c27bdfd9a5a800d08252de0ddbe5a019ea1d96b46211039f865b4b9662c9697060499cfe8c6ad75d64f19ab4fa09bf3c5ad858a359ef077f0c088ff42"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-09 16:52:48.747188) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-09 16:52:48.747503) ========= 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=41a7e32711b8e08598a63237000001d6-1497045106.932687-980759909 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004434 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-09 16:52:48.829518) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-09 16:52:48.829807) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-09 16:52:48.833131) ========= ========= Total master_lag: 0.20 =========