builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-024 starttime: 1500197823.35 results: success (0) revision: b4e656e5a996dd385e9af43a4d9e207553377c51 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:03.354151) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:03.354750) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:03.355212) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:03.422424) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:03.422805) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1500187430.546621-271104504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-16 02:37:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 58.8K=0.2s 2017-07-16 02:37:03 (58.8 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.413221 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:03.878478) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:03.878914) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1500187430.546621-271104504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.030644 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:03.932414) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:03.932861) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b4e656e5a996dd385e9af43a4d9e207553377c51 --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 b4e656e5a996dd385e9af43a4d9e207553377c51 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1500187430.546621-271104504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-16 02:37:03,979 truncating revision to first 12 chars 2017-07-16 02:37:03,979 Setting DEBUG logging. 2017-07-16 02:37:03,979 attempt 1/10 2017-07-16 02:37:03,979 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b4e656e5a996?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-16 02:37:04,580 unpacking tar archive at: mozilla-central-b4e656e5a996/testing/mozharness/ program finished with exit code 0 elapsedTime=0.908397 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:04.853838) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:04.857353) ========= script_repo_revision: b4e656e5a996dd385e9af43a4d9e207553377c51 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:04.857863) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:04.858202) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-16 02:37:04.874532) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-07-16 02:37:04.874924) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1500187430.546621-271104504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:37:05 INFO - MultiFileLogger online at 20170716 02:37:05 in /builds/slave/test 02:37:05 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 02:37:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:37:05 INFO - {'append_to_log': False, 02:37:05 INFO - 'base_work_dir': '/builds/slave/test', 02:37:05 INFO - 'blob_upload_branch': 'Firefox', 02:37:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:37:05 INFO - 'branch': 'Firefox', 02:37:05 INFO - 'buildbot_json_path': 'buildprops.json', 02:37:05 INFO - 'code_coverage': False, 02:37:05 INFO - 'config_files': ('talos/linux_config.py',), 02:37:05 INFO - 'default_actions': ('clobber', 02:37:05 INFO - 'read-buildbot-config', 02:37:05 INFO - 'download-and-extract', 02:37:05 INFO - 'populate-webroot', 02:37:05 INFO - 'create-virtualenv', 02:37:05 INFO - 'install', 02:37:05 INFO - 'setup-mitmproxy', 02:37:05 INFO - 'run-tests'), 02:37:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:37:05 INFO - 'disable_ccov_upload': False, 02:37:05 INFO - 'download_minidump_stackwalk': True, 02:37:05 INFO - 'download_symbols': 'ondemand', 02:37:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:37:05 INFO - 'tooltool.py': '/tools/tooltool.py', 02:37:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:37:05 INFO - '/tools/misc-python/virtualenv.py')}, 02:37:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:37:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:37:05 INFO - 'gecko_profile': False, 02:37:05 INFO - 'gecko_profile_interval': 0, 02:37:05 INFO - 'installer_path': 'installer.exe', 02:37:05 INFO - 'log_level': 'info', 02:37:05 INFO - 'log_name': 'talos', 02:37:05 INFO - 'log_to_console': True, 02:37:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:37:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:37:05 INFO - 'opt_config_files': (), 02:37:05 INFO - 'pip_index': False, 02:37:05 INFO - 'suite': 'dromaeojs-e10s', 02:37:05 INFO - 'system_bits': '32', 02:37:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:37:05 INFO - 'title': 'talos-linux64-ix-024', 02:37:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:37:05 INFO - 'use_talos_json': True, 02:37:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:37:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:37:05 INFO - 'work_dir': 'build'} 02:37:05 INFO - [mozharness: 2017-07-16 09:37:05.156662Z] Running clobber step. 02:37:05 INFO - Running pre-action listener: _resource_record_pre_action 02:37:05 INFO - Running main action method: clobber 02:37:05 INFO - rmtree: /builds/slave/test/build 02:37:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:37:07 INFO - Running post-action listener: _resource_record_post_action 02:37:07 INFO - [mozharness: 2017-07-16 09:37:07.319553Z] Finished clobber step (success) 02:37:07 INFO - [mozharness: 2017-07-16 09:37:07.319655Z] Running read-buildbot-config step. 02:37:07 INFO - Running pre-action listener: _resource_record_pre_action 02:37:07 INFO - Running main action method: read_buildbot_config 02:37:07 INFO - Using buildbot properties: 02:37:07 INFO - { 02:37:07 INFO - "project": "", 02:37:07 INFO - "product": "firefox", 02:37:07 INFO - "who": "archaeopteryx@coole-files.de", 02:37:07 INFO - "installer_path": "public/build/target.tar.bz2", 02:37:07 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 02:37:07 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 02:37:07 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 02:37:07 INFO - "stage_platform": "linux64-stylo", 02:37:07 INFO - "basedir": "/builds/slave/test", 02:37:07 INFO - "buildnumber": 29, 02:37:07 INFO - "platform": "ubuntu64_hw_stylo", 02:37:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:37:07 INFO - "slavebuilddir": "test", 02:37:07 INFO - "taskId": "X58Y9eBGQ9SOO-8WwOkiHg", 02:37:07 INFO - "branch": "mozilla-central", 02:37:07 INFO - "script_repo_revision": "production", 02:37:07 INFO - "revision": "b4e656e5a996dd385e9af43a4d9e207553377c51", 02:37:07 INFO - "slavename": "talos-linux64-ix-024", 02:37:07 INFO - "repo_path": "mozilla-central" 02:37:07 INFO - } 02:37:07 INFO - Finding installer, test and symbols from parent task. 02:37:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X58Y9eBGQ9SOO-8WwOkiHg'}, attempt #1 02:37:07 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X58Y9eBGQ9SOO-8WwOkiHg'}, attempt #1 02:37:08 INFO - Task dependencies: WJ_icmeDTNmefs5D-71J0w 02:37:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w'}, attempt #1 02:37:08 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.tar.bz2 02:37:08 INFO - Set test_url: https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/test_packages.json 02:37:08 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.crashreporter-symbols.zip 02:37:08 INFO - Running post-action listener: _resource_record_post_action 02:37:08 INFO - [mozharness: 2017-07-16 09:37:08.685552Z] Finished read-buildbot-config step (success) 02:37:08 INFO - [mozharness: 2017-07-16 09:37:08.685908Z] Running download-and-extract step. 02:37:08 INFO - Running pre-action listener: _resource_record_pre_action 02:37:08 INFO - Running main action method: download_and_extract 02:37:08 INFO - mkdir: /builds/slave/test/build/tests 02:37:08 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')]} 02:37:08 INFO - trying https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.test_packages.json 02:37:08 INFO - Downloading https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:37:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:37:09 INFO - Downloaded 989 bytes. 02:37:09 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:37:09 INFO - Using the following test package requirements: 02:37:09 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:37:09 INFO - u'common': [u'target.common.tests.zip'], 02:37:09 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:37:09 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:37:09 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:37:09 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:37:09 INFO - u'mozbase': [u'target.common.tests.zip'], 02:37:09 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:37:09 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:37:09 INFO - u'web-platform': [u'target.common.tests.zip', 02:37:09 INFO - u'target.web-platform.tests.tar.gz'], 02:37:09 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:37:09 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:37:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.common.tests.zip 02:37:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:37:09 INFO - Fetch https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.common.tests.zip into memory 02:37:11 INFO - Content-Length response header: 72753054 02:37:11 INFO - Bytes received: 72753054 02:37:22 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:37:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.common.tests.zip 02:37:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:37:22 INFO - Fetch https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.common.tests.zip into memory 02:37:23 INFO - Content-Length response header: 72753054 02:37:23 INFO - Bytes received: 72753054 02:37:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.talos.tests.zip 02:37:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 02:37:37 INFO - Fetch https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.talos.tests.zip into memory 02:37:37 INFO - Content-Length response header: 14495033 02:37:37 INFO - Bytes received: 14495033 02:37:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:37:37 INFO - trying https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.tar.bz2 02:37:37 INFO - Downloading https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 02:37:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 02:37:39 INFO - Downloaded 61896492 bytes. 02:37:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.tar.bz2 02:37:39 INFO - mkdir: /builds/slave/test/properties 02:37:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:37:39 INFO - Writing to file /builds/slave/test/properties/build_url 02:37:39 INFO - Contents: 02:37:39 INFO - build_url:https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.tar.bz2 02:37:39 INFO - Running post-action listener: _resource_record_post_action 02:37:39 INFO - Running post-action listener: set_extra_try_arguments 02:37:39 INFO - [mozharness: 2017-07-16 09:37:39.095835Z] Finished download-and-extract step (success) 02:37:39 INFO - [mozharness: 2017-07-16 09:37:39.095932Z] Running populate-webroot step. 02:37:39 INFO - Running pre-action listener: _resource_record_pre_action 02:37:39 INFO - Running main action method: populate_webroot 02:37:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:37:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:37:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:37:39 INFO - '--tppagecycles', 02:37:39 INFO - '7'], 02:37:39 INFO - 'tests': ['tsvgm']}}, 02:37:39 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:37:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:37:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:37:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:37:39 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:37:39 INFO - 'talos_options': ['--disable-e10s'], 02:37:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:37:39 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:37:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:37:39 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:37:39 INFO - 'talos_options': ['--disable-e10s'], 02:37:39 INFO - 'tests': ['damp', 'tps']}, 02:37:39 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:37:39 INFO - 'tests': ['damp', 'tps']}, 02:37:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:37:39 INFO - 'tests': ['dromaeo_dom']}, 02:37:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:37:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:37:39 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:37:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:37:39 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 02:37:39 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 02:37:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:37:39 INFO - 'tests': ['a11yr', 02:37:39 INFO - 'ts_paint', 02:37:39 INFO - 'tpaint', 02:37:39 INFO - 'sessionrestore', 02:37:39 INFO - 'sessionrestore_no_auto_restore', 02:37:39 INFO - 'tabpaint']}, 02:37:39 INFO - 'other-e10s': {'tests': ['a11yr', 02:37:39 INFO - 'ts_paint', 02:37:39 INFO - 'tpaint', 02:37:39 INFO - 'sessionrestore', 02:37:39 INFO - 'sessionrestore_many_windows', 02:37:39 INFO - 'sessionrestore_no_auto_restore', 02:37:39 INFO - 'tabpaint']}, 02:37:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:37:39 INFO - 'ts_paint', 02:37:39 INFO - 'tpaint', 02:37:39 INFO - 'sessionrestore', 02:37:39 INFO - 'sessionrestore_many_windows', 02:37:39 INFO - 'sessionrestore_no_auto_restore', 02:37:39 INFO - 'tabpaint']}, 02:37:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:37:39 INFO - 'ts_paint', 02:37:39 INFO - 'tpaint', 02:37:39 INFO - 'sessionrestore', 02:37:39 INFO - 'sessionrestore_many_windows', 02:37:39 INFO - 'sessionrestore_no_auto_restore', 02:37:39 INFO - 'tabpaint']}, 02:37:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:37:39 INFO - 'tests': ['a11yr', 02:37:39 INFO - 'ts_paint', 02:37:39 INFO - 'tpaint', 02:37:39 INFO - 'sessionrestore', 02:37:39 INFO - 'sessionrestore_no_auto_restore', 02:37:39 INFO - 'tabpaint']}, 02:37:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:37:39 INFO - 'tests': ['a11yr', 02:37:39 INFO - 'ts_paint', 02:37:39 INFO - 'tpaint', 02:37:39 INFO - 'sessionrestore', 02:37:39 INFO - 'sessionrestore_no_auto_restore', 02:37:39 INFO - 'tabpaint']}, 02:37:39 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 02:37:39 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 02:37:39 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 02:37:39 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 02:37:39 INFO - 'talos_options': ['--mitmproxy', 02:37:39 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 02:37:39 INFO - '--firstNonBlankPaint'], 02:37:39 INFO - 'tests': ['quantum_pageload_google', 02:37:39 INFO - 'quantum_pageload_youtube', 02:37:39 INFO - 'quantum_pageload_amazon', 02:37:39 INFO - 'quantum_pageload_facebook']}, 02:37:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:37:39 INFO - 'tests': ['tsvgx', 02:37:39 INFO - 'tsvgr_opacity', 02:37:39 INFO - 'tart', 02:37:39 INFO - 'tscrollx', 02:37:39 INFO - 'cart', 02:37:39 INFO - 'tsvg_static']}, 02:37:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:37:39 INFO - 'tsvgr_opacity', 02:37:39 INFO - 'tart', 02:37:39 INFO - 'tscrollx', 02:37:39 INFO - 'cart', 02:37:39 INFO - 'tsvg_static']}, 02:37:39 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:37:39 INFO - 'talos_options': ['--disable-e10s'], 02:37:39 INFO - 'tests': ['tp5o']}, 02:37:39 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:37:39 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:37:39 INFO - 'talos_options': ['--disable-e10s', 02:37:39 INFO - '--xperf_path', 02:37:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:37:39 INFO - 'tests': ['tp5n']}, 02:37:39 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:37:39 INFO - 'talos_options': ['--xperf_path', 02:37:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:37:39 INFO - 'tests': ['tp5n']}}, 02:37:39 INFO - 'talos.zip': {'path': '', 02:37:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:37:39 INFO - Running post-action listener: _resource_record_post_action 02:37:39 INFO - [mozharness: 2017-07-16 09:37:39.111141Z] Finished populate-webroot step (success) 02:37:39 INFO - [mozharness: 2017-07-16 09:37:39.111231Z] Running create-virtualenv step. 02:37:39 INFO - Running pre-action listener: _resource_record_pre_action 02:37:39 INFO - Running main action method: create_virtualenv 02:37:39 INFO - Creating virtualenv /builds/slave/test/build/venv 02:37:39 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 02:37:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:37:39 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 02:37:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:37:39 INFO - Using real prefix '/usr' 02:37:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:37:39 INFO - Installing distribute.............................................................................................................................................................................................done. 02:37:41 INFO - Installing pip.................done. 02:37:41 INFO - Return code: 0 02:37:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:37:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:37:42 INFO - Reading from file tmpfile_stdout 02:37:42 INFO - Output received: 02:37:42 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) 02:37:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:37:42 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')]} 02:37:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:42 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')]} 02:37:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:42 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 0x28d41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c45b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c42d00>, '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 0x2c43c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c44090>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1500187430.546621-271104504', '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 02:37:42 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 02:37:42 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 02:37:42 INFO - Using env: {'DISPLAY': ':0', 02:37:42 INFO - 'HOME': '/home/cltbld', 02:37:42 INFO - 'LANG': 'en_US.UTF-8', 02:37:42 INFO - 'LANGUAGE': 'en_US:en', 02:37:42 INFO - 'LOGNAME': 'cltbld', 02:37:42 INFO - 'MAIL': '/var/mail/cltbld', 02:37:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:42 INFO - 'MOZ_NO_REMOTE': '1', 02:37:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:37:42 INFO - 'NO_EM_RESTART': '1', 02:37:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:37:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:42 INFO - 'PWD': '/builds/slave/test', 02:37:42 INFO - 'SHELL': '/bin/bash', 02:37:42 INFO - 'SHLVL': '1', 02:37:42 INFO - 'TERM': 'linux', 02:37:42 INFO - 'TMOUT': '86400', 02:37:42 INFO - 'USER': 'cltbld', 02:37:42 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1500187430.546621-271104504', 02:37:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:42 INFO - '_': '/tools/buildbot/bin/python'} 02:37:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:42 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 02:37:42 INFO - Cleaning up... 02:37:42 INFO - Return code: 0 02:37:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:37:42 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')]} 02:37:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:42 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')]} 02:37:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:42 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 0x28d41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c45b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c42d00>, '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 0x2c43c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c44090>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1500187430.546621-271104504', '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 02:37:42 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 02:37:42 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 02:37:42 INFO - Using env: {'DISPLAY': ':0', 02:37:42 INFO - 'HOME': '/home/cltbld', 02:37:42 INFO - 'LANG': 'en_US.UTF-8', 02:37:42 INFO - 'LANGUAGE': 'en_US:en', 02:37:42 INFO - 'LOGNAME': 'cltbld', 02:37:42 INFO - 'MAIL': '/var/mail/cltbld', 02:37:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:42 INFO - 'MOZ_NO_REMOTE': '1', 02:37:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:37:42 INFO - 'NO_EM_RESTART': '1', 02:37:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:37:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:42 INFO - 'PWD': '/builds/slave/test', 02:37:42 INFO - 'SHELL': '/bin/bash', 02:37:42 INFO - 'SHLVL': '1', 02:37:42 INFO - 'TERM': 'linux', 02:37:42 INFO - 'TMOUT': '86400', 02:37:42 INFO - 'USER': 'cltbld', 02:37:42 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1500187430.546621-271104504', 02:37:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:42 INFO - '_': '/tools/buildbot/bin/python'} 02:37:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:42 INFO - Downloading/unpacking psutil>=3.1.1 02:37: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 02:37: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 02:37: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 02:37: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 02:37:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:37:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:37:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:37:43 INFO - Installing collected packages: psutil 02:37:43 INFO - Running setup.py install for psutil 02:37:43 INFO - building 'psutil._psutil_linux' extension 02:37:43 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 02:37:44 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 02:37:44 INFO - building 'psutil._psutil_posix' extension 02:37:44 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 02:37:44 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 02:37:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:37:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:37:45 INFO - Successfully installed psutil 02:37:45 INFO - Cleaning up... 02:37:45 INFO - Return code: 0 02:37:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:37: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')]} 02:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37: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')]} 02:37:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c45b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c42d00>, '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 0x2c43c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c44090>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1500187430.546621-271104504', '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 02:37: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:37: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 mozsystemmonitor==0.3 02:37:45 INFO - Using env: {'DISPLAY': ':0', 02:37:45 INFO - 'HOME': '/home/cltbld', 02:37:45 INFO - 'LANG': 'en_US.UTF-8', 02:37:45 INFO - 'LANGUAGE': 'en_US:en', 02:37:45 INFO - 'LOGNAME': 'cltbld', 02:37:45 INFO - 'MAIL': '/var/mail/cltbld', 02:37:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:45 INFO - 'MOZ_NO_REMOTE': '1', 02:37:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:37:45 INFO - 'NO_EM_RESTART': '1', 02:37:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:37:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:45 INFO - 'PWD': '/builds/slave/test', 02:37:45 INFO - 'SHELL': '/bin/bash', 02:37:45 INFO - 'SHLVL': '1', 02:37:45 INFO - 'TERM': 'linux', 02:37:45 INFO - 'TMOUT': '86400', 02:37:45 INFO - 'USER': 'cltbld', 02:37:45 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1500187430.546621-271104504', 02:37:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:45 INFO - '_': '/tools/buildbot/bin/python'} 02:37:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:37: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 02:37: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 02:37: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 02:37: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 02:37:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:37:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:37:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:37:46 INFO - Installing collected packages: mozsystemmonitor 02:37:46 INFO - Running setup.py install for mozsystemmonitor 02:37:46 INFO - Successfully installed mozsystemmonitor 02:37:46 INFO - Cleaning up... 02:37:46 INFO - Return code: 0 02:37:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:37:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:37:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:46 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 0x28d41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c45b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c42d00>, '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 0x2c43c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c44090>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1500187430.546621-271104504', '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 02:37:46 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 02:37:46 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 02:37:46 INFO - Using env: {'DISPLAY': ':0', 02:37:46 INFO - 'HOME': '/home/cltbld', 02:37:46 INFO - 'LANG': 'en_US.UTF-8', 02:37:46 INFO - 'LANGUAGE': 'en_US:en', 02:37:46 INFO - 'LOGNAME': 'cltbld', 02:37:46 INFO - 'MAIL': '/var/mail/cltbld', 02:37:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:46 INFO - 'MOZ_NO_REMOTE': '1', 02:37:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:37:46 INFO - 'NO_EM_RESTART': '1', 02:37:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:37:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:46 INFO - 'PWD': '/builds/slave/test', 02:37:46 INFO - 'SHELL': '/bin/bash', 02:37:46 INFO - 'SHLVL': '1', 02:37:46 INFO - 'TERM': 'linux', 02:37:46 INFO - 'TMOUT': '86400', 02:37:46 INFO - 'USER': 'cltbld', 02:37:46 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1500187430.546621-271104504', 02:37:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:46 INFO - '_': '/tools/buildbot/bin/python'} 02:37:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:46 INFO - Downloading/unpacking jsonschema==2.5.1 02:37: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 02:37: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 02:37: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 02:37: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 02:37:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:37:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:37: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 02:37: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 02:37: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 02:37: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 02:37:48 INFO - Downloading functools32-3.2.3-2.tar.gz 02:37:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:37:48 INFO - warning: no files found matching '*.txt' 02:37:48 INFO - no previously-included directories found matching 'build' 02:37:48 INFO - no previously-included directories found matching 'dist' 02:37:48 INFO - no previously-included directories found matching '.git*' 02:37:48 INFO - Installing collected packages: jsonschema, functools32 02:37:48 INFO - Running setup.py install for functools32 02:37:48 INFO - warning: no files found matching '*.txt' 02:37:48 INFO - no previously-included directories found matching 'build' 02:37:48 INFO - no previously-included directories found matching 'dist' 02:37:48 INFO - no previously-included directories found matching '.git*' 02:37:48 INFO - Successfully installed jsonschema functools32 02:37:48 INFO - Cleaning up... 02:37:48 INFO - Return code: 0 02:37:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:37:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:37:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x28d41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c45b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c42d00>, '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 0x2c43c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c44090>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1500187430.546621-271104504', '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 02:37:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:37:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:37:48 INFO - Using env: {'DISPLAY': ':0', 02:37:48 INFO - 'HOME': '/home/cltbld', 02:37:48 INFO - 'LANG': 'en_US.UTF-8', 02:37:48 INFO - 'LANGUAGE': 'en_US:en', 02:37:48 INFO - 'LOGNAME': 'cltbld', 02:37:48 INFO - 'MAIL': '/var/mail/cltbld', 02:37:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:48 INFO - 'MOZ_NO_REMOTE': '1', 02:37:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:37:48 INFO - 'NO_EM_RESTART': '1', 02:37:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:37:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:48 INFO - 'PWD': '/builds/slave/test', 02:37:48 INFO - 'SHELL': '/bin/bash', 02:37:48 INFO - 'SHLVL': '1', 02:37:48 INFO - 'TERM': 'linux', 02:37:48 INFO - 'TMOUT': '86400', 02:37:48 INFO - 'USER': 'cltbld', 02:37:48 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1500187430.546621-271104504', 02:37:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:48 INFO - '_': '/tools/buildbot/bin/python'} 02:37:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:37:48 INFO - Cleaning up... 02:37:48 INFO - Return code: 0 02:37:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:37:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:37:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x28d41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c45b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c42d00>, '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 0x2c43c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c44090>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1500187430.546621-271104504', '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 02:37:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:37:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:37:48 INFO - Using env: {'DISPLAY': ':0', 02:37:48 INFO - 'HOME': '/home/cltbld', 02:37:48 INFO - 'LANG': 'en_US.UTF-8', 02:37:48 INFO - 'LANGUAGE': 'en_US:en', 02:37:48 INFO - 'LOGNAME': 'cltbld', 02:37:48 INFO - 'MAIL': '/var/mail/cltbld', 02:37:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:48 INFO - 'MOZ_NO_REMOTE': '1', 02:37:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:37:48 INFO - 'NO_EM_RESTART': '1', 02:37:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:37:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:48 INFO - 'PWD': '/builds/slave/test', 02:37:48 INFO - 'SHELL': '/bin/bash', 02:37:48 INFO - 'SHLVL': '1', 02:37:48 INFO - 'TERM': 'linux', 02:37:48 INFO - 'TMOUT': '86400', 02:37:48 INFO - 'USER': 'cltbld', 02:37:48 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1500187430.546621-271104504', 02:37:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:48 INFO - '_': '/tools/buildbot/bin/python'} 02:37:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:48 INFO - Downloading/unpacking blobuploader==1.2.4 02:37:48 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 02:37:48 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 02:37:48 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 02:37:48 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 02:37:49 INFO - Downloading blobuploader-1.2.4.tar.gz 02:37:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:37:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:37:49 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 02:37:49 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 02:37:49 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 02:37:49 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 02:37:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:37:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:50 INFO - Downloading docopt-0.6.1.tar.gz 02:37:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:37:50 INFO - Installing collected packages: blobuploader, requests, docopt 02:37:50 INFO - Running setup.py install for blobuploader 02:37:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:37:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:37:50 INFO - Running setup.py install for requests 02:37:50 INFO - Running setup.py install for docopt 02:37:50 INFO - Successfully installed blobuploader requests docopt 02:37:50 INFO - Cleaning up... 02:37:51 INFO - Return code: 0 02:37:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:37: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')]} 02:37:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37: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')]} 02:37:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:51 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 0x28d41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c45b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c42d00>, '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 0x2c43c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c44090>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1500187430.546621-271104504', '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 02:37:51 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 02:37:51 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 02:37:51 INFO - Using env: {'DISPLAY': ':0', 02:37:51 INFO - 'HOME': '/home/cltbld', 02:37:51 INFO - 'LANG': 'en_US.UTF-8', 02:37:51 INFO - 'LANGUAGE': 'en_US:en', 02:37:51 INFO - 'LOGNAME': 'cltbld', 02:37:51 INFO - 'MAIL': '/var/mail/cltbld', 02:37:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:51 INFO - 'MOZ_NO_REMOTE': '1', 02:37:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:37:51 INFO - 'NO_EM_RESTART': '1', 02:37:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:37:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:51 INFO - 'PWD': '/builds/slave/test', 02:37:51 INFO - 'SHELL': '/bin/bash', 02:37:51 INFO - 'SHLVL': '1', 02:37:51 INFO - 'TERM': 'linux', 02:37:51 INFO - 'TMOUT': '86400', 02:37:51 INFO - 'USER': 'cltbld', 02:37:51 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1500187430.546621-271104504', 02:37:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:51 INFO - '_': '/tools/buildbot/bin/python'} 02:37:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:37:51 INFO - Running setup.py (path:/tmp/pip-zRFIce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:37:51 INFO - Running setup.py (path:/tmp/pip-l4FUYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:37:51 INFO - Running setup.py (path:/tmp/pip-MXkZWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:37:51 INFO - Running setup.py (path:/tmp/pip-5phGxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:37:51 INFO - Running setup.py (path:/tmp/pip-98PtcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:37:51 INFO - Running setup.py (path:/tmp/pip-heWiqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:37:51 INFO - Running setup.py (path:/tmp/pip-dzlGMg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:37:51 INFO - Running setup.py (path:/tmp/pip-D09T2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:37:51 INFO - Running setup.py (path:/tmp/pip-JiQTAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:37:51 INFO - Running setup.py (path:/tmp/pip-s2utBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:37:51 INFO - Running setup.py (path:/tmp/pip-4GqoVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:37:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:37:51 INFO - Running setup.py (path:/tmp/pip-fQP1Fm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:37:52 INFO - Running setup.py (path:/tmp/pip-8ZqWzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:37:52 INFO - Running setup.py (path:/tmp/pip-PKgyYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:37:52 INFO - Running setup.py (path:/tmp/pip-ywCTlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:37:52 INFO - Running setup.py (path:/tmp/pip-0cPui1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:37:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:37:52 INFO - Running setup.py (path:/tmp/pip-l7HujE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:37:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:37:52 INFO - Running setup.py install for manifestparser 02:37:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:37:52 INFO - Running setup.py install for mozcrash 02:37:52 INFO - Running setup.py install for mozdebug 02:37:52 INFO - Running setup.py install for mozdevice 02:37:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:37:52 INFO - Running setup.py install for mozfile 02:37:52 INFO - Running setup.py install for mozhttpd 02:37:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:37:53 INFO - Running setup.py install for mozinfo 02:37:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:37:53 INFO - Running setup.py install for mozInstall 02:37:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:37:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:37:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:37:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:37:53 INFO - Running setup.py install for mozleak 02:37:53 INFO - Running setup.py install for mozlog 02:37:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:37:53 INFO - Running setup.py install for moznetwork 02:37:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:37:53 INFO - Running setup.py install for mozprocess 02:37:53 INFO - Running setup.py install for mozprofile 02:37:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:37:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:37:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:37:53 INFO - Running setup.py install for mozrunner 02:37:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:37:53 INFO - Running setup.py install for mozscreenshot 02:37:53 INFO - Running setup.py install for moztest 02:37:54 INFO - Running setup.py install for mozversion 02:37:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:37:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:37:54 INFO - Cleaning up... 02:37:54 INFO - Return code: 0 02:37:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:37: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')]} 02:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37: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')]} 02:37:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:54 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 0x28d41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c45b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c42d00>, '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 0x2c43c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c44090>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1500187430.546621-271104504', '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 02:37:54 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 02:37:54 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 02:37:54 INFO - Using env: {'DISPLAY': ':0', 02:37:54 INFO - 'HOME': '/home/cltbld', 02:37:54 INFO - 'LANG': 'en_US.UTF-8', 02:37:54 INFO - 'LANGUAGE': 'en_US:en', 02:37:54 INFO - 'LOGNAME': 'cltbld', 02:37:54 INFO - 'MAIL': '/var/mail/cltbld', 02:37:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:54 INFO - 'MOZ_NO_REMOTE': '1', 02:37:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:37:54 INFO - 'NO_EM_RESTART': '1', 02:37:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:37:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:54 INFO - 'PWD': '/builds/slave/test', 02:37:54 INFO - 'SHELL': '/bin/bash', 02:37:54 INFO - 'SHLVL': '1', 02:37:54 INFO - 'TERM': 'linux', 02:37:54 INFO - 'TMOUT': '86400', 02:37:54 INFO - 'USER': 'cltbld', 02:37:54 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1500187430.546621-271104504', 02:37:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:54 INFO - '_': '/tools/buildbot/bin/python'} 02:37:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:37:54 INFO - Running setup.py (path:/tmp/pip-AtFONU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:37:54 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)) 02:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:37:54 INFO - Running setup.py (path:/tmp/pip-U8H6QM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:37:54 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)) 02:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:37:54 INFO - Running setup.py (path:/tmp/pip-m4zkZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:37:54 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)) 02:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:37:54 INFO - Running setup.py (path:/tmp/pip-S8DMF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:37:54 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)) 02:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:37:54 INFO - Running setup.py (path:/tmp/pip-RV1cC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:37:54 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)) 02:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:37:54 INFO - Running setup.py (path:/tmp/pip-MlUqEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:37:54 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)) 02:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:37:54 INFO - Running setup.py (path:/tmp/pip-GeEWzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:37:54 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)) 02:37:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:37:54 INFO - Running setup.py (path:/tmp/pip-QsSt7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:37:55 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)) 02:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:37:55 INFO - Running setup.py (path:/tmp/pip-PmfwcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:37:55 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)) 02:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:37:55 INFO - Running setup.py (path:/tmp/pip-M8PKvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:37:55 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)) 02:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:37:55 INFO - Running setup.py (path:/tmp/pip-l2PrMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:37:55 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)) 02:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:37:55 INFO - Running setup.py (path:/tmp/pip-OA12w0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:37:55 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)) 02:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:37:55 INFO - Running setup.py (path:/tmp/pip-3qHEjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:37:55 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)) 02:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:37:55 INFO - Running setup.py (path:/tmp/pip-vzoYkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:37:55 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)) 02:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:37:55 INFO - Running setup.py (path:/tmp/pip-sLn_yI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:37:55 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)) 02:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:37:55 INFO - Running setup.py (path:/tmp/pip-uPuxJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:37:55 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)) 02:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:37:55 INFO - Running setup.py (path:/tmp/pip-U5fUkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:37:55 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)) 02:37:55 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)) 02:37:55 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)) 02:37:55 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)) 02:37:55 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)) 02:37:55 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)) 02:37:55 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)) 02:37:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:37: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 02:37: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 02:37: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 02:37: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 02:37:56 INFO - Downloading blessings-1.6.tar.gz 02:37:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:37:56 INFO - Installing collected packages: blessings 02:37:56 INFO - Running setup.py install for blessings 02:37:56 INFO - Successfully installed blessings 02:37:56 INFO - Cleaning up... 02:37:57 INFO - Return code: 0 02:37:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:37:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:37:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:37:57 INFO - Reading from file tmpfile_stdout 02:37:57 INFO - Current package versions: 02:37:57 INFO - argparse == 1.2.1 02:37:57 INFO - blessings == 1.6 02:37:57 INFO - blobuploader == 1.2.4 02:37:57 INFO - docopt == 0.6.1 02:37:57 INFO - functools32 == 3.2.3-2 02:37:57 INFO - jsonschema == 2.5.1 02:37:57 INFO - manifestparser == 1.1 02:37:57 INFO - mozInstall == 1.13 02:37:57 INFO - mozcrash == 1.0 02:37:57 INFO - mozdebug == 0.1 02:37:57 INFO - mozdevice == 0.51 02:37:57 INFO - mozfile == 1.2 02:37:57 INFO - mozhttpd == 0.7 02:37:57 INFO - mozinfo == 0.10 02:37:57 INFO - mozleak == 0.1 02:37:57 INFO - mozlog == 3.5 02:37:57 INFO - moznetwork == 0.27 02:37:57 INFO - mozprocess == 0.25 02:37:57 INFO - mozprofile == 0.28 02:37:57 INFO - mozrunner == 6.13 02:37:57 INFO - mozscreenshot == 0.1 02:37:57 INFO - mozsystemmonitor == 0.3 02:37:57 INFO - moztest == 0.8 02:37:57 INFO - mozversion == 1.4 02:37:57 INFO - psutil == 3.1.1 02:37:57 INFO - requests == 1.2.3 02:37:57 INFO - wsgiref == 0.1.2 02:37:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:37:57 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')]} 02:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:37:57 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')]} 02:37:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:37:57 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 0x28d41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c45b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c42d00>, '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 0x2c43c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c44090>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1500187430.546621-271104504', '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 02:37:57 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 02:37:57 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 02:37:57 INFO - Using env: {'DISPLAY': ':0', 02:37:57 INFO - 'HOME': '/home/cltbld', 02:37:57 INFO - 'LANG': 'en_US.UTF-8', 02:37:57 INFO - 'LANGUAGE': 'en_US:en', 02:37:57 INFO - 'LOGNAME': 'cltbld', 02:37:57 INFO - 'MAIL': '/var/mail/cltbld', 02:37:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:37:57 INFO - 'MOZ_NO_REMOTE': '1', 02:37:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:37:57 INFO - 'NO_EM_RESTART': '1', 02:37:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:37:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:37:57 INFO - 'PWD': '/builds/slave/test', 02:37:57 INFO - 'SHELL': '/bin/bash', 02:37:57 INFO - 'SHLVL': '1', 02:37:57 INFO - 'TERM': 'linux', 02:37:57 INFO - 'TMOUT': '86400', 02:37:57 INFO - 'USER': 'cltbld', 02:37:57 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1500187430.546621-271104504', 02:37:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:37:57 INFO - '_': '/tools/buildbot/bin/python'} 02:37:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:37:57 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)) 02:37:57 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)) 02:37:57 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)) 02:37:57 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)) 02:37:57 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)) 02:37:57 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)) 02:37:57 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)) 02:37:57 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)) 02:37:57 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)) 02:37:57 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 02:37:57 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 02:37:57 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 02:37:57 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 02:37:57 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 02:37:58 INFO - Downloading marionette_driver-1.4.0.tar.gz 02:37:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 02:37:58 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 02:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:37:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:37:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 02:37:58 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)) 02:37:58 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)) 02:37:58 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)) 02:37:58 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)) 02:37:58 INFO - Installing collected packages: marionette-driver, simplejson 02:37:58 INFO - Running setup.py install for marionette-driver 02:37:58 INFO - Running setup.py install for simplejson 02:37:59 INFO - building 'simplejson._speedups' extension 02:37:59 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 02:37:59 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 02:37:59 INFO - Successfully installed marionette-driver simplejson 02:37:59 INFO - Cleaning up... 02:38:00 INFO - Return code: 0 02:38:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:38:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:38:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:38:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:38:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28d41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c45b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c42d00>, '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 0x2c43c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c44090>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1500187430.546621-271104504', '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 02:38:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:38:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:38:00 INFO - Using env: {'DISPLAY': ':0', 02:38:00 INFO - 'HOME': '/home/cltbld', 02:38:00 INFO - 'LANG': 'en_US.UTF-8', 02:38:00 INFO - 'LANGUAGE': 'en_US:en', 02:38:00 INFO - 'LOGNAME': 'cltbld', 02:38:00 INFO - 'MAIL': '/var/mail/cltbld', 02:38:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:00 INFO - 'MOZ_NO_REMOTE': '1', 02:38:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:00 INFO - 'NO_EM_RESTART': '1', 02:38:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:00 INFO - 'PWD': '/builds/slave/test', 02:38:00 INFO - 'SHELL': '/bin/bash', 02:38:00 INFO - 'SHLVL': '1', 02:38:00 INFO - 'TERM': 'linux', 02:38:00 INFO - 'TMOUT': '86400', 02:38:00 INFO - 'USER': 'cltbld', 02:38:00 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1500187430.546621-271104504', 02:38:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:00 INFO - '_': '/tools/buildbot/bin/python'} 02:38:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:38:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:38:00 INFO - Cleaning up... 02:38:00 INFO - Return code: 0 02:38:00 INFO - Running post-action listener: _resource_record_post_action 02:38:00 INFO - Running post-action listener: _start_resource_monitoring 02:38:00 INFO - Starting resource monitoring. 02:38:00 INFO - [mozharness: 2017-07-16 09:38:00.284827Z] Finished create-virtualenv step (success) 02:38:00 INFO - [mozharness: 2017-07-16 09:38:00.285799Z] Running install step. 02:38:00 INFO - Running pre-action listener: _resource_record_pre_action 02:38:00 INFO - Running main action method: install 02:38:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:38:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:38:00 INFO - Reading from file tmpfile_stdout 02:38:00 INFO - Detecting whether we're running mozinstall >=1.0... 02:38:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:38:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:38:00 INFO - Reading from file tmpfile_stdout 02:38:00 INFO - Output received: 02:38:00 INFO - Usage: mozinstall [options] installer 02:38:00 INFO - Options: 02:38:00 INFO - -h, --help show this help message and exit 02:38:00 INFO - -d DEST, --destination=DEST 02:38:00 INFO - Directory to install application into. [default: 02:38:00 INFO - "/builds/slave/test"] 02:38:00 INFO - --app=APP Application being installed. [default: firefox] 02:38:00 INFO - mkdir: /builds/slave/test/build/application 02:38:00 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'] 02:38:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 02:38:18 INFO - Reading from file tmpfile_stdout 02:38:18 INFO - Output received: 02:38:18 INFO - /builds/slave/test/build/application/firefox/firefox 02:38:18 INFO - Running post-action listener: _resource_record_post_action 02:38:18 INFO - [mozharness: 2017-07-16 09:38:18.565152Z] Finished install step (success) 02:38:18 INFO - [mozharness: 2017-07-16 09:38:18.565407Z] Running setup-mitmproxy step. 02:38:18 INFO - Running pre-action listener: _resource_record_pre_action 02:38:18 INFO - Running main action method: setup_mitmproxy 02:38:18 INFO - Skipping: mitmproxy is not required 02:38:18 INFO - Running post-action listener: _resource_record_post_action 02:38:18 INFO - [mozharness: 2017-07-16 09:38:18.566621Z] Finished setup-mitmproxy step (success) 02:38:18 INFO - [mozharness: 2017-07-16 09:38:18.566843Z] Running run-tests step. 02:38:18 INFO - Running pre-action listener: _resource_record_pre_action 02:38:18 INFO - Running pre-action listener: _set_gcov_prefix 02:38:18 INFO - Running main action method: run_tests 02:38:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:38:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:38:18 INFO - Python 2.7.3 02:38:18 INFO - Return code: 0 02:38:18 INFO - grabbing minidump binary from tooltool 02:38:18 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')]} 02:38:18 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 0x2c42d00>, '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 0x2c43c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c44090>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:38:18 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 02:38:18 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 02:38:18 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 02:38:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:38:18 INFO - Return code: 0 02:38:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:38:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:38:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:38:18 INFO - ENV: RUST_BACKTRACE is now 1 02:38:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:38:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:38:18 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/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:38:18 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/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:38:18 INFO - Using env: {'DISPLAY': ':0', 02:38:18 INFO - 'HOME': '/home/cltbld', 02:38:18 INFO - 'LANG': 'en_US.UTF-8', 02:38:18 INFO - 'LANGUAGE': 'en_US:en', 02:38:18 INFO - 'LOGNAME': 'cltbld', 02:38:18 INFO - 'MAIL': '/var/mail/cltbld', 02:38:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:38:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:38:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:38:18 INFO - 'MOZ_NO_REMOTE': '1', 02:38:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:38:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:38:18 INFO - 'NO_EM_RESTART': '1', 02:38:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:38:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:38:18 INFO - 'PWD': '/builds/slave/test', 02:38:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:38:18 INFO - 'RUST_BACKTRACE': '1', 02:38:18 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 02:38:18 INFO - 'SHELL': '/bin/bash', 02:38:18 INFO - 'SHLVL': '1', 02:38:18 INFO - 'TERM': 'linux', 02:38:18 INFO - 'TMOUT': '86400', 02:38:18 INFO - 'USER': 'cltbld', 02:38:18 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1500187430.546621-271104504', 02:38:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:38:18 INFO - '_': '/tools/buildbot/bin/python'} 02:38:18 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/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:38:18 INFO - mozversion application_buildid: 20170716085807 02:38:18 INFO - mozversion application_changeset: b4e656e5a996dd385e9af43a4d9e207553377c51 02:38:18 INFO - mozversion application_display_name: Nightly 02:38:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:38:18 INFO - mozversion application_name: Firefox 02:38:18 INFO - mozversion application_remotingname: firefox 02:38:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 02:38:18 INFO - mozversion application_vendor: Mozilla 02:38:18 INFO - mozversion application_version: 56.0a1 02:38:18 INFO - mozversion platform_buildid: 20170716085807 02:38:18 INFO - mozversion platform_changeset: b4e656e5a996dd385e9af43a4d9e207553377c51 02:38:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 02:38:18 INFO - mozversion platform_version: 56.0a1 02:38:18 INFO - using testdate: 1500197898 02:38:18 INFO - actual date: 1500197898 02:38:18 INFO - starting webserver on 'localhost:43262' 02:38:18 INFO - SUITE-START | Running 2 tests 02:38:18 INFO - TEST-START | dromaeo_css 02:38:18 INFO - Initialising browser for dromaeo_css test... 02:38:19 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43262/getInfo.html -profile /tmp/tmpVKcCz0/profile 02:38:19 INFO - TEST-INFO | started process 3338 (/builds/slave/test/build/application/firefox/firefox http://localhost:43262/getInfo.html) 02:38:28 INFO - TEST-INFO | 3338: exit 0 02:38:28 INFO - Browser initialized. 02:38:28 INFO - Running cycle 1/1 for dromaeo_css test... 02:38:28 INFO - TEST-INFO | started process 3565 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVKcCz0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:38:39 INFO - PID 3565 | RSS: Main: 173498368 02:38:39 INFO - PID 3565 | 02:41:38 INFO - PID 3565 | Cycle 1(1): loaded http://localhost:43262/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43262/tests/dromaeo/cssquery-ext.html) 02:41:39 INFO - PID 3565 | RSS: Main: 178376704 02:41:39 INFO - PID 3565 | 02:44:41 INFO - PID 3565 | Cycle 1(1): loaded http://localhost:43262/tests/dromaeo/cssquery-ext.html (next: http://localhost:43262/tests/dromaeo/cssquery-jquery.html) 02:44:41 INFO - PID 3565 | RSS: Main: 176934912 02:44:41 INFO - PID 3565 | 02:47:43 INFO - PID 3565 | Cycle 1(1): loaded http://localhost:43262/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43262/tests/dromaeo/cssquery-mootools.html) 02:47:44 INFO - PID 3565 | RSS: Main: 179380224 02:47:44 INFO - PID 3565 | 02:50:45 INFO - PID 3565 | Cycle 1(1): loaded http://localhost:43262/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43262/tests/dromaeo/cssquery-prototype.html) 02:50:46 INFO - PID 3565 | RSS: Main: 177905664 02:50:46 INFO - PID 3565 | 02:53:49 INFO - PID 3565 | Cycle 1(1): loaded http://localhost:43262/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43262/tests/dromaeo/cssquery-yui.html) 02:53:50 INFO - PID 3565 | RSS: Main: 177123328 02:53:50 INFO - PID 3565 | 02:56:52 INFO - PID 3565 | Cycle 1(1): loaded http://localhost:43262/tests/dromaeo/cssquery-yui.html (next: http://localhost:43262/tests/dromaeo/cssquery-dojo.html) 02:56:52 INFO - PID 3565 | RSS: Main: 180355072 02:56:52 INFO - PID 3565 | 02:56:52 INFO - PID 3565 | __start_tp_report 02:56:52 INFO - PID 3565 | _x_x_mozilla_page_load 02:56:52 INFO - PID 3565 | _x_x_mozilla_page_load_details 02:56:52 INFO - PID 3565 | |i|pagename|runs| 02:56:52 INFO - PID 3565 | |0;dojo.html;3055.694430556946;3088.227943014245;3099.4421004219244;3109.6890310968906;3119.578856854324;5965.9701701491485;5992.3108842483125;5994.190784244126;6006.699665016748;6089.269287685473;6059.515238780898;6082.878342433149;6098.451139397464;6099.237595300588;6100.725467353968;5563.554915606742;5591.30108736407;5610;5627.409122042188;5648.435156484339;5619.662820230778;5625.099984002561;5634.239377684022;5641.68970706611;5642.2100905873;5610.747516361753;5610.915836262459;5641.2384328115795;5646.068398714207;5649.096144616862;5633.605647604629;5641.548676105902;5656.773729050833;5660.801871934463;5661.348944871331;5568.1647752837;5603.411641777596;5617.297837770278;5620.494155525981;5714.79998200061;6111.724972376253;6148.262208534959;6149.754009839601;6216.2851272103835;6242.531810114214;6352.237731472253;6520.315366886503;6547;6624.171978502687;6635.834104147387;6492.7402903883785;6553.508486863504;6623.569467984566;6687.49843761715;6705.932940670579;6134.079888016789;6145.784897528565;6155.045967874987;6157.4458298753325;6167.660778657172;6664.666766661648;6695.230048544382;6747.257801641816;6750.561213521106;6777.593344399352;6351.650659213788;6389.808305750835;6409.487241020707;6478.805635830932;6506.869862602722;6387.265464471552;6468.579542329733;6489.091527186198;6565;6566.1135746674545;6006.879862402815;6516.869662606816;6523.347665233438;6628.4697224221945;6629.569078009914;6543.411093001652;6562.639054852029;6580.539362244597;6642.070110184578;6686.933130668728;5252.159654455345;5369.892602147936;5440.483154100354;5441.265429167091;5442.646227995247;4486.730796152241;4499.6400287976885;4500.369948207253;4510.143072816154;4535.4103966484145;5520.53075488588;5525.640833345819;5534.861628459321;5549.139883318092;5562.443755624486;6346.968265158737;6374.235091789015;6390;6400.743970241231;6449.032645103178;5486.259354987025;5528.530074943675;5531.640443371168;5539.889202215933;5544.584156188302;5580.107182850725;5667.858303542444;5669.149627555899;5697.088465845445;5718.4567466091485;6220.284667263232;6306.463950564162;6327.557071004985;6383.840403989938;6396.648184349905;6538.574992625464;6558.344165583403;6639.435647969976;6660.400563949268;6678.532502724957;6343.809685709436;6345.809625711236;6413.839654008687;6448.193975753031;6465.967670161807;6377.1390862233;6423.454006409321;6433.970564709811;6450;6452.161219041494;6599.241087275025;6613.768518101843;6621.238557565942;6630.83422914431;6723.562968407038;6357.777477788441;6368.172137622079;6426.518011149276;6450.129232553733;6499.415052645285;6368.299487056327;6372.968135159294;6451.290358060516;6485.708143133476;6519.902201467076;6259.405356491126;6353.745850165941;6359.491240700825;6361.395667411589;6364.363563643784;6243.531735119794;6301.054841773771;6309.905351419824;6322.241331040121;6367.267764207176;6056.878862422815;6193.504519638508;6203.472704820141;6253.5622506424115;6255.562110652393 02:56:52 INFO - PID 3565 | |1;ext.html;763.7746864674921;778.5717855179657;810.5784991804261;840.8108175660475;849.6558893648074;38521.22957540848;39060.21879562407;39308.41037384438;39391.60608393915;39411.21177576447;36349;36765.26469470616;36819.263614727686;36839.81580092096;36874;6672.466202703797;6764.729410823561;6768.560043597175;6797.7960661179995;6805.863882722368;6701.43037841784;6807.115075040263;6808.2170550386845;6834.726610935557;6837.247902730695;6782.966085169592;6802.829929251783;6803.387695107439;6813.7955861324235;6816.420604248645;6735.292794256606;6744.561603495807;6745.426638735713;6746.662666866661;6756.459483241329;6036.396360363929;6044.184035155242;6054.273487181523;6056.636601803862;6085.148079268906;31858.522122168186;31859.840700796347;32057.679423205704;32143.51784723231;32149.357012859844;3291.8643068141455;3312.668733126692;3329.8335083245743;3340.1315657929113;3350.363430948112;25933.481330373288;26122.085726999463;26136.215913522625;26262.868685656642;26287.60568591473;4122.154958233555;4221.282381995068;4243.151369726036;4256.957430425687;4314.309710446313;188313.0584347083;189082;190251;194756;195577;40989;46561.5343846564;47833.52166478291;48476.27285590719;48511;50206.24690629644;50265.497345026815;50481.747591262545;50497.242541361906;50683.49316506861;15940.92029539845;16018.27917743681;16047.438339658056;16062.751214829934;16114.838851611568;13335.93332033353;13338.266395348155;13387.397567109503;13393.665158370924;13402;12836.48654053846;13057.934710326388;13115.672108197181;13159.144655597547;13212.339383031001;5355.758990845421;5453.372862120827;5465.453454654503;5476.397596264408;5595.104783234663;950.1591091883595;983.1397527163732;996.3722854601555;1021.5249908792447;1025.2413214221572;22113.115475380804;22297.777022229893;22491.66262506064;22679.773202268098;22783.772162278496;1093.7156339351825;1097.1348707197797;1117.6088369070924;1124.9887501124883;1140.7433327501246;11535.596254131066;11741.941290293495;11779.352135632622;11839.993600543878;11898.881011189951;207325;208862;209182;209552;209838;50376.748116259914;50761.74619126954;50790.49209507932;50882.236766448535;50938.490615093375;1460.3282490054694;1468.4493315006873;1486.3311509820624;1509.8112735908012;1521.5359315408684;21758.347249582537;21881.234156804436;21907.780922190574;22250.554988900454;26244;50333.49666503288;50631.49368506415;50643.74678126586;50741.23888141607;50769.746151269006;206520;208512;209492;209701;210153;29228.707712922598;29912.55131173078;31217.53173702351;32670.50994235136;32934.176645583095;42066.789666051474;43289.783551082044;43863.34204986864;44114.55885441104;44309;30463.695363046085;30738;31945.520817188226;32166;32362.029139125865;30817.69182308148;31119.844400777853;31509;31524.684753152174;31563.684363156994;36578.8171059143;37411.25177496489;37454.81272593619;37488.625113748516;37489.87530374093;29872.701272987862;30610.693893060783;31353.216169595944;31859.681403186598;31929.201769955936;23441.296761097194;23892.88053559721;24046.27861164168;24100.51798964046;24351.51296974015 02:56:52 INFO - PID 3565 | |2;jquery.html;560.655197053812;561.8511094559942;566.5241197394188;581.0963951056108;586.3872253495097;16275.104869232187;21830.345089647297;22731.659025114594;22788.430289242777;22843.972021259062;18903.52741181471;19341.323053693122;19394.418167454965;22079.779202207974;22452.887817979947;3847.1536262022382;3948.0722030322995;4000.7799571023584;4008.178323443687;6511.837204069912;6437.324080971477;6519.282878883319;6536.084948107269;6539.607623542579;6544.967275163642;6505;6516.283208847023;6520.31536688648;6527.445167160797;6528.445082168021;6490.188726409199;6498.9350106498805;6499.805005849832;6505.772297969572;6509.544331896769;3591.371509985768;3783.3190025795348;3819.3316169670475;6037.63774173551;6051;26533.3366665833;28030.719692803013;28276.575851362246;28327.858360708065;28450.857745711346;1892.7255547945472;1923.4902750771057;1929.807019298073;1931.7102434634776;1936.4287535177157;17374.826251737446;18030.188641511162;18549.907250463795;18595.907020464812;18640.974746389078;2243.2933625907785;2325.081592770846;2359.905603775847;2378.6669866218745;2381.0951838301507;124169;129449;131419;131502.3424882879;131961.34019329937;13812.723745525032;13902.721945561032;14024.649383765487;14058.71882562343;14341.856581434053;21853.344399668036;21914;21992.89003554972;22041.669374959387;22073.448163796034;9614.807703845883;9841.704748857546;9870.950645246729;9954.37121738395;10140.340877842917;9193.770155746026;9219.90780092204;9258.259339252843;9458.385204961656;9551.42691438516;8813.69152079687;8836.911630883738;8876.778080548038;8973.237274831712;9034.277257819358;2430.3559556717482;2431.951360972806;2476.5294594027077;2508.2851387354517;2525.356034211264;965.8454647256546;968.6752432740487;990.9256805739599;1007.8034783217203;1020.3673722292226;18483.260669573334;18575.81424185741;18598.628027439645;18826.62346753057;18981.240750370107;1033.2859288136617;1058.142904247562;1073.1682945716975;1079.8974097460887;1084.4631907205983;10372.688819335432;10405.53175107122;10517.316374435637;10588.841167382496;10618.522166502526;472326;544078;546396;548385;548789;118488;120778.3961080189;123422.38288808499;124825.37587312005;124850;1235.5613757116273;1261.413442749126;1310.4692599497218;1317.8945684345038;1318.3342412081838;18733.90633046826;19428.222871085;19800.90099549493;19942;20103.497412564804;53793.73103134459;57455.712721436124;57686.423135768106;59181.40818591759;60209;69755.30244697692;69844.30155698581;70139.64930175316;70775.29224707687;70911.64544177246;13914.860851391357;14228.861691064483;14241.928790355982;14273.57179284623;14283.357248923616;20731.68902466434;21334.786652133902;21639.891800540896;22082.779172208073;22512;17210.483685489457;17282.65434691324;17445.738313925554;17456.82543174552;17468.47594572165;15653.295601698179;16225.269862855963;16284.43004494837;17123.22945467482;17153.399631012853;16967.23647435893;17233.138343083046;17903.73144402861;19250.65245432806;19468.123934423267;14192.574222773334;14354;19959.700604490652;20997;21106.261280855095;18633;18645.72031419557;18892.905535472233;19247.90376048111;19404.12681429367 02:56:52 INFO - PID 3565 | |3;mootools.html;1330.6540299522123;1371.7667996440605;1394.7001394700137;1395.0931894268724;1397.9999999999993;13234.272115033682;13922.86077139227;13946.093503922251;13952.511662091829;13961.930190349034;13415.731685366287;13895.722085558284;13922.721545569082;13944.442222311096;13959.651008724786;2578.2523068310165;2622.8032897532667;2634.3809204836944;2637.696664883534;2644.8016398770073;2556.2075756515446;2607.3742301847515;2634.2624065261757;2636.9472610547778;2640.7095219525836;2525.684289463817;2544.5165418570505;2552.629868669042;2564.9615255771178;2571.0872640212738;2520.395105174763;2536.885840137189;2542.834715743471;2549.7195308516048;2550.5409026375246;2441.340837973737;2466.519028789387;2468.8518688878726;2477.752224777526;2486.788622967032;13322.666933326647;13669.316534173351;13671.043026988114;13674.726505469935;13677.110987785762;7319.121705395387;7587.089549254069;7624.580648064354;7631.503952243086;7638.656260468292;4884.853454396374;4990.5508504234795;5084.313617661605;5105.5149760772665;5148.897022059576;1821.4808779497912;1834.5230240137528;1850.0842083168784;1883.3502441657606;1895.8672892897503;20553.38339849807;21331.253406130712;21713.457163570878;22022.669659954954;22183.556328873492;5741.942580574224;6190.3190649028575;6345.968270158712;6422.582532135396;6466.870662586722;15283.61790955235;15302.158381289137;15441.5367538974;15463;15463.690726185414;7154.4634152438775;7302.123745150616;7310.780676579711;7329.157146928065;7333.88999165013;6926.826829329307;6953.443724502028;6996.510244282953;7029.29707029293;7050.189228238818;4856.660033797601;5001.64988450805;5003.974980125076;5036.5718913892;5192.169252919591;1485.6657252118187;1493.887958403124;1503.1131632336974;1508.8340282568909;1511.7127745728276;879.0681877210178;879.7756572074209;898.6315610599753;901.3915606965272;907.6188001039579;6937;7105.46708996817;7172.390346820474;7236.565806051653;7251.601161936039;713.6931119618614;718.3211864787726;720.6432815756234;729.8795698709654;735.3712575747766;4564.42944631921;4940.357753492095;5006.874828129326;5052.545270925634;5131.61512886535;17678.911605441892;18347.17437715306;18550.44348669542;18652;18920.905395473208;18156.36452724175;18647.254109835725;18675.626487470174;18895.811041889407;19029.61940761177;10522.684319470582;10760;10804.78390432187;10971.23201375896;11005.724856878482;7548.773536793905;7743.728969486041;7861.449698521277;7928.484648497829;8093.231143041402;15767.68464630678;16088.758668619746;16294.67410651804;16345.591360215614;16372.83627163713;16240.91879540642;16358.591035224215;16708.916455417646;17257.56856078608;17354.566135846704;10378.910214427377;10528.36829790215;11202.43987800623;11588.594399195988;11714.76570468603;12054.578089766816;12161;12201.877981220074;12217.938910305747;12252;10202.540885660015;10513.78972420532;10721.731956701145;10728.195385346286;11129.83305250438;10370.170386369224;10474.947625261824;10557.841632375366;10659.093977011731;10761.354318740901;8980.910190898006;9083.68207112748;9205.631774728936;9301.116393942564;9317.208037316905;6842.178938527409;7070.328318809705;7236.467805204302;7259.310365515267;7312.415006799337;6875.48433867472;6901.89647155283;6961.920902260158;6999;7027.578345299298 02:56:52 INFO - PID 3565 | |4;prototype.html;475.1399966061427;499.6452518711716;507.8425688036708;516.5635038392562;525.8133362656257;6035.456808887199;6078.87842243156;6102.2067131272925;6135;6144.969275153623;5907.468327850493;5946.375630558794;6010.909836352458;6015.0751759437;6032.215811944452;4902.411710594716;4903.53416425439;4910.680805747615;4937.851864444055;4949.277897156568;4808.422989241296;4865.464798872121;4880.780364883589;4912.828051018215;4926.926096108561;4881.414230292352;4889.6821706589135;4899.167141585921;4906.484819093997;4925.359703238574;4687.906241875177;4801.223547287508;4844.249141383056;4856.39295088114;4860.878478038042;4323.913521729579;4327.788219298602;4373.2565463871215;4389.956100438987;4397.966477877696;5834.708264586754;5890.587658863881;5909.8818023639715;5911.29064512257;5913;5479.1781232815;5543.168524721284;5560.2493663355335;5565.554755619541;5599;6373.3945275198785;6411.493299074714;6441.516886233504;6455.61266324022;6486.254080780676;4733.621310295168;4748.57262846342;4757.643176761757;4796.640251981115;4799.256115302133;6705.329467053304;6761.971408577457;6772.458203343721;6810.353016463478;6854.828629284258;4988.476209997971;4993.850184494471;4995.500449955048;5002.374703162105;5013.548780609763;4946.095753135069;4984.127777638899;5012.899742005213;5063.620228482879;5068.41713202979;5467.781288748485;5528.474794894479;5581.246531718247;5620.4660557247;5630.831075067755;6338;6419.935800642027;6477.870442591122;6483.124778154983;6491.383318584822;1711.4865540338099;1734.6530693861278;1742.677604643145;1745.5199820049334;1755.1136675978805;1126.2341607706674;1210.9515619375302;1216.0636310041218;1219.1100496637505;1237.4307818403456;5410.269613602192;5425.37608175057;5539.19681646159;5546.69493177871;5575.303087114111;6492.253390860017;6579.736810527525;6602.867942641216;6635.270120286765;6652.268250492442;5560.304961879765;5584.994700953786;5629.493345598834;5632.211490391349;5649.265595472644;3397.8301084945656;3471.7192253320873;3493.8602455901478;3498.352804731133;3521.559805024372;6259.906101408483;6294;6311.905321420182;6328.208973878265;6405.8718825624155;6723.630200339028;6744.696488658022;6756.662166891636;6761.556946657987;6783.846746053183;6293.779717709858;6301.0863424804065;6368.235811702625;6410.391012853772;6445.1621289233035;6495.415412612888;6550.246721626883;6583.868322633425;6609.438197753245;6640.542999090368;6405.71885622868;6452.354764523698;6521;6539.313372095861;6558.114654521769;6331.176946996861;6375.139356186855;6375.266844312778;6413.4869210463985;6443.420092191725;4867.245576935581;4876.536729010738;4890.951090489192;4912.6561140719805;4949.549972763505;6559.311272316338;6621.9337806621315;6643.907169241674;6671.5997040177745;6688.264290927897;6331.878820595152;6353.237611486651;6357.014662727284;6425.1968503937005;6442.323556026549;6350.269718982191;6365.962891874556;6391.872162556816;6401.199850018747;6452.7418903245225;6276.623402595859;6298.716557755004;6347.587406818542;6359.713812878339;6370;6244.5316601256;6332.620042797447;6364.809055728336;6469.611823290617;6472.805815825533;5665.603407761582;6120.60216085953;6160.13758073861;6176.845578860564;6203.7828675996125 02:56:52 INFO - PID 3565 | |5;yui.html;909.1817364372065;918.7243826851943;923.8752768376268;929.9953500232498;943.3820847344987;16431.58921026975;17283.135843207838;17319.653606927855;17332;17342.30630774769;17754.733678994824;18709.812901870977;19606.70589941152;19777.802221977778;19823.603527929434;1030.0883717909649;1042.9895701043006;1045.5399624165382;1046.4296958157822;1047.9423631700254;1045.3100953370777;1048.3395460859647;1048.3709774135534;1048.6015314180638;1050.8949105089469;1052.3317693264794;1099.8680158381005;1105.6517197082894;1106.817375133106;1107.9224454288203;1083.1984331594604;1090.7927493776158;1096.1559599108682;1099.483242875847;1103.0844399148727;796.34699546372;800.0039950261961;800.0479429478902;802;802.6749166587541;17317.307307707677;17566.82433175665;17692.646147077114;17811.821881781147;17919;17521.211545480484;17620.823791762046;18028.188731506983;18083.63832723351;18206.18072186755;14240.572782816533;14284.000119991604;14364.35360408784;14384.35270412834;14455;3345.1469875181915;3439.2949445363643;3440.7591468597207;3443.139215196201;3445.104272889042;112598;114139.42930285378;116321;116945.41527292394;117467;13810.240436776074;14106;14111.22388268655;14180.14919104857;14329.35517901697;25232.243032709048;26155.476890462465;26519.734802651725;26682.5997610036;26716.866415668184;8047.356211503065;8204.630791614392;8257.463264887763;8290.46112002718;8303.750887473385;3851.0372406898277;3878.9030274242805;3898.1229223424502;3906.3554513505524;3915.882523524299;4658.767061646904;5021.774020169101;5193;5243.161094224905;5267.762950667229;802.4864086984335;1062.8990245926625;1067.5676351077825;1088.5373716170595;1089.6404186618397;530.273525270382;655.4625207329943;660.474922436664;668.024683961412;669.7086767256259;11569.710757231136;12517.248965062125;12621.24272543632;12807.679808004874;12850.807237891438;665.7769647168253;679.9796006119824;684.5139950635005;709.1773542690454;710.9939435698532;4972.975135124301;5087.236914462786;5097.592192624581;5104.566111880532;5210.505002024802;95274;96050.51974740221;97392.51303743436;97731.51134244283;102416;80561;83727.5813620928;84268;84729.57635211785;84783;72462;73574;74782;76985.61507192541;78629.60685196538;11291;11357.602483913024;11358.432078396212;11646.88353116458;11958.521659133537;33340.33319333648;35533;36095.27809443849;36210.4568431479;36264;61368;64681.67659161674;66151.33848661644;67326.32673673397;67840.6607966957;16656.167191640612;17254.827451725323;17432.91283543574;17549.298028078734;17687.557811054827;19374.128164232927;19600.215991360186;19683.409497715093;19690.50773730668;19909.303174388828;14880.7767883484;15934.52196434109;16846.241919113425;17335.479935601954;17567.736483952496;17115.743263851302;17475;17490.91254543719;17767.911160444633;17910.10449477547;16257.3497060121;16350.264238109552;16359.2638331273;16921.492355229362;17694.734578981068;12396.628101156979;13043.217945775437;13234.338283085615;13319.600411987656;13584.93207533956;12897.935510322388;12911.35443227816;13440.126391784503;13529.86470135286;13539.390727417092 02:56:52 INFO - PID 3565 | __end_tp_report 02:56:52 INFO - PID 3565 | __start_cc_report 02:56:52 INFO - PID 3565 | _x_x_mozilla_cycle_collect,352 02:56:52 INFO - PID 3565 | __end_cc_report 02:56:52 INFO - PID 3565 | __startTimestamp1500199012496__endTimestamp 02:56:52 INFO - PID 3565 | 02:56:52 INFO - PID 3565 | ------- Summary: start ------- 02:56:52 INFO - PID 3565 | Number of tests: 6 02:56:52 INFO - PID 3565 | 02:56:52 INFO - PID 3565 | [#0] dojo.html Cycles:165 Average:6019.98 Median:6255.56 stddev:712.73 (11.4%) stddev-sans-first:675.92 02:56:52 INFO - PID 3565 | Values: 3055.7 3088.2 3099.4 3109.7 3119.6 5966.0 5992.3 5994.2 6006.7 6089.3 6059.5 6082.9 6098.5 6099.2 6100.7 5563.6 5591.3 5610.0 5627.4 5648.4 5619.7 5625.1 5634.2 5641.7 5642.2 5610.7 5610.9 5641.2 5646.1 5649.1 5633.6 5641.5 5656.8 5660.8 5661.3 5568.2 5603.4 5617.3 5620.5 5714.8 6111.7 6148.3 6149.8 6216.3 6242.5 6352.2 6520.3 6547.0 6624.2 6635.8 6492.7 6553.5 6623.6 6687.5 6705.9 6134.1 6145.8 6155.0 6157.4 6167.7 6664.7 6695.2 6747.3 6750.6 6777.6 6351.7 6389.8 6409.5 6478.8 6506.9 6387.3 6468.6 6489.1 6565.0 6566.1 6006.9 6516.9 6523.3 6628.5 6629.6 6543.4 6562.6 6580.5 6642.1 6686.9 5252.2 5369.9 5440.5 5441.3 5442.6 4486.7 4499.6 4500.4 4510.1 4535.4 5520.5 5525.6 5534.9 5549.1 5562.4 6347.0 6374.2 6390.0 6400.7 6449.0 5486.3 5528.5 5531.6 5539.9 5544.6 5580.1 5667.9 5669.1 5697.1 5718.5 6220.3 6306.5 6327.6 6383.8 6396.6 6538.6 6558.3 6639.4 6660.4 6678.5 6343.8 6345.8 6413.8 6448.2 6466.0 6377.1 6423.5 6434.0 6450.0 6452.2 6599.2 6613.8 6621.2 6630.8 6723.6 6357.8 6368.2 6426.5 6450.1 6499.4 6368.3 6373.0 6451.3 6485.7 6519.9 6259.4 6353.7 6359.5 6361.4 6364.4 6243.5 6301.1 6309.9 6322.2 6367.3 6056.9 6193.5 6203.5 6253.6 6255.6 02:56:52 INFO - PID 3565 | 02:56:52 INFO - PID 3565 | [#1] ext.html Cycles:180 Average:36716.44 Median:17981.19 stddev:52787.00 (293.6%) stddev-sans-first:52866.05 02:56:52 INFO - PID 3565 | Values: 763.8 778.6 810.6 840.8 849.7 38521.2 39060.2 39308.4 39391.6 39411.2 36349.0 36765.3 36819.3 36839.8 36874.0 6672.5 6764.7 6768.6 6797.8 6805.9 6701.4 6807.1 6808.2 6834.7 6837.2 6783.0 6802.8 6803.4 6813.8 6816.4 6735.3 6744.6 6745.4 6746.7 6756.5 6036.4 6044.2 6054.3 6056.6 6085.1 31858.5 31859.8 32057.7 32143.5 32149.4 3291.9 3312.7 3329.8 3340.1 3350.4 25933.5 26122.1 26136.2 26262.9 26287.6 4122.2 4221.3 4243.2 4257.0 4314.3 188313.1 189082.0 190251.0 194756.0 195577.0 40989.0 46561.5 47833.5 48476.3 48511.0 50206.2 50265.5 50481.7 50497.2 50683.5 15940.9 16018.3 16047.4 16062.8 16114.8 13335.9 13338.3 13387.4 13393.7 13402.0 12836.5 13057.9 13115.7 13159.1 13212.3 5355.8 5453.4 5465.5 5476.4 5595.1 950.2 983.1 996.4 1021.5 1025.2 22113.1 22297.8 22491.7 22679.8 22783.8 1093.7 1097.1 1117.6 1125.0 1140.7 11535.6 11741.9 11779.4 11840.0 11898.9 207325.0 208862.0 209182.0 209552.0 209838.0 50376.7 50761.7 50790.5 50882.2 50938.5 1460.3 1468.4 1486.3 1509.8 1521.5 21758.3 21881.2 21907.8 22250.6 26244.0 50333.5 50631.5 50643.7 50741.2 50769.7 206520.0 208512.0 209492.0 209701.0 210153.0 29228.7 29912.6 31217.5 32670.5 32934.2 42066.8 43289.8 43863.3 44114.6 44309.0 30463.7 30738.0 31945.5 32166.0 32362.0 30817.7 31119.8 31509.0 31524.7 31563.7 36578.8 37411.3 37454.8 37488.6 37489.9 29872.7 30610.7 31353.2 31859.7 31929.2 23441.3 23892.9 24046.3 24100.5 24351.5 02:56:52 INFO - PID 3565 | 02:56:52 INFO - PID 3565 | [#2] jquery.html Cycles:180 Average:35477.86 Median:21841.84 stddev:89216.20 (408.5%) stddev-sans-first:89427.95 02:56:52 INFO - PID 3565 | Values: 560.7 561.9 566.5 581.1 586.4 16275.1 21830.3 22731.7 22788.4 22844.0 18903.5 19341.3 19394.4 22079.8 22452.9 3847.2 3948.1 4000.8 4008.2 6511.8 6437.3 6519.3 6536.1 6539.6 6545.0 6505.0 6516.3 6520.3 6527.4 6528.4 6490.2 6498.9 6499.8 6505.8 6509.5 3591.4 3783.3 3819.3 6037.6 6051.0 26533.3 28030.7 28276.6 28327.9 28450.9 1892.7 1923.5 1929.8 1931.7 1936.4 17374.8 18030.2 18549.9 18595.9 18641.0 2243.3 2325.1 2359.9 2378.7 2381.1 124169.0 129449.0 131419.0 131502.3 131961.3 13812.7 13902.7 14024.6 14058.7 14341.9 21853.3 21914.0 21992.9 22041.7 22073.4 9614.8 9841.7 9871.0 9954.4 10140.3 9193.8 9219.9 9258.3 9458.4 9551.4 8813.7 8836.9 8876.8 8973.2 9034.3 2430.4 2432.0 2476.5 2508.3 2525.4 965.8 968.7 990.9 1007.8 1020.4 18483.3 18575.8 18598.6 18826.6 18981.2 1033.3 1058.1 1073.2 1079.9 1084.5 10372.7 10405.5 10517.3 10588.8 10618.5 472326.0 544078.0 546396.0 548385.0 548789.0 118488.0 120778.4 123422.4 124825.4 124850.0 1235.6 1261.4 1310.5 1317.9 1318.3 18733.9 19428.2 19800.9 19942.0 20103.5 53793.7 57455.7 57686.4 59181.4 60209.0 69755.3 69844.3 70139.6 70775.3 70911.6 13914.9 14228.9 14241.9 14273.6 14283.4 20731.7 21334.8 21639.9 22082.8 22512.0 17210.5 17282.7 17445.7 17456.8 17468.5 15653.3 16225.3 16284.4 17123.2 17153.4 16967.2 17233.1 17903.7 19250.7 19468.1 14192.6 14354.0 19959.7 20997.0 21106.3 18633.0 18645.7 18892.9 19247.9 19404.1 02:56:52 INFO - PID 3565 | 02:56:52 INFO - PID 3565 | [#3] mootools.html Cycles:180 Average:8445.14 Median:2523.04 stddev:5688.81 (225.5%) stddev-sans-first:5679.65 02:56:52 INFO - PID 3565 | Values: 1330.7 1371.8 1394.7 1395.1 1398.0 13234.3 13922.9 13946.1 13952.5 13961.9 13415.7 13895.7 13922.7 13944.4 13959.7 2578.3 2622.8 2634.4 2637.7 2644.8 2556.2 2607.4 2634.3 2636.9 2640.7 2525.7 2544.5 2552.6 2565.0 2571.1 2520.4 2536.9 2542.8 2549.7 2550.5 2441.3 2466.5 2468.9 2477.8 2486.8 13322.7 13669.3 13671.0 13674.7 13677.1 7319.1 7587.1 7624.6 7631.5 7638.7 4884.9 4990.6 5084.3 5105.5 5148.9 1821.5 1834.5 1850.1 1883.4 1895.9 20553.4 21331.3 21713.5 22022.7 22183.6 5741.9 6190.3 6346.0 6422.6 6466.9 15283.6 15302.2 15441.5 15463.0 15463.7 7154.5 7302.1 7310.8 7329.2 7333.9 6926.8 6953.4 6996.5 7029.3 7050.2 4856.7 5001.6 5004.0 5036.6 5192.2 1485.7 1493.9 1503.1 1508.8 1511.7 879.1 879.8 898.6 901.4 907.6 6937.0 7105.5 7172.4 7236.6 7251.6 713.7 718.3 720.6 729.9 735.4 4564.4 4940.4 5006.9 5052.5 5131.6 17678.9 18347.2 18550.4 18652.0 18920.9 18156.4 18647.3 18675.6 18895.8 19029.6 10522.7 10760.0 10804.8 10971.2 11005.7 7548.8 7743.7 7861.4 7928.5 8093.2 15767.7 16088.8 16294.7 16345.6 16372.8 16240.9 16358.6 16708.9 17257.6 17354.6 10378.9 10528.4 11202.4 11588.6 11714.8 12054.6 12161.0 12201.9 12217.9 12252.0 10202.5 10513.8 10721.7 10728.2 11129.8 10370.2 10474.9 10557.8 10659.1 10761.4 8980.9 9083.7 9205.6 9301.1 9317.2 6842.2 7070.3 7236.5 7259.3 7312.4 6875.5 6901.9 6961.9 6999.0 7027.6 02:56:52 INFO - PID 3565 | 02:56:52 INFO - PID 3565 | [#4] prototype.html Cycles:180 Average:5389.00 Median:5912.15 stddev:1508.84 (25.5%) stddev-sans-first:1467.30 02:56:52 INFO - PID 3565 | Values: 475.1 499.6 507.8 516.6 525.8 6035.5 6078.9 6102.2 6135.0 6145.0 5907.5 5946.4 6010.9 6015.1 6032.2 4902.4 4903.5 4910.7 4937.9 4949.3 4808.4 4865.5 4880.8 4912.8 4926.9 4881.4 4889.7 4899.2 4906.5 4925.4 4687.9 4801.2 4844.2 4856.4 4860.9 4323.9 4327.8 4373.3 4390.0 4398.0 5834.7 5890.6 5909.9 5911.3 5913.0 5479.2 5543.2 5560.2 5565.6 5599.0 6373.4 6411.5 6441.5 6455.6 6486.3 4733.6 4748.6 4757.6 4796.6 4799.3 6705.3 6762.0 6772.5 6810.4 6854.8 4988.5 4993.9 4995.5 5002.4 5013.5 4946.1 4984.1 5012.9 5063.6 5068.4 5467.8 5528.5 5581.2 5620.5 5630.8 6338.0 6419.9 6477.9 6483.1 6491.4 1711.5 1734.7 1742.7 1745.5 1755.1 1126.2 1211.0 1216.1 1219.1 1237.4 5410.3 5425.4 5539.2 5546.7 5575.3 6492.3 6579.7 6602.9 6635.3 6652.3 5560.3 5585.0 5629.5 5632.2 5649.3 3397.8 3471.7 3493.9 3498.4 3521.6 6259.9 6294.0 6311.9 6328.2 6405.9 6723.6 6744.7 6756.7 6761.6 6783.8 6293.8 6301.1 6368.2 6410.4 6445.2 6495.4 6550.2 6583.9 6609.4 6640.5 6405.7 6452.4 6521.0 6539.3 6558.1 6331.2 6375.1 6375.3 6413.5 6443.4 4867.2 4876.5 4891.0 4912.7 4949.5 6559.3 6621.9 6643.9 6671.6 6688.3 6331.9 6353.2 6357.0 6425.2 6442.3 6350.3 6366.0 6391.9 6401.2 6452.7 6276.6 6298.7 6347.6 6359.7 6370.0 6244.5 6332.6 6364.8 6469.6 6472.8 5665.6 6120.6 6160.1 6176.8 6203.8 02:56:52 INFO - PID 3565 | 02:56:52 INFO - PID 3565 | [#5] yui.html Cycles:180 Average:21440.49 Median:17860.96 stddev:28610.88 (160.2%) stddev-sans-first:28649.60 02:56:52 INFO - PID 3565 | Values: 909.2 918.7 923.9 930.0 943.4 16431.6 17283.1 17319.7 17332.0 17342.3 17754.7 18709.8 19606.7 19777.8 19823.6 1030.1 1043.0 1045.5 1046.4 1047.9 1045.3 1048.3 1048.4 1048.6 1050.9 1052.3 1099.9 1105.7 1106.8 1107.9 1083.2 1090.8 1096.2 1099.5 1103.1 796.3 800.0 800.0 802.0 802.7 17317.3 17566.8 17692.6 17811.8 17919.0 17521.2 17620.8 18028.2 18083.6 18206.2 14240.6 14284.0 14364.4 14384.4 14455.0 3345.1 3439.3 3440.8 3443.1 3445.1 112598.0 114139.4 116321.0 116945.4 117467.0 13810.2 14106.0 14111.2 14180.1 14329.4 25232.2 26155.5 26519.7 26682.6 26716.9 8047.4 8204.6 8257.5 8290.5 8303.8 3851.0 3878.9 3898.1 3906.4 3915.9 4658.8 5021.8 5193.0 5243.2 5267.8 802.5 1062.9 1067.6 1088.5 1089.6 530.3 655.5 660.5 668.0 669.7 11569.7 12517.2 12621.2 12807.7 12850.8 665.8 680.0 684.5 709.2 711.0 4973.0 5087.2 5097.6 5104.6 5210.5 95274.0 96050.5 97392.5 97731.5 102416.0 80561.0 83727.6 84268.0 84729.6 84783.0 72462.0 73574.0 74782.0 76985.6 78629.6 11291.0 11357.6 11358.4 11646.9 11958.5 33340.3 35533.0 36095.3 36210.5 36264.0 61368.0 64681.7 66151.3 67326.3 67840.7 16656.2 17254.8 17432.9 17549.3 17687.6 19374.1 19600.2 19683.4 19690.5 19909.3 14880.8 15934.5 16846.2 17335.5 17567.7 17115.7 17475.0 17490.9 17767.9 17910.1 16257.3 16350.3 16359.3 16921.5 17694.7 12396.6 13043.2 13234.3 13319.6 13584.9 12897.9 12911.4 13440.1 13529.9 13539.4 02:56:52 INFO - PID 3565 | -------- Summary: end -------- 02:56:52 INFO - PID 3565 | 02:56:53 INFO - TEST-INFO | 3565: exit 0 02:56:53 INFO - TEST-OK | dromaeo_css | took 1114107ms 02:56:53 INFO - TEST-START | kraken 02:56:53 INFO - Initialising browser for kraken test... 02:56:53 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:43262/getInfo.html -profile /tmp/tmpHYD1RM/profile 02:56:53 INFO - TEST-INFO | started process 3973 (/builds/slave/test/build/application/firefox/firefox http://localhost:43262/getInfo.html) 02:56:59 INFO - TEST-INFO | 3973: exit 0 02:56:59 INFO - Browser initialized. 02:56:59 INFO - Running cycle 1/1 for kraken test... 02:56:59 INFO - TEST-INFO | started process 4200 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHYD1RM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 02:57:10 INFO - PID 4200 | RSS: Main: 169750528 02:57:10 INFO - PID 4200 | 02:57:13 INFO - PID 4200 | Cycle 1(1): loaded http://localhost:43262/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43262/tests/kraken/driver.html?testName=audio-beat-detection) 02:57:14 INFO - PID 4200 | RSS: Main: 176390144 02:57:14 INFO - PID 4200 | 02:57:16 INFO - PID 4200 | Cycle 1(1): loaded http://localhost:43262/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43262/tests/kraken/driver.html?testName=audio-dft) 02:57:17 INFO - PID 4200 | RSS: Main: 176836608 02:57:17 INFO - PID 4200 | 02:57:20 INFO - PID 4200 | Cycle 1(1): loaded http://localhost:43262/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43262/tests/kraken/driver.html?testName=audio-fft) 02:57:21 INFO - PID 4200 | RSS: Main: 171307008 02:57:21 INFO - PID 4200 | 02:57:23 INFO - PID 4200 | Cycle 1(1): loaded http://localhost:43262/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43262/tests/kraken/driver.html?testName=audio-oscillator) 02:57:23 INFO - PID 4200 | RSS: Main: 171737088 02:57:23 INFO - PID 4200 | 02:57:26 INFO - PID 4200 | Cycle 1(1): loaded http://localhost:43262/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43262/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:57:26 INFO - PID 4200 | RSS: Main: 171606016 02:57:26 INFO - PID 4200 | 02:57:29 INFO - PID 4200 | Cycle 1(1): loaded http://localhost:43262/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43262/tests/kraken/driver.html?testName=imaging-darkroom) 02:57:30 INFO - PID 4200 | RSS: Main: 175394816 02:57:30 INFO - PID 4200 | 02:57:33 INFO - PID 4200 | Cycle 1(1): loaded http://localhost:43262/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43262/tests/kraken/driver.html?testName=imaging-desaturate) 02:57:34 INFO - PID 4200 | RSS: Main: 176721920 02:57:34 INFO - PID 4200 | 02:57:37 INFO - PID 4200 | Cycle 1(1): loaded http://localhost:43262/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43262/tests/kraken/driver.html?testName=json-parse-financial) 02:57:37 INFO - PID 4200 | RSS: Main: 175407104 02:57:37 INFO - PID 4200 | 02:57:39 INFO - PID 4200 | Cycle 1(1): loaded http://localhost:43262/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43262/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:57:39 INFO - PID 4200 | RSS: Main: 175255552 02:57:39 INFO - PID 4200 | 02:57:41 INFO - PID 4200 | Cycle 1(1): loaded http://localhost:43262/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43262/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:57:42 INFO - PID 4200 | RSS: Main: 175587328 02:57:42 INFO - PID 4200 | 02:57:44 INFO - PID 4200 | Cycle 1(1): loaded http://localhost:43262/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43262/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:57:44 INFO - PID 4200 | RSS: Main: 175206400 02:57:44 INFO - PID 4200 | 02:57:47 INFO - PID 4200 | Cycle 1(1): loaded http://localhost:43262/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:57:48 INFO - PID 4200 | RSS: Main: 174833664 02:57:48 INFO - PID 4200 | 02:57:51 INFO - PID 4200 | Cycle 1(1): loaded http://localhost:43262/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:57:51 INFO - PID 4200 | RSS: Main: 175599616 02:57:51 INFO - PID 4200 | 02:57:53 INFO - PID 4200 | Cycle 1(1): loaded http://localhost:43262/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43262/tests/kraken/driver.html?testName=ai-astar) 02:57:53 INFO - PID 4200 | RSS: Main: 177086464 02:57:53 INFO - PID 4200 | 02:57:53 INFO - PID 4200 | __start_tp_report 02:57:53 INFO - PID 4200 | _x_x_mozilla_page_load 02:57:53 INFO - PID 4200 | _x_x_mozilla_page_load_details 02:57:53 INFO - PID 4200 | |i|pagename|runs| 02:57:53 INFO - PID 4200 | |0;ai-astar;101;110;110;110;110;108;111;109;110;111 02:57:53 INFO - PID 4200 | |1;audio-beat-detection;149;122;148;176;121;146;147;120;175;127 02:57:53 INFO - PID 4200 | |2;audio-dft;163;164;161;161;160;167;162;166;165;163 02:57:53 INFO - PID 4200 | |3;audio-fft;75;75;74;186;75;74;75;76;95;75 02:57:53 INFO - PID 4200 | |4;audio-oscillator;82;80;136;83;81;81;125;81;81;130 02:57:53 INFO - PID 4200 | |5;imaging-gaussian-blur;114;113;114;114;115;113;113;114;113;113 02:57:53 INFO - PID 4200 | |6;imaging-darkroom;150;149;150;149;151;150;150;149;150;151 02:57:53 INFO - PID 4200 | |7;imaging-desaturate;94;94;94;94;94;94;94;94;94;94 02:57:53 INFO - PID 4200 | |8;json-parse-financial;55;54;55;57;55;56;55;54;55;54 02:57:53 INFO - PID 4200 | |9;json-stringify-tinderbox;54;54;54;53;54;56;54;54;55;54 02:57:53 INFO - PID 4200 | |10;stanford-crypto-aes;79;80;82;77;78;87;78;77;80;78 02:57:53 INFO - PID 4200 | |11;stanford-crypto-ccm;126;126;124;127;128;131;130;124;132;156 02:57:53 INFO - PID 4200 | |12;stanford-crypto-pbkdf2;186;186;182;191;183;184;183;184;188;185 02:57:53 INFO - PID 4200 | |13;stanford-crypto-sha256-iterative;69;69;69;70;70;73;71;70;67;76 02:57:53 INFO - PID 4200 | __end_tp_report 02:57:53 INFO - PID 4200 | __start_cc_report 02:57:53 INFO - PID 4200 | _x_x_mozilla_cycle_collect,956 02:57:53 INFO - PID 4200 | __end_cc_report 02:57:53 INFO - PID 4200 | __startTimestamp1500199073985__endTimestamp 02:57:53 INFO - PID 4200 | 02:57:53 INFO - PID 4200 | ------- Summary: start ------- 02:57:53 INFO - PID 4200 | Number of tests: 14 02:57:53 INFO - PID 4200 | 02:57:53 INFO - PID 4200 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.00 stddev:2.94 (2.7%) stddev-sans-first:0.93 02:57:53 INFO - PID 4200 | Values: 101.0 110.0 110.0 110.0 110.0 108.0 111.0 109.0 110.0 111.0 02:57:53 INFO - PID 4200 | 02:57:53 INFO - PID 4200 | [#1] audio-beat-detection Cycles:10 Average:143.10 Median:147.50 stddev:20.84 (14.1%) stddev-sans-first:21.99 02:57:53 INFO - PID 4200 | Values: 149.0 122.0 148.0 176.0 121.0 146.0 147.0 120.0 175.0 127.0 02:57:53 INFO - PID 4200 | 02:57:54 INFO - PID 4200 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.50 stddev:2.30 (1.4%) stddev-sans-first:2.44 02:57:54 INFO - PID 4200 | Values: 163.0 164.0 161.0 161.0 160.0 167.0 162.0 166.0 165.0 163.0 02:57:54 INFO - PID 4200 | 02:57:54 INFO - PID 4200 | [#3] audio-fft Cycles:10 Average:88.00 Median:75.00 stddev:35.01 (46.7%) stddev-sans-first:36.82 02:57:54 INFO - PID 4200 | Values: 75.0 75.0 74.0 186.0 75.0 74.0 75.0 76.0 95.0 75.0 02:57:54 INFO - PID 4200 | 02:57:54 INFO - PID 4200 | [#4] audio-oscillator Cycles:10 Average:96.00 Median:81.00 stddev:23.85 (29.4%) stddev-sans-first:24.75 02:57:54 INFO - PID 4200 | Values: 82.0 80.0 136.0 83.0 81.0 81.0 125.0 81.0 81.0 130.0 02:57:54 INFO - PID 4200 | 02:57:54 INFO - PID 4200 | [#5] imaging-gaussian-blur Cycles:10 Average:113.60 Median:114.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 02:57:54 INFO - PID 4200 | Values: 114.0 113.0 114.0 114.0 115.0 113.0 113.0 114.0 113.0 113.0 02:57:54 INFO - PID 4200 | 02:57:54 INFO - PID 4200 | [#6] imaging-darkroom Cycles:10 Average:149.90 Median:150.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 02:57:54 INFO - PID 4200 | Values: 150.0 149.0 150.0 149.0 151.0 150.0 150.0 149.0 150.0 151.0 02:57:54 INFO - PID 4200 | 02:57:54 INFO - PID 4200 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 02:57:54 INFO - PID 4200 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 02:57:54 INFO - PID 4200 | 02:57:54 INFO - PID 4200 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.00 stddev:0.94 (1.7%) stddev-sans-first:1.00 02:57:54 INFO - PID 4200 | Values: 55.0 54.0 55.0 57.0 55.0 56.0 55.0 54.0 55.0 54.0 02:57:54 INFO - PID 4200 | 02:57:54 INFO - PID 4200 | [#9] json-stringify-tinderbox Cycles:10 Average:54.20 Median:54.00 stddev:0.79 (1.5%) stddev-sans-first:0.83 02:57:54 INFO - PID 4200 | Values: 54.0 54.0 54.0 53.0 54.0 56.0 54.0 54.0 55.0 54.0 02:57:54 INFO - PID 4200 | 02:57:54 INFO - PID 4200 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:79.50 stddev:3.03 (3.8%) stddev-sans-first:3.20 02:57:54 INFO - PID 4200 | Values: 79.0 80.0 82.0 77.0 78.0 87.0 78.0 77.0 80.0 78.0 02:57:54 INFO - PID 4200 | 02:57:54 INFO - PID 4200 | [#11] stanford-crypto-ccm Cycles:10 Average:130.40 Median:129.00 stddev:9.41 (7.3%) stddev-sans-first:9.84 02:57:54 INFO - PID 4200 | Values: 126.0 126.0 124.0 127.0 128.0 131.0 130.0 124.0 132.0 156.0 02:57:54 INFO - PID 4200 | 02:57:54 INFO - PID 4200 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.20 Median:185.50 stddev:2.70 (1.5%) stddev-sans-first:2.85 02:57:54 INFO - PID 4200 | Values: 186.0 186.0 182.0 191.0 183.0 184.0 183.0 184.0 188.0 185.0 02:57:54 INFO - PID 4200 | 02:57:54 INFO - PID 4200 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.00 stddev:2.50 (3.6%) stddev-sans-first:2.60 02:57:54 INFO - PID 4200 | Values: 69.0 69.0 69.0 70.0 70.0 73.0 71.0 70.0 67.0 76.0 02:57:54 INFO - PID 4200 | -------- Summary: end -------- 02:57:54 INFO - PID 4200 | 02:57:54 INFO - PID 4200 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 02:57:54 INFO - TEST-INFO | 4200: exit 0 02:57:54 INFO - TEST-OK | kraken | took 61620ms 02:57:54 INFO - SUITE-END | took 1175s 02:57:55 INFO - Completed test suite (00:19:36) 02:57:55 INFO - javascript benchmark 02:57:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8170.2302762918325, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3055.694430556946, 3088.227943014245, 3099.4421004219244, 3109.6890310968906, 3119.578856854324, 5965.9701701491485, 5992.3108842483125, 5994.190784244126, 6006.699665016748, 6089.269287685473, 6059.515238780898, 6082.878342433149, 6098.451139397464, 6099.237595300588, 6100.725467353968, 5563.554915606742, 5591.30108736407, 5610.0, 5627.409122042188, 5648.435156484339, 5619.662820230778, 5625.099984002561, 5634.239377684022, 5641.68970706611, 5642.2100905873, 5610.747516361753, 5610.915836262459, 5641.2384328115795, 5646.068398714207, 5649.096144616862, 5633.605647604629, 5641.548676105902, 5656.773729050833, 5660.801871934463, 5661.348944871331, 5568.1647752837, 5603.411641777596, 5617.297837770278, 5620.494155525981, 5714.79998200061, 6111.724972376253, 6148.262208534959, 6149.754009839601, 6216.2851272103835, 6242.531810114214, 6352.237731472253, 6520.315366886503, 6547.0, 6624.171978502687, 6635.834104147387, 6492.7402903883785, 6553.508486863504, 6623.569467984566, 6687.49843761715, 6705.932940670579, 6134.079888016789, 6145.784897528565, 6155.045967874987, 6157.4458298753325, 6167.660778657172, 6664.666766661648, 6695.230048544382, 6747.257801641816, 6750.561213521106, 6777.593344399352, 6351.650659213788, 6389.808305750835, 6409.487241020707, 6478.805635830932, 6506.869862602722, 6387.265464471552, 6468.579542329733, 6489.091527186198, 6565.0, 6566.1135746674545, 6006.879862402815, 6516.869662606816, 6523.347665233438, 6628.4697224221945, 6629.569078009914, 6543.411093001652, 6562.639054852029, 6580.539362244597, 6642.070110184578, 6686.933130668728, 5252.159654455345, 5369.892602147936, 5440.483154100354, 5441.265429167091, 5442.646227995247, 4486.730796152241, 4499.6400287976885, 4500.369948207253, 4510.143072816154, 4535.4103966484145, 5520.53075488588, 5525.640833345819, 5534.861628459321, 5549.139883318092, 5562.443755624486, 6346.968265158737, 6374.235091789015, 6390.0, 6400.743970241231, 6449.032645103178, 5486.259354987025, 5528.530074943675, 5531.640443371168, 5539.889202215933, 5544.584156188302, 5580.107182850725, 5667.858303542444, 5669.149627555899, 5697.088465845445, 5718.4567466091485, 6220.284667263232, 6306.463950564162, 6327.557071004985, 6383.840403989938, 6396.648184349905, 6538.574992625464, 6558.344165583403, 6639.435647969976, 6660.400563949268, 6678.532502724957, 6343.809685709436, 6345.809625711236, 6413.839654008687, 6448.193975753031, 6465.967670161807, 6377.1390862233, 6423.454006409321, 6433.970564709811, 6450.0, 6452.161219041494, 6599.241087275025, 6613.768518101843, 6621.238557565942, 6630.83422914431, 6723.562968407038, 6357.777477788441, 6368.172137622079, 6426.518011149276, 6450.129232553733, 6499.415052645285, 6368.299487056327, 6372.968135159294, 6451.290358060516, 6485.708143133476, 6519.902201467076, 6259.405356491126, 6353.745850165941, 6359.491240700825, 6361.395667411589, 6364.363563643784, 6243.531735119794, 6301.054841773771, 6309.905351419824, 6322.241331040121, 6367.267764207176, 6056.878862422815, 6193.504519638508, 6203.472704820141, 6253.5622506424115, 6255.562110652393], "value": 5966.499784519632, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [763.7746864674921, 778.5717855179657, 810.5784991804261, 840.8108175660475, 849.6558893648074, 38521.22957540848, 39060.21879562407, 39308.41037384438, 39391.60608393915, 39411.21177576447, 36349.0, 36765.26469470616, 36819.263614727686, 36839.81580092096, 36874.0, 6672.466202703797, 6764.729410823561, 6768.560043597175, 6797.7960661179995, 6805.863882722368, 6701.43037841784, 6807.115075040263, 6808.2170550386845, 6834.726610935557, 6837.247902730695, 6782.966085169592, 6802.829929251783, 6803.387695107439, 6813.7955861324235, 6816.420604248645, 6735.292794256606, 6744.561603495807, 6745.426638735713, 6746.662666866661, 6756.459483241329, 6036.396360363929, 6044.184035155242, 6054.273487181523, 6056.636601803862, 6085.148079268906, 31858.522122168186, 31859.840700796347, 32057.679423205704, 32143.51784723231, 32149.357012859844, 3291.8643068141455, 3312.668733126692, 3329.8335083245743, 3340.1315657929113, 3350.363430948112, 25933.481330373288, 26122.085726999463, 26136.215913522625, 26262.868685656642, 26287.60568591473, 4122.154958233555, 4221.282381995068, 4243.151369726036, 4256.957430425687, 4314.309710446313, 188313.0584347083, 189082.0, 190251.0, 194756.0, 195577.0, 40989.0, 46561.5343846564, 47833.52166478291, 48476.27285590719, 48511.0, 50206.24690629644, 50265.497345026815, 50481.747591262545, 50497.242541361906, 50683.49316506861, 15940.92029539845, 16018.27917743681, 16047.438339658056, 16062.751214829934, 16114.838851611568, 13335.93332033353, 13338.266395348155, 13387.397567109503, 13393.665158370924, 13402.0, 12836.48654053846, 13057.934710326388, 13115.672108197181, 13159.144655597547, 13212.339383031001, 5355.758990845421, 5453.372862120827, 5465.453454654503, 5476.397596264408, 5595.104783234663, 950.1591091883595, 983.1397527163732, 996.3722854601555, 1021.5249908792447, 1025.2413214221572, 22113.115475380804, 22297.777022229893, 22491.66262506064, 22679.773202268098, 22783.772162278496, 1093.7156339351825, 1097.1348707197797, 1117.6088369070924, 1124.9887501124883, 1140.7433327501246, 11535.596254131066, 11741.941290293495, 11779.352135632622, 11839.993600543878, 11898.881011189951, 207325.0, 208862.0, 209182.0, 209552.0, 209838.0, 50376.748116259914, 50761.74619126954, 50790.49209507932, 50882.236766448535, 50938.490615093375, 1460.3282490054694, 1468.4493315006873, 1486.3311509820624, 1509.8112735908012, 1521.5359315408684, 21758.347249582537, 21881.234156804436, 21907.780922190574, 22250.554988900454, 26244.0, 50333.49666503288, 50631.49368506415, 50643.74678126586, 50741.23888141607, 50769.746151269006, 206520.0, 208512.0, 209492.0, 209701.0, 210153.0, 29228.707712922598, 29912.55131173078, 31217.53173702351, 32670.50994235136, 32934.176645583095, 42066.789666051474, 43289.783551082044, 43863.34204986864, 44114.55885441104, 44309.0, 30463.695363046085, 30738.0, 31945.520817188226, 32166.0, 32362.029139125865, 30817.69182308148, 31119.844400777853, 31509.0, 31524.684753152174, 31563.684363156994, 36578.8171059143, 37411.25177496489, 37454.81272593619, 37488.625113748516, 37489.87530374093, 29872.701272987862, 30610.693893060783, 31353.216169595944, 31859.681403186598, 31929.201769955936, 23441.296761097194, 23892.88053559721, 24046.27861164168, 24100.51798964046, 24351.51296974015], "value": 16366.06747299669, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.655197053812, 561.8511094559942, 566.5241197394188, 581.0963951056108, 586.3872253495097, 16275.104869232187, 21830.345089647297, 22731.659025114594, 22788.430289242777, 22843.972021259062, 18903.52741181471, 19341.323053693122, 19394.418167454965, 22079.779202207974, 22452.887817979947, 3847.1536262022382, 3948.0722030322995, 4000.7799571023584, 4008.178323443687, 6511.837204069912, 6437.324080971477, 6519.282878883319, 6536.084948107269, 6539.607623542579, 6544.967275163642, 6505.0, 6516.283208847023, 6520.31536688648, 6527.445167160797, 6528.445082168021, 6490.188726409199, 6498.9350106498805, 6499.805005849832, 6505.772297969572, 6509.544331896769, 3591.371509985768, 3783.3190025795348, 3819.3316169670475, 6037.63774173551, 6051.0, 26533.3366665833, 28030.719692803013, 28276.575851362246, 28327.858360708065, 28450.857745711346, 1892.7255547945472, 1923.4902750771057, 1929.807019298073, 1931.7102434634776, 1936.4287535177157, 17374.826251737446, 18030.188641511162, 18549.907250463795, 18595.907020464812, 18640.974746389078, 2243.2933625907785, 2325.081592770846, 2359.905603775847, 2378.6669866218745, 2381.0951838301507, 124169.0, 129449.0, 131419.0, 131502.3424882879, 131961.34019329937, 13812.723745525032, 13902.721945561032, 14024.649383765487, 14058.71882562343, 14341.856581434053, 21853.344399668036, 21914.0, 21992.89003554972, 22041.669374959387, 22073.448163796034, 9614.807703845883, 9841.704748857546, 9870.950645246729, 9954.37121738395, 10140.340877842917, 9193.770155746026, 9219.90780092204, 9258.259339252843, 9458.385204961656, 9551.42691438516, 8813.69152079687, 8836.911630883738, 8876.778080548038, 8973.237274831712, 9034.277257819358, 2430.3559556717482, 2431.951360972806, 2476.5294594027077, 2508.2851387354517, 2525.356034211264, 965.8454647256546, 968.6752432740487, 990.9256805739599, 1007.8034783217203, 1020.3673722292226, 18483.260669573334, 18575.81424185741, 18598.628027439645, 18826.62346753057, 18981.240750370107, 1033.2859288136617, 1058.142904247562, 1073.1682945716975, 1079.8974097460887, 1084.4631907205983, 10372.688819335432, 10405.53175107122, 10517.316374435637, 10588.841167382496, 10618.522166502526, 472326.0, 544078.0, 546396.0, 548385.0, 548789.0, 118488.0, 120778.3961080189, 123422.38288808499, 124825.37587312005, 124850.0, 1235.5613757116273, 1261.413442749126, 1310.4692599497218, 1317.8945684345038, 1318.3342412081838, 18733.90633046826, 19428.222871085, 19800.90099549493, 19942.0, 20103.497412564804, 53793.73103134459, 57455.712721436124, 57686.423135768106, 59181.40818591759, 60209.0, 69755.30244697692, 69844.30155698581, 70139.64930175316, 70775.29224707687, 70911.64544177246, 13914.860851391357, 14228.861691064483, 14241.928790355982, 14273.57179284623, 14283.357248923616, 20731.68902466434, 21334.786652133902, 21639.891800540896, 22082.779172208073, 22512.0, 17210.483685489457, 17282.65434691324, 17445.738313925554, 17456.82543174552, 17468.47594572165, 15653.295601698179, 16225.269862855963, 16284.43004494837, 17123.22945467482, 17153.399631012853, 16967.23647435893, 17233.138343083046, 17903.73144402861, 19250.65245432806, 19468.123934423267, 14192.574222773334, 14354.0, 19959.700604490652, 20997.0, 21106.261280855095, 18633.0, 18645.72031419557, 18892.905535472233, 19247.90376048111, 19404.12681429367], "value": 11590.03451726807, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1330.6540299522123, 1371.7667996440605, 1394.7001394700137, 1395.0931894268724, 1397.9999999999993, 13234.272115033682, 13922.86077139227, 13946.093503922251, 13952.511662091829, 13961.930190349034, 13415.731685366287, 13895.722085558284, 13922.721545569082, 13944.442222311096, 13959.651008724786, 2578.2523068310165, 2622.8032897532667, 2634.3809204836944, 2637.696664883534, 2644.8016398770073, 2556.2075756515446, 2607.3742301847515, 2634.2624065261757, 2636.9472610547778, 2640.7095219525836, 2525.684289463817, 2544.5165418570505, 2552.629868669042, 2564.9615255771178, 2571.0872640212738, 2520.395105174763, 2536.885840137189, 2542.834715743471, 2549.7195308516048, 2550.5409026375246, 2441.340837973737, 2466.519028789387, 2468.8518688878726, 2477.752224777526, 2486.788622967032, 13322.666933326647, 13669.316534173351, 13671.043026988114, 13674.726505469935, 13677.110987785762, 7319.121705395387, 7587.089549254069, 7624.580648064354, 7631.503952243086, 7638.656260468292, 4884.853454396374, 4990.5508504234795, 5084.313617661605, 5105.5149760772665, 5148.897022059576, 1821.4808779497912, 1834.5230240137528, 1850.0842083168784, 1883.3502441657606, 1895.8672892897503, 20553.38339849807, 21331.253406130712, 21713.457163570878, 22022.669659954954, 22183.556328873492, 5741.942580574224, 6190.3190649028575, 6345.968270158712, 6422.582532135396, 6466.870662586722, 15283.61790955235, 15302.158381289137, 15441.5367538974, 15463.0, 15463.690726185414, 7154.4634152438775, 7302.123745150616, 7310.780676579711, 7329.157146928065, 7333.88999165013, 6926.826829329307, 6953.443724502028, 6996.510244282953, 7029.29707029293, 7050.189228238818, 4856.660033797601, 5001.64988450805, 5003.974980125076, 5036.5718913892, 5192.169252919591, 1485.6657252118187, 1493.887958403124, 1503.1131632336974, 1508.8340282568909, 1511.7127745728276, 879.0681877210178, 879.7756572074209, 898.6315610599753, 901.3915606965272, 907.6188001039579, 6937.0, 7105.46708996817, 7172.390346820474, 7236.565806051653, 7251.601161936039, 713.6931119618614, 718.3211864787726, 720.6432815756234, 729.8795698709654, 735.3712575747766, 4564.42944631921, 4940.357753492095, 5006.874828129326, 5052.545270925634, 5131.61512886535, 17678.911605441892, 18347.17437715306, 18550.44348669542, 18652.0, 18920.905395473208, 18156.36452724175, 18647.254109835725, 18675.626487470174, 18895.811041889407, 19029.61940761177, 10522.684319470582, 10760.0, 10804.78390432187, 10971.23201375896, 11005.724856878482, 7548.773536793905, 7743.728969486041, 7861.449698521277, 7928.484648497829, 8093.231143041402, 15767.68464630678, 16088.758668619746, 16294.67410651804, 16345.591360215614, 16372.83627163713, 16240.91879540642, 16358.591035224215, 16708.916455417646, 17257.56856078608, 17354.566135846704, 10378.910214427377, 10528.36829790215, 11202.43987800623, 11588.594399195988, 11714.76570468603, 12054.578089766816, 12161.0, 12201.877981220074, 12217.938910305747, 12252.0, 10202.540885660015, 10513.78972420532, 10721.731956701145, 10728.195385346286, 11129.83305250438, 10370.170386369224, 10474.947625261824, 10557.841632375366, 10659.093977011731, 10761.354318740901, 8980.910190898006, 9083.68207112748, 9205.631774728936, 9301.116393942564, 9317.208037316905, 6842.178938527409, 7070.328318809705, 7236.467805204302, 7259.310365515267, 7312.415006799337, 6875.48433867472, 6901.89647155283, 6961.920902260158, 6999.0, 7027.578345299298], "value": 6166.850768560572, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [475.1399966061427, 499.6452518711716, 507.8425688036708, 516.5635038392562, 525.8133362656257, 6035.456808887199, 6078.87842243156, 6102.2067131272925, 6135.0, 6144.969275153623, 5907.468327850493, 5946.375630558794, 6010.909836352458, 6015.0751759437, 6032.215811944452, 4902.411710594716, 4903.53416425439, 4910.680805747615, 4937.851864444055, 4949.277897156568, 4808.422989241296, 4865.464798872121, 4880.780364883589, 4912.828051018215, 4926.926096108561, 4881.414230292352, 4889.6821706589135, 4899.167141585921, 4906.484819093997, 4925.359703238574, 4687.906241875177, 4801.223547287508, 4844.249141383056, 4856.39295088114, 4860.878478038042, 4323.913521729579, 4327.788219298602, 4373.2565463871215, 4389.956100438987, 4397.966477877696, 5834.708264586754, 5890.587658863881, 5909.8818023639715, 5911.29064512257, 5913.0, 5479.1781232815, 5543.168524721284, 5560.2493663355335, 5565.554755619541, 5599.0, 6373.3945275198785, 6411.493299074714, 6441.516886233504, 6455.61266324022, 6486.254080780676, 4733.621310295168, 4748.57262846342, 4757.643176761757, 4796.640251981115, 4799.256115302133, 6705.329467053304, 6761.971408577457, 6772.458203343721, 6810.353016463478, 6854.828629284258, 4988.476209997971, 4993.850184494471, 4995.500449955048, 5002.374703162105, 5013.548780609763, 4946.095753135069, 4984.127777638899, 5012.899742005213, 5063.620228482879, 5068.41713202979, 5467.781288748485, 5528.474794894479, 5581.246531718247, 5620.4660557247, 5630.831075067755, 6338.0, 6419.935800642027, 6477.870442591122, 6483.124778154983, 6491.383318584822, 1711.4865540338099, 1734.6530693861278, 1742.677604643145, 1745.5199820049334, 1755.1136675978805, 1126.2341607706674, 1210.9515619375302, 1216.0636310041218, 1219.1100496637505, 1237.4307818403456, 5410.269613602192, 5425.37608175057, 5539.19681646159, 5546.69493177871, 5575.303087114111, 6492.253390860017, 6579.736810527525, 6602.867942641216, 6635.270120286765, 6652.268250492442, 5560.304961879765, 5584.994700953786, 5629.493345598834, 5632.211490391349, 5649.265595472644, 3397.8301084945656, 3471.7192253320873, 3493.8602455901478, 3498.352804731133, 3521.559805024372, 6259.906101408483, 6294.0, 6311.905321420182, 6328.208973878265, 6405.8718825624155, 6723.630200339028, 6744.696488658022, 6756.662166891636, 6761.556946657987, 6783.846746053183, 6293.779717709858, 6301.0863424804065, 6368.235811702625, 6410.391012853772, 6445.1621289233035, 6495.415412612888, 6550.246721626883, 6583.868322633425, 6609.438197753245, 6640.542999090368, 6405.71885622868, 6452.354764523698, 6521.0, 6539.313372095861, 6558.114654521769, 6331.176946996861, 6375.139356186855, 6375.266844312778, 6413.4869210463985, 6443.420092191725, 4867.245576935581, 4876.536729010738, 4890.951090489192, 4912.6561140719805, 4949.549972763505, 6559.311272316338, 6621.9337806621315, 6643.907169241674, 6671.5997040177745, 6688.264290927897, 6331.878820595152, 6353.237611486651, 6357.014662727284, 6425.1968503937005, 6442.323556026549, 6350.269718982191, 6365.962891874556, 6391.872162556816, 6401.199850018747, 6452.7418903245225, 6276.623402595859, 6298.716557755004, 6347.587406818542, 6359.713812878339, 6370.0, 6244.5316601256, 6332.620042797447, 6364.809055728336, 6469.611823290617, 6472.805815825533, 5665.603407761582, 6120.60216085953, 6160.13758073861, 6176.845578860564, 6203.7828675996125], "value": 4946.9045446109985, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [909.1817364372065, 918.7243826851943, 923.8752768376268, 929.9953500232498, 943.3820847344987, 16431.58921026975, 17283.135843207838, 17319.653606927855, 17332.0, 17342.30630774769, 17754.733678994824, 18709.812901870977, 19606.70589941152, 19777.802221977778, 19823.603527929434, 1030.0883717909649, 1042.9895701043006, 1045.5399624165382, 1046.4296958157822, 1047.9423631700254, 1045.3100953370777, 1048.3395460859647, 1048.3709774135534, 1048.6015314180638, 1050.8949105089469, 1052.3317693264794, 1099.8680158381005, 1105.6517197082894, 1106.817375133106, 1107.9224454288203, 1083.1984331594604, 1090.7927493776158, 1096.1559599108682, 1099.483242875847, 1103.0844399148727, 796.34699546372, 800.0039950261961, 800.0479429478902, 802.0, 802.6749166587541, 17317.307307707677, 17566.82433175665, 17692.646147077114, 17811.821881781147, 17919.0, 17521.211545480484, 17620.823791762046, 18028.188731506983, 18083.63832723351, 18206.18072186755, 14240.572782816533, 14284.000119991604, 14364.35360408784, 14384.35270412834, 14455.0, 3345.1469875181915, 3439.2949445363643, 3440.7591468597207, 3443.139215196201, 3445.104272889042, 112598.0, 114139.42930285378, 116321.0, 116945.41527292394, 117467.0, 13810.240436776074, 14106.0, 14111.22388268655, 14180.14919104857, 14329.35517901697, 25232.243032709048, 26155.476890462465, 26519.734802651725, 26682.5997610036, 26716.866415668184, 8047.356211503065, 8204.630791614392, 8257.463264887763, 8290.46112002718, 8303.750887473385, 3851.0372406898277, 3878.9030274242805, 3898.1229223424502, 3906.3554513505524, 3915.882523524299, 4658.767061646904, 5021.774020169101, 5193.0, 5243.161094224905, 5267.762950667229, 802.4864086984335, 1062.8990245926625, 1067.5676351077825, 1088.5373716170595, 1089.6404186618397, 530.273525270382, 655.4625207329943, 660.474922436664, 668.024683961412, 669.7086767256259, 11569.710757231136, 12517.248965062125, 12621.24272543632, 12807.679808004874, 12850.807237891438, 665.7769647168253, 679.9796006119824, 684.5139950635005, 709.1773542690454, 710.9939435698532, 4972.975135124301, 5087.236914462786, 5097.592192624581, 5104.566111880532, 5210.505002024802, 95274.0, 96050.51974740221, 97392.51303743436, 97731.51134244283, 102416.0, 80561.0, 83727.5813620928, 84268.0, 84729.57635211785, 84783.0, 72462.0, 73574.0, 74782.0, 76985.61507192541, 78629.60685196538, 11291.0, 11357.602483913024, 11358.432078396212, 11646.88353116458, 11958.521659133537, 33340.33319333648, 35533.0, 36095.27809443849, 36210.4568431479, 36264.0, 61368.0, 64681.67659161674, 66151.33848661644, 67326.32673673397, 67840.6607966957, 16656.167191640612, 17254.827451725323, 17432.91283543574, 17549.298028078734, 17687.557811054827, 19374.128164232927, 19600.215991360186, 19683.409497715093, 19690.50773730668, 19909.303174388828, 14880.7767883484, 15934.52196434109, 16846.241919113425, 17335.479935601954, 17567.736483952496, 17115.743263851302, 17475.0, 17490.91254543719, 17767.911160444633, 17910.10449477547, 16257.3497060121, 16350.264238109552, 16359.2638331273, 16921.492355229362, 17694.734578981068, 12396.628101156979, 13043.217945775437, 13234.338283085615, 13319.600411987656, 13584.93207533956, 12897.935510322388, 12911.35443227816, 13440.126391784503, 13529.86470135286, 13539.390727417092], "value": 8614.570571338347, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1531.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 110.0, 110.0, 110.0, 108.0, 111.0, 109.0, 110.0, 111.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 122.0, 148.0, 176.0, 121.0, 146.0, 147.0, 120.0, 175.0, 127.0], "value": 143.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 161.0, 161.0, 160.0, 167.0, 162.0, 166.0, 165.0, 163.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 186.0, 75.0, 74.0, 75.0, 76.0, 95.0, 75.0], "value": 88.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 136.0, 83.0, 81.0, 81.0, 125.0, 81.0, 81.0, 130.0], "value": 96.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 114.0, 115.0, 113.0, 113.0, 114.0, 113.0, 113.0], "value": 113.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 150.0, 149.0, 151.0, 150.0, 150.0, 149.0, 150.0, 151.0], "value": 149.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 55.0, 57.0, 55.0, 56.0, 55.0, 54.0, 55.0, 54.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 53.0, 54.0, 56.0, 54.0, 54.0, 55.0, 54.0], "value": 54.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 82.0, 77.0, 78.0, 87.0, 78.0, 77.0, 80.0, 78.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 126.0, 124.0, 127.0, 128.0, 131.0, 130.0, 124.0, 132.0, 156.0], "value": 130.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 186.0, 182.0, 191.0, 183.0, 184.0, 183.0, 184.0, 188.0, 185.0], "value": 185.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 69.0, 70.0, 70.0, 73.0, 71.0, 70.0, 67.0, 76.0], "value": 70.4, "unit": "score"}]}]} 02:57:55 INFO - Return code: 0 02:57:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:57:55 INFO - # TBPL SUCCESS # 02:57:55 INFO - Running post-action listener: _package_coverage_data 02:57:55 INFO - Running post-action listener: _resource_record_post_action 02:57:55 INFO - [mozharness: 2017-07-16 09:57:55.246203Z] Finished run-tests step (success) 02:57:55 INFO - Running post-run listener: _resource_record_post_run 02:57:55 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 5771264; Write bytes: 441864192; Read time: 2664; Write time: 273752 02:57:55 INFO - TinderboxPrint: CPU usage
13.1% 02:57:55 INFO - TinderboxPrint: I/O read bytes / time
5,771,264 / 2,664 02:57:55 INFO - TinderboxPrint: I/O write bytes / time
441,864,192 / 273,752 02:57:55 INFO - TinderboxPrint: CPU idle
8,271.9 (86.9%) 02:57:55 INFO - TinderboxPrint: CPU user
1,197.6 (12.6%) 02:57:55 INFO - TinderboxPrint: Swap in / out
0 / 0 02:57:55 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 4096; Write bytes: 116412416; Read time: 156; Write time: 74996 02:57:55 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 02:57:55 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 3395584; Write bytes: 325451776; Read time: 1908; Write time: 198756 02:57:55 INFO - Running post-run listener: _upload_blobber_files 02:57:55 INFO - Blob upload gear active. 02:57:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:57:55 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 02:57:55 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'] 02:57:55 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 02:57:56 INFO - Traceback (most recent call last): 02:57:56 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 02:57:56 INFO - main() 02:57:56 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 02:57:56 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 02:57:56 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 02:57:56 INFO - return set(response.json().get('whitelist', [])) 02:57:56 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 02:57:56 INFO - return json.loads(self.text or self.content, **kwargs) 02:57:56 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/__init__.py", line 488, in loads 02:57:56 INFO - return _default_decoder.decode(s) 02:57:56 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 370, in decode 02:57:56 INFO - obj, end = self.raw_decode(s) 02:57:56 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 389, in raw_decode 02:57:56 INFO - return self.scan_once(s, idx=_w(s, idx).end()) 02:57:56 INFO - simplejson.scanner.JSONDecodeError: Expecting value: line 1 column 1 (char 0) 02:57:56 ERROR - Return code: 1 02:57:56 INFO - Setting buildbot property blobber_files to {} 02:57:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:57:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:57:56 INFO - Contents: 02:57:56 INFO - blobber_files:{} 02:57:56 INFO - Running post-run listener: copy_logs_to_upload_dir 02:57:56 INFO - Copying logs to upload dir... 02:57:56 INFO - mkdir: /builds/slave/test/build/upload/logs 02:57:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1251.453433 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 51 secs) (at 2017-07-16 02:57:56.384121) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-16 02:57:56.388630) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1500187430.546621-271104504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011123 build_url: 'https://queue.taskcluster.net/v1/task/WJ_icmeDTNmefs5D-71J0w/artifacts/public/build/target.tar.bz2' blobber_files: '{}' ========= master_lag: 0.15 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-16 02:57:56.554361) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 02:57:56.554696) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1500187430.546621-271104504 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 02:57:56.607204) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-16 02:57:56.607581) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-16 02:57:56.607957) ========= ========= Total master_lag: 0.34 =========