builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-062 starttime: 1500423273.83 results: success (0) revision: 1b065ffd8a535a0ad4c39a912af18e948e6a42c1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-18 17:14:33.829049) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-18 17:14:33.829578) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-18 17:14:33.829865) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-18 17:14:33.845833) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 17:14:33.846161) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1500423273.763360-1125523907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-18 17:14:34-- 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% 108M=0s 2017-07-18 17:14:34 (108 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.135050 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 17:14:33.994606) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 17:14:33.994970) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1500423273.763360-1125523907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020285 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 17:14:34.044689) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 17:14:34.045090) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1b065ffd8a535a0ad4c39a912af18e948e6a42c1 --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 1b065ffd8a535a0ad4c39a912af18e948e6a42c1 --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=a4ce256d2ec601f24a60a71e000001bc-1500423273.763360-1125523907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-18 17:14:34,540 truncating revision to first 12 chars 2017-07-18 17:14:34,540 Setting DEBUG logging. 2017-07-18 17:14:34,540 attempt 1/10 2017-07-18 17:14:34,540 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1b065ffd8a53?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-18 17:14:34,847 unpacking tar archive at: mozilla-central-1b065ffd8a53/testing/mozharness/ program finished with exit code 0 elapsedTime=0.630854 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 17:14:34.689042) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-18 17:14:34.689384) ========= script_repo_revision: 1b065ffd8a535a0ad4c39a912af18e948e6a42c1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-18 17:14:34.689791) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-18 17:14:34.690072) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-18 17:14:34.697657) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-07-18 17:14:34.697975) ========= /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=a4ce256d2ec601f24a60a71e000001bc-1500423273.763360-1125523907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:14:35 INFO - MultiFileLogger online at 20170718 17:14:35 in /builds/slave/test 17:14:35 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:14:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:14:35 INFO - {'append_to_log': False, 17:14:35 INFO - 'base_work_dir': '/builds/slave/test', 17:14:35 INFO - 'blob_upload_branch': 'Firefox', 17:14:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:14:35 INFO - 'branch': 'Firefox', 17:14:35 INFO - 'buildbot_json_path': 'buildprops.json', 17:14:35 INFO - 'code_coverage': False, 17:14:35 INFO - 'config_files': ('talos/linux_config.py',), 17:14:35 INFO - 'default_actions': ('clobber', 17:14:35 INFO - 'read-buildbot-config', 17:14:35 INFO - 'download-and-extract', 17:14:35 INFO - 'populate-webroot', 17:14:35 INFO - 'create-virtualenv', 17:14:35 INFO - 'install', 17:14:35 INFO - 'setup-mitmproxy', 17:14:35 INFO - 'run-tests'), 17:14:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:14:35 INFO - 'disable_ccov_upload': False, 17:14:35 INFO - 'download_minidump_stackwalk': True, 17:14:35 INFO - 'download_symbols': 'ondemand', 17:14:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:14:35 INFO - 'tooltool.py': '/tools/tooltool.py', 17:14:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:14:35 INFO - '/tools/misc-python/virtualenv.py')}, 17:14:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:14:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:14:35 INFO - 'gecko_profile': False, 17:14:35 INFO - 'gecko_profile_interval': 0, 17:14:35 INFO - 'installer_path': 'installer.exe', 17:14:35 INFO - 'log_level': 'info', 17:14:35 INFO - 'log_name': 'talos', 17:14:35 INFO - 'log_to_console': True, 17:14:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:14:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:14:35 INFO - 'opt_config_files': (), 17:14:35 INFO - 'pip_index': False, 17:14:35 INFO - 'suite': 'dromaeojs-e10s', 17:14:35 INFO - 'system_bits': '32', 17:14:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:14:35 INFO - 'title': 'talos-linux64-ix-062', 17:14:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:14:35 INFO - 'use_talos_json': True, 17:14:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:14:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:14:35 INFO - 'work_dir': 'build'} 17:14:35 INFO - [mozharness: 2017-07-19 00:14:35.299036Z] Running clobber step. 17:14:35 INFO - Running pre-action listener: _resource_record_pre_action 17:14:35 INFO - Running main action method: clobber 17:14:35 INFO - rmtree: /builds/slave/test/build 17:14:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:14:37 INFO - Running post-action listener: _resource_record_post_action 17:14:37 INFO - [mozharness: 2017-07-19 00:14:37.030830Z] Finished clobber step (success) 17:14:37 INFO - [mozharness: 2017-07-19 00:14:37.030934Z] Running read-buildbot-config step. 17:14:37 INFO - Running pre-action listener: _resource_record_pre_action 17:14:37 INFO - Running main action method: read_buildbot_config 17:14:37 INFO - Using buildbot properties: 17:14:37 INFO - { 17:14:37 INFO - "project": "", 17:14:37 INFO - "product": "firefox", 17:14:37 INFO - "who": "kwierso@gmail.com", 17:14:37 INFO - "installer_path": "public/build/target.tar.bz2", 17:14:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 17:14:37 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 17:14:37 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 17:14:37 INFO - "stage_platform": "linux64-stylosequential", 17:14:37 INFO - "basedir": "/builds/slave/test", 17:14:37 INFO - "buildnumber": 130, 17:14:37 INFO - "platform": "ubuntu64_hw_styloseq", 17:14:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:14:37 INFO - "slavebuilddir": "test", 17:14:37 INFO - "taskId": "fxTLOXapTKGn-vZqrnu9sA", 17:14:37 INFO - "branch": "mozilla-central", 17:14:37 INFO - "script_repo_revision": "production", 17:14:37 INFO - "revision": "1b065ffd8a535a0ad4c39a912af18e948e6a42c1", 17:14:37 INFO - "slavename": "talos-linux64-ix-062", 17:14:37 INFO - "repo_path": "mozilla-central" 17:14:37 INFO - } 17:14:37 INFO - Finding installer, test and symbols from parent task. 17:14:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fxTLOXapTKGn-vZqrnu9sA'}, attempt #1 17:14:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fxTLOXapTKGn-vZqrnu9sA'}, attempt #1 17:14:37 INFO - Task dependencies: AL8eNrU6QISMrRooVk2SfA 17:14:37 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA'}, attempt #1 17:14:38 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.tar.bz2 17:14:38 INFO - Set test_url: https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/test_packages.json 17:14:38 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.crashreporter-symbols.zip 17:14:38 INFO - Running post-action listener: _resource_record_post_action 17:14:38 INFO - [mozharness: 2017-07-19 00:14:38.418230Z] Finished read-buildbot-config step (success) 17:14:38 INFO - [mozharness: 2017-07-19 00:14:38.418451Z] Running download-and-extract step. 17:14:38 INFO - Running pre-action listener: _resource_record_pre_action 17:14:38 INFO - Running main action method: download_and_extract 17:14:38 INFO - mkdir: /builds/slave/test/build/tests 17:14:38 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:14:38 INFO - trying https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.test_packages.json 17:14:38 INFO - Downloading https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:14:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:14:38 INFO - Downloaded 989 bytes. 17:14:38 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:14:38 INFO - Using the following test package requirements: 17:14:38 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 17:14:38 INFO - u'common': [u'target.common.tests.zip'], 17:14:38 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:14:38 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:14:38 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:14:38 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:14:38 INFO - u'mozbase': [u'target.common.tests.zip'], 17:14:38 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:14:38 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:14:38 INFO - u'web-platform': [u'target.common.tests.zip', 17:14:38 INFO - u'target.web-platform.tests.tar.gz'], 17:14:38 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:14:38 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:14:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.common.tests.zip 17:14:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:14:38 INFO - Fetch https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.common.tests.zip into memory 17:14:40 INFO - Content-Length response header: 72754959 17:14:40 INFO - Bytes received: 72754959 17:14:51 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:14:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.common.tests.zip 17:14:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:14:51 INFO - Fetch https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.common.tests.zip into memory 17:14:53 INFO - Content-Length response header: 72754959 17:14:53 INFO - Bytes received: 72754959 17:15:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.talos.tests.zip 17:15:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:15:05 INFO - Fetch https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.talos.tests.zip into memory 17:15:06 INFO - Content-Length response header: 14495033 17:15:06 INFO - Bytes received: 14495033 17:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:06 INFO - trying https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.tar.bz2 17:15:06 INFO - Downloading https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:15:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:15:10 INFO - Downloaded 61947920 bytes. 17:15:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.tar.bz2 17:15:10 INFO - mkdir: /builds/slave/test/properties 17:15:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:15:10 INFO - Writing to file /builds/slave/test/properties/build_url 17:15:10 INFO - Contents: 17:15:10 INFO - build_url:https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.tar.bz2 17:15:10 INFO - Running post-action listener: _resource_record_post_action 17:15:10 INFO - Running post-action listener: set_extra_try_arguments 17:15:10 INFO - [mozharness: 2017-07-19 00:15:10.599989Z] Finished download-and-extract step (success) 17:15:10 INFO - [mozharness: 2017-07-19 00:15:10.600217Z] Running populate-webroot step. 17:15:10 INFO - Running pre-action listener: _resource_record_pre_action 17:15:10 INFO - Running main action method: populate_webroot 17:15:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:15:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:15:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:15:10 INFO - '--tppagecycles', 17:15:10 INFO - '7'], 17:15:10 INFO - 'tests': ['tsvgm']}}, 17:15:10 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:15:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:15:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:15:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:15:10 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:15:10 INFO - 'talos_options': ['--disable-e10s'], 17:15:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:15:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:15:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:15:10 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:15:10 INFO - 'talos_options': ['--disable-e10s'], 17:15:10 INFO - 'tests': ['damp', 'tps']}, 17:15:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:15:10 INFO - 'tests': ['damp', 'tps']}, 17:15:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:15:10 INFO - 'tests': ['dromaeo_dom']}, 17:15:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:15:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:15:10 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 17:15:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 17:15:10 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 17:15:10 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 17:15:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:15:10 INFO - 'tests': ['a11yr', 17:15:10 INFO - 'ts_paint', 17:15:10 INFO - 'tpaint', 17:15:10 INFO - 'sessionrestore', 17:15:10 INFO - 'sessionrestore_no_auto_restore', 17:15:10 INFO - 'tabpaint']}, 17:15:10 INFO - 'other-e10s': {'tests': ['a11yr', 17:15:10 INFO - 'ts_paint', 17:15:10 INFO - 'tpaint', 17:15:10 INFO - 'sessionrestore', 17:15:10 INFO - 'sessionrestore_many_windows', 17:15:10 INFO - 'sessionrestore_no_auto_restore', 17:15:10 INFO - 'tabpaint']}, 17:15:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:15:10 INFO - 'ts_paint', 17:15:10 INFO - 'tpaint', 17:15:10 INFO - 'sessionrestore', 17:15:10 INFO - 'sessionrestore_many_windows', 17:15:10 INFO - 'sessionrestore_no_auto_restore', 17:15:10 INFO - 'tabpaint']}, 17:15:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:15:10 INFO - 'ts_paint', 17:15:10 INFO - 'tpaint', 17:15:10 INFO - 'sessionrestore', 17:15:10 INFO - 'sessionrestore_many_windows', 17:15:10 INFO - 'sessionrestore_no_auto_restore', 17:15:10 INFO - 'tabpaint']}, 17:15:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:15:10 INFO - 'tests': ['a11yr', 17:15:10 INFO - 'ts_paint', 17:15:10 INFO - 'tpaint', 17:15:10 INFO - 'sessionrestore', 17:15:10 INFO - 'sessionrestore_no_auto_restore', 17:15:10 INFO - 'tabpaint']}, 17:15:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:15:10 INFO - 'tests': ['a11yr', 17:15:10 INFO - 'ts_paint', 17:15:10 INFO - 'tpaint', 17:15:10 INFO - 'sessionrestore', 17:15:10 INFO - 'sessionrestore_no_auto_restore', 17:15:10 INFO - 'tabpaint']}, 17:15:10 INFO - 'perf-reftest': {'tests': ['bloom_basic']}, 17:15:10 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 17:15:10 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 17:15:10 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 17:15:10 INFO - 'talos_options': ['--mitmproxy', 17:15:10 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 17:15:10 INFO - '--firstNonBlankPaint'], 17:15:10 INFO - 'tests': ['quantum_pageload_google', 17:15:10 INFO - 'quantum_pageload_youtube', 17:15:10 INFO - 'quantum_pageload_amazon', 17:15:10 INFO - 'quantum_pageload_facebook']}, 17:15:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:15:10 INFO - 'tests': ['tsvgx', 17:15:10 INFO - 'tsvgr_opacity', 17:15:10 INFO - 'tart', 17:15:10 INFO - 'tscrollx', 17:15:10 INFO - 'cart', 17:15:10 INFO - 'tsvg_static']}, 17:15:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:15:10 INFO - 'tsvgr_opacity', 17:15:10 INFO - 'tart', 17:15:10 INFO - 'tscrollx', 17:15:10 INFO - 'cart', 17:15:10 INFO - 'tsvg_static']}, 17:15:10 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:15:10 INFO - 'talos_options': ['--disable-e10s'], 17:15:10 INFO - 'tests': ['tp5o']}, 17:15:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:15:10 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:15:10 INFO - 'talos_options': ['--disable-e10s', 17:15:10 INFO - '--xperf_path', 17:15:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:15:10 INFO - 'tests': ['tp5n']}, 17:15:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:15:10 INFO - 'talos_options': ['--xperf_path', 17:15:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:15:10 INFO - 'tests': ['tp5n']}}, 17:15:10 INFO - 'talos.zip': {'path': '', 17:15:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:15:10 INFO - Running post-action listener: _resource_record_post_action 17:15:10 INFO - [mozharness: 2017-07-19 00:15:10.623675Z] Finished populate-webroot step (success) 17:15:10 INFO - [mozharness: 2017-07-19 00:15:10.623766Z] Running create-virtualenv step. 17:15:10 INFO - Running pre-action listener: _resource_record_pre_action 17:15:10 INFO - Running main action method: create_virtualenv 17:15:10 INFO - Creating virtualenv /builds/slave/test/build/venv 17:15:10 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:15:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:15:10 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 17:15:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:15:10 INFO - Using real prefix '/usr' 17:15:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:15:11 INFO - Installing distribute.............................................................................................................................................................................................done. 17:15:13 INFO - Installing pip.................done. 17:15:13 INFO - Return code: 0 17:15:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:15:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:15:13 INFO - Reading from file tmpfile_stdout 17:15:13 INFO - Output received: 17:15:13 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:15:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:15:13 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:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:13 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:15:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:13 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 0x1daf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2120b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211dd00>, '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 0x211ec00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211f090>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1500423273.763360-1125523907', '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:15:13 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:15:13 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:15:13 INFO - Using env: {'DISPLAY': ':0', 17:15:13 INFO - 'HOME': '/home/cltbld', 17:15:13 INFO - 'LANG': 'en_US.UTF-8', 17:15:13 INFO - 'LANGUAGE': 'en_US:en', 17:15:13 INFO - 'LOGNAME': 'cltbld', 17:15:13 INFO - 'MAIL': '/var/mail/cltbld', 17:15:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:13 INFO - 'MOZ_NO_REMOTE': '1', 17:15:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:13 INFO - 'NO_EM_RESTART': '1', 17:15:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:13 INFO - 'PWD': '/builds/slave/test', 17:15:13 INFO - 'SHELL': '/bin/bash', 17:15:13 INFO - 'SHLVL': '1', 17:15:13 INFO - 'TERM': 'linux', 17:15:13 INFO - 'TMOUT': '86400', 17:15:13 INFO - 'USER': 'cltbld', 17:15:13 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1500423273.763360-1125523907', 17:15:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:13 INFO - '_': '/tools/buildbot/bin/python'} 17:15:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:13 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:15:13 INFO - Cleaning up... 17:15:13 INFO - Return code: 0 17:15:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:15:13 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:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:13 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:15:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:13 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 0x1daf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2120b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211dd00>, '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 0x211ec00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211f090>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1500423273.763360-1125523907', '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:15:13 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:15:13 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:15:13 INFO - Using env: {'DISPLAY': ':0', 17:15:13 INFO - 'HOME': '/home/cltbld', 17:15:13 INFO - 'LANG': 'en_US.UTF-8', 17:15:13 INFO - 'LANGUAGE': 'en_US:en', 17:15:13 INFO - 'LOGNAME': 'cltbld', 17:15:13 INFO - 'MAIL': '/var/mail/cltbld', 17:15:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:13 INFO - 'MOZ_NO_REMOTE': '1', 17:15:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:13 INFO - 'NO_EM_RESTART': '1', 17:15:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:13 INFO - 'PWD': '/builds/slave/test', 17:15:13 INFO - 'SHELL': '/bin/bash', 17:15:13 INFO - 'SHLVL': '1', 17:15:13 INFO - 'TERM': 'linux', 17:15:13 INFO - 'TMOUT': '86400', 17:15:13 INFO - 'USER': 'cltbld', 17:15:13 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1500423273.763360-1125523907', 17:15:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:13 INFO - '_': '/tools/buildbot/bin/python'} 17:15:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:13 INFO - Downloading/unpacking psutil>=3.1.1 17:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:15:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:15:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:15:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:15:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:15:15 INFO - Installing collected packages: psutil 17:15:15 INFO - Running setup.py install for psutil 17:15:15 INFO - building 'psutil._psutil_linux' extension 17:15:15 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:15:15 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:15:15 INFO - building 'psutil._psutil_posix' extension 17:15:15 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:15:15 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:15:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:15:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:15:15 INFO - Successfully installed psutil 17:15:15 INFO - Cleaning up... 17:15:15 INFO - Return code: 0 17:15:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:15:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:15 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 0x1daf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2120b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211dd00>, '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 0x211ec00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211f090>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1500423273.763360-1125523907', '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:15:15 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:15:15 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:15:15 INFO - Using env: {'DISPLAY': ':0', 17:15:15 INFO - 'HOME': '/home/cltbld', 17:15:15 INFO - 'LANG': 'en_US.UTF-8', 17:15:15 INFO - 'LANGUAGE': 'en_US:en', 17:15:15 INFO - 'LOGNAME': 'cltbld', 17:15:15 INFO - 'MAIL': '/var/mail/cltbld', 17:15:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:15 INFO - 'MOZ_NO_REMOTE': '1', 17:15:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:15 INFO - 'NO_EM_RESTART': '1', 17:15:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:15 INFO - 'PWD': '/builds/slave/test', 17:15:15 INFO - 'SHELL': '/bin/bash', 17:15:15 INFO - 'SHLVL': '1', 17:15:15 INFO - 'TERM': 'linux', 17:15:15 INFO - 'TMOUT': '86400', 17:15:15 INFO - 'USER': 'cltbld', 17:15:15 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1500423273.763360-1125523907', 17:15:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:15 INFO - '_': '/tools/buildbot/bin/python'} 17:15:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:15:15 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:15:15 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:15:15 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:15:15 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:15:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:15:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:15:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:15:17 INFO - Installing collected packages: mozsystemmonitor 17:15:17 INFO - Running setup.py install for mozsystemmonitor 17:15:17 INFO - Successfully installed mozsystemmonitor 17:15:17 INFO - Cleaning up... 17:15:17 INFO - Return code: 0 17:15:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:15:17 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:15:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:17 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:15:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:17 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 0x1daf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2120b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211dd00>, '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 0x211ec00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211f090>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1500423273.763360-1125523907', '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:15:17 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:15:17 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:15:17 INFO - Using env: {'DISPLAY': ':0', 17:15:17 INFO - 'HOME': '/home/cltbld', 17:15:17 INFO - 'LANG': 'en_US.UTF-8', 17:15:17 INFO - 'LANGUAGE': 'en_US:en', 17:15:17 INFO - 'LOGNAME': 'cltbld', 17:15:17 INFO - 'MAIL': '/var/mail/cltbld', 17:15:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:17 INFO - 'MOZ_NO_REMOTE': '1', 17:15:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:17 INFO - 'NO_EM_RESTART': '1', 17:15:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:17 INFO - 'PWD': '/builds/slave/test', 17:15:17 INFO - 'SHELL': '/bin/bash', 17:15:17 INFO - 'SHLVL': '1', 17:15:17 INFO - 'TERM': 'linux', 17:15:17 INFO - 'TMOUT': '86400', 17:15:17 INFO - 'USER': 'cltbld', 17:15:17 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1500423273.763360-1125523907', 17:15:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:17 INFO - '_': '/tools/buildbot/bin/python'} 17:15:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:17 INFO - Downloading/unpacking jsonschema==2.5.1 17:15:17 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:15:17 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:15:17 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:15:17 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:15:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:15:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:15:18 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:15:18 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:15:18 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:15:18 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:15:18 INFO - Downloading functools32-3.2.3-2.tar.gz 17:15:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:15:18 INFO - warning: no files found matching '*.txt' 17:15:18 INFO - no previously-included directories found matching 'build' 17:15:18 INFO - no previously-included directories found matching 'dist' 17:15:18 INFO - no previously-included directories found matching '.git*' 17:15:18 INFO - Installing collected packages: jsonschema, functools32 17:15:18 INFO - Running setup.py install for functools32 17:15:18 INFO - warning: no files found matching '*.txt' 17:15:18 INFO - no previously-included directories found matching 'build' 17:15:18 INFO - no previously-included directories found matching 'dist' 17:15:18 INFO - no previously-included directories found matching '.git*' 17:15:18 INFO - Successfully installed jsonschema functools32 17:15:18 INFO - Cleaning up... 17:15:18 INFO - Return code: 0 17:15:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:15:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:18 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 0x1daf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2120b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211dd00>, '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 0x211ec00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211f090>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1500423273.763360-1125523907', '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:15:18 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:15:18 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:15:18 INFO - Using env: {'DISPLAY': ':0', 17:15:18 INFO - 'HOME': '/home/cltbld', 17:15:18 INFO - 'LANG': 'en_US.UTF-8', 17:15:18 INFO - 'LANGUAGE': 'en_US:en', 17:15:18 INFO - 'LOGNAME': 'cltbld', 17:15:18 INFO - 'MAIL': '/var/mail/cltbld', 17:15:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:18 INFO - 'MOZ_NO_REMOTE': '1', 17:15:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:18 INFO - 'NO_EM_RESTART': '1', 17:15:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:18 INFO - 'PWD': '/builds/slave/test', 17:15:18 INFO - 'SHELL': '/bin/bash', 17:15:18 INFO - 'SHLVL': '1', 17:15:18 INFO - 'TERM': 'linux', 17:15:18 INFO - 'TMOUT': '86400', 17:15:18 INFO - 'USER': 'cltbld', 17:15:18 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1500423273.763360-1125523907', 17:15:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:18 INFO - '_': '/tools/buildbot/bin/python'} 17:15:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:15:19 INFO - Cleaning up... 17:15:19 INFO - Return code: 0 17:15:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:15:19 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:15:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:19 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:15:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:19 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 0x1daf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2120b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211dd00>, '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 0x211ec00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211f090>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1500423273.763360-1125523907', '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:15:19 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:15:19 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:15:19 INFO - Using env: {'DISPLAY': ':0', 17:15:19 INFO - 'HOME': '/home/cltbld', 17:15:19 INFO - 'LANG': 'en_US.UTF-8', 17:15:19 INFO - 'LANGUAGE': 'en_US:en', 17:15:19 INFO - 'LOGNAME': 'cltbld', 17:15:19 INFO - 'MAIL': '/var/mail/cltbld', 17:15:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:19 INFO - 'MOZ_NO_REMOTE': '1', 17:15:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:19 INFO - 'NO_EM_RESTART': '1', 17:15:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:19 INFO - 'PWD': '/builds/slave/test', 17:15:19 INFO - 'SHELL': '/bin/bash', 17:15:19 INFO - 'SHLVL': '1', 17:15:19 INFO - 'TERM': 'linux', 17:15:19 INFO - 'TMOUT': '86400', 17:15:19 INFO - 'USER': 'cltbld', 17:15:19 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1500423273.763360-1125523907', 17:15:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:19 INFO - '_': '/tools/buildbot/bin/python'} 17:15:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:19 INFO - Downloading/unpacking blobuploader==1.2.4 17:15:19 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:15:19 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:15:19 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:15:19 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:15:20 INFO - Downloading blobuploader-1.2.4.tar.gz 17:15:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:15:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:15: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:15: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:15: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:15: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:15:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:15:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:15: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:15: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:15: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:15: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:15:20 INFO - Downloading docopt-0.6.1.tar.gz 17:15:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:15:21 INFO - Installing collected packages: blobuploader, requests, docopt 17:15:21 INFO - Running setup.py install for blobuploader 17:15:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:15:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:15:21 INFO - Running setup.py install for requests 17:15:21 INFO - Running setup.py install for docopt 17:15:21 INFO - Successfully installed blobuploader requests docopt 17:15:21 INFO - Cleaning up... 17:15:21 INFO - Return code: 0 17:15:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:15:21 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:15:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:21 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:15:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:21 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 0x1daf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2120b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211dd00>, '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 0x211ec00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211f090>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1500423273.763360-1125523907', '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:15:21 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:15:21 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:15:21 INFO - Using env: {'DISPLAY': ':0', 17:15:21 INFO - 'HOME': '/home/cltbld', 17:15:21 INFO - 'LANG': 'en_US.UTF-8', 17:15:21 INFO - 'LANGUAGE': 'en_US:en', 17:15:21 INFO - 'LOGNAME': 'cltbld', 17:15:21 INFO - 'MAIL': '/var/mail/cltbld', 17:15:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:21 INFO - 'MOZ_NO_REMOTE': '1', 17:15:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:21 INFO - 'NO_EM_RESTART': '1', 17:15:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:21 INFO - 'PWD': '/builds/slave/test', 17:15:21 INFO - 'SHELL': '/bin/bash', 17:15:21 INFO - 'SHLVL': '1', 17:15:21 INFO - 'TERM': 'linux', 17:15:21 INFO - 'TMOUT': '86400', 17:15:21 INFO - 'USER': 'cltbld', 17:15:21 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1500423273.763360-1125523907', 17:15:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:21 INFO - '_': '/tools/buildbot/bin/python'} 17:15:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:15:21 INFO - Running setup.py (path:/tmp/pip-eE0AdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:15:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:15:21 INFO - Running setup.py (path:/tmp/pip-ZA6QMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:15:22 INFO - Running setup.py (path:/tmp/pip-DLFTWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:15:22 INFO - Running setup.py (path:/tmp/pip-45lnyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:15:22 INFO - Running setup.py (path:/tmp/pip-VZUKWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:15:22 INFO - Running setup.py (path:/tmp/pip-qylnBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:15:22 INFO - Running setup.py (path:/tmp/pip-flHCr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:15:22 INFO - Running setup.py (path:/tmp/pip-hbAmzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:15:22 INFO - Running setup.py (path:/tmp/pip-spo4ua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:15:22 INFO - Running setup.py (path:/tmp/pip-qYQnTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:15:22 INFO - Running setup.py (path:/tmp/pip-A84ShU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:15:22 INFO - Running setup.py (path:/tmp/pip-5PBbIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:15:22 INFO - Running setup.py (path:/tmp/pip-lumKVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:15:22 INFO - Running setup.py (path:/tmp/pip-HhkR_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:15:22 INFO - Running setup.py (path:/tmp/pip-4T07Pg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:15:22 INFO - Running setup.py (path:/tmp/pip-frgWhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:15:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:15:22 INFO - Running setup.py (path:/tmp/pip-r5O0MO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:15:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:15:23 INFO - Running setup.py install for manifestparser 17:15:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:15:23 INFO - Running setup.py install for mozcrash 17:15:23 INFO - Running setup.py install for mozdebug 17:15:23 INFO - Running setup.py install for mozdevice 17:15:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:15:23 INFO - Running setup.py install for mozfile 17:15:23 INFO - Running setup.py install for mozhttpd 17:15:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:15:23 INFO - Running setup.py install for mozinfo 17:15:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:15:23 INFO - Running setup.py install for mozInstall 17:15:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:15:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:15:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:15:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:15:23 INFO - Running setup.py install for mozleak 17:15:23 INFO - Running setup.py install for mozlog 17:15:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:15:24 INFO - Running setup.py install for moznetwork 17:15:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:15:24 INFO - Running setup.py install for mozprocess 17:15:24 INFO - Running setup.py install for mozprofile 17:15:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:15:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:15:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:15:24 INFO - Running setup.py install for mozrunner 17:15:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:15:24 INFO - Running setup.py install for mozscreenshot 17:15:24 INFO - Running setup.py install for moztest 17:15:24 INFO - Running setup.py install for mozversion 17:15:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:15:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:15:24 INFO - Cleaning up... 17:15:24 INFO - Return code: 0 17:15:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:15:24 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:15:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:24 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:15:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:24 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 0x1daf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2120b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211dd00>, '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 0x211ec00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211f090>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1500423273.763360-1125523907', '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:15:24 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:15:24 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:15:24 INFO - Using env: {'DISPLAY': ':0', 17:15:24 INFO - 'HOME': '/home/cltbld', 17:15:24 INFO - 'LANG': 'en_US.UTF-8', 17:15:24 INFO - 'LANGUAGE': 'en_US:en', 17:15:24 INFO - 'LOGNAME': 'cltbld', 17:15:24 INFO - 'MAIL': '/var/mail/cltbld', 17:15:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:24 INFO - 'MOZ_NO_REMOTE': '1', 17:15:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:24 INFO - 'NO_EM_RESTART': '1', 17:15:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:24 INFO - 'PWD': '/builds/slave/test', 17:15:24 INFO - 'SHELL': '/bin/bash', 17:15:24 INFO - 'SHLVL': '1', 17:15:24 INFO - 'TERM': 'linux', 17:15:24 INFO - 'TMOUT': '86400', 17:15:24 INFO - 'USER': 'cltbld', 17:15:24 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1500423273.763360-1125523907', 17:15:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:24 INFO - '_': '/tools/buildbot/bin/python'} 17:15:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:15:25 INFO - Running setup.py (path:/tmp/pip-AJjJmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:15:25 INFO - Running setup.py (path:/tmp/pip-Uq3Dhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:15:25 INFO - Running setup.py (path:/tmp/pip-eHrxhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:15:25 INFO - Running setup.py (path:/tmp/pip-PhMWFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:15:25 INFO - Running setup.py (path:/tmp/pip-IaqEML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:15:25 INFO - Running setup.py (path:/tmp/pip-QCwClc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:15:25 INFO - Running setup.py (path:/tmp/pip-llTR2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:15:25 INFO - Running setup.py (path:/tmp/pip-qjYbAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:15:25 INFO - Running setup.py (path:/tmp/pip-yljqTo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:15:25 INFO - Running setup.py (path:/tmp/pip-xWj2IC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:15:25 INFO - Running setup.py (path:/tmp/pip-v2O1Wk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:15:25 INFO - Running setup.py (path:/tmp/pip-H20A9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:15:25 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:15:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:15:25 INFO - Running setup.py (path:/tmp/pip-wMRIbQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:15:26 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:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:15:26 INFO - Running setup.py (path:/tmp/pip-wq9MTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:15:26 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:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:15:26 INFO - Running setup.py (path:/tmp/pip-wn9mHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:15:26 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:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:15:26 INFO - Running setup.py (path:/tmp/pip-JdMHlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:15:26 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:15:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:15:26 INFO - Running setup.py (path:/tmp/pip-f4BAvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:15:26 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:15:26 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:15:26 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:15:26 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:15:26 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:15:26 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:15:26 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:15:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:15:26 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:15:26 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:15:26 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:15:26 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:15:27 INFO - Downloading blessings-1.6.tar.gz 17:15:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:15:27 INFO - Installing collected packages: blessings 17:15:27 INFO - Running setup.py install for blessings 17:15:27 INFO - Successfully installed blessings 17:15:27 INFO - Cleaning up... 17:15:27 INFO - Return code: 0 17:15:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:15:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:15:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:15:27 INFO - Reading from file tmpfile_stdout 17:15:27 INFO - Current package versions: 17:15:27 INFO - argparse == 1.2.1 17:15:27 INFO - blessings == 1.6 17:15:27 INFO - blobuploader == 1.2.4 17:15:27 INFO - docopt == 0.6.1 17:15:27 INFO - functools32 == 3.2.3-2 17:15:27 INFO - jsonschema == 2.5.1 17:15:27 INFO - manifestparser == 1.1 17:15:27 INFO - mozInstall == 1.13 17:15:27 INFO - mozcrash == 1.0 17:15:27 INFO - mozdebug == 0.1 17:15:27 INFO - mozdevice == 0.51 17:15:27 INFO - mozfile == 1.2 17:15:27 INFO - mozhttpd == 0.7 17:15:27 INFO - mozinfo == 0.10 17:15:27 INFO - mozleak == 0.1 17:15:27 INFO - mozlog == 3.5 17:15:27 INFO - moznetwork == 0.27 17:15:27 INFO - mozprocess == 0.25 17:15:27 INFO - mozprofile == 0.28 17:15:27 INFO - mozrunner == 6.13 17:15:27 INFO - mozscreenshot == 0.1 17:15:27 INFO - mozsystemmonitor == 0.3 17:15:27 INFO - moztest == 0.8 17:15:27 INFO - mozversion == 1.4 17:15:27 INFO - psutil == 3.1.1 17:15:27 INFO - requests == 1.2.3 17:15:27 INFO - wsgiref == 0.1.2 17:15:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:15:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:15:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:27 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 0x1daf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2120b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211dd00>, '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 0x211ec00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211f090>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1500423273.763360-1125523907', '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:15:27 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:15:27 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:15:27 INFO - Using env: {'DISPLAY': ':0', 17:15:27 INFO - 'HOME': '/home/cltbld', 17:15:27 INFO - 'LANG': 'en_US.UTF-8', 17:15:27 INFO - 'LANGUAGE': 'en_US:en', 17:15:27 INFO - 'LOGNAME': 'cltbld', 17:15:27 INFO - 'MAIL': '/var/mail/cltbld', 17:15:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:27 INFO - 'MOZ_NO_REMOTE': '1', 17:15:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:27 INFO - 'NO_EM_RESTART': '1', 17:15:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:27 INFO - 'PWD': '/builds/slave/test', 17:15:27 INFO - 'SHELL': '/bin/bash', 17:15:27 INFO - 'SHLVL': '1', 17:15:27 INFO - 'TERM': 'linux', 17:15:27 INFO - 'TMOUT': '86400', 17:15:27 INFO - 'USER': 'cltbld', 17:15:27 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1500423273.763360-1125523907', 17:15:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:27 INFO - '_': '/tools/buildbot/bin/python'} 17:15:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:28 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:15:28 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:15:28 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:15:28 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:15:28 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:15:28 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:15:28 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:15:28 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:15:28 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:15:28 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 17:15:28 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:15:28 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:15:28 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:15:28 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:15:29 INFO - Downloading marionette_driver-1.4.0.tar.gz 17:15:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 17:15:29 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 17:15:29 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:15:29 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:15:29 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:15:29 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:15:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 17:15:29 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:15:29 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:15:29 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:15:29 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:15:29 INFO - Installing collected packages: marionette-driver, simplejson 17:15:29 INFO - Running setup.py install for marionette-driver 17:15:29 INFO - Running setup.py install for simplejson 17:15:29 INFO - building 'simplejson._speedups' extension 17:15:29 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:15:30 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:15:30 INFO - Successfully installed marionette-driver simplejson 17:15:30 INFO - Cleaning up... 17:15:30 INFO - Return code: 0 17:15:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:15:30 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:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:15:30 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:15:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:15:30 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 0x1daf1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f7ba80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2120b60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x211dd00>, '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 0x211ec00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211f090>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1500423273.763360-1125523907', '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:15:30 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:15:30 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:15:30 INFO - Using env: {'DISPLAY': ':0', 17:15:30 INFO - 'HOME': '/home/cltbld', 17:15:30 INFO - 'LANG': 'en_US.UTF-8', 17:15:30 INFO - 'LANGUAGE': 'en_US:en', 17:15:30 INFO - 'LOGNAME': 'cltbld', 17:15:30 INFO - 'MAIL': '/var/mail/cltbld', 17:15:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:30 INFO - 'MOZ_NO_REMOTE': '1', 17:15:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:30 INFO - 'NO_EM_RESTART': '1', 17:15:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:30 INFO - 'PWD': '/builds/slave/test', 17:15:30 INFO - 'SHELL': '/bin/bash', 17:15:30 INFO - 'SHLVL': '1', 17:15:30 INFO - 'TERM': 'linux', 17:15:30 INFO - 'TMOUT': '86400', 17:15:30 INFO - 'USER': 'cltbld', 17:15:30 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1500423273.763360-1125523907', 17:15:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:30 INFO - '_': '/tools/buildbot/bin/python'} 17:15:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:15:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:15:30 INFO - Cleaning up... 17:15:30 INFO - Return code: 0 17:15:30 INFO - Running post-action listener: _resource_record_post_action 17:15:30 INFO - Running post-action listener: _start_resource_monitoring 17:15:30 INFO - Starting resource monitoring. 17:15:30 INFO - [mozharness: 2017-07-19 00:15:30.922769Z] Finished create-virtualenv step (success) 17:15:30 INFO - [mozharness: 2017-07-19 00:15:30.923369Z] Running install step. 17:15:30 INFO - Running pre-action listener: _resource_record_pre_action 17:15:30 INFO - Running main action method: install 17:15:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:15:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:15:31 INFO - Reading from file tmpfile_stdout 17:15:31 INFO - Detecting whether we're running mozinstall >=1.0... 17:15:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:15:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:15:31 INFO - Reading from file tmpfile_stdout 17:15:31 INFO - Output received: 17:15:31 INFO - Usage: mozinstall [options] installer 17:15:31 INFO - Options: 17:15:31 INFO - -h, --help show this help message and exit 17:15:31 INFO - -d DEST, --destination=DEST 17:15:31 INFO - Directory to install application into. [default: 17:15:31 INFO - "/builds/slave/test"] 17:15:31 INFO - --app=APP Application being installed. [default: firefox] 17:15:31 INFO - mkdir: /builds/slave/test/build/application 17:15:31 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:15:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:15:49 INFO - Reading from file tmpfile_stdout 17:15:49 INFO - Output received: 17:15:49 INFO - /builds/slave/test/build/application/firefox/firefox 17:15:49 INFO - Running post-action listener: _resource_record_post_action 17:15:49 INFO - [mozharness: 2017-07-19 00:15:49.231423Z] Finished install step (success) 17:15:49 INFO - [mozharness: 2017-07-19 00:15:49.231681Z] Running setup-mitmproxy step. 17:15:49 INFO - Running pre-action listener: _resource_record_pre_action 17:15:49 INFO - Running main action method: setup_mitmproxy 17:15:49 INFO - Skipping: mitmproxy is not required 17:15:49 INFO - Running post-action listener: _resource_record_post_action 17:15:49 INFO - [mozharness: 2017-07-19 00:15:49.232834Z] Finished setup-mitmproxy step (success) 17:15:49 INFO - [mozharness: 2017-07-19 00:15:49.233059Z] Running run-tests step. 17:15:49 INFO - Running pre-action listener: _resource_record_pre_action 17:15:49 INFO - Running pre-action listener: _set_gcov_prefix 17:15:49 INFO - Running main action method: run_tests 17:15:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:15:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:15:49 INFO - Python 2.7.3 17:15:49 INFO - Return code: 0 17:15:49 INFO - grabbing minidump binary from tooltool 17:15:49 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:15:49 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 0x211dd00>, '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 0x211ec00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x211f090>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:15:49 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:15:49 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:15:49 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:15:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:15:49 INFO - Return code: 0 17:15:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:15:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:15:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:15:49 INFO - ENV: RUST_BACKTRACE is now 1 17:15:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:15:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:15:49 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/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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:15:49 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/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-062 --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:15:49 INFO - Using env: {'DISPLAY': ':0', 17:15:49 INFO - 'HOME': '/home/cltbld', 17:15:49 INFO - 'LANG': 'en_US.UTF-8', 17:15:49 INFO - 'LANGUAGE': 'en_US:en', 17:15:49 INFO - 'LOGNAME': 'cltbld', 17:15:49 INFO - 'MAIL': '/var/mail/cltbld', 17:15:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:15:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:15:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:15:49 INFO - 'MOZ_NO_REMOTE': '1', 17:15:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:15:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:15:49 INFO - 'NO_EM_RESTART': '1', 17:15:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:15:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:15:49 INFO - 'PWD': '/builds/slave/test', 17:15:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:15:49 INFO - 'RUST_BACKTRACE': '1', 17:15:49 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 17:15:49 INFO - 'SHELL': '/bin/bash', 17:15:49 INFO - 'SHLVL': '1', 17:15:49 INFO - 'TERM': 'linux', 17:15:49 INFO - 'TMOUT': '86400', 17:15:49 INFO - 'USER': 'cltbld', 17:15:49 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1500423273.763360-1125523907', 17:15:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:15:49 INFO - '_': '/tools/buildbot/bin/python'} 17:15:49 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/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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:15:49 INFO - mozversion application_buildid: 20170718233341 17:15:49 INFO - mozversion application_changeset: 1b065ffd8a535a0ad4c39a912af18e948e6a42c1 17:15:49 INFO - mozversion application_display_name: Nightly 17:15:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:15:49 INFO - mozversion application_name: Firefox 17:15:49 INFO - mozversion application_remotingname: firefox 17:15:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:15:49 INFO - mozversion application_vendor: Mozilla 17:15:49 INFO - mozversion application_version: 56.0a1 17:15:49 INFO - mozversion platform_buildid: 20170718233341 17:15:49 INFO - mozversion platform_changeset: 1b065ffd8a535a0ad4c39a912af18e948e6a42c1 17:15:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:15:49 INFO - mozversion platform_version: 56.0a1 17:15:49 INFO - using testdate: 1500423349 17:15:49 INFO - actual date: 1500423349 17:15:49 INFO - starting webserver on 'localhost:42945' 17:15:49 INFO - SUITE-START | Running 2 tests 17:15:49 INFO - TEST-START | dromaeo_css 17:15:49 INFO - Initialising browser for dromaeo_css test... 17:15:49 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42945/getInfo.html -profile /tmp/tmpE7YcMX/profile 17:15:49 INFO - TEST-INFO | started process 28675 (/builds/slave/test/build/application/firefox/firefox http://localhost:42945/getInfo.html) 17:15:55 INFO - TEST-INFO | 28675: exit 0 17:15:55 INFO - Browser initialized. 17:15:55 INFO - Running cycle 1/1 for dromaeo_css test... 17:15:55 INFO - TEST-INFO | started process 28944 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE7YcMX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:16:07 INFO - PID 28944 | RSS: Main: 175902720 17:16:07 INFO - PID 28944 | 17:19:05 INFO - PID 28944 | Cycle 1(1): loaded http://localhost:42945/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42945/tests/dromaeo/cssquery-ext.html) 17:19:06 INFO - PID 28944 | RSS: Main: 181022720 17:19:06 INFO - PID 28944 | 17:22:08 INFO - PID 28944 | Cycle 1(1): loaded http://localhost:42945/tests/dromaeo/cssquery-ext.html (next: http://localhost:42945/tests/dromaeo/cssquery-jquery.html) 17:22:09 INFO - PID 28944 | RSS: Main: 178331648 17:22:09 INFO - PID 28944 | 17:25:10 INFO - PID 28944 | Cycle 1(1): loaded http://localhost:42945/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42945/tests/dromaeo/cssquery-mootools.html) 17:25:11 INFO - PID 28944 | RSS: Main: 178782208 17:25:11 INFO - PID 28944 | 17:28:13 INFO - PID 28944 | Cycle 1(1): loaded http://localhost:42945/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42945/tests/dromaeo/cssquery-prototype.html) 17:28:13 INFO - PID 28944 | RSS: Main: 178876416 17:28:13 INFO - PID 28944 | 17:31:16 INFO - PID 28944 | Cycle 1(1): loaded http://localhost:42945/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42945/tests/dromaeo/cssquery-yui.html) 17:31:17 INFO - PID 28944 | RSS: Main: 180682752 17:31:17 INFO - PID 28944 | 17:34:19 INFO - PID 28944 | Cycle 1(1): loaded http://localhost:42945/tests/dromaeo/cssquery-yui.html (next: http://localhost:42945/tests/dromaeo/cssquery-dojo.html) 17:34:19 INFO - PID 28944 | RSS: Main: 182845440 17:34:19 INFO - PID 28944 | 17:34:19 INFO - PID 28944 | __start_tp_report 17:34:19 INFO - PID 28944 | _x_x_mozilla_page_load 17:34:19 INFO - PID 28944 | _x_x_mozilla_page_load_details 17:34:19 INFO - PID 28944 | |i|pagename|runs| 17:34:19 INFO - PID 28944 | |0;dojo.html;3063.877444902204;3114.454970380183;3118.36073604911;3135.717785399315;3154.8264845433505;6011.609245399051;6034.336223015464;6077.301110372308;6083.665398403086;6112.205413296271;6113.938860611393;6156.6613836238985;6166.167567378403;6169;6181.1964444622245;5586.35756887957;5642.351129620085;5644;5672.347680016789;5687.60186786923;5644.407337229593;5680.857978550528;5685.545156387479;5690.658560486363;5707.400722924095;5663.631863928852;5672.773089076432;5675;5677.261955945742;5706.971465142668;5613.859653508654;5614.719264036782;5675.914861277105;5690.971545142248;5691.971540142294;5521.2270282160525;5555.8888822223325;5599.888002239933;5610.24261724666;5652.152177173416;6024.1566180734735;6047.0627052806885;6082.178905847698;6104.725287362079;6128.724207410677;6488.643124628144;6496.870062598721;6603.273639899608;6611.86776264472;6647.6343801090925;6558.540902136852;6615.4046135848;6656.733730650768;6667.966660166717;6691.799246022579;6187.443130118266;6206.25524937006;6206.379362063757;6212.596181248205;6292.276388215368;6732.394084532416;6757.087793147911;6778.22050464193;6834;6858.3141685831015;6405.807825765234;6451.096846441502;6502.122213501117;6506.544541882117;6524.804255872236;6421.550491465552;6573.769918052845;6574.112494813235;6601.504887133484;6603.20761508622;5633.718314084362;6358.109864618957;6476.190476190476;6552.934470655233;6658.300878407795;6580.934190658128;6583.7695680651905;6663.86672266552;6669.733210671616;6681.198256209189;5245.554127899171;5326.840194794162;5355.3841308249275;5365.034293827149;5374.811881584125;4546.977265113654;4579.290210017452;4585.610223131004;4594.104149690845;4607.493175750665;5695.345035320991;5706.657600543981;5716.056850619684;5717.571182161355;5730.255066841367;6531.444827189647;6568.737250510022;6622.106015687917;6623.536352455379;6631.30371311015;5683.886322273532;5691.430856914276;5698.572607054488;5712.371639119693;5722.084466485342;4996.725180115129;5713.657180569179;5737.254156959652;5756.050251708505;5770.105633626795;6366;6397.776077837253;6503.219613646393;6506.1541999540705;6518.315576864456;6545.639989800607;6642.83392915181;6681.966590167018;6712.194536655437;6756.628385438848;6312.747490100344;6315;6404.1674582304;6420.2937676856445;6427.971524556048;5725.074851418073;6457.580257283262;6498.512611554247;6512.283648798723;6523.739050437929;6657.900131497934;6676.432503237279;6688.464922806066;6748.089007983859;6748.122744043243;6356.173697419306;6451.2903580607035;6517.576357536745;6537.0521274413995;6542.182227221598;6350.079238510298;6423.197100362455;6439.903401449075;6452.774152904626;6512.54412191161;6304.621722696653;6326.2092238470195;6358.205224346957;6361.904571431525;6377.394147555975;6319.988801791691;6367.044943258548;6413.615183089029;6487.18910136233;6500.739970401131;6279.744051189689;6291.087792270187;6345.302016778243;6346.90479642815;6377.585456945284 17:34:19 INFO - PID 28944 | |1;ext.html;737.3290305821703;752.2327226229249;794.3367288314257;817.6402382951501;825.1748251748252;39902.20195596086;40200.798996005055;40380.79809600955;40384.990375240595;40392.798036009815;36492.63507364925;37022.81488592553;37125;37148.257034859285;37183.62816371836;6807.761728339509;6924.134483189601;6953;6958.8956165657555;6960.164780226354;6867.141607299088;6923.861522769566;6958.756443524478;6962.268961758993;6968.616726080064;6820.931790682104;6849.349311815369;6891.138607674041;6904.102466679325;6945.791626251221;6866.725330986755;6908.447324214051;6916.066331045295;6916.896246556305;6920.100386949714;6154.815355539296;6158.507319414481;6207.937920620781;6215.067739839015;6215.627062376272;33583.32833343319;33775.6622433775;33817.49273760871;33853;34068.82965585181;3342.8829990950444;3394.6435624259343;3399.3201359727905;3406.574178227697;3428.0572842468273;26829;26891.193264202106;26901.192964211106;26924.461510769674;26962.32594185161;4294.79402263729;4294.978525107385;4300.075483770973;4316.892077698051;4367.432233809616;184876;190450.9999999986;190470;191228;191665;46844.76577617158;47404.762976184895;47569.5243047572;47656.5234347659;47783.283250751265;49136;49321.260181097314;49340.753296234005;49693.50306496961;49725.751371243634;15805.446809361618;15916.920415397848;15924.76112858308;15967.281472333541;16010.519684409486;13333.466661333632;13637.863621363858;13686.384112714952;13727.588172354845;13757.79363309551;14216.715665686628;14292;14329.283535823168;14400.351984160738;14544.927275363556;5488.463230295523;5654.717264136777;5665.3201615806365;5786.71066446676;5792.913106303409;960.0702587798436;970.0498347066605;989.7426669066094;1013.1287093099928;1015.4465816130227;22470;22610.321690349316;22785.20251791179;23023.194188203666;28519;1091.6397588795837;1098.7363032872054;1100.708312297242;1107.4186052322434;1111.1721767283425;12200.145989780807;12285.262884226975;12330.753384932252;12351.25892446456;12403.689907752198;235554;236981;237682;237706;239111;49433.25850112251;49744.75127624339;50045.74977125164;50220;50690.74654626777;1420.7229590229806;1474.2849717887032;1480.1267252321181;1487.0780116327946;1502.0912348029503;21867.924341747825;21947.561048778614;22389.104435822384;22717;22903;35914.820425897706;36121.81939090288;36127.81936090303;36182.27635447329;36255.27489450249;139676;192968;196227;196914;197193;29302.41395172127;29938.101856944326;31444;31849.203769905936;33360.1659958503;40249;41957.1608567833;42025.78987105045;42448;42792.57207427886;29691.40617187601;31713.365732685677;32212.677873221906;33199.170020749676;33808.15479613029;32612.510812338307;32726.34547309088;33212.33575328528;33391.49912751262;33549.161270967445;35128.29743405066;36305.27389452144;36331.818340908125;36363.09092272714;36507.634923650425;31705.5244171333;32252.516212257306;32527.837360813046;32532.349353012334;32785.836070819496;22847.314580562608;23320.067197311917;23772.930218139878;23783.405414864766;23877 17:34:19 INFO - PID 28944 | |2;jquery.html;571.6141604417018;574.362457671984;580.7096451774112;587.7678317064757;590.3683059126733;21649;22395;22417.439564010907;22673.886630566845;22759.31722048337;23593.41016474589;24646.383840404;26057.348566285804;26073.65337119659;26195.214143575675;6334.176557047577;6488;6489.578177418476;6491.448226900719;6497.090407342976;6412.519061070415;6447.677616119198;6456.838579035515;6464.676766161697;6529.5429319947625;5783.190353350535;6197.349278325779;6399.648019358933;6448.12950251717;6480.4815614750705;6261.624302541816;6276.905846412307;6292.370762923671;6359.077933699611;6396.936030639704;5871.588988770788;5877.882442351171;5878.5297176225795;5886.941130588682;5898.292204935436;28718.282042948886;29130;29447.263818404495;29485.705142948726;29536.409271814657;1940.9029548522658;1961.568454939911;1964.734760807287;1969.1532640964379;1981.4749091490767;18157.273709051624;18816.81183188178;18913.810861891343;18975.810241897543;19034;2341.3561270650707;2358.13927916311;2395.6286775549816;2405.518896220763;2406.446517301013;135500;143088.28455857758;143507;143691.28154359266;143868;13990.30048497571;14455.855441445661;14654.56036318912;14740.189289589176;14746.778798318033;23190.65214021791;23205.767942320697;23224.767752322598;23293.76706232916;23401.648975265383;10337.534810933375;10370.27408081427;10540.262181647364;10661.946690266499;10697.197710171768;9739.513024348897;9784.510774461249;9788.951055244679;9969.152622027064;10112.949435252776;8772.91227087721;9021.548922553977;9054.683086091954;9097.13577210164;9358.251339892793;2568.0754928225824;2642;2665.6134860445127;2701.4597080583567;2789.7768178545666;937.704623043739;944.3719926248967;947.4457442396138;977.726236653738;996.1681995533665;19546.511337216398;19804.108815103355;20467.28364507235;23127.653085203736;25595.232143035737;1044.6657069737612;1066.648006157966;1069.1340014588209;1070.3195982307857;1075.499892549968;11398.772024559463;11607.883921160681;11682.299062056303;11698.239614425205;11700.765984680258;478169;498524;507770;508570;509592;116309;117192;119220.99999999827;119846;120989.39505302593;1258.0816004316716;1268.657462485124;1283.756086343573;1290.9225446473242;1292.1730092740654;17431.866928650106;18393.908030459763;18551;18861.528461788566;19053.42839714811;52947.73526132345;53111.73444132755;54190;54901;56105;67457.3254267451;67605.66197168983;68407.65796170988;68547.3145268541;68849.65575172091;14137.787933180805;14612.561623150898;15039.323230454436;15112.09327440357;15277;23904.282871513882;23907.641385379582;24403.511929761662;24453;24833;18876.150573223964;19124.808751912304;19190.904045479685;19227;19336.70994935049;15886.364545418053;16834.410795622094;16946.322147113977;17255.309787608858;17722.46832595024;18972.525686857385;19151.712724309426;19722.90138549298;19753.209871605548;19854;14792.556223313319;14898.702025959203;14933.850661493681;14970.326335315154;14985.100893946397;18064.909675451538;18918.810811891704;18970.905145474186;19129.617407652047;19250 17:34:19 INFO - PID 28944 | |3;mootools.html;1324.3047400114942;1372.6499742565645;1406.964825879353;1407.0783636717954;1414.632195629136;13301.534446294381;13989.370478328474;14109.082909610881;14133.78799318011;14178.361973711182;13455.125416847897;13944.233067181302;14507.709845803078;14509.347079381427;14549.636259093528;2521.924342269735;2580.8838602262945;2581.6772903387077;2584.5735453650127;2589;2525.8105642076825;2564.384547708555;2569.6530968319316;2572.2669039323796;2576.0726138590094;2494.0896572751;2503.198976327576;2508.3603681061395;2528.4311030018284;2553.438243586408;2618.3454136465884;2639.5908634161638;2642.8150029497942;2648.523265812153;2649.31117909344;2425.527022230666;2430.9513809723708;2444.863138640541;2451.570975079354;2477.801775857945;13934.86065139356;14047.367868445843;14059.929700351535;14075.859241407557;14079.85920140806;7211.278872112799;7570.129435114977;7573.886391704129;7587.620618969029;7594.734184303523;4592.150452166326;4898.877528061791;4951.232558953368;5007.699538027694;5022.4977502249485;1801.5135913303466;1840.2638944422204;1841.3371186372894;1902.7431296774896;1919.1172060852025;22590.548189036126;22850.200242991414;22873.885630572073;22963.885180574158;23063.423414414607;6059.121917089347;6093.421124993119;6163.291221509584;6206.534509911775;6325.841853953688;15091.773623395658;15147.621309467351;15159.24203789806;15271.618209544627;15273.396293389256;7179.210286868441;7296.124465064227;7313.744018959417;7314.561126332437;7328.487005909536;6732.091167692299;6759.797206083826;6793.830154246085;6801.795946121624;6900.482463815234;4701.459332176843;4734.834280800155;4783.8757891895375;4897.804087836446;4981.053599816023;1374.086232655293;1376.1536654957329;1381.4681347681014;1404.7190561887664;1409.7462456757883;862.1206369503071;882.5234373438271;896.7489103051156;913.488446469979;923.6305477808796;7056.470764692566;7205.747798827016;7286.089238845145;7299.160596531361;7317.597532135677;684.8596037812237;713.2724620886667;980.3578655980344;998.770282834952;1023.65195833417;4699.154152252559;4924.556789888856;5271.78912843482;5340.225667278223;5343.625946183807;18691.81308186928;19530.218791248477;19563.804361956198;19580.21679132819;19656.70514942277;17267.568310792078;18919.43241702751;19215.13531891068;19302.806971930102;19690;10472.738181545523;10666.41334726582;10932.56269749217;11020;11207.495662695199;7613.619319034137;8276.586170691562;8437.198466145706;8511.8723219153;8610.483370997761;16497.422590209284;16750.24623891952;16944.49166525006;17272.136393180543;17331.65336693234;15890.205489725236;17300.65398691994;17763;17920.193591288164;17932.64134717272;10988.505517251902;11096.5561377544;11125.777484450104;11143.108551315712;11216.943915280697;12978.156419832681;12983.28591927453;13006.869931300565;13065.150765200231;13083.934580327037;10052.64815731446;10165.83092944321;10410.011048950337;10645.520951557353;10758.031777139782;9982.35114717541;10395.844062339222;10625.309354891908;10805.297655652357;10851.891481085404;9131.863022054542;9162.312826537904;9193.264538837011;9220.723378298662;9292.814143717223;6620.3710647488415;7063.293670633101;7215.530990485601;7348.706051758084;7387.593682347522;7206.315400036988;7288.67200975968;7395.8151046224275;7446.032015837906;7456.142543607338 17:34:19 INFO - PID 28944 | |4;prototype.html;474.3904083253021;476.48539577256554;504.1429569731456;506.1597747738752;513.345484507253;6019.217501724781;6025.6685882276515;6041.939580604193;6118.663473508961;6126.908096378553;5719.828405147842;5880.5883588148845;5893.38119497453;5923.942099661735;5960.7317670704815;4742.4309082910095;4837.588804951574;4843.39457567804;4869.685185000048;4870.391201099863;4782.33047373368;4793.640476964224;4804.20730579454;4812.951870481285;4865.732384718839;4739.668223224376;4792.90414191716;4817.542333478314;4852;4864.0515099555605;4683.765811709401;4771.761411929389;4776.689515181502;4784.306275590037;4809.591184749301;4280.72175308604;4325.4593175853015;4330.588594083557;4330.956690433087;4363.67272454564;5822.301323841124;5850.824475265749;5853.122031695238;5877.559183061245;5926.733297001645;5526.281583394173;5543.8891222175735;5550.111982082847;5563.161418621179;5578.972105139489;6319.968400158015;6320.367963203689;6369.6496692681885;6387.936120638827;6424.293327733945;4728.763561821929;4759.952400476021;4763.333133361332;4796.2326027835725;4821.903561928777;6684.231313398973;6732.83167920801;6749.5612785168805;6768.5600435972;6796.898046529306;4880.975595122072;4891.437484689306;4900.117978763857;4914;4930.728809915489;4856.781444834991;4913.11563918491;4949.257611358325;4978.477259887732;5004.774785134678;5396.244525766396;5405.405405405402;5416.322959630046;5431.293931788842;5448.700321482277;6243.531735119794;6309.274433440213;6313.179286692793;6393;6396.872062558816;1680.823513531086;1683.4764538093045;1685.9662806743797;1689.923953422099;1709.1112621437032;1101.9724506887392;1170.9531618735325;1185.875483074282;1199.2264989081993;1201.9158658893793;5437.564994800407;5498.762778374914;5639.464250896158;5652;5692.544596432275;6489.383508566679;6529.151210342625;6543.672816359163;6558.491546944229;6615.272320044791;5600.719964001783;5623.184638227434;5659.179418984224;5666.668332941756;5685.772569097273;3417.4019546579248;3460.809655468923;3466.341395134916;3496.930061398758;3554;6384.936150638527;6416.35836416364;6433.646149461824;6441.518450756353;6458.257300410419;6773.525853190328;6776.93223067763;6787.2534021257625;6794.422474089659;6796.558223715443;6401.519886008475;6401.9039714404325;6409.455196308273;6421.903671444838;6447.161868957006;6580.802575922538;6603.8113139635325;6605.834854128685;6613.14029176204;6671.766488172891;6420.903686444613;6449.258335291313;6538.901916471352;6584.407403333723;6604.405603495708;6284.24589049317;6360.809175724736;6377.202849643794;6416.615003099829;6425.485961123006;4767.976160119178;4798.5441383068555;4802.135615589227;4813.278008298783;4844.854654360375;6511.674416279072;6538.803835884931;6573.868522629617;6583.325838654609;6606.669666516751;6244.781432649836;6247.5001999839;6316.9887121678985;6325.905111423424;6326.841828954313;6276.968615156895;6340.365963403623;6397.185238495047;6450;6481.902771458337;6220.782272620437;6291.937080629318;6313.6843157841;6337.7781777637565;6383.648899310582;6352.425239876706;6384.521160912857;6403.775867844603;6447.484201263794;6484.675766211765;5784.418036594706;5862.67755273447;5890.764369425175;6084.969575152273;6125.540584456273 17:34:19 INFO - PID 28944 | |5;yui.html;890.8307421589893;895.4761464543242;904.4663648447415;909.7771046093704;911.0525053943899;16240.51278461648;16275.430359937389;16312.102834344107;16413.507594772145;17340.393086241984;18151.63696726068;19013.52466188346;19512.12195451208;19624.901875490603;19884.900575497137;1029.130384824822;1043.0768769638848;1045.1012129568564;1054.2409465185056;1063.7393838509538;1021.8262895307815;1034.0848349210964;1034.6533911139777;1034.7671773850861;1046.1892033673887;1047.9476026198697;1092.8907109289087;1114.420501339303;1127.216584473791;1128.7798879218556;1092.006274290392;1093.038126448728;1095.6986828622114;1097.3854641400842;1097.6926460591046;797.1072398913254;797.4258533855615;798.1858504325613;800.139849661616;800.4076983032572;18404.355847545405;18649.81350186508;19439.416817495498;19694.507637309038;19910.80089199104;20174.596508069902;20359.89820050905;20822.16711331545;20916;20941.5811683767;16118.838811611851;16338.918305408397;16465.83534164667;16541.338346466127;16573.6685266294;3594.245208506217;3649.9635003649887;3677.264547090566;3684.852605895761;3686.9631303687156;124592.37703811514;127391;130531.34734326362;130821;131151;15222.923885380724;16093.597660058593;16203.189840507928;16441.09573973443;16449.177541122895;29516.557251641243;29581;29959;29960.50619798691;29966;8383.16168383169;8384.287335576422;8403.579821009047;8420.957895210608;8435.620397082146;3935.626115519021;3983.50206224222;3990.74060186087;4042.969042894043;4061.248668996245;5033.19468884984;5098.133317335987;5131.923021154686;5151.5621172200035;5221.582273418117;915.199200699388;926;943.9811203776023;950.064186776025;952.5903861339552;600.8708127752467;672.525869262169;695.5548448992648;697.5117417807454;707.8938159276149;11773.646790596125;11974.6229183645;11991.280523168638;12135.817962730565;12351.047664747375;648.7859006527834;674.7469698862926;680.6630717794724;696.916370035599;697.6999890047329;5262.105442074857;5405.864853378697;5508.283923089973;5557.916631250535;5666.2350582670815;99946;99967;102868;103773.48113259385;104709.95290047154;90798.54600726954;93118;95170.52414737882;96145;96206.51896740471;74028;74358;79571.60214198891;80636;81265.59367203126;11161.49773260189;11639.76720465603;11663.833616638269;12052.457639406422;12089.62741685325;34249.31501369909;36585.268294633424;36992.445113322785;37724.24551509009;37875.431868521446;61611;62714;66200;67226.66386668035;67304.6634766823;18272;18865.528361791065;18880.05599720036;18887.244510219985;18962.52593685169;20201.292954746514;20525.486862828548;20734.481637959172;21207.10769000112;21945.780542194374;16280.755788662942;16369.508914732578;16454.670906581563;19002.239910403983;19042.904785475985;18578.814211858247;18688.159032843825;19188.904055479634;19743.21027158955;19852.305169319003;18704;18878;19484.805151948865;19798.40604781859;19832.107555159764;11910.821337680116;11937.28376297425;11938.52245910154;12944.870551294744;14232.573022809333;12785.424655890321;13070.477180913038;13156.736865262832;13393.732125357634;13440.39518221702 17:34:19 INFO - PID 28944 | __end_tp_report 17:34:19 INFO - PID 28944 | __start_cc_report 17:34:19 INFO - PID 28944 | _x_x_mozilla_cycle_collect,349 17:34:19 INFO - PID 28944 | __end_cc_report 17:34:19 INFO - PID 28944 | __startTimestamp1500424459531__endTimestamp 17:34:19 INFO - PID 28944 | 17:34:19 INFO - PID 28944 | ------- Summary: start ------- 17:34:19 INFO - PID 28944 | Number of tests: 6 17:34:19 INFO - PID 28944 | 17:34:19 INFO - PID 28944 | [#0] dojo.html Cycles:165 Average:6059.79 Median:6319.99 stddev:721.17 (11.4%) stddev-sans-first:684.01 17:34:19 INFO - PID 28944 | Values: 3063.9 3114.5 3118.4 3135.7 3154.8 6011.6 6034.3 6077.3 6083.7 6112.2 6113.9 6156.7 6166.2 6169.0 6181.2 5586.4 5642.4 5644.0 5672.3 5687.6 5644.4 5680.9 5685.5 5690.7 5707.4 5663.6 5672.8 5675.0 5677.3 5707.0 5613.9 5614.7 5675.9 5691.0 5692.0 5521.2 5555.9 5599.9 5610.2 5652.2 6024.2 6047.1 6082.2 6104.7 6128.7 6488.6 6496.9 6603.3 6611.9 6647.6 6558.5 6615.4 6656.7 6668.0 6691.8 6187.4 6206.3 6206.4 6212.6 6292.3 6732.4 6757.1 6778.2 6834.0 6858.3 6405.8 6451.1 6502.1 6506.5 6524.8 6421.6 6573.8 6574.1 6601.5 6603.2 5633.7 6358.1 6476.2 6552.9 6658.3 6580.9 6583.8 6663.9 6669.7 6681.2 5245.6 5326.8 5355.4 5365.0 5374.8 4547.0 4579.3 4585.6 4594.1 4607.5 5695.3 5706.7 5716.1 5717.6 5730.3 6531.4 6568.7 6622.1 6623.5 6631.3 5683.9 5691.4 5698.6 5712.4 5722.1 4996.7 5713.7 5737.3 5756.1 5770.1 6366.0 6397.8 6503.2 6506.2 6518.3 6545.6 6642.8 6682.0 6712.2 6756.6 6312.7 6315.0 6404.2 6420.3 6428.0 5725.1 6457.6 6498.5 6512.3 6523.7 6657.9 6676.4 6688.5 6748.1 6748.1 6356.2 6451.3 6517.6 6537.1 6542.2 6350.1 6423.2 6439.9 6452.8 6512.5 6304.6 6326.2 6358.2 6361.9 6377.4 6320.0 6367.0 6413.6 6487.2 6500.7 6279.7 6291.1 6345.3 6346.9 6377.6 17:34:19 INFO - PID 28944 | 17:34:19 INFO - PID 28944 | [#1] ext.html Cycles:180 Average:36586.07 Median:33835.25 stddev:53393.54 (157.8%) stddev-sans-first:53475.47 17:34:19 INFO - PID 28944 | Values: 737.3 752.2 794.3 817.6 825.2 39902.2 40200.8 40380.8 40385.0 40392.8 36492.6 37022.8 37125.0 37148.3 37183.6 6807.8 6924.1 6953.0 6958.9 6960.2 6867.1 6923.9 6958.8 6962.3 6968.6 6820.9 6849.3 6891.1 6904.1 6945.8 6866.7 6908.4 6916.1 6916.9 6920.1 6154.8 6158.5 6207.9 6215.1 6215.6 33583.3 33775.7 33817.5 33853.0 34068.8 3342.9 3394.6 3399.3 3406.6 3428.1 26829.0 26891.2 26901.2 26924.5 26962.3 4294.8 4295.0 4300.1 4316.9 4367.4 184876.0 190451.0 190470.0 191228.0 191665.0 46844.8 47404.8 47569.5 47656.5 47783.3 49136.0 49321.3 49340.8 49693.5 49725.8 15805.4 15916.9 15924.8 15967.3 16010.5 13333.5 13637.9 13686.4 13727.6 13757.8 14216.7 14292.0 14329.3 14400.4 14544.9 5488.5 5654.7 5665.3 5786.7 5792.9 960.1 970.0 989.7 1013.1 1015.4 22470.0 22610.3 22785.2 23023.2 28519.0 1091.6 1098.7 1100.7 1107.4 1111.2 12200.1 12285.3 12330.8 12351.3 12403.7 235554.0 236981.0 237682.0 237706.0 239111.0 49433.3 49744.8 50045.7 50220.0 50690.7 1420.7 1474.3 1480.1 1487.1 1502.1 21867.9 21947.6 22389.1 22717.0 22903.0 35914.8 36121.8 36127.8 36182.3 36255.3 139676.0 192968.0 196227.0 196914.0 197193.0 29302.4 29938.1 31444.0 31849.2 33360.2 40249.0 41957.2 42025.8 42448.0 42792.6 29691.4 31713.4 32212.7 33199.2 33808.2 32612.5 32726.3 33212.3 33391.5 33549.2 35128.3 36305.3 36331.8 36363.1 36507.6 31705.5 32252.5 32527.8 32532.3 32785.8 22847.3 23320.1 23772.9 23783.4 23877.0 17:34:19 INFO - PID 28944 | 17:34:19 INFO - PID 28944 | [#2] jquery.html Cycles:180 Average:35253.65 Median:23198.21 stddev:84356.83 (363.6%) stddev-sans-first:84553.28 17:34:19 INFO - PID 28944 | Values: 571.6 574.4 580.7 587.8 590.4 21649.0 22395.0 22417.4 22673.9 22759.3 23593.4 24646.4 26057.3 26073.7 26195.2 6334.2 6488.0 6489.6 6491.4 6497.1 6412.5 6447.7 6456.8 6464.7 6529.5 5783.2 6197.3 6399.6 6448.1 6480.5 6261.6 6276.9 6292.4 6359.1 6396.9 5871.6 5877.9 5878.5 5886.9 5898.3 28718.3 29130.0 29447.3 29485.7 29536.4 1940.9 1961.6 1964.7 1969.2 1981.5 18157.3 18816.8 18913.8 18975.8 19034.0 2341.4 2358.1 2395.6 2405.5 2406.4 135500.0 143088.3 143507.0 143691.3 143868.0 13990.3 14455.9 14654.6 14740.2 14746.8 23190.7 23205.8 23224.8 23293.8 23401.6 10337.5 10370.3 10540.3 10661.9 10697.2 9739.5 9784.5 9789.0 9969.2 10112.9 8772.9 9021.5 9054.7 9097.1 9358.3 2568.1 2642.0 2665.6 2701.5 2789.8 937.7 944.4 947.4 977.7 996.2 19546.5 19804.1 20467.3 23127.7 25595.2 1044.7 1066.6 1069.1 1070.3 1075.5 11398.8 11607.9 11682.3 11698.2 11700.8 478169.0 498524.0 507770.0 508570.0 509592.0 116309.0 117192.0 119221.0 119846.0 120989.4 1258.1 1268.7 1283.8 1290.9 1292.2 17431.9 18393.9 18551.0 18861.5 19053.4 52947.7 53111.7 54190.0 54901.0 56105.0 67457.3 67605.7 68407.7 68547.3 68849.7 14137.8 14612.6 15039.3 15112.1 15277.0 23904.3 23907.6 24403.5 24453.0 24833.0 18876.2 19124.8 19190.9 19227.0 19336.7 15886.4 16834.4 16946.3 17255.3 17722.5 18972.5 19151.7 19722.9 19753.2 19854.0 14792.6 14898.7 14933.9 14970.3 14985.1 18064.9 18918.8 18970.9 19129.6 19250.0 17:34:19 INFO - PID 28944 | 17:34:19 INFO - PID 28944 | [#3] mootools.html Cycles:180 Average:8603.35 Median:2498.64 stddev:5922.72 (237.0%) stddev-sans-first:5914.09 17:34:19 INFO - PID 28944 | Values: 1324.3 1372.6 1407.0 1407.1 1414.6 13301.5 13989.4 14109.1 14133.8 14178.4 13455.1 13944.2 14507.7 14509.3 14549.6 2521.9 2580.9 2581.7 2584.6 2589.0 2525.8 2564.4 2569.7 2572.3 2576.1 2494.1 2503.2 2508.4 2528.4 2553.4 2618.3 2639.6 2642.8 2648.5 2649.3 2425.5 2431.0 2444.9 2451.6 2477.8 13934.9 14047.4 14059.9 14075.9 14079.9 7211.3 7570.1 7573.9 7587.6 7594.7 4592.2 4898.9 4951.2 5007.7 5022.5 1801.5 1840.3 1841.3 1902.7 1919.1 22590.5 22850.2 22873.9 22963.9 23063.4 6059.1 6093.4 6163.3 6206.5 6325.8 15091.8 15147.6 15159.2 15271.6 15273.4 7179.2 7296.1 7313.7 7314.6 7328.5 6732.1 6759.8 6793.8 6801.8 6900.5 4701.5 4734.8 4783.9 4897.8 4981.1 1374.1 1376.2 1381.5 1404.7 1409.7 862.1 882.5 896.7 913.5 923.6 7056.5 7205.7 7286.1 7299.2 7317.6 684.9 713.3 980.4 998.8 1023.7 4699.2 4924.6 5271.8 5340.2 5343.6 18691.8 19530.2 19563.8 19580.2 19656.7 17267.6 18919.4 19215.1 19302.8 19690.0 10472.7 10666.4 10932.6 11020.0 11207.5 7613.6 8276.6 8437.2 8511.9 8610.5 16497.4 16750.2 16944.5 17272.1 17331.7 15890.2 17300.7 17763.0 17920.2 17932.6 10988.5 11096.6 11125.8 11143.1 11216.9 12978.2 12983.3 13006.9 13065.2 13083.9 10052.6 10165.8 10410.0 10645.5 10758.0 9982.4 10395.8 10625.3 10805.3 10851.9 9131.9 9162.3 9193.3 9220.7 9292.8 6620.4 7063.3 7215.5 7348.7 7387.6 7206.3 7288.7 7395.8 7446.0 7456.1 17:34:19 INFO - PID 28944 | 17:34:19 INFO - PID 28944 | [#4] prototype.html Cycles:180 Average:5357.34 Median:5870.12 stddev:1514.23 (25.8%) stddev-sans-first:1473.45 17:34:19 INFO - PID 28944 | Values: 474.4 476.5 504.1 506.2 513.3 6019.2 6025.7 6041.9 6118.7 6126.9 5719.8 5880.6 5893.4 5923.9 5960.7 4742.4 4837.6 4843.4 4869.7 4870.4 4782.3 4793.6 4804.2 4813.0 4865.7 4739.7 4792.9 4817.5 4852.0 4864.1 4683.8 4771.8 4776.7 4784.3 4809.6 4280.7 4325.5 4330.6 4331.0 4363.7 5822.3 5850.8 5853.1 5877.6 5926.7 5526.3 5543.9 5550.1 5563.2 5579.0 6320.0 6320.4 6369.6 6387.9 6424.3 4728.8 4760.0 4763.3 4796.2 4821.9 6684.2 6732.8 6749.6 6768.6 6796.9 4881.0 4891.4 4900.1 4914.0 4930.7 4856.8 4913.1 4949.3 4978.5 5004.8 5396.2 5405.4 5416.3 5431.3 5448.7 6243.5 6309.3 6313.2 6393.0 6396.9 1680.8 1683.5 1686.0 1689.9 1709.1 1102.0 1171.0 1185.9 1199.2 1201.9 5437.6 5498.8 5639.5 5652.0 5692.5 6489.4 6529.2 6543.7 6558.5 6615.3 5600.7 5623.2 5659.2 5666.7 5685.8 3417.4 3460.8 3466.3 3496.9 3554.0 6384.9 6416.4 6433.6 6441.5 6458.3 6773.5 6776.9 6787.3 6794.4 6796.6 6401.5 6401.9 6409.5 6421.9 6447.2 6580.8 6603.8 6605.8 6613.1 6671.8 6420.9 6449.3 6538.9 6584.4 6604.4 6284.2 6360.8 6377.2 6416.6 6425.5 4768.0 4798.5 4802.1 4813.3 4844.9 6511.7 6538.8 6573.9 6583.3 6606.7 6244.8 6247.5 6317.0 6325.9 6326.8 6277.0 6340.4 6397.2 6450.0 6481.9 6220.8 6291.9 6313.7 6337.8 6383.6 6352.4 6384.5 6403.8 6447.5 6484.7 5784.4 5862.7 5890.8 6085.0 6125.5 17:34:19 INFO - PID 28944 | 17:34:19 INFO - PID 28944 | [#5] yui.html Cycles:180 Average:22865.57 Median:19868.60 stddev:30951.76 (155.8%) stddev-sans-first:30994.61 17:34:19 INFO - PID 28944 | Values: 890.8 895.5 904.5 909.8 911.1 16240.5 16275.4 16312.1 16413.5 17340.4 18151.6 19013.5 19512.1 19624.9 19884.9 1029.1 1043.1 1045.1 1054.2 1063.7 1021.8 1034.1 1034.7 1034.8 1046.2 1047.9 1092.9 1114.4 1127.2 1128.8 1092.0 1093.0 1095.7 1097.4 1097.7 797.1 797.4 798.2 800.1 800.4 18404.4 18649.8 19439.4 19694.5 19910.8 20174.6 20359.9 20822.2 20916.0 20941.6 16118.8 16338.9 16465.8 16541.3 16573.7 3594.2 3650.0 3677.3 3684.9 3687.0 124592.4 127391.0 130531.3 130821.0 131151.0 15222.9 16093.6 16203.2 16441.1 16449.2 29516.6 29581.0 29959.0 29960.5 29966.0 8383.2 8384.3 8403.6 8421.0 8435.6 3935.6 3983.5 3990.7 4043.0 4061.2 5033.2 5098.1 5131.9 5151.6 5221.6 915.2 926.0 944.0 950.1 952.6 600.9 672.5 695.6 697.5 707.9 11773.6 11974.6 11991.3 12135.8 12351.0 648.8 674.7 680.7 696.9 697.7 5262.1 5405.9 5508.3 5557.9 5666.2 99946.0 99967.0 102868.0 103773.5 104710.0 90798.5 93118.0 95170.5 96145.0 96206.5 74028.0 74358.0 79571.6 80636.0 81265.6 11161.5 11639.8 11663.8 12052.5 12089.6 34249.3 36585.3 36992.4 37724.2 37875.4 61611.0 62714.0 66200.0 67226.7 67304.7 18272.0 18865.5 18880.1 18887.2 18962.5 20201.3 20525.5 20734.5 21207.1 21945.8 16280.8 16369.5 16454.7 19002.2 19042.9 18578.8 18688.2 19188.9 19743.2 19852.3 18704.0 18878.0 19484.8 19798.4 19832.1 11910.8 11937.3 11938.5 12944.9 14232.6 12785.4 13070.5 13156.7 13393.7 13440.4 17:34:19 INFO - PID 28944 | -------- Summary: end -------- 17:34:19 INFO - PID 28944 | 17:34:20 INFO - TEST-INFO | 28944: exit 0 17:34:20 INFO - TEST-OK | dromaeo_css | took 1110625ms 17:34:20 INFO - TEST-START | kraken 17:34:20 INFO - Initialising browser for kraken test... 17:34:20 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42945/getInfo.html -profile /tmp/tmpVDJ9FJ/profile 17:34:20 INFO - TEST-INFO | started process 29358 (/builds/slave/test/build/application/firefox/firefox http://localhost:42945/getInfo.html) 17:34:26 INFO - TEST-INFO | 29358: exit 0 17:34:26 INFO - Browser initialized. 17:34:26 INFO - Running cycle 1/1 for kraken test... 17:34:26 INFO - TEST-INFO | started process 29627 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVDJ9FJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 17:34:37 INFO - PID 29627 | RSS: Main: 175824896 17:34:37 INFO - PID 29627 | 17:34:40 INFO - PID 29627 | Cycle 1(1): loaded http://localhost:42945/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42945/tests/kraken/driver.html?testName=audio-beat-detection) 17:34:41 INFO - PID 29627 | RSS: Main: 179589120 17:34:41 INFO - PID 29627 | 17:34:43 INFO - PID 29627 | Cycle 1(1): loaded http://localhost:42945/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42945/tests/kraken/driver.html?testName=audio-dft) 17:34:44 INFO - PID 29627 | RSS: Main: 180670464 17:34:44 INFO - PID 29627 | 17:34:47 INFO - PID 29627 | Cycle 1(1): loaded http://localhost:42945/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42945/tests/kraken/driver.html?testName=audio-fft) 17:34:48 INFO - PID 29627 | RSS: Main: 174247936 17:34:48 INFO - PID 29627 | 17:34:50 INFO - PID 29627 | Cycle 1(1): loaded http://localhost:42945/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42945/tests/kraken/driver.html?testName=audio-oscillator) 17:34:50 INFO - PID 29627 | RSS: Main: 175337472 17:34:50 INFO - PID 29627 | 17:34:52 INFO - PID 29627 | Cycle 1(1): loaded http://localhost:42945/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42945/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:34:53 INFO - PID 29627 | RSS: Main: 175267840 17:34:53 INFO - PID 29627 | 17:34:56 INFO - PID 29627 | Cycle 1(1): loaded http://localhost:42945/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42945/tests/kraken/driver.html?testName=imaging-darkroom) 17:34:57 INFO - PID 29627 | RSS: Main: 178503680 17:34:57 INFO - PID 29627 | 17:35:00 INFO - PID 29627 | Cycle 1(1): loaded http://localhost:42945/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42945/tests/kraken/driver.html?testName=imaging-desaturate) 17:35:01 INFO - PID 29627 | RSS: Main: 179605504 17:35:01 INFO - PID 29627 | 17:35:04 INFO - PID 29627 | Cycle 1(1): loaded http://localhost:42945/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42945/tests/kraken/driver.html?testName=json-parse-financial) 17:35:04 INFO - PID 29627 | RSS: Main: 178593792 17:35:04 INFO - PID 29627 | 17:35:06 INFO - PID 29627 | Cycle 1(1): loaded http://localhost:42945/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42945/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:35:06 INFO - PID 29627 | RSS: Main: 178352128 17:35:06 INFO - PID 29627 | 17:35:08 INFO - PID 29627 | Cycle 1(1): loaded http://localhost:42945/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42945/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:35:09 INFO - PID 29627 | RSS: Main: 178388992 17:35:09 INFO - PID 29627 | 17:35:11 INFO - PID 29627 | Cycle 1(1): loaded http://localhost:42945/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42945/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:35:11 INFO - PID 29627 | RSS: Main: 178335744 17:35:11 INFO - PID 29627 | 17:35:14 INFO - PID 29627 | Cycle 1(1): loaded http://localhost:42945/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42945/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:35:15 INFO - PID 29627 | RSS: Main: 178163712 17:35:15 INFO - PID 29627 | 17:35:18 INFO - PID 29627 | Cycle 1(1): loaded http://localhost:42945/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42945/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:35:19 INFO - PID 29627 | RSS: Main: 178765824 17:35:19 INFO - PID 29627 | 17:35:20 INFO - PID 29627 | Cycle 1(1): loaded http://localhost:42945/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42945/tests/kraken/driver.html?testName=ai-astar) 17:35:21 INFO - PID 29627 | RSS: Main: 180031488 17:35:21 INFO - PID 29627 | 17:35:21 INFO - PID 29627 | __start_tp_report 17:35:21 INFO - PID 29627 | _x_x_mozilla_page_load 17:35:21 INFO - PID 29627 | _x_x_mozilla_page_load_details 17:35:21 INFO - PID 29627 | |i|pagename|runs| 17:35:21 INFO - PID 29627 | |0;ai-astar;100;109;105;110;107;108;110;100;109;109 17:35:21 INFO - PID 29627 | |1;audio-beat-detection;152;120;149;177;124;152;155;125;170;123 17:35:21 INFO - PID 29627 | |2;audio-dft;165;163;163;165;163;165;161;166;181;171 17:35:21 INFO - PID 29627 | |3;audio-fft;77;76;75;200;77;76;74;76;153;76 17:35:21 INFO - PID 29627 | |4;audio-oscillator;82;82;130;82;82;81;140;81;82;126 17:35:21 INFO - PID 29627 | |5;imaging-gaussian-blur;115;114;114;114;114;114;115;115;113;114 17:35:21 INFO - PID 29627 | |6;imaging-darkroom;152;152;150;149;151;151;150;150;150;150 17:35:21 INFO - PID 29627 | |7;imaging-desaturate;94;95;95;96;95;95;95;94;94;95 17:35:21 INFO - PID 29627 | |8;json-parse-financial;57;57;60;57;56;58;60;56;57;58 17:35:21 INFO - PID 29627 | |9;json-stringify-tinderbox;55;55;55;54;54;55;56;56;54;55 17:35:21 INFO - PID 29627 | |10;stanford-crypto-aes;79;87;79;78;78;78;77;78;78;80 17:35:21 INFO - PID 29627 | |11;stanford-crypto-ccm;129;130;136;152;135;127;128;135;133;173 17:35:21 INFO - PID 29627 | |12;stanford-crypto-pbkdf2;178;182;191;186;184;185;179;193;182;187 17:35:21 INFO - PID 29627 | |13;stanford-crypto-sha256-iterative;67;69;71;69;69;69;70;77;71;73 17:35:21 INFO - PID 29627 | __end_tp_report 17:35:21 INFO - PID 29627 | __start_cc_report 17:35:21 INFO - PID 29627 | _x_x_mozilla_cycle_collect,954 17:35:21 INFO - PID 29627 | __end_cc_report 17:35:21 INFO - PID 29627 | __startTimestamp1500424521094__endTimestamp 17:35:21 INFO - PID 29627 | 17:35:21 INFO - PID 29627 | ------- Summary: start ------- 17:35:21 INFO - PID 29627 | Number of tests: 14 17:35:21 INFO - PID 29627 | 17:35:21 INFO - PID 29627 | [#0] ai-astar Cycles:10 Average:106.70 Median:109.00 stddev:3.83 (3.5%) stddev-sans-first:3.21 17:35:21 INFO - PID 29627 | Values: 100.0 109.0 105.0 110.0 107.0 108.0 110.0 100.0 109.0 109.0 17:35:21 INFO - PID 29627 | 17:35:21 INFO - PID 29627 | [#1] audio-beat-detection Cycles:10 Average:144.70 Median:152.00 stddev:20.58 (13.5%) stddev-sans-first:21.66 17:35:21 INFO - PID 29627 | Values: 152.0 120.0 149.0 177.0 124.0 152.0 155.0 125.0 170.0 123.0 17:35:21 INFO - PID 29627 | 17:35:21 INFO - PID 29627 | [#2] audio-dft Cycles:10 Average:166.30 Median:165.00 stddev:5.81 (3.5%) stddev-sans-first:6.15 17:35:21 INFO - PID 29627 | Values: 165.0 163.0 163.0 165.0 163.0 165.0 161.0 166.0 181.0 171.0 17:35:21 INFO - PID 29627 | 17:35:21 INFO - PID 29627 | [#3] audio-fft Cycles:10 Average:96.00 Median:76.00 stddev:43.86 (57.7%) stddev-sans-first:45.98 17:35:21 INFO - PID 29627 | Values: 77.0 76.0 75.0 200.0 77.0 76.0 74.0 76.0 153.0 76.0 17:35:21 INFO - PID 29627 | 17:35:21 INFO - PID 29627 | [#4] audio-oscillator Cycles:10 Average:96.80 Median:82.00 stddev:24.53 (29.9%) stddev-sans-first:25.43 17:35:21 INFO - PID 29627 | Values: 82.0 82.0 130.0 82.0 82.0 81.0 140.0 81.0 82.0 126.0 17:35:21 INFO - PID 29627 | 17:35:21 INFO - PID 29627 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.63 (0.6%) stddev-sans-first:0.60 17:35:21 INFO - PID 29627 | Values: 115.0 114.0 114.0 114.0 114.0 114.0 115.0 115.0 113.0 114.0 17:35:21 INFO - PID 29627 | 17:35:21 INFO - PID 29627 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:150.50 stddev:0.97 (0.6%) stddev-sans-first:0.87 17:35:21 INFO - PID 29627 | Values: 152.0 152.0 150.0 149.0 151.0 151.0 150.0 150.0 150.0 150.0 17:35:21 INFO - PID 29627 | 17:35:21 INFO - PID 29627 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 17:35:21 INFO - PID 29627 | Values: 94.0 95.0 95.0 96.0 95.0 95.0 95.0 94.0 94.0 95.0 17:35:21 INFO - PID 29627 | 17:35:21 INFO - PID 29627 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:57.50 stddev:1.43 (2.5%) stddev-sans-first:1.50 17:35:21 INFO - PID 29627 | Values: 57.0 57.0 60.0 57.0 56.0 58.0 60.0 56.0 57.0 58.0 17:35:21 INFO - PID 29627 | 17:35:21 INFO - PID 29627 | [#9] json-stringify-tinderbox Cycles:10 Average:54.90 Median:55.00 stddev:0.74 (1.3%) stddev-sans-first:0.78 17:35:21 INFO - PID 29627 | Values: 55.0 55.0 55.0 54.0 54.0 55.0 56.0 56.0 54.0 55.0 17:35:21 INFO - PID 29627 | 17:35:21 INFO - PID 29627 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:78.50 stddev:2.86 (3.6%) stddev-sans-first:3.03 17:35:21 INFO - PID 29627 | Values: 79.0 87.0 79.0 78.0 78.0 78.0 77.0 78.0 78.0 80.0 17:35:21 INFO - PID 29627 | 17:35:21 INFO - PID 29627 | [#11] stanford-crypto-ccm Cycles:10 Average:137.80 Median:135.00 stddev:14.27 (10.6%) stddev-sans-first:14.78 17:35:21 INFO - PID 29627 | Values: 129.0 130.0 136.0 152.0 135.0 127.0 128.0 135.0 133.0 173.0 17:35:21 INFO - PID 29627 | 17:35:21 INFO - PID 29627 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.70 Median:185.50 stddev:4.81 (2.6%) stddev-sans-first:4.45 17:35:21 INFO - PID 29627 | Values: 178.0 182.0 191.0 186.0 184.0 185.0 179.0 193.0 182.0 187.0 17:35:21 INFO - PID 29627 | 17:35:21 INFO - PID 29627 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:70.50 stddev:2.80 (4.0%) stddev-sans-first:2.67 17:35:21 INFO - PID 29627 | Values: 67.0 69.0 71.0 69.0 69.0 69.0 70.0 77.0 71.0 73.0 17:35:21 INFO - PID 29627 | -------- Summary: end -------- 17:35:21 INFO - PID 29627 | 17:35:21 INFO - PID 29627 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 17:35:21 INFO - TEST-INFO | 29627: exit 0 17:35:21 INFO - TEST-OK | kraken | took 61631ms 17:35:21 INFO - SUITE-END | took 1172s 17:35:22 INFO - Completed test suite (00:19:32) 17:35:22 INFO - javascript benchmark 17:35:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8299.093081548448, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3063.877444902204, 3114.454970380183, 3118.36073604911, 3135.717785399315, 3154.8264845433505, 6011.609245399051, 6034.336223015464, 6077.301110372308, 6083.665398403086, 6112.205413296271, 6113.938860611393, 6156.6613836238985, 6166.167567378403, 6169.0, 6181.1964444622245, 5586.35756887957, 5642.351129620085, 5644.0, 5672.347680016789, 5687.60186786923, 5644.407337229593, 5680.857978550528, 5685.545156387479, 5690.658560486363, 5707.400722924095, 5663.631863928852, 5672.773089076432, 5675.0, 5677.261955945742, 5706.971465142668, 5613.859653508654, 5614.719264036782, 5675.914861277105, 5690.971545142248, 5691.971540142294, 5521.2270282160525, 5555.8888822223325, 5599.888002239933, 5610.24261724666, 5652.152177173416, 6024.1566180734735, 6047.0627052806885, 6082.178905847698, 6104.725287362079, 6128.724207410677, 6488.643124628144, 6496.870062598721, 6603.273639899608, 6611.86776264472, 6647.6343801090925, 6558.540902136852, 6615.4046135848, 6656.733730650768, 6667.966660166717, 6691.799246022579, 6187.443130118266, 6206.25524937006, 6206.379362063757, 6212.596181248205, 6292.276388215368, 6732.394084532416, 6757.087793147911, 6778.22050464193, 6834.0, 6858.3141685831015, 6405.807825765234, 6451.096846441502, 6502.122213501117, 6506.544541882117, 6524.804255872236, 6421.550491465552, 6573.769918052845, 6574.112494813235, 6601.504887133484, 6603.20761508622, 5633.718314084362, 6358.109864618957, 6476.190476190476, 6552.934470655233, 6658.300878407795, 6580.934190658128, 6583.7695680651905, 6663.86672266552, 6669.733210671616, 6681.198256209189, 5245.554127899171, 5326.840194794162, 5355.3841308249275, 5365.034293827149, 5374.811881584125, 4546.977265113654, 4579.290210017452, 4585.610223131004, 4594.104149690845, 4607.493175750665, 5695.345035320991, 5706.657600543981, 5716.056850619684, 5717.571182161355, 5730.255066841367, 6531.444827189647, 6568.737250510022, 6622.106015687917, 6623.536352455379, 6631.30371311015, 5683.886322273532, 5691.430856914276, 5698.572607054488, 5712.371639119693, 5722.084466485342, 4996.725180115129, 5713.657180569179, 5737.254156959652, 5756.050251708505, 5770.105633626795, 6366.0, 6397.776077837253, 6503.219613646393, 6506.1541999540705, 6518.315576864456, 6545.639989800607, 6642.83392915181, 6681.966590167018, 6712.194536655437, 6756.628385438848, 6312.747490100344, 6315.0, 6404.1674582304, 6420.2937676856445, 6427.971524556048, 5725.074851418073, 6457.580257283262, 6498.512611554247, 6512.283648798723, 6523.739050437929, 6657.900131497934, 6676.432503237279, 6688.464922806066, 6748.089007983859, 6748.122744043243, 6356.173697419306, 6451.2903580607035, 6517.576357536745, 6537.0521274413995, 6542.182227221598, 6350.079238510298, 6423.197100362455, 6439.903401449075, 6452.774152904626, 6512.54412191161, 6304.621722696653, 6326.2092238470195, 6358.205224346957, 6361.904571431525, 6377.394147555975, 6319.988801791691, 6367.044943258548, 6413.615183089029, 6487.18910136233, 6500.739970401131, 6279.744051189689, 6291.087792270187, 6345.302016778243, 6346.90479642815, 6377.585456945284], "value": 6006.270154478563, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.3290305821703, 752.2327226229249, 794.3367288314257, 817.6402382951501, 825.1748251748252, 39902.20195596086, 40200.798996005055, 40380.79809600955, 40384.990375240595, 40392.798036009815, 36492.63507364925, 37022.81488592553, 37125.0, 37148.257034859285, 37183.62816371836, 6807.761728339509, 6924.134483189601, 6953.0, 6958.8956165657555, 6960.164780226354, 6867.141607299088, 6923.861522769566, 6958.756443524478, 6962.268961758993, 6968.616726080064, 6820.931790682104, 6849.349311815369, 6891.138607674041, 6904.102466679325, 6945.791626251221, 6866.725330986755, 6908.447324214051, 6916.066331045295, 6916.896246556305, 6920.100386949714, 6154.815355539296, 6158.507319414481, 6207.937920620781, 6215.067739839015, 6215.627062376272, 33583.32833343319, 33775.6622433775, 33817.49273760871, 33853.0, 34068.82965585181, 3342.8829990950444, 3394.6435624259343, 3399.3201359727905, 3406.574178227697, 3428.0572842468273, 26829.0, 26891.193264202106, 26901.192964211106, 26924.461510769674, 26962.32594185161, 4294.79402263729, 4294.978525107385, 4300.075483770973, 4316.892077698051, 4367.432233809616, 184876.0, 190450.9999999986, 190470.0, 191228.0, 191665.0, 46844.76577617158, 47404.762976184895, 47569.5243047572, 47656.5234347659, 47783.283250751265, 49136.0, 49321.260181097314, 49340.753296234005, 49693.50306496961, 49725.751371243634, 15805.446809361618, 15916.920415397848, 15924.76112858308, 15967.281472333541, 16010.519684409486, 13333.466661333632, 13637.863621363858, 13686.384112714952, 13727.588172354845, 13757.79363309551, 14216.715665686628, 14292.0, 14329.283535823168, 14400.351984160738, 14544.927275363556, 5488.463230295523, 5654.717264136777, 5665.3201615806365, 5786.71066446676, 5792.913106303409, 960.0702587798436, 970.0498347066605, 989.7426669066094, 1013.1287093099928, 1015.4465816130227, 22470.0, 22610.321690349316, 22785.20251791179, 23023.194188203666, 28519.0, 1091.6397588795837, 1098.7363032872054, 1100.708312297242, 1107.4186052322434, 1111.1721767283425, 12200.145989780807, 12285.262884226975, 12330.753384932252, 12351.25892446456, 12403.689907752198, 235554.0, 236981.0, 237682.0, 237706.0, 239111.0, 49433.25850112251, 49744.75127624339, 50045.74977125164, 50220.0, 50690.74654626777, 1420.7229590229806, 1474.2849717887032, 1480.1267252321181, 1487.0780116327946, 1502.0912348029503, 21867.924341747825, 21947.561048778614, 22389.104435822384, 22717.0, 22903.0, 35914.820425897706, 36121.81939090288, 36127.81936090303, 36182.27635447329, 36255.27489450249, 139676.0, 192968.0, 196227.0, 196914.0, 197193.0, 29302.41395172127, 29938.101856944326, 31444.0, 31849.203769905936, 33360.1659958503, 40249.0, 41957.1608567833, 42025.78987105045, 42448.0, 42792.57207427886, 29691.40617187601, 31713.365732685677, 32212.677873221906, 33199.170020749676, 33808.15479613029, 32612.510812338307, 32726.34547309088, 33212.33575328528, 33391.49912751262, 33549.161270967445, 35128.29743405066, 36305.27389452144, 36331.818340908125, 36363.09092272714, 36507.634923650425, 31705.5244171333, 32252.516212257306, 32527.837360813046, 32532.349353012334, 32785.836070819496, 22847.314580562608, 23320.067197311917, 23772.930218139878, 23783.405414864766, 23877.0], "value": 16411.17852254926, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.6141604417018, 574.362457671984, 580.7096451774112, 587.7678317064757, 590.3683059126733, 21649.0, 22395.0, 22417.439564010907, 22673.886630566845, 22759.31722048337, 23593.41016474589, 24646.383840404, 26057.348566285804, 26073.65337119659, 26195.214143575675, 6334.176557047577, 6488.0, 6489.578177418476, 6491.448226900719, 6497.090407342976, 6412.519061070415, 6447.677616119198, 6456.838579035515, 6464.676766161697, 6529.5429319947625, 5783.190353350535, 6197.349278325779, 6399.648019358933, 6448.12950251717, 6480.4815614750705, 6261.624302541816, 6276.905846412307, 6292.370762923671, 6359.077933699611, 6396.936030639704, 5871.588988770788, 5877.882442351171, 5878.5297176225795, 5886.941130588682, 5898.292204935436, 28718.282042948886, 29130.0, 29447.263818404495, 29485.705142948726, 29536.409271814657, 1940.9029548522658, 1961.568454939911, 1964.734760807287, 1969.1532640964379, 1981.4749091490767, 18157.273709051624, 18816.81183188178, 18913.810861891343, 18975.810241897543, 19034.0, 2341.3561270650707, 2358.13927916311, 2395.6286775549816, 2405.518896220763, 2406.446517301013, 135500.0, 143088.28455857758, 143507.0, 143691.28154359266, 143868.0, 13990.30048497571, 14455.855441445661, 14654.56036318912, 14740.189289589176, 14746.778798318033, 23190.65214021791, 23205.767942320697, 23224.767752322598, 23293.76706232916, 23401.648975265383, 10337.534810933375, 10370.27408081427, 10540.262181647364, 10661.946690266499, 10697.197710171768, 9739.513024348897, 9784.510774461249, 9788.951055244679, 9969.152622027064, 10112.949435252776, 8772.91227087721, 9021.548922553977, 9054.683086091954, 9097.13577210164, 9358.251339892793, 2568.0754928225824, 2642.0, 2665.6134860445127, 2701.4597080583567, 2789.7768178545666, 937.704623043739, 944.3719926248967, 947.4457442396138, 977.726236653738, 996.1681995533665, 19546.511337216398, 19804.108815103355, 20467.28364507235, 23127.653085203736, 25595.232143035737, 1044.6657069737612, 1066.648006157966, 1069.1340014588209, 1070.3195982307857, 1075.499892549968, 11398.772024559463, 11607.883921160681, 11682.299062056303, 11698.239614425205, 11700.765984680258, 478169.0, 498524.0, 507770.0, 508570.0, 509592.0, 116309.0, 117192.0, 119220.99999999827, 119846.0, 120989.39505302593, 1258.0816004316716, 1268.657462485124, 1283.756086343573, 1290.9225446473242, 1292.1730092740654, 17431.866928650106, 18393.908030459763, 18551.0, 18861.528461788566, 19053.42839714811, 52947.73526132345, 53111.73444132755, 54190.0, 54901.0, 56105.0, 67457.3254267451, 67605.66197168983, 68407.65796170988, 68547.3145268541, 68849.65575172091, 14137.787933180805, 14612.561623150898, 15039.323230454436, 15112.09327440357, 15277.0, 23904.282871513882, 23907.641385379582, 24403.511929761662, 24453.0, 24833.0, 18876.150573223964, 19124.808751912304, 19190.904045479685, 19227.0, 19336.70994935049, 15886.364545418053, 16834.410795622094, 16946.322147113977, 17255.309787608858, 17722.46832595024, 18972.525686857385, 19151.712724309426, 19722.90138549298, 19753.209871605548, 19854.0, 14792.556223313319, 14898.702025959203, 14933.850661493681, 14970.326335315154, 14985.100893946397, 18064.909675451538, 18918.810811891704, 18970.905145474186, 19129.617407652047, 19250.0], "value": 12062.716861487716, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1324.3047400114942, 1372.6499742565645, 1406.964825879353, 1407.0783636717954, 1414.632195629136, 13301.534446294381, 13989.370478328474, 14109.082909610881, 14133.78799318011, 14178.361973711182, 13455.125416847897, 13944.233067181302, 14507.709845803078, 14509.347079381427, 14549.636259093528, 2521.924342269735, 2580.8838602262945, 2581.6772903387077, 2584.5735453650127, 2589.0, 2525.8105642076825, 2564.384547708555, 2569.6530968319316, 2572.2669039323796, 2576.0726138590094, 2494.0896572751, 2503.198976327576, 2508.3603681061395, 2528.4311030018284, 2553.438243586408, 2618.3454136465884, 2639.5908634161638, 2642.8150029497942, 2648.523265812153, 2649.31117909344, 2425.527022230666, 2430.9513809723708, 2444.863138640541, 2451.570975079354, 2477.801775857945, 13934.86065139356, 14047.367868445843, 14059.929700351535, 14075.859241407557, 14079.85920140806, 7211.278872112799, 7570.129435114977, 7573.886391704129, 7587.620618969029, 7594.734184303523, 4592.150452166326, 4898.877528061791, 4951.232558953368, 5007.699538027694, 5022.4977502249485, 1801.5135913303466, 1840.2638944422204, 1841.3371186372894, 1902.7431296774896, 1919.1172060852025, 22590.548189036126, 22850.200242991414, 22873.885630572073, 22963.885180574158, 23063.423414414607, 6059.121917089347, 6093.421124993119, 6163.291221509584, 6206.534509911775, 6325.841853953688, 15091.773623395658, 15147.621309467351, 15159.24203789806, 15271.618209544627, 15273.396293389256, 7179.210286868441, 7296.124465064227, 7313.744018959417, 7314.561126332437, 7328.487005909536, 6732.091167692299, 6759.797206083826, 6793.830154246085, 6801.795946121624, 6900.482463815234, 4701.459332176843, 4734.834280800155, 4783.8757891895375, 4897.804087836446, 4981.053599816023, 1374.086232655293, 1376.1536654957329, 1381.4681347681014, 1404.7190561887664, 1409.7462456757883, 862.1206369503071, 882.5234373438271, 896.7489103051156, 913.488446469979, 923.6305477808796, 7056.470764692566, 7205.747798827016, 7286.089238845145, 7299.160596531361, 7317.597532135677, 684.8596037812237, 713.2724620886667, 980.3578655980344, 998.770282834952, 1023.65195833417, 4699.154152252559, 4924.556789888856, 5271.78912843482, 5340.225667278223, 5343.625946183807, 18691.81308186928, 19530.218791248477, 19563.804361956198, 19580.21679132819, 19656.70514942277, 17267.568310792078, 18919.43241702751, 19215.13531891068, 19302.806971930102, 19690.0, 10472.738181545523, 10666.41334726582, 10932.56269749217, 11020.0, 11207.495662695199, 7613.619319034137, 8276.586170691562, 8437.198466145706, 8511.8723219153, 8610.483370997761, 16497.422590209284, 16750.24623891952, 16944.49166525006, 17272.136393180543, 17331.65336693234, 15890.205489725236, 17300.65398691994, 17763.0, 17920.193591288164, 17932.64134717272, 10988.505517251902, 11096.5561377544, 11125.777484450104, 11143.108551315712, 11216.943915280697, 12978.156419832681, 12983.28591927453, 13006.869931300565, 13065.150765200231, 13083.934580327037, 10052.64815731446, 10165.83092944321, 10410.011048950337, 10645.520951557353, 10758.031777139782, 9982.35114717541, 10395.844062339222, 10625.309354891908, 10805.297655652357, 10851.891481085404, 9131.863022054542, 9162.312826537904, 9193.264538837011, 9220.723378298662, 9292.814143717223, 6620.3710647488415, 7063.293670633101, 7215.530990485601, 7348.706051758084, 7387.593682347522, 7206.315400036988, 7288.67200975968, 7395.8151046224275, 7446.032015837906, 7456.142543607338], "value": 6245.011958452366, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [474.3904083253021, 476.48539577256554, 504.1429569731456, 506.1597747738752, 513.345484507253, 6019.217501724781, 6025.6685882276515, 6041.939580604193, 6118.663473508961, 6126.908096378553, 5719.828405147842, 5880.5883588148845, 5893.38119497453, 5923.942099661735, 5960.7317670704815, 4742.4309082910095, 4837.588804951574, 4843.39457567804, 4869.685185000048, 4870.391201099863, 4782.33047373368, 4793.640476964224, 4804.20730579454, 4812.951870481285, 4865.732384718839, 4739.668223224376, 4792.90414191716, 4817.542333478314, 4852.0, 4864.0515099555605, 4683.765811709401, 4771.761411929389, 4776.689515181502, 4784.306275590037, 4809.591184749301, 4280.72175308604, 4325.4593175853015, 4330.588594083557, 4330.956690433087, 4363.67272454564, 5822.301323841124, 5850.824475265749, 5853.122031695238, 5877.559183061245, 5926.733297001645, 5526.281583394173, 5543.8891222175735, 5550.111982082847, 5563.161418621179, 5578.972105139489, 6319.968400158015, 6320.367963203689, 6369.6496692681885, 6387.936120638827, 6424.293327733945, 4728.763561821929, 4759.952400476021, 4763.333133361332, 4796.2326027835725, 4821.903561928777, 6684.231313398973, 6732.83167920801, 6749.5612785168805, 6768.5600435972, 6796.898046529306, 4880.975595122072, 4891.437484689306, 4900.117978763857, 4914.0, 4930.728809915489, 4856.781444834991, 4913.11563918491, 4949.257611358325, 4978.477259887732, 5004.774785134678, 5396.244525766396, 5405.405405405402, 5416.322959630046, 5431.293931788842, 5448.700321482277, 6243.531735119794, 6309.274433440213, 6313.179286692793, 6393.0, 6396.872062558816, 1680.823513531086, 1683.4764538093045, 1685.9662806743797, 1689.923953422099, 1709.1112621437032, 1101.9724506887392, 1170.9531618735325, 1185.875483074282, 1199.2264989081993, 1201.9158658893793, 5437.564994800407, 5498.762778374914, 5639.464250896158, 5652.0, 5692.544596432275, 6489.383508566679, 6529.151210342625, 6543.672816359163, 6558.491546944229, 6615.272320044791, 5600.719964001783, 5623.184638227434, 5659.179418984224, 5666.668332941756, 5685.772569097273, 3417.4019546579248, 3460.809655468923, 3466.341395134916, 3496.930061398758, 3554.0, 6384.936150638527, 6416.35836416364, 6433.646149461824, 6441.518450756353, 6458.257300410419, 6773.525853190328, 6776.93223067763, 6787.2534021257625, 6794.422474089659, 6796.558223715443, 6401.519886008475, 6401.9039714404325, 6409.455196308273, 6421.903671444838, 6447.161868957006, 6580.802575922538, 6603.8113139635325, 6605.834854128685, 6613.14029176204, 6671.766488172891, 6420.903686444613, 6449.258335291313, 6538.901916471352, 6584.407403333723, 6604.405603495708, 6284.24589049317, 6360.809175724736, 6377.202849643794, 6416.615003099829, 6425.485961123006, 4767.976160119178, 4798.5441383068555, 4802.135615589227, 4813.278008298783, 4844.854654360375, 6511.674416279072, 6538.803835884931, 6573.868522629617, 6583.325838654609, 6606.669666516751, 6244.781432649836, 6247.5001999839, 6316.9887121678985, 6325.905111423424, 6326.841828954313, 6276.968615156895, 6340.365963403623, 6397.185238495047, 6450.0, 6481.902771458337, 6220.782272620437, 6291.937080629318, 6313.6843157841, 6337.7781777637565, 6383.648899310582, 6352.425239876706, 6384.521160912857, 6403.775867844603, 6447.484201263794, 6484.675766211765, 5784.418036594706, 5862.67755273447, 5890.764369425175, 6084.969575152273, 6125.540584456273], "value": 4909.896787944489, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [890.8307421589893, 895.4761464543242, 904.4663648447415, 909.7771046093704, 911.0525053943899, 16240.51278461648, 16275.430359937389, 16312.102834344107, 16413.507594772145, 17340.393086241984, 18151.63696726068, 19013.52466188346, 19512.12195451208, 19624.901875490603, 19884.900575497137, 1029.130384824822, 1043.0768769638848, 1045.1012129568564, 1054.2409465185056, 1063.7393838509538, 1021.8262895307815, 1034.0848349210964, 1034.6533911139777, 1034.7671773850861, 1046.1892033673887, 1047.9476026198697, 1092.8907109289087, 1114.420501339303, 1127.216584473791, 1128.7798879218556, 1092.006274290392, 1093.038126448728, 1095.6986828622114, 1097.3854641400842, 1097.6926460591046, 797.1072398913254, 797.4258533855615, 798.1858504325613, 800.139849661616, 800.4076983032572, 18404.355847545405, 18649.81350186508, 19439.416817495498, 19694.507637309038, 19910.80089199104, 20174.596508069902, 20359.89820050905, 20822.16711331545, 20916.0, 20941.5811683767, 16118.838811611851, 16338.918305408397, 16465.83534164667, 16541.338346466127, 16573.6685266294, 3594.245208506217, 3649.9635003649887, 3677.264547090566, 3684.852605895761, 3686.9631303687156, 124592.37703811514, 127391.0, 130531.34734326362, 130821.0, 131151.0, 15222.923885380724, 16093.597660058593, 16203.189840507928, 16441.09573973443, 16449.177541122895, 29516.557251641243, 29581.0, 29959.0, 29960.50619798691, 29966.0, 8383.16168383169, 8384.287335576422, 8403.579821009047, 8420.957895210608, 8435.620397082146, 3935.626115519021, 3983.50206224222, 3990.74060186087, 4042.969042894043, 4061.248668996245, 5033.19468884984, 5098.133317335987, 5131.923021154686, 5151.5621172200035, 5221.582273418117, 915.199200699388, 926.0, 943.9811203776023, 950.064186776025, 952.5903861339552, 600.8708127752467, 672.525869262169, 695.5548448992648, 697.5117417807454, 707.8938159276149, 11773.646790596125, 11974.6229183645, 11991.280523168638, 12135.817962730565, 12351.047664747375, 648.7859006527834, 674.7469698862926, 680.6630717794724, 696.916370035599, 697.6999890047329, 5262.105442074857, 5405.864853378697, 5508.283923089973, 5557.916631250535, 5666.2350582670815, 99946.0, 99967.0, 102868.0, 103773.48113259385, 104709.95290047154, 90798.54600726954, 93118.0, 95170.52414737882, 96145.0, 96206.51896740471, 74028.0, 74358.0, 79571.60214198891, 80636.0, 81265.59367203126, 11161.49773260189, 11639.76720465603, 11663.833616638269, 12052.457639406422, 12089.62741685325, 34249.31501369909, 36585.268294633424, 36992.445113322785, 37724.24551509009, 37875.431868521446, 61611.0, 62714.0, 66200.0, 67226.66386668035, 67304.6634766823, 18272.0, 18865.528361791065, 18880.05599720036, 18887.244510219985, 18962.52593685169, 20201.292954746514, 20525.486862828548, 20734.481637959172, 21207.10769000112, 21945.780542194374, 16280.755788662942, 16369.508914732578, 16454.670906581563, 19002.239910403983, 19042.904785475985, 18578.814211858247, 18688.159032843825, 19188.904055479634, 19743.21027158955, 19852.305169319003, 18704.0, 18878.0, 19484.805151948865, 19798.40604781859, 19832.107555159764, 11910.821337680116, 11937.28376297425, 11938.52245910154, 12944.870551294744, 14232.573022809333, 12785.424655890321, 13070.477180913038, 13156.736865262832, 13393.732125357634, 13440.39518221702], "value": 8961.096742346777, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1554.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 109.0, 105.0, 110.0, 107.0, 108.0, 110.0, 100.0, 109.0, 109.0], "value": 106.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 120.0, 149.0, 177.0, 124.0, 152.0, 155.0, 125.0, 170.0, 123.0], "value": 144.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 163.0, 165.0, 163.0, 165.0, 161.0, 166.0, 181.0, 171.0], "value": 166.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 200.0, 77.0, 76.0, 74.0, 76.0, 153.0, 76.0], "value": 96.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 130.0, 82.0, 82.0, 81.0, 140.0, 81.0, 82.0, 126.0], "value": 96.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 115.0, 113.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 152.0, 150.0, 149.0, 151.0, 151.0, 150.0, 150.0, 150.0, 150.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 60.0, 57.0, 56.0, 58.0, 60.0, 56.0, 57.0, 58.0], "value": 57.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 54.0, 54.0, 55.0, 56.0, 56.0, 54.0, 55.0], "value": 54.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 87.0, 79.0, 78.0, 78.0, 78.0, 77.0, 78.0, 78.0, 80.0], "value": 79.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 130.0, 136.0, 152.0, 135.0, 127.0, 128.0, 135.0, 133.0, 173.0], "value": 137.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 182.0, 191.0, 186.0, 184.0, 185.0, 179.0, 193.0, 182.0, 187.0], "value": 184.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 69.0, 71.0, 69.0, 69.0, 69.0, 70.0, 77.0, 71.0, 73.0], "value": 70.5, "unit": "score"}]}]} 17:35:22 INFO - Return code: 0 17:35:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:35:22 INFO - # TBPL SUCCESS # 17:35:22 INFO - Running post-action listener: _package_coverage_data 17:35:22 INFO - Running post-action listener: _resource_record_post_action 17:35:22 INFO - [mozharness: 2017-07-19 00:35:22.376899Z] Finished run-tests step (success) 17:35:22 INFO - Running post-run listener: _resource_record_post_run 17:35:22 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 8192; Write bytes: 438657024; Read time: 240; Write time: 362952 17:35:22 INFO - TinderboxPrint: CPU usage
13.1% 17:35:22 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 240 17:35:22 INFO - TinderboxPrint: I/O write bytes / time
438,657,024 / 362,952 17:35:22 INFO - TinderboxPrint: CPU idle
8,246.1 (86.8%) 17:35:22 INFO - TinderboxPrint: CPU user
1,199.3 (12.6%) 17:35:22 INFO - TinderboxPrint: Swap in / out
0 / 0 17:35:22 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 106708992; Read time: 0; Write time: 70752 17:35:22 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 17:35:22 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 4096; Write bytes: 331948032; Read time: 228; Write time: 292200 17:35:23 INFO - Running post-run listener: _upload_blobber_files 17:35:23 INFO - Blob upload gear active. 17:35:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:35:23 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:35:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:35:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:35:23 INFO - Traceback (most recent call last): 17:35:23 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 17:35:23 INFO - main() 17:35:23 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 17:35:23 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 17:35:23 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 17:35:23 INFO - return set(response.json().get('whitelist', [])) 17:35:23 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 17:35:23 INFO - return json.loads(self.text or self.content, **kwargs) 17:35:23 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/__init__.py", line 488, in loads 17:35:23 INFO - return _default_decoder.decode(s) 17:35:23 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 370, in decode 17:35:23 INFO - obj, end = self.raw_decode(s) 17:35:23 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/simplejson/decoder.py", line 389, in raw_decode 17:35:23 INFO - return self.scan_once(s, idx=_w(s, idx).end()) 17:35:23 INFO - simplejson.scanner.JSONDecodeError: Expecting value: line 1 column 1 (char 0) 17:35:23 ERROR - Return code: 1 17:35:23 INFO - Setting buildbot property blobber_files to {} 17:35:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:35:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:35:23 INFO - Contents: 17:35:23 INFO - blobber_files:{} 17:35:23 INFO - Running post-run listener: copy_logs_to_upload_dir 17:35:23 INFO - Copying logs to upload dir... 17:35:23 INFO - mkdir: /builds/slave/test/build/upload/logs 17:35:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.318489 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-07-18 17:35:23.046778) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-18 17:35:23.051981) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1500423273.763360-1125523907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011349 build_url: 'https://queue.taskcluster.net/v1/task/AL8eNrU6QISMrRooVk2SfA/artifacts/public/build/target.tar.bz2' blobber_files: '{}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-18 17:35:23.102310) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 17:35:23.102640) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1500423273.763360-1125523907 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004517 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 17:35:23.152637) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-18 17:35:23.152950) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-18 17:35:23.153270) ========= ========= Total master_lag: 0.17 =========