builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-032 starttime: 1500252699.49 results: success (0) revision: aff336ac161daa3ea350e59a288963edbd58ed39 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-16 17:51:39.487493) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-16 17:51:39.488572) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-16 17:51:39.488845) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-16 17:51:39.512667) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 17:51:39.512935) ========= 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=745a4373a2a16df560f216e000000264-1500246898.727850-1272901271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-16 17:51:39-- 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% 45.6K=0.3s 2017-07-16 17:51:39 (45.6 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.344184 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 17:51:39.869781) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 17:51:39.870094) ========= 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=745a4373a2a16df560f216e000000264-1500246898.727850-1272901271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015035 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 17:51:39.919438) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-16 17:51:39.922792) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev aff336ac161daa3ea350e59a288963edbd58ed39 --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 aff336ac161daa3ea350e59a288963edbd58ed39 --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=745a4373a2a16df560f216e000000264-1500246898.727850-1272901271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-16 17:51:40,052 truncating revision to first 12 chars 2017-07-16 17:51:40,052 Setting DEBUG logging. 2017-07-16 17:51:40,052 attempt 1/10 2017-07-16 17:51:40,052 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/aff336ac161d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-16 17:51:41,247 unpacking tar archive at: mozilla-central-aff336ac161d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.510104 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-07-16 17:51:41.455116) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-16 17:51:41.455441) ========= script_repo_revision: aff336ac161daa3ea350e59a288963edbd58ed39 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-16 17:51:41.455869) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-16 17:51:41.456171) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-16 17:51:41.466933) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-07-16 17:51:41.467247) ========= /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=745a4373a2a16df560f216e000000264-1500246898.727850-1272901271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:51:41 INFO - MultiFileLogger online at 20170716 17:51:41 in /builds/slave/test 17:51:41 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 17:51:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:51:41 INFO - {'append_to_log': False, 17:51:41 INFO - 'base_work_dir': '/builds/slave/test', 17:51:41 INFO - 'blob_upload_branch': 'Firefox', 17:51:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:51:41 INFO - 'branch': 'Firefox', 17:51:41 INFO - 'buildbot_json_path': 'buildprops.json', 17:51:41 INFO - 'code_coverage': False, 17:51:41 INFO - 'config_files': ('talos/linux_config.py',), 17:51:41 INFO - 'default_actions': ('clobber', 17:51:41 INFO - 'read-buildbot-config', 17:51:41 INFO - 'download-and-extract', 17:51:41 INFO - 'populate-webroot', 17:51:41 INFO - 'create-virtualenv', 17:51:41 INFO - 'install', 17:51:41 INFO - 'setup-mitmproxy', 17:51:41 INFO - 'run-tests'), 17:51:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:51:41 INFO - 'disable_ccov_upload': False, 17:51:41 INFO - 'download_minidump_stackwalk': True, 17:51:41 INFO - 'download_symbols': 'ondemand', 17:51:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:51:41 INFO - 'tooltool.py': '/tools/tooltool.py', 17:51:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:51:41 INFO - '/tools/misc-python/virtualenv.py')}, 17:51:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:51:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:51:41 INFO - 'gecko_profile': False, 17:51:41 INFO - 'gecko_profile_interval': 0, 17:51:41 INFO - 'installer_path': 'installer.exe', 17:51:41 INFO - 'log_level': 'info', 17:51:41 INFO - 'log_name': 'talos', 17:51:41 INFO - 'log_to_console': True, 17:51:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:51:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:51:41 INFO - 'opt_config_files': (), 17:51:41 INFO - 'pip_index': False, 17:51:41 INFO - 'suite': 'dromaeojs-e10s', 17:51:41 INFO - 'system_bits': '32', 17:51:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:51:41 INFO - 'title': 'talos-linux64-ix-032', 17:51:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:51:41 INFO - 'use_talos_json': True, 17:51:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:51:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:51:41 INFO - 'work_dir': 'build'} 17:51:41 INFO - [mozharness: 2017-07-17 00:51:41.699484Z] Running clobber step. 17:51:41 INFO - Running pre-action listener: _resource_record_pre_action 17:51:41 INFO - Running main action method: clobber 17:51:41 INFO - rmtree: /builds/slave/test/build 17:51:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:51:42 INFO - Running post-action listener: _resource_record_post_action 17:51:42 INFO - [mozharness: 2017-07-17 00:51:42.734889Z] Finished clobber step (success) 17:51:42 INFO - [mozharness: 2017-07-17 00:51:42.734992Z] Running read-buildbot-config step. 17:51:42 INFO - Running pre-action listener: _resource_record_pre_action 17:51:42 INFO - Running main action method: read_buildbot_config 17:51:42 INFO - Using buildbot properties: 17:51:42 INFO - { 17:51:42 INFO - "project": "", 17:51:42 INFO - "product": "firefox", 17:51:42 INFO - "who": "nnethercote@mozilla.com", 17:51:42 INFO - "installer_path": "public/build/target.tar.bz2", 17:51:42 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 17:51:42 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 17:51:42 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 17:51:42 INFO - "stage_platform": "linux64-stylosequential", 17:51:42 INFO - "basedir": "/builds/slave/test", 17:51:42 INFO - "buildnumber": 108, 17:51:42 INFO - "platform": "ubuntu64_hw_styloseq", 17:51:42 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:51:42 INFO - "slavebuilddir": "test", 17:51:42 INFO - "taskId": "XowQewdXSqeEgwm8DaiFYA", 17:51:42 INFO - "branch": "mozilla-central", 17:51:42 INFO - "script_repo_revision": "production", 17:51:42 INFO - "revision": "aff336ac161daa3ea350e59a288963edbd58ed39", 17:51:42 INFO - "slavename": "talos-linux64-ix-032", 17:51:42 INFO - "repo_path": "mozilla-central" 17:51:42 INFO - } 17:51:42 INFO - Finding installer, test and symbols from parent task. 17:51:42 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XowQewdXSqeEgwm8DaiFYA'}, attempt #1 17:51:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XowQewdXSqeEgwm8DaiFYA'}, attempt #1 17:51:43 INFO - Task dependencies: NrNICH0tQbmyluaBowvvdg 17:51:43 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg'}, attempt #1 17:51:44 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.tar.bz2 17:51:44 INFO - Set test_url: https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/test_packages.json 17:51:44 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.crashreporter-symbols.zip 17:51:44 INFO - Running post-action listener: _resource_record_post_action 17:51:44 INFO - [mozharness: 2017-07-17 00:51:44.069945Z] Finished read-buildbot-config step (success) 17:51:44 INFO - [mozharness: 2017-07-17 00:51:44.070167Z] Running download-and-extract step. 17:51:44 INFO - Running pre-action listener: _resource_record_pre_action 17:51:44 INFO - Running main action method: download_and_extract 17:51:44 INFO - mkdir: /builds/slave/test/build/tests 17:51:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:51:44 INFO - trying https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.test_packages.json 17:51:44 INFO - Downloading https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:51:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:51:44 INFO - Downloaded 989 bytes. 17:51:44 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:51:44 INFO - Using the following test package requirements: 17:51:44 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:51:44 INFO - u'common': [u'target.common.tests.zip'], 17:51:44 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:51:44 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:51:44 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:51:44 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:51:44 INFO - u'mozbase': [u'target.common.tests.zip'], 17:51:44 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:51:44 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:51:44 INFO - u'web-platform': [u'target.common.tests.zip', 17:51:44 INFO - u'target.web-platform.tests.tar.gz'], 17:51:44 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:51:44 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:51:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.common.tests.zip 17:51:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:51:44 INFO - Fetch https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.common.tests.zip into memory 17:51:45 INFO - Content-Length response header: 72769114 17:51:45 INFO - Bytes received: 72769114 17:51:57 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:51:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.common.tests.zip 17:51:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:51:57 INFO - Fetch https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.common.tests.zip into memory 17:51:58 INFO - Content-Length response header: 72769114 17:51:58 INFO - Bytes received: 72769114 17:52:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.talos.tests.zip 17:52:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:52:15 INFO - Fetch https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.talos.tests.zip into memory 17:52:15 INFO - Content-Length response header: 14495033 17:52:15 INFO - Bytes received: 14495033 17:52:16 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')]} 17:52:16 INFO - trying https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.tar.bz2 17:52:16 INFO - Downloading https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:52:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:52:17 INFO - Downloaded 61824462 bytes. 17:52:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.tar.bz2 17:52:17 INFO - mkdir: /builds/slave/test/properties 17:52:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:52:17 INFO - Writing to file /builds/slave/test/properties/build_url 17:52:17 INFO - Contents: 17:52:17 INFO - build_url:https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.tar.bz2 17:52:17 INFO - Running post-action listener: _resource_record_post_action 17:52:17 INFO - Running post-action listener: set_extra_try_arguments 17:52:17 INFO - [mozharness: 2017-07-17 00:52:17.295013Z] Finished download-and-extract step (success) 17:52:17 INFO - [mozharness: 2017-07-17 00:52:17.295110Z] Running populate-webroot step. 17:52:17 INFO - Running pre-action listener: _resource_record_pre_action 17:52:17 INFO - Running main action method: populate_webroot 17:52:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:52:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:52:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:52:17 INFO - '--tppagecycles', 17:52:17 INFO - '7'], 17:52:17 INFO - 'tests': ['tsvgm']}}, 17:52:17 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:52:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:52:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:52:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:52:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:52:17 INFO - 'talos_options': ['--disable-e10s'], 17:52:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:52:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:52:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:52:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:52:17 INFO - 'talos_options': ['--disable-e10s'], 17:52:17 INFO - 'tests': ['damp', 'tps']}, 17:52:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:52:17 INFO - 'tests': ['damp', 'tps']}, 17:52:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:52:17 INFO - 'tests': ['dromaeo_dom']}, 17:52:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:52:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:52:17 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:52:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:52:17 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:52:17 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:52:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:52:17 INFO - 'tests': ['a11yr', 17:52:17 INFO - 'ts_paint', 17:52:17 INFO - 'tpaint', 17:52:17 INFO - 'sessionrestore', 17:52:17 INFO - 'sessionrestore_no_auto_restore', 17:52:17 INFO - 'tabpaint']}, 17:52:17 INFO - 'other-e10s': {'tests': ['a11yr', 17:52:17 INFO - 'ts_paint', 17:52:17 INFO - 'tpaint', 17:52:17 INFO - 'sessionrestore', 17:52:17 INFO - 'sessionrestore_many_windows', 17:52:17 INFO - 'sessionrestore_no_auto_restore', 17:52:17 INFO - 'tabpaint']}, 17:52:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:52:17 INFO - 'ts_paint', 17:52:17 INFO - 'tpaint', 17:52:17 INFO - 'sessionrestore', 17:52:17 INFO - 'sessionrestore_many_windows', 17:52:17 INFO - 'sessionrestore_no_auto_restore', 17:52:17 INFO - 'tabpaint']}, 17:52:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:52:17 INFO - 'ts_paint', 17:52:17 INFO - 'tpaint', 17:52:17 INFO - 'sessionrestore', 17:52:17 INFO - 'sessionrestore_many_windows', 17:52:17 INFO - 'sessionrestore_no_auto_restore', 17:52:17 INFO - 'tabpaint']}, 17:52:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:52:17 INFO - 'tests': ['a11yr', 17:52:17 INFO - 'ts_paint', 17:52:17 INFO - 'tpaint', 17:52:17 INFO - 'sessionrestore', 17:52:17 INFO - 'sessionrestore_no_auto_restore', 17:52:17 INFO - 'tabpaint']}, 17:52:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:52:17 INFO - 'tests': ['a11yr', 17:52:17 INFO - 'ts_paint', 17:52:17 INFO - 'tpaint', 17:52:17 INFO - 'sessionrestore', 17:52:17 INFO - 'sessionrestore_no_auto_restore', 17:52:17 INFO - 'tabpaint']}, 17:52:17 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 17:52:17 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:52:17 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 17:52:17 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:52:17 INFO - 'talos_options': ['--mitmproxy', 17:52:17 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:52:17 INFO - '--firstNonBlankPaint'], 17:52:17 INFO - 'tests': ['quantum_pageload_google', 17:52:17 INFO - 'quantum_pageload_youtube', 17:52:17 INFO - 'quantum_pageload_amazon', 17:52:17 INFO - 'quantum_pageload_facebook']}, 17:52:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:52:17 INFO - 'tests': ['tsvgx', 17:52:17 INFO - 'tsvgr_opacity', 17:52:17 INFO - 'tart', 17:52:17 INFO - 'tscrollx', 17:52:17 INFO - 'cart', 17:52:17 INFO - 'tsvg_static']}, 17:52:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:52:17 INFO - 'tsvgr_opacity', 17:52:17 INFO - 'tart', 17:52:17 INFO - 'tscrollx', 17:52:17 INFO - 'cart', 17:52:17 INFO - 'tsvg_static']}, 17:52:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:52:17 INFO - 'talos_options': ['--disable-e10s'], 17:52:17 INFO - 'tests': ['tp5o']}, 17:52:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:52:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:52:17 INFO - 'talos_options': ['--disable-e10s', 17:52:17 INFO - '--xperf_path', 17:52:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:52:17 INFO - 'tests': ['tp5n']}, 17:52:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:52:17 INFO - 'talos_options': ['--xperf_path', 17:52:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:52:17 INFO - 'tests': ['tp5n']}}, 17:52:17 INFO - 'talos.zip': {'path': '', 17:52:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:52:17 INFO - Running post-action listener: _resource_record_post_action 17:52:17 INFO - [mozharness: 2017-07-17 00:52:17.310531Z] Finished populate-webroot step (success) 17:52:17 INFO - [mozharness: 2017-07-17 00:52:17.310622Z] Running create-virtualenv step. 17:52:17 INFO - Running pre-action listener: _resource_record_pre_action 17:52:17 INFO - Running main action method: create_virtualenv 17:52:17 INFO - Creating virtualenv /builds/slave/test/build/venv 17:52:17 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 17:52:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:52:17 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:52:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:52:17 INFO - Using real prefix '/usr' 17:52:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:52:17 INFO - Installing distribute.............................................................................................................................................................................................done. 17:52:19 INFO - Installing pip.................done. 17:52:19 INFO - Return code: 0 17:52:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:52:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:52:20 INFO - Reading from file tmpfile_stdout 17:52:20 INFO - Output received: 17:52:20 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) 17:52:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:52:20 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')]} 17:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:52:20 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')]} 17:52:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:52:20 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 0x26f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a63b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a60d00>, '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 0x2a61c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a62090>, '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': '745a4373a2a16df560f216e000000264-1500246898.727850-1272901271', '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 17:52:20 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 17:52:20 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 17:52:20 INFO - Using env: {'DISPLAY': ':0', 17:52:20 INFO - 'HOME': '/home/cltbld', 17:52:20 INFO - 'LANG': 'en_US.UTF-8', 17:52:20 INFO - 'LANGUAGE': 'en_US:en', 17:52:20 INFO - 'LOGNAME': 'cltbld', 17:52:20 INFO - 'MAIL': '/var/mail/cltbld', 17:52:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:52:20 INFO - 'MOZ_NO_REMOTE': '1', 17:52:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:52:20 INFO - 'NO_EM_RESTART': '1', 17:52:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:52:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:52:20 INFO - 'PWD': '/builds/slave/test', 17:52:20 INFO - 'SHELL': '/bin/bash', 17:52:20 INFO - 'SHLVL': '1', 17:52:20 INFO - 'TERM': 'linux', 17:52:20 INFO - 'TMOUT': '86400', 17:52:20 INFO - 'USER': 'cltbld', 17:52:20 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1500246898.727850-1272901271', 17:52:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:52:20 INFO - '_': '/tools/buildbot/bin/python'} 17:52:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:52:20 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 17:52:20 INFO - Cleaning up... 17:52:20 INFO - Return code: 0 17:52:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:52:20 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')]} 17:52:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:52:20 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')]} 17:52:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:52:20 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 0x26f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a63b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a60d00>, '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 0x2a61c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a62090>, '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': '745a4373a2a16df560f216e000000264-1500246898.727850-1272901271', '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 17:52:20 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 17:52:20 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 17:52:20 INFO - Using env: {'DISPLAY': ':0', 17:52:20 INFO - 'HOME': '/home/cltbld', 17:52:20 INFO - 'LANG': 'en_US.UTF-8', 17:52:20 INFO - 'LANGUAGE': 'en_US:en', 17:52:20 INFO - 'LOGNAME': 'cltbld', 17:52:20 INFO - 'MAIL': '/var/mail/cltbld', 17:52:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:52:20 INFO - 'MOZ_NO_REMOTE': '1', 17:52:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:52:20 INFO - 'NO_EM_RESTART': '1', 17:52:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:52:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:52:20 INFO - 'PWD': '/builds/slave/test', 17:52:20 INFO - 'SHELL': '/bin/bash', 17:52:20 INFO - 'SHLVL': '1', 17:52:20 INFO - 'TERM': 'linux', 17:52:20 INFO - 'TMOUT': '86400', 17:52:20 INFO - 'USER': 'cltbld', 17:52:20 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1500246898.727850-1272901271', 17:52:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:52:20 INFO - '_': '/tools/buildbot/bin/python'} 17:52:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:52:20 INFO - Downloading/unpacking psutil>=3.1.1 17:52:20 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 17:52:20 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 17:52:20 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 17:52:20 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 17:52:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:52:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:52:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:52:21 INFO - Installing collected packages: psutil 17:52:21 INFO - Running setup.py install for psutil 17:52:21 INFO - building 'psutil._psutil_linux' extension 17:52:21 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 17:52:21 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 17:52:21 INFO - building 'psutil._psutil_posix' extension 17:52:21 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 17:52:22 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 17:52:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:52:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:52:22 INFO - Successfully installed psutil 17:52:22 INFO - Cleaning up... 17:52:22 INFO - Return code: 0 17:52:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:52:22 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')]} 17:52:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:52:22 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')]} 17:52:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:52:22 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 0x26f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a63b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a60d00>, '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 0x2a61c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a62090>, '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': '745a4373a2a16df560f216e000000264-1500246898.727850-1272901271', '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 17:52:22 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 17:52:22 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 17:52:22 INFO - Using env: {'DISPLAY': ':0', 17:52:22 INFO - 'HOME': '/home/cltbld', 17:52:22 INFO - 'LANG': 'en_US.UTF-8', 17:52:22 INFO - 'LANGUAGE': 'en_US:en', 17:52:22 INFO - 'LOGNAME': 'cltbld', 17:52:22 INFO - 'MAIL': '/var/mail/cltbld', 17:52:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:52:22 INFO - 'MOZ_NO_REMOTE': '1', 17:52:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:52:22 INFO - 'NO_EM_RESTART': '1', 17:52:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:52:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:52:22 INFO - 'PWD': '/builds/slave/test', 17:52:22 INFO - 'SHELL': '/bin/bash', 17:52:22 INFO - 'SHLVL': '1', 17:52:22 INFO - 'TERM': 'linux', 17:52:22 INFO - 'TMOUT': '86400', 17:52:22 INFO - 'USER': 'cltbld', 17:52:22 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1500246898.727850-1272901271', 17:52:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:52:22 INFO - '_': '/tools/buildbot/bin/python'} 17:52:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:52:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:52:22 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 17:52:22 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 17:52:22 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 17:52:22 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 17:52:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:52:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:52:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:52:23 INFO - Installing collected packages: mozsystemmonitor 17:52:23 INFO - Running setup.py install for mozsystemmonitor 17:52:23 INFO - Successfully installed mozsystemmonitor 17:52:23 INFO - Cleaning up... 17:52:23 INFO - Return code: 0 17:52:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:52:23 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')]} 17:52:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:52:23 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')]} 17:52:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:52:23 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 0x26f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a63b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a60d00>, '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 0x2a61c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a62090>, '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': '745a4373a2a16df560f216e000000264-1500246898.727850-1272901271', '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 17:52:23 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 17:52:23 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 17:52:23 INFO - Using env: {'DISPLAY': ':0', 17:52:23 INFO - 'HOME': '/home/cltbld', 17:52:23 INFO - 'LANG': 'en_US.UTF-8', 17:52:23 INFO - 'LANGUAGE': 'en_US:en', 17:52:23 INFO - 'LOGNAME': 'cltbld', 17:52:23 INFO - 'MAIL': '/var/mail/cltbld', 17:52:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:52:23 INFO - 'MOZ_NO_REMOTE': '1', 17:52:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:52:23 INFO - 'NO_EM_RESTART': '1', 17:52:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:52:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:52:23 INFO - 'PWD': '/builds/slave/test', 17:52:23 INFO - 'SHELL': '/bin/bash', 17:52:23 INFO - 'SHLVL': '1', 17:52:23 INFO - 'TERM': 'linux', 17:52:23 INFO - 'TMOUT': '86400', 17:52:23 INFO - 'USER': 'cltbld', 17:52:23 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1500246898.727850-1272901271', 17:52:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:52:23 INFO - '_': '/tools/buildbot/bin/python'} 17:52:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:52:23 INFO - Downloading/unpacking jsonschema==2.5.1 17:52:23 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 17:52:23 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 17:52:23 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 17:52:23 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 17:52:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:52:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:52:24 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 17:52:24 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 17:52:24 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 17:52:24 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 17:52:25 INFO - Downloading functools32-3.2.3-2.tar.gz 17:52:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:52:25 INFO - warning: no files found matching '*.txt' 17:52:25 INFO - no previously-included directories found matching 'build' 17:52:25 INFO - no previously-included directories found matching 'dist' 17:52:25 INFO - no previously-included directories found matching '.git*' 17:52:25 INFO - Installing collected packages: jsonschema, functools32 17:52:25 INFO - Running setup.py install for functools32 17:52:25 INFO - warning: no files found matching '*.txt' 17:52:25 INFO - no previously-included directories found matching 'build' 17:52:25 INFO - no previously-included directories found matching 'dist' 17:52:25 INFO - no previously-included directories found matching '.git*' 17:52:25 INFO - Successfully installed jsonschema functools32 17:52:25 INFO - Cleaning up... 17:52:25 INFO - Return code: 0 17:52:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:52:25 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')]} 17:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:52:25 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')]} 17:52:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:52:25 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 0x26f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a63b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a60d00>, '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 0x2a61c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a62090>, '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': '745a4373a2a16df560f216e000000264-1500246898.727850-1272901271', '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 17:52:25 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 17:52:25 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 17:52:25 INFO - Using env: {'DISPLAY': ':0', 17:52:25 INFO - 'HOME': '/home/cltbld', 17:52:25 INFO - 'LANG': 'en_US.UTF-8', 17:52:25 INFO - 'LANGUAGE': 'en_US:en', 17:52:25 INFO - 'LOGNAME': 'cltbld', 17:52:25 INFO - 'MAIL': '/var/mail/cltbld', 17:52:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:52:25 INFO - 'MOZ_NO_REMOTE': '1', 17:52:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:52:25 INFO - 'NO_EM_RESTART': '1', 17:52:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:52:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:52:25 INFO - 'PWD': '/builds/slave/test', 17:52:25 INFO - 'SHELL': '/bin/bash', 17:52:25 INFO - 'SHLVL': '1', 17:52:25 INFO - 'TERM': 'linux', 17:52:25 INFO - 'TMOUT': '86400', 17:52:25 INFO - 'USER': 'cltbld', 17:52:25 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1500246898.727850-1272901271', 17:52:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:52:25 INFO - '_': '/tools/buildbot/bin/python'} 17:52:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:52:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:52:25 INFO - Cleaning up... 17:52:25 INFO - Return code: 0 17:52:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:52:25 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')]} 17:52:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:52:25 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')]} 17:52:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:52:25 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 0x26f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a63b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a60d00>, '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 0x2a61c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a62090>, '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': '745a4373a2a16df560f216e000000264-1500246898.727850-1272901271', '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 17:52:25 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 17:52:25 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 17:52:25 INFO - Using env: {'DISPLAY': ':0', 17:52:25 INFO - 'HOME': '/home/cltbld', 17:52:25 INFO - 'LANG': 'en_US.UTF-8', 17:52:25 INFO - 'LANGUAGE': 'en_US:en', 17:52:25 INFO - 'LOGNAME': 'cltbld', 17:52:25 INFO - 'MAIL': '/var/mail/cltbld', 17:52:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:52:25 INFO - 'MOZ_NO_REMOTE': '1', 17:52:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:52:25 INFO - 'NO_EM_RESTART': '1', 17:52:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:52:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:52:25 INFO - 'PWD': '/builds/slave/test', 17:52:25 INFO - 'SHELL': '/bin/bash', 17:52:25 INFO - 'SHLVL': '1', 17:52:25 INFO - 'TERM': 'linux', 17:52:25 INFO - 'TMOUT': '86400', 17:52:25 INFO - 'USER': 'cltbld', 17:52:25 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1500246898.727850-1272901271', 17:52:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:52:25 INFO - '_': '/tools/buildbot/bin/python'} 17:52:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:52:25 INFO - Downloading/unpacking blobuploader==1.2.4 17:52:25 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 17:52:25 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 17:52:25 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 17:52:25 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 17:52:26 INFO - Downloading blobuploader-1.2.4.tar.gz 17:52:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:52:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:52:27 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 17:52:27 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 17:52:27 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 17:52:27 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 17:52:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:52:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:52:27 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 17:52:27 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 17:52:27 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 17:52:27 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 17:52:27 INFO - Downloading docopt-0.6.1.tar.gz 17:52:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:52:27 INFO - Installing collected packages: blobuploader, requests, docopt 17:52:27 INFO - Running setup.py install for blobuploader 17:52:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:52:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:52:27 INFO - Running setup.py install for requests 17:52:27 INFO - Running setup.py install for docopt 17:52:28 INFO - Successfully installed blobuploader requests docopt 17:52:28 INFO - Cleaning up... 17:52:28 INFO - Return code: 0 17:52:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:52:28 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')]} 17:52:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:52:28 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')]} 17:52:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:52:28 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 0x26f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a63b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a60d00>, '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 0x2a61c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a62090>, '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': '745a4373a2a16df560f216e000000264-1500246898.727850-1272901271', '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 17:52:28 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 17:52:28 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 17:52:28 INFO - Using env: {'DISPLAY': ':0', 17:52:28 INFO - 'HOME': '/home/cltbld', 17:52:28 INFO - 'LANG': 'en_US.UTF-8', 17:52:28 INFO - 'LANGUAGE': 'en_US:en', 17:52:28 INFO - 'LOGNAME': 'cltbld', 17:52:28 INFO - 'MAIL': '/var/mail/cltbld', 17:52:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:52:28 INFO - 'MOZ_NO_REMOTE': '1', 17:52:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:52:28 INFO - 'NO_EM_RESTART': '1', 17:52:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:52:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:52:28 INFO - 'PWD': '/builds/slave/test', 17:52:28 INFO - 'SHELL': '/bin/bash', 17:52:28 INFO - 'SHLVL': '1', 17:52:28 INFO - 'TERM': 'linux', 17:52:28 INFO - 'TMOUT': '86400', 17:52:28 INFO - 'USER': 'cltbld', 17:52:28 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1500246898.727850-1272901271', 17:52:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:52:28 INFO - '_': '/tools/buildbot/bin/python'} 17:52:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:52:28 INFO - Running setup.py (path:/tmp/pip-rUzafv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:52:28 INFO - Running setup.py (path:/tmp/pip-4ZerNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:52:28 INFO - Running setup.py (path:/tmp/pip-DUGsT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:52:28 INFO - Running setup.py (path:/tmp/pip-Dd5iXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:52:28 INFO - Running setup.py (path:/tmp/pip-zWFUjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:52:28 INFO - Running setup.py (path:/tmp/pip-QIN885-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:52:28 INFO - Running setup.py (path:/tmp/pip-pAGcql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:52:28 INFO - Running setup.py (path:/tmp/pip-N4WI7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:52:28 INFO - Running setup.py (path:/tmp/pip-UrTd4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:52:29 INFO - Running setup.py (path:/tmp/pip-h2pFHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:52:29 INFO - Running setup.py (path:/tmp/pip-Ixs3JA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:52:29 INFO - Running setup.py (path:/tmp/pip-eZMhua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:52:29 INFO - Running setup.py (path:/tmp/pip-SQIBm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:52:29 INFO - Running setup.py (path:/tmp/pip-WOIFey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:52:29 INFO - Running setup.py (path:/tmp/pip-GQEWcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:52:29 INFO - Running setup.py (path:/tmp/pip-tukNWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:52:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:52:29 INFO - Running setup.py (path:/tmp/pip-l3hN1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:52:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:52:29 INFO - Running setup.py install for manifestparser 17:52:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:52:29 INFO - Running setup.py install for mozcrash 17:52:29 INFO - Running setup.py install for mozdebug 17:52:29 INFO - Running setup.py install for mozdevice 17:52:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:52:30 INFO - Running setup.py install for mozfile 17:52:30 INFO - Running setup.py install for mozhttpd 17:52:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:52:30 INFO - Running setup.py install for mozinfo 17:52:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:52:30 INFO - Running setup.py install for mozInstall 17:52:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:52:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:52:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:52:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:52:30 INFO - Running setup.py install for mozleak 17:52:30 INFO - Running setup.py install for mozlog 17:52:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:52:30 INFO - Running setup.py install for moznetwork 17:52:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:52:30 INFO - Running setup.py install for mozprocess 17:52:30 INFO - Running setup.py install for mozprofile 17:52:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:52:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:52:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:52:30 INFO - Running setup.py install for mozrunner 17:52:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:52:31 INFO - Running setup.py install for mozscreenshot 17:52:31 INFO - Running setup.py install for moztest 17:52:31 INFO - Running setup.py install for mozversion 17:52:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:52:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:52:31 INFO - Cleaning up... 17:52:31 INFO - Return code: 0 17:52:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:52:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:52:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:52:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:52:31 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 0x26f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a63b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a60d00>, '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 0x2a61c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a62090>, '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': '745a4373a2a16df560f216e000000264-1500246898.727850-1272901271', '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 17:52:31 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 17:52:31 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 17:52:31 INFO - Using env: {'DISPLAY': ':0', 17:52:31 INFO - 'HOME': '/home/cltbld', 17:52:31 INFO - 'LANG': 'en_US.UTF-8', 17:52:31 INFO - 'LANGUAGE': 'en_US:en', 17:52:31 INFO - 'LOGNAME': 'cltbld', 17:52:31 INFO - 'MAIL': '/var/mail/cltbld', 17:52:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:52:31 INFO - 'MOZ_NO_REMOTE': '1', 17:52:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:52:31 INFO - 'NO_EM_RESTART': '1', 17:52:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:52:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:52:31 INFO - 'PWD': '/builds/slave/test', 17:52:31 INFO - 'SHELL': '/bin/bash', 17:52:31 INFO - 'SHLVL': '1', 17:52:31 INFO - 'TERM': 'linux', 17:52:31 INFO - 'TMOUT': '86400', 17:52:31 INFO - 'USER': 'cltbld', 17:52:31 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1500246898.727850-1272901271', 17:52:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:52:31 INFO - '_': '/tools/buildbot/bin/python'} 17:52:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:52:31 INFO - Running setup.py (path:/tmp/pip-YAtmzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:52:31 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)) 17:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:52:31 INFO - Running setup.py (path:/tmp/pip-ETQJiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:52:31 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)) 17:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:52:31 INFO - Running setup.py (path:/tmp/pip-uITIum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:52:31 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)) 17:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:52:31 INFO - Running setup.py (path:/tmp/pip-9ng4DY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:52:31 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)) 17:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:52:31 INFO - Running setup.py (path:/tmp/pip-7NLBHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:52:31 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)) 17:52:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:52:31 INFO - Running setup.py (path:/tmp/pip-ctR5NQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:52:32 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)) 17:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:52:32 INFO - Running setup.py (path:/tmp/pip-nMh4Ww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:52:32 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)) 17:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:52:32 INFO - Running setup.py (path:/tmp/pip-ZfRSRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:52:32 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)) 17:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:52:32 INFO - Running setup.py (path:/tmp/pip-100Wc5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:52:32 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)) 17:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:52:32 INFO - Running setup.py (path:/tmp/pip-9McOlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:52:32 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)) 17:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:52:32 INFO - Running setup.py (path:/tmp/pip-ly2p0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:52:32 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)) 17:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:52:32 INFO - Running setup.py (path:/tmp/pip-fzUQ3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:52:32 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)) 17:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:52:32 INFO - Running setup.py (path:/tmp/pip-hOCBn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:52:32 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)) 17:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:52:32 INFO - Running setup.py (path:/tmp/pip-VHip2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:52:32 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)) 17:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:52:32 INFO - Running setup.py (path:/tmp/pip-K0sOhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:52:32 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)) 17:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:52:32 INFO - Running setup.py (path:/tmp/pip-VohGRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:52:32 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)) 17:52:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:52:32 INFO - Running setup.py (path:/tmp/pip-y8ShLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:52:32 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)) 17:52:32 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)) 17:52:32 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)) 17:52:32 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)) 17:52:32 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)) 17:52:32 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)) 17:52:32 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)) 17:52:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:52:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:52:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:52:33 INFO - Downloading blessings-1.6.tar.gz 17:52:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:52:34 INFO - Installing collected packages: blessings 17:52:34 INFO - Running setup.py install for blessings 17:52:34 INFO - Successfully installed blessings 17:52:34 INFO - Cleaning up... 17:52:34 INFO - Return code: 0 17:52:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:52:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:52:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:52:34 INFO - Reading from file tmpfile_stdout 17:52:34 INFO - Current package versions: 17:52:34 INFO - argparse == 1.2.1 17:52:34 INFO - blessings == 1.6 17:52:34 INFO - blobuploader == 1.2.4 17:52:34 INFO - docopt == 0.6.1 17:52:34 INFO - functools32 == 3.2.3-2 17:52:34 INFO - jsonschema == 2.5.1 17:52:34 INFO - manifestparser == 1.1 17:52:34 INFO - mozInstall == 1.13 17:52:34 INFO - mozcrash == 1.0 17:52:34 INFO - mozdebug == 0.1 17:52:34 INFO - mozdevice == 0.51 17:52:34 INFO - mozfile == 1.2 17:52:34 INFO - mozhttpd == 0.7 17:52:34 INFO - mozinfo == 0.10 17:52:34 INFO - mozleak == 0.1 17:52:34 INFO - mozlog == 3.5 17:52:34 INFO - moznetwork == 0.27 17:52:34 INFO - mozprocess == 0.25 17:52:34 INFO - mozprofile == 0.28 17:52:34 INFO - mozrunner == 6.13 17:52:34 INFO - mozscreenshot == 0.1 17:52:34 INFO - mozsystemmonitor == 0.3 17:52:34 INFO - moztest == 0.8 17:52:34 INFO - mozversion == 1.4 17:52:34 INFO - psutil == 3.1.1 17:52:34 INFO - requests == 1.2.3 17:52:34 INFO - wsgiref == 0.1.2 17:52:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:52:34 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')]} 17:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:52:34 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')]} 17:52:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:52:34 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 0x26f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a63b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a60d00>, '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 0x2a61c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a62090>, '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': '745a4373a2a16df560f216e000000264-1500246898.727850-1272901271', '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 17:52:34 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 17:52:34 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 17:52:34 INFO - Using env: {'DISPLAY': ':0', 17:52:34 INFO - 'HOME': '/home/cltbld', 17:52:34 INFO - 'LANG': 'en_US.UTF-8', 17:52:34 INFO - 'LANGUAGE': 'en_US:en', 17:52:34 INFO - 'LOGNAME': 'cltbld', 17:52:34 INFO - 'MAIL': '/var/mail/cltbld', 17:52:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:52:34 INFO - 'MOZ_NO_REMOTE': '1', 17:52:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:52:34 INFO - 'NO_EM_RESTART': '1', 17:52:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:52:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:52:34 INFO - 'PWD': '/builds/slave/test', 17:52:34 INFO - 'SHELL': '/bin/bash', 17:52:34 INFO - 'SHLVL': '1', 17:52:34 INFO - 'TERM': 'linux', 17:52:34 INFO - 'TMOUT': '86400', 17:52:34 INFO - 'USER': 'cltbld', 17:52:34 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1500246898.727850-1272901271', 17:52:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:52:34 INFO - '_': '/tools/buildbot/bin/python'} 17:52:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:52:34 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)) 17:52:34 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)) 17:52:34 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)) 17:52:34 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)) 17:52:34 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)) 17:52:34 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)) 17:52:34 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)) 17:52:34 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)) 17:52:34 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)) 17:52:34 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:52:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:52:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:52:35 INFO - Downloading marionette_driver-1.4.0.tar.gz 17:52:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 17:52:35 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 17:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:52:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:52:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:52:35 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)) 17:52:35 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)) 17:52:35 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)) 17:52:35 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)) 17:52:35 INFO - Installing collected packages: marionette-driver, simplejson 17:52:36 INFO - Running setup.py install for marionette-driver 17:52:36 INFO - Running setup.py install for simplejson 17:52:36 INFO - building 'simplejson._speedups' extension 17:52:36 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 17:52:37 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 17:52:37 INFO - Successfully installed marionette-driver simplejson 17:52:37 INFO - Cleaning up... 17:52:37 INFO - Return code: 0 17:52:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:52: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')]} 17:52:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:52: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')]} 17:52:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:52:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a63b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a60d00>, '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 0x2a61c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a62090>, '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': '745a4373a2a16df560f216e000000264-1500246898.727850-1272901271', '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 17:52:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:52:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:52:37 INFO - Using env: {'DISPLAY': ':0', 17:52:37 INFO - 'HOME': '/home/cltbld', 17:52:37 INFO - 'LANG': 'en_US.UTF-8', 17:52:37 INFO - 'LANGUAGE': 'en_US:en', 17:52:37 INFO - 'LOGNAME': 'cltbld', 17:52:37 INFO - 'MAIL': '/var/mail/cltbld', 17:52:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:52:37 INFO - 'MOZ_NO_REMOTE': '1', 17:52:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:52:37 INFO - 'NO_EM_RESTART': '1', 17:52:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:52:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:52:37 INFO - 'PWD': '/builds/slave/test', 17:52:37 INFO - 'SHELL': '/bin/bash', 17:52:37 INFO - 'SHLVL': '1', 17:52:37 INFO - 'TERM': 'linux', 17:52:37 INFO - 'TMOUT': '86400', 17:52:37 INFO - 'USER': 'cltbld', 17:52:37 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1500246898.727850-1272901271', 17:52:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:52:37 INFO - '_': '/tools/buildbot/bin/python'} 17:52:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:52:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:52:37 INFO - Cleaning up... 17:52:37 INFO - Return code: 0 17:52:37 INFO - Running post-action listener: _resource_record_post_action 17:52:37 INFO - Running post-action listener: _start_resource_monitoring 17:52:37 INFO - Starting resource monitoring. 17:52:37 INFO - [mozharness: 2017-07-17 00:52:37.415154Z] Finished create-virtualenv step (success) 17:52:37 INFO - [mozharness: 2017-07-17 00:52:37.415678Z] Running install step. 17:52:37 INFO - Running pre-action listener: _resource_record_pre_action 17:52:37 INFO - Running main action method: install 17:52:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:52:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:52:37 INFO - Reading from file tmpfile_stdout 17:52:37 INFO - Detecting whether we're running mozinstall >=1.0... 17:52:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:52:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:52:37 INFO - Reading from file tmpfile_stdout 17:52:37 INFO - Output received: 17:52:37 INFO - Usage: mozinstall [options] installer 17:52:37 INFO - Options: 17:52:37 INFO - -h, --help show this help message and exit 17:52:37 INFO - -d DEST, --destination=DEST 17:52:37 INFO - Directory to install application into. [default: 17:52:37 INFO - "/builds/slave/test"] 17:52:37 INFO - --app=APP Application being installed. [default: firefox] 17:52:37 INFO - mkdir: /builds/slave/test/build/application 17:52:37 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'] 17:52:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:52:55 INFO - Reading from file tmpfile_stdout 17:52:55 INFO - Output received: 17:52:55 INFO - /builds/slave/test/build/application/firefox/firefox 17:52:55 INFO - Running post-action listener: _resource_record_post_action 17:52:55 INFO - [mozharness: 2017-07-17 00:52:55.670533Z] Finished install step (success) 17:52:55 INFO - [mozharness: 2017-07-17 00:52:55.670789Z] Running setup-mitmproxy step. 17:52:55 INFO - Running pre-action listener: _resource_record_pre_action 17:52:55 INFO - Running main action method: setup_mitmproxy 17:52:55 INFO - Skipping: mitmproxy is not required 17:52:55 INFO - Running post-action listener: _resource_record_post_action 17:52:55 INFO - [mozharness: 2017-07-17 00:52:55.671945Z] Finished setup-mitmproxy step (success) 17:52:55 INFO - [mozharness: 2017-07-17 00:52:55.672170Z] Running run-tests step. 17:52:55 INFO - Running pre-action listener: _resource_record_pre_action 17:52:55 INFO - Running pre-action listener: _set_gcov_prefix 17:52:55 INFO - Running main action method: run_tests 17:52:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:52:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:52:55 INFO - Python 2.7.3 17:52:55 INFO - Return code: 0 17:52:55 INFO - grabbing minidump binary from tooltool 17:52:55 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')]} 17:52:55 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 0x2a60d00>, '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 0x2a61c00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a62090>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:52:55 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 17:52:55 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 17:52:55 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 17:52:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:52:55 INFO - Return code: 0 17:52:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:52:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:52:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:52:55 INFO - ENV: RUST_BACKTRACE is now 1 17:52:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:52:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:52:55 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/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 17:52:55 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/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-032 --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 17:52:55 INFO - Using env: {'DISPLAY': ':0', 17:52:55 INFO - 'HOME': '/home/cltbld', 17:52:55 INFO - 'LANG': 'en_US.UTF-8', 17:52:55 INFO - 'LANGUAGE': 'en_US:en', 17:52:55 INFO - 'LOGNAME': 'cltbld', 17:52:55 INFO - 'MAIL': '/var/mail/cltbld', 17:52:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:52:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:52:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:52:55 INFO - 'MOZ_NO_REMOTE': '1', 17:52:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:52:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:52:55 INFO - 'NO_EM_RESTART': '1', 17:52:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:52:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:52:55 INFO - 'PWD': '/builds/slave/test', 17:52:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:52:55 INFO - 'RUST_BACKTRACE': '1', 17:52:55 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:52:55 INFO - 'SHELL': '/bin/bash', 17:52:55 INFO - 'SHLVL': '1', 17:52:55 INFO - 'TERM': 'linux', 17:52:55 INFO - 'TMOUT': '86400', 17:52:55 INFO - 'USER': 'cltbld', 17:52:55 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1500246898.727850-1272901271', 17:52:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:52:55 INFO - '_': '/tools/buildbot/bin/python'} 17:52:55 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/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--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 17:52:56 INFO - mozversion application_buildid: 20170717000747 17:52:56 INFO - mozversion application_changeset: aff336ac161daa3ea350e59a288963edbd58ed39 17:52:56 INFO - mozversion application_display_name: Nightly 17:52:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:52:56 INFO - mozversion application_name: Firefox 17:52:56 INFO - mozversion application_remotingname: firefox 17:52:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:52:56 INFO - mozversion application_vendor: Mozilla 17:52:56 INFO - mozversion application_version: 56.0a1 17:52:56 INFO - mozversion platform_buildid: 20170717000747 17:52:56 INFO - mozversion platform_changeset: aff336ac161daa3ea350e59a288963edbd58ed39 17:52:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:52:56 INFO - mozversion platform_version: 56.0a1 17:52:56 INFO - using testdate: 1500252776 17:52:56 INFO - actual date: 1500252776 17:52:56 INFO - starting webserver on 'localhost:44615' 17:52:56 INFO - SUITE-START | Running 2 tests 17:52:56 INFO - TEST-START | dromaeo_css 17:52:56 INFO - Initialising browser for dromaeo_css test... 17:52:56 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44615/getInfo.html -profile /tmp/tmpEUXRNX/profile 17:52:56 INFO - TEST-INFO | started process 5500 (/builds/slave/test/build/application/firefox/firefox http://localhost:44615/getInfo.html) 17:53:02 INFO - TEST-INFO | 5500: exit 0 17:53:02 INFO - Browser initialized. 17:53:02 INFO - Running cycle 1/1 for dromaeo_css test... 17:53:02 INFO - TEST-INFO | started process 5729 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEUXRNX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:53:14 INFO - PID 5729 | RSS: Main: 173334528 17:53:14 INFO - PID 5729 | 17:56:12 INFO - PID 5729 | Cycle 1(1): loaded http://localhost:44615/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44615/tests/dromaeo/cssquery-ext.html) 17:56:13 INFO - PID 5729 | RSS: Main: 178274304 17:56:13 INFO - PID 5729 | 17:59:15 INFO - PID 5729 | Cycle 1(1): loaded http://localhost:44615/tests/dromaeo/cssquery-ext.html (next: http://localhost:44615/tests/dromaeo/cssquery-jquery.html) 17:59:16 INFO - PID 5729 | RSS: Main: 176902144 17:59:16 INFO - PID 5729 | 18:02:17 INFO - PID 5729 | Cycle 1(1): loaded http://localhost:44615/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44615/tests/dromaeo/cssquery-mootools.html) 18:02:18 INFO - PID 5729 | RSS: Main: 179245056 18:02:18 INFO - PID 5729 | 18:05:20 INFO - PID 5729 | Cycle 1(1): loaded http://localhost:44615/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44615/tests/dromaeo/cssquery-prototype.html) 18:05:20 INFO - PID 5729 | RSS: Main: 175751168 18:05:20 INFO - PID 5729 | 18:08:24 INFO - PID 5729 | Cycle 1(1): loaded http://localhost:44615/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44615/tests/dromaeo/cssquery-yui.html) 18:08:24 INFO - PID 5729 | RSS: Main: 176697344 18:08:24 INFO - PID 5729 | 18:11:26 INFO - PID 5729 | Cycle 1(1): loaded http://localhost:44615/tests/dromaeo/cssquery-yui.html (next: http://localhost:44615/tests/dromaeo/cssquery-dojo.html) 18:11:26 INFO - PID 5729 | RSS: Main: 180187136 18:11:26 INFO - PID 5729 | 18:11:26 INFO - PID 5729 | __start_tp_report 18:11:26 INFO - PID 5729 | _x_x_mozilla_page_load 18:11:26 INFO - PID 5729 | _x_x_mozilla_page_load_details 18:11:26 INFO - PID 5729 | |i|pagename|runs| 18:11:26 INFO - PID 5729 | |0;dojo.html;3071.8617662205197;3126.968730312697;3143.1984843864825;3157.9684203157963;3166.050184944516;5839.386864379243;5861.150133230684;5882.911756323659;5897.3218079920825;5954.9281129396695;5935.554833387491;5936.851578710534;5937.940620593793;5942.61373010754;5965.373635768236;5459.754311055992;5484.204790305414;5495.505404513593;5510.91733623996;5520.806771762989;5476.534494567966;5478.369987451454;5484.780608775644;5498.340199176105;5522.3649280332675;5508.173773933902;5509.944900551003;5513.3108361454815;5519.862003449905;5534.03154447972;5505.3393592768725;5515.61390702651;5518.117101263799;5528.861778455531;5532.059549876511;5403.351597808288;5473.452654734535;5486.835394938158;5503.889922201573;5584.21820945068;5982.7906023289415;5992.34084250732;6046.516278697693;6050.334463209044;6113.144159817629;6383.106365108889;6384.904226436607;6473.546851720382;6475.870482590321;6493.51298652603;6305.621662700252;6353.269374022;6353.745850165988;6379.202599675041;6405.071264666597;5939.406059394069;5957.8808423831715;5961.493273071794;5969.791057312973;5976.402359764033;6490.38341357575;6543.378379053982;6566.540342176002;6613.371729685672;6675.699593518206;6195.659238741912;6244.937550624527;6259.530535209878;6344.143540622049;6344.777932772331;6250.624962502265;6336.778212762531;6353.36466353361;6397.6801159941815;6436.517261205428;6213.254409470802;6289.245290565162;6348.396902294275;6359.364063593696;6415.582987105823;5888.499477544457;6407.583507072025;6421.903671444932;6434.195725534309;6458.903116453257;5195.84412467619;5207.218917162456;5269.314989051399;5270.893112446429;5271.20931860224;4411.602955733999;4489.595936365743;4497.05561832019;4515.571020753023;4523.411956445641;5501.394846566875;5514.255575497336;5525.475079867406;5534.944650553443;5535.391106978229;6362.77730279438;6366.108744775735;6372.522060845455;6378.043293506012;6380.106785050097;5506.862328441821;5547.16792481123;5559.249501317351;5599.300087489064;5629.549636029108;5555.2778138842505;5604.467575580314;5622.803201887914;5688.033034384164;5760.53915686744;6092.908606370908;6103.42017508336;6120.081987701791;6124.724387402578;6132.141500189977;6184;6239.032949892774;6244.000959846494;6257.530685198537;6265;5342.225377320189;6095.420935011167;6102.206713127265;6278.623282603058;6367.395097465734;6346.841328966812;6369.14016607752;6447.871042579216;6449.129367535323;6462.515311351762;6463.547551671526;6481.125048118443;6591.307912669101;6599.274079851117;6599.835004124743;6124.846878827887;6227.19046523949;6231.345708700521;6272.780452684134;6380.330065343072;6258.217722784652;6279.466245369194;6286.119943208046;6296.937030629819;6299.716512756845;6148.78479253224;6166.075088736546;6173.074038894202;6179.5056395489155;6190.473809726223;5352.571794256528;6260.373962603703;6319;6354.6822658867795;6390.456811170917;6109.816705498843;6141.447269745744;6195.256569211723;6201.224846894138;6223.564350495421 18:11:26 INFO - PID 5729 | |1;ext.html;785.5914924239396;823.6129019360899;849.8852654891589;875.3566128895263;876.6975393489244;40686;41011.58988410115;41559.37660935088;41600.16799664013;41625.79187104068;37662.81168594153;37795.055123621925;38094;38130.8093459533;38154.618453815456;6936.6184859832565;7029.718811247544;7038.85922281554;7045.964770176142;7046.365827075562;6954.09596752424;7026.297370262984;7056.294370562929;7062.399696025844;7070.116235470567;7004.29957004298;7009.299070093001;7031.613261270628;7031.718731250769;7047.788566343018;6976.058232138647;7005.299470052954;7016.9999999999745;7024.2273349931465;7037.577745335297;6382.36176382358;6409.294977552466;6421.582597131218;6426.164598602152;6432.935670643281;33509.329813403594;33865.6613433865;33930.49104263438;33953.49069763956;34135.48796768051;3407.216340241758;3435.6220815710253;3444.603870554868;3534.91162720934;3585.4442561403025;31011.534826977615;31035.534466983012;31244.531332030037;31375.529367059513;31408.528872066938;4911.189653707134;4917.72952487613;4959.305697202394;4979.427365852901;4996.600271978233;178009.9999999987;178510;181691.09154454275;181743;182649;48772.26841597379;49213.507864920895;49225.50774492281;49350.50649493531;49553;51012.74493627508;51270.230946535834;51402;51404.48595513997;51522.484775152516;15532.767008494882;15592.922035389978;15615.375384984472;15648.139352335731;15655.373785048698;13229.073964822563;13266;13277.535286264934;13406.329683515785;13418.93290533541;14421.278936053155;14527.636809079646;14536;14675.881531681463;14812.185329806964;5863.7947671832135;5915.58590898633;5979.5515336349945;6006.6696331701305;6020.157177995085;972.246508955551;991.7818080022383;1015.9085682288629;1016.4409574733867;1020.0936577217973;22425.959663915233;22502.774972250394;23213.41966450852;23411.297661070195;23843.642345364835;1056.434807378049;1098.3519723363254;1099.0932480703452;1102.8180350242121;1110.1119104716195;11984.940075299568;12007.579734709243;12094.697632559257;12193.634190974284;12303.95416389599;224007;224069;226465;227268;228553;50766.238506422436;50830.23754643683;50907.49092509101;51006.48993510017;51052;1403.5578792680274;1468.41263494603;1474.8820094392638;1480.407836865241;1485.2351039214814;21065.684014739483;22021.449463762892;22344.77655223427;22501.43746406353;22645.094196231967;36709;37107.814460927526;37316.440253395675;37545;37603.2479350406;200129;200230;201613;201873;202613;31239.531407029368;31797.04608861738;31862.203444914063;31957.20106997344;34217.486737698455;38866.4170037444;38961.805190973864;38994.80502597469;41102.58897410987;43815.56184438242;30823;31741.8412907934;32038;32221;32479;30921.8453907729;31137;31357.52963705592;31542.684573154893;31641.20896977502;34442;34473.482897756054;34535.82732086324;34900.65099349076;35396.29207415889;30178.69821301759;30481.54277685792;30733.385332293677;30737.53893691641;30905;21173;23080.769192308533;23140.652890207;23188.3043508695;23198.420039498473 18:11:26 INFO - PID 5729 | |2;jquery.html;565.2538648983343;569.6695916368507;570.4181734630677;574.4284436985199;595.8331667133201;21724.34826955192;22693.659595106088;22702.77297227027;22711.54576908463;22830.657540136912;24873;25989.740102598967;27298.45403091937;27548.311292217706;27565.448691026166;6389.616623002611;6550.508711846607;6554.180727409074;6565.737370505174;6567.704453299589;6450.6452145132;6492.253390860064;6515.34846515347;6535.803925882231;6540.117084193645;4056.1684854604737;4916;5628.846086552247;6396.61620302781;6473.1261279727105;6459.580127291711;6476.7370362779275;6522.771702990372;6530.249021362532;6531.934680653204;5954.077118046666;6009.2188015557695;6035.124906888521;6064.9090263646085;6067.18093057436;28718.138455846358;30632.84683576568;31101.84449077763;31118.066458006295;31187.688123118704;1935.7580302462193;1957.7552805899263;1965.9410217693492;1969.5371587676884;1978.4262563856464;18665.973371464563;19311.130999105073;19315.903420482948;19361.612767744566;19367.418977430698;2299.8965046572944;2316.7683231676697;2379.0959435414434;2381.368937231635;2396.6405039244078;134434;137282;138823;139664;143777.28111359375;14100.717985640229;14814.259287035606;14905.850941490664;15144.318505667272;15644.92177539105;24068.39829004289;24090.879545602158;24124.27627171188;24135;24148;10023.19118734876;10253.411306042974;10311.07200351972;10322.174226061898;10581.153507719519;9578.425294482215;9617.749692539925;9696.466694331739;9726.36778609388;9847.60609575609;9057.909420905838;9489.383190092622;9511.57197926081;9623.615055397846;9711.36876103051;2675.6254124422207;2790.3024243939017;2817.971820281812;2830.36316828716;2934.105097945147;975.7365511311906;981.2429735113666;982.2044144243185;995.8058178655093;1009.5255230041869;19844.20623175057;20212.09045592952;20334.389968300973;20465.976701164884;20597.279095231595;954.5609019850807;1010.4442556593845;1025.4669269442084;1044.3629386074488;1055.3931489393628;10760.246782725291;11126.443677816076;11182.217244792786;11216.046636035866;11219.439028048564;448647;460267;470450;477534;477940;111264.4436777827;111776.44111779389;111952.44023779992;113457;113641;1182.8521434820648;1207.7886369885234;1219.5792451604182;1222.2238878312335;1236.505397840871;17575.912120439316;17656.470305890845;17686.823131768517;17702.380416685355;18130;48791.75604121957;51222.74388628033;53283.4671653294;55411.44588554224;58407.70796145992;70352.64823675848;72121.27878721355;72365.6381718109;73114;73273.6336318315;14692.191929443983;15269.312880920608;15270.083794972337;15419.460318889234;15428.84571154274;23768.168114115924;24249.636255456535;24333.296669232983;24496.265112046665;24641.507169856144;19099.140538675514;19258.90370548138;19422.805771942665;19611.215551377783;19628.116734746684;16444.67110657804;17633.64732705313;18126.5468363292;18151;18165.36421225251;18909.338173163873;19705.90147049313;20216.292429765475;20331.186752529735;20340.79659203389;15254.466093686668;15291.464798731991;15459.536213913601;15474.226288685746;15476.374980626872;18772;18840.152193151614;18908;19237;19485.707714384578 18:11:26 INFO - PID 5729 | |3;mootools.html;1348.4067010515373;1366.590022993102;1373.5055380063175;1385.840628327742;1395.8464568897423;12671;13274.070815042951;13277.734445311087;13304.401301941412;13326.866731332708;12813.231206127639;13235.272060036694;13428.932855335734;13539.526116585921;13549.864501354983;2561.3724637463847;2635.3806855388966;2652.071774878796;2657.9734202658015;2669.2659518632436;2530.5318516074494;2595.0657763205327;2619.8952041918396;2624.527585034693;2626.107123577983;2458.2625212436287;2488.415222422729;2492.962605560918;2494.2143224884194;2500.0749722602663;2486.266551367342;2592.41670624109;2652.5358062339014;2662.5739881619043;2669.866506674668;2598.8180827342094;2653.150991682662;2657.096587160375;2660.015794156155;2662.60060990851;13626.1143025703;13678.658033549142;13747.862521374758;13747.862521374758;13751.656208594764;7094.929050709478;7455.664495097733;7456.918746781686;7475.177730449646;7491.8501629967095;4608.769561521944;4811.350467686888;4846.854594362175;4882.389701287339;4923.58149557288;1797.3284845094058;1812.0667856054142;1815.4916623345352;1860.5348662834292;1866.6360059788346;20632;20632.07155677998;20681.06935187905;20742.27402040921;20822.27122050721;5805.82582522525;5939.138824870456;6046.425589568984;6067.544934129958;6076.696165191811;14785.92607036958;14790.926045369704;14817.62955926089;14832.332545035499;14898.925505372405;6673.932170852738;7174.282571742889;7176.246494118042;7177.282271772781;7179.210286868441;6667.266600673922;6704.597724136567;6736.494762892803;6747.763828265987;6816.931830681729;4716.787744551503;4773.355596994361;4827.782749776268;4858.562729354375;4874.341963834837;1401.467442371892;1422.0898624880085;1426.5292453490324;1465.5603319004256;1470.5294305822035;887.121749468022;902.670525258276;911.726482055394;932.6595792535676;948.9572969216264;7040.612766297801;7108.075950126554;7135.250798666169;7156.964215178891;7161.606111663908;709.2907092907093;731.8389954210065;984.1929617713549;1007.9496025198711;1023.2581378500528;4870.245112007645;4922.286268491049;5155.304033955443;5155.845324640191;5165.586753059746;17136;17451.127443627767;17574.472765817045;17727.202275897616;17744.733828992576;16911.985280883186;17374.218160182823;17508;17644.294228230985;17644.735328970077;9904.60381584743;10123.898761012295;10163.593456261815;10236.641717539851;10243.38539687621;7262.419006479575;7667.539947603162;7711.421643376882;7711.730089446843;7785;15018.399264029753;15669.686606268038;15937.12345820991;16310.102944338176;16389.754153687943;15393.923030384776;16081;16113.033218006956;16328.755068673741;16564.503064908073;9818.75453113678;10058.949705251427;10062.49687515636;10067.949660251652;10071.143952764098;12154.756904861677;12178.269303841798;12178.330191839534;12235.75528489443;12518.561850335194;9896.851547226941;10343.965603439596;10381.53283102247;10576.629817956335;10790.244682872124;9478.24174066087;9497.952510237405;9695.321327507289;9882.11061004513;9967.202623790225;8619.612117454855;8725.52009639476;8727.694530691395;8736.519491428033;8772.473651580925;6109.877802444015;6480.57876238043;6527;6621.304763000008;6792.66036698173;6960.930390696029;6982.79051628452;6991.265917078634;7089.751858684921;7105.502614816914 18:11:26 INFO - PID 5729 | |4;prototype.html;496.2927231949715;498.57480091291086;520.7396301849076;525.3039722367863;525.7187404738465;5892.616979896304;6054.424829641177;6135.754569817202;6160.291566469858;6164.383561643834;5986.2517185351835;5990.341062483123;5996.880062398749;6058.454739073482;6059.212302400681;4842.733649649268;4842.806287748486;4860.448264661063;4905.705657660543;4920.901581968358;4927.359443272369;4939.67835117496;4948.303174769759;4974.452810190876;4985.202367621181;4701.200795864695;4883.926741098886;4886.364772579577;4890.14422476067;4903;4890.5109489051165;4913.385826771653;4918.114739346934;4922.876928076791;4953.257011448276;4399.472063352387;4408.426904502427;4426.380306757057;4429.512753597101;4453.465584129925;5869.530437564985;5872.500837428781;5905.4980326672285;5939.881202375971;5981.820545383602;5544.889102217973;5566.805161819317;5583.441655834425;5626.971865140689;5646.943530564683;6466.191726034246;6493.31820158886;6505.739770409178;6512.837179070561;6520.673966301713;4761.642876784255;4806.182948898696;4857.14999875024;4859;4881.219004959189;6781.186257649064;6786.864262714718;6834.316568343175;6861.279565645636;6865.485088618324;4965;4970.826021089245;5005.6996580205305;5012.749362531858;5017.172166592544;4967.3542439482635;4969.403671559364;5026.52248036436;5044.924326135111;5047.091523525801;5524.210273811699;5546.362168350611;5574.219609254707;5577.330720313588;5600.775968961278;6421.29365769765;6445.774397896051;6461.418472337512;6474.697904068865;6489.383508566679;1734.4449776071788;1737.1586118714204;1749.3964582219114;1753.3687872365938;1758.6746451906438;1113.3987646670869;1131.7170707323169;1137.147139645266;1209.29256385014;1224.6203676860202;5426.728663566806;5470.835874923759;5530.364008139035;5554.750036248379;5590.294960037147;6518.478521718251;6524.217093948757;6529.967350163314;6533.308680595448;6543.476521878239;5595.18869763882;5614.9438505615235;5626.971865140648;5641.899829533284;5699.914501282484;3475.5134281200653;3534.6818786309354;3536.628653991294;3542.6988705960284;3543.7342199335153;6376.776812811622;6413.647249401234;6451.838704032343;6453.741850326029;6484.870302594016;6692.498062645321;6747.797566073025;6785.219699734594;6811.25076241613;6883.311668833177;6386.169797926333;6388.552801303864;6454.967725161344;6477.643729594917;6499.967500162469;6549.6070235786;6557.475401967736;6564.704588293443;6566.540342176193;6660.966695166493;6392.3379921219885;6404.743810247538;6452.935060780505;6540.117084193573;6558.672066396756;6262.248530176408;6366.9681651591445;6380.7447702091395;6423.132877061724;6481.967590162208;4862.149123903374;4905.092557876804;4916.385451818523;4932.0135972804865;4943.35736354286;6570.8357291068105;6573.1454910861285;6638.668066596554;6727.730890764315;6735.4611631070375;6407.679616019273;6436.903446448214;6465.127207826883;6479.287278399466;6500;6404.103425520524;6414.871702565829;6459.450946669585;6485.675716214076;6500.3174666659315;6194.969025154845;6201.782937597162;6310.810675679737;6326.272478665012;6380.457661098673;5946.375630558902;6382.266039405527;6459.321771213955;6461.64460954652;6513.967430162819;6227.657478838707;6246.500279977682;6272.5922815016875;6278.748850045947;6281.214848143982 18:11:26 INFO - PID 5729 | |5;yui.html;907.3104440625127;908.4776253654148;918.7197904639082;923.035427977764;925.4632313258309;16413.261403236855;16569.66860662786;16732.41436549721;16793.83206167938;16876;17031.148442577884;17076;17097.145142742876;18537.073146342696;19819.90090049548;1026.2764750850633;1060.9893901060968;1061.6921092883056;1065.4193464561793;1067.5249513966248;1079.600547797316;1080.5785743560018;1084.2735367303926;1084.799312127255;1086.6142519405616;1125.5779082843933;1126.7577470843767;1127.1321082766265;1131.598282609674;1133.4162906103363;1111.5276007696696;1113.059464752287;1116.6594188772422;1120.9047230985336;1127.7631697343568;787.401574803148;788.2393490281905;791.5606838204794;793.567505709384;797.4178849439884;18476.63046739071;18931.14809833561;18945.715814262796;18957.146928388116;18993.43019709411;18845.905770471196;20782;20890.791092089035;20906;20979.16083356664;15438.228088595526;16304.103274319908;16391.508254752258;16418.1790910454;16456.753148702777;3581.87463438781;3582.6059133495296;3588.659077387644;3603.990882552889;3606.5131207287204;91186.5440672799;113552;117194.41402793016;117429;119745;13979.580612581638;14124.858751412354;14424.134551926918;15043.398264069534;17496;30371.088867334016;30443.08670739837;30528.236794079883;30899.845500772353;31301.686983129875;8456.450330728483;8801.075887031897;8833.823323533494;8842.823143537093;8858.468491890508;4182.205380977604;4228.386883901817;4253.851115210953;4266.104118135165;4268.231718290737;4961.702297862068;5078.238264260391;5081;5083.771230294646;5092.108880945893;948.6821914658667;988.2489308125876;1025.7128004158847;1048.224314007629;1049.4333060147587;661.9073329733841;687.2418596298784;715.0704084689883;719.2124623537219;730.6565914020401;11858.940705296418;12231.938840305742;12952.740945181044;12983.610491685264;13176.42365612849;686.2862622872157;696.8606278744271;709.0994437064899;721.2751185058983;726.6148941061246;5643.125315576092;5652.152177173457;5659.349174844863;5759;5777.104548794943;101863.49068254611;102591.4870425658;105270;110150.44924775325;111065;88252;90796;91148;92155;94967.52516237374;78916;82820;83477;83838.58080709557;84984.57507712422;10982.341059536453;12331.69170770738;12370.81443778326;12511.874881251071;12648.05139614551;34139;36595.26809463849;36657;37010;37561.43657845189;61201.38798611957;62887;65264;65304.34695652983;67804;18490.63018739591;18754.437366879014;19036;19201.51996200106;19499.902500487406;21086.156553738292;22159;22183.667244991662;22239;22428.663570046137;17697.20362583661;17886.195121219836;19535.413937581896;19758.802411975696;19759.110840012523;17756.91121544384;18801.96589187608;19458.708119378505;19832.60334793325;19898;17279.3952211672;18622.813771862107;19340.4197874064;19456.416307510797;19559;13516.662083447993;14036.649083772987;14598;14665.093537840012;14901;13017.544385946447;14911.478098266509;14913.254337282875;15296.61758456003;15389.461368852484 18:11:26 INFO - PID 5729 | __end_tp_report 18:11:26 INFO - PID 5729 | __start_cc_report 18:11:26 INFO - PID 5729 | _x_x_mozilla_cycle_collect,368 18:11:26 INFO - PID 5729 | __end_cc_report 18:11:26 INFO - PID 5729 | __startTimestamp1500253886676__endTimestamp 18:11:26 INFO - PID 5729 | 18:11:26 INFO - PID 5729 | ------- Summary: start ------- 18:11:26 INFO - PID 5729 | Number of tests: 6 18:11:26 INFO - PID 5729 | 18:11:26 INFO - PID 5729 | [#0] dojo.html Cycles:165 Average:5889.06 Median:6113.14 stddev:672.41 (11.0%) stddev-sans-first:637.12 18:11:26 INFO - PID 5729 | Values: 3071.9 3127.0 3143.2 3158.0 3166.1 5839.4 5861.2 5882.9 5897.3 5954.9 5935.6 5936.9 5937.9 5942.6 5965.4 5459.8 5484.2 5495.5 5510.9 5520.8 5476.5 5478.4 5484.8 5498.3 5522.4 5508.2 5509.9 5513.3 5519.9 5534.0 5505.3 5515.6 5518.1 5528.9 5532.1 5403.4 5473.5 5486.8 5503.9 5584.2 5982.8 5992.3 6046.5 6050.3 6113.1 6383.1 6384.9 6473.5 6475.9 6493.5 6305.6 6353.3 6353.7 6379.2 6405.1 5939.4 5957.9 5961.5 5969.8 5976.4 6490.4 6543.4 6566.5 6613.4 6675.7 6195.7 6244.9 6259.5 6344.1 6344.8 6250.6 6336.8 6353.4 6397.7 6436.5 6213.3 6289.2 6348.4 6359.4 6415.6 5888.5 6407.6 6421.9 6434.2 6458.9 5195.8 5207.2 5269.3 5270.9 5271.2 4411.6 4489.6 4497.1 4515.6 4523.4 5501.4 5514.3 5525.5 5534.9 5535.4 6362.8 6366.1 6372.5 6378.0 6380.1 5506.9 5547.2 5559.2 5599.3 5629.5 5555.3 5604.5 5622.8 5688.0 5760.5 6092.9 6103.4 6120.1 6124.7 6132.1 6184.0 6239.0 6244.0 6257.5 6265.0 5342.2 6095.4 6102.2 6278.6 6367.4 6346.8 6369.1 6447.9 6449.1 6462.5 6463.5 6481.1 6591.3 6599.3 6599.8 6124.8 6227.2 6231.3 6272.8 6380.3 6258.2 6279.5 6286.1 6296.9 6299.7 6148.8 6166.1 6173.1 6179.5 6190.5 5352.6 6260.4 6319.0 6354.7 6390.5 6109.8 6141.4 6195.3 6201.2 6223.6 18:11:26 INFO - PID 5729 | 18:11:26 INFO - PID 5729 | [#1] ext.html Cycles:180 Average:36637.40 Median:18680.35 stddev:52760.43 (282.4%) stddev-sans-first:52839.75 18:11:26 INFO - PID 5729 | Values: 785.6 823.6 849.9 875.4 876.7 40686.0 41011.6 41559.4 41600.2 41625.8 37662.8 37795.1 38094.0 38130.8 38154.6 6936.6 7029.7 7038.9 7046.0 7046.4 6954.1 7026.3 7056.3 7062.4 7070.1 7004.3 7009.3 7031.6 7031.7 7047.8 6976.1 7005.3 7017.0 7024.2 7037.6 6382.4 6409.3 6421.6 6426.2 6432.9 33509.3 33865.7 33930.5 33953.5 34135.5 3407.2 3435.6 3444.6 3534.9 3585.4 31011.5 31035.5 31244.5 31375.5 31408.5 4911.2 4917.7 4959.3 4979.4 4996.6 178010.0 178510.0 181691.1 181743.0 182649.0 48772.3 49213.5 49225.5 49350.5 49553.0 51012.7 51270.2 51402.0 51404.5 51522.5 15532.8 15592.9 15615.4 15648.1 15655.4 13229.1 13266.0 13277.5 13406.3 13418.9 14421.3 14527.6 14536.0 14675.9 14812.2 5863.8 5915.6 5979.6 6006.7 6020.2 972.2 991.8 1015.9 1016.4 1020.1 22426.0 22502.8 23213.4 23411.3 23843.6 1056.4 1098.4 1099.1 1102.8 1110.1 11984.9 12007.6 12094.7 12193.6 12304.0 224007.0 224069.0 226465.0 227268.0 228553.0 50766.2 50830.2 50907.5 51006.5 51052.0 1403.6 1468.4 1474.9 1480.4 1485.2 21065.7 22021.4 22344.8 22501.4 22645.1 36709.0 37107.8 37316.4 37545.0 37603.2 200129.0 200230.0 201613.0 201873.0 202613.0 31239.5 31797.0 31862.2 31957.2 34217.5 38866.4 38961.8 38994.8 41102.6 43815.6 30823.0 31741.8 32038.0 32221.0 32479.0 30921.8 31137.0 31357.5 31542.7 31641.2 34442.0 34473.5 34535.8 34900.7 35396.3 30178.7 30481.5 30733.4 30737.5 30905.0 21173.0 23080.8 23140.7 23188.3 23198.4 18:11:26 INFO - PID 5729 | 18:11:26 INFO - PID 5729 | [#2] jquery.html Cycles:180 Average:34260.65 Median:2308.33 stddev:78944.99 (3420.0%) stddev-sans-first:79125.91 18:11:26 INFO - PID 5729 | Values: 565.3 569.7 570.4 574.4 595.8 21724.3 22693.7 22702.8 22711.5 22830.7 24873.0 25989.7 27298.5 27548.3 27565.4 6389.6 6550.5 6554.2 6565.7 6567.7 6450.6 6492.3 6515.3 6535.8 6540.1 4056.2 4916.0 5628.8 6396.6 6473.1 6459.6 6476.7 6522.8 6530.2 6531.9 5954.1 6009.2 6035.1 6064.9 6067.2 28718.1 30632.8 31101.8 31118.1 31187.7 1935.8 1957.8 1965.9 1969.5 1978.4 18666.0 19311.1 19315.9 19361.6 19367.4 2299.9 2316.8 2379.1 2381.4 2396.6 134434.0 137282.0 138823.0 139664.0 143777.3 14100.7 14814.3 14905.9 15144.3 15644.9 24068.4 24090.9 24124.3 24135.0 24148.0 10023.2 10253.4 10311.1 10322.2 10581.2 9578.4 9617.7 9696.5 9726.4 9847.6 9057.9 9489.4 9511.6 9623.6 9711.4 2675.6 2790.3 2818.0 2830.4 2934.1 975.7 981.2 982.2 995.8 1009.5 19844.2 20212.1 20334.4 20466.0 20597.3 954.6 1010.4 1025.5 1044.4 1055.4 10760.2 11126.4 11182.2 11216.0 11219.4 448647.0 460267.0 470450.0 477534.0 477940.0 111264.4 111776.4 111952.4 113457.0 113641.0 1182.9 1207.8 1219.6 1222.2 1236.5 17575.9 17656.5 17686.8 17702.4 18130.0 48791.8 51222.7 53283.5 55411.4 58407.7 70352.6 72121.3 72365.6 73114.0 73273.6 14692.2 15269.3 15270.1 15419.5 15428.8 23768.2 24249.6 24333.3 24496.3 24641.5 19099.1 19258.9 19422.8 19611.2 19628.1 16444.7 17633.6 18126.5 18151.0 18165.4 18909.3 19705.9 20216.3 20331.2 20340.8 15254.5 15291.5 15459.5 15474.2 15476.4 18772.0 18840.2 18908.0 19237.0 19485.7 18:11:26 INFO - PID 5729 | 18:11:26 INFO - PID 5729 | [#3] mootools.html Cycles:180 Average:8150.83 Median:2622.21 stddev:5416.22 (206.6%) stddev-sans-first:5407.30 18:11:26 INFO - PID 5729 | Values: 1348.4 1366.6 1373.5 1385.8 1395.8 12671.0 13274.1 13277.7 13304.4 13326.9 12813.2 13235.3 13428.9 13539.5 13549.9 2561.4 2635.4 2652.1 2658.0 2669.3 2530.5 2595.1 2619.9 2624.5 2626.1 2458.3 2488.4 2493.0 2494.2 2500.1 2486.3 2592.4 2652.5 2662.6 2669.9 2598.8 2653.2 2657.1 2660.0 2662.6 13626.1 13678.7 13747.9 13747.9 13751.7 7094.9 7455.7 7456.9 7475.2 7491.9 4608.8 4811.4 4846.9 4882.4 4923.6 1797.3 1812.1 1815.5 1860.5 1866.6 20632.0 20632.1 20681.1 20742.3 20822.3 5805.8 5939.1 6046.4 6067.5 6076.7 14785.9 14790.9 14817.6 14832.3 14898.9 6673.9 7174.3 7176.2 7177.3 7179.2 6667.3 6704.6 6736.5 6747.8 6816.9 4716.8 4773.4 4827.8 4858.6 4874.3 1401.5 1422.1 1426.5 1465.6 1470.5 887.1 902.7 911.7 932.7 949.0 7040.6 7108.1 7135.3 7157.0 7161.6 709.3 731.8 984.2 1007.9 1023.3 4870.2 4922.3 5155.3 5155.8 5165.6 17136.0 17451.1 17574.5 17727.2 17744.7 16912.0 17374.2 17508.0 17644.3 17644.7 9904.6 10123.9 10163.6 10236.6 10243.4 7262.4 7667.5 7711.4 7711.7 7785.0 15018.4 15669.7 15937.1 16310.1 16389.8 15393.9 16081.0 16113.0 16328.8 16564.5 9818.8 10058.9 10062.5 10067.9 10071.1 12154.8 12178.3 12178.3 12235.8 12518.6 9896.9 10344.0 10381.5 10576.6 10790.2 9478.2 9498.0 9695.3 9882.1 9967.2 8619.6 8725.5 8727.7 8736.5 8772.5 6109.9 6480.6 6527.0 6621.3 6792.7 6960.9 6982.8 6991.3 7089.8 7105.5 18:11:26 INFO - PID 5729 | 18:11:26 INFO - PID 5729 | [#4] prototype.html Cycles:180 Average:5414.25 Median:5964.10 stddev:1516.24 (25.4%) stddev-sans-first:1474.87 18:11:26 INFO - PID 5729 | Values: 496.3 498.6 520.7 525.3 525.7 5892.6 6054.4 6135.8 6160.3 6164.4 5986.3 5990.3 5996.9 6058.5 6059.2 4842.7 4842.8 4860.4 4905.7 4920.9 4927.4 4939.7 4948.3 4974.5 4985.2 4701.2 4883.9 4886.4 4890.1 4903.0 4890.5 4913.4 4918.1 4922.9 4953.3 4399.5 4408.4 4426.4 4429.5 4453.5 5869.5 5872.5 5905.5 5939.9 5981.8 5544.9 5566.8 5583.4 5627.0 5646.9 6466.2 6493.3 6505.7 6512.8 6520.7 4761.6 4806.2 4857.1 4859.0 4881.2 6781.2 6786.9 6834.3 6861.3 6865.5 4965.0 4970.8 5005.7 5012.7 5017.2 4967.4 4969.4 5026.5 5044.9 5047.1 5524.2 5546.4 5574.2 5577.3 5600.8 6421.3 6445.8 6461.4 6474.7 6489.4 1734.4 1737.2 1749.4 1753.4 1758.7 1113.4 1131.7 1137.1 1209.3 1224.6 5426.7 5470.8 5530.4 5554.8 5590.3 6518.5 6524.2 6530.0 6533.3 6543.5 5595.2 5614.9 5627.0 5641.9 5699.9 3475.5 3534.7 3536.6 3542.7 3543.7 6376.8 6413.6 6451.8 6453.7 6484.9 6692.5 6747.8 6785.2 6811.3 6883.3 6386.2 6388.6 6455.0 6477.6 6500.0 6549.6 6557.5 6564.7 6566.5 6661.0 6392.3 6404.7 6452.9 6540.1 6558.7 6262.2 6367.0 6380.7 6423.1 6482.0 4862.1 4905.1 4916.4 4932.0 4943.4 6570.8 6573.1 6638.7 6727.7 6735.5 6407.7 6436.9 6465.1 6479.3 6500.0 6404.1 6414.9 6459.5 6485.7 6500.3 6195.0 6201.8 6310.8 6326.3 6380.5 5946.4 6382.3 6459.3 6461.6 6514.0 6227.7 6246.5 6272.6 6278.7 6281.2 18:11:26 INFO - PID 5729 | 18:11:26 INFO - PID 5729 | [#5] yui.html Cycles:180 Average:22685.82 Median:19517.66 stddev:29776.81 (152.6%) stddev-sans-first:29815.44 18:11:26 INFO - PID 5729 | Values: 907.3 908.5 918.7 923.0 925.5 16413.3 16569.7 16732.4 16793.8 16876.0 17031.1 17076.0 17097.1 18537.1 19819.9 1026.3 1061.0 1061.7 1065.4 1067.5 1079.6 1080.6 1084.3 1084.8 1086.6 1125.6 1126.8 1127.1 1131.6 1133.4 1111.5 1113.1 1116.7 1120.9 1127.8 787.4 788.2 791.6 793.6 797.4 18476.6 18931.1 18945.7 18957.1 18993.4 18845.9 20782.0 20890.8 20906.0 20979.2 15438.2 16304.1 16391.5 16418.2 16456.8 3581.9 3582.6 3588.7 3604.0 3606.5 91186.5 113552.0 117194.4 117429.0 119745.0 13979.6 14124.9 14424.1 15043.4 17496.0 30371.1 30443.1 30528.2 30899.8 31301.7 8456.5 8801.1 8833.8 8842.8 8858.5 4182.2 4228.4 4253.9 4266.1 4268.2 4961.7 5078.2 5081.0 5083.8 5092.1 948.7 988.2 1025.7 1048.2 1049.4 661.9 687.2 715.1 719.2 730.7 11858.9 12231.9 12952.7 12983.6 13176.4 686.3 696.9 709.1 721.3 726.6 5643.1 5652.2 5659.3 5759.0 5777.1 101863.5 102591.5 105270.0 110150.4 111065.0 88252.0 90796.0 91148.0 92155.0 94967.5 78916.0 82820.0 83477.0 83838.6 84984.6 10982.3 12331.7 12370.8 12511.9 12648.1 34139.0 36595.3 36657.0 37010.0 37561.4 61201.4 62887.0 65264.0 65304.3 67804.0 18490.6 18754.4 19036.0 19201.5 19499.9 21086.2 22159.0 22183.7 22239.0 22428.7 17697.2 17886.2 19535.4 19758.8 19759.1 17756.9 18802.0 19458.7 19832.6 19898.0 17279.4 18622.8 19340.4 19456.4 19559.0 13516.7 14036.6 14598.0 14665.1 14901.0 13017.5 14911.5 14913.3 15296.6 15389.5 18:11:26 INFO - PID 5729 | -------- Summary: end -------- 18:11:26 INFO - PID 5729 | 18:11:27 INFO - TEST-INFO | 5729: exit 0 18:11:27 INFO - TEST-OK | dromaeo_css | took 1111197ms 18:11:27 INFO - TEST-START | kraken 18:11:27 INFO - Initialising browser for kraken test... 18:11:27 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:44615/getInfo.html -profile /tmp/tmpZKQCGz/profile 18:11:27 INFO - TEST-INFO | started process 6142 (/builds/slave/test/build/application/firefox/firefox http://localhost:44615/getInfo.html) 18:11:33 INFO - TEST-INFO | 6142: exit 0 18:11:33 INFO - Browser initialized. 18:11:33 INFO - Running cycle 1/1 for kraken test... 18:11:33 INFO - TEST-INFO | started process 6369 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZKQCGz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 18:11:45 INFO - PID 6369 | RSS: Main: 173441024 18:11:45 INFO - PID 6369 | 18:11:47 INFO - PID 6369 | Cycle 1(1): loaded http://localhost:44615/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44615/tests/kraken/driver.html?testName=audio-beat-detection) 18:11:48 INFO - PID 6369 | RSS: Main: 180088832 18:11:48 INFO - PID 6369 | 18:11:51 INFO - PID 6369 | Cycle 1(1): loaded http://localhost:44615/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44615/tests/kraken/driver.html?testName=audio-dft) 18:11:52 INFO - PID 6369 | RSS: Main: 179994624 18:11:52 INFO - PID 6369 | 18:11:55 INFO - PID 6369 | Cycle 1(1): loaded http://localhost:44615/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44615/tests/kraken/driver.html?testName=audio-fft) 18:11:55 INFO - PID 6369 | RSS: Main: 173858816 18:11:55 INFO - PID 6369 | 18:11:57 INFO - PID 6369 | Cycle 1(1): loaded http://localhost:44615/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44615/tests/kraken/driver.html?testName=audio-oscillator) 18:11:58 INFO - PID 6369 | RSS: Main: 175624192 18:11:58 INFO - PID 6369 | 18:12:00 INFO - PID 6369 | Cycle 1(1): loaded http://localhost:44615/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44615/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:12:01 INFO - PID 6369 | RSS: Main: 176242688 18:12:01 INFO - PID 6369 | 18:12:04 INFO - PID 6369 | Cycle 1(1): loaded http://localhost:44615/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44615/tests/kraken/driver.html?testName=imaging-darkroom) 18:12:04 INFO - PID 6369 | RSS: Main: 179331072 18:12:04 INFO - PID 6369 | 18:12:08 INFO - PID 6369 | Cycle 1(1): loaded http://localhost:44615/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44615/tests/kraken/driver.html?testName=imaging-desaturate) 18:12:08 INFO - PID 6369 | RSS: Main: 180305920 18:12:08 INFO - PID 6369 | 18:12:11 INFO - PID 6369 | Cycle 1(1): loaded http://localhost:44615/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44615/tests/kraken/driver.html?testName=json-parse-financial) 18:12:12 INFO - PID 6369 | RSS: Main: 179691520 18:12:12 INFO - PID 6369 | 18:12:13 INFO - PID 6369 | Cycle 1(1): loaded http://localhost:44615/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44615/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:12:14 INFO - PID 6369 | RSS: Main: 179335168 18:12:14 INFO - PID 6369 | 18:12:16 INFO - PID 6369 | Cycle 1(1): loaded http://localhost:44615/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44615/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:12:16 INFO - PID 6369 | RSS: Main: 179200000 18:12:16 INFO - PID 6369 | 18:12:18 INFO - PID 6369 | Cycle 1(1): loaded http://localhost:44615/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44615/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:12:19 INFO - PID 6369 | RSS: Main: 175861760 18:12:19 INFO - PID 6369 | 18:12:22 INFO - PID 6369 | Cycle 1(1): loaded http://localhost:44615/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44615/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:12:22 INFO - PID 6369 | RSS: Main: 176054272 18:12:22 INFO - PID 6369 | 18:12:25 INFO - PID 6369 | Cycle 1(1): loaded http://localhost:44615/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44615/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:12:26 INFO - PID 6369 | RSS: Main: 176345088 18:12:26 INFO - PID 6369 | 18:12:28 INFO - PID 6369 | Cycle 1(1): loaded http://localhost:44615/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44615/tests/kraken/driver.html?testName=ai-astar) 18:12:28 INFO - PID 6369 | RSS: Main: 177983488 18:12:28 INFO - PID 6369 | 18:12:28 INFO - PID 6369 | __start_tp_report 18:12:28 INFO - PID 6369 | _x_x_mozilla_page_load 18:12:28 INFO - PID 6369 | _x_x_mozilla_page_load_details 18:12:28 INFO - PID 6369 | |i|pagename|runs| 18:12:28 INFO - PID 6369 | |0;ai-astar;100;107;108;107;112;108;108;110;109;108 18:12:28 INFO - PID 6369 | |1;audio-beat-detection;147;119;152;177;124;148;156;123;175;130 18:12:28 INFO - PID 6369 | |2;audio-dft;164;162;163;160;164;172;162;166;166;165 18:12:28 INFO - PID 6369 | |3;audio-fft;73;76;75;159;75;74;74;74;94;74 18:12:28 INFO - PID 6369 | |4;audio-oscillator;81;82;134;81;82;80;139;81;83;128 18:12:28 INFO - PID 6369 | |5;imaging-gaussian-blur;113;115;114;114;114;114;113;114;114;114 18:12:28 INFO - PID 6369 | |6;imaging-darkroom;150;150;151;148;149;152;149;149;150;149 18:12:28 INFO - PID 6369 | |7;imaging-desaturate;95;94;94;95;94;94;94;95;94;94 18:12:28 INFO - PID 6369 | |8;json-parse-financial;56;55;57;55;63;60;57;54;55;57 18:12:28 INFO - PID 6369 | |9;json-stringify-tinderbox;55;55;54;53;54;54;55;54;55;54 18:12:28 INFO - PID 6369 | |10;stanford-crypto-aes;77;78;77;80;76;76;76;76;77;80 18:12:28 INFO - PID 6369 | |11;stanford-crypto-ccm;133;130;126;134;129;131;128;126;134;154 18:12:28 INFO - PID 6369 | |12;stanford-crypto-pbkdf2;184;184;188;185;195;189;185;193;181;182 18:12:28 INFO - PID 6369 | |13;stanford-crypto-sha256-iterative;68;67;74;78;76;68;68;69;68;69 18:12:28 INFO - PID 6369 | __end_tp_report 18:12:28 INFO - PID 6369 | __start_cc_report 18:12:28 INFO - PID 6369 | _x_x_mozilla_cycle_collect,954 18:12:28 INFO - PID 6369 | __end_cc_report 18:12:28 INFO - PID 6369 | __startTimestamp1500253948496__endTimestamp 18:12:28 INFO - PID 6369 | 18:12:28 INFO - PID 6369 | ------- Summary: start ------- 18:12:28 INFO - PID 6369 | Number of tests: 14 18:12:28 INFO - PID 6369 | 18:12:28 INFO - PID 6369 | [#0] ai-astar Cycles:10 Average:107.70 Median:108.00 stddev:3.09 (2.9%) stddev-sans-first:1.59 18:12:28 INFO - PID 6369 | Values: 100.0 107.0 108.0 107.0 112.0 108.0 108.0 110.0 109.0 108.0 18:12:28 INFO - PID 6369 | 18:12:28 INFO - PID 6369 | [#1] audio-beat-detection Cycles:10 Average:145.10 Median:150.00 stddev:20.90 (13.9%) stddev-sans-first:22.16 18:12:28 INFO - PID 6369 | Values: 147.0 119.0 152.0 177.0 124.0 148.0 156.0 123.0 175.0 130.0 18:12:28 INFO - PID 6369 | 18:12:28 INFO - PID 6369 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.50 stddev:3.27 (2.0%) stddev-sans-first:3.47 18:12:28 INFO - PID 6369 | Values: 164.0 162.0 163.0 160.0 164.0 172.0 162.0 166.0 166.0 165.0 18:12:28 INFO - PID 6369 | 18:12:28 INFO - PID 6369 | [#3] audio-fft Cycles:10 Average:84.80 Median:74.50 stddev:26.80 (36.0%) stddev-sans-first:28.09 18:12:28 INFO - PID 6369 | Values: 73.0 76.0 75.0 159.0 75.0 74.0 74.0 74.0 94.0 74.0 18:12:28 INFO - PID 6369 | 18:12:28 INFO - PID 6369 | [#4] audio-oscillator Cycles:10 Average:97.10 Median:81.00 stddev:25.38 (31.3%) stddev-sans-first:26.24 18:12:28 INFO - PID 6369 | Values: 81.0 82.0 134.0 81.0 82.0 80.0 139.0 81.0 83.0 128.0 18:12:28 INFO - PID 6369 | 18:12:28 INFO - PID 6369 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 18:12:28 INFO - PID 6369 | Values: 113.0 115.0 114.0 114.0 114.0 114.0 113.0 114.0 114.0 114.0 18:12:28 INFO - PID 6369 | 18:12:28 INFO - PID 6369 | [#6] imaging-darkroom Cycles:10 Average:149.70 Median:150.00 stddev:1.16 (0.8%) stddev-sans-first:1.22 18:12:28 INFO - PID 6369 | Values: 150.0 150.0 151.0 148.0 149.0 152.0 149.0 149.0 150.0 149.0 18:12:28 INFO - PID 6369 | 18:12:28 INFO - PID 6369 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 18:12:28 INFO - PID 6369 | Values: 95.0 94.0 94.0 95.0 94.0 94.0 94.0 95.0 94.0 94.0 18:12:28 INFO - PID 6369 | 18:12:28 INFO - PID 6369 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:57.00 stddev:2.73 (4.8%) stddev-sans-first:2.87 18:12:28 INFO - PID 6369 | Values: 56.0 55.0 57.0 55.0 63.0 60.0 57.0 54.0 55.0 57.0 18:12:28 INFO - PID 6369 | 18:12:28 INFO - PID 6369 | [#9] json-stringify-tinderbox Cycles:10 Average:54.30 Median:54.50 stddev:0.67 (1.2%) stddev-sans-first:0.67 18:12:28 INFO - PID 6369 | Values: 55.0 55.0 54.0 53.0 54.0 54.0 55.0 54.0 55.0 54.0 18:12:28 INFO - PID 6369 | 18:12:28 INFO - PID 6369 | [#10] stanford-crypto-aes Cycles:10 Average:77.30 Median:77.00 stddev:1.57 (2.0%) stddev-sans-first:1.66 18:12:28 INFO - PID 6369 | Values: 77.0 78.0 77.0 80.0 76.0 76.0 76.0 76.0 77.0 80.0 18:12:28 INFO - PID 6369 | 18:12:28 INFO - PID 6369 | [#11] stanford-crypto-ccm Cycles:10 Average:132.50 Median:132.00 stddev:8.11 (6.1%) stddev-sans-first:8.60 18:12:28 INFO - PID 6369 | Values: 133.0 130.0 126.0 134.0 129.0 131.0 128.0 126.0 134.0 154.0 18:12:28 INFO - PID 6369 | 18:12:28 INFO - PID 6369 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.60 Median:186.50 stddev:4.60 (2.5%) stddev-sans-first:4.78 18:12:28 INFO - PID 6369 | Values: 184.0 184.0 188.0 185.0 195.0 189.0 185.0 193.0 181.0 182.0 18:12:28 INFO - PID 6369 | 18:12:28 INFO - PID 6369 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:69.00 stddev:3.95 (5.7%) stddev-sans-first:4.09 18:12:28 INFO - PID 6369 | Values: 68.0 67.0 74.0 78.0 76.0 68.0 68.0 69.0 68.0 69.0 18:12:28 INFO - PID 6369 | -------- Summary: end -------- 18:12:28 INFO - PID 6369 | 18:12:28 INFO - PID 6369 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 18:12:29 INFO - TEST-INFO | 6369: exit 0 18:12:29 INFO - TEST-OK | kraken | took 62046ms 18:12:29 INFO - SUITE-END | took 1173s 18:12:29 INFO - Completed test suite (00:19:33) 18:12:29 INFO - javascript benchmark 18:12:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8269.248409602998, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3071.8617662205197, 3126.968730312697, 3143.1984843864825, 3157.9684203157963, 3166.050184944516, 5839.386864379243, 5861.150133230684, 5882.911756323659, 5897.3218079920825, 5954.9281129396695, 5935.554833387491, 5936.851578710534, 5937.940620593793, 5942.61373010754, 5965.373635768236, 5459.754311055992, 5484.204790305414, 5495.505404513593, 5510.91733623996, 5520.806771762989, 5476.534494567966, 5478.369987451454, 5484.780608775644, 5498.340199176105, 5522.3649280332675, 5508.173773933902, 5509.944900551003, 5513.3108361454815, 5519.862003449905, 5534.03154447972, 5505.3393592768725, 5515.61390702651, 5518.117101263799, 5528.861778455531, 5532.059549876511, 5403.351597808288, 5473.452654734535, 5486.835394938158, 5503.889922201573, 5584.21820945068, 5982.7906023289415, 5992.34084250732, 6046.516278697693, 6050.334463209044, 6113.144159817629, 6383.106365108889, 6384.904226436607, 6473.546851720382, 6475.870482590321, 6493.51298652603, 6305.621662700252, 6353.269374022, 6353.745850165988, 6379.202599675041, 6405.071264666597, 5939.406059394069, 5957.8808423831715, 5961.493273071794, 5969.791057312973, 5976.402359764033, 6490.38341357575, 6543.378379053982, 6566.540342176002, 6613.371729685672, 6675.699593518206, 6195.659238741912, 6244.937550624527, 6259.530535209878, 6344.143540622049, 6344.777932772331, 6250.624962502265, 6336.778212762531, 6353.36466353361, 6397.6801159941815, 6436.517261205428, 6213.254409470802, 6289.245290565162, 6348.396902294275, 6359.364063593696, 6415.582987105823, 5888.499477544457, 6407.583507072025, 6421.903671444932, 6434.195725534309, 6458.903116453257, 5195.84412467619, 5207.218917162456, 5269.314989051399, 5270.893112446429, 5271.20931860224, 4411.602955733999, 4489.595936365743, 4497.05561832019, 4515.571020753023, 4523.411956445641, 5501.394846566875, 5514.255575497336, 5525.475079867406, 5534.944650553443, 5535.391106978229, 6362.77730279438, 6366.108744775735, 6372.522060845455, 6378.043293506012, 6380.106785050097, 5506.862328441821, 5547.16792481123, 5559.249501317351, 5599.300087489064, 5629.549636029108, 5555.2778138842505, 5604.467575580314, 5622.803201887914, 5688.033034384164, 5760.53915686744, 6092.908606370908, 6103.42017508336, 6120.081987701791, 6124.724387402578, 6132.141500189977, 6184.0, 6239.032949892774, 6244.000959846494, 6257.530685198537, 6265.0, 5342.225377320189, 6095.420935011167, 6102.206713127265, 6278.623282603058, 6367.395097465734, 6346.841328966812, 6369.14016607752, 6447.871042579216, 6449.129367535323, 6462.515311351762, 6463.547551671526, 6481.125048118443, 6591.307912669101, 6599.274079851117, 6599.835004124743, 6124.846878827887, 6227.19046523949, 6231.345708700521, 6272.780452684134, 6380.330065343072, 6258.217722784652, 6279.466245369194, 6286.119943208046, 6296.937030629819, 6299.716512756845, 6148.78479253224, 6166.075088736546, 6173.074038894202, 6179.5056395489155, 6190.473809726223, 5352.571794256528, 6260.373962603703, 6319.0, 6354.6822658867795, 6390.456811170917, 6109.816705498843, 6141.447269745744, 6195.256569211723, 6201.224846894138, 6223.564350495421], "value": 5841.827780653983, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [785.5914924239396, 823.6129019360899, 849.8852654891589, 875.3566128895263, 876.6975393489244, 40686.0, 41011.58988410115, 41559.37660935088, 41600.16799664013, 41625.79187104068, 37662.81168594153, 37795.055123621925, 38094.0, 38130.8093459533, 38154.618453815456, 6936.6184859832565, 7029.718811247544, 7038.85922281554, 7045.964770176142, 7046.365827075562, 6954.09596752424, 7026.297370262984, 7056.294370562929, 7062.399696025844, 7070.116235470567, 7004.29957004298, 7009.299070093001, 7031.613261270628, 7031.718731250769, 7047.788566343018, 6976.058232138647, 7005.299470052954, 7016.9999999999745, 7024.2273349931465, 7037.577745335297, 6382.36176382358, 6409.294977552466, 6421.582597131218, 6426.164598602152, 6432.935670643281, 33509.329813403594, 33865.6613433865, 33930.49104263438, 33953.49069763956, 34135.48796768051, 3407.216340241758, 3435.6220815710253, 3444.603870554868, 3534.91162720934, 3585.4442561403025, 31011.534826977615, 31035.534466983012, 31244.531332030037, 31375.529367059513, 31408.528872066938, 4911.189653707134, 4917.72952487613, 4959.305697202394, 4979.427365852901, 4996.600271978233, 178009.9999999987, 178510.0, 181691.09154454275, 181743.0, 182649.0, 48772.26841597379, 49213.507864920895, 49225.50774492281, 49350.50649493531, 49553.0, 51012.74493627508, 51270.230946535834, 51402.0, 51404.48595513997, 51522.484775152516, 15532.767008494882, 15592.922035389978, 15615.375384984472, 15648.139352335731, 15655.373785048698, 13229.073964822563, 13266.0, 13277.535286264934, 13406.329683515785, 13418.93290533541, 14421.278936053155, 14527.636809079646, 14536.0, 14675.881531681463, 14812.185329806964, 5863.7947671832135, 5915.58590898633, 5979.5515336349945, 6006.6696331701305, 6020.157177995085, 972.246508955551, 991.7818080022383, 1015.9085682288629, 1016.4409574733867, 1020.0936577217973, 22425.959663915233, 22502.774972250394, 23213.41966450852, 23411.297661070195, 23843.642345364835, 1056.434807378049, 1098.3519723363254, 1099.0932480703452, 1102.8180350242121, 1110.1119104716195, 11984.940075299568, 12007.579734709243, 12094.697632559257, 12193.634190974284, 12303.95416389599, 224007.0, 224069.0, 226465.0, 227268.0, 228553.0, 50766.238506422436, 50830.23754643683, 50907.49092509101, 51006.48993510017, 51052.0, 1403.5578792680274, 1468.41263494603, 1474.8820094392638, 1480.407836865241, 1485.2351039214814, 21065.684014739483, 22021.449463762892, 22344.77655223427, 22501.43746406353, 22645.094196231967, 36709.0, 37107.814460927526, 37316.440253395675, 37545.0, 37603.2479350406, 200129.0, 200230.0, 201613.0, 201873.0, 202613.0, 31239.531407029368, 31797.04608861738, 31862.203444914063, 31957.20106997344, 34217.486737698455, 38866.4170037444, 38961.805190973864, 38994.80502597469, 41102.58897410987, 43815.56184438242, 30823.0, 31741.8412907934, 32038.0, 32221.0, 32479.0, 30921.8453907729, 31137.0, 31357.52963705592, 31542.684573154893, 31641.20896977502, 34442.0, 34473.482897756054, 34535.82732086324, 34900.65099349076, 35396.29207415889, 30178.69821301759, 30481.54277685792, 30733.385332293677, 30737.53893691641, 30905.0, 21173.0, 23080.769192308533, 23140.652890207, 23188.3043508695, 23198.420039498473], "value": 16598.108349623017, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.2538648983343, 569.6695916368507, 570.4181734630677, 574.4284436985199, 595.8331667133201, 21724.34826955192, 22693.659595106088, 22702.77297227027, 22711.54576908463, 22830.657540136912, 24873.0, 25989.740102598967, 27298.45403091937, 27548.311292217706, 27565.448691026166, 6389.616623002611, 6550.508711846607, 6554.180727409074, 6565.737370505174, 6567.704453299589, 6450.6452145132, 6492.253390860064, 6515.34846515347, 6535.803925882231, 6540.117084193645, 4056.1684854604737, 4916.0, 5628.846086552247, 6396.61620302781, 6473.1261279727105, 6459.580127291711, 6476.7370362779275, 6522.771702990372, 6530.249021362532, 6531.934680653204, 5954.077118046666, 6009.2188015557695, 6035.124906888521, 6064.9090263646085, 6067.18093057436, 28718.138455846358, 30632.84683576568, 31101.84449077763, 31118.066458006295, 31187.688123118704, 1935.7580302462193, 1957.7552805899263, 1965.9410217693492, 1969.5371587676884, 1978.4262563856464, 18665.973371464563, 19311.130999105073, 19315.903420482948, 19361.612767744566, 19367.418977430698, 2299.8965046572944, 2316.7683231676697, 2379.0959435414434, 2381.368937231635, 2396.6405039244078, 134434.0, 137282.0, 138823.0, 139664.0, 143777.28111359375, 14100.717985640229, 14814.259287035606, 14905.850941490664, 15144.318505667272, 15644.92177539105, 24068.39829004289, 24090.879545602158, 24124.27627171188, 24135.0, 24148.0, 10023.19118734876, 10253.411306042974, 10311.07200351972, 10322.174226061898, 10581.153507719519, 9578.425294482215, 9617.749692539925, 9696.466694331739, 9726.36778609388, 9847.60609575609, 9057.909420905838, 9489.383190092622, 9511.57197926081, 9623.615055397846, 9711.36876103051, 2675.6254124422207, 2790.3024243939017, 2817.971820281812, 2830.36316828716, 2934.105097945147, 975.7365511311906, 981.2429735113666, 982.2044144243185, 995.8058178655093, 1009.5255230041869, 19844.20623175057, 20212.09045592952, 20334.389968300973, 20465.976701164884, 20597.279095231595, 954.5609019850807, 1010.4442556593845, 1025.4669269442084, 1044.3629386074488, 1055.3931489393628, 10760.246782725291, 11126.443677816076, 11182.217244792786, 11216.046636035866, 11219.439028048564, 448647.0, 460267.0, 470450.0, 477534.0, 477940.0, 111264.4436777827, 111776.44111779389, 111952.44023779992, 113457.0, 113641.0, 1182.8521434820648, 1207.7886369885234, 1219.5792451604182, 1222.2238878312335, 1236.505397840871, 17575.912120439316, 17656.470305890845, 17686.823131768517, 17702.380416685355, 18130.0, 48791.75604121957, 51222.74388628033, 53283.4671653294, 55411.44588554224, 58407.70796145992, 70352.64823675848, 72121.27878721355, 72365.6381718109, 73114.0, 73273.6336318315, 14692.191929443983, 15269.312880920608, 15270.083794972337, 15419.460318889234, 15428.84571154274, 23768.168114115924, 24249.636255456535, 24333.296669232983, 24496.265112046665, 24641.507169856144, 19099.140538675514, 19258.90370548138, 19422.805771942665, 19611.215551377783, 19628.116734746684, 16444.67110657804, 17633.64732705313, 18126.5468363292, 18151.0, 18165.36421225251, 18909.338173163873, 19705.90147049313, 20216.292429765475, 20331.186752529735, 20340.79659203389, 15254.466093686668, 15291.464798731991, 15459.536213913601, 15474.226288685746, 15476.374980626872, 18772.0, 18840.152193151614, 18908.0, 19237.0, 19485.707714384578], "value": 12055.825350661149, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1348.4067010515373, 1366.590022993102, 1373.5055380063175, 1385.840628327742, 1395.8464568897423, 12671.0, 13274.070815042951, 13277.734445311087, 13304.401301941412, 13326.866731332708, 12813.231206127639, 13235.272060036694, 13428.932855335734, 13539.526116585921, 13549.864501354983, 2561.3724637463847, 2635.3806855388966, 2652.071774878796, 2657.9734202658015, 2669.2659518632436, 2530.5318516074494, 2595.0657763205327, 2619.8952041918396, 2624.527585034693, 2626.107123577983, 2458.2625212436287, 2488.415222422729, 2492.962605560918, 2494.2143224884194, 2500.0749722602663, 2486.266551367342, 2592.41670624109, 2652.5358062339014, 2662.5739881619043, 2669.866506674668, 2598.8180827342094, 2653.150991682662, 2657.096587160375, 2660.015794156155, 2662.60060990851, 13626.1143025703, 13678.658033549142, 13747.862521374758, 13747.862521374758, 13751.656208594764, 7094.929050709478, 7455.664495097733, 7456.918746781686, 7475.177730449646, 7491.8501629967095, 4608.769561521944, 4811.350467686888, 4846.854594362175, 4882.389701287339, 4923.58149557288, 1797.3284845094058, 1812.0667856054142, 1815.4916623345352, 1860.5348662834292, 1866.6360059788346, 20632.0, 20632.07155677998, 20681.06935187905, 20742.27402040921, 20822.27122050721, 5805.82582522525, 5939.138824870456, 6046.425589568984, 6067.544934129958, 6076.696165191811, 14785.92607036958, 14790.926045369704, 14817.62955926089, 14832.332545035499, 14898.925505372405, 6673.932170852738, 7174.282571742889, 7176.246494118042, 7177.282271772781, 7179.210286868441, 6667.266600673922, 6704.597724136567, 6736.494762892803, 6747.763828265987, 6816.931830681729, 4716.787744551503, 4773.355596994361, 4827.782749776268, 4858.562729354375, 4874.341963834837, 1401.467442371892, 1422.0898624880085, 1426.5292453490324, 1465.5603319004256, 1470.5294305822035, 887.121749468022, 902.670525258276, 911.726482055394, 932.6595792535676, 948.9572969216264, 7040.612766297801, 7108.075950126554, 7135.250798666169, 7156.964215178891, 7161.606111663908, 709.2907092907093, 731.8389954210065, 984.1929617713549, 1007.9496025198711, 1023.2581378500528, 4870.245112007645, 4922.286268491049, 5155.304033955443, 5155.845324640191, 5165.586753059746, 17136.0, 17451.127443627767, 17574.472765817045, 17727.202275897616, 17744.733828992576, 16911.985280883186, 17374.218160182823, 17508.0, 17644.294228230985, 17644.735328970077, 9904.60381584743, 10123.898761012295, 10163.593456261815, 10236.641717539851, 10243.38539687621, 7262.419006479575, 7667.539947603162, 7711.421643376882, 7711.730089446843, 7785.0, 15018.399264029753, 15669.686606268038, 15937.12345820991, 16310.102944338176, 16389.754153687943, 15393.923030384776, 16081.0, 16113.033218006956, 16328.755068673741, 16564.503064908073, 9818.75453113678, 10058.949705251427, 10062.49687515636, 10067.949660251652, 10071.143952764098, 12154.756904861677, 12178.269303841798, 12178.330191839534, 12235.75528489443, 12518.561850335194, 9896.851547226941, 10343.965603439596, 10381.53283102247, 10576.629817956335, 10790.244682872124, 9478.24174066087, 9497.952510237405, 9695.321327507289, 9882.11061004513, 9967.202623790225, 8619.612117454855, 8725.52009639476, 8727.694530691395, 8736.519491428033, 8772.473651580925, 6109.877802444015, 6480.57876238043, 6527.0, 6621.304763000008, 6792.66036698173, 6960.930390696029, 6982.79051628452, 6991.265917078634, 7089.751858684921, 7105.502614816914], "value": 6044.506480017063, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [496.2927231949715, 498.57480091291086, 520.7396301849076, 525.3039722367863, 525.7187404738465, 5892.616979896304, 6054.424829641177, 6135.754569817202, 6160.291566469858, 6164.383561643834, 5986.2517185351835, 5990.341062483123, 5996.880062398749, 6058.454739073482, 6059.212302400681, 4842.733649649268, 4842.806287748486, 4860.448264661063, 4905.705657660543, 4920.901581968358, 4927.359443272369, 4939.67835117496, 4948.303174769759, 4974.452810190876, 4985.202367621181, 4701.200795864695, 4883.926741098886, 4886.364772579577, 4890.14422476067, 4903.0, 4890.5109489051165, 4913.385826771653, 4918.114739346934, 4922.876928076791, 4953.257011448276, 4399.472063352387, 4408.426904502427, 4426.380306757057, 4429.512753597101, 4453.465584129925, 5869.530437564985, 5872.500837428781, 5905.4980326672285, 5939.881202375971, 5981.820545383602, 5544.889102217973, 5566.805161819317, 5583.441655834425, 5626.971865140689, 5646.943530564683, 6466.191726034246, 6493.31820158886, 6505.739770409178, 6512.837179070561, 6520.673966301713, 4761.642876784255, 4806.182948898696, 4857.14999875024, 4859.0, 4881.219004959189, 6781.186257649064, 6786.864262714718, 6834.316568343175, 6861.279565645636, 6865.485088618324, 4965.0, 4970.826021089245, 5005.6996580205305, 5012.749362531858, 5017.172166592544, 4967.3542439482635, 4969.403671559364, 5026.52248036436, 5044.924326135111, 5047.091523525801, 5524.210273811699, 5546.362168350611, 5574.219609254707, 5577.330720313588, 5600.775968961278, 6421.29365769765, 6445.774397896051, 6461.418472337512, 6474.697904068865, 6489.383508566679, 1734.4449776071788, 1737.1586118714204, 1749.3964582219114, 1753.3687872365938, 1758.6746451906438, 1113.3987646670869, 1131.7170707323169, 1137.147139645266, 1209.29256385014, 1224.6203676860202, 5426.728663566806, 5470.835874923759, 5530.364008139035, 5554.750036248379, 5590.294960037147, 6518.478521718251, 6524.217093948757, 6529.967350163314, 6533.308680595448, 6543.476521878239, 5595.18869763882, 5614.9438505615235, 5626.971865140648, 5641.899829533284, 5699.914501282484, 3475.5134281200653, 3534.6818786309354, 3536.628653991294, 3542.6988705960284, 3543.7342199335153, 6376.776812811622, 6413.647249401234, 6451.838704032343, 6453.741850326029, 6484.870302594016, 6692.498062645321, 6747.797566073025, 6785.219699734594, 6811.25076241613, 6883.311668833177, 6386.169797926333, 6388.552801303864, 6454.967725161344, 6477.643729594917, 6499.967500162469, 6549.6070235786, 6557.475401967736, 6564.704588293443, 6566.540342176193, 6660.966695166493, 6392.3379921219885, 6404.743810247538, 6452.935060780505, 6540.117084193573, 6558.672066396756, 6262.248530176408, 6366.9681651591445, 6380.7447702091395, 6423.132877061724, 6481.967590162208, 4862.149123903374, 4905.092557876804, 4916.385451818523, 4932.0135972804865, 4943.35736354286, 6570.8357291068105, 6573.1454910861285, 6638.668066596554, 6727.730890764315, 6735.4611631070375, 6407.679616019273, 6436.903446448214, 6465.127207826883, 6479.287278399466, 6500.0, 6404.103425520524, 6414.871702565829, 6459.450946669585, 6485.675716214076, 6500.3174666659315, 6194.969025154845, 6201.782937597162, 6310.810675679737, 6326.272478665012, 6380.457661098673, 5946.375630558902, 6382.266039405527, 6459.321771213955, 6461.64460954652, 6513.967430162819, 6227.657478838707, 6246.500279977682, 6272.5922815016875, 6278.748850045947, 6281.214848143982], "value": 4968.360056196711, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [907.3104440625127, 908.4776253654148, 918.7197904639082, 923.035427977764, 925.4632313258309, 16413.261403236855, 16569.66860662786, 16732.41436549721, 16793.83206167938, 16876.0, 17031.148442577884, 17076.0, 17097.145142742876, 18537.073146342696, 19819.90090049548, 1026.2764750850633, 1060.9893901060968, 1061.6921092883056, 1065.4193464561793, 1067.5249513966248, 1079.600547797316, 1080.5785743560018, 1084.2735367303926, 1084.799312127255, 1086.6142519405616, 1125.5779082843933, 1126.7577470843767, 1127.1321082766265, 1131.598282609674, 1133.4162906103363, 1111.5276007696696, 1113.059464752287, 1116.6594188772422, 1120.9047230985336, 1127.7631697343568, 787.401574803148, 788.2393490281905, 791.5606838204794, 793.567505709384, 797.4178849439884, 18476.63046739071, 18931.14809833561, 18945.715814262796, 18957.146928388116, 18993.43019709411, 18845.905770471196, 20782.0, 20890.791092089035, 20906.0, 20979.16083356664, 15438.228088595526, 16304.103274319908, 16391.508254752258, 16418.1790910454, 16456.753148702777, 3581.87463438781, 3582.6059133495296, 3588.659077387644, 3603.990882552889, 3606.5131207287204, 91186.5440672799, 113552.0, 117194.41402793016, 117429.0, 119745.0, 13979.580612581638, 14124.858751412354, 14424.134551926918, 15043.398264069534, 17496.0, 30371.088867334016, 30443.08670739837, 30528.236794079883, 30899.845500772353, 31301.686983129875, 8456.450330728483, 8801.075887031897, 8833.823323533494, 8842.823143537093, 8858.468491890508, 4182.205380977604, 4228.386883901817, 4253.851115210953, 4266.104118135165, 4268.231718290737, 4961.702297862068, 5078.238264260391, 5081.0, 5083.771230294646, 5092.108880945893, 948.6821914658667, 988.2489308125876, 1025.7128004158847, 1048.224314007629, 1049.4333060147587, 661.9073329733841, 687.2418596298784, 715.0704084689883, 719.2124623537219, 730.6565914020401, 11858.940705296418, 12231.938840305742, 12952.740945181044, 12983.610491685264, 13176.42365612849, 686.2862622872157, 696.8606278744271, 709.0994437064899, 721.2751185058983, 726.6148941061246, 5643.125315576092, 5652.152177173457, 5659.349174844863, 5759.0, 5777.104548794943, 101863.49068254611, 102591.4870425658, 105270.0, 110150.44924775325, 111065.0, 88252.0, 90796.0, 91148.0, 92155.0, 94967.52516237374, 78916.0, 82820.0, 83477.0, 83838.58080709557, 84984.57507712422, 10982.341059536453, 12331.69170770738, 12370.81443778326, 12511.874881251071, 12648.05139614551, 34139.0, 36595.26809463849, 36657.0, 37010.0, 37561.43657845189, 61201.38798611957, 62887.0, 65264.0, 65304.34695652983, 67804.0, 18490.63018739591, 18754.437366879014, 19036.0, 19201.51996200106, 19499.902500487406, 21086.156553738292, 22159.0, 22183.667244991662, 22239.0, 22428.663570046137, 17697.20362583661, 17886.195121219836, 19535.413937581896, 19758.802411975696, 19759.110840012523, 17756.91121544384, 18801.96589187608, 19458.708119378505, 19832.60334793325, 19898.0, 17279.3952211672, 18622.813771862107, 19340.4197874064, 19456.416307510797, 19559.0, 13516.662083447993, 14036.649083772987, 14598.0, 14665.093537840012, 14901.0, 13017.544385946447, 14911.478098266509, 14913.254337282875, 15296.61758456003, 15389.461368852484], "value": 9107.300609953085, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1535.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 107.0, 108.0, 107.0, 112.0, 108.0, 108.0, 110.0, 109.0, 108.0], "value": 107.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 119.0, 152.0, 177.0, 124.0, 148.0, 156.0, 123.0, 175.0, 130.0], "value": 145.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 163.0, 160.0, 164.0, 172.0, 162.0, 166.0, 166.0, 165.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 75.0, 159.0, 75.0, 74.0, 74.0, 74.0, 94.0, 74.0], "value": 84.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 134.0, 81.0, 82.0, 80.0, 139.0, 81.0, 83.0, 128.0], "value": 97.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0, 114.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 151.0, 148.0, 149.0, 152.0, 149.0, 149.0, 150.0, 149.0], "value": 149.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 57.0, 55.0, 63.0, 60.0, 57.0, 54.0, 55.0, 57.0], "value": 56.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 53.0, 54.0, 54.0, 55.0, 54.0, 55.0, 54.0], "value": 54.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 77.0, 80.0, 76.0, 76.0, 76.0, 76.0, 77.0, 80.0], "value": 77.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 130.0, 126.0, 134.0, 129.0, 131.0, 128.0, 126.0, 134.0, 154.0], "value": 132.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 188.0, 185.0, 195.0, 189.0, 185.0, 193.0, 181.0, 182.0], "value": 186.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 74.0, 78.0, 76.0, 68.0, 68.0, 69.0, 68.0, 69.0], "value": 70.5, "unit": "score"}]}]} 18:12:29 INFO - Return code: 0 18:12:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:12:29 INFO - # TBPL SUCCESS # 18:12:29 INFO - Running post-action listener: _package_coverage_data 18:12:29 INFO - Running post-action listener: _resource_record_post_action 18:12:29 INFO - [mozharness: 2017-07-17 01:12:29.801213Z] Finished run-tests step (success) 18:12:29 INFO - Running post-run listener: _resource_record_post_run 18:12:29 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 626688; Write bytes: 441581568; Read time: 432; Write time: 578436 18:12:29 INFO - TinderboxPrint: CPU usage
13.1% 18:12:29 INFO - TinderboxPrint: I/O read bytes / time
626,688 / 432 18:12:29 INFO - TinderboxPrint: I/O write bytes / time
441,581,568 / 578,436 18:12:29 INFO - TinderboxPrint: CPU idle
8,256.2 (86.8%) 18:12:29 INFO - TinderboxPrint: CPU user
1,197.8 (12.6%) 18:12:29 INFO - TinderboxPrint: Swap in / out
0 / 0 18:12:29 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 116338688; Read time: 0; Write time: 194484 18:12:29 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 18:12:29 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 622592; Write bytes: 325242880; Read time: 424; Write time: 383952 18:12:30 INFO - Running post-run listener: _upload_blobber_files 18:12:30 INFO - Blob upload gear active. 18:12:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:12:30 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 18:12:30 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'] 18:12:30 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 18:12:30 INFO - Traceback (most recent call last): 18:12:30 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 18:12:30 INFO - main() 18:12:30 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 18:12:30 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 18:12:30 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 18:12:30 INFO - return set(response.json().get('whitelist', [])) 18:12:30 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 18:12:30 INFO - return json.loads(self.text or self.content, **kwargs) 18:12:30 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/__init__.py", line 488, in loads 18:12:30 INFO - return _default_decoder.decode(s) 18:12:30 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 370, in decode 18:12:30 INFO - obj, end = self.raw_decode(s) 18:12:30 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 389, in raw_decode 18:12:30 INFO - return self.scan_once(s, idx=_w(s, idx).end()) 18:12:30 INFO - simplejson.scanner.JSONDecodeError: Expecting value: line 1 column 1 (char 0) 18:12:30 ERROR - Return code: 1 18:12:30 INFO - Setting buildbot property blobber_files to {} 18:12:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:12:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:12:30 INFO - Contents: 18:12:30 INFO - blobber_files:{} 18:12:30 INFO - Running post-run listener: copy_logs_to_upload_dir 18:12:30 INFO - Copying logs to upload dir... 18:12:30 INFO - mkdir: /builds/slave/test/build/upload/logs 18:12:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.346837 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2017-07-16 18:12:30.815985) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-16 18:12:30.824095) ========= 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=745a4373a2a16df560f216e000000264-1500246898.727850-1272901271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011253 build_url: 'https://queue.taskcluster.net/v1/task/NrNICH0tQbmyluaBowvvdg/artifacts/public/build/target.tar.bz2' blobber_files: '{}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-16 18:12:30.880495) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 18:12:30.880832) ========= 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=745a4373a2a16df560f216e000000264-1500246898.727850-1272901271 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-16 18:12:30.930462) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-16 18:12:30.933812) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-16 18:12:30.934141) ========= ========= Total master_lag: 0.16 =========