builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-007 starttime: 1486085943.67 results: success (0) revision: c8102da699dba43d85eb80b70956e80c6793feca ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-02 17:39:03.667654) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-02 17:39:03.668420) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-02 17:39:03.668890) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-02 17:39:03.685680) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 17:39:03.685968) ========= 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=923d835db2ba3686ebe126b700000192-1486085943.341339-1502583955 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-02 17:39:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 111M=0s 2017-02-02 17:39:04 (111 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.086924 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 17:39:03.789083) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 17:39:03.789427) ========= 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=923d835db2ba3686ebe126b700000192-1486085943.341339-1502583955 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017088 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 17:39:03.839618) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-02 17:39:03.839953) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c8102da699dba43d85eb80b70956e80c6793feca --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 c8102da699dba43d85eb80b70956e80c6793feca --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=923d835db2ba3686ebe126b700000192-1486085943.341339-1502583955 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-02 17:39:04,213 truncating revision to first 12 chars 2017-02-02 17:39:04,214 Setting DEBUG logging. 2017-02-02 17:39:04,214 attempt 1/10 2017-02-02 17:39:04,214 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c8102da699db?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-02 17:39:05,132 unpacking tar archive at: mozilla-central-c8102da699db/testing/mozharness/ program finished with exit code 0 elapsedTime=1.241148 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-02 17:39:05.095734) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-02 17:39:05.096291) ========= script_repo_revision: c8102da699dba43d85eb80b70956e80c6793feca ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-02 17:39:05.096991) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-02 17:39:05.097431) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-02 17:39:05.107973) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-02-02 17:39:05.108327) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=923d835db2ba3686ebe126b700000192-1486085943.341339-1502583955 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:39:05 INFO - MultiFileLogger online at 20170202 17:39:05 in /builds/slave/test 17:39:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:39:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:39:05 INFO - {'append_to_log': False, 17:39:05 INFO - 'base_work_dir': '/builds/slave/test', 17:39:05 INFO - 'blob_upload_branch': 'Firefox', 17:39:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:39:05 INFO - 'branch': 'Firefox', 17:39:05 INFO - 'buildbot_json_path': 'buildprops.json', 17:39:05 INFO - 'config_files': ('talos/linux_config.py',), 17:39:05 INFO - 'default_actions': ('clobber', 17:39:05 INFO - 'read-buildbot-config', 17:39:05 INFO - 'download-and-extract', 17:39:05 INFO - 'populate-webroot', 17:39:05 INFO - 'create-virtualenv', 17:39:05 INFO - 'install', 17:39:05 INFO - 'run-tests'), 17:39:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:39:05 INFO - 'download_minidump_stackwalk': True, 17:39:05 INFO - 'download_symbols': 'ondemand', 17:39:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:39:05 INFO - 'tooltool.py': '/tools/tooltool.py', 17:39:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:39:05 INFO - '/tools/misc-python/virtualenv.py')}, 17:39:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:39:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:39:05 INFO - 'installer_path': 'installer.exe', 17:39:05 INFO - 'log_level': 'info', 17:39:05 INFO - 'log_name': 'talos', 17:39:05 INFO - 'log_to_console': True, 17:39:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:39:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:39:05 INFO - 'opt_config_files': (), 17:39:05 INFO - 'pip_index': False, 17:39:05 INFO - 'sps_profile': False, 17:39:05 INFO - 'sps_profile_interval': 0, 17:39:05 INFO - 'suite': 'dromaeojs', 17:39:05 INFO - 'system_bits': '32', 17:39:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:39:05 INFO - 'title': 'talos-linux64-ix-007', 17:39:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:39:05 INFO - 'use_talos_json': True, 17:39:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:39:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:39:05 INFO - 'work_dir': 'build'} 17:39:05 INFO - [mozharness: 2017-02-03 01:39:05.577302Z] Running clobber step. 17:39:05 INFO - Running pre-action listener: _resource_record_pre_action 17:39:05 INFO - Running main action method: clobber 17:39:05 INFO - rmtree: /builds/slave/test/build 17:39:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:39:06 INFO - Running post-action listener: _resource_record_post_action 17:39:06 INFO - [mozharness: 2017-02-03 01:39:06.049796Z] Finished clobber step (success) 17:39:06 INFO - [mozharness: 2017-02-03 01:39:06.049897Z] Running read-buildbot-config step. 17:39:06 INFO - Running pre-action listener: _resource_record_pre_action 17:39:06 INFO - Running main action method: read_buildbot_config 17:39:06 INFO - Using buildbot properties: 17:39:06 INFO - { 17:39:06 INFO - "project": "", 17:39:06 INFO - "product": "firefox", 17:39:06 INFO - "who": "kwierso@gmail.com", 17:39:06 INFO - "installer_path": "public/build/target.tar.bz2", 17:39:06 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 17:39:06 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 17:39:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 17:39:06 INFO - "stage_platform": "linux64-pgo", 17:39:06 INFO - "basedir": "/builds/slave/test", 17:39:06 INFO - "buildnumber": 10, 17:39:06 INFO - "platform": "ubuntu64_hw", 17:39:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:39:06 INFO - "slavebuilddir": "test", 17:39:06 INFO - "taskId": "ZmwTqfu6Rfq6kCUwhWhkvw", 17:39:06 INFO - "branch": "mozilla-central", 17:39:06 INFO - "script_repo_revision": "production", 17:39:06 INFO - "revision": "c8102da699dba43d85eb80b70956e80c6793feca", 17:39:06 INFO - "slavename": "talos-linux64-ix-007", 17:39:06 INFO - "repo_path": "mozilla-central" 17:39:06 INFO - } 17:39:06 INFO - Finding installer, test and symbols from parent task. 17:39:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZmwTqfu6Rfq6kCUwhWhkvw'}, attempt #1 17:39:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZmwTqfu6Rfq6kCUwhWhkvw'}, attempt #1 17:39:06 INFO - Task dependencies: UQxJoFPNS22vL3vu9QKTQA 17:39:06 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UQxJoFPNS22vL3vu9QKTQA'}, attempt #1 17:39:07 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/UQxJoFPNS22vL3vu9QKTQA/artifacts/public/build/target.tar.bz2 17:39:07 INFO - Set test_url: https://queue.taskcluster.net/v1/task/UQxJoFPNS22vL3vu9QKTQA/artifacts/public/build/test_packages.json 17:39:07 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/UQxJoFPNS22vL3vu9QKTQA/artifacts/public/build/target.crashreporter-symbols.zip 17:39:07 INFO - Running post-action listener: _resource_record_post_action 17:39:07 INFO - [mozharness: 2017-02-03 01:39:07.439165Z] Finished read-buildbot-config step (success) 17:39:07 INFO - [mozharness: 2017-02-03 01:39:07.439384Z] Running download-and-extract step. 17:39:07 INFO - Running pre-action listener: _resource_record_pre_action 17:39:07 INFO - Running main action method: download_and_extract 17:39:07 INFO - mkdir: /builds/slave/test/build/tests 17:39:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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:39:07 INFO - trying https://queue.taskcluster.net/v1/task/UQxJoFPNS22vL3vu9QKTQA/artifacts/public/build/target.test_packages.json 17:39:07 INFO - Downloading https://queue.taskcluster.net/v1/task/UQxJoFPNS22vL3vu9QKTQA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:39:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UQxJoFPNS22vL3vu9QKTQA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:39:08 INFO - Downloaded 896 bytes. 17:39:08 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:39:08 INFO - Using the following test package requirements: 17:39:08 INFO - {u'common': [u'target.common.tests.zip'], 17:39:08 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:39:08 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:39:08 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:39:08 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:39:08 INFO - u'mozbase': [u'target.common.tests.zip'], 17:39:08 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:39:08 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:39:08 INFO - u'web-platform': [u'target.common.tests.zip', 17:39:08 INFO - u'target.web-platform.tests.zip'], 17:39:08 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:39:08 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:39:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UQxJoFPNS22vL3vu9QKTQA/artifacts/public/build/target.common.tests.zip 17:39:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UQxJoFPNS22vL3vu9QKTQA/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:39:08 INFO - Fetch https://queue.taskcluster.net/v1/task/UQxJoFPNS22vL3vu9QKTQA/artifacts/public/build/target.common.tests.zip into memory 17:39:09 INFO - Expected file size: 41749399 17:39:09 INFO - Obtained file size: 41749399 17:39:13 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:39:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UQxJoFPNS22vL3vu9QKTQA/artifacts/public/build/target.common.tests.zip 17:39:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UQxJoFPNS22vL3vu9QKTQA/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:39:13 INFO - Fetch https://queue.taskcluster.net/v1/task/UQxJoFPNS22vL3vu9QKTQA/artifacts/public/build/target.common.tests.zip into memory 17:39:14 INFO - Expected file size: 41749399 17:39:14 INFO - Obtained file size: 41749399 17:39:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UQxJoFPNS22vL3vu9QKTQA/artifacts/public/build/target.talos.tests.zip 17:39:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UQxJoFPNS22vL3vu9QKTQA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:39:19 INFO - Fetch https://queue.taskcluster.net/v1/task/UQxJoFPNS22vL3vu9QKTQA/artifacts/public/build/target.talos.tests.zip into memory 17:39:20 INFO - Expected file size: 14403454 17:39:20 INFO - Obtained file size: 14403454 17:39:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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:39:20 INFO - trying https://queue.taskcluster.net/v1/task/UQxJoFPNS22vL3vu9QKTQA/artifacts/public/build/target.tar.bz2 17:39:20 INFO - Downloading https://queue.taskcluster.net/v1/task/UQxJoFPNS22vL3vu9QKTQA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:39:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UQxJoFPNS22vL3vu9QKTQA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:39:21 INFO - Downloaded 61719780 bytes. 17:39:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UQxJoFPNS22vL3vu9QKTQA/artifacts/public/build/target.tar.bz2 17:39:21 INFO - mkdir: /builds/slave/test/properties 17:39:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:39:21 INFO - Writing to file /builds/slave/test/properties/build_url 17:39:21 INFO - Contents: 17:39:21 INFO - build_url:https://queue.taskcluster.net/v1/task/UQxJoFPNS22vL3vu9QKTQA/artifacts/public/build/target.tar.bz2 17:39:21 INFO - Running post-action listener: _resource_record_post_action 17:39:21 INFO - Running post-action listener: set_extra_try_arguments 17:39:21 INFO - [mozharness: 2017-02-03 01:39:21.632313Z] Finished download-and-extract step (success) 17:39:21 INFO - [mozharness: 2017-02-03 01:39:21.632410Z] Running populate-webroot step. 17:39:21 INFO - Running pre-action listener: _resource_record_pre_action 17:39:21 INFO - Running main action method: populate_webroot 17:39:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:39:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:39:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:39:21 INFO - '--tppagecycles', 17:39:21 INFO - '7'], 17:39:21 INFO - 'tests': ['tsvgm']}}, 17:39:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:39:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:39:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:39:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:39:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:39:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:39:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:39:21 INFO - 'talos_options': ['--disable-e10s'], 17:39:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:39:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:39:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:39:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:39:21 INFO - 'talos_options': ['--disable-e10s'], 17:39:21 INFO - 'tests': ['damp', 'tps']}, 17:39:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:39:21 INFO - 'tests': ['damp', 'tps']}, 17:39:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:39:21 INFO - 'tests': ['dromaeo_dom']}, 17:39:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:39:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:39:21 INFO - 'tests': ['basic_compositor_video']}, 17:39:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:39:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:39:21 INFO - 'tests': ['a11yr', 17:39:21 INFO - 'ts_paint', 17:39:21 INFO - 'tpaint', 17:39:21 INFO - 'sessionrestore', 17:39:21 INFO - 'sessionrestore_no_auto_restore', 17:39:21 INFO - 'tabpaint']}, 17:39:21 INFO - 'other-e10s': {'tests': ['a11yr', 17:39:21 INFO - 'ts_paint', 17:39:21 INFO - 'tpaint', 17:39:21 INFO - 'sessionrestore', 17:39:21 INFO - 'sessionrestore_no_auto_restore', 17:39:21 INFO - 'tabpaint']}, 17:39:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:39:21 INFO - 'ts_paint', 17:39:21 INFO - 'tpaint', 17:39:21 INFO - 'sessionrestore', 17:39:21 INFO - 'sessionrestore_no_auto_restore', 17:39:21 INFO - 'tabpaint']}, 17:39:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:39:21 INFO - 'ts_paint', 17:39:21 INFO - 'tpaint', 17:39:21 INFO - 'sessionrestore', 17:39:21 INFO - 'sessionrestore_no_auto_restore', 17:39:21 INFO - 'tabpaint']}, 17:39:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:39:21 INFO - 'tests': ['a11yr', 17:39:21 INFO - 'ts_paint', 17:39:21 INFO - 'tpaint', 17:39:21 INFO - 'sessionrestore', 17:39:21 INFO - 'sessionrestore_no_auto_restore', 17:39:21 INFO - 'tabpaint']}, 17:39:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:39:21 INFO - 'tests': ['a11yr', 17:39:21 INFO - 'ts_paint', 17:39:21 INFO - 'tpaint', 17:39:21 INFO - 'sessionrestore', 17:39:21 INFO - 'sessionrestore_no_auto_restore', 17:39:21 INFO - 'tabpaint']}, 17:39:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:39:21 INFO - 'tests': ['tsvgx', 17:39:21 INFO - 'tsvgr_opacity', 17:39:21 INFO - 'tart', 17:39:21 INFO - 'tscrollx', 17:39:21 INFO - 'cart', 17:39:21 INFO - 'tsvg_static']}, 17:39:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:39:21 INFO - 'tsvgr_opacity', 17:39:21 INFO - 'tart', 17:39:21 INFO - 'tscrollx', 17:39:21 INFO - 'cart', 17:39:21 INFO - 'tsvg_static']}, 17:39:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:39:21 INFO - 'talos_options': ['--disable-e10s'], 17:39:21 INFO - 'tests': ['tp5o']}, 17:39:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:39:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:39:21 INFO - 'talos_options': ['--disable-e10s', 17:39:21 INFO - '--xperf_path', 17:39:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:39:21 INFO - 'tests': ['tp5n']}, 17:39:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:39:21 INFO - 'talos_options': ['--xperf_path', 17:39:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:39:21 INFO - 'tests': ['tp5n']}}, 17:39:21 INFO - 'talos.zip': {'path': '', 17:39:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:39:21 INFO - Running post-action listener: _resource_record_post_action 17:39:21 INFO - [mozharness: 2017-02-03 01:39:21.645422Z] Finished populate-webroot step (success) 17:39:21 INFO - [mozharness: 2017-02-03 01:39:21.645514Z] Running create-virtualenv step. 17:39:21 INFO - Running pre-action listener: _resource_record_pre_action 17:39:21 INFO - Running main action method: create_virtualenv 17:39:21 INFO - Creating virtualenv /builds/slave/test/build/venv 17:39:21 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:39:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:39:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:39:21 INFO - Using real prefix '/usr' 17:39:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:39:22 INFO - Installing distribute.............................................................................................................................................................................................done. 17:39:24 INFO - Installing pip.................done. 17:39:24 INFO - Return code: 0 17:39:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:39:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:39:24 INFO - Reading from file tmpfile_stdout 17:39:24 INFO - Output received: 17:39:24 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:39:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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:39:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:24 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x26cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2898a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a3dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b3f0>, '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 0x2a3bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c1a0>, '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': '923d835db2ba3686ebe126b700000192-1486085943.341339-1502583955', '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:39:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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:39:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:39:24 INFO - Using env: {'DISPLAY': ':0', 17:39:24 INFO - 'HOME': '/home/cltbld', 17:39:24 INFO - 'LANG': 'en_US.UTF-8', 17:39:24 INFO - 'LANGUAGE': 'en_US:en', 17:39:24 INFO - 'LOGNAME': 'cltbld', 17:39:24 INFO - 'MAIL': '/var/mail/cltbld', 17:39:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:24 INFO - 'MOZ_NO_REMOTE': '1', 17:39:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:39:24 INFO - 'NO_EM_RESTART': '1', 17:39:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:39:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:24 INFO - 'PWD': '/builds/slave/test', 17:39:24 INFO - 'SHELL': '/bin/bash', 17:39:24 INFO - 'SHLVL': '1', 17:39:24 INFO - 'TERM': 'linux', 17:39:24 INFO - 'TMOUT': '86400', 17:39:24 INFO - 'USER': 'cltbld', 17:39:24 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1486085943.341339-1502583955', 17:39:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:24 INFO - '_': '/tools/buildbot/bin/python'} 17:39:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:24 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:39:24 INFO - Cleaning up... 17:39:24 INFO - Return code: 0 17:39:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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:39:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:24 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x26cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2898a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a3dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b3f0>, '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 0x2a3bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c1a0>, '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': '923d835db2ba3686ebe126b700000192-1486085943.341339-1502583955', '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:39:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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:39:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:39:24 INFO - Using env: {'DISPLAY': ':0', 17:39:24 INFO - 'HOME': '/home/cltbld', 17:39:24 INFO - 'LANG': 'en_US.UTF-8', 17:39:24 INFO - 'LANGUAGE': 'en_US:en', 17:39:24 INFO - 'LOGNAME': 'cltbld', 17:39:24 INFO - 'MAIL': '/var/mail/cltbld', 17:39:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:24 INFO - 'MOZ_NO_REMOTE': '1', 17:39:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:39:24 INFO - 'NO_EM_RESTART': '1', 17:39:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:39:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:24 INFO - 'PWD': '/builds/slave/test', 17:39:24 INFO - 'SHELL': '/bin/bash', 17:39:24 INFO - 'SHLVL': '1', 17:39:24 INFO - 'TERM': 'linux', 17:39:24 INFO - 'TMOUT': '86400', 17:39:24 INFO - 'USER': 'cltbld', 17:39:24 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1486085943.341339-1502583955', 17:39:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:24 INFO - '_': '/tools/buildbot/bin/python'} 17:39:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:24 INFO - Downloading/unpacking psutil>=3.1.1 17:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:39:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:39:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:39:26 INFO - Installing collected packages: psutil 17:39:26 INFO - Running setup.py install for psutil 17:39:27 INFO - building 'psutil._psutil_linux' extension 17:39:27 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:39:27 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:39:27 INFO - building 'psutil._psutil_posix' extension 17:39:27 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:39:27 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:39:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:39:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:39:27 INFO - Successfully installed psutil 17:39:27 INFO - Cleaning up... 17:39:27 INFO - Return code: 0 17:39:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:39:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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:39:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:27 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x26cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2898a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a3dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b3f0>, '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 0x2a3bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c1a0>, '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': '923d835db2ba3686ebe126b700000192-1486085943.341339-1502583955', '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:39:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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:39:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:39:27 INFO - Using env: {'DISPLAY': ':0', 17:39:27 INFO - 'HOME': '/home/cltbld', 17:39:27 INFO - 'LANG': 'en_US.UTF-8', 17:39:27 INFO - 'LANGUAGE': 'en_US:en', 17:39:27 INFO - 'LOGNAME': 'cltbld', 17:39:27 INFO - 'MAIL': '/var/mail/cltbld', 17:39:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:27 INFO - 'MOZ_NO_REMOTE': '1', 17:39:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:39:27 INFO - 'NO_EM_RESTART': '1', 17:39:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:39:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:27 INFO - 'PWD': '/builds/slave/test', 17:39:27 INFO - 'SHELL': '/bin/bash', 17:39:27 INFO - 'SHLVL': '1', 17:39:27 INFO - 'TERM': 'linux', 17:39:27 INFO - 'TMOUT': '86400', 17:39:27 INFO - 'USER': 'cltbld', 17:39:27 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1486085943.341339-1502583955', 17:39:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:27 INFO - '_': '/tools/buildbot/bin/python'} 17:39:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:39:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:39:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:39:29 INFO - Installing collected packages: mozsystemmonitor 17:39:29 INFO - Running setup.py install for mozsystemmonitor 17:39:29 INFO - Successfully installed mozsystemmonitor 17:39:29 INFO - Cleaning up... 17:39:29 INFO - Return code: 0 17:39:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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:39:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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:39:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:29 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x26cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2898a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a3dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b3f0>, '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 0x2a3bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c1a0>, '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': '923d835db2ba3686ebe126b700000192-1486085943.341339-1502583955', '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:39:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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:39:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:39:29 INFO - Using env: {'DISPLAY': ':0', 17:39:29 INFO - 'HOME': '/home/cltbld', 17:39:29 INFO - 'LANG': 'en_US.UTF-8', 17:39:29 INFO - 'LANGUAGE': 'en_US:en', 17:39:29 INFO - 'LOGNAME': 'cltbld', 17:39:29 INFO - 'MAIL': '/var/mail/cltbld', 17:39:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:29 INFO - 'MOZ_NO_REMOTE': '1', 17:39:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:39:29 INFO - 'NO_EM_RESTART': '1', 17:39:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:39:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:29 INFO - 'PWD': '/builds/slave/test', 17:39:29 INFO - 'SHELL': '/bin/bash', 17:39:29 INFO - 'SHLVL': '1', 17:39:29 INFO - 'TERM': 'linux', 17:39:29 INFO - 'TMOUT': '86400', 17:39:29 INFO - 'USER': 'cltbld', 17:39:29 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1486085943.341339-1502583955', 17:39:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:29 INFO - '_': '/tools/buildbot/bin/python'} 17:39:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:30 INFO - Downloading/unpacking jsonschema==2.5.1 17:39:30 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:39:30 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:39:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:30 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:39:30 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:39:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:39:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:32 INFO - Downloading functools32-3.2.3-2.tar.gz 17:39:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:39:32 INFO - warning: no files found matching '*.txt' 17:39:32 INFO - no previously-included directories found matching 'build' 17:39:32 INFO - no previously-included directories found matching 'dist' 17:39:32 INFO - no previously-included directories found matching '.git*' 17:39:32 INFO - Installing collected packages: jsonschema, functools32 17:39:32 INFO - Running setup.py install for functools32 17:39:32 INFO - warning: no files found matching '*.txt' 17:39:32 INFO - no previously-included directories found matching 'build' 17:39:32 INFO - no previously-included directories found matching 'dist' 17:39:32 INFO - no previously-included directories found matching '.git*' 17:39:32 INFO - Successfully installed jsonschema functools32 17:39:32 INFO - Cleaning up... 17:39:32 INFO - Return code: 0 17:39:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:39:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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:39:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x26cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2898a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a3dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b3f0>, '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 0x2a3bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c1a0>, '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': '923d835db2ba3686ebe126b700000192-1486085943.341339-1502583955', '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:39:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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:39:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:39:32 INFO - Using env: {'DISPLAY': ':0', 17:39:32 INFO - 'HOME': '/home/cltbld', 17:39:32 INFO - 'LANG': 'en_US.UTF-8', 17:39:32 INFO - 'LANGUAGE': 'en_US:en', 17:39:32 INFO - 'LOGNAME': 'cltbld', 17:39:32 INFO - 'MAIL': '/var/mail/cltbld', 17:39:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:32 INFO - 'MOZ_NO_REMOTE': '1', 17:39:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:39:32 INFO - 'NO_EM_RESTART': '1', 17:39:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:39:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:32 INFO - 'PWD': '/builds/slave/test', 17:39:32 INFO - 'SHELL': '/bin/bash', 17:39:32 INFO - 'SHLVL': '1', 17:39:32 INFO - 'TERM': 'linux', 17:39:32 INFO - 'TMOUT': '86400', 17:39:32 INFO - 'USER': 'cltbld', 17:39:32 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1486085943.341339-1502583955', 17:39:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:32 INFO - '_': '/tools/buildbot/bin/python'} 17:39:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:39:32 INFO - Cleaning up... 17:39:32 INFO - Return code: 0 17:39:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:39:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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:39:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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:39:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x26cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2898a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a3dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b3f0>, '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 0x2a3bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c1a0>, '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': '923d835db2ba3686ebe126b700000192-1486085943.341339-1502583955', '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:39:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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:39:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:39:32 INFO - Using env: {'DISPLAY': ':0', 17:39:32 INFO - 'HOME': '/home/cltbld', 17:39:32 INFO - 'LANG': 'en_US.UTF-8', 17:39:32 INFO - 'LANGUAGE': 'en_US:en', 17:39:32 INFO - 'LOGNAME': 'cltbld', 17:39:32 INFO - 'MAIL': '/var/mail/cltbld', 17:39:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:32 INFO - 'MOZ_NO_REMOTE': '1', 17:39:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:39:32 INFO - 'NO_EM_RESTART': '1', 17:39:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:39:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:32 INFO - 'PWD': '/builds/slave/test', 17:39:32 INFO - 'SHELL': '/bin/bash', 17:39:32 INFO - 'SHLVL': '1', 17:39:32 INFO - 'TERM': 'linux', 17:39:32 INFO - 'TMOUT': '86400', 17:39:32 INFO - 'USER': 'cltbld', 17:39:32 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1486085943.341339-1502583955', 17:39:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:32 INFO - '_': '/tools/buildbot/bin/python'} 17:39:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:33 INFO - Downloading/unpacking blobuploader==1.2.4 17:39:33 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:39:33 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:39:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:33 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:39:33 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:39:35 INFO - Downloading blobuploader-1.2.4.tar.gz 17:39:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:39:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:39:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:39:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:39:35 INFO - Downloading docopt-0.6.1.tar.gz 17:39:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:39:35 INFO - Installing collected packages: blobuploader, requests, docopt 17:39:35 INFO - Running setup.py install for blobuploader 17:39:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:39:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:39:36 INFO - Running setup.py install for requests 17:39:36 INFO - Running setup.py install for docopt 17:39:36 INFO - Successfully installed blobuploader requests docopt 17:39:36 INFO - Cleaning up... 17:39:36 INFO - Return code: 0 17:39:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:39:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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:39:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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:39:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:36 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x26cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2898a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a3dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b3f0>, '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 0x2a3bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c1a0>, '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': '923d835db2ba3686ebe126b700000192-1486085943.341339-1502583955', '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:39:36 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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:39:36 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:39:36 INFO - Using env: {'DISPLAY': ':0', 17:39:36 INFO - 'HOME': '/home/cltbld', 17:39:36 INFO - 'LANG': 'en_US.UTF-8', 17:39:36 INFO - 'LANGUAGE': 'en_US:en', 17:39:36 INFO - 'LOGNAME': 'cltbld', 17:39:36 INFO - 'MAIL': '/var/mail/cltbld', 17:39:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:36 INFO - 'MOZ_NO_REMOTE': '1', 17:39:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:39:36 INFO - 'NO_EM_RESTART': '1', 17:39:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:39:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:36 INFO - 'PWD': '/builds/slave/test', 17:39:36 INFO - 'SHELL': '/bin/bash', 17:39:36 INFO - 'SHLVL': '1', 17:39:36 INFO - 'TERM': 'linux', 17:39:36 INFO - 'TMOUT': '86400', 17:39:36 INFO - 'USER': 'cltbld', 17:39:36 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1486085943.341339-1502583955', 17:39:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:36 INFO - '_': '/tools/buildbot/bin/python'} 17:39:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:39:36 INFO - Running setup.py (path:/tmp/pip-3_ow6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:39:36 INFO - Running setup.py (path:/tmp/pip-cqlpLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:39:36 INFO - Running setup.py (path:/tmp/pip-SSIGFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:39:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:39:37 INFO - Running setup.py (path:/tmp/pip-JUqdMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:39:37 INFO - Running setup.py (path:/tmp/pip-ceMQoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:39:37 INFO - Running setup.py (path:/tmp/pip-VgsDup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:39:37 INFO - Running setup.py (path:/tmp/pip-5SZoxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:39:37 INFO - Running setup.py (path:/tmp/pip-0nBp0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:39:37 INFO - Running setup.py (path:/tmp/pip-pDyY9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:39:37 INFO - Running setup.py (path:/tmp/pip-eRisMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:39:37 INFO - Running setup.py (path:/tmp/pip-wLd4iP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:39:37 INFO - Running setup.py (path:/tmp/pip-DVDnoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:39:37 INFO - Running setup.py (path:/tmp/pip-HRwl4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:39:37 INFO - Running setup.py (path:/tmp/pip-2lM1I4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:39:37 INFO - Running setup.py (path:/tmp/pip-iLJZSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:39:37 INFO - Running setup.py (path:/tmp/pip-nk7qzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:39:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:39:37 INFO - Running setup.py (path:/tmp/pip-K4kCm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:39:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:39:38 INFO - Running setup.py install for manifestparser 17:39:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:39:38 INFO - Running setup.py install for mozcrash 17:39:38 INFO - Running setup.py install for mozdebug 17:39:38 INFO - Running setup.py install for mozdevice 17:39:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:39:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:39:38 INFO - Running setup.py install for mozfile 17:39:38 INFO - Running setup.py install for mozhttpd 17:39:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:39:38 INFO - Running setup.py install for mozinfo 17:39:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:39:38 INFO - Running setup.py install for mozInstall 17:39:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:39:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:39:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:39:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:39:38 INFO - Running setup.py install for mozleak 17:39:38 INFO - Running setup.py install for mozlog 17:39:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:39:39 INFO - Running setup.py install for moznetwork 17:39:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:39:39 INFO - Running setup.py install for mozprocess 17:39:39 INFO - Running setup.py install for mozprofile 17:39:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:39:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:39:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:39:39 INFO - Running setup.py install for mozrunner 17:39:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:39:39 INFO - Running setup.py install for mozscreenshot 17:39:39 INFO - Running setup.py install for moztest 17:39:39 INFO - Running setup.py install for mozversion 17:39:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:39:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:39:39 INFO - Cleaning up... 17:39:39 INFO - Return code: 0 17:39:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:39:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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:39:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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:39:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:39 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x26cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2898a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a3dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b3f0>, '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 0x2a3bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c1a0>, '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': '923d835db2ba3686ebe126b700000192-1486085943.341339-1502583955', '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:39:39 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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:39:39 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:39:39 INFO - Using env: {'DISPLAY': ':0', 17:39:39 INFO - 'HOME': '/home/cltbld', 17:39:39 INFO - 'LANG': 'en_US.UTF-8', 17:39:39 INFO - 'LANGUAGE': 'en_US:en', 17:39:39 INFO - 'LOGNAME': 'cltbld', 17:39:39 INFO - 'MAIL': '/var/mail/cltbld', 17:39:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:39 INFO - 'MOZ_NO_REMOTE': '1', 17:39:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:39:39 INFO - 'NO_EM_RESTART': '1', 17:39:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:39:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:39 INFO - 'PWD': '/builds/slave/test', 17:39:39 INFO - 'SHELL': '/bin/bash', 17:39:39 INFO - 'SHLVL': '1', 17:39:39 INFO - 'TERM': 'linux', 17:39:39 INFO - 'TMOUT': '86400', 17:39:39 INFO - 'USER': 'cltbld', 17:39:39 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1486085943.341339-1502583955', 17:39:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:39 INFO - '_': '/tools/buildbot/bin/python'} 17:39:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:39:40 INFO - Running setup.py (path:/tmp/pip-rBDav6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:39:40 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:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:39:40 INFO - Running setup.py (path:/tmp/pip-tfFPOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:39:40 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:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:39:40 INFO - Running setup.py (path:/tmp/pip-ab2zR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:39:40 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:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:39:40 INFO - Running setup.py (path:/tmp/pip-sLSHVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:39:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:39:40 INFO - Running setup.py (path:/tmp/pip-80WWJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:39:40 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:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:39:40 INFO - Running setup.py (path:/tmp/pip-m_uMFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:39:40 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:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:39:40 INFO - Running setup.py (path:/tmp/pip-yX5GWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:39:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:39:40 INFO - Running setup.py (path:/tmp/pip-MJB008-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:39:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 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:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:39:40 INFO - Running setup.py (path:/tmp/pip-uy8Vwe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:39:40 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:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:39:40 INFO - Running setup.py (path:/tmp/pip-G4Xza7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:39:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:39:40 INFO - Running setup.py (path:/tmp/pip-OUchfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:39:40 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:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:39:40 INFO - Running setup.py (path:/tmp/pip-BCdAwZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:39:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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:39:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:39:40 INFO - Running setup.py (path:/tmp/pip-0_Gwqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:39:41 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:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:39:41 INFO - Running setup.py (path:/tmp/pip-Qj4oFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:39:41 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:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:39:41 INFO - Running setup.py (path:/tmp/pip-qqQlsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:39:41 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:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:39:41 INFO - Running setup.py (path:/tmp/pip-FsSRMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:39:41 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:39:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:39:41 INFO - Running setup.py (path:/tmp/pip-hGYO0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:39:41 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:39:41 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:39:41 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:39:41 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:39:41 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:39:41 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:39:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:39:41 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:39:41 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:39:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:39:41 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:39:41 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:39:43 INFO - Downloading blessings-1.6.tar.gz 17:39:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:39:43 INFO - Installing collected packages: blessings 17:39:43 INFO - Running setup.py install for blessings 17:39:43 INFO - Successfully installed blessings 17:39:43 INFO - Cleaning up... 17:39:43 INFO - Return code: 0 17:39:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:39:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:39:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:39:43 INFO - Reading from file tmpfile_stdout 17:39:43 INFO - Current package versions: 17:39:43 INFO - argparse == 1.2.1 17:39:43 INFO - blessings == 1.6 17:39:43 INFO - blobuploader == 1.2.4 17:39:43 INFO - docopt == 0.6.1 17:39:43 INFO - functools32 == 3.2.3-2 17:39:43 INFO - jsonschema == 2.5.1 17:39:43 INFO - manifestparser == 1.1 17:39:43 INFO - mozInstall == 1.12 17:39:43 INFO - mozcrash == 1.0 17:39:43 INFO - mozdebug == 0.1 17:39:43 INFO - mozdevice == 0.49 17:39:43 INFO - mozfile == 1.2 17:39:43 INFO - mozhttpd == 0.7 17:39:43 INFO - mozinfo == 0.9 17:39:43 INFO - mozleak == 0.1 17:39:43 INFO - mozlog == 3.4 17:39:43 INFO - moznetwork == 0.27 17:39:43 INFO - mozprocess == 0.24 17:39:43 INFO - mozprofile == 0.28 17:39:43 INFO - mozrunner == 6.13 17:39:43 INFO - mozscreenshot == 0.1 17:39:43 INFO - mozsystemmonitor == 0.3 17:39:43 INFO - moztest == 0.8 17:39:43 INFO - mozversion == 1.4 17:39:43 INFO - psutil == 3.1.1 17:39:43 INFO - requests == 1.2.3 17:39:43 INFO - wsgiref == 0.1.2 17:39:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:39:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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:39:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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:39:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:43 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x26cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2898a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a3dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b3f0>, '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 0x2a3bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c1a0>, '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': '923d835db2ba3686ebe126b700000192-1486085943.341339-1502583955', '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:39:43 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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:39:43 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:39:43 INFO - Using env: {'DISPLAY': ':0', 17:39:43 INFO - 'HOME': '/home/cltbld', 17:39:43 INFO - 'LANG': 'en_US.UTF-8', 17:39:43 INFO - 'LANGUAGE': 'en_US:en', 17:39:43 INFO - 'LOGNAME': 'cltbld', 17:39:43 INFO - 'MAIL': '/var/mail/cltbld', 17:39:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:43 INFO - 'MOZ_NO_REMOTE': '1', 17:39:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:39:43 INFO - 'NO_EM_RESTART': '1', 17:39:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:39:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:43 INFO - 'PWD': '/builds/slave/test', 17:39:43 INFO - 'SHELL': '/bin/bash', 17:39:43 INFO - 'SHLVL': '1', 17:39:43 INFO - 'TERM': 'linux', 17:39:43 INFO - 'TMOUT': '86400', 17:39:43 INFO - 'USER': 'cltbld', 17:39:43 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1486085943.341339-1502583955', 17:39:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:43 INFO - '_': '/tools/buildbot/bin/python'} 17:39:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:43 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:39:43 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:39:43 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:39:43 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:39:43 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:39:43 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:39:43 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:39:43 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:39:43 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:39:44 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:39:44 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:39:44 INFO - Cleaning up... 17:39:44 INFO - Return code: 0 17:39:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:39:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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:39:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:39:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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:39:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:39:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:39:44 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x26cc1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2898a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a3dc70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a3b3f0>, '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 0x2a3bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c1a0>, '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': '923d835db2ba3686ebe126b700000192-1486085943.341339-1502583955', '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:39:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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:39:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:39:44 INFO - Using env: {'DISPLAY': ':0', 17:39:44 INFO - 'HOME': '/home/cltbld', 17:39:44 INFO - 'LANG': 'en_US.UTF-8', 17:39:44 INFO - 'LANGUAGE': 'en_US:en', 17:39:44 INFO - 'LOGNAME': 'cltbld', 17:39:44 INFO - 'MAIL': '/var/mail/cltbld', 17:39:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:39:44 INFO - 'MOZ_NO_REMOTE': '1', 17:39:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:39:44 INFO - 'NO_EM_RESTART': '1', 17:39:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:39:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:39:44 INFO - 'PWD': '/builds/slave/test', 17:39:44 INFO - 'SHELL': '/bin/bash', 17:39:44 INFO - 'SHLVL': '1', 17:39:44 INFO - 'TERM': 'linux', 17:39:44 INFO - 'TMOUT': '86400', 17:39:44 INFO - 'USER': 'cltbld', 17:39:44 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1486085943.341339-1502583955', 17:39:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:39:44 INFO - '_': '/tools/buildbot/bin/python'} 17:39:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:39:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:39:44 INFO - Cleaning up... 17:39:44 INFO - Return code: 0 17:39:44 INFO - Running post-action listener: _resource_record_post_action 17:39:44 INFO - Running post-action listener: _start_resource_monitoring 17:39:44 INFO - Starting resource monitoring. 17:39:44 INFO - [mozharness: 2017-02-03 01:39:44.290468Z] Finished create-virtualenv step (success) 17:39:44 INFO - [mozharness: 2017-02-03 01:39:44.290969Z] Running install step. 17:39:44 INFO - Running pre-action listener: _resource_record_pre_action 17:39:44 INFO - Running main action method: install 17:39:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:39:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:39:44 INFO - Reading from file tmpfile_stdout 17:39:44 INFO - Detecting whether we're running mozinstall >=1.0... 17:39:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:39:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:39:44 INFO - Reading from file tmpfile_stdout 17:39:44 INFO - Output received: 17:39:44 INFO - Usage: mozinstall [options] installer 17:39:44 INFO - Options: 17:39:44 INFO - -h, --help show this help message and exit 17:39:44 INFO - -d DEST, --destination=DEST 17:39:44 INFO - Directory to install application into. [default: 17:39:44 INFO - "/builds/slave/test"] 17:39:44 INFO - --app=APP Application being installed. [default: firefox] 17:39:44 INFO - mkdir: /builds/slave/test/build/application 17:39:44 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:39:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:40:02 INFO - Reading from file tmpfile_stdout 17:40:02 INFO - Output received: 17:40:02 INFO - /builds/slave/test/build/application/firefox/firefox 17:40:02 INFO - Running post-action listener: _resource_record_post_action 17:40:02 INFO - [mozharness: 2017-02-03 01:40:02.096101Z] Finished install step (success) 17:40:02 INFO - [mozharness: 2017-02-03 01:40:02.096378Z] Running run-tests step. 17:40:02 INFO - Running pre-action listener: _resource_record_pre_action 17:40:02 INFO - Running main action method: run_tests 17:40:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:40:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:40:02 INFO - Python 2.7.3 17:40:02 INFO - Return code: 0 17:40:02 INFO - grabbing minidump binary from tooltool 17:40:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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:40:02 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 0x2a3b3f0>, '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 0x2a3bcf0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a3c1a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:40:02 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:40:02 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:40:02 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:40:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:40:02 INFO - Return code: 0 17:40:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:40:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:40:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:40:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:40:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:40:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UQxJoFPNS22vL3vu9QKTQA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:40:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UQxJoFPNS22vL3vu9QKTQA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:40:02 INFO - Using env: {'DISPLAY': ':0', 17:40:02 INFO - 'HOME': '/home/cltbld', 17:40:02 INFO - 'LANG': 'en_US.UTF-8', 17:40:02 INFO - 'LANGUAGE': 'en_US:en', 17:40:02 INFO - 'LOGNAME': 'cltbld', 17:40:02 INFO - 'MAIL': '/var/mail/cltbld', 17:40:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:40:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:40:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:40:02 INFO - 'MOZ_NO_REMOTE': '1', 17:40:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:40:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:40:02 INFO - 'NO_EM_RESTART': '1', 17:40:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:40:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:40:02 INFO - 'PWD': '/builds/slave/test', 17:40:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:40:02 INFO - 'SHELL': '/bin/bash', 17:40:02 INFO - 'SHLVL': '1', 17:40:02 INFO - 'TERM': 'linux', 17:40:02 INFO - 'TMOUT': '86400', 17:40:02 INFO - 'USER': 'cltbld', 17:40:02 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1486085943.341339-1502583955', 17:40:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:40:02 INFO - '_': '/tools/buildbot/bin/python'} 17:40:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UQxJoFPNS22vL3vu9QKTQA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:40:02 INFO - mozversion application_buildid: 20170203003930 17:40:02 INFO - mozversion application_changeset: c8102da699dba43d85eb80b70956e80c6793feca 17:40:02 INFO - mozversion application_display_name: Nightly 17:40:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:40:02 INFO - mozversion application_name: Firefox 17:40:02 INFO - mozversion application_remotingname: firefox 17:40:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:40:02 INFO - mozversion application_vendor: Mozilla 17:40:02 INFO - mozversion application_version: 54.0a1 17:40:02 INFO - mozversion platform_buildid: 20170203003930 17:40:02 INFO - mozversion platform_changeset: c8102da699dba43d85eb80b70956e80c6793feca 17:40:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:40:02 INFO - mozversion platform_version: 54.0a1 17:40:02 INFO - using testdate: 1486086002 17:40:02 INFO - actual date: 1486086002 17:40:02 INFO - starting webserver on 'localhost:46491' 17:40:02 INFO - SUITE-START | Running 2 tests 17:40:02 INFO - TEST-START | dromaeo_css 17:40:02 INFO - operating with platform_type : linux_ 17:40:02 INFO - Initialising browser for dromaeo_css test... 17:40:02 INFO - TEST-INFO | started process 22989 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpusv0UT/profile http://localhost:46491/getInfo.html) 17:40:05 INFO - PROCESS | 22989 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 17:40:05 INFO - PROCESS | 22989 | __metrics Screen width/height:1600/1200 17:40:05 INFO - PROCESS | 22989 | colorDepth:24 17:40:05 INFO - PROCESS | 22989 | Browser inner width/height: 1024/697 17:40:05 INFO - PROCESS | 22989 | __metrics 17:40:06 INFO - PROCESS | 22989 | 1486086006097 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 17:40:06 INFO - PROCESS | 22989 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:40:06 INFO - PROCESS | 22989 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:40:06 INFO - PROCESS | 22989 | console.error: PushService: 17:40:06 INFO - PROCESS | 22989 | stateChangeProcessEnqueue: Error transitioning state 17:40:06 INFO - PROCESS | 22989 | UnknownError 17:40:07 INFO - TEST-INFO | 22989: exit 0 17:40:07 INFO - Browser initialized. 17:40:07 INFO - Running cycle 1/1 for dromaeo_css test... 17:40:07 INFO - TEST-INFO | started process 23073 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpusv0UT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:40:19 INFO - PROCESS | 23073 | RSS: Main: 148746240 17:40:19 INFO - PROCESS | 23073 | 17:43:19 INFO - PROCESS | 23073 | Cycle 1(1): loaded http://localhost:46491/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46491/tests/dromaeo/cssquery-ext.html) 17:43:21 INFO - PROCESS | 23073 | RSS: Main: 366661632 17:43:21 INFO - PROCESS | 23073 | 17:45:09 INFO - PROCESS | 23073 | ************************* 17:45:09 INFO - PROCESS | 23073 | A coding exception was thrown and uncaught in a Task. 17:45:09 INFO - PROCESS | 23073 | 17:45:09 ERROR - PROCESS | 23073 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:45:09 INFO - PROCESS | 23073 | Full stack: 17:45:09 INFO - PROCESS | 23073 | ************************* 17:46:24 INFO - PROCESS | 23073 | Cycle 1(1): loaded http://localhost:46491/tests/dromaeo/cssquery-ext.html (next: http://localhost:46491/tests/dromaeo/cssquery-jquery.html) 17:46:24 INFO - PROCESS | 23073 | RSS: Main: 249069568 17:46:24 INFO - PROCESS | 23073 | 17:49:26 INFO - PROCESS | 23073 | Cycle 1(1): loaded http://localhost:46491/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46491/tests/dromaeo/cssquery-mootools.html) 17:49:27 INFO - PROCESS | 23073 | RSS: Main: 184995840 17:49:27 INFO - PROCESS | 23073 | 17:52:29 INFO - PROCESS | 23073 | Cycle 1(1): loaded http://localhost:46491/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46491/tests/dromaeo/cssquery-prototype.html) 17:52:29 INFO - PROCESS | 23073 | RSS: Main: 222519296 17:52:29 INFO - PROCESS | 23073 | 17:55:32 INFO - PROCESS | 23073 | Cycle 1(1): loaded http://localhost:46491/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46491/tests/dromaeo/cssquery-yui.html) 17:55:33 INFO - PROCESS | 23073 | RSS: Main: 189558784 17:55:33 INFO - PROCESS | 23073 | 17:58:36 INFO - PROCESS | 23073 | Cycle 1(1): loaded http://localhost:46491/tests/dromaeo/cssquery-yui.html (next: http://localhost:46491/tests/dromaeo/cssquery-dojo.html) 17:58:36 INFO - PROCESS | 23073 | RSS: Main: 285573120 17:58:36 INFO - PROCESS | 23073 | 17:58:36 INFO - PROCESS | 23073 | __start_tp_report 17:58:36 INFO - PROCESS | 23073 | _x_x_mozilla_page_load 17:58:36 INFO - PROCESS | 23073 | _x_x_mozilla_page_load_details 17:58:36 INFO - PROCESS | 23073 | |i|pagename|runs| 17:58:36 INFO - PROCESS | 23073 | |0;dojo.html;3131.5146152346388;3147.748180145589;3163.177573830804;3179.85690643921;3203.519472079188;5150.871228219296;5214;5267.578593712504;5281.128613778722;5293.364796224459;5162.148245539491;5234.319538460004;5246.134387826004;5279.841604751864;5309.150535914255;4545.659075569329;4734.360861283734;4908.656394052417;4921.606271498289;4936.062148191832;4739.478657347689;4778;4792.376990991183;4816.566509014188;4822.445418776833;4832.057748738997;4874.073925954058;4886.975565122188;4921.3110164577165;4953.876153096166;4867.610591152699;4900.754962251873;4908.0429316283335;4909.410870695504;4932.876678083041;4766.118268120409;4801.951980480186;4831.879203019917;4884.6092312615265;4927.088488629615;5185.611079169077;5244.318238628992;5251.816186433494;5277.788888444457;5322.680639161663;5633.80281690143;5633.887322253532;5634;5634.802781902655;5641.915371269434;5500.779968801243;5652.886942261173;5658.971705141489;5668.404817494186;5671.319441666985;5185.974070129663;5247.47525247476;5279.155335146358;5279.5512381447625;5325.281087053276;5745.310562732415;5752.597318187771;5758.3665796762325;5762.279715035621;5765.1928729977835;5425.457454254543;5481.177823326533;5493.23094766733;5538.363088244903;5610.831675049755;5587.106063029895;5674.829755107354;5678.659280443187;5682.431756824284;5730.856728581735;5446.945530544723;5488.533474654699;5553.944460555424;5554.750036248379;5643.322801263875;5553.194786755897;5557.194206839986;5565.916511252253;5587.972060139673;5597.972010139923;4335.1329734053315;4341.131773645284;4387.166438376698;4389.3635422864145;4391.297392417198;3824.3116239077235;3882.184741204322;3916.3929590913453;3924.0582260257333;3946.210757848442;5443.292371991616;5475.7262136893;5477.04151773438;5511.3937466878615;5520;5774;5774.624649397776;5782.392848750905;5788.392218817048;5790.652560846363;5272.868178295574;5316.627836051439;5398.811041613525;5408.432114627986;5419.187121931742;4801.615870730333;4837.467878533358;4838.250071238964;4871.634627402959;4954.133026720309;5915.1718759373725;5954.225950626391;5964.582479226499;5966.880662386815;5982.4914882234625;5559.11054231321;5625.071863142535;5655.943440565707;5692.800751973661;5692.857678558069;5855.677937713466;5867.20792692981;5885.588008839341;5907.172995780508;5945.34601193877;5543.445655434424;5561.555075593862;5572.247746554325;5573.721313934206;5594.860128496657;5386.919196211981;5411.621186516906;5663.320401551676;5705.800296989585;5706.229658995982;5276.129438642581;5318.920216196682;5326.227696983993;5331.786728530816;5334.706591137525;5298.231756395224;5330.573554115739;5335.813246536352;5337.492938170868;5338.706371149468;5321.414644389037;5326.573874089986;5329.067413202596;5330.147176451904;5336.626436149588;5339.332583427072;5376.650517716336;5378.784848606012;5378.97310513445;5387.2727181831515;5418.810341638024;5421.376541697755;5425;5425.294711687456;5452.836414907559 17:58:36 INFO - PROCESS | 23073 | |1;ext.html;581.1776336483875;606.7997560804935;626.0577830365299;632.9303477123658;648.5719425179383;45728.77135614322;48451;48594.27108593374;51495;51497;47545.286820697715;48001.51998480014;48079.75960120194;48145;48173.99999999991;8491.19333663301;8726.738197854074;8933.597988090536;9119.361644684876;9125.634974601007;10450.111740502067;10800.351978881254;10815.35107893525;11118.944405277962;11141;10851.565937362497;10925.781484370307;10932.070773984182;10934.343939363624;10938.671839844817;10825.783484330348;10837.512311945982;10926.180536459718;10942.13983622786;10945.671629851038;10702.892971070267;10747.677569672922;10757.246992710514;10758.569657213702;10762.892371076266;45455.54544454546;45809.770951145365;45935.31097033547;45943.31085033727;45969;4115.54728979812;4134.793260336971;4145;4155.439015732898;4168.166366726667;32967.83516082428;33355;33434.83282583596;33524.3295134096;34118;4360.803763830603;4402.185595664812;4507.188706032913;4604.608608268301;4656.254999200111;320667;322492;324430;326911;327882;56188.43811561914;57797.71101144468;60700.39299607036;64834.675826620565;65303;57969.71015144981;64821.351786482475;65136.34863651303;65161;65206;17140.142992850557;17280.395186168425;17327.480175594752;17344.82655173432;17352.219150138273;13148.40832162555;13222.471101155847;13237.669058273428;13370.26463544495;13371.866281337063;19356.90321548383;19438.05619438045;19470.641922726103;19540;19611.31360402379;7203.963980180066;7327.487075904742;7342.229065947999;7374;7516.624168791648;914.3005600715458;922.0456827183966;922.4327038871046;929.5166513413122;934.5981228071994;29099;31276.687233127832;31462.528062079087;31627.367452651277;32010.839945800588;997.6382238244888;1035.3684252605904;1080.989190108089;1090.3131027452655;1102.2725001498973;16343.770726428767;16586.83413165853;16799.91600041992;16824.915875420545;17074.743878841826;395343;398164;399010;399031;400117;60777.39222607806;61028.694856525435;61062;61286.38713612896;61391.38608613946;1416.7662335714697;1461.5834487171105;1471.9558413247619;1480.9259537023322;1493.925303734809;27170.592441113004;29673.406531869674;29831.552526711683;29969.850150749106;30459.695403045687;51228.74385628048;51838.22242666438;51890.74054629854;52011.21983170331;52020.479795201565;325919;327043;327333;328817;328953;40263.79868100641;40449.595504044584;41218.79390603028;41340;42832.78583607062;48971;49790.253146202114;50328.74835625799;50374.49625503698;50857.74571127121;40854;41419.378709319986;42854.78572607117;43230.135397292506;43589;41237.79381103075;41454.378184326655;41840.35155254124;42934.78532607317;42951.785241073594;40468.39297410482;40552.391714124904;40820.38769418521;41252.38121428121;41496.58503414927;33962.66037339694;35595.08454069999;35715.28569428649;36509.45235821518;36803;27006;27402.862985684944;27405;27413.31466713348;27443.862780686766 17:58:36 INFO - PROCESS | 23073 | |2;jquery.html;412.79979210083104;421.7996451685449;422.12198626856144;431.6978115319277;446.87264129723013;19924.302649407273;21491.355259342225;21856.672149917726;22084.668729969042;22094.779052209473;21265.787342126576;21350.145994160215;21573.568528629457;21692;22122.115115395405;5848.970755146218;6075.392460753911;6085.087236914476;6086.087086936951;6090.3909609038965;5780.797672081478;5828.446297601721;5969.522438204955;5996.760129594811;6007.429294217042;5956.731947062371;5970.73131709072;5973.1040343948325;5973.731182096816;5973.85065373367;5745.310562732478;5901.881962360751;5913.349531551526;5937.109433584954;5939.198208241897;5311.7344132793205;5325.840224793224;5327.653702509325;5327.866803329909;5349.384820745625;13767.862321376759;14484;14526.34631441577;14593.343299551545;20138.89930550338;2660.8935642574274;2714.348556346463;2717.266338088705;2790.9302267443477;2799.650043744532;6923.9960205769885;9323.627054917795;10910.454477276104;11285.379304138269;11349.694785099737;1880.125741530195;1898.3260942365537;1920.69268916974;1922.9615407691767;1927.4506765571884;98185;100498.49750751273;102675.48662256716;103867.48066259696;104069;11786.351750653796;11845.466953987092;12208.633740987785;12584.496620135274;12770.61688149357;16571.751423728652;16574.917125414537;16638.168091595373;16646;16649.16754162287;8398.328133749286;8572.442791218551;8712.564371781385;8908.821823563621;8926.598303076376;8238.464499807493;8280.668773249003;8328.541930193776;8535.701250456204;8547.145285471403;4972.801087956514;5051.646384753106;5090.669106508065;5116.130257856174;5541.196526503634;2081.8126368626895;2125.585510825374;2153.48316404065;2183.4323076000037;2197.121151539397;850.3834719828075;854.4958474500074;857.5712143928037;871.1158174452935;883.8497455432592;20713.171473141207;20998.16007359719;21005.36983890486;21395.121999770843;21479;869.3045563549261;873.7902903303161;874.7550685807984;884.2174675412307;886.1448702002598;10735.57057717698;11758.647240582795;11792.056635469142;11885.643430697093;11899.643010709693;639786;641345;652537;665156;667667;80237.59881200557;81904.59047704723;86087.96076411886;111105;114123;1035.171862510004;1062.4740753327153;1070.4701172919454;1074.6346242277664;1075.1936047964027;18055.729164062814;18919.243230270637;19165.616687666447;19194.13626386788;19337.903310483358;45221.32168017548;45654.77172614116;46248.537514624426;46365.768171158925;46423.76788116038;63824.68087659532;64002.35997639964;64422;65054.34945650483;66121.66939165273;9213.539323033687;9419;9461.716148515556;9563.426194428357;9738.805223895624;10629;14204.573862784133;14478.900559419037;14695;15175;11971.401429928643;11991.160618756603;12227.327496987751;12334.50661973547;12389.504419823466;11323.547058117583;11518.481668324777;11700.70748231301;11701.531938722355;11936.701582460508;11866.584669536525;11922.76154476923;12733;13135.277559734306;13186.142900711424;8031.867571647179;9232;9463;9531.952340238255;9721.659741909;10706.357618542912;12542.372881355714;12682.365881706062;12758.48966041348;13264.668383290495 17:58:36 INFO - PROCESS | 23073 | |3;mootools.html;1391.4434226309475;1411.8164638596993;1420.0414720063957;1426.5648977061994;1427.9000469967093;7874.527528348303;8361.247487726103;8369.330453563716;8371.121032291612;8377.664893404257;7836;8004.879926801103;8035.437519373646;8042.115367309591;8179.713710020151;2251.0545570860195;2309.983607212821;2319.3969567912295;2323.1172154581236;2324.5815753164425;2070.7929207079246;2129.9787002130015;2238.0935721033006;2286.8399212055165;2297.873616951067;2108.5888251790907;2131.8827464489445;2162.8810415427147;2221.9000144993515;2229.1863469833474;2252.279270633398;2256.2892688802976;2256.4922892349255;2260;2261.1294651559188;2202.0971401725374;2240.9215677451375;2246.9438264043365;2249.8200143988606;2251.3471093383064;8242.505449673039;8344.582770861432;8349.457285276438;8352.498850068954;8361.372897032747;5038.949610503884;5169.81905633301;5170.095233334189;5170.870728231786;5178.482151784791;3291.325278317939;3374.183841895383;3389.2713066690535;3467.7919324840336;3497.737669674759;1390.1520072755611;1392.2829742682527;1402.7825687018528;1404.4171668757454;1427.978580321296;10790.298630588986;10948.781024379468;10962.616308429167;10979;11003.779924401548;4335.28467802809;4547.567981041796;4555.498895121534;4594.908101837945;4622.352870598119;9562.904370956201;9582.472963987047;9586.760330991781;9587.328886977984;9618.086281803357;5230.137027390514;5233.738313084331;5234.214867769789;5237.711925844115;5240.711760853113;4580.541945805393;4668.183067963093;4749.786259618326;4789.568938795525;4842.297866809364;3830.157365379612;3833.195029043932;3884.6309600587897;3939.8424063037733;3981.5023122109737;1290.1613950931783;1315.283170671986;1330.7405056014177;1342.0203251626367;1343.355189509041;930.1767935377104;944.6882528765628;949.9477528735848;950.4724877692947;975.7121649113528;5307.4692530746615;5443;5526.613137080446;5591.133374326986;5695.800646977336;628.6196850905228;638.0684201066495;638.2022471910112;639.9936000639934;643.112504743451;3672;3679.889603311905;3705;3708.1841994761107;3805.2009078093356;9135.680251191176;9476.905230947741;9529.237660987104;9587.664431744855;9592.760180995392;9574.712758617252;9588.90411095894;9594.712158635251;9609.807803844024;9613.951930240444;7470.551766893895;7543.283388078124;7566.092068951651;7566.205548417447;7632.24458374577;5279.762410691605;5283.920741188962;5329.704317703823;5414;5520.199571062254;8818.559072046244;8821.647134114564;8829.072947340694;8837.734867953972;8885.200331969894;8642.22220000178;8938.910610893809;9024;9047.547622618975;9295.256379489489;7176.677049532679;7261.818454538467;7298.160711518243;7312.634368281459;7324.81687957784;7694.538327700356;7773;7816.57008864518;7820.726274580363;7835.098963619257;6982.538660115673;6998.720051197895;7143.535670181422;7235.457340699574;7248.0939882514685;6847.965760171167;6904.654767261717;6909.136357955255;6976.616286104313;7170;6174.722137503733;6290.779822706183;6299.055141728594;6299.6535190564955;6303.495720342454;4813.278008298643;4960.330355402119;5079.415867175175;5084.466131056334;5156.716380598953;4830.227163653799;4968.453470118212;4981.227909674007;5084.745762711776;5103.617228707936 17:58:36 INFO - PROCESS | 23073 | |4;prototype.html;379.28504768511345;392.97642141471516;410.20625090449977;415.362418687315;417.5573891674825;4969.950300496994;5132.6920384776895;5203.245529398235;5217.895642087156;5217.92173117403;4958.033183529214;5160.942006888588;5167.302414174085;5168.431472538027;5181.5854731621475;4132.2768515509815;4133.173365326931;4144.48193975753;4144.8963775905695;4154.501459824825;3938.9803050984847;4062.248484030449;4156.875293741177;4164.854230101947;4172;3970.900727481822;4030.758154510724;4044.2720310344125;4095.508538975312;4101.712880098395;4115.629593336614;4119.382092686091;4120.299549076634;4124.896877578055;4127.7936103195025;3659.8170091495317;3667.431548110047;3668.413053911388;3671.1739858531882;3678.393065144248;4898.338724272213;5049.873753156164;5055.241713742931;5077.517635824591;5077.543021128116;4675.485696573374;4693.296005599153;4705.894114883;4711.293306004092;4740.834070807539;5432.397442754397;5479.972600136974;5490.752916118744;5493.285872836545;5509.641873278224;3811.8856434307013;4011.6389524942897;4033.9596604033877;4040.979795101035;4043.555208927016;5647.887042259173;5656.43435656431;5666.433356664342;5687.175359572881;5697.373288938214;4123.134141830189;4135.152293779768;4148.253314403376;4151.301653924913;4162.271602469556;3909.3354129798004;3979.5622481527007;4209.852655157055;4219.662427005832;4228.3446065859225;4549.931751023737;4575.055601369405;4662.323963025342;4664.790084446208;4675.953240467552;5494.36814766299;5495.477929596682;5497.147942068986;5498.268045565634;5511.988124334589;1351.5403364366462;1381.067779249023;1391.3877893726728;1395.5534229046812;1426.587678198576;987.7975015121883;988.945607991553;992.9304948653669;992.93545919515;1005.7334806276342;5104.770285337168;5158.174692049329;5169.560587350042;5174.818881339211;5198.818041368534;5529.170624406291;5541.418151094158;5548.361938377057;5554.111342185231;5564.8330550083565;4968.583953573287;5207.218917162456;5215.191645294985;5233.71214583194;5267.209918512177;2904.5207540755537;2918.2266699324696;2918.2266699324696;2921.1674672718173;2929.2383980164886;5429.783698780465;5715.514181294553;5725.2843394575675;5741.081426971665;5765.308163020464;5564.916526252109;5568.276124103922;5588.2455868458055;5597.720113994284;5619.381867994517;5659.405762394971;5701.914471283017;5702.030654788696;5717.285339332583;5721.227634269404;5219.19102539107;5349.304590403222;5394.460553944574;5396.7587454884815;5413.918791218056;5369.570434365163;5376.489233522809;5377.784888604412;5377.919331209957;5390.622656414013;5343.096963809778;5533.280673512418;5638.379778224474;5647.915281270866;5664.376918538875;3977.7812220327;4007.4352414455357;4041.1513582148077;4042.6563742081075;4050.4531888194715;5364.436734143015;5425.321834770653;5460.863478412913;5496.51594069591;5579.4978451937895;5392.191171324333;5414.458554144554;5418.945810541844;5481.766602514403;5487.6981766003255;5430.83707488776;5451.873769230083;5455.7997240607;5470.288862447856;5478.90441900341;5172.922406163986;5356.1697936819855;5397.217403476552;5413.40452550227;5456.290682211287;5466.933947880125;5472.179173124063;5498.340199176125;5503.532199763065;5508.228847961209;5188.377394712658;5314.548263397654;5335.546478549211;5340.118880384693;5359.946400535945 17:58:36 INFO - PROCESS | 23073 | |5;yui.html;763.3015790551646;775.2325198053928;790.4782843323404;837.4347315561995;891.0777345447461;15104.169270690109;15131.470398536054;15255.923720381397;15294.847051529481;16100.033997960116;15278.541643750677;15279.388824447009;15439.536813895573;15534.145621990787;15939.123348215844;720.394868310619;732.8131326511746;746.8917007033976;748.0275641665839;749.4004796163075;748.4760667532722;757.6249756370604;758.3364556013488;758.9127250366223;759.5404780108038;776.5767656627152;778.4511919097023;780.6994307191744;782.9647665855022;784.7802615267734;779.6296759039411;779.8011507065719;780.2158830375494;780.8360244348694;781.0081196879987;572.1503567202701;572.9111987641922;573.1030936584274;573.3292048303495;573.4151165810849;15017.324220410108;15017.624559385993;15028.549143525603;15657.451989180325;17306.394276200273;15427.5371738848;15619.375224990987;15942.920285398615;15953;16072.919635401748;11981.460834262392;11984.880151198551;12556.497740090386;12651.240925544405;12764.297963611998;4510.481294651125;4523.158051838204;4545.340925565807;4780.4741478437345;4786.64100192487;80788;82167.5891620538;82703.17296827016;83179.16820831774;83674.16325836786;11049.558017679203;11347.773044539228;11534.192606517463;11567.942160289145;11659;21064.15743370248;21127.683084753742;21176.15295388198;21404.78595214028;21432.571348573252;8092.514449132953;8105.230003149692;8139.43023988327;8254.711085112112;8385.454945428528;4272.636825869836;4279.550647182064;4306.031142992864;4333.523312435629;4444.688871778944;3372.1232479555;3441.690247877653;3514;3541.11472131967;3551.7691350062164;590.8995470769979;593.8723174517413;598.0341748076911;601.8585632376388;649.7433513762038;752.3905636434506;757.7082823113141;786.7993661616251;788.6450997725494;796.665400531778;9943.80112397748;10727.19546034035;10933.234673572773;11054.447277636085;11253.15601329887;756.6784116750359;759.0284435922028;763.8854171874264;767.4742801181209;777.1878387085509;4957.256411538298;5176.223566465061;5222.660527065728;5224.764885580158;5228.686278823283;75428.62285688537;75549.0234306644;79377;79910.20089799027;81907.5904620473;66577.66711166414;67181.32818671751;67631.66184169146;68021;71094.28905710876;53843;56103.438965610636;58844.41155588475;59066.40933590695;61471.38528614746;10473.895261047597;10983.725406864893;11085.7805641381;11373.20387572862;11376.54493820238;40554;41083.383749243185;41209.75804839104;41286.1742765149;41954.580454195064;48603.756981214865;50155.24767128569;55469;55985.72007139938;57405;13144.868551314365;13153.473861045833;13211.471541138631;13476.93261533686;14056.226907520184;14704.338304776526;15076.849231507544;15765.605859853595;16100.516984490485;16187.352505899633;13578.592642220749;14138.575842724735;14259.786103208668;14493.492727754478;14516.346764395415;14038.654130730287;14094.647633809236;14346.856531434969;14768.778468323198;14801.92599037041;14169.858301416854;14256.786148207993;14977.925110374379;15006.099634021994;15035.323410446776;10903.890961090288;10920.283225267221;11061.668149955514;11183.161262905152;11395.373254471084;10577;10606.575736970435;10654.200934929757;10686.679399618024;10706.357618542912 17:58:36 INFO - PROCESS | 23073 | __end_tp_report 17:58:36 INFO - PROCESS | 23073 | __start_cc_report 17:58:36 INFO - PROCESS | 23073 | _x_x_mozilla_cycle_collect,2241 17:58:36 INFO - PROCESS | 23073 | __end_cc_report 17:58:36 INFO - PROCESS | 23073 | __startTimestamp1486087116526__endTimestamp 17:58:36 INFO - PROCESS | 23073 | 17:58:36 INFO - PROCESS | 23073 | ------- Summary: start ------- 17:58:36 INFO - PROCESS | 23073 | Number of tests: 6 17:58:36 INFO - PROCESS | 23073 | 17:58:36 INFO - PROCESS | 23073 | [#0] dojo.html Cycles:165 Average:5239.31 Median:5339.33 stddev:570.57 (10.7%) stddev-sans-first:547.84 17:58:36 INFO - PROCESS | 23073 | Values: 3131.5 3147.7 3163.2 3179.9 3203.5 5150.9 5214.0 5267.6 5281.1 5293.4 5162.1 5234.3 5246.1 5279.8 5309.2 4545.7 4734.4 4908.7 4921.6 4936.1 4739.5 4778.0 4792.4 4816.6 4822.4 4832.1 4874.1 4887.0 4921.3 4953.9 4867.6 4900.8 4908.0 4909.4 4932.9 4766.1 4802.0 4831.9 4884.6 4927.1 5185.6 5244.3 5251.8 5277.8 5322.7 5633.8 5633.9 5634.0 5634.8 5641.9 5500.8 5652.9 5659.0 5668.4 5671.3 5186.0 5247.5 5279.2 5279.6 5325.3 5745.3 5752.6 5758.4 5762.3 5765.2 5425.5 5481.2 5493.2 5538.4 5610.8 5587.1 5674.8 5678.7 5682.4 5730.9 5446.9 5488.5 5553.9 5554.8 5643.3 5553.2 5557.2 5565.9 5588.0 5598.0 4335.1 4341.1 4387.2 4389.4 4391.3 3824.3 3882.2 3916.4 3924.1 3946.2 5443.3 5475.7 5477.0 5511.4 5520.0 5774.0 5774.6 5782.4 5788.4 5790.7 5272.9 5316.6 5398.8 5408.4 5419.2 4801.6 4837.5 4838.3 4871.6 4954.1 5915.2 5954.2 5964.6 5966.9 5982.5 5559.1 5625.1 5655.9 5692.8 5692.9 5855.7 5867.2 5885.6 5907.2 5945.3 5543.4 5561.6 5572.2 5573.7 5594.9 5386.9 5411.6 5663.3 5705.8 5706.2 5276.1 5318.9 5326.2 5331.8 5334.7 5298.2 5330.6 5335.8 5337.5 5338.7 5321.4 5326.6 5329.1 5330.1 5336.6 5339.3 5376.7 5378.8 5379.0 5387.3 5418.8 5421.4 5425.0 5425.3 5452.8 17:58:36 INFO - PROCESS | 23073 | 17:58:36 INFO - PROCESS | 23073 | [#1] ext.html Cycles:180 Average:53994.06 Median:40458.99 stddev:92087.19 (227.6%) stddev-sans-first:92258.19 17:58:36 INFO - PROCESS | 23073 | Values: 581.2 606.8 626.1 632.9 648.6 45728.8 48451.0 48594.3 51495.0 51497.0 47545.3 48001.5 48079.8 48145.0 48174.0 8491.2 8726.7 8933.6 9119.4 9125.6 10450.1 10800.4 10815.4 11118.9 11141.0 10851.6 10925.8 10932.1 10934.3 10938.7 10825.8 10837.5 10926.2 10942.1 10945.7 10702.9 10747.7 10757.2 10758.6 10762.9 45455.5 45809.8 45935.3 45943.3 45969.0 4115.5 4134.8 4145.0 4155.4 4168.2 32967.8 33355.0 33434.8 33524.3 34118.0 4360.8 4402.2 4507.2 4604.6 4656.3 320667.0 322492.0 324430.0 326911.0 327882.0 56188.4 57797.7 60700.4 64834.7 65303.0 57969.7 64821.4 65136.3 65161.0 65206.0 17140.1 17280.4 17327.5 17344.8 17352.2 13148.4 13222.5 13237.7 13370.3 13371.9 19356.9 19438.1 19470.6 19540.0 19611.3 7204.0 7327.5 7342.2 7374.0 7516.6 914.3 922.0 922.4 929.5 934.6 29099.0 31276.7 31462.5 31627.4 32010.8 997.6 1035.4 1081.0 1090.3 1102.3 16343.8 16586.8 16799.9 16824.9 17074.7 395343.0 398164.0 399010.0 399031.0 400117.0 60777.4 61028.7 61062.0 61286.4 61391.4 1416.8 1461.6 1472.0 1480.9 1493.9 27170.6 29673.4 29831.6 29969.9 30459.7 51228.7 51838.2 51890.7 52011.2 52020.5 325919.0 327043.0 327333.0 328817.0 328953.0 40263.8 40449.6 41218.8 41340.0 42832.8 48971.0 49790.3 50328.7 50374.5 50857.7 40854.0 41419.4 42854.8 43230.1 43589.0 41237.8 41454.4 41840.4 42934.8 42951.8 40468.4 40552.4 40820.4 41252.4 41496.6 33962.7 35595.1 35715.3 36509.5 36803.0 27006.0 27402.9 27405.0 27413.3 27443.9 17:58:36 INFO - PROCESS | 23073 | 17:58:36 INFO - PROCESS | 23073 | [#2] jquery.html Cycles:180 Average:34785.87 Median:2715.81 stddev:107434.00 (3955.9%) stddev-sans-first:107704.37 17:58:36 INFO - PROCESS | 23073 | Values: 412.8 421.8 422.1 431.7 446.9 19924.3 21491.4 21856.7 22084.7 22094.8 21265.8 21350.1 21573.6 21692.0 22122.1 5849.0 6075.4 6085.1 6086.1 6090.4 5780.8 5828.4 5969.5 5996.8 6007.4 5956.7 5970.7 5973.1 5973.7 5973.9 5745.3 5901.9 5913.3 5937.1 5939.2 5311.7 5325.8 5327.7 5327.9 5349.4 13767.9 14484.0 14526.3 14593.3 20138.9 2660.9 2714.3 2717.3 2790.9 2799.7 6924.0 9323.6 10910.5 11285.4 11349.7 1880.1 1898.3 1920.7 1923.0 1927.5 98185.0 100498.5 102675.5 103867.5 104069.0 11786.4 11845.5 12208.6 12584.5 12770.6 16571.8 16574.9 16638.2 16646.0 16649.2 8398.3 8572.4 8712.6 8908.8 8926.6 8238.5 8280.7 8328.5 8535.7 8547.1 4972.8 5051.6 5090.7 5116.1 5541.2 2081.8 2125.6 2153.5 2183.4 2197.1 850.4 854.5 857.6 871.1 883.8 20713.2 20998.2 21005.4 21395.1 21479.0 869.3 873.8 874.8 884.2 886.1 10735.6 11758.6 11792.1 11885.6 11899.6 639786.0 641345.0 652537.0 665156.0 667667.0 80237.6 81904.6 86088.0 111105.0 114123.0 1035.2 1062.5 1070.5 1074.6 1075.2 18055.7 18919.2 19165.6 19194.1 19337.9 45221.3 45654.8 46248.5 46365.8 46423.8 63824.7 64002.4 64422.0 65054.3 66121.7 9213.5 9419.0 9461.7 9563.4 9738.8 10629.0 14204.6 14478.9 14695.0 15175.0 11971.4 11991.2 12227.3 12334.5 12389.5 11323.5 11518.5 11700.7 11701.5 11936.7 11866.6 11922.8 12733.0 13135.3 13186.1 8031.9 9232.0 9463.0 9532.0 9721.7 10706.4 12542.4 12682.4 12758.5 13264.7 17:58:36 INFO - PROCESS | 23073 | 17:58:36 INFO - PROCESS | 23073 | [#3] mootools.html Cycles:180 Average:5373.83 Median:5281.84 stddev:2907.97 (55.1%) stddev-sans-first:2900.72 17:58:36 INFO - PROCESS | 23073 | Values: 1391.4 1411.8 1420.0 1426.6 1427.9 7874.5 8361.2 8369.3 8371.1 8377.7 7836.0 8004.9 8035.4 8042.1 8179.7 2251.1 2310.0 2319.4 2323.1 2324.6 2070.8 2130.0 2238.1 2286.8 2297.9 2108.6 2131.9 2162.9 2221.9 2229.2 2252.3 2256.3 2256.5 2260.0 2261.1 2202.1 2240.9 2246.9 2249.8 2251.3 8242.5 8344.6 8349.5 8352.5 8361.4 5038.9 5169.8 5170.1 5170.9 5178.5 3291.3 3374.2 3389.3 3467.8 3497.7 1390.2 1392.3 1402.8 1404.4 1428.0 10790.3 10948.8 10962.6 10979.0 11003.8 4335.3 4547.6 4555.5 4594.9 4622.4 9562.9 9582.5 9586.8 9587.3 9618.1 5230.1 5233.7 5234.2 5237.7 5240.7 4580.5 4668.2 4749.8 4789.6 4842.3 3830.2 3833.2 3884.6 3939.8 3981.5 1290.2 1315.3 1330.7 1342.0 1343.4 930.2 944.7 949.9 950.5 975.7 5307.5 5443.0 5526.6 5591.1 5695.8 628.6 638.1 638.2 640.0 643.1 3672.0 3679.9 3705.0 3708.2 3805.2 9135.7 9476.9 9529.2 9587.7 9592.8 9574.7 9588.9 9594.7 9609.8 9614.0 7470.6 7543.3 7566.1 7566.2 7632.2 5279.8 5283.9 5329.7 5414.0 5520.2 8818.6 8821.6 8829.1 8837.7 8885.2 8642.2 8938.9 9024.0 9047.5 9295.3 7176.7 7261.8 7298.2 7312.6 7324.8 7694.5 7773.0 7816.6 7820.7 7835.1 6982.5 6998.7 7143.5 7235.5 7248.1 6848.0 6904.7 6909.1 6976.6 7170.0 6174.7 6290.8 6299.1 6299.7 6303.5 4813.3 4960.3 5079.4 5084.5 5156.7 4830.2 4968.5 4981.2 5084.7 5103.6 17:58:36 INFO - PROCESS | 23073 | 17:58:36 INFO - PROCESS | 23073 | [#4] prototype.html Cycles:180 Average:4583.55 Median:5201.03 stddev:1310.25 (25.2%) stddev-sans-first:1275.36 17:58:36 INFO - PROCESS | 23073 | Values: 379.3 393.0 410.2 415.4 417.6 4970.0 5132.7 5203.2 5217.9 5217.9 4958.0 5160.9 5167.3 5168.4 5181.6 4132.3 4133.2 4144.5 4144.9 4154.5 3939.0 4062.2 4156.9 4164.9 4172.0 3970.9 4030.8 4044.3 4095.5 4101.7 4115.6 4119.4 4120.3 4124.9 4127.8 3659.8 3667.4 3668.4 3671.2 3678.4 4898.3 5049.9 5055.2 5077.5 5077.5 4675.5 4693.3 4705.9 4711.3 4740.8 5432.4 5480.0 5490.8 5493.3 5509.6 3811.9 4011.6 4034.0 4041.0 4043.6 5647.9 5656.4 5666.4 5687.2 5697.4 4123.1 4135.2 4148.3 4151.3 4162.3 3909.3 3979.6 4209.9 4219.7 4228.3 4549.9 4575.1 4662.3 4664.8 4676.0 5494.4 5495.5 5497.1 5498.3 5512.0 1351.5 1381.1 1391.4 1395.6 1426.6 987.8 988.9 992.9 992.9 1005.7 5104.8 5158.2 5169.6 5174.8 5198.8 5529.2 5541.4 5548.4 5554.1 5564.8 4968.6 5207.2 5215.2 5233.7 5267.2 2904.5 2918.2 2918.2 2921.2 2929.2 5429.8 5715.5 5725.3 5741.1 5765.3 5564.9 5568.3 5588.2 5597.7 5619.4 5659.4 5701.9 5702.0 5717.3 5721.2 5219.2 5349.3 5394.5 5396.8 5413.9 5369.6 5376.5 5377.8 5377.9 5390.6 5343.1 5533.3 5638.4 5647.9 5664.4 3977.8 4007.4 4041.2 4042.7 4050.5 5364.4 5425.3 5460.9 5496.5 5579.5 5392.2 5414.5 5418.9 5481.8 5487.7 5430.8 5451.9 5455.8 5470.3 5478.9 5172.9 5356.2 5397.2 5413.4 5456.3 5466.9 5472.2 5498.3 5503.5 5508.2 5188.4 5314.5 5335.5 5340.1 5359.9 17:58:36 INFO - PROCESS | 23073 | 17:58:36 INFO - PROCESS | 23073 | [#5] yui.html Cycles:180 Average:17700.71 Median:4292.79 stddev:22197.04 (517.1%) stddev-sans-first:22222.87 17:58:36 INFO - PROCESS | 23073 | Values: 763.3 775.2 790.5 837.4 891.1 15104.2 15131.5 15255.9 15294.8 16100.0 15278.5 15279.4 15439.5 15534.1 15939.1 720.4 732.8 746.9 748.0 749.4 748.5 757.6 758.3 758.9 759.5 776.6 778.5 780.7 783.0 784.8 779.6 779.8 780.2 780.8 781.0 572.2 572.9 573.1 573.3 573.4 15017.3 15017.6 15028.5 15657.5 17306.4 15427.5 15619.4 15942.9 15953.0 16072.9 11981.5 11984.9 12556.5 12651.2 12764.3 4510.5 4523.2 4545.3 4780.5 4786.6 80788.0 82167.6 82703.2 83179.2 83674.2 11049.6 11347.8 11534.2 11567.9 11659.0 21064.2 21127.7 21176.2 21404.8 21432.6 8092.5 8105.2 8139.4 8254.7 8385.5 4272.6 4279.6 4306.0 4333.5 4444.7 3372.1 3441.7 3514.0 3541.1 3551.8 590.9 593.9 598.0 601.9 649.7 752.4 757.7 786.8 788.6 796.7 9943.8 10727.2 10933.2 11054.4 11253.2 756.7 759.0 763.9 767.5 777.2 4957.3 5176.2 5222.7 5224.8 5228.7 75428.6 75549.0 79377.0 79910.2 81907.6 66577.7 67181.3 67631.7 68021.0 71094.3 53843.0 56103.4 58844.4 59066.4 61471.4 10473.9 10983.7 11085.8 11373.2 11376.5 40554.0 41083.4 41209.8 41286.2 41954.6 48603.8 50155.2 55469.0 55985.7 57405.0 13144.9 13153.5 13211.5 13476.9 14056.2 14704.3 15076.8 15765.6 16100.5 16187.4 13578.6 14138.6 14259.8 14493.5 14516.3 14038.7 14094.6 14346.9 14768.8 14801.9 14169.9 14256.8 14977.9 15006.1 15035.3 10903.9 10920.3 11061.7 11183.2 11395.4 10577.0 10606.6 10654.2 10686.7 10706.4 17:58:36 INFO - PROCESS | 23073 | -------- Summary: end -------- 17:58:36 INFO - PROCESS | 23073 | 17:58:37 INFO - TEST-INFO | 23073: exit 0 17:58:37 INFO - TEST-OK | dromaeo_css | took 1114956ms 17:58:37 INFO - TEST-START | kraken 17:58:37 INFO - operating with platform_type : linux_ 17:58:37 INFO - Initialising browser for kraken test... 17:58:37 INFO - TEST-INFO | started process 23371 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcYZ3Qo/profile http://localhost:46491/getInfo.html) 17:58:40 INFO - PROCESS | 23371 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 17:58:40 INFO - PROCESS | 23371 | __metrics Screen width/height:1600/1200 17:58:40 INFO - PROCESS | 23371 | colorDepth:24 17:58:40 INFO - PROCESS | 23371 | Browser inner width/height: 1024/697 17:58:40 INFO - PROCESS | 23371 | __metrics 17:58:41 INFO - PROCESS | 23371 | 1486087121344 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < canQuitApplication@quit.js:67:3 < goQuitApplication@quit.js:109:8 < whenDone@quit.js:100:7 < promise callback*goQuitApplication@quit.js:103:5 < onload@getInfo.html:7:5 17:58:41 INFO - PROCESS | 23371 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:58:41 INFO - PROCESS | 23371 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:58:41 INFO - PROCESS | 23371 | console.error: PushService: 17:58:41 INFO - PROCESS | 23371 | stateChangeProcessEnqueue: Error transitioning state 17:58:41 INFO - PROCESS | 23371 | UnknownError 17:58:42 INFO - TEST-INFO | 23371: exit 0 17:58:42 INFO - Browser initialized. 17:58:42 INFO - Running cycle 1/1 for kraken test... 17:58:42 INFO - TEST-INFO | started process 23455 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcYZ3Qo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:58:54 INFO - PROCESS | 23455 | RSS: Main: 149159936 17:58:54 INFO - PROCESS | 23455 | 17:58:57 INFO - PROCESS | 23455 | Cycle 1(1): loaded http://localhost:46491/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46491/tests/kraken/driver.html?testName=audio-beat-detection) 17:58:57 INFO - PROCESS | 23455 | RSS: Main: 204877824 17:58:57 INFO - PROCESS | 23455 | 17:59:00 INFO - PROCESS | 23455 | Cycle 1(1): loaded http://localhost:46491/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46491/tests/kraken/driver.html?testName=audio-dft) 17:59:01 INFO - PROCESS | 23455 | RSS: Main: 183889920 17:59:01 INFO - PROCESS | 23455 | 17:59:04 INFO - PROCESS | 23455 | Cycle 1(1): loaded http://localhost:46491/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46491/tests/kraken/driver.html?testName=audio-fft) 17:59:04 INFO - PROCESS | 23455 | RSS: Main: 266059776 17:59:04 INFO - PROCESS | 23455 | 17:59:06 INFO - PROCESS | 23455 | Cycle 1(1): loaded http://localhost:46491/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46491/tests/kraken/driver.html?testName=audio-oscillator) 17:59:07 INFO - PROCESS | 23455 | RSS: Main: 176259072 17:59:07 INFO - PROCESS | 23455 | 17:59:09 INFO - PROCESS | 23455 | Cycle 1(1): loaded http://localhost:46491/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46491/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:59:10 INFO - PROCESS | 23455 | RSS: Main: 180895744 17:59:10 INFO - PROCESS | 23455 | 17:59:13 INFO - PROCESS | 23455 | Cycle 1(1): loaded http://localhost:46491/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46491/tests/kraken/driver.html?testName=imaging-darkroom) 17:59:13 INFO - PROCESS | 23455 | RSS: Main: 220229632 17:59:13 INFO - PROCESS | 23455 | 17:59:17 INFO - PROCESS | 23455 | Cycle 1(1): loaded http://localhost:46491/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46491/tests/kraken/driver.html?testName=imaging-desaturate) 17:59:17 INFO - PROCESS | 23455 | RSS: Main: 219779072 17:59:17 INFO - PROCESS | 23455 | 17:59:20 INFO - PROCESS | 23455 | Cycle 1(1): loaded http://localhost:46491/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46491/tests/kraken/driver.html?testName=json-parse-financial) 17:59:21 INFO - PROCESS | 23455 | RSS: Main: 218361856 17:59:21 INFO - PROCESS | 23455 | 17:59:22 INFO - PROCESS | 23455 | Cycle 1(1): loaded http://localhost:46491/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46491/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:59:23 INFO - PROCESS | 23455 | RSS: Main: 181104640 17:59:23 INFO - PROCESS | 23455 | 17:59:24 INFO - PROCESS | 23455 | Cycle 1(1): loaded http://localhost:46491/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46491/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:59:25 INFO - PROCESS | 23455 | RSS: Main: 188387328 17:59:25 INFO - PROCESS | 23455 | 17:59:27 INFO - PROCESS | 23455 | Cycle 1(1): loaded http://localhost:46491/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46491/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:59:28 INFO - PROCESS | 23455 | RSS: Main: 196837376 17:59:28 INFO - PROCESS | 23455 | 17:59:30 INFO - PROCESS | 23455 | Cycle 1(1): loaded http://localhost:46491/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46491/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:59:31 INFO - PROCESS | 23455 | RSS: Main: 206327808 17:59:31 INFO - PROCESS | 23455 | 17:59:34 INFO - PROCESS | 23455 | Cycle 1(1): loaded http://localhost:46491/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46491/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:59:34 INFO - PROCESS | 23455 | RSS: Main: 202719232 17:59:34 INFO - PROCESS | 23455 | 17:59:36 INFO - PROCESS | 23455 | Cycle 1(1): loaded http://localhost:46491/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46491/tests/kraken/driver.html?testName=ai-astar) 17:59:36 INFO - PROCESS | 23455 | RSS: Main: 254545920 17:59:36 INFO - PROCESS | 23455 | 17:59:36 INFO - PROCESS | 23455 | __start_tp_report 17:59:36 INFO - PROCESS | 23455 | _x_x_mozilla_page_load 17:59:36 INFO - PROCESS | 23455 | _x_x_mozilla_page_load_details 17:59:36 INFO - PROCESS | 23455 | |i|pagename|runs| 17:59:36 INFO - PROCESS | 23455 | |0;ai-astar;110;113;114;113;119;113;111;114;113;113 17:59:36 INFO - PROCESS | 23455 | |1;audio-beat-detection;155;118;118;155;125;119;119;121;148;118 17:59:36 INFO - PROCESS | 23455 | |2;audio-dft;161;160;160;161;163;161;162;162;163;161 17:59:36 INFO - PROCESS | 23455 | |3;audio-fft;75;74;78;107;76;75;77;76;98;77 17:59:36 INFO - PROCESS | 23455 | |4;audio-oscillator;94;83;102;83;83;84;95;83;83;110 17:59:36 INFO - PROCESS | 23455 | |5;imaging-gaussian-blur;118;118;118;117;118;117;117;118;116;117 17:59:36 INFO - PROCESS | 23455 | |6;imaging-darkroom;146;146;146;146;146;147;147;147;146;147 17:59:36 INFO - PROCESS | 23455 | |7;imaging-desaturate;97;96;96;95;96;96;96;95;95;96 17:59:36 INFO - PROCESS | 23455 | |8;json-parse-financial;56;53;55;54;56;59;55;55;56;56 17:59:36 INFO - PROCESS | 23455 | |9;json-stringify-tinderbox;66;66;67;67;68;67;67;67;67;68 17:59:36 INFO - PROCESS | 23455 | |10;stanford-crypto-aes;95;88;81;81;81;82;82;81;80;80 17:59:36 INFO - PROCESS | 23455 | |11;stanford-crypto-ccm;126;134;125;140;128;125;132;125;157;134 17:59:36 INFO - PROCESS | 23455 | |12;stanford-crypto-pbkdf2;176;179;169;170;174;177;169;171;164;166 17:59:36 INFO - PROCESS | 23455 | |13;stanford-crypto-sha256-iterative;64;65;62;63;62;64;63;63;70;61 17:59:36 INFO - PROCESS | 23455 | __end_tp_report 17:59:36 INFO - PROCESS | 23455 | __start_cc_report 17:59:36 INFO - PROCESS | 23455 | _x_x_mozilla_cycle_collect,1617 17:59:36 INFO - PROCESS | 23455 | __end_cc_report 17:59:36 INFO - PROCESS | 23455 | __startTimestamp1486087176917__endTimestamp 17:59:36 INFO - PROCESS | 23455 | 17:59:36 INFO - PROCESS | 23455 | ------- Summary: start ------- 17:59:36 INFO - PROCESS | 23455 | Number of tests: 14 17:59:36 INFO - PROCESS | 23455 | 17:59:36 INFO - PROCESS | 23455 | [#0] ai-astar Cycles:10 Average:113.30 Median:113.00 stddev:2.36 (2.1%) stddev-sans-first:2.18 17:59:36 INFO - PROCESS | 23455 | Values: 110.0 113.0 114.0 113.0 119.0 113.0 111.0 114.0 113.0 113.0 17:59:36 INFO - PROCESS | 23455 | 17:59:36 INFO - PROCESS | 23455 | [#1] audio-beat-detection Cycles:10 Average:129.60 Median:123.00 stddev:16.17 (13.1%) stddev-sans-first:14.30 17:59:36 INFO - PROCESS | 23455 | Values: 155.0 118.0 118.0 155.0 125.0 119.0 119.0 121.0 148.0 118.0 17:59:36 INFO - PROCESS | 23455 | 17:59:36 INFO - PROCESS | 23455 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.07 (0.7%) stddev-sans-first:1.13 17:59:36 INFO - PROCESS | 23455 | Values: 161.0 160.0 160.0 161.0 163.0 161.0 162.0 162.0 163.0 161.0 17:59:36 INFO - PROCESS | 23455 | 17:59:36 INFO - PROCESS | 23455 | [#3] audio-fft Cycles:10 Average:81.30 Median:76.50 stddev:11.43 (14.9%) stddev-sans-first:11.90 17:59:36 INFO - PROCESS | 23455 | Values: 75.0 74.0 78.0 107.0 76.0 75.0 77.0 76.0 98.0 77.0 17:59:36 INFO - PROCESS | 23455 | 17:59:36 INFO - PROCESS | 23455 | [#4] audio-oscillator Cycles:10 Average:90.00 Median:83.00 stddev:9.81 (11.8%) stddev-sans-first:10.30 17:59:36 INFO - PROCESS | 23455 | Values: 94.0 83.0 102.0 83.0 83.0 84.0 95.0 83.0 83.0 110.0 17:59:36 INFO - PROCESS | 23455 | 17:59:36 INFO - PROCESS | 23455 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 17:59:36 INFO - PROCESS | 23455 | Values: 118.0 118.0 118.0 117.0 118.0 117.0 117.0 118.0 116.0 117.0 17:59:36 INFO - PROCESS | 23455 | 17:59:36 INFO - PROCESS | 23455 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 17:59:36 INFO - PROCESS | 23455 | Values: 146.0 146.0 146.0 146.0 146.0 147.0 147.0 147.0 146.0 147.0 17:59:36 INFO - PROCESS | 23455 | 17:59:36 INFO - PROCESS | 23455 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 17:59:36 INFO - PROCESS | 23455 | Values: 97.0 96.0 96.0 95.0 96.0 96.0 96.0 95.0 95.0 96.0 17:59:36 INFO - PROCESS | 23455 | 17:59:36 INFO - PROCESS | 23455 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:56.00 stddev:1.58 (2.8%) stddev-sans-first:1.67 17:59:36 INFO - PROCESS | 23455 | Values: 56.0 53.0 55.0 54.0 56.0 59.0 55.0 55.0 56.0 56.0 17:59:36 INFO - PROCESS | 23455 | 17:59:36 INFO - PROCESS | 23455 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 17:59:36 INFO - PROCESS | 23455 | Values: 66.0 66.0 67.0 67.0 68.0 67.0 67.0 67.0 67.0 68.0 17:59:36 INFO - PROCESS | 23455 | 17:59:36 INFO - PROCESS | 23455 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:81.50 stddev:4.77 (5.9%) stddev-sans-first:2.44 17:59:36 INFO - PROCESS | 23455 | Values: 95.0 88.0 81.0 81.0 81.0 82.0 82.0 81.0 80.0 80.0 17:59:36 INFO - PROCESS | 23455 | 17:59:36 INFO - PROCESS | 23455 | [#11] stanford-crypto-ccm Cycles:10 Average:132.60 Median:133.00 stddev:9.96 (7.5%) stddev-sans-first:10.27 17:59:36 INFO - PROCESS | 23455 | Values: 126.0 134.0 125.0 140.0 128.0 125.0 132.0 125.0 157.0 134.0 17:59:36 INFO - PROCESS | 23455 | 17:59:36 INFO - PROCESS | 23455 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.50 Median:172.50 stddev:4.88 (2.8%) stddev-sans-first:4.90 17:59:36 INFO - PROCESS | 23455 | Values: 176.0 179.0 169.0 170.0 174.0 177.0 169.0 171.0 164.0 166.0 17:59:36 INFO - PROCESS | 23455 | 17:59:36 INFO - PROCESS | 23455 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:63.50 stddev:2.50 (3.9%) stddev-sans-first:2.65 17:59:36 INFO - PROCESS | 23455 | Values: 64.0 65.0 62.0 63.0 62.0 64.0 63.0 63.0 70.0 61.0 17:59:36 INFO - PROCESS | 23455 | -------- Summary: end -------- 17:59:36 INFO - PROCESS | 23455 | 17:59:37 INFO - TEST-INFO | 23455: exit 0 17:59:37 INFO - TEST-OK | kraken | took 60666ms 17:59:37 INFO - SUITE-END | took 1175s 17:59:38 INFO - Completed test suite (00:19:35) 17:59:38 INFO - javascript benchmark 17:59:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7213.002437922421, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3131.5146152346388, 3147.748180145589, 3163.177573830804, 3179.85690643921, 3203.519472079188, 5150.871228219296, 5214.0, 5267.578593712504, 5281.128613778722, 5293.364796224459, 5162.148245539491, 5234.319538460004, 5246.134387826004, 5279.841604751864, 5309.150535914255, 4545.659075569329, 4734.360861283734, 4908.656394052417, 4921.606271498289, 4936.062148191832, 4739.478657347689, 4778.0, 4792.376990991183, 4816.566509014188, 4822.445418776833, 4832.057748738997, 4874.073925954058, 4886.975565122188, 4921.3110164577165, 4953.876153096166, 4867.610591152699, 4900.754962251873, 4908.0429316283335, 4909.410870695504, 4932.876678083041, 4766.118268120409, 4801.951980480186, 4831.879203019917, 4884.6092312615265, 4927.088488629615, 5185.611079169077, 5244.318238628992, 5251.816186433494, 5277.788888444457, 5322.680639161663, 5633.80281690143, 5633.887322253532, 5634.0, 5634.802781902655, 5641.915371269434, 5500.779968801243, 5652.886942261173, 5658.971705141489, 5668.404817494186, 5671.319441666985, 5185.974070129663, 5247.47525247476, 5279.155335146358, 5279.5512381447625, 5325.281087053276, 5745.310562732415, 5752.597318187771, 5758.3665796762325, 5762.279715035621, 5765.1928729977835, 5425.457454254543, 5481.177823326533, 5493.23094766733, 5538.363088244903, 5610.831675049755, 5587.106063029895, 5674.829755107354, 5678.659280443187, 5682.431756824284, 5730.856728581735, 5446.945530544723, 5488.533474654699, 5553.944460555424, 5554.750036248379, 5643.322801263875, 5553.194786755897, 5557.194206839986, 5565.916511252253, 5587.972060139673, 5597.972010139923, 4335.1329734053315, 4341.131773645284, 4387.166438376698, 4389.3635422864145, 4391.297392417198, 3824.3116239077235, 3882.184741204322, 3916.3929590913453, 3924.0582260257333, 3946.210757848442, 5443.292371991616, 5475.7262136893, 5477.04151773438, 5511.3937466878615, 5520.0, 5774.0, 5774.624649397776, 5782.392848750905, 5788.392218817048, 5790.652560846363, 5272.868178295574, 5316.627836051439, 5398.811041613525, 5408.432114627986, 5419.187121931742, 4801.615870730333, 4837.467878533358, 4838.250071238964, 4871.634627402959, 4954.133026720309, 5915.1718759373725, 5954.225950626391, 5964.582479226499, 5966.880662386815, 5982.4914882234625, 5559.11054231321, 5625.071863142535, 5655.943440565707, 5692.800751973661, 5692.857678558069, 5855.677937713466, 5867.20792692981, 5885.588008839341, 5907.172995780508, 5945.34601193877, 5543.445655434424, 5561.555075593862, 5572.247746554325, 5573.721313934206, 5594.860128496657, 5386.919196211981, 5411.621186516906, 5663.320401551676, 5705.800296989585, 5706.229658995982, 5276.129438642581, 5318.920216196682, 5326.227696983993, 5331.786728530816, 5334.706591137525, 5298.231756395224, 5330.573554115739, 5335.813246536352, 5337.492938170868, 5338.706371149468, 5321.414644389037, 5326.573874089986, 5329.067413202596, 5330.147176451904, 5336.626436149588, 5339.332583427072, 5376.650517716336, 5378.784848606012, 5378.97310513445, 5387.2727181831515, 5418.810341638024, 5421.376541697755, 5425.0, 5425.294711687456, 5452.836414907559], "value": 5203.053847637979, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.1776336483875, 606.7997560804935, 626.0577830365299, 632.9303477123658, 648.5719425179383, 45728.77135614322, 48451.0, 48594.27108593374, 51495.0, 51497.0, 47545.286820697715, 48001.51998480014, 48079.75960120194, 48145.0, 48173.99999999991, 8491.19333663301, 8726.738197854074, 8933.597988090536, 9119.361644684876, 9125.634974601007, 10450.111740502067, 10800.351978881254, 10815.35107893525, 11118.944405277962, 11141.0, 10851.565937362497, 10925.781484370307, 10932.070773984182, 10934.343939363624, 10938.671839844817, 10825.783484330348, 10837.512311945982, 10926.180536459718, 10942.13983622786, 10945.671629851038, 10702.892971070267, 10747.677569672922, 10757.246992710514, 10758.569657213702, 10762.892371076266, 45455.54544454546, 45809.770951145365, 45935.31097033547, 45943.31085033727, 45969.0, 4115.54728979812, 4134.793260336971, 4145.0, 4155.439015732898, 4168.166366726667, 32967.83516082428, 33355.0, 33434.83282583596, 33524.3295134096, 34118.0, 4360.803763830603, 4402.185595664812, 4507.188706032913, 4604.608608268301, 4656.254999200111, 320667.0, 322492.0, 324430.0, 326911.0, 327882.0, 56188.43811561914, 57797.71101144468, 60700.39299607036, 64834.675826620565, 65303.0, 57969.71015144981, 64821.351786482475, 65136.34863651303, 65161.0, 65206.0, 17140.142992850557, 17280.395186168425, 17327.480175594752, 17344.82655173432, 17352.219150138273, 13148.40832162555, 13222.471101155847, 13237.669058273428, 13370.26463544495, 13371.866281337063, 19356.90321548383, 19438.05619438045, 19470.641922726103, 19540.0, 19611.31360402379, 7203.963980180066, 7327.487075904742, 7342.229065947999, 7374.0, 7516.624168791648, 914.3005600715458, 922.0456827183966, 922.4327038871046, 929.5166513413122, 934.5981228071994, 29099.0, 31276.687233127832, 31462.528062079087, 31627.367452651277, 32010.839945800588, 997.6382238244888, 1035.3684252605904, 1080.989190108089, 1090.3131027452655, 1102.2725001498973, 16343.770726428767, 16586.83413165853, 16799.91600041992, 16824.915875420545, 17074.743878841826, 395343.0, 398164.0, 399010.0, 399031.0, 400117.0, 60777.39222607806, 61028.694856525435, 61062.0, 61286.38713612896, 61391.38608613946, 1416.7662335714697, 1461.5834487171105, 1471.9558413247619, 1480.9259537023322, 1493.925303734809, 27170.592441113004, 29673.406531869674, 29831.552526711683, 29969.850150749106, 30459.695403045687, 51228.74385628048, 51838.22242666438, 51890.74054629854, 52011.21983170331, 52020.479795201565, 325919.0, 327043.0, 327333.0, 328817.0, 328953.0, 40263.79868100641, 40449.595504044584, 41218.79390603028, 41340.0, 42832.78583607062, 48971.0, 49790.253146202114, 50328.74835625799, 50374.49625503698, 50857.74571127121, 40854.0, 41419.378709319986, 42854.78572607117, 43230.135397292506, 43589.0, 41237.79381103075, 41454.378184326655, 41840.35155254124, 42934.78532607317, 42951.785241073594, 40468.39297410482, 40552.391714124904, 40820.38769418521, 41252.38121428121, 41496.58503414927, 33962.66037339694, 35595.08454069999, 35715.28569428649, 36509.45235821518, 36803.0, 27006.0, 27402.862985684944, 27405.0, 27413.31466713348, 27443.862780686766], "value": 20809.224234331567, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.79979210083104, 421.7996451685449, 422.12198626856144, 431.6978115319277, 446.87264129723013, 19924.302649407273, 21491.355259342225, 21856.672149917726, 22084.668729969042, 22094.779052209473, 21265.787342126576, 21350.145994160215, 21573.568528629457, 21692.0, 22122.115115395405, 5848.970755146218, 6075.392460753911, 6085.087236914476, 6086.087086936951, 6090.3909609038965, 5780.797672081478, 5828.446297601721, 5969.522438204955, 5996.760129594811, 6007.429294217042, 5956.731947062371, 5970.73131709072, 5973.1040343948325, 5973.731182096816, 5973.85065373367, 5745.310562732478, 5901.881962360751, 5913.349531551526, 5937.109433584954, 5939.198208241897, 5311.7344132793205, 5325.840224793224, 5327.653702509325, 5327.866803329909, 5349.384820745625, 13767.862321376759, 14484.0, 14526.34631441577, 14593.343299551545, 20138.89930550338, 2660.8935642574274, 2714.348556346463, 2717.266338088705, 2790.9302267443477, 2799.650043744532, 6923.9960205769885, 9323.627054917795, 10910.454477276104, 11285.379304138269, 11349.694785099737, 1880.125741530195, 1898.3260942365537, 1920.69268916974, 1922.9615407691767, 1927.4506765571884, 98185.0, 100498.49750751273, 102675.48662256716, 103867.48066259696, 104069.0, 11786.351750653796, 11845.466953987092, 12208.633740987785, 12584.496620135274, 12770.61688149357, 16571.751423728652, 16574.917125414537, 16638.168091595373, 16646.0, 16649.16754162287, 8398.328133749286, 8572.442791218551, 8712.564371781385, 8908.821823563621, 8926.598303076376, 8238.464499807493, 8280.668773249003, 8328.541930193776, 8535.701250456204, 8547.145285471403, 4972.801087956514, 5051.646384753106, 5090.669106508065, 5116.130257856174, 5541.196526503634, 2081.8126368626895, 2125.585510825374, 2153.48316404065, 2183.4323076000037, 2197.121151539397, 850.3834719828075, 854.4958474500074, 857.5712143928037, 871.1158174452935, 883.8497455432592, 20713.171473141207, 20998.16007359719, 21005.36983890486, 21395.121999770843, 21479.0, 869.3045563549261, 873.7902903303161, 874.7550685807984, 884.2174675412307, 886.1448702002598, 10735.57057717698, 11758.647240582795, 11792.056635469142, 11885.643430697093, 11899.643010709693, 639786.0, 641345.0, 652537.0, 665156.0, 667667.0, 80237.59881200557, 81904.59047704723, 86087.96076411886, 111105.0, 114123.0, 1035.171862510004, 1062.4740753327153, 1070.4701172919454, 1074.6346242277664, 1075.1936047964027, 18055.729164062814, 18919.243230270637, 19165.616687666447, 19194.13626386788, 19337.903310483358, 45221.32168017548, 45654.77172614116, 46248.537514624426, 46365.768171158925, 46423.76788116038, 63824.68087659532, 64002.35997639964, 64422.0, 65054.34945650483, 66121.66939165273, 9213.539323033687, 9419.0, 9461.716148515556, 9563.426194428357, 9738.805223895624, 10629.0, 14204.573862784133, 14478.900559419037, 14695.0, 15175.0, 11971.401429928643, 11991.160618756603, 12227.327496987751, 12334.50661973547, 12389.504419823466, 11323.547058117583, 11518.481668324777, 11700.70748231301, 11701.531938722355, 11936.701582460508, 11866.584669536525, 11922.76154476923, 12733.0, 13135.277559734306, 13186.142900711424, 8031.867571647179, 9232.0, 9463.0, 9531.952340238255, 9721.659741909, 10706.357618542912, 12542.372881355714, 12682.365881706062, 12758.48966041348, 13264.668383290495], "value": 9697.125349745926, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1391.4434226309475, 1411.8164638596993, 1420.0414720063957, 1426.5648977061994, 1427.9000469967093, 7874.527528348303, 8361.247487726103, 8369.330453563716, 8371.121032291612, 8377.664893404257, 7836.0, 8004.879926801103, 8035.437519373646, 8042.115367309591, 8179.713710020151, 2251.0545570860195, 2309.983607212821, 2319.3969567912295, 2323.1172154581236, 2324.5815753164425, 2070.7929207079246, 2129.9787002130015, 2238.0935721033006, 2286.8399212055165, 2297.873616951067, 2108.5888251790907, 2131.8827464489445, 2162.8810415427147, 2221.9000144993515, 2229.1863469833474, 2252.279270633398, 2256.2892688802976, 2256.4922892349255, 2260.0, 2261.1294651559188, 2202.0971401725374, 2240.9215677451375, 2246.9438264043365, 2249.8200143988606, 2251.3471093383064, 8242.505449673039, 8344.582770861432, 8349.457285276438, 8352.498850068954, 8361.372897032747, 5038.949610503884, 5169.81905633301, 5170.095233334189, 5170.870728231786, 5178.482151784791, 3291.325278317939, 3374.183841895383, 3389.2713066690535, 3467.7919324840336, 3497.737669674759, 1390.1520072755611, 1392.2829742682527, 1402.7825687018528, 1404.4171668757454, 1427.978580321296, 10790.298630588986, 10948.781024379468, 10962.616308429167, 10979.0, 11003.779924401548, 4335.28467802809, 4547.567981041796, 4555.498895121534, 4594.908101837945, 4622.352870598119, 9562.904370956201, 9582.472963987047, 9586.760330991781, 9587.328886977984, 9618.086281803357, 5230.137027390514, 5233.738313084331, 5234.214867769789, 5237.711925844115, 5240.711760853113, 4580.541945805393, 4668.183067963093, 4749.786259618326, 4789.568938795525, 4842.297866809364, 3830.157365379612, 3833.195029043932, 3884.6309600587897, 3939.8424063037733, 3981.5023122109737, 1290.1613950931783, 1315.283170671986, 1330.7405056014177, 1342.0203251626367, 1343.355189509041, 930.1767935377104, 944.6882528765628, 949.9477528735848, 950.4724877692947, 975.7121649113528, 5307.4692530746615, 5443.0, 5526.613137080446, 5591.133374326986, 5695.800646977336, 628.6196850905228, 638.0684201066495, 638.2022471910112, 639.9936000639934, 643.112504743451, 3672.0, 3679.889603311905, 3705.0, 3708.1841994761107, 3805.2009078093356, 9135.680251191176, 9476.905230947741, 9529.237660987104, 9587.664431744855, 9592.760180995392, 9574.712758617252, 9588.90411095894, 9594.712158635251, 9609.807803844024, 9613.951930240444, 7470.551766893895, 7543.283388078124, 7566.092068951651, 7566.205548417447, 7632.24458374577, 5279.762410691605, 5283.920741188962, 5329.704317703823, 5414.0, 5520.199571062254, 8818.559072046244, 8821.647134114564, 8829.072947340694, 8837.734867953972, 8885.200331969894, 8642.22220000178, 8938.910610893809, 9024.0, 9047.547622618975, 9295.256379489489, 7176.677049532679, 7261.818454538467, 7298.160711518243, 7312.634368281459, 7324.81687957784, 7694.538327700356, 7773.0, 7816.57008864518, 7820.726274580363, 7835.098963619257, 6982.538660115673, 6998.720051197895, 7143.535670181422, 7235.457340699574, 7248.0939882514685, 6847.965760171167, 6904.654767261717, 6909.136357955255, 6976.616286104313, 7170.0, 6174.722137503733, 6290.779822706183, 6299.055141728594, 6299.6535190564955, 6303.495720342454, 4813.278008298643, 4960.330355402119, 5079.415867175175, 5084.466131056334, 5156.716380598953, 4830.227163653799, 4968.453470118212, 4981.227909674007, 5084.745762711776, 5103.617228707936], "value": 4359.295637047949, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.28504768511345, 392.97642141471516, 410.20625090449977, 415.362418687315, 417.5573891674825, 4969.950300496994, 5132.6920384776895, 5203.245529398235, 5217.895642087156, 5217.92173117403, 4958.033183529214, 5160.942006888588, 5167.302414174085, 5168.431472538027, 5181.5854731621475, 4132.2768515509815, 4133.173365326931, 4144.48193975753, 4144.8963775905695, 4154.501459824825, 3938.9803050984847, 4062.248484030449, 4156.875293741177, 4164.854230101947, 4172.0, 3970.900727481822, 4030.758154510724, 4044.2720310344125, 4095.508538975312, 4101.712880098395, 4115.629593336614, 4119.382092686091, 4120.299549076634, 4124.896877578055, 4127.7936103195025, 3659.8170091495317, 3667.431548110047, 3668.413053911388, 3671.1739858531882, 3678.393065144248, 4898.338724272213, 5049.873753156164, 5055.241713742931, 5077.517635824591, 5077.543021128116, 4675.485696573374, 4693.296005599153, 4705.894114883, 4711.293306004092, 4740.834070807539, 5432.397442754397, 5479.972600136974, 5490.752916118744, 5493.285872836545, 5509.641873278224, 3811.8856434307013, 4011.6389524942897, 4033.9596604033877, 4040.979795101035, 4043.555208927016, 5647.887042259173, 5656.43435656431, 5666.433356664342, 5687.175359572881, 5697.373288938214, 4123.134141830189, 4135.152293779768, 4148.253314403376, 4151.301653924913, 4162.271602469556, 3909.3354129798004, 3979.5622481527007, 4209.852655157055, 4219.662427005832, 4228.3446065859225, 4549.931751023737, 4575.055601369405, 4662.323963025342, 4664.790084446208, 4675.953240467552, 5494.36814766299, 5495.477929596682, 5497.147942068986, 5498.268045565634, 5511.988124334589, 1351.5403364366462, 1381.067779249023, 1391.3877893726728, 1395.5534229046812, 1426.587678198576, 987.7975015121883, 988.945607991553, 992.9304948653669, 992.93545919515, 1005.7334806276342, 5104.770285337168, 5158.174692049329, 5169.560587350042, 5174.818881339211, 5198.818041368534, 5529.170624406291, 5541.418151094158, 5548.361938377057, 5554.111342185231, 5564.8330550083565, 4968.583953573287, 5207.218917162456, 5215.191645294985, 5233.71214583194, 5267.209918512177, 2904.5207540755537, 2918.2266699324696, 2918.2266699324696, 2921.1674672718173, 2929.2383980164886, 5429.783698780465, 5715.514181294553, 5725.2843394575675, 5741.081426971665, 5765.308163020464, 5564.916526252109, 5568.276124103922, 5588.2455868458055, 5597.720113994284, 5619.381867994517, 5659.405762394971, 5701.914471283017, 5702.030654788696, 5717.285339332583, 5721.227634269404, 5219.19102539107, 5349.304590403222, 5394.460553944574, 5396.7587454884815, 5413.918791218056, 5369.570434365163, 5376.489233522809, 5377.784888604412, 5377.919331209957, 5390.622656414013, 5343.096963809778, 5533.280673512418, 5638.379778224474, 5647.915281270866, 5664.376918538875, 3977.7812220327, 4007.4352414455357, 4041.1513582148077, 4042.6563742081075, 4050.4531888194715, 5364.436734143015, 5425.321834770653, 5460.863478412913, 5496.51594069591, 5579.4978451937895, 5392.191171324333, 5414.458554144554, 5418.945810541844, 5481.766602514403, 5487.6981766003255, 5430.83707488776, 5451.873769230083, 5455.7997240607, 5470.288862447856, 5478.90441900341, 5172.922406163986, 5356.1697936819855, 5397.217403476552, 5413.40452550227, 5456.290682211287, 5466.933947880125, 5472.179173124063, 5498.340199176125, 5503.532199763065, 5508.228847961209, 5188.377394712658, 5314.548263397654, 5335.546478549211, 5340.118880384693, 5359.946400535945], "value": 4188.933157711522, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [763.3015790551646, 775.2325198053928, 790.4782843323404, 837.4347315561995, 891.0777345447461, 15104.169270690109, 15131.470398536054, 15255.923720381397, 15294.847051529481, 16100.033997960116, 15278.541643750677, 15279.388824447009, 15439.536813895573, 15534.145621990787, 15939.123348215844, 720.394868310619, 732.8131326511746, 746.8917007033976, 748.0275641665839, 749.4004796163075, 748.4760667532722, 757.6249756370604, 758.3364556013488, 758.9127250366223, 759.5404780108038, 776.5767656627152, 778.4511919097023, 780.6994307191744, 782.9647665855022, 784.7802615267734, 779.6296759039411, 779.8011507065719, 780.2158830375494, 780.8360244348694, 781.0081196879987, 572.1503567202701, 572.9111987641922, 573.1030936584274, 573.3292048303495, 573.4151165810849, 15017.324220410108, 15017.624559385993, 15028.549143525603, 15657.451989180325, 17306.394276200273, 15427.5371738848, 15619.375224990987, 15942.920285398615, 15953.0, 16072.919635401748, 11981.460834262392, 11984.880151198551, 12556.497740090386, 12651.240925544405, 12764.297963611998, 4510.481294651125, 4523.158051838204, 4545.340925565807, 4780.4741478437345, 4786.64100192487, 80788.0, 82167.5891620538, 82703.17296827016, 83179.16820831774, 83674.16325836786, 11049.558017679203, 11347.773044539228, 11534.192606517463, 11567.942160289145, 11659.0, 21064.15743370248, 21127.683084753742, 21176.15295388198, 21404.78595214028, 21432.571348573252, 8092.514449132953, 8105.230003149692, 8139.43023988327, 8254.711085112112, 8385.454945428528, 4272.636825869836, 4279.550647182064, 4306.031142992864, 4333.523312435629, 4444.688871778944, 3372.1232479555, 3441.690247877653, 3514.0, 3541.11472131967, 3551.7691350062164, 590.8995470769979, 593.8723174517413, 598.0341748076911, 601.8585632376388, 649.7433513762038, 752.3905636434506, 757.7082823113141, 786.7993661616251, 788.6450997725494, 796.665400531778, 9943.80112397748, 10727.19546034035, 10933.234673572773, 11054.447277636085, 11253.15601329887, 756.6784116750359, 759.0284435922028, 763.8854171874264, 767.4742801181209, 777.1878387085509, 4957.256411538298, 5176.223566465061, 5222.660527065728, 5224.764885580158, 5228.686278823283, 75428.62285688537, 75549.0234306644, 79377.0, 79910.20089799027, 81907.5904620473, 66577.66711166414, 67181.32818671751, 67631.66184169146, 68021.0, 71094.28905710876, 53843.0, 56103.438965610636, 58844.41155588475, 59066.40933590695, 61471.38528614746, 10473.895261047597, 10983.725406864893, 11085.7805641381, 11373.20387572862, 11376.54493820238, 40554.0, 41083.383749243185, 41209.75804839104, 41286.1742765149, 41954.580454195064, 48603.756981214865, 50155.24767128569, 55469.0, 55985.72007139938, 57405.0, 13144.868551314365, 13153.473861045833, 13211.471541138631, 13476.93261533686, 14056.226907520184, 14704.338304776526, 15076.849231507544, 15765.605859853595, 16100.516984490485, 16187.352505899633, 13578.592642220749, 14138.575842724735, 14259.786103208668, 14493.492727754478, 14516.346764395415, 14038.654130730287, 14094.647633809236, 14346.856531434969, 14768.778468323198, 14801.92599037041, 14169.858301416854, 14256.786148207993, 14977.925110374379, 15006.099634021994, 15035.323410446776, 10903.890961090288, 10920.283225267221, 11061.668149955514, 11183.161262905152, 11395.373254471084, 10577.0, 10606.575736970435, 10654.200934929757, 10686.679399618024, 10706.357618542912], "value": 7344.618053902403, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1508.5999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 114.0, 113.0, 119.0, 113.0, 111.0, 114.0, 113.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 118.0, 118.0, 155.0, 125.0, 119.0, 119.0, 121.0, 148.0, 118.0], "value": 129.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 161.0, 163.0, 161.0, 162.0, 162.0, 163.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 78.0, 107.0, 76.0, 75.0, 77.0, 76.0, 98.0, 77.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 83.0, 102.0, 83.0, 83.0, 84.0, 95.0, 83.0, 83.0, 110.0], "value": 90.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 116.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 146.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 55.0, 54.0, 56.0, 59.0, 55.0, 55.0, 56.0, 56.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 67.0, 68.0, 67.0, 67.0, 67.0, 67.0, 68.0], "value": 67.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 88.0, 81.0, 81.0, 81.0, 82.0, 82.0, 81.0, 80.0, 80.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 134.0, 125.0, 140.0, 128.0, 125.0, 132.0, 125.0, 157.0, 134.0], "value": 132.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 179.0, 169.0, 170.0, 174.0, 177.0, 169.0, 171.0, 164.0, 166.0], "value": 171.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 62.0, 63.0, 62.0, 64.0, 63.0, 63.0, 70.0, 61.0], "value": 63.7, "unit": "score"}]}]} 17:59:38 INFO - Return code: 0 17:59:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:59:38 ERROR - # TBPL SUCCESS # 17:59:38 INFO - Running post-action listener: _resource_record_post_action 17:59:38 INFO - [mozharness: 2017-02-03 01:59:38.241877Z] Finished run-tests step (success) 17:59:38 INFO - Running post-run listener: _resource_record_post_run 17:59:38 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 404140032; Read time: 0; Write time: 278020 17:59:38 INFO - TinderboxPrint: CPU usage
13.1% 17:59:38 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 17:59:38 INFO - TinderboxPrint: I/O write bytes / time
404,140,032 / 278,020 17:59:38 INFO - TinderboxPrint: CPU idle
8,276.7 (86.9%) 17:59:38 INFO - TinderboxPrint: CPU user
1,198.9 (12.6%) 17:59:38 INFO - TinderboxPrint: Swap in / out
0 / 0 17:59:38 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 105861120; Read time: 0; Write time: 100996 17:59:38 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 298278912; Read time: 0; Write time: 177024 17:59:38 INFO - Running post-run listener: _upload_blobber_files 17:59:38 INFO - Blob upload gear active. 17:59:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:59:38 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:59:38 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:59:38 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:59:39 INFO - (blobuploader) - INFO - Open directory for files ... 17:59:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:59:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:59:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:59:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:59:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:59:40 INFO - (blobuploader) - INFO - Done attempting. 17:59:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:59:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:59:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:59:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:59:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:59:43 INFO - (blobuploader) - INFO - Done attempting. 17:59:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:59:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:59:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:59:44 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:59:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:59:44 INFO - (blobuploader) - INFO - Done attempting. 17:59:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:59:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:59:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:59:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:59:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:59:45 INFO - (blobuploader) - INFO - Done attempting. 17:59:45 INFO - (blobuploader) - INFO - Iteration through files over. 17:59:45 INFO - Return code: 0 17:59:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:59:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:59:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2996f4725c18872655c1f66295e64489567176e514dfe56f58a12659fc1c1a0a99ec8a3b81eab96efa2011bfde3ba8a25d29c3271a18bc950d4102809e2f1460", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39b7de8d2ac0855e810f0e1ad5c6031f4abd9612063d99269bf23ab5eecc4e16112745ce2c8f973644f5823844e25f1af1f68e1c9a3e6759dfc89ffd49f94134", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef7c7ca776bf66980792dbcf8e4ea87536f4af919e51adf269b113373c8057153108f0a8fce384a29edd0b2be44bcfb3cfd9faad1871bb1bc762f10cd670b768", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/622ce63757579c6ded6273fe54b9db0c2027c3e6b2f0e836758be8e7d48a66b02d12a79017a458c5ca65130eea24bd8edff3d52cd4dd6fbdaf710f6f7247c498"} 17:59:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:59:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:59:45 INFO - Contents: 17:59:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2996f4725c18872655c1f66295e64489567176e514dfe56f58a12659fc1c1a0a99ec8a3b81eab96efa2011bfde3ba8a25d29c3271a18bc950d4102809e2f1460", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39b7de8d2ac0855e810f0e1ad5c6031f4abd9612063d99269bf23ab5eecc4e16112745ce2c8f973644f5823844e25f1af1f68e1c9a3e6759dfc89ffd49f94134", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef7c7ca776bf66980792dbcf8e4ea87536f4af919e51adf269b113373c8057153108f0a8fce384a29edd0b2be44bcfb3cfd9faad1871bb1bc762f10cd670b768", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/622ce63757579c6ded6273fe54b9db0c2027c3e6b2f0e836758be8e7d48a66b02d12a79017a458c5ca65130eea24bd8edff3d52cd4dd6fbdaf710f6f7247c498"} 17:59:45 INFO - Running post-run listener: copy_logs_to_upload_dir 17:59:45 INFO - Copying logs to upload dir... 17:59:45 INFO - mkdir: /builds/slave/test/build/upload/logs 17:59:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.978421 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2017-02-02 17:59:45.098822) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-02 17:59:45.102331) ========= 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=923d835db2ba3686ebe126b700000192-1486085943.341339-1502583955 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2996f4725c18872655c1f66295e64489567176e514dfe56f58a12659fc1c1a0a99ec8a3b81eab96efa2011bfde3ba8a25d29c3271a18bc950d4102809e2f1460", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39b7de8d2ac0855e810f0e1ad5c6031f4abd9612063d99269bf23ab5eecc4e16112745ce2c8f973644f5823844e25f1af1f68e1c9a3e6759dfc89ffd49f94134", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef7c7ca776bf66980792dbcf8e4ea87536f4af919e51adf269b113373c8057153108f0a8fce384a29edd0b2be44bcfb3cfd9faad1871bb1bc762f10cd670b768", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/622ce63757579c6ded6273fe54b9db0c2027c3e6b2f0e836758be8e7d48a66b02d12a79017a458c5ca65130eea24bd8edff3d52cd4dd6fbdaf710f6f7247c498"} build_url:https://queue.taskcluster.net/v1/task/UQxJoFPNS22vL3vu9QKTQA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011378 build_url: 'https://queue.taskcluster.net/v1/task/UQxJoFPNS22vL3vu9QKTQA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2996f4725c18872655c1f66295e64489567176e514dfe56f58a12659fc1c1a0a99ec8a3b81eab96efa2011bfde3ba8a25d29c3271a18bc950d4102809e2f1460", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/39b7de8d2ac0855e810f0e1ad5c6031f4abd9612063d99269bf23ab5eecc4e16112745ce2c8f973644f5823844e25f1af1f68e1c9a3e6759dfc89ffd49f94134", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ef7c7ca776bf66980792dbcf8e4ea87536f4af919e51adf269b113373c8057153108f0a8fce384a29edd0b2be44bcfb3cfd9faad1871bb1bc762f10cd670b768", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/622ce63757579c6ded6273fe54b9db0c2027c3e6b2f0e836758be8e7d48a66b02d12a79017a458c5ca65130eea24bd8edff3d52cd4dd6fbdaf710f6f7247c498"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-02 17:59:45.128176) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 17:59:45.128494) ========= 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=923d835db2ba3686ebe126b700000192-1486085943.341339-1502583955 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004468 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-02 17:59:45.213515) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-02 17:59:45.213844) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-02 17:59:45.214142) ========= ========= Total master_lag: 0.17 =========