builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-008 starttime: 1500295680.6 results: success (0) revision: d43779e278d2e4d3e21dba2fcb585a3bf4b1288e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-17 05:48:00.603939) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-17 05:48:00.604910) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-17 05:48:00.605189) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-17 05:48:00.723047) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 05:48:00.723308) ========= 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=32c5991c409366f7fec8a718000001d2-1500294816.967678-1879613223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-17 05:48:01-- 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% 228M=0s 2017-07-17 05:48:01 (228 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.119655 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 05:48:00.864465) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 05:48:00.864751) ========= 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=32c5991c409366f7fec8a718000001d2-1500294816.967678-1879613223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015582 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 05:48:00.926148) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-17 05:48:00.926537) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d43779e278d2e4d3e21dba2fcb585a3bf4b1288e --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 d43779e278d2e4d3e21dba2fcb585a3bf4b1288e --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=32c5991c409366f7fec8a718000001d2-1500294816.967678-1879613223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-17 05:48:01,484 truncating revision to first 12 chars 2017-07-17 05:48:01,484 Setting DEBUG logging. 2017-07-17 05:48:01,484 attempt 1/10 2017-07-17 05:48:01,484 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d43779e278d2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-17 05:48:02,322 unpacking tar archive at: mozilla-central-d43779e278d2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.201217 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-17 05:48:02.146883) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-17 05:48:02.147211) ========= script_repo_revision: d43779e278d2e4d3e21dba2fcb585a3bf4b1288e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-17 05:48:02.147619) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-17 05:48:02.147888) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-17 05:48:02.157320) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-07-17 05:48:02.157590) ========= /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=32c5991c409366f7fec8a718000001d2-1500294816.967678-1879613223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:48:02 INFO - MultiFileLogger online at 20170717 05:48:02 in /builds/slave/test 05:48:02 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 05:48:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:48:02 INFO - {'append_to_log': False, 05:48:02 INFO - 'base_work_dir': '/builds/slave/test', 05:48:02 INFO - 'blob_upload_branch': 'Firefox', 05:48:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:48:02 INFO - 'branch': 'Firefox', 05:48:02 INFO - 'buildbot_json_path': 'buildprops.json', 05:48:02 INFO - 'code_coverage': False, 05:48:02 INFO - 'config_files': ('talos/linux_config.py',), 05:48:02 INFO - 'default_actions': ('clobber', 05:48:02 INFO - 'read-buildbot-config', 05:48:02 INFO - 'download-and-extract', 05:48:02 INFO - 'populate-webroot', 05:48:02 INFO - 'create-virtualenv', 05:48:02 INFO - 'install', 05:48:02 INFO - 'setup-mitmproxy', 05:48:02 INFO - 'run-tests'), 05:48:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:48:02 INFO - 'disable_ccov_upload': False, 05:48:02 INFO - 'download_minidump_stackwalk': True, 05:48:02 INFO - 'download_symbols': 'ondemand', 05:48:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:48:02 INFO - 'tooltool.py': '/tools/tooltool.py', 05:48:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:48:02 INFO - '/tools/misc-python/virtualenv.py')}, 05:48:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:48:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:48:02 INFO - 'gecko_profile': False, 05:48:02 INFO - 'gecko_profile_interval': 0, 05:48:02 INFO - 'installer_path': 'installer.exe', 05:48:02 INFO - 'log_level': 'info', 05:48:02 INFO - 'log_name': 'talos', 05:48:02 INFO - 'log_to_console': True, 05:48:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:48:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:48:02 INFO - 'opt_config_files': (), 05:48:02 INFO - 'pip_index': False, 05:48:02 INFO - 'suite': 'dromaeojs-e10s', 05:48:02 INFO - 'system_bits': '32', 05:48:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:48:02 INFO - 'title': 'talos-linux64-ix-008', 05:48:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:48:02 INFO - 'use_talos_json': True, 05:48:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:48:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:48:02 INFO - 'work_dir': 'build'} 05:48:02 INFO - [mozharness: 2017-07-17 12:48:02.819565Z] Running clobber step. 05:48:02 INFO - Running pre-action listener: _resource_record_pre_action 05:48:02 INFO - Running main action method: clobber 05:48:02 INFO - rmtree: /builds/slave/test/build 05:48:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:48:03 INFO - Running post-action listener: _resource_record_post_action 05:48:03 INFO - [mozharness: 2017-07-17 12:48:03.853851Z] Finished clobber step (success) 05:48:03 INFO - [mozharness: 2017-07-17 12:48:03.853955Z] Running read-buildbot-config step. 05:48:03 INFO - Running pre-action listener: _resource_record_pre_action 05:48:03 INFO - Running main action method: read_buildbot_config 05:48:03 INFO - Using buildbot properties: 05:48:03 INFO - { 05:48:03 INFO - "project": "", 05:48:03 INFO - "product": "firefox", 05:48:03 INFO - "who": "archaeopteryx@coole-files.de", 05:48:03 INFO - "installer_path": "public/build/target.tar.bz2", 05:48:03 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 05:48:03 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:48:03 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 05:48:03 INFO - "stage_platform": "linux64-stylosequential", 05:48:03 INFO - "basedir": "/builds/slave/test", 05:48:03 INFO - "buildnumber": 106, 05:48:03 INFO - "platform": "ubuntu64_hw_styloseq", 05:48:03 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:48:03 INFO - "slavebuilddir": "test", 05:48:03 INFO - "taskId": "Ut31HQdNRC2RTUZNGcpHCA", 05:48:03 INFO - "branch": "mozilla-central", 05:48:03 INFO - "script_repo_revision": "production", 05:48:03 INFO - "revision": "d43779e278d2e4d3e21dba2fcb585a3bf4b1288e", 05:48:03 INFO - "slavename": "talos-linux64-ix-008", 05:48:03 INFO - "repo_path": "mozilla-central" 05:48:03 INFO - } 05:48:03 INFO - Finding installer, test and symbols from parent task. 05:48:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ut31HQdNRC2RTUZNGcpHCA'}, attempt #1 05:48:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ut31HQdNRC2RTUZNGcpHCA'}, attempt #1 05:48:04 INFO - Task dependencies: AcKXipBCQoSWPd6GQSLflg 05:48:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg'}, attempt #1 05:48:05 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.tar.bz2 05:48:05 INFO - Set test_url: https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/test_packages.json 05:48:05 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.crashreporter-symbols.zip 05:48:05 INFO - Running post-action listener: _resource_record_post_action 05:48:05 INFO - [mozharness: 2017-07-17 12:48:05.212393Z] Finished read-buildbot-config step (success) 05:48:05 INFO - [mozharness: 2017-07-17 12:48:05.212613Z] Running download-and-extract step. 05:48:05 INFO - Running pre-action listener: _resource_record_pre_action 05:48:05 INFO - Running main action method: download_and_extract 05:48:05 INFO - mkdir: /builds/slave/test/build/tests 05:48: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')]} 05:48:05 INFO - trying https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.test_packages.json 05:48:05 INFO - Downloading https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:48:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:48:05 INFO - Downloaded 989 bytes. 05:48:05 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:48:05 INFO - Using the following test package requirements: 05:48:05 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 05:48:05 INFO - u'common': [u'target.common.tests.zip'], 05:48:05 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:48:05 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:48:05 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:48:05 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:48:05 INFO - u'mozbase': [u'target.common.tests.zip'], 05:48:05 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:48:05 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:48:05 INFO - u'web-platform': [u'target.common.tests.zip', 05:48:05 INFO - u'target.web-platform.tests.tar.gz'], 05:48:05 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:48:05 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:48:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.common.tests.zip 05:48:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:48:05 INFO - Fetch https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.common.tests.zip into memory 05:48:09 INFO - Content-Length response header: 72769128 05:48:09 INFO - Bytes received: 72769128 05:48:20 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:48:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.common.tests.zip 05:48:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:48:20 INFO - Fetch https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.common.tests.zip into memory 05:48:22 INFO - Content-Length response header: 72769128 05:48:22 INFO - Bytes received: 72769128 05:48:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.talos.tests.zip 05:48:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:48:34 INFO - Fetch https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.talos.tests.zip into memory 05:48:34 INFO - Content-Length response header: 14495033 05:48:34 INFO - Bytes received: 14495033 05:48: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')]} 05:48:35 INFO - trying https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.tar.bz2 05:48:35 INFO - Downloading https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:48:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:48:36 INFO - Downloaded 61816108 bytes. 05:48:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.tar.bz2 05:48:36 INFO - mkdir: /builds/slave/test/properties 05:48:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:48:36 INFO - Writing to file /builds/slave/test/properties/build_url 05:48:36 INFO - Contents: 05:48:36 INFO - build_url:https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.tar.bz2 05:48:36 INFO - Running post-action listener: _resource_record_post_action 05:48:36 INFO - Running post-action listener: set_extra_try_arguments 05:48:36 INFO - [mozharness: 2017-07-17 12:48:36.938837Z] Finished download-and-extract step (success) 05:48:36 INFO - [mozharness: 2017-07-17 12:48:36.939000Z] Running populate-webroot step. 05:48:36 INFO - Running pre-action listener: _resource_record_pre_action 05:48:36 INFO - Running main action method: populate_webroot 05:48:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:48:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:48:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:48:36 INFO - '--tppagecycles', 05:48:36 INFO - '7'], 05:48:36 INFO - 'tests': ['tsvgm']}}, 05:48:36 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:48:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:48:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:48:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:48:36 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:48:36 INFO - 'talos_options': ['--disable-e10s'], 05:48:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:48:36 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:48:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:48:36 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:48:36 INFO - 'talos_options': ['--disable-e10s'], 05:48:36 INFO - 'tests': ['damp', 'tps']}, 05:48:36 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:48:36 INFO - 'tests': ['damp', 'tps']}, 05:48:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:48:36 INFO - 'tests': ['dromaeo_dom']}, 05:48:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:48:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:48:36 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:48:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:48:36 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 05:48:36 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 05:48:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:48:36 INFO - 'tests': ['a11yr', 05:48:36 INFO - 'ts_paint', 05:48:36 INFO - 'tpaint', 05:48:36 INFO - 'sessionrestore', 05:48:36 INFO - 'sessionrestore_no_auto_restore', 05:48:36 INFO - 'tabpaint']}, 05:48:36 INFO - 'other-e10s': {'tests': ['a11yr', 05:48:36 INFO - 'ts_paint', 05:48:36 INFO - 'tpaint', 05:48:36 INFO - 'sessionrestore', 05:48:36 INFO - 'sessionrestore_many_windows', 05:48:36 INFO - 'sessionrestore_no_auto_restore', 05:48:36 INFO - 'tabpaint']}, 05:48:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:48:36 INFO - 'ts_paint', 05:48:36 INFO - 'tpaint', 05:48:36 INFO - 'sessionrestore', 05:48:36 INFO - 'sessionrestore_many_windows', 05:48:36 INFO - 'sessionrestore_no_auto_restore', 05:48:36 INFO - 'tabpaint']}, 05:48:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:48:36 INFO - 'ts_paint', 05:48:36 INFO - 'tpaint', 05:48:36 INFO - 'sessionrestore', 05:48:36 INFO - 'sessionrestore_many_windows', 05:48:36 INFO - 'sessionrestore_no_auto_restore', 05:48:36 INFO - 'tabpaint']}, 05:48:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:48:36 INFO - 'tests': ['a11yr', 05:48:36 INFO - 'ts_paint', 05:48:36 INFO - 'tpaint', 05:48:36 INFO - 'sessionrestore', 05:48:36 INFO - 'sessionrestore_no_auto_restore', 05:48:36 INFO - 'tabpaint']}, 05:48:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:48:36 INFO - 'tests': ['a11yr', 05:48:36 INFO - 'ts_paint', 05:48:36 INFO - 'tpaint', 05:48:36 INFO - 'sessionrestore', 05:48:36 INFO - 'sessionrestore_no_auto_restore', 05:48:36 INFO - 'tabpaint']}, 05:48:36 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 05:48:36 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 05:48:36 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 05:48:36 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 05:48:36 INFO - 'talos_options': ['--mitmproxy', 05:48:36 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 05:48:36 INFO - '--firstNonBlankPaint'], 05:48:36 INFO - 'tests': ['quantum_pageload_google', 05:48:36 INFO - 'quantum_pageload_youtube', 05:48:36 INFO - 'quantum_pageload_amazon', 05:48:36 INFO - 'quantum_pageload_facebook']}, 05:48:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:48:36 INFO - 'tests': ['tsvgx', 05:48:36 INFO - 'tsvgr_opacity', 05:48:36 INFO - 'tart', 05:48:36 INFO - 'tscrollx', 05:48:36 INFO - 'cart', 05:48:36 INFO - 'tsvg_static']}, 05:48:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:48:36 INFO - 'tsvgr_opacity', 05:48:36 INFO - 'tart', 05:48:36 INFO - 'tscrollx', 05:48:36 INFO - 'cart', 05:48:36 INFO - 'tsvg_static']}, 05:48:36 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:48:36 INFO - 'talos_options': ['--disable-e10s'], 05:48:36 INFO - 'tests': ['tp5o']}, 05:48:36 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:48:36 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:48:36 INFO - 'talos_options': ['--disable-e10s', 05:48:36 INFO - '--xperf_path', 05:48:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:48:36 INFO - 'tests': ['tp5n']}, 05:48:36 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:48:36 INFO - 'talos_options': ['--xperf_path', 05:48:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:48:36 INFO - 'tests': ['tp5n']}}, 05:48:36 INFO - 'talos.zip': {'path': '', 05:48:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:48:36 INFO - Running post-action listener: _resource_record_post_action 05:48:36 INFO - [mozharness: 2017-07-17 12:48:36.957171Z] Finished populate-webroot step (success) 05:48:36 INFO - [mozharness: 2017-07-17 12:48:36.957262Z] Running create-virtualenv step. 05:48:36 INFO - Running pre-action listener: _resource_record_pre_action 05:48:36 INFO - Running main action method: create_virtualenv 05:48:36 INFO - Creating virtualenv /builds/slave/test/build/venv 05:48:36 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 05:48:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:48:36 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 05:48:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:48:37 INFO - Using real prefix '/usr' 05:48:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:48:37 INFO - Installing distribute.............................................................................................................................................................................................done. 05:48:39 INFO - Installing pip.................done. 05:48:39 INFO - Return code: 0 05:48:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:48:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:48:39 INFO - Reading from file tmpfile_stdout 05:48:39 INFO - Output received: 05:48:39 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) 05:48:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:48: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')]} 05:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48: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')]} 05:48:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:39 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 0x17301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ed00>, '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 0x1a9fc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0090>, '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': '32c5991c409366f7fec8a718000001d2-1500294816.967678-1879613223', '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 05:48:39 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 05:48:39 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 05:48:39 INFO - Using env: {'DISPLAY': ':0', 05:48:39 INFO - 'HOME': '/home/cltbld', 05:48:39 INFO - 'LANG': 'en_US.UTF-8', 05:48:39 INFO - 'LANGUAGE': 'en_US:en', 05:48:39 INFO - 'LOGNAME': 'cltbld', 05:48:39 INFO - 'MAIL': '/var/mail/cltbld', 05:48:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:39 INFO - 'MOZ_NO_REMOTE': '1', 05:48:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:39 INFO - 'NO_EM_RESTART': '1', 05:48:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:39 INFO - 'PWD': '/builds/slave/test', 05:48:39 INFO - 'SHELL': '/bin/bash', 05:48:39 INFO - 'SHLVL': '1', 05:48:39 INFO - 'TERM': 'linux', 05:48:39 INFO - 'TMOUT': '86400', 05:48:39 INFO - 'USER': 'cltbld', 05:48:39 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1500294816.967678-1879613223', 05:48:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:39 INFO - '_': '/tools/buildbot/bin/python'} 05:48:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:39 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 05:48:39 INFO - Cleaning up... 05:48:39 INFO - Return code: 0 05:48:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:48: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')]} 05:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48: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')]} 05:48:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:39 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 0x17301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ed00>, '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 0x1a9fc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0090>, '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': '32c5991c409366f7fec8a718000001d2-1500294816.967678-1879613223', '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 05:48:39 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 05:48:39 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 05:48:39 INFO - Using env: {'DISPLAY': ':0', 05:48:39 INFO - 'HOME': '/home/cltbld', 05:48:39 INFO - 'LANG': 'en_US.UTF-8', 05:48:39 INFO - 'LANGUAGE': 'en_US:en', 05:48:39 INFO - 'LOGNAME': 'cltbld', 05:48:39 INFO - 'MAIL': '/var/mail/cltbld', 05:48:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:39 INFO - 'MOZ_NO_REMOTE': '1', 05:48:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:39 INFO - 'NO_EM_RESTART': '1', 05:48:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:39 INFO - 'PWD': '/builds/slave/test', 05:48:39 INFO - 'SHELL': '/bin/bash', 05:48:39 INFO - 'SHLVL': '1', 05:48:39 INFO - 'TERM': 'linux', 05:48:39 INFO - 'TMOUT': '86400', 05:48:39 INFO - 'USER': 'cltbld', 05:48:39 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1500294816.967678-1879613223', 05:48:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:39 INFO - '_': '/tools/buildbot/bin/python'} 05:48:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:40 INFO - Downloading/unpacking psutil>=3.1.1 05:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:48:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:48:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:48:41 INFO - Installing collected packages: psutil 05:48:41 INFO - Running setup.py install for psutil 05:48:41 INFO - building 'psutil._psutil_linux' extension 05:48:41 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 05:48:41 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 05:48:41 INFO - building 'psutil._psutil_posix' extension 05:48:41 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 05:48:41 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 05:48:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:48:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:48:41 INFO - Successfully installed psutil 05:48:41 INFO - Cleaning up... 05:48:41 INFO - Return code: 0 05:48:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:48:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ed00>, '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 0x1a9fc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0090>, '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': '32c5991c409366f7fec8a718000001d2-1500294816.967678-1879613223', '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 05:48:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:48:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:48:41 INFO - Using env: {'DISPLAY': ':0', 05:48:41 INFO - 'HOME': '/home/cltbld', 05:48:41 INFO - 'LANG': 'en_US.UTF-8', 05:48:41 INFO - 'LANGUAGE': 'en_US:en', 05:48:41 INFO - 'LOGNAME': 'cltbld', 05:48:41 INFO - 'MAIL': '/var/mail/cltbld', 05:48:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:41 INFO - 'MOZ_NO_REMOTE': '1', 05:48:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:41 INFO - 'NO_EM_RESTART': '1', 05:48:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:41 INFO - 'PWD': '/builds/slave/test', 05:48:41 INFO - 'SHELL': '/bin/bash', 05:48:41 INFO - 'SHLVL': '1', 05:48:41 INFO - 'TERM': 'linux', 05:48:41 INFO - 'TMOUT': '86400', 05:48:41 INFO - 'USER': 'cltbld', 05:48:41 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1500294816.967678-1879613223', 05:48:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:41 INFO - '_': '/tools/buildbot/bin/python'} 05:48:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:48:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:48:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:48:43 INFO - Installing collected packages: mozsystemmonitor 05:48:43 INFO - Running setup.py install for mozsystemmonitor 05:48:43 INFO - Successfully installed mozsystemmonitor 05:48:43 INFO - Cleaning up... 05:48:43 INFO - Return code: 0 05:48:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:48: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')]} 05:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48: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')]} 05:48:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ed00>, '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 0x1a9fc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0090>, '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': '32c5991c409366f7fec8a718000001d2-1500294816.967678-1879613223', '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 05:48:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:48:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:48:43 INFO - Using env: {'DISPLAY': ':0', 05:48:43 INFO - 'HOME': '/home/cltbld', 05:48:43 INFO - 'LANG': 'en_US.UTF-8', 05:48:43 INFO - 'LANGUAGE': 'en_US:en', 05:48:43 INFO - 'LOGNAME': 'cltbld', 05:48:43 INFO - 'MAIL': '/var/mail/cltbld', 05:48:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:43 INFO - 'MOZ_NO_REMOTE': '1', 05:48:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:43 INFO - 'NO_EM_RESTART': '1', 05:48:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:43 INFO - 'PWD': '/builds/slave/test', 05:48:43 INFO - 'SHELL': '/bin/bash', 05:48:43 INFO - 'SHLVL': '1', 05:48:43 INFO - 'TERM': 'linux', 05:48:43 INFO - 'TMOUT': '86400', 05:48:43 INFO - 'USER': 'cltbld', 05:48:43 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1500294816.967678-1879613223', 05:48:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:43 INFO - '_': '/tools/buildbot/bin/python'} 05:48:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:43 INFO - Downloading/unpacking jsonschema==2.5.1 05:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:48:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:48: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 05:48: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 05:48: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 05:48: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 05:48:44 INFO - Downloading functools32-3.2.3-2.tar.gz 05:48:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:48:44 INFO - warning: no files found matching '*.txt' 05:48:44 INFO - no previously-included directories found matching 'build' 05:48:44 INFO - no previously-included directories found matching 'dist' 05:48:44 INFO - no previously-included directories found matching '.git*' 05:48:44 INFO - Installing collected packages: jsonschema, functools32 05:48:44 INFO - Running setup.py install for functools32 05:48:45 INFO - warning: no files found matching '*.txt' 05:48:45 INFO - no previously-included directories found matching 'build' 05:48:45 INFO - no previously-included directories found matching 'dist' 05:48:45 INFO - no previously-included directories found matching '.git*' 05:48:45 INFO - Successfully installed jsonschema functools32 05:48:45 INFO - Cleaning up... 05:48:45 INFO - Return code: 0 05:48:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:45 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 0x17301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ed00>, '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 0x1a9fc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0090>, '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': '32c5991c409366f7fec8a718000001d2-1500294816.967678-1879613223', '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 05:48:45 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 05:48:45 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 05:48:45 INFO - Using env: {'DISPLAY': ':0', 05:48:45 INFO - 'HOME': '/home/cltbld', 05:48:45 INFO - 'LANG': 'en_US.UTF-8', 05:48:45 INFO - 'LANGUAGE': 'en_US:en', 05:48:45 INFO - 'LOGNAME': 'cltbld', 05:48:45 INFO - 'MAIL': '/var/mail/cltbld', 05:48:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:45 INFO - 'MOZ_NO_REMOTE': '1', 05:48:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:45 INFO - 'NO_EM_RESTART': '1', 05:48:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:45 INFO - 'PWD': '/builds/slave/test', 05:48:45 INFO - 'SHELL': '/bin/bash', 05:48:45 INFO - 'SHLVL': '1', 05:48:45 INFO - 'TERM': 'linux', 05:48:45 INFO - 'TMOUT': '86400', 05:48:45 INFO - 'USER': 'cltbld', 05:48:45 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1500294816.967678-1879613223', 05:48:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:45 INFO - '_': '/tools/buildbot/bin/python'} 05:48:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:48:45 INFO - Cleaning up... 05:48:45 INFO - Return code: 0 05:48:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:45 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 0x17301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ed00>, '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 0x1a9fc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0090>, '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': '32c5991c409366f7fec8a718000001d2-1500294816.967678-1879613223', '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 05:48:45 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 05:48:45 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 05:48:45 INFO - Using env: {'DISPLAY': ':0', 05:48:45 INFO - 'HOME': '/home/cltbld', 05:48:45 INFO - 'LANG': 'en_US.UTF-8', 05:48:45 INFO - 'LANGUAGE': 'en_US:en', 05:48:45 INFO - 'LOGNAME': 'cltbld', 05:48:45 INFO - 'MAIL': '/var/mail/cltbld', 05:48:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:45 INFO - 'MOZ_NO_REMOTE': '1', 05:48:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:45 INFO - 'NO_EM_RESTART': '1', 05:48:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:45 INFO - 'PWD': '/builds/slave/test', 05:48:45 INFO - 'SHELL': '/bin/bash', 05:48:45 INFO - 'SHLVL': '1', 05:48:45 INFO - 'TERM': 'linux', 05:48:45 INFO - 'TMOUT': '86400', 05:48:45 INFO - 'USER': 'cltbld', 05:48:45 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1500294816.967678-1879613223', 05:48:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:45 INFO - '_': '/tools/buildbot/bin/python'} 05:48:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:45 INFO - Downloading/unpacking blobuploader==1.2.4 05:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:46 INFO - Downloading blobuploader-1.2.4.tar.gz 05:48:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:48:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:48: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 05:48: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 05:48: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 05:48: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 05:48:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:48:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:47 INFO - Downloading docopt-0.6.1.tar.gz 05:48:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:48:47 INFO - Installing collected packages: blobuploader, requests, docopt 05:48:47 INFO - Running setup.py install for blobuploader 05:48:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:48:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:48:47 INFO - Running setup.py install for requests 05:48:47 INFO - Running setup.py install for docopt 05:48:47 INFO - Successfully installed blobuploader requests docopt 05:48:47 INFO - Cleaning up... 05:48:47 INFO - Return code: 0 05:48:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:48: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')]} 05:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48: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')]} 05:48:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:47 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 0x17301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ed00>, '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 0x1a9fc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0090>, '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': '32c5991c409366f7fec8a718000001d2-1500294816.967678-1879613223', '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 05:48:47 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 05:48:47 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 05:48:47 INFO - Using env: {'DISPLAY': ':0', 05:48:47 INFO - 'HOME': '/home/cltbld', 05:48:47 INFO - 'LANG': 'en_US.UTF-8', 05:48:47 INFO - 'LANGUAGE': 'en_US:en', 05:48:47 INFO - 'LOGNAME': 'cltbld', 05:48:47 INFO - 'MAIL': '/var/mail/cltbld', 05:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:47 INFO - 'MOZ_NO_REMOTE': '1', 05:48:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:47 INFO - 'NO_EM_RESTART': '1', 05:48:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:47 INFO - 'PWD': '/builds/slave/test', 05:48:47 INFO - 'SHELL': '/bin/bash', 05:48:47 INFO - 'SHLVL': '1', 05:48:47 INFO - 'TERM': 'linux', 05:48:47 INFO - 'TMOUT': '86400', 05:48:47 INFO - 'USER': 'cltbld', 05:48:47 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1500294816.967678-1879613223', 05:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:47 INFO - '_': '/tools/buildbot/bin/python'} 05:48:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:48:48 INFO - Running setup.py (path:/tmp/pip-iXY3BS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:48:48 INFO - Running setup.py (path:/tmp/pip-Ng0nig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:48:48 INFO - Running setup.py (path:/tmp/pip-71_FyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:48:48 INFO - Running setup.py (path:/tmp/pip-Gfzq2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:48:48 INFO - Running setup.py (path:/tmp/pip-yVcm_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:48:48 INFO - Running setup.py (path:/tmp/pip-rG1sIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:48:48 INFO - Running setup.py (path:/tmp/pip-SCV6xm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:48:48 INFO - Running setup.py (path:/tmp/pip-dRfppK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:48:48 INFO - Running setup.py (path:/tmp/pip-KB_2oa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:48:48 INFO - Running setup.py (path:/tmp/pip-Qk_5Mw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:48:48 INFO - Running setup.py (path:/tmp/pip-dI3CZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:48:48 INFO - Running setup.py (path:/tmp/pip-hol0mr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:48:48 INFO - Running setup.py (path:/tmp/pip-h_SFyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:48:48 INFO - Running setup.py (path:/tmp/pip-1xFz8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:49 INFO - Running setup.py (path:/tmp/pip-GYqcIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:48:49 INFO - Running setup.py (path:/tmp/pip-0usvs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:48:49 INFO - Running setup.py (path:/tmp/pip-DcMZ6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:48:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:48:49 INFO - Running setup.py install for manifestparser 05:48:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:48:49 INFO - Running setup.py install for mozcrash 05:48:49 INFO - Running setup.py install for mozdebug 05:48:49 INFO - Running setup.py install for mozdevice 05:48:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:48:49 INFO - Running setup.py install for mozfile 05:48:49 INFO - Running setup.py install for mozhttpd 05:48:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:48:49 INFO - Running setup.py install for mozinfo 05:48:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:48:49 INFO - Running setup.py install for mozInstall 05:48:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:48:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:48:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:48:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:48:50 INFO - Running setup.py install for mozleak 05:48:50 INFO - Running setup.py install for mozlog 05:48:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:48:50 INFO - Running setup.py install for moznetwork 05:48:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:48:50 INFO - Running setup.py install for mozprocess 05:48:50 INFO - Running setup.py install for mozprofile 05:48:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:48:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:48:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:48:50 INFO - Running setup.py install for mozrunner 05:48:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:48:50 INFO - Running setup.py install for mozscreenshot 05:48:50 INFO - Running setup.py install for moztest 05:48:50 INFO - Running setup.py install for mozversion 05:48:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:48:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:48:51 INFO - Cleaning up... 05:48:51 INFO - Return code: 0 05:48:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:48:51 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')]} 05:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:51 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')]} 05:48:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:51 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 0x17301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ed00>, '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 0x1a9fc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0090>, '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': '32c5991c409366f7fec8a718000001d2-1500294816.967678-1879613223', '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 05:48:51 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 05:48:51 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 05:48:51 INFO - Using env: {'DISPLAY': ':0', 05:48:51 INFO - 'HOME': '/home/cltbld', 05:48:51 INFO - 'LANG': 'en_US.UTF-8', 05:48:51 INFO - 'LANGUAGE': 'en_US:en', 05:48:51 INFO - 'LOGNAME': 'cltbld', 05:48:51 INFO - 'MAIL': '/var/mail/cltbld', 05:48:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:51 INFO - 'MOZ_NO_REMOTE': '1', 05:48:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:51 INFO - 'NO_EM_RESTART': '1', 05:48:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:51 INFO - 'PWD': '/builds/slave/test', 05:48:51 INFO - 'SHELL': '/bin/bash', 05:48:51 INFO - 'SHLVL': '1', 05:48:51 INFO - 'TERM': 'linux', 05:48:51 INFO - 'TMOUT': '86400', 05:48:51 INFO - 'USER': 'cltbld', 05:48:51 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1500294816.967678-1879613223', 05:48:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:51 INFO - '_': '/tools/buildbot/bin/python'} 05:48:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:48:51 INFO - Running setup.py (path:/tmp/pip-g2YwFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:48:51 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)) 05:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:48:51 INFO - Running setup.py (path:/tmp/pip-KM6rut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:48:51 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)) 05:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:48:51 INFO - Running setup.py (path:/tmp/pip-5Coq0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:48:51 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)) 05:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:48:51 INFO - Running setup.py (path:/tmp/pip-fhRdY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:48:51 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)) 05:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:48:51 INFO - Running setup.py (path:/tmp/pip-pxPvu1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:48:51 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)) 05:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:48:51 INFO - Running setup.py (path:/tmp/pip-pO05on-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:48:51 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)) 05:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:48:51 INFO - Running setup.py (path:/tmp/pip-LqaUDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:48:51 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)) 05:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:48:51 INFO - Running setup.py (path:/tmp/pip-U4oIqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:48:51 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)) 05:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:48:51 INFO - Running setup.py (path:/tmp/pip-BGaBf_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:48:51 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)) 05:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:48:51 INFO - Running setup.py (path:/tmp/pip-tuKzoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:48:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 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)) 05:48:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:48:51 INFO - Running setup.py (path:/tmp/pip-eYZQBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:48:52 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)) 05:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:48:52 INFO - Running setup.py (path:/tmp/pip-ftyXnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:48:52 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)) 05:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:48:52 INFO - Running setup.py (path:/tmp/pip-fMx7dd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:48:52 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)) 05:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:48:52 INFO - Running setup.py (path:/tmp/pip-iofyAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:48:52 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)) 05:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:52 INFO - Running setup.py (path:/tmp/pip-tIW_Wr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:48:52 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)) 05:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:48:52 INFO - Running setup.py (path:/tmp/pip-OHMxdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:48:52 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)) 05:48:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:48:52 INFO - Running setup.py (path:/tmp/pip-EZAK3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:48:52 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)) 05:48:52 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)) 05:48:52 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)) 05:48:52 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)) 05:48:52 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)) 05:48:52 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)) 05:48:52 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)) 05:48:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:48:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:48:53 INFO - Downloading blessings-1.6.tar.gz 05:48:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:48:53 INFO - Installing collected packages: blessings 05:48:53 INFO - Running setup.py install for blessings 05:48:53 INFO - Successfully installed blessings 05:48:53 INFO - Cleaning up... 05:48:53 INFO - Return code: 0 05:48:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:48:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:48:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:48:54 INFO - Reading from file tmpfile_stdout 05:48:54 INFO - Current package versions: 05:48:54 INFO - argparse == 1.2.1 05:48:54 INFO - blessings == 1.6 05:48:54 INFO - blobuploader == 1.2.4 05:48:54 INFO - docopt == 0.6.1 05:48:54 INFO - functools32 == 3.2.3-2 05:48:54 INFO - jsonschema == 2.5.1 05:48:54 INFO - manifestparser == 1.1 05:48:54 INFO - mozInstall == 1.13 05:48:54 INFO - mozcrash == 1.0 05:48:54 INFO - mozdebug == 0.1 05:48:54 INFO - mozdevice == 0.51 05:48:54 INFO - mozfile == 1.2 05:48:54 INFO - mozhttpd == 0.7 05:48:54 INFO - mozinfo == 0.10 05:48:54 INFO - mozleak == 0.1 05:48:54 INFO - mozlog == 3.5 05:48:54 INFO - moznetwork == 0.27 05:48:54 INFO - mozprocess == 0.25 05:48:54 INFO - mozprofile == 0.28 05:48:54 INFO - mozrunner == 6.13 05:48:54 INFO - mozscreenshot == 0.1 05:48:54 INFO - mozsystemmonitor == 0.3 05:48:54 INFO - moztest == 0.8 05:48:54 INFO - mozversion == 1.4 05:48:54 INFO - psutil == 3.1.1 05:48:54 INFO - requests == 1.2.3 05:48:54 INFO - wsgiref == 0.1.2 05:48:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:48:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:54 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 0x17301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ed00>, '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 0x1a9fc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0090>, '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': '32c5991c409366f7fec8a718000001d2-1500294816.967678-1879613223', '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 05:48:54 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 05:48:54 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 05:48:54 INFO - Using env: {'DISPLAY': ':0', 05:48:54 INFO - 'HOME': '/home/cltbld', 05:48:54 INFO - 'LANG': 'en_US.UTF-8', 05:48:54 INFO - 'LANGUAGE': 'en_US:en', 05:48:54 INFO - 'LOGNAME': 'cltbld', 05:48:54 INFO - 'MAIL': '/var/mail/cltbld', 05:48:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:54 INFO - 'MOZ_NO_REMOTE': '1', 05:48:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:54 INFO - 'NO_EM_RESTART': '1', 05:48:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:54 INFO - 'PWD': '/builds/slave/test', 05:48:54 INFO - 'SHELL': '/bin/bash', 05:48:54 INFO - 'SHLVL': '1', 05:48:54 INFO - 'TERM': 'linux', 05:48:54 INFO - 'TMOUT': '86400', 05:48:54 INFO - 'USER': 'cltbld', 05:48:54 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1500294816.967678-1879613223', 05:48:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:54 INFO - '_': '/tools/buildbot/bin/python'} 05:48:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:54 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)) 05:48:54 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)) 05:48:54 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)) 05:48:54 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)) 05:48:54 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)) 05:48:54 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)) 05:48:54 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)) 05:48:54 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)) 05:48:54 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)) 05:48:54 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 05:48:54 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 05:48:54 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 05:48:54 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 05:48:54 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 05:48:55 INFO - Downloading marionette_driver-1.4.0.tar.gz 05:48:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 05:48:55 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 05:48:55 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 05:48:55 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 05:48:55 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 05:48:55 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 05:48:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 05:48:55 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)) 05:48:55 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)) 05:48:55 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)) 05:48:55 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)) 05:48:55 INFO - Installing collected packages: marionette-driver, simplejson 05:48:55 INFO - Running setup.py install for marionette-driver 05:48:55 INFO - Running setup.py install for simplejson 05:48:55 INFO - building 'simplejson._speedups' extension 05:48:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 05:48:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 05:48:56 INFO - Successfully installed marionette-driver simplejson 05:48:56 INFO - Cleaning up... 05:48:56 INFO - Return code: 0 05:48:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:48:56 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')]} 05:48:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:48:56 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')]} 05:48:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:48:56 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 0x17301f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18fca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa1b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ed00>, '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 0x1a9fc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0090>, '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': '32c5991c409366f7fec8a718000001d2-1500294816.967678-1879613223', '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 05:48:56 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 05:48:56 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 05:48:56 INFO - Using env: {'DISPLAY': ':0', 05:48:56 INFO - 'HOME': '/home/cltbld', 05:48:56 INFO - 'LANG': 'en_US.UTF-8', 05:48:56 INFO - 'LANGUAGE': 'en_US:en', 05:48:56 INFO - 'LOGNAME': 'cltbld', 05:48:56 INFO - 'MAIL': '/var/mail/cltbld', 05:48:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:48:56 INFO - 'MOZ_NO_REMOTE': '1', 05:48:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:48:56 INFO - 'NO_EM_RESTART': '1', 05:48:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:48:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:48:56 INFO - 'PWD': '/builds/slave/test', 05:48:56 INFO - 'SHELL': '/bin/bash', 05:48:56 INFO - 'SHLVL': '1', 05:48:56 INFO - 'TERM': 'linux', 05:48:56 INFO - 'TMOUT': '86400', 05:48:56 INFO - 'USER': 'cltbld', 05:48:56 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1500294816.967678-1879613223', 05:48:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:48:56 INFO - '_': '/tools/buildbot/bin/python'} 05:48:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:48:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:48:56 INFO - Cleaning up... 05:48:56 INFO - Return code: 0 05:48:56 INFO - Running post-action listener: _resource_record_post_action 05:48:56 INFO - Running post-action listener: _start_resource_monitoring 05:48:57 INFO - Starting resource monitoring. 05:48:57 INFO - [mozharness: 2017-07-17 12:48:57.026875Z] Finished create-virtualenv step (success) 05:48:57 INFO - [mozharness: 2017-07-17 12:48:57.027391Z] Running install step. 05:48:57 INFO - Running pre-action listener: _resource_record_pre_action 05:48:57 INFO - Running main action method: install 05:48:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:48:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:48:57 INFO - Reading from file tmpfile_stdout 05:48:57 INFO - Detecting whether we're running mozinstall >=1.0... 05:48:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:48:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:48:57 INFO - Reading from file tmpfile_stdout 05:48:57 INFO - Output received: 05:48:57 INFO - Usage: mozinstall [options] installer 05:48:57 INFO - Options: 05:48:57 INFO - -h, --help show this help message and exit 05:48:57 INFO - -d DEST, --destination=DEST 05:48:57 INFO - Directory to install application into. [default: 05:48:57 INFO - "/builds/slave/test"] 05:48:57 INFO - --app=APP Application being installed. [default: firefox] 05:48:57 INFO - mkdir: /builds/slave/test/build/application 05:48:57 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'] 05:48:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:49:15 INFO - Reading from file tmpfile_stdout 05:49:15 INFO - Output received: 05:49:15 INFO - /builds/slave/test/build/application/firefox/firefox 05:49:15 INFO - Running post-action listener: _resource_record_post_action 05:49:15 INFO - [mozharness: 2017-07-17 12:49:15.224775Z] Finished install step (success) 05:49:15 INFO - [mozharness: 2017-07-17 12:49:15.224925Z] Running setup-mitmproxy step. 05:49:15 INFO - Running pre-action listener: _resource_record_pre_action 05:49:15 INFO - Running main action method: setup_mitmproxy 05:49:15 INFO - Skipping: mitmproxy is not required 05:49:15 INFO - Running post-action listener: _resource_record_post_action 05:49:15 INFO - [mozharness: 2017-07-17 12:49:15.225612Z] Finished setup-mitmproxy step (success) 05:49:15 INFO - [mozharness: 2017-07-17 12:49:15.225836Z] Running run-tests step. 05:49:15 INFO - Running pre-action listener: _resource_record_pre_action 05:49:15 INFO - Running pre-action listener: _set_gcov_prefix 05:49:15 INFO - Running main action method: run_tests 05:49:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:49:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:49:15 INFO - Python 2.7.3 05:49:15 INFO - Return code: 0 05:49:15 INFO - grabbing minidump binary from tooltool 05:49:15 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')]} 05:49:15 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 0x1a9ed00>, '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 0x1a9fc00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0090>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:49:15 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 05:49:15 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 05:49:15 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 05:49:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:49:15 INFO - Return code: 0 05:49:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:49:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:49:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:49:15 INFO - ENV: RUST_BACKTRACE is now 1 05:49:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:49:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:49:15 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/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 05:49:15 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/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 05:49:15 INFO - Using env: {'DISPLAY': ':0', 05:49:15 INFO - 'HOME': '/home/cltbld', 05:49:15 INFO - 'LANG': 'en_US.UTF-8', 05:49:15 INFO - 'LANGUAGE': 'en_US:en', 05:49:15 INFO - 'LOGNAME': 'cltbld', 05:49:15 INFO - 'MAIL': '/var/mail/cltbld', 05:49:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:49:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:49:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:15 INFO - 'MOZ_NO_REMOTE': '1', 05:49:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:49:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:49:15 INFO - 'NO_EM_RESTART': '1', 05:49:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:49:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:15 INFO - 'PWD': '/builds/slave/test', 05:49:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:49:15 INFO - 'RUST_BACKTRACE': '1', 05:49:15 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 05:49:15 INFO - 'SHELL': '/bin/bash', 05:49:15 INFO - 'SHLVL': '1', 05:49:15 INFO - 'TERM': 'linux', 05:49:15 INFO - 'TMOUT': '86400', 05:49:15 INFO - 'USER': 'cltbld', 05:49:15 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1500294816.967678-1879613223', 05:49:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:15 INFO - '_': '/tools/buildbot/bin/python'} 05:49:15 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/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 05:49:15 INFO - mozversion application_buildid: 20170717120626 05:49:15 INFO - mozversion application_changeset: d43779e278d2e4d3e21dba2fcb585a3bf4b1288e 05:49:15 INFO - mozversion application_display_name: Nightly 05:49:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:49:15 INFO - mozversion application_name: Firefox 05:49:15 INFO - mozversion application_remotingname: firefox 05:49:15 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:49:15 INFO - mozversion application_vendor: Mozilla 05:49:15 INFO - mozversion application_version: 56.0a1 05:49:15 INFO - mozversion platform_buildid: 20170717120626 05:49:15 INFO - mozversion platform_changeset: d43779e278d2e4d3e21dba2fcb585a3bf4b1288e 05:49:15 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:49:15 INFO - mozversion platform_version: 56.0a1 05:49:15 INFO - using testdate: 1500295755 05:49:15 INFO - actual date: 1500295755 05:49:15 INFO - starting webserver on 'localhost:37843' 05:49:15 INFO - SUITE-START | Running 2 tests 05:49:15 INFO - TEST-START | dromaeo_css 05:49:15 INFO - Initialising browser for dromaeo_css test... 05:49:15 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37843/getInfo.html -profile /tmp/tmpU9baH0/profile 05:49:15 INFO - TEST-INFO | started process 2480 (/builds/slave/test/build/application/firefox/firefox http://localhost:37843/getInfo.html) 05:49:22 INFO - TEST-INFO | 2480: exit 0 05:49:22 INFO - Browser initialized. 05:49:22 INFO - Running cycle 1/1 for dromaeo_css test... 05:49:22 INFO - TEST-INFO | started process 2752 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU9baH0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 05:49:33 INFO - PID 2752 | RSS: Main: 169816064 05:49:33 INFO - PID 2752 | 05:52:32 INFO - PID 2752 | Cycle 1(1): loaded http://localhost:37843/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37843/tests/dromaeo/cssquery-ext.html) 05:52:33 INFO - PID 2752 | RSS: Main: 178212864 05:52:33 INFO - PID 2752 | 05:55:35 INFO - PID 2752 | Cycle 1(1): loaded http://localhost:37843/tests/dromaeo/cssquery-ext.html (next: http://localhost:37843/tests/dromaeo/cssquery-jquery.html) 05:55:36 INFO - PID 2752 | RSS: Main: 176181248 05:55:36 INFO - PID 2752 | 05:58:37 INFO - PID 2752 | Cycle 1(1): loaded http://localhost:37843/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37843/tests/dromaeo/cssquery-mootools.html) 05:58:38 INFO - PID 2752 | RSS: Main: 178417664 05:58:38 INFO - PID 2752 | 06:01:39 INFO - PID 2752 | Cycle 1(1): loaded http://localhost:37843/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37843/tests/dromaeo/cssquery-prototype.html) 06:01:40 INFO - PID 2752 | RSS: Main: 175456256 06:01:40 INFO - PID 2752 | 06:04:43 INFO - PID 2752 | Cycle 1(1): loaded http://localhost:37843/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37843/tests/dromaeo/cssquery-yui.html) 06:04:44 INFO - PID 2752 | RSS: Main: 176893952 06:04:44 INFO - PID 2752 | 06:07:46 INFO - PID 2752 | Cycle 1(1): loaded http://localhost:37843/tests/dromaeo/cssquery-yui.html (next: http://localhost:37843/tests/dromaeo/cssquery-dojo.html) 06:07:46 INFO - PID 2752 | RSS: Main: 180035584 06:07:46 INFO - PID 2752 | 06:07:46 INFO - PID 2752 | __start_tp_report 06:07:46 INFO - PID 2752 | _x_x_mozilla_page_load 06:07:46 INFO - PID 2752 | _x_x_mozilla_page_load_details 06:07:46 INFO - PID 2752 | |i|pagename|runs| 06:07:46 INFO - PID 2752 | |0;dojo.html;3059.847007649617;3102.270966322914;3106.2700265437634;3109.471389863723;3145.921351966202;6005.939940600598;6058.1518587397795;6060.757569697218;6064.272287325522;6078.8480287992825;6027.3972602739705;6072.362401947798;6135.447809697126;6154.292256390517;6195.25656921169;5477.561795056386;5594.132909399029;5601.915971260434;5631.63394379366;5649.49154576088;5576.247206627114;5598.076317407643;5599.272094627713;5673.971630141864;5690.174924635925;5383.192521121824;5497.3952865185;5515.834524964257;5577.665340079588;5602.971985140089;5515.669059856381;5577.024020796385;5577.442255774431;5577.498025177713;5596.188552659883;5459.781608735646;5537.446255374431;5541.722913854332;5547.029269877796;5555.194496797982;5958.255218097738;5974.044152935509;5985.0124729419595;5989.161517387569;5999;6423.7430502779835;6454.515911306671;6491.513136514733;6491.642959637218;6517;6522.249941256769;6560.770373036921;6574.211094668671;6625.93374066258;6626.237982632011;6051.909221361683;6089.086637004485;6124.418180272912;6142.692865356715;6144.907826382608;6668.799936001928;6680.365365290289;6727.394534491919;6751.932480675228;6767.35710107539;6177.876442471125;6319.8104056878365;6323.778667746698;6324.936750632435;6375.521835862329;6439.710213040425;6442.06590044441;6451.419372256426;6535.150430444012;6571.342865713486;6388.584741991755;6412.134361861183;6416.326285740023;6418.326075762071;6496.70764815575;6430;6451.903221451682;6524.021396790519;6549.836254093686;6558.1802274715665;5198.2722418861385;5270.025045366543;5270.446603106619;5287.867803304948;5313.123334649739;4535.63714902807;4556.88607784808;4559.065391594715;4559.908801823945;4560.4071470708595;5402.135658294654;5486.31421072366;5526.419725928719;5531.889362212733;5535.889282214333;5640.323161220597;6498.5126115541525;6502.7724029659685;6583.07836902834;6599.769008084694;5489.890202195934;5518.889622207534;5584.329880414295;5597.720113994284;5622.32532096151;5713.400092990176;5717.885642287214;5780.71096445176;5784.681842498703;5799.5650326225705;6148.723307451175;6216.2540495140875;6256.906146407808;6336.493080553637;6372.235331760218;6471.773487927994;6517.804465866032;6527.5757075789925;6533.281339052795;6537.836554086186;6293.96853015732;6317.684115794284;6323.272823625158;6327.019312006646;6333.113364129118;6117.405743309309;6405.615663060231;6412.487001039999;6425;6449.7420103195345;6428.8071357859335;6488.578242414228;6556.508261880283;6589.703463344257;6614.603123812587;6283.340249273943;6285.340039295991;6379.489640828815;6386.489080873612;6392.776252831314;6191.226096737908;6283.8114856554375;6287.339829317856;6300.464460520907;6387.4570661492435;6230.7819226326865;6250.343713910156;6267.467265282502;6270.529710271657;6285.811425657238;6329.1139240505445;6387.329330420424;6394.360563943755;6409.134766806422;6449.451796597342;6177.1969643945995;6186.4741496973265;6238.719257633508;6251.656158911122;6266.060090986389 06:07:46 INFO - PID 2752 | |1;ext.html;738.5421038955844;792.7185849023597;798.1180795221277;835.4444294544129;845.1801752300266;40631.79684101579;41101.38347924784;41188.79405602968;41351;41457.79271103644;37142.8142859286;37170.628293717054;37198.25603487928;37259.813700931525;37461;6617.735290588371;6791.864162716743;6798.422134118606;6803.931960680379;6805.149356330458;6760.628165450898;6854.177498700163;6866.485013623973;6870.4503639708955;6881.277465866087;6794.728210871559;6818.045473633695;6821.18145822502;6829.829254268633;6848.897266541006;6758.8310292242595;6758.9662051689675;6778.694958726869;6778.932210677929;6816.352446517573;6091.573589848713;6134.77304539094;6147.661878596676;6154.78458253959;6197.287311959092;32930.34139317224;33045.50431743526;33304.16739581506;33568;33582.160445988804;3358.580177477815;3407.9148021299666;3412.095794614429;3414.6243913169533;3418.1967237699123;26370.868145659148;29523;30596.84701576478;30705.69294307073;30749.692503074908;4823.5176482351835;4883.633727470454;4900.803967841318;4904.828331008398;4999.775010124553;183408;186828;188286.05856970765;191195;191727;47460.5253947463;48285;48430.51569484331;48571.75714121477;48576.5142348572;51258.74370628123;51309.23036154461;51335.229971550456;51361.74319128455;51438.48561514412;16188.838111618968;16189.676206475804;16235.83764162367;16297.67404651924;16367.42714005004;13735.107218030797;13743.381547830171;13743.518976835763;13756.65608359779;13793.517226897011;14342.784858227134;14463.13221206731;14529.491467798576;14624;14716.779248311284;5843.503302219359;5896.6756828374855;5964.1650168976375;5969.671668058299;5978.880422391528;971.5433746139303;978.6379039755194;994.4381424495137;1018.8828284747201;1026.2405819693374;22700.205492807672;22806.42983925382;22838.771612283996;22857;23237.41906452352;1080.7568297133082;1084.6854412220525;1110.8111621024445;1114.7982734100249;1121.8092924202906;11818.645440636794;12071.034317254598;12131.090168237417;12171.695707607381;12315.876841231653;230489;232754;235625;235723;235836;53429.1985620216;53571.732141339045;53807.73096134494;53937;53940.730296348265;1439.1437094928501;1442.4086124688827;1453.573867573242;1482.1625781433456;1493.7983372244826;21819.76282214629;22024.779752202274;22507.549849003255;22861.08555657755;23024.76975230226;37107.628923710414;37194.25611487701;37437.62562374341;37479.43780843235;37497;193869;193931;194328;194579;194701;34626.30747385089;35736.821315894296;36365.27269454649;38357.84926452211;38478.42282365711;46033;46473;47159.528404715515;47555.28667070066;47739.76130119327;31637.525437118;33006.758107729875;33686.83156584201;33827;34442.655573443946;32640.183995400304;32872.50691239585;33506.16234594155;33583;33602.66397336093;34997.30005399827;37674;37713.62286377101;37728.056798580255;37731.62268377281;31097.53353699651;31646.683533164374;32540.186495337806;32739.508907365933;33060.66939330672;23481.530369392858;23488;23675.763242367357;23814.571125732513;23878.641820372362 06:07:46 INFO - PID 2752 | |2;jquery.html;555.6194007105133;568.9061304884694;575.9971200143999;585.8623223542468;594.8007417515132;21939.561208775816;22718.432039199008;22731.659025114637;22781.772182278215;22787.202447914326;24111;25569.74430255697;26783.33041673959;26976.730232697668;27052.864735676296;6424.486041116711;6593;6593.604383736967;6593.637349945751;6595.472362211036;6380.521460890429;6424.389682980132;6426.6144031358035;6433.131527243809;6454.19322584677;6076.3316035236085;6248.380344861937;6376.617402955838;6394.232692076957;6408.93591064088;6390.808275751735;6425.678716064225;6429.099926010363;6484.93515064848;6496.707648155821;5984.521238300926;6006.759729610811;6026.879462410771;6030.638161710312;6048.727807248641;25332.873335633387;29009.70990290091;29370.853145734134;29392.853035734686;29432.11703648894;1940.3790786948182;1958.1384190955935;1971.6352474792209;1980.5048737815546;1988.890611016408;18228.635427291512;19022;19044.71432928507;19141;19212.327568535035;2332.661764044204;2342.4612339161918;2403.8197135214755;2405.0379848060743;2418.5404773093055;134432;141323.29338353346;141638;141785;141857.2907135468;13774.931125344308;14768;14824.184669843047;14889.851101488846;15342.846571534365;23863.284101476984;23906.043758249823;23961;24015.399615009763;24021.759782402303;10469.581216751245;10503.264771465923;10503.894961050444;10646.520906559068;10674.839877401846;9632.27757918159;9669.709908702609;9714.174295184988;9838.75403114928;9915.256355773347;8868.733937981871;9369.812603747887;9551.90448095524;9593.232541396672;9646.90353096474;2717.5813525961908;2731.508328500849;2827.604135421043;2899.6810350861388;2982.585773055846;940.219617717293;940.8965013848472;942.4062840410497;976.511744127936;978.5792109393029;19424.805751942582;19626.411207663794;20128.698069528968;20480.078396472196;24983.250502484956;995.8431771285044;1024.8513965474965;1059.8410238464292;1072.463768115942;1075.0700643942932;10646;11131.220814542905;11212.775744485229;11229.21395502307;11607;473469;509425;519737;528223;529205;123107;124924.37537812252;126348.36825815812;128925;129000;1238.0961897814466;1275.9170653907465;1296.1186393252678;1311.8819306262483;1314.158938279521;17248.310067597155;18015.819841801414;18128;18631.44105676832;18756.96836673996;55715;56857.71571142118;57175.714121429126;57390.7130464345;57882;73131;73352.63323683561;73530.63234683793;74737.6263118681;75052.62473687815;20034.699479508112;20500.589988199856;21240.681389779475;21266;21800.781992179876;23500.764992349857;23542.529149416572;23794.167204147772;23944.161954332212;24010.639840402757;18591.44225673232;18694.25222991065;18739.90630046841;18815.623687526448;18993.050347482294;16200.594985125466;16403.343866245694;16875.409360672318;16963;17482.388116415863;19005.334813281468;20471;20505.077271523114;20526.076326565042;20720.58558828845;20154.899225503777;20778.272760453918;21299;21338.893305533373;21673.891630541748;15557.299921503332;16067.11630860314;16078.839211608201;16307.347706092098;16340.264688088826 06:07:46 INFO - PID 2752 | |3;mootools.html;1330.1952318847098;1399.7130588229413;1413.5405993052261;1415.2216281045428;1417.0718179592368;13094.410751516181;13684;13759.724805503884;13770.931145344259;13779.242141682204;13109.803352949713;13625.659358516043;13635.659108522266;13645;13655.86344136561;2618.031328408487;2672.532306846304;2691.111933062085;2696.8516731579757;2701.04113039871;2518.7103483099404;2594.532984062868;2603.947921041578;2608.2827222513865;2621.6722909636296;2536.3025168078743;2559.654446649706;2593.209071233273;2608.699999500063;2619.803514736393;2610.9086181983635;2692.044324264897;2705.4318593095472;2705.8105932584626;2714.1043455659583;2588.8705564721877;2624.5800671892407;2626.4484458263787;2633.381155428473;2636.93407664808;13665.590032299047;13782.862171378258;13792.655183620389;13825.755681988669;13845.446182152702;7194.892076618855;7575.431842611826;7631.007968963999;7641.961790191013;7671.23287671234;4634.490206077328;4905.166121759274;5054.064997975386;5065.417476990119;5087.262346959707;1754.675385053769;1801.6666916620468;1813.555678858688;1853.156813649786;1862.6740320443869;21682.34952951414;21810.89094554533;21925.671114933288;21933.232336868292;22050.4487387815;6158.846028849225;6209.5032397408095;6258;6327.651979141191;6404.807855764335;15184.46854360092;15206.847931520764;15220.162891040878;15246.161461119746;15270.389184432499;7211;7412.703491860373;7414.777556673308;7419.517731347445;7425.146108197627;6669.333066693292;6701.1623547056615;6855.931440685529;6897.3447522485285;6903.965480172567;4896.730679812573;4963.8262660806695;5031.823886163967;5095.541401273903;5117.41149767774;1488.642725745835;1493.6340596553914;1501.7146742118962;1501.924903754808;1531.8008658874498;901.4501154295874;904.1681652879366;922.4511415707643;935.4948327902993;937.1378331934636;7088.645567721594;7109.111361079865;7217.458690598226;7250.927490725131;7263.564186148848;723.4574069447914;724.7970568240795;731.5135434935814;751.8308380614318;754.5925200391837;4175.665946724254;4794.880127996828;4820.542048505386;5084.110280700863;5125.256837758504;17710.557236068944;17839.375621853174;17881.7317740234;18085.547861303574;18351.541211469554;17892.731609025876;18162.545936351697;18230.63538729218;18453.907730461262;18532.907335463235;9689.273304502332;9964.302498825158;9974.351667141613;9999.800003999879;10039.196864250842;7272.454565907472;7489.962550187214;7615.42884283692;7624;7671.07947046358;15825.841741582437;15865.365385384917;15900.284487197872;16067.035977841368;16789;15590.376384944475;16087.75868361952;16748.330066797193;16908;17059.48821535356;10485.9475702621;10781.353118812896;10790.514426850654;10815.783684326427;10822.945885270523;11800.70498237551;12169.939150304192;12315.322657253937;12359.938200308941;12449.93775031119;9920.40477571348;10360.378377297386;10550.8417373741;10677.039066484054;10681.198910081619;10242.436665983443;10289.382637041801;10339.431331276552;10548;10672.89327106719;8581.399302048796;9054.728358149267;9068.274538036809;9105.954470227607;9128.315376346667;6330.1454303668415;6581.243157037002;6621;6646.60120392778;6656.500762442739;6049.213602231857;6171.938280617136;6211.627302361872;6249.687515624291;6252.843678908063 06:07:46 INFO - PID 2752 | |4;prototype.html;499.5985368899989;501.29301770439633;518.8054479570161;518.8210067526704;527.1986580397795;6120.9693951530235;6136.447719705226;6185.783497577586;6199.9770037943745;6204.937950620492;5830.688095178582;5969.701514924258;5978.4918281945975;6058.4850287725485;6067.57526973111;4893.584045356131;4894.216925291937;4933.679310844802;4962.900741985158;4976.676516026456;4834.4923783002805;4858.125537403266;4893.975530122344;4904.264360345941;4939.67892087015;4810.278458231258;4855.781489832948;4898.779554920019;4915.5084491550915;4916.557509824115;4658.90682186356;4808.903821923542;4838.104950584118;4884.755762211875;4887.633427492934;4330.856226168035;4334.414853994702;4339.153864996327;4352.499462561783;4424.712393694432;5927.703614819285;5937.465628093449;5942.316633587149;5953.970230148865;5957.672328021957;5543.616245014642;5588.469095435927;5597.160425936142;5599.356074051455;5604.187392828057;6382.329855365213;6394.23269207698;6410.487161027107;6421.711023003976;6461.773837915697;4774.259989701602;4790.616750659939;4841.951580484185;4850.296706977469;4853.247746599282;6724.562903411312;6759.763408280735;6831.726730930806;6838.760643377507;6883.655817209069;4969.204927211629;4978.5270399312;4991.550760431506;5021.472745361758;5031.798728050837;4957.702537847668;4993.300937868628;5033.766727151871;5054.368203974504;5067.391912970467;5423.864403389868;5466.058106205097;5470.261514695465;5499.560035197174;5603.467670571289;6239.188905442264;6388.456981156561;6402.551821372553;6429.839254018687;6465.191851018622;1709.837565431282;1754.7631069805668;1767.7878654561534;1770.97343539847;1779.1815764748103;1133.8412622232895;1215.3012018089635;1224.4245204753752;1230.3110258255226;1241.075398827861;5403.13549832025;5461.481159289861;5535.806246781343;5544.695041772741;5553.805616803393;6465.579737317059;6537.248216455074;6641.136652235178;6642.136522252173;6673.699683514254;5548.500634942875;5548.726251511627;5593.636413633101;5606.131049687305;5607.915881261702;3454.775439596418;3495.07380544156;3520.2959408118477;3564.7682900611376;3572.6427357264583;6320.146780184708;6397.808065758035;6404.679766011774;6445.967770161119;6467.191601049869;6653.73385064592;6694.765683201064;6703.93296067033;6705.597664140168;6728.798136055926;6328.873422531616;6359.109724638462;6397.968010160012;6418.518611104186;6481.347256449575;6457.676176383736;6542.705578248895;6569.737210511717;6605.372489613479;6609.3060228675295;6268.686565671789;6484.351564843478;6542.509311801729;6549.579034152023;6558.868822623616;6328.873422531616;6351.30135685065;6368.299487056513;6373.94829853069;6376.776812811715;5263.736813159403;5363.731813409392;5377.542908852792;5393.595480339069;5395;6608.356657337104;6623.787463080498;6628.436582890508;6629.370209830058;6656.167979002625;6316.84207894788;6333.809985700436;6370.267419246846;6375.808725738235;6411.93588064132;6360.968195158995;6381.1704478417505;6398.616083035033;6407.423331900151;6495.610263384212;6226.283977342482;6322.430981211713;6327.430531252209;6350.523295914505;6375.649339286384;5860.765569377178;6391.456726178327;6416.615003099642;6423.518236132215;6450;6167.321594624677;6203.596766210182;6215.502759779117;6228.750849965951;6248.812915479546 06:07:46 INFO - PID 2752 | |5;yui.html;802.8728104034789;845.4039901869179;894.1907573645844;923.0492592629589;948.146667998801;16935.83064169358;17077.23152458139;17082.658346833057;17655.94064356138;20080.29718959837;19422;19554.804451955475;19626.803731962675;19655.31206407776;19660.311889083885;975.2929126383386;1010.570507534295;1077.779055293667;1078.1267173589417;1078.9892101078967;1063.5852017713098;1063.6277302943986;1067.3009178987736;1069.5400977579638;1071.4535586850723;1106.690126764507;1106.9280496767685;1112.5494174859195;1114.164376717462;1116.4417791104447;991.8016396720685;1038.2939601071268;1106.7122548137502;1108.2020944919645;1109.6171820721838;791.8416316736676;798.0463346301173;799.9640016199285;801.2428255298745;801.3669201330941;19077.141528631244;19392.12735426909;19471;19475.220991160335;19533.511662208417;17709.557261068447;18483.075846207637;18500.537486562807;18586.44240672782;18653.906730466395;15254.38982440701;15637.452689155938;15706.05763654173;15763.054216747032;15769.132697701622;3334.4498157803932;3360.512725654766;3366.0575038989123;3366.107981384935;3373.527706121145;107826.46086769595;112358.43820780926;112718.43640781744;112904.43547782209;116208.41895790551;15726.449574264845;16030.519084427486;16398.590035249214;16430.342786288653;16513.6697266054;28322;29331.85334073316;29526.852365738036;29599.704002960127;29975.700242997726;8154.714584989497;8193.09875913649;8243.587820609066;8246.793830154294;8305.252527272574;3477.2002439438565;3590.3537363274863;3649.671529562352;3656.8171591420855;3791.241751649681;5012.8496145115705;5148.639595228373;5193.870153246199;5231.293775340357;5241.318628578337;933.673214374977;964.5273815830333;979.9853002204973;981.4601968917067;984.5323471351194;668.2916108924555;670.7819958513405;683.5351960666794;690.378659206718;696.331521739126;11015.684650201885;11769.529218831321;12197.51209951592;12437.253764773961;12888.93555532235;681.1485642946317;693.9167299924042;698.6192525073847;718.2781304788758;718.335539625844;5212.748940254388;5285.392179899361;5300.655457395257;5381.78472861089;5430.375506816687;94597;95053;99473.50263248637;101495;103242.48378758058;85254.57372713096;87719.56140219385;87921;88650;91111.54444227736;75478.62260688661;76765.61617191878;77225;77422;79024.60487697525;10889.673309800719;11009.889901100887;11018.44907754593;11034.903368359986;11040.171987101161;34519.827400862836;35391.82304088463;35608.28783424265;36778;38192;43323.56676433321;44352;44377.33433998428;44640.33039504475;45148;15648.4523041693;15717.921410392875;15728.21358932026;15759.212039398213;15873.603159920633;16306.26621801998;16483.175841207652;16495.257713403167;16622.75065874037;16666.4166754163;14951.626209344853;15169.772453413429;15221.6194595136;15323.77014344808;15372.84627153714;15458.072515649097;18142.183601737688;19054.523636908634;19117.426477205707;19545.413637590325;17679.823201767816;18043;18467.16897739578;18542.351017714314;18778.154983025524;12058.638240852788;13751.587452376045;13753.243571603258;13867.722645547234;14038.508652197532;13140.474381024653;13164.80252796228;13668.52160174389;13727;13810.861891381359 06:07:46 INFO - PID 2752 | __end_tp_report 06:07:46 INFO - PID 2752 | __start_cc_report 06:07:46 INFO - PID 2752 | _x_x_mozilla_cycle_collect,380 06:07:46 INFO - PID 2752 | __end_cc_report 06:07:46 INFO - PID 2752 | __startTimestamp1500296866340__endTimestamp 06:07:46 INFO - PID 2752 | 06:07:46 INFO - PID 2752 | ------- Summary: start ------- 06:07:46 INFO - PID 2752 | Number of tests: 6 06:07:46 INFO - PID 2752 | 06:07:46 INFO - PID 2752 | [#0] dojo.html Cycles:165 Average:5976.26 Median:6216.25 stddev:698.43 (11.2%) stddev-sans-first:662.04 06:07:46 INFO - PID 2752 | Values: 3059.8 3102.3 3106.3 3109.5 3145.9 6005.9 6058.2 6060.8 6064.3 6078.8 6027.4 6072.4 6135.4 6154.3 6195.3 5477.6 5594.1 5601.9 5631.6 5649.5 5576.2 5598.1 5599.3 5674.0 5690.2 5383.2 5497.4 5515.8 5577.7 5603.0 5515.7 5577.0 5577.4 5577.5 5596.2 5459.8 5537.4 5541.7 5547.0 5555.2 5958.3 5974.0 5985.0 5989.2 5999.0 6423.7 6454.5 6491.5 6491.6 6517.0 6522.2 6560.8 6574.2 6625.9 6626.2 6051.9 6089.1 6124.4 6142.7 6144.9 6668.8 6680.4 6727.4 6751.9 6767.4 6177.9 6319.8 6323.8 6324.9 6375.5 6439.7 6442.1 6451.4 6535.2 6571.3 6388.6 6412.1 6416.3 6418.3 6496.7 6430.0 6451.9 6524.0 6549.8 6558.2 5198.3 5270.0 5270.4 5287.9 5313.1 4535.6 4556.9 4559.1 4559.9 4560.4 5402.1 5486.3 5526.4 5531.9 5535.9 5640.3 6498.5 6502.8 6583.1 6599.8 5489.9 5518.9 5584.3 5597.7 5622.3 5713.4 5717.9 5780.7 5784.7 5799.6 6148.7 6216.3 6256.9 6336.5 6372.2 6471.8 6517.8 6527.6 6533.3 6537.8 6294.0 6317.7 6323.3 6327.0 6333.1 6117.4 6405.6 6412.5 6425.0 6449.7 6428.8 6488.6 6556.5 6589.7 6614.6 6283.3 6285.3 6379.5 6386.5 6392.8 6191.2 6283.8 6287.3 6300.5 6387.5 6230.8 6250.3 6267.5 6270.5 6285.8 6329.1 6387.3 6394.4 6409.1 6449.5 6177.2 6186.5 6238.7 6251.7 6266.1 06:07:46 INFO - PID 2752 | 06:07:46 INFO - PID 2752 | [#1] ext.html Cycles:180 Average:37385.23 Median:18930.43 stddev:53612.81 (283.2%) stddev-sans-first:53692.59 06:07:46 INFO - PID 2752 | Values: 738.5 792.7 798.1 835.4 845.2 40631.8 41101.4 41188.8 41351.0 41457.8 37142.8 37170.6 37198.3 37259.8 37461.0 6617.7 6791.9 6798.4 6803.9 6805.1 6760.6 6854.2 6866.5 6870.5 6881.3 6794.7 6818.0 6821.2 6829.8 6848.9 6758.8 6759.0 6778.7 6778.9 6816.4 6091.6 6134.8 6147.7 6154.8 6197.3 32930.3 33045.5 33304.2 33568.0 33582.2 3358.6 3407.9 3412.1 3414.6 3418.2 26370.9 29523.0 30596.8 30705.7 30749.7 4823.5 4883.6 4900.8 4904.8 4999.8 183408.0 186828.0 188286.1 191195.0 191727.0 47460.5 48285.0 48430.5 48571.8 48576.5 51258.7 51309.2 51335.2 51361.7 51438.5 16188.8 16189.7 16235.8 16297.7 16367.4 13735.1 13743.4 13743.5 13756.7 13793.5 14342.8 14463.1 14529.5 14624.0 14716.8 5843.5 5896.7 5964.2 5969.7 5978.9 971.5 978.6 994.4 1018.9 1026.2 22700.2 22806.4 22838.8 22857.0 23237.4 1080.8 1084.7 1110.8 1114.8 1121.8 11818.6 12071.0 12131.1 12171.7 12315.9 230489.0 232754.0 235625.0 235723.0 235836.0 53429.2 53571.7 53807.7 53937.0 53940.7 1439.1 1442.4 1453.6 1482.2 1493.8 21819.8 22024.8 22507.5 22861.1 23024.8 37107.6 37194.3 37437.6 37479.4 37497.0 193869.0 193931.0 194328.0 194579.0 194701.0 34626.3 35736.8 36365.3 38357.8 38478.4 46033.0 46473.0 47159.5 47555.3 47739.8 31637.5 33006.8 33686.8 33827.0 34442.7 32640.2 32872.5 33506.2 33583.0 33602.7 34997.3 37674.0 37713.6 37728.1 37731.6 31097.5 31646.7 32540.2 32739.5 33060.7 23481.5 23488.0 23675.8 23814.6 23878.6 06:07:46 INFO - PID 2752 | 06:07:46 INFO - PID 2752 | [#2] jquery.html Cycles:180 Average:36245.95 Median:23521.65 stddev:86358.81 (367.1%) stddev-sans-first:86559.49 06:07:46 INFO - PID 2752 | Values: 555.6 568.9 576.0 585.9 594.8 21939.6 22718.4 22731.7 22781.8 22787.2 24111.0 25569.7 26783.3 26976.7 27052.9 6424.5 6593.0 6593.6 6593.6 6595.5 6380.5 6424.4 6426.6 6433.1 6454.2 6076.3 6248.4 6376.6 6394.2 6408.9 6390.8 6425.7 6429.1 6484.9 6496.7 5984.5 6006.8 6026.9 6030.6 6048.7 25332.9 29009.7 29370.9 29392.9 29432.1 1940.4 1958.1 1971.6 1980.5 1988.9 18228.6 19022.0 19044.7 19141.0 19212.3 2332.7 2342.5 2403.8 2405.0 2418.5 134432.0 141323.3 141638.0 141785.0 141857.3 13774.9 14768.0 14824.2 14889.9 15342.8 23863.3 23906.0 23961.0 24015.4 24021.8 10469.6 10503.3 10503.9 10646.5 10674.8 9632.3 9669.7 9714.2 9838.8 9915.3 8868.7 9369.8 9551.9 9593.2 9646.9 2717.6 2731.5 2827.6 2899.7 2982.6 940.2 940.9 942.4 976.5 978.6 19424.8 19626.4 20128.7 20480.1 24983.3 995.8 1024.9 1059.8 1072.5 1075.1 10646.0 11131.2 11212.8 11229.2 11607.0 473469.0 509425.0 519737.0 528223.0 529205.0 123107.0 124924.4 126348.4 128925.0 129000.0 1238.1 1275.9 1296.1 1311.9 1314.2 17248.3 18015.8 18128.0 18631.4 18757.0 55715.0 56857.7 57175.7 57390.7 57882.0 73131.0 73352.6 73530.6 74737.6 75052.6 20034.7 20500.6 21240.7 21266.0 21800.8 23500.8 23542.5 23794.2 23944.2 24010.6 18591.4 18694.3 18739.9 18815.6 18993.1 16200.6 16403.3 16875.4 16963.0 17482.4 19005.3 20471.0 20505.1 20526.1 20720.6 20154.9 20778.3 21299.0 21338.9 21673.9 15557.3 16067.1 16078.8 16307.3 16340.3 06:07:46 INFO - PID 2752 | 06:07:46 INFO - PID 2752 | [#3] mootools.html Cycles:180 Average:8315.14 Median:2618.92 stddev:5624.59 (214.8%) stddev-sans-first:5615.88 06:07:46 INFO - PID 2752 | Values: 1330.2 1399.7 1413.5 1415.2 1417.1 13094.4 13684.0 13759.7 13770.9 13779.2 13109.8 13625.7 13635.7 13645.0 13655.9 2618.0 2672.5 2691.1 2696.9 2701.0 2518.7 2594.5 2603.9 2608.3 2621.7 2536.3 2559.7 2593.2 2608.7 2619.8 2610.9 2692.0 2705.4 2705.8 2714.1 2588.9 2624.6 2626.4 2633.4 2636.9 13665.6 13782.9 13792.7 13825.8 13845.4 7194.9 7575.4 7631.0 7642.0 7671.2 4634.5 4905.2 5054.1 5065.4 5087.3 1754.7 1801.7 1813.6 1853.2 1862.7 21682.3 21810.9 21925.7 21933.2 22050.4 6158.8 6209.5 6258.0 6327.7 6404.8 15184.5 15206.8 15220.2 15246.2 15270.4 7211.0 7412.7 7414.8 7419.5 7425.1 6669.3 6701.2 6855.9 6897.3 6904.0 4896.7 4963.8 5031.8 5095.5 5117.4 1488.6 1493.6 1501.7 1501.9 1531.8 901.5 904.2 922.5 935.5 937.1 7088.6 7109.1 7217.5 7250.9 7263.6 723.5 724.8 731.5 751.8 754.6 4175.7 4794.9 4820.5 5084.1 5125.3 17710.6 17839.4 17881.7 18085.5 18351.5 17892.7 18162.5 18230.6 18453.9 18532.9 9689.3 9964.3 9974.4 9999.8 10039.2 7272.5 7490.0 7615.4 7624.0 7671.1 15825.8 15865.4 15900.3 16067.0 16789.0 15590.4 16087.8 16748.3 16908.0 17059.5 10485.9 10781.4 10790.5 10815.8 10822.9 11800.7 12169.9 12315.3 12359.9 12449.9 9920.4 10360.4 10550.8 10677.0 10681.2 10242.4 10289.4 10339.4 10548.0 10672.9 8581.4 9054.7 9068.3 9106.0 9128.3 6330.1 6581.2 6621.0 6646.6 6656.5 6049.2 6171.9 6211.6 6249.7 6252.8 06:07:46 INFO - PID 2752 | 06:07:46 INFO - PID 2752 | [#4] prototype.html Cycles:180 Average:5407.34 Median:5955.82 stddev:1502.57 (25.2%) stddev-sans-first:1460.93 06:07:46 INFO - PID 2752 | Values: 499.6 501.3 518.8 518.8 527.2 6121.0 6136.4 6185.8 6200.0 6204.9 5830.7 5969.7 5978.5 6058.5 6067.6 4893.6 4894.2 4933.7 4962.9 4976.7 4834.5 4858.1 4894.0 4904.3 4939.7 4810.3 4855.8 4898.8 4915.5 4916.6 4658.9 4808.9 4838.1 4884.8 4887.6 4330.9 4334.4 4339.2 4352.5 4424.7 5927.7 5937.5 5942.3 5954.0 5957.7 5543.6 5588.5 5597.2 5599.4 5604.2 6382.3 6394.2 6410.5 6421.7 6461.8 4774.3 4790.6 4842.0 4850.3 4853.2 6724.6 6759.8 6831.7 6838.8 6883.7 4969.2 4978.5 4991.6 5021.5 5031.8 4957.7 4993.3 5033.8 5054.4 5067.4 5423.9 5466.1 5470.3 5499.6 5603.5 6239.2 6388.5 6402.6 6429.8 6465.2 1709.8 1754.8 1767.8 1771.0 1779.2 1133.8 1215.3 1224.4 1230.3 1241.1 5403.1 5461.5 5535.8 5544.7 5553.8 6465.6 6537.2 6641.1 6642.1 6673.7 5548.5 5548.7 5593.6 5606.1 5607.9 3454.8 3495.1 3520.3 3564.8 3572.6 6320.1 6397.8 6404.7 6446.0 6467.2 6653.7 6694.8 6703.9 6705.6 6728.8 6328.9 6359.1 6398.0 6418.5 6481.3 6457.7 6542.7 6569.7 6605.4 6609.3 6268.7 6484.4 6542.5 6549.6 6558.9 6328.9 6351.3 6368.3 6373.9 6376.8 5263.7 5363.7 5377.5 5393.6 5395.0 6608.4 6623.8 6628.4 6629.4 6656.2 6316.8 6333.8 6370.3 6375.8 6411.9 6361.0 6381.2 6398.6 6407.4 6495.6 6226.3 6322.4 6327.4 6350.5 6375.6 5860.8 6391.5 6416.6 6423.5 6450.0 6167.3 6203.6 6215.5 6228.8 6248.8 06:07:46 INFO - PID 2752 | 06:07:46 INFO - PID 2752 | [#5] yui.html Cycles:180 Average:21150.21 Median:19446.50 stddev:28116.92 (144.6%) stddev-sans-first:28154.28 06:07:46 INFO - PID 2752 | Values: 802.9 845.4 894.2 923.0 948.1 16935.8 17077.2 17082.7 17655.9 20080.3 19422.0 19554.8 19626.8 19655.3 19660.3 975.3 1010.6 1077.8 1078.1 1079.0 1063.6 1063.6 1067.3 1069.5 1071.5 1106.7 1106.9 1112.5 1114.2 1116.4 991.8 1038.3 1106.7 1108.2 1109.6 791.8 798.0 800.0 801.2 801.4 19077.1 19392.1 19471.0 19475.2 19533.5 17709.6 18483.1 18500.5 18586.4 18653.9 15254.4 15637.5 15706.1 15763.1 15769.1 3334.4 3360.5 3366.1 3366.1 3373.5 107826.5 112358.4 112718.4 112904.4 116208.4 15726.4 16030.5 16398.6 16430.3 16513.7 28322.0 29331.9 29526.9 29599.7 29975.7 8154.7 8193.1 8243.6 8246.8 8305.3 3477.2 3590.4 3649.7 3656.8 3791.2 5012.8 5148.6 5193.9 5231.3 5241.3 933.7 964.5 980.0 981.5 984.5 668.3 670.8 683.5 690.4 696.3 11015.7 11769.5 12197.5 12437.3 12888.9 681.1 693.9 698.6 718.3 718.3 5212.7 5285.4 5300.7 5381.8 5430.4 94597.0 95053.0 99473.5 101495.0 103242.5 85254.6 87719.6 87921.0 88650.0 91111.5 75478.6 76765.6 77225.0 77422.0 79024.6 10889.7 11009.9 11018.4 11034.9 11040.2 34519.8 35391.8 35608.3 36778.0 38192.0 43323.6 44352.0 44377.3 44640.3 45148.0 15648.5 15717.9 15728.2 15759.2 15873.6 16306.3 16483.2 16495.3 16622.8 16666.4 14951.6 15169.8 15221.6 15323.8 15372.8 15458.1 18142.2 19054.5 19117.4 19545.4 17679.8 18043.0 18467.2 18542.4 18778.2 12058.6 13751.6 13753.2 13867.7 14038.5 13140.5 13164.8 13668.5 13727.0 13810.9 06:07:46 INFO - PID 2752 | -------- Summary: end -------- 06:07:46 INFO - PID 2752 | 06:07:46 INFO - TEST-INFO | 2752: exit 0 06:07:46 INFO - TEST-OK | dromaeo_css | took 1111278ms 06:07:46 INFO - TEST-START | kraken 06:07:46 INFO - Initialising browser for kraken test... 06:07:46 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:37843/getInfo.html -profile /tmp/tmp8OrNBh/profile 06:07:46 INFO - TEST-INFO | started process 3243 (/builds/slave/test/build/application/firefox/firefox http://localhost:37843/getInfo.html) 06:07:53 INFO - TEST-INFO | 3243: exit 0 06:07:53 INFO - Browser initialized. 06:07:53 INFO - Running cycle 1/1 for kraken test... 06:07:53 INFO - TEST-INFO | started process 3469 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8OrNBh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:08:04 INFO - PID 3469 | RSS: Main: 169828352 06:08:04 INFO - PID 3469 | 06:08:07 INFO - PID 3469 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37843/tests/kraken/driver.html?testName=audio-beat-detection) 06:08:08 INFO - PID 3469 | RSS: Main: 176504832 06:08:08 INFO - PID 3469 | 06:08:10 INFO - PID 3469 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37843/tests/kraken/driver.html?testName=audio-dft) 06:08:11 INFO - PID 3469 | RSS: Main: 176635904 06:08:11 INFO - PID 3469 | 06:08:14 INFO - PID 3469 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37843/tests/kraken/driver.html?testName=audio-fft) 06:08:14 INFO - PID 3469 | RSS: Main: 170917888 06:08:14 INFO - PID 3469 | 06:08:17 INFO - PID 3469 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37843/tests/kraken/driver.html?testName=audio-oscillator) 06:08:17 INFO - PID 3469 | RSS: Main: 171749376 06:08:17 INFO - PID 3469 | 06:08:19 INFO - PID 3469 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37843/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:08:20 INFO - PID 3469 | RSS: Main: 171536384 06:08:20 INFO - PID 3469 | 06:08:23 INFO - PID 3469 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37843/tests/kraken/driver.html?testName=imaging-darkroom) 06:08:24 INFO - PID 3469 | RSS: Main: 175255552 06:08:24 INFO - PID 3469 | 06:08:27 INFO - PID 3469 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37843/tests/kraken/driver.html?testName=imaging-desaturate) 06:08:28 INFO - PID 3469 | RSS: Main: 176300032 06:08:28 INFO - PID 3469 | 06:08:30 INFO - PID 3469 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37843/tests/kraken/driver.html?testName=json-parse-financial) 06:08:31 INFO - PID 3469 | RSS: Main: 175017984 06:08:31 INFO - PID 3469 | 06:08:33 INFO - PID 3469 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37843/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:08:33 INFO - PID 3469 | RSS: Main: 174804992 06:08:33 INFO - PID 3469 | 06:08:35 INFO - PID 3469 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37843/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:08:36 INFO - PID 3469 | RSS: Main: 174956544 06:08:36 INFO - PID 3469 | 06:08:38 INFO - PID 3469 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37843/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:08:38 INFO - PID 3469 | RSS: Main: 175210496 06:08:38 INFO - PID 3469 | 06:08:41 INFO - PID 3469 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37843/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:08:42 INFO - PID 3469 | RSS: Main: 175083520 06:08:42 INFO - PID 3469 | 06:08:45 INFO - PID 3469 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37843/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:08:45 INFO - PID 3469 | RSS: Main: 175906816 06:08:45 INFO - PID 3469 | 06:08:47 INFO - PID 3469 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37843/tests/kraken/driver.html?testName=ai-astar) 06:08:47 INFO - PID 3469 | RSS: Main: 177405952 06:08:47 INFO - PID 3469 | 06:08:47 INFO - PID 3469 | __start_tp_report 06:08:47 INFO - PID 3469 | _x_x_mozilla_page_load 06:08:47 INFO - PID 3469 | _x_x_mozilla_page_load_details 06:08:47 INFO - PID 3469 | |i|pagename|runs| 06:08:47 INFO - PID 3469 | |0;ai-astar;101;109;109;109;108;109;114;111;110;110 06:08:47 INFO - PID 3469 | |1;audio-beat-detection;146;121;154;196;123;147;151;120;176;123 06:08:47 INFO - PID 3469 | |2;audio-dft;163;161;163;162;163;163;162;164;176;171 06:08:47 INFO - PID 3469 | |3;audio-fft;79;75;74;181;75;75;75;74;95;75 06:08:47 INFO - PID 3469 | |4;audio-oscillator;81;82;134;81;81;82;131;81;82;142 06:08:47 INFO - PID 3469 | |5;imaging-gaussian-blur;113;113;113;114;114;113;113;113;114;113 06:08:47 INFO - PID 3469 | |6;imaging-darkroom;151;150;150;148;150;151;150;151;151;151 06:08:47 INFO - PID 3469 | |7;imaging-desaturate;94;94;94;95;94;95;95;94;93;94 06:08:47 INFO - PID 3469 | |8;json-parse-financial;55;57;58;55;55;56;55;54;55;56 06:08:47 INFO - PID 3469 | |9;json-stringify-tinderbox;54;54;54;54;54;54;54;54;54;54 06:08:47 INFO - PID 3469 | |10;stanford-crypto-aes;76;80;77;77;80;77;78;78;77;77 06:08:47 INFO - PID 3469 | |11;stanford-crypto-ccm;127;135;129;126;126;125;124;123;124;148 06:08:47 INFO - PID 3469 | |12;stanford-crypto-pbkdf2;190;186;183;184;190;181;187;184;181;184 06:08:47 INFO - PID 3469 | |13;stanford-crypto-sha256-iterative;72;68;70;69;67;72;68;74;79;68 06:08:47 INFO - PID 3469 | __end_tp_report 06:08:47 INFO - PID 3469 | __start_cc_report 06:08:47 INFO - PID 3469 | _x_x_mozilla_cycle_collect,942 06:08:47 INFO - PID 3469 | __end_cc_report 06:08:47 INFO - PID 3469 | __startTimestamp1500296927789__endTimestamp 06:08:47 INFO - PID 3469 | 06:08:47 INFO - PID 3469 | ------- Summary: start ------- 06:08:47 INFO - PID 3469 | Number of tests: 14 06:08:47 INFO - PID 3469 | 06:08:47 INFO - PID 3469 | [#0] ai-astar Cycles:10 Average:109.00 Median:109.50 stddev:3.27 (3.0%) stddev-sans-first:1.76 06:08:47 INFO - PID 3469 | Values: 101.0 109.0 109.0 109.0 108.0 109.0 114.0 111.0 110.0 110.0 06:08:47 INFO - PID 3469 | 06:08:47 INFO - PID 3469 | [#1] audio-beat-detection Cycles:10 Average:145.70 Median:149.00 stddev:25.49 (17.1%) stddev-sans-first:27.04 06:08:47 INFO - PID 3469 | Values: 146.0 121.0 154.0 196.0 123.0 147.0 151.0 120.0 176.0 123.0 06:08:47 INFO - PID 3469 | 06:08:47 INFO - PID 3469 | [#2] audio-dft Cycles:10 Average:164.80 Median:163.00 stddev:4.80 (2.9%) stddev-sans-first:5.05 06:08:47 INFO - PID 3469 | Values: 163.0 161.0 163.0 162.0 163.0 163.0 162.0 164.0 176.0 171.0 06:08:47 INFO - PID 3469 | 06:08:47 INFO - PID 3469 | [#3] audio-fft Cycles:10 Average:87.80 Median:75.00 stddev:33.36 (44.5%) stddev-sans-first:35.23 06:08:47 INFO - PID 3469 | Values: 79.0 75.0 74.0 181.0 75.0 75.0 75.0 74.0 95.0 75.0 06:08:47 INFO - PID 3469 | 06:08:47 INFO - PID 3469 | [#4] audio-oscillator Cycles:10 Average:97.70 Median:81.00 stddev:26.34 (32.5%) stddev-sans-first:27.24 06:08:47 INFO - PID 3469 | Values: 81.0 82.0 134.0 81.0 81.0 82.0 131.0 81.0 82.0 142.0 06:08:47 INFO - PID 3469 | 06:08:47 INFO - PID 3469 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:113.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 06:08:47 INFO - PID 3469 | Values: 113.0 113.0 113.0 114.0 114.0 113.0 113.0 113.0 114.0 113.0 06:08:47 INFO - PID 3469 | 06:08:47 INFO - PID 3469 | [#6] imaging-darkroom Cycles:10 Average:150.30 Median:151.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 06:08:47 INFO - PID 3469 | Values: 151.0 150.0 150.0 148.0 150.0 151.0 150.0 151.0 151.0 151.0 06:08:47 INFO - PID 3469 | 06:08:47 INFO - PID 3469 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 06:08:47 INFO - PID 3469 | Values: 94.0 94.0 94.0 95.0 94.0 95.0 95.0 94.0 93.0 94.0 06:08:47 INFO - PID 3469 | 06:08:47 INFO - PID 3469 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.50 stddev:1.17 (2.1%) stddev-sans-first:1.22 06:08:47 INFO - PID 3469 | Values: 55.0 57.0 58.0 55.0 55.0 56.0 55.0 54.0 55.0 56.0 06:08:47 INFO - PID 3469 | 06:08:47 INFO - PID 3469 | [#9] json-stringify-tinderbox Cycles:10 Average:54.00 Median:54.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 06:08:47 INFO - PID 3469 | Values: 54.0 54.0 54.0 54.0 54.0 54.0 54.0 54.0 54.0 54.0 06:08:47 INFO - PID 3469 | 06:08:47 INFO - PID 3469 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:77.50 stddev:1.34 (1.7%) stddev-sans-first:1.27 06:08:47 INFO - PID 3469 | Values: 76.0 80.0 77.0 77.0 80.0 77.0 78.0 78.0 77.0 77.0 06:08:47 INFO - PID 3469 | 06:08:47 INFO - PID 3469 | [#11] stanford-crypto-ccm Cycles:10 Average:128.70 Median:126.50 stddev:7.60 (6.0%) stddev-sans-first:8.04 06:08:47 INFO - PID 3469 | Values: 127.0 135.0 129.0 126.0 126.0 125.0 124.0 123.0 124.0 148.0 06:08:47 INFO - PID 3469 | 06:08:47 INFO - PID 3469 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.00 Median:185.00 stddev:3.23 (1.7%) stddev-sans-first:2.88 06:08:47 INFO - PID 3469 | Values: 190.0 186.0 183.0 184.0 190.0 181.0 187.0 184.0 181.0 184.0 06:08:47 INFO - PID 3469 | 06:08:47 INFO - PID 3469 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:71.00 stddev:3.68 (5.2%) stddev-sans-first:3.88 06:08:47 INFO - PID 3469 | Values: 72.0 68.0 70.0 69.0 67.0 72.0 68.0 74.0 79.0 68.0 06:08:47 INFO - PID 3469 | -------- Summary: end -------- 06:08:47 INFO - PID 3469 | 06:08:48 INFO - PID 3469 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 06:08:48 INFO - TEST-INFO | 3469: exit 0 06:08:48 INFO - TEST-OK | kraken | took 61673ms 06:08:48 INFO - SUITE-END | took 1172s 06:08:48 INFO - Completed test suite (00:19:33) 06:08:48 INFO - javascript benchmark 06:08:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8267.905829552805, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3059.847007649617, 3102.270966322914, 3106.2700265437634, 3109.471389863723, 3145.921351966202, 6005.939940600598, 6058.1518587397795, 6060.757569697218, 6064.272287325522, 6078.8480287992825, 6027.3972602739705, 6072.362401947798, 6135.447809697126, 6154.292256390517, 6195.25656921169, 5477.561795056386, 5594.132909399029, 5601.915971260434, 5631.63394379366, 5649.49154576088, 5576.247206627114, 5598.076317407643, 5599.272094627713, 5673.971630141864, 5690.174924635925, 5383.192521121824, 5497.3952865185, 5515.834524964257, 5577.665340079588, 5602.971985140089, 5515.669059856381, 5577.024020796385, 5577.442255774431, 5577.498025177713, 5596.188552659883, 5459.781608735646, 5537.446255374431, 5541.722913854332, 5547.029269877796, 5555.194496797982, 5958.255218097738, 5974.044152935509, 5985.0124729419595, 5989.161517387569, 5999.0, 6423.7430502779835, 6454.515911306671, 6491.513136514733, 6491.642959637218, 6517.0, 6522.249941256769, 6560.770373036921, 6574.211094668671, 6625.93374066258, 6626.237982632011, 6051.909221361683, 6089.086637004485, 6124.418180272912, 6142.692865356715, 6144.907826382608, 6668.799936001928, 6680.365365290289, 6727.394534491919, 6751.932480675228, 6767.35710107539, 6177.876442471125, 6319.8104056878365, 6323.778667746698, 6324.936750632435, 6375.521835862329, 6439.710213040425, 6442.06590044441, 6451.419372256426, 6535.150430444012, 6571.342865713486, 6388.584741991755, 6412.134361861183, 6416.326285740023, 6418.326075762071, 6496.70764815575, 6430.0, 6451.903221451682, 6524.021396790519, 6549.836254093686, 6558.1802274715665, 5198.2722418861385, 5270.025045366543, 5270.446603106619, 5287.867803304948, 5313.123334649739, 4535.63714902807, 4556.88607784808, 4559.065391594715, 4559.908801823945, 4560.4071470708595, 5402.135658294654, 5486.31421072366, 5526.419725928719, 5531.889362212733, 5535.889282214333, 5640.323161220597, 6498.5126115541525, 6502.7724029659685, 6583.07836902834, 6599.769008084694, 5489.890202195934, 5518.889622207534, 5584.329880414295, 5597.720113994284, 5622.32532096151, 5713.400092990176, 5717.885642287214, 5780.71096445176, 5784.681842498703, 5799.5650326225705, 6148.723307451175, 6216.2540495140875, 6256.906146407808, 6336.493080553637, 6372.235331760218, 6471.773487927994, 6517.804465866032, 6527.5757075789925, 6533.281339052795, 6537.836554086186, 6293.96853015732, 6317.684115794284, 6323.272823625158, 6327.019312006646, 6333.113364129118, 6117.405743309309, 6405.615663060231, 6412.487001039999, 6425.0, 6449.7420103195345, 6428.8071357859335, 6488.578242414228, 6556.508261880283, 6589.703463344257, 6614.603123812587, 6283.340249273943, 6285.340039295991, 6379.489640828815, 6386.489080873612, 6392.776252831314, 6191.226096737908, 6283.8114856554375, 6287.339829317856, 6300.464460520907, 6387.4570661492435, 6230.7819226326865, 6250.343713910156, 6267.467265282502, 6270.529710271657, 6285.811425657238, 6329.1139240505445, 6387.329330420424, 6394.360563943755, 6409.134766806422, 6449.451796597342, 6177.1969643945995, 6186.4741496973265, 6238.719257633508, 6251.656158911122, 6266.060090986389], "value": 5925.0283641051155, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [738.5421038955844, 792.7185849023597, 798.1180795221277, 835.4444294544129, 845.1801752300266, 40631.79684101579, 41101.38347924784, 41188.79405602968, 41351.0, 41457.79271103644, 37142.8142859286, 37170.628293717054, 37198.25603487928, 37259.813700931525, 37461.0, 6617.735290588371, 6791.864162716743, 6798.422134118606, 6803.931960680379, 6805.149356330458, 6760.628165450898, 6854.177498700163, 6866.485013623973, 6870.4503639708955, 6881.277465866087, 6794.728210871559, 6818.045473633695, 6821.18145822502, 6829.829254268633, 6848.897266541006, 6758.8310292242595, 6758.9662051689675, 6778.694958726869, 6778.932210677929, 6816.352446517573, 6091.573589848713, 6134.77304539094, 6147.661878596676, 6154.78458253959, 6197.287311959092, 32930.34139317224, 33045.50431743526, 33304.16739581506, 33568.0, 33582.160445988804, 3358.580177477815, 3407.9148021299666, 3412.095794614429, 3414.6243913169533, 3418.1967237699123, 26370.868145659148, 29523.0, 30596.84701576478, 30705.69294307073, 30749.692503074908, 4823.5176482351835, 4883.633727470454, 4900.803967841318, 4904.828331008398, 4999.775010124553, 183408.0, 186828.0, 188286.05856970765, 191195.0, 191727.0, 47460.5253947463, 48285.0, 48430.51569484331, 48571.75714121477, 48576.5142348572, 51258.74370628123, 51309.23036154461, 51335.229971550456, 51361.74319128455, 51438.48561514412, 16188.838111618968, 16189.676206475804, 16235.83764162367, 16297.67404651924, 16367.42714005004, 13735.107218030797, 13743.381547830171, 13743.518976835763, 13756.65608359779, 13793.517226897011, 14342.784858227134, 14463.13221206731, 14529.491467798576, 14624.0, 14716.779248311284, 5843.503302219359, 5896.6756828374855, 5964.1650168976375, 5969.671668058299, 5978.880422391528, 971.5433746139303, 978.6379039755194, 994.4381424495137, 1018.8828284747201, 1026.2405819693374, 22700.205492807672, 22806.42983925382, 22838.771612283996, 22857.0, 23237.41906452352, 1080.7568297133082, 1084.6854412220525, 1110.8111621024445, 1114.7982734100249, 1121.8092924202906, 11818.645440636794, 12071.034317254598, 12131.090168237417, 12171.695707607381, 12315.876841231653, 230489.0, 232754.0, 235625.0, 235723.0, 235836.0, 53429.1985620216, 53571.732141339045, 53807.73096134494, 53937.0, 53940.730296348265, 1439.1437094928501, 1442.4086124688827, 1453.573867573242, 1482.1625781433456, 1493.7983372244826, 21819.76282214629, 22024.779752202274, 22507.549849003255, 22861.08555657755, 23024.76975230226, 37107.628923710414, 37194.25611487701, 37437.62562374341, 37479.43780843235, 37497.0, 193869.0, 193931.0, 194328.0, 194579.0, 194701.0, 34626.30747385089, 35736.821315894296, 36365.27269454649, 38357.84926452211, 38478.42282365711, 46033.0, 46473.0, 47159.528404715515, 47555.28667070066, 47739.76130119327, 31637.525437118, 33006.758107729875, 33686.83156584201, 33827.0, 34442.655573443946, 32640.183995400304, 32872.50691239585, 33506.16234594155, 33583.0, 33602.66397336093, 34997.30005399827, 37674.0, 37713.62286377101, 37728.056798580255, 37731.62268377281, 31097.53353699651, 31646.683533164374, 32540.186495337806, 32739.508907365933, 33060.66939330672, 23481.530369392858, 23488.0, 23675.763242367357, 23814.571125732513, 23878.641820372362], "value": 16760.247412021774, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.6194007105133, 568.9061304884694, 575.9971200143999, 585.8623223542468, 594.8007417515132, 21939.561208775816, 22718.432039199008, 22731.659025114637, 22781.772182278215, 22787.202447914326, 24111.0, 25569.74430255697, 26783.33041673959, 26976.730232697668, 27052.864735676296, 6424.486041116711, 6593.0, 6593.604383736967, 6593.637349945751, 6595.472362211036, 6380.521460890429, 6424.389682980132, 6426.6144031358035, 6433.131527243809, 6454.19322584677, 6076.3316035236085, 6248.380344861937, 6376.617402955838, 6394.232692076957, 6408.93591064088, 6390.808275751735, 6425.678716064225, 6429.099926010363, 6484.93515064848, 6496.707648155821, 5984.521238300926, 6006.759729610811, 6026.879462410771, 6030.638161710312, 6048.727807248641, 25332.873335633387, 29009.70990290091, 29370.853145734134, 29392.853035734686, 29432.11703648894, 1940.3790786948182, 1958.1384190955935, 1971.6352474792209, 1980.5048737815546, 1988.890611016408, 18228.635427291512, 19022.0, 19044.71432928507, 19141.0, 19212.327568535035, 2332.661764044204, 2342.4612339161918, 2403.8197135214755, 2405.0379848060743, 2418.5404773093055, 134432.0, 141323.29338353346, 141638.0, 141785.0, 141857.2907135468, 13774.931125344308, 14768.0, 14824.184669843047, 14889.851101488846, 15342.846571534365, 23863.284101476984, 23906.043758249823, 23961.0, 24015.399615009763, 24021.759782402303, 10469.581216751245, 10503.264771465923, 10503.894961050444, 10646.520906559068, 10674.839877401846, 9632.27757918159, 9669.709908702609, 9714.174295184988, 9838.75403114928, 9915.256355773347, 8868.733937981871, 9369.812603747887, 9551.90448095524, 9593.232541396672, 9646.90353096474, 2717.5813525961908, 2731.508328500849, 2827.604135421043, 2899.6810350861388, 2982.585773055846, 940.219617717293, 940.8965013848472, 942.4062840410497, 976.511744127936, 978.5792109393029, 19424.805751942582, 19626.411207663794, 20128.698069528968, 20480.078396472196, 24983.250502484956, 995.8431771285044, 1024.8513965474965, 1059.8410238464292, 1072.463768115942, 1075.0700643942932, 10646.0, 11131.220814542905, 11212.775744485229, 11229.21395502307, 11607.0, 473469.0, 509425.0, 519737.0, 528223.0, 529205.0, 123107.0, 124924.37537812252, 126348.36825815812, 128925.0, 129000.0, 1238.0961897814466, 1275.9170653907465, 1296.1186393252678, 1311.8819306262483, 1314.158938279521, 17248.310067597155, 18015.819841801414, 18128.0, 18631.44105676832, 18756.96836673996, 55715.0, 56857.71571142118, 57175.714121429126, 57390.7130464345, 57882.0, 73131.0, 73352.63323683561, 73530.63234683793, 74737.6263118681, 75052.62473687815, 20034.699479508112, 20500.589988199856, 21240.681389779475, 21266.0, 21800.781992179876, 23500.764992349857, 23542.529149416572, 23794.167204147772, 23944.161954332212, 24010.639840402757, 18591.44225673232, 18694.25222991065, 18739.90630046841, 18815.623687526448, 18993.050347482294, 16200.594985125466, 16403.343866245694, 16875.409360672318, 16963.0, 17482.388116415863, 19005.334813281468, 20471.0, 20505.077271523114, 20526.076326565042, 20720.58558828845, 20154.899225503777, 20778.272760453918, 21299.0, 21338.893305533373, 21673.891630541748, 15557.299921503332, 16067.11630860314, 16078.839211608201, 16307.347706092098, 16340.264688088826], "value": 12338.732092230619, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1330.1952318847098, 1399.7130588229413, 1413.5405993052261, 1415.2216281045428, 1417.0718179592368, 13094.410751516181, 13684.0, 13759.724805503884, 13770.931145344259, 13779.242141682204, 13109.803352949713, 13625.659358516043, 13635.659108522266, 13645.0, 13655.86344136561, 2618.031328408487, 2672.532306846304, 2691.111933062085, 2696.8516731579757, 2701.04113039871, 2518.7103483099404, 2594.532984062868, 2603.947921041578, 2608.2827222513865, 2621.6722909636296, 2536.3025168078743, 2559.654446649706, 2593.209071233273, 2608.699999500063, 2619.803514736393, 2610.9086181983635, 2692.044324264897, 2705.4318593095472, 2705.8105932584626, 2714.1043455659583, 2588.8705564721877, 2624.5800671892407, 2626.4484458263787, 2633.381155428473, 2636.93407664808, 13665.590032299047, 13782.862171378258, 13792.655183620389, 13825.755681988669, 13845.446182152702, 7194.892076618855, 7575.431842611826, 7631.007968963999, 7641.961790191013, 7671.23287671234, 4634.490206077328, 4905.166121759274, 5054.064997975386, 5065.417476990119, 5087.262346959707, 1754.675385053769, 1801.6666916620468, 1813.555678858688, 1853.156813649786, 1862.6740320443869, 21682.34952951414, 21810.89094554533, 21925.671114933288, 21933.232336868292, 22050.4487387815, 6158.846028849225, 6209.5032397408095, 6258.0, 6327.651979141191, 6404.807855764335, 15184.46854360092, 15206.847931520764, 15220.162891040878, 15246.161461119746, 15270.389184432499, 7211.0, 7412.703491860373, 7414.777556673308, 7419.517731347445, 7425.146108197627, 6669.333066693292, 6701.1623547056615, 6855.931440685529, 6897.3447522485285, 6903.965480172567, 4896.730679812573, 4963.8262660806695, 5031.823886163967, 5095.541401273903, 5117.41149767774, 1488.642725745835, 1493.6340596553914, 1501.7146742118962, 1501.924903754808, 1531.8008658874498, 901.4501154295874, 904.1681652879366, 922.4511415707643, 935.4948327902993, 937.1378331934636, 7088.645567721594, 7109.111361079865, 7217.458690598226, 7250.927490725131, 7263.564186148848, 723.4574069447914, 724.7970568240795, 731.5135434935814, 751.8308380614318, 754.5925200391837, 4175.665946724254, 4794.880127996828, 4820.542048505386, 5084.110280700863, 5125.256837758504, 17710.557236068944, 17839.375621853174, 17881.7317740234, 18085.547861303574, 18351.541211469554, 17892.731609025876, 18162.545936351697, 18230.63538729218, 18453.907730461262, 18532.907335463235, 9689.273304502332, 9964.302498825158, 9974.351667141613, 9999.800003999879, 10039.196864250842, 7272.454565907472, 7489.962550187214, 7615.42884283692, 7624.0, 7671.07947046358, 15825.841741582437, 15865.365385384917, 15900.284487197872, 16067.035977841368, 16789.0, 15590.376384944475, 16087.75868361952, 16748.330066797193, 16908.0, 17059.48821535356, 10485.9475702621, 10781.353118812896, 10790.514426850654, 10815.783684326427, 10822.945885270523, 11800.70498237551, 12169.939150304192, 12315.322657253937, 12359.938200308941, 12449.93775031119, 9920.40477571348, 10360.378377297386, 10550.8417373741, 10677.039066484054, 10681.198910081619, 10242.436665983443, 10289.382637041801, 10339.431331276552, 10548.0, 10672.89327106719, 8581.399302048796, 9054.728358149267, 9068.274538036809, 9105.954470227607, 9128.315376346667, 6330.1454303668415, 6581.243157037002, 6621.0, 6646.60120392778, 6656.500762442739, 6049.213602231857, 6171.938280617136, 6211.627302361872, 6249.687515624291, 6252.843678908063], "value": 6103.716765626929, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.5985368899989, 501.29301770439633, 518.8054479570161, 518.8210067526704, 527.1986580397795, 6120.9693951530235, 6136.447719705226, 6185.783497577586, 6199.9770037943745, 6204.937950620492, 5830.688095178582, 5969.701514924258, 5978.4918281945975, 6058.4850287725485, 6067.57526973111, 4893.584045356131, 4894.216925291937, 4933.679310844802, 4962.900741985158, 4976.676516026456, 4834.4923783002805, 4858.125537403266, 4893.975530122344, 4904.264360345941, 4939.67892087015, 4810.278458231258, 4855.781489832948, 4898.779554920019, 4915.5084491550915, 4916.557509824115, 4658.90682186356, 4808.903821923542, 4838.104950584118, 4884.755762211875, 4887.633427492934, 4330.856226168035, 4334.414853994702, 4339.153864996327, 4352.499462561783, 4424.712393694432, 5927.703614819285, 5937.465628093449, 5942.316633587149, 5953.970230148865, 5957.672328021957, 5543.616245014642, 5588.469095435927, 5597.160425936142, 5599.356074051455, 5604.187392828057, 6382.329855365213, 6394.23269207698, 6410.487161027107, 6421.711023003976, 6461.773837915697, 4774.259989701602, 4790.616750659939, 4841.951580484185, 4850.296706977469, 4853.247746599282, 6724.562903411312, 6759.763408280735, 6831.726730930806, 6838.760643377507, 6883.655817209069, 4969.204927211629, 4978.5270399312, 4991.550760431506, 5021.472745361758, 5031.798728050837, 4957.702537847668, 4993.300937868628, 5033.766727151871, 5054.368203974504, 5067.391912970467, 5423.864403389868, 5466.058106205097, 5470.261514695465, 5499.560035197174, 5603.467670571289, 6239.188905442264, 6388.456981156561, 6402.551821372553, 6429.839254018687, 6465.191851018622, 1709.837565431282, 1754.7631069805668, 1767.7878654561534, 1770.97343539847, 1779.1815764748103, 1133.8412622232895, 1215.3012018089635, 1224.4245204753752, 1230.3110258255226, 1241.075398827861, 5403.13549832025, 5461.481159289861, 5535.806246781343, 5544.695041772741, 5553.805616803393, 6465.579737317059, 6537.248216455074, 6641.136652235178, 6642.136522252173, 6673.699683514254, 5548.500634942875, 5548.726251511627, 5593.636413633101, 5606.131049687305, 5607.915881261702, 3454.775439596418, 3495.07380544156, 3520.2959408118477, 3564.7682900611376, 3572.6427357264583, 6320.146780184708, 6397.808065758035, 6404.679766011774, 6445.967770161119, 6467.191601049869, 6653.73385064592, 6694.765683201064, 6703.93296067033, 6705.597664140168, 6728.798136055926, 6328.873422531616, 6359.109724638462, 6397.968010160012, 6418.518611104186, 6481.347256449575, 6457.676176383736, 6542.705578248895, 6569.737210511717, 6605.372489613479, 6609.3060228675295, 6268.686565671789, 6484.351564843478, 6542.509311801729, 6549.579034152023, 6558.868822623616, 6328.873422531616, 6351.30135685065, 6368.299487056513, 6373.94829853069, 6376.776812811715, 5263.736813159403, 5363.731813409392, 5377.542908852792, 5393.595480339069, 5395.0, 6608.356657337104, 6623.787463080498, 6628.436582890508, 6629.370209830058, 6656.167979002625, 6316.84207894788, 6333.809985700436, 6370.267419246846, 6375.808725738235, 6411.93588064132, 6360.968195158995, 6381.1704478417505, 6398.616083035033, 6407.423331900151, 6495.610263384212, 6226.283977342482, 6322.430981211713, 6327.430531252209, 6350.523295914505, 6375.649339286384, 5860.765569377178, 6391.456726178327, 6416.615003099642, 6423.518236132215, 6450.0, 6167.321594624677, 6203.596766210182, 6215.502759779117, 6228.750849965951, 6248.812915479546], "value": 4968.6158031846935, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [802.8728104034789, 845.4039901869179, 894.1907573645844, 923.0492592629589, 948.146667998801, 16935.83064169358, 17077.23152458139, 17082.658346833057, 17655.94064356138, 20080.29718959837, 19422.0, 19554.804451955475, 19626.803731962675, 19655.31206407776, 19660.311889083885, 975.2929126383386, 1010.570507534295, 1077.779055293667, 1078.1267173589417, 1078.9892101078967, 1063.5852017713098, 1063.6277302943986, 1067.3009178987736, 1069.5400977579638, 1071.4535586850723, 1106.690126764507, 1106.9280496767685, 1112.5494174859195, 1114.164376717462, 1116.4417791104447, 991.8016396720685, 1038.2939601071268, 1106.7122548137502, 1108.2020944919645, 1109.6171820721838, 791.8416316736676, 798.0463346301173, 799.9640016199285, 801.2428255298745, 801.3669201330941, 19077.141528631244, 19392.12735426909, 19471.0, 19475.220991160335, 19533.511662208417, 17709.557261068447, 18483.075846207637, 18500.537486562807, 18586.44240672782, 18653.906730466395, 15254.38982440701, 15637.452689155938, 15706.05763654173, 15763.054216747032, 15769.132697701622, 3334.4498157803932, 3360.512725654766, 3366.0575038989123, 3366.107981384935, 3373.527706121145, 107826.46086769595, 112358.43820780926, 112718.43640781744, 112904.43547782209, 116208.41895790551, 15726.449574264845, 16030.519084427486, 16398.590035249214, 16430.342786288653, 16513.6697266054, 28322.0, 29331.85334073316, 29526.852365738036, 29599.704002960127, 29975.700242997726, 8154.714584989497, 8193.09875913649, 8243.587820609066, 8246.793830154294, 8305.252527272574, 3477.2002439438565, 3590.3537363274863, 3649.671529562352, 3656.8171591420855, 3791.241751649681, 5012.8496145115705, 5148.639595228373, 5193.870153246199, 5231.293775340357, 5241.318628578337, 933.673214374977, 964.5273815830333, 979.9853002204973, 981.4601968917067, 984.5323471351194, 668.2916108924555, 670.7819958513405, 683.5351960666794, 690.378659206718, 696.331521739126, 11015.684650201885, 11769.529218831321, 12197.51209951592, 12437.253764773961, 12888.93555532235, 681.1485642946317, 693.9167299924042, 698.6192525073847, 718.2781304788758, 718.335539625844, 5212.748940254388, 5285.392179899361, 5300.655457395257, 5381.78472861089, 5430.375506816687, 94597.0, 95053.0, 99473.50263248637, 101495.0, 103242.48378758058, 85254.57372713096, 87719.56140219385, 87921.0, 88650.0, 91111.54444227736, 75478.62260688661, 76765.61617191878, 77225.0, 77422.0, 79024.60487697525, 10889.673309800719, 11009.889901100887, 11018.44907754593, 11034.903368359986, 11040.171987101161, 34519.827400862836, 35391.82304088463, 35608.28783424265, 36778.0, 38192.0, 43323.56676433321, 44352.0, 44377.33433998428, 44640.33039504475, 45148.0, 15648.4523041693, 15717.921410392875, 15728.21358932026, 15759.212039398213, 15873.603159920633, 16306.26621801998, 16483.175841207652, 16495.257713403167, 16622.75065874037, 16666.4166754163, 14951.626209344853, 15169.772453413429, 15221.6194595136, 15323.77014344808, 15372.84627153714, 15458.072515649097, 18142.183601737688, 19054.523636908634, 19117.426477205707, 19545.413637590325, 17679.823201767816, 18043.0, 18467.16897739578, 18542.351017714314, 18778.154983025524, 12058.638240852788, 13751.587452376045, 13753.243571603258, 13867.722645547234, 14038.508652197532, 13140.474381024653, 13164.80252796228, 13668.52160174389, 13727.0, 13810.861891381359], "value": 8595.549104177006, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1534.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 109.0, 109.0, 109.0, 108.0, 109.0, 114.0, 111.0, 110.0, 110.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 121.0, 154.0, 196.0, 123.0, 147.0, 151.0, 120.0, 176.0, 123.0], "value": 145.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 163.0, 162.0, 163.0, 163.0, 162.0, 164.0, 176.0, 171.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 75.0, 74.0, 181.0, 75.0, 75.0, 75.0, 74.0, 95.0, 75.0], "value": 87.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 134.0, 81.0, 81.0, 82.0, 131.0, 81.0, 82.0, 142.0], "value": 97.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 114.0, 114.0, 113.0, 113.0, 113.0, 114.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 150.0, 148.0, 150.0, 151.0, 150.0, 151.0, 151.0, 151.0], "value": 150.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 93.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 58.0, 55.0, 55.0, 56.0, 55.0, 54.0, 55.0, 56.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 80.0, 77.0, 77.0, 80.0, 77.0, 78.0, 78.0, 77.0, 77.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 135.0, 129.0, 126.0, 126.0, 125.0, 124.0, 123.0, 124.0, 148.0], "value": 128.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 186.0, 183.0, 184.0, 190.0, 181.0, 187.0, 184.0, 181.0, 184.0], "value": 185.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 68.0, 70.0, 69.0, 67.0, 72.0, 68.0, 74.0, 79.0, 68.0], "value": 70.7, "unit": "score"}]}]} 06:08:49 INFO - Return code: 0 06:08:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:08:49 INFO - # TBPL SUCCESS # 06:08:49 INFO - Running post-action listener: _package_coverage_data 06:08:49 INFO - Running post-action listener: _resource_record_post_action 06:08:49 INFO - [mozharness: 2017-07-17 13:08:49.107379Z] Finished run-tests step (success) 06:08:49 INFO - Running post-run listener: _resource_record_post_run 06:08:49 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 435568640; Read time: 12; Write time: 432032 06:08:49 INFO - TinderboxPrint: CPU usage
13.1% 06:08:49 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 06:08:49 INFO - TinderboxPrint: I/O write bytes / time
435,568,640 / 432,032 06:08:49 INFO - TinderboxPrint: CPU idle
8,259.7 (86.9%) 06:08:49 INFO - TinderboxPrint: CPU user
1,198.4 (12.6%) 06:08:49 INFO - TinderboxPrint: Swap in / out
0 / 0 06:08:49 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106557440; Read time: 0; Write time: 102160 06:08:49 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 06:08:49 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 329011200; Read time: 0; Write time: 329872 06:08:49 INFO - Running post-run listener: _upload_blobber_files 06:08:49 INFO - Blob upload gear active. 06:08:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:08:49 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 06:08:49 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'] 06:08:49 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 06:08:50 INFO - Traceback (most recent call last): 06:08:50 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 06:08:50 INFO - main() 06:08:50 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 06:08:50 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 06:08:50 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 06:08:50 INFO - return set(response.json().get('whitelist', [])) 06:08:50 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 06:08:50 INFO - return json.loads(self.text or self.content, **kwargs) 06:08:50 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/__init__.py", line 488, in loads 06:08:50 INFO - return _default_decoder.decode(s) 06:08:50 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 370, in decode 06:08:50 INFO - obj, end = self.raw_decode(s) 06:08:50 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 389, in raw_decode 06:08:50 INFO - return self.scan_once(s, idx=_w(s, idx).end()) 06:08:50 INFO - simplejson.scanner.JSONDecodeError: Expecting value: line 1 column 1 (char 0) 06:08:50 ERROR - Return code: 1 06:08:50 INFO - Setting buildbot property blobber_files to {} 06:08:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:08:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:08:50 INFO - Contents: 06:08:50 INFO - blobber_files:{} 06:08:50 INFO - Running post-run listener: copy_logs_to_upload_dir 06:08:50 INFO - Copying logs to upload dir... 06:08:50 INFO - mkdir: /builds/slave/test/build/upload/logs 06:08:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.566299 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-07-17 06:08:49.746334) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-17 06:08:49.750743) ========= 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=32c5991c409366f7fec8a718000001d2-1500294816.967678-1879613223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011246 build_url: 'https://queue.taskcluster.net/v1/task/AcKXipBCQoSWPd6GQSLflg/artifacts/public/build/target.tar.bz2' blobber_files: '{}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-17 06:08:49.804507) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 06:08:49.804879) ========= 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=32c5991c409366f7fec8a718000001d2-1500294816.967678-1879613223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004433 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-17 06:08:49.854229) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-17 06:08:49.857558) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-17 06:08:49.857881) ========= ========= Total master_lag: 0.20 =========