builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-058 starttime: 1489538426.92 results: success (0) revision: fd8bdabb4813164e70b51d02b420e3659eb38536 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-14 17:40:26.923863) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-14 17:40:26.924376) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-14 17:40:26.924673) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-14 17:40:26.941955) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 17:40:26.942346) ========= 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=0e2a256762fed810e2f0f810000001b3-1489538426.60049-1832119983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-14 17:40:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2017-03-14 17:40:27 (46.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131105 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 17:40:27.102290) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 17:40:27.102621) ========= 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=0e2a256762fed810e2f0f810000001b3-1489538426.60049-1832119983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019392 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 17:40:27.151937) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 17:40:27.152293) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev fd8bdabb4813164e70b51d02b420e3659eb38536 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev fd8bdabb4813164e70b51d02b420e3659eb38536 --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=0e2a256762fed810e2f0f810000001b3-1489538426.60049-1832119983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-14 17:40:27,402 truncating revision to first 12 chars 2017-03-14 17:40:27,402 Setting DEBUG logging. 2017-03-14 17:40:27,402 attempt 1/10 2017-03-14 17:40:27,402 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/fd8bdabb4813?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-14 17:40:27,981 unpacking tar archive at: mozilla-aurora-fd8bdabb4813/testing/mozharness/ program finished with exit code 0 elapsedTime=0.874720 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 17:40:28.039912) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-14 17:40:28.040224) ========= script_repo_revision: fd8bdabb4813164e70b51d02b420e3659eb38536 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-14 17:40:28.040624) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-14 17:40:28.040885) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-14 17:40:28.049878) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-03-14 17:40:28.050216) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=0e2a256762fed810e2f0f810000001b3-1489538426.60049-1832119983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:40:28 INFO - MultiFileLogger online at 20170314 17:40:28 in /builds/slave/test 17:40:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 17:40:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:40:28 INFO - {'append_to_log': False, 17:40:28 INFO - 'base_work_dir': '/builds/slave/test', 17:40:28 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 17:40:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:40:28 INFO - 'branch': 'Mozilla-Aurora', 17:40:28 INFO - 'buildbot_json_path': 'buildprops.json', 17:40:28 INFO - 'config_files': ('talos/linux_config.py',), 17:40:28 INFO - 'default_actions': ('clobber', 17:40:28 INFO - 'read-buildbot-config', 17:40:28 INFO - 'download-and-extract', 17:40:28 INFO - 'populate-webroot', 17:40:28 INFO - 'create-virtualenv', 17:40:28 INFO - 'install', 17:40:28 INFO - 'run-tests'), 17:40:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:40:28 INFO - 'download_minidump_stackwalk': True, 17:40:28 INFO - 'download_symbols': 'ondemand', 17:40:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:40:28 INFO - 'tooltool.py': '/tools/tooltool.py', 17:40:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:40:28 INFO - '/tools/misc-python/virtualenv.py')}, 17:40:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:40:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:40:28 INFO - 'gecko_profile': False, 17:40:28 INFO - 'gecko_profile_interval': 0, 17:40:28 INFO - 'installer_path': 'installer.exe', 17:40:28 INFO - 'log_level': 'info', 17:40:28 INFO - 'log_name': 'talos', 17:40:28 INFO - 'log_to_console': True, 17:40:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:40:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:40:28 INFO - 'opt_config_files': (), 17:40:28 INFO - 'pip_index': False, 17:40:28 INFO - 'suite': 'dromaeojs', 17:40:28 INFO - 'system_bits': '32', 17:40:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:40:28 INFO - 'title': 'talos-linux64-ix-058', 17:40:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:40:28 INFO - 'use_talos_json': True, 17:40:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:40:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:40:28 INFO - 'work_dir': 'build'} 17:40:28 INFO - [mozharness: 2017-03-15 00:40:28.498143Z] Running clobber step. 17:40:28 INFO - Running pre-action listener: _resource_record_pre_action 17:40:28 INFO - Running main action method: clobber 17:40:28 INFO - rmtree: /builds/slave/test/build 17:40:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:40:29 INFO - Running post-action listener: _resource_record_post_action 17:40:29 INFO - [mozharness: 2017-03-15 00:40:29.464141Z] Finished clobber step (success) 17:40:29 INFO - [mozharness: 2017-03-15 00:40:29.464239Z] Running read-buildbot-config step. 17:40:29 INFO - Running pre-action listener: _resource_record_pre_action 17:40:29 INFO - Running main action method: read_buildbot_config 17:40:29 INFO - Using buildbot properties: 17:40:29 INFO - { 17:40:29 INFO - "project": "", 17:40:29 INFO - "product": "firefox", 17:40:29 INFO - "who": "asasaki@mozilla.com", 17:40:29 INFO - "installer_path": "public/build/target.tar.bz2", 17:40:29 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 17:40:29 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 17:40:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 17:40:29 INFO - "stage_platform": "linux64-pgo", 17:40:29 INFO - "basedir": "/builds/slave/test", 17:40:29 INFO - "buildnumber": 832, 17:40:29 INFO - "platform": "ubuntu64_hw", 17:40:29 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:40:29 INFO - "slavebuilddir": "test", 17:40:29 INFO - "taskId": "Fi9Nct5tRFSd0vldebMdGQ", 17:40:29 INFO - "branch": "mozilla-aurora", 17:40:29 INFO - "script_repo_revision": "production", 17:40:29 INFO - "revision": "fd8bdabb4813164e70b51d02b420e3659eb38536", 17:40:29 INFO - "slavename": "talos-linux64-ix-058", 17:40:29 INFO - "repo_path": "releases/mozilla-aurora" 17:40:29 INFO - } 17:40:29 INFO - Finding installer, test and symbols from parent task. 17:40:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fi9Nct5tRFSd0vldebMdGQ'}, attempt #1 17:40:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fi9Nct5tRFSd0vldebMdGQ'}, attempt #1 17:40:30 INFO - Task dependencies: aRlMdMDkQUSqK3Kpnp2-ig 17:40:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aRlMdMDkQUSqK3Kpnp2-ig'}, attempt #1 17:40:30 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/aRlMdMDkQUSqK3Kpnp2-ig/artifacts/public/build/target.tar.bz2 17:40:30 INFO - Set test_url: https://queue.taskcluster.net/v1/task/aRlMdMDkQUSqK3Kpnp2-ig/artifacts/public/build/test_packages.json 17:40:30 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/aRlMdMDkQUSqK3Kpnp2-ig/artifacts/public/build/target.crashreporter-symbols.zip 17:40:30 INFO - Running post-action listener: _resource_record_post_action 17:40:30 INFO - [mozharness: 2017-03-15 00:40:30.846159Z] Finished read-buildbot-config step (success) 17:40:30 INFO - [mozharness: 2017-03-15 00:40:30.846377Z] Running download-and-extract step. 17:40:30 INFO - Running pre-action listener: _resource_record_pre_action 17:40:30 INFO - Running main action method: download_and_extract 17:40:30 INFO - mkdir: /builds/slave/test/build/tests 17:40:30 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:30 INFO - trying https://queue.taskcluster.net/v1/task/aRlMdMDkQUSqK3Kpnp2-ig/artifacts/public/build/target.test_packages.json 17:40:30 INFO - Downloading https://queue.taskcluster.net/v1/task/aRlMdMDkQUSqK3Kpnp2-ig/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:40:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aRlMdMDkQUSqK3Kpnp2-ig/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:40:31 INFO - Downloaded 896 bytes. 17:40:31 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:40:31 INFO - Using the following test package requirements: 17:40:31 INFO - {u'common': [u'target.common.tests.zip'], 17:40:31 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:40:31 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:40:31 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:40:31 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:40:31 INFO - u'mozbase': [u'target.common.tests.zip'], 17:40:31 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:40:31 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:40:31 INFO - u'web-platform': [u'target.common.tests.zip', 17:40:31 INFO - u'target.web-platform.tests.zip'], 17:40:31 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:40:31 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:40:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aRlMdMDkQUSqK3Kpnp2-ig/artifacts/public/build/target.common.tests.zip 17:40:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aRlMdMDkQUSqK3Kpnp2-ig/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:40:31 INFO - Fetch https://queue.taskcluster.net/v1/task/aRlMdMDkQUSqK3Kpnp2-ig/artifacts/public/build/target.common.tests.zip into memory 17:40:32 INFO - Expected file size: 59529999 17:40:32 INFO - Obtained file size: 59529999 17:40:42 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:40:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aRlMdMDkQUSqK3Kpnp2-ig/artifacts/public/build/target.common.tests.zip 17:40:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aRlMdMDkQUSqK3Kpnp2-ig/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:40:42 INFO - Fetch https://queue.taskcluster.net/v1/task/aRlMdMDkQUSqK3Kpnp2-ig/artifacts/public/build/target.common.tests.zip into memory 17:40:43 INFO - Expected file size: 59529999 17:40:43 INFO - Obtained file size: 59529999 17:40:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aRlMdMDkQUSqK3Kpnp2-ig/artifacts/public/build/target.talos.tests.zip 17:40:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aRlMdMDkQUSqK3Kpnp2-ig/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:40:54 INFO - Fetch https://queue.taskcluster.net/v1/task/aRlMdMDkQUSqK3Kpnp2-ig/artifacts/public/build/target.talos.tests.zip into memory 17:40:55 INFO - Expected file size: 14404424 17:40:55 INFO - Obtained file size: 14404424 17:40:55 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:55 INFO - trying https://queue.taskcluster.net/v1/task/aRlMdMDkQUSqK3Kpnp2-ig/artifacts/public/build/target.tar.bz2 17:40:55 INFO - Downloading https://queue.taskcluster.net/v1/task/aRlMdMDkQUSqK3Kpnp2-ig/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:40:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aRlMdMDkQUSqK3Kpnp2-ig/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:40:57 INFO - Downloaded 66547256 bytes. 17:40:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aRlMdMDkQUSqK3Kpnp2-ig/artifacts/public/build/target.tar.bz2 17:40:57 INFO - mkdir: /builds/slave/test/properties 17:40:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:40:57 INFO - Writing to file /builds/slave/test/properties/build_url 17:40:57 INFO - Contents: 17:40:57 INFO - build_url:https://queue.taskcluster.net/v1/task/aRlMdMDkQUSqK3Kpnp2-ig/artifacts/public/build/target.tar.bz2 17:40:57 INFO - Running post-action listener: _resource_record_post_action 17:40:57 INFO - Running post-action listener: set_extra_try_arguments 17:40:57 INFO - [mozharness: 2017-03-15 00:40:57.041518Z] Finished download-and-extract step (success) 17:40:57 INFO - [mozharness: 2017-03-15 00:40:57.041614Z] Running populate-webroot step. 17:40:57 INFO - Running pre-action listener: _resource_record_pre_action 17:40:57 INFO - Running main action method: populate_webroot 17:40:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:40:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:40:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:40:57 INFO - '--tppagecycles', 17:40:57 INFO - '7'], 17:40:57 INFO - 'tests': ['tsvgm']}}, 17:40:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:40:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:40:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:40:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:40:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:40:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:40:57 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:40:57 INFO - 'talos_options': ['--disable-e10s'], 17:40:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:40:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:40:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:40:57 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:40:57 INFO - 'talos_options': ['--disable-e10s'], 17:40:57 INFO - 'tests': ['damp', 'tps']}, 17:40:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:40:57 INFO - 'tests': ['damp', 'tps']}, 17:40:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:40:57 INFO - 'tests': ['dromaeo_dom']}, 17:40:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:40:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:40:57 INFO - 'tests': ['basic_compositor_video']}, 17:40:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:40:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:40:57 INFO - 'tests': ['a11yr', 17:40:57 INFO - 'ts_paint', 17:40:57 INFO - 'tpaint', 17:40:57 INFO - 'sessionrestore', 17:40:57 INFO - 'sessionrestore_no_auto_restore', 17:40:57 INFO - 'tabpaint']}, 17:40:57 INFO - 'other-e10s': {'tests': ['a11yr', 17:40:57 INFO - 'ts_paint', 17:40:57 INFO - 'tpaint', 17:40:57 INFO - 'sessionrestore', 17:40:57 INFO - 'sessionrestore_no_auto_restore', 17:40:57 INFO - 'tabpaint']}, 17:40:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:40:57 INFO - 'ts_paint', 17:40:57 INFO - 'tpaint', 17:40:57 INFO - 'sessionrestore', 17:40:57 INFO - 'sessionrestore_no_auto_restore', 17:40:57 INFO - 'tabpaint']}, 17:40:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:40:57 INFO - 'ts_paint', 17:40:57 INFO - 'tpaint', 17:40:57 INFO - 'sessionrestore', 17:40:57 INFO - 'sessionrestore_no_auto_restore', 17:40:57 INFO - 'tabpaint']}, 17:40:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:40:57 INFO - 'tests': ['a11yr', 17:40:57 INFO - 'ts_paint', 17:40:57 INFO - 'tpaint', 17:40:57 INFO - 'sessionrestore', 17:40:57 INFO - 'sessionrestore_no_auto_restore', 17:40:57 INFO - 'tabpaint']}, 17:40:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:40:57 INFO - 'tests': ['a11yr', 17:40:57 INFO - 'ts_paint', 17:40:57 INFO - 'tpaint', 17:40:57 INFO - 'sessionrestore', 17:40:57 INFO - 'sessionrestore_no_auto_restore', 17:40:57 INFO - 'tabpaint']}, 17:40:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:40:57 INFO - 'tests': ['tsvgx', 17:40:57 INFO - 'tsvgr_opacity', 17:40:57 INFO - 'tart', 17:40:57 INFO - 'tscrollx', 17:40:57 INFO - 'cart', 17:40:57 INFO - 'tsvg_static']}, 17:40:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:40:57 INFO - 'tsvgr_opacity', 17:40:57 INFO - 'tart', 17:40:57 INFO - 'tscrollx', 17:40:57 INFO - 'cart', 17:40:57 INFO - 'tsvg_static']}, 17:40:57 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:40:57 INFO - 'talos_options': ['--disable-e10s'], 17:40:57 INFO - 'tests': ['tp5o']}, 17:40:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:40:57 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:40:57 INFO - 'talos_options': ['--disable-e10s', 17:40:57 INFO - '--xperf_path', 17:40:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:40:57 INFO - 'tests': ['tp5n']}, 17:40:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:40:57 INFO - 'talos_options': ['--xperf_path', 17:40:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:40:57 INFO - 'tests': ['tp5n']}}, 17:40:57 INFO - 'talos.zip': {'path': '', 17:40:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:40:57 INFO - Running post-action listener: _resource_record_post_action 17:40:57 INFO - [mozharness: 2017-03-15 00:40:57.054735Z] Finished populate-webroot step (success) 17:40:57 INFO - [mozharness: 2017-03-15 00:40:57.054825Z] Running create-virtualenv step. 17:40:57 INFO - Running pre-action listener: _resource_record_pre_action 17:40:57 INFO - Running main action method: create_virtualenv 17:40:57 INFO - Creating virtualenv /builds/slave/test/build/venv 17:40:57 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:40:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:40:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:40:57 INFO - Using real prefix '/usr' 17:40:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:40:57 INFO - Installing distribute.............................................................................................................................................................................................done. 17:40:59 INFO - Installing pip.................done. 17:40:59 INFO - Return code: 0 17:40:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:40:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:41:01 INFO - Reading from file tmpfile_stdout 17:41:01 INFO - Output received: 17:41:01 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:41:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:41:01 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:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:01 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:41:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:01 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 0x24d61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2773b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2771290>, '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 0x2771b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2772040>, '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': '0e2a256762fed810e2f0f810000001b3-1489538426.60049-1832119983', '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:41:01 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:41:01 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:41:01 INFO - Using env: {'DISPLAY': ':0', 17:41:01 INFO - 'HOME': '/home/cltbld', 17:41:01 INFO - 'LANG': 'en_US.UTF-8', 17:41:01 INFO - 'LANGUAGE': 'en_US:en', 17:41:01 INFO - 'LOGNAME': 'cltbld', 17:41:01 INFO - 'MAIL': '/var/mail/cltbld', 17:41:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:01 INFO - 'MOZ_NO_REMOTE': '1', 17:41:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:01 INFO - 'NO_EM_RESTART': '1', 17:41:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:01 INFO - 'PWD': '/builds/slave/test', 17:41:01 INFO - 'SHELL': '/bin/bash', 17:41:01 INFO - 'SHLVL': '1', 17:41:01 INFO - 'TERM': 'linux', 17:41:01 INFO - 'TMOUT': '86400', 17:41:01 INFO - 'USER': 'cltbld', 17:41:01 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1489538426.60049-1832119983', 17:41:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:01 INFO - '_': '/tools/buildbot/bin/python'} 17:41:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:01 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:41:01 INFO - Cleaning up... 17:41:01 INFO - Return code: 0 17:41:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:41:01 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:41:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:01 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:41:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:01 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 0x24d61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2773b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2771290>, '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 0x2771b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2772040>, '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': '0e2a256762fed810e2f0f810000001b3-1489538426.60049-1832119983', '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:41:01 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:41:01 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:41:01 INFO - Using env: {'DISPLAY': ':0', 17:41:01 INFO - 'HOME': '/home/cltbld', 17:41:01 INFO - 'LANG': 'en_US.UTF-8', 17:41:01 INFO - 'LANGUAGE': 'en_US:en', 17:41:01 INFO - 'LOGNAME': 'cltbld', 17:41:01 INFO - 'MAIL': '/var/mail/cltbld', 17:41:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:01 INFO - 'MOZ_NO_REMOTE': '1', 17:41:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:01 INFO - 'NO_EM_RESTART': '1', 17:41:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:01 INFO - 'PWD': '/builds/slave/test', 17:41:01 INFO - 'SHELL': '/bin/bash', 17:41:01 INFO - 'SHLVL': '1', 17:41:01 INFO - 'TERM': 'linux', 17:41:01 INFO - 'TMOUT': '86400', 17:41:01 INFO - 'USER': 'cltbld', 17:41:01 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1489538426.60049-1832119983', 17:41:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:01 INFO - '_': '/tools/buildbot/bin/python'} 17:41:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:01 INFO - Downloading/unpacking psutil>=3.1.1 17:41:01 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:41:01 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:41:01 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:41:01 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:41:01 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:41:01 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:41:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:41:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:41:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:41:03 INFO - Installing collected packages: psutil 17:41:03 INFO - Running setup.py install for psutil 17:41:03 INFO - building 'psutil._psutil_linux' extension 17:41:03 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:41:04 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:41:05 INFO - building 'psutil._psutil_posix' extension 17:41:05 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:41:05 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:41:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:41:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:41:05 INFO - Successfully installed psutil 17:41:05 INFO - Cleaning up... 17:41:05 INFO - Return code: 0 17:41:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:41:05 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:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:05 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:41:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:05 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 0x24d61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2773b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2771290>, '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 0x2771b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2772040>, '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': '0e2a256762fed810e2f0f810000001b3-1489538426.60049-1832119983', '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:41:05 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:41:05 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:41:05 INFO - Using env: {'DISPLAY': ':0', 17:41:05 INFO - 'HOME': '/home/cltbld', 17:41:05 INFO - 'LANG': 'en_US.UTF-8', 17:41:05 INFO - 'LANGUAGE': 'en_US:en', 17:41:05 INFO - 'LOGNAME': 'cltbld', 17:41:05 INFO - 'MAIL': '/var/mail/cltbld', 17:41:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:05 INFO - 'MOZ_NO_REMOTE': '1', 17:41:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:05 INFO - 'NO_EM_RESTART': '1', 17:41:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:05 INFO - 'PWD': '/builds/slave/test', 17:41:05 INFO - 'SHELL': '/bin/bash', 17:41:05 INFO - 'SHLVL': '1', 17:41:05 INFO - 'TERM': 'linux', 17:41:05 INFO - 'TMOUT': '86400', 17:41:05 INFO - 'USER': 'cltbld', 17:41:05 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1489538426.60049-1832119983', 17:41:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:05 INFO - '_': '/tools/buildbot/bin/python'} 17:41:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:41:05 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:41:05 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:41:05 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:41:05 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:41:05 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:41:05 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:41:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:41:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:41:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:41:07 INFO - Installing collected packages: mozsystemmonitor 17:41:07 INFO - Running setup.py install for mozsystemmonitor 17:41:07 INFO - Successfully installed mozsystemmonitor 17:41:07 INFO - Cleaning up... 17:41:07 INFO - Return code: 0 17:41:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:41: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:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41: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:41:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:07 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 0x24d61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2773b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2771290>, '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 0x2771b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2772040>, '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': '0e2a256762fed810e2f0f810000001b3-1489538426.60049-1832119983', '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:41:07 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:41:07 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:41:07 INFO - Using env: {'DISPLAY': ':0', 17:41:07 INFO - 'HOME': '/home/cltbld', 17:41:07 INFO - 'LANG': 'en_US.UTF-8', 17:41:07 INFO - 'LANGUAGE': 'en_US:en', 17:41:07 INFO - 'LOGNAME': 'cltbld', 17:41:07 INFO - 'MAIL': '/var/mail/cltbld', 17:41:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:07 INFO - 'MOZ_NO_REMOTE': '1', 17:41:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:07 INFO - 'NO_EM_RESTART': '1', 17:41:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:07 INFO - 'PWD': '/builds/slave/test', 17:41:07 INFO - 'SHELL': '/bin/bash', 17:41:07 INFO - 'SHLVL': '1', 17:41:07 INFO - 'TERM': 'linux', 17:41:07 INFO - 'TMOUT': '86400', 17:41:07 INFO - 'USER': 'cltbld', 17:41:07 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1489538426.60049-1832119983', 17:41:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:07 INFO - '_': '/tools/buildbot/bin/python'} 17:41:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:08 INFO - Downloading/unpacking jsonschema==2.5.1 17:41:08 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:41:08 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:41:08 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:41:08 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:41:08 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:41:08 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:41:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:41:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:41:10 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:41:10 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:41:10 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:41:10 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:41:10 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:41:10 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:41:10 INFO - Downloading functools32-3.2.3-2.tar.gz 17:41:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:41:10 INFO - warning: no files found matching '*.txt' 17:41:10 INFO - no previously-included directories found matching 'build' 17:41:10 INFO - no previously-included directories found matching 'dist' 17:41:10 INFO - no previously-included directories found matching '.git*' 17:41:10 INFO - Installing collected packages: jsonschema, functools32 17:41:10 INFO - Running setup.py install for functools32 17:41:10 INFO - warning: no files found matching '*.txt' 17:41:10 INFO - no previously-included directories found matching 'build' 17:41:10 INFO - no previously-included directories found matching 'dist' 17:41:10 INFO - no previously-included directories found matching '.git*' 17:41:10 INFO - Successfully installed jsonschema functools32 17:41:10 INFO - Cleaning up... 17:41:10 INFO - Return code: 0 17:41:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:41:10 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:41:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:10 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:41:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:10 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 0x24d61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2773b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2771290>, '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 0x2771b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2772040>, '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': '0e2a256762fed810e2f0f810000001b3-1489538426.60049-1832119983', '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:41:10 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:41:10 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:41:10 INFO - Using env: {'DISPLAY': ':0', 17:41:10 INFO - 'HOME': '/home/cltbld', 17:41:10 INFO - 'LANG': 'en_US.UTF-8', 17:41:10 INFO - 'LANGUAGE': 'en_US:en', 17:41:10 INFO - 'LOGNAME': 'cltbld', 17:41:10 INFO - 'MAIL': '/var/mail/cltbld', 17:41:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:10 INFO - 'MOZ_NO_REMOTE': '1', 17:41:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:10 INFO - 'NO_EM_RESTART': '1', 17:41:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:10 INFO - 'PWD': '/builds/slave/test', 17:41:10 INFO - 'SHELL': '/bin/bash', 17:41:10 INFO - 'SHLVL': '1', 17:41:10 INFO - 'TERM': 'linux', 17:41:10 INFO - 'TMOUT': '86400', 17:41:10 INFO - 'USER': 'cltbld', 17:41:10 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1489538426.60049-1832119983', 17:41:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:10 INFO - '_': '/tools/buildbot/bin/python'} 17:41:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:41:10 INFO - Cleaning up... 17:41:10 INFO - Return code: 0 17:41:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:41:10 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:41:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:10 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:41:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:10 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 0x24d61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2773b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2771290>, '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 0x2771b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2772040>, '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': '0e2a256762fed810e2f0f810000001b3-1489538426.60049-1832119983', '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:41:10 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:41:10 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:41:10 INFO - Using env: {'DISPLAY': ':0', 17:41:10 INFO - 'HOME': '/home/cltbld', 17:41:10 INFO - 'LANG': 'en_US.UTF-8', 17:41:10 INFO - 'LANGUAGE': 'en_US:en', 17:41:10 INFO - 'LOGNAME': 'cltbld', 17:41:10 INFO - 'MAIL': '/var/mail/cltbld', 17:41:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:10 INFO - 'MOZ_NO_REMOTE': '1', 17:41:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:10 INFO - 'NO_EM_RESTART': '1', 17:41:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:10 INFO - 'PWD': '/builds/slave/test', 17:41:10 INFO - 'SHELL': '/bin/bash', 17:41:10 INFO - 'SHLVL': '1', 17:41:10 INFO - 'TERM': 'linux', 17:41:10 INFO - 'TMOUT': '86400', 17:41:10 INFO - 'USER': 'cltbld', 17:41:10 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1489538426.60049-1832119983', 17:41:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:10 INFO - '_': '/tools/buildbot/bin/python'} 17:41:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:10 INFO - Downloading/unpacking blobuploader==1.2.4 17:41:10 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:41:10 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:41:10 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:41:11 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:41:11 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:41:11 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:41:13 INFO - Downloading blobuploader-1.2.4.tar.gz 17:41:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:41:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:41:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:41:13 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:41:13 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:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:41:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:41:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:41:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:41:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:41:13 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:41:13 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:41:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:41:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:41:13 INFO - Downloading docopt-0.6.1.tar.gz 17:41:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:41:13 INFO - Installing collected packages: blobuploader, requests, docopt 17:41:13 INFO - Running setup.py install for blobuploader 17:41:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:41:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:41:13 INFO - Running setup.py install for requests 17:41:14 INFO - Running setup.py install for docopt 17:41:14 INFO - Successfully installed blobuploader requests docopt 17:41:14 INFO - Cleaning up... 17:41:14 INFO - Return code: 0 17:41:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:41:14 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:41:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:14 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:41:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:14 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 0x24d61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2773b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2771290>, '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 0x2771b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2772040>, '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': '0e2a256762fed810e2f0f810000001b3-1489538426.60049-1832119983', '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:41:14 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:41:14 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:41:14 INFO - Using env: {'DISPLAY': ':0', 17:41:14 INFO - 'HOME': '/home/cltbld', 17:41:14 INFO - 'LANG': 'en_US.UTF-8', 17:41:14 INFO - 'LANGUAGE': 'en_US:en', 17:41:14 INFO - 'LOGNAME': 'cltbld', 17:41:14 INFO - 'MAIL': '/var/mail/cltbld', 17:41:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:14 INFO - 'MOZ_NO_REMOTE': '1', 17:41:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:14 INFO - 'NO_EM_RESTART': '1', 17:41:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:14 INFO - 'PWD': '/builds/slave/test', 17:41:14 INFO - 'SHELL': '/bin/bash', 17:41:14 INFO - 'SHLVL': '1', 17:41:14 INFO - 'TERM': 'linux', 17:41:14 INFO - 'TMOUT': '86400', 17:41:14 INFO - 'USER': 'cltbld', 17:41:14 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1489538426.60049-1832119983', 17:41:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:14 INFO - '_': '/tools/buildbot/bin/python'} 17:41:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:41:14 INFO - Running setup.py (path:/tmp/pip-l6JCfw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:41:14 INFO - Running setup.py (path:/tmp/pip-k2IQTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:41:14 INFO - Running setup.py (path:/tmp/pip-Aku9T5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:41:14 INFO - Running setup.py (path:/tmp/pip-4OOUlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:41:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:41:14 INFO - Running setup.py (path:/tmp/pip-paj8rB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:41:15 INFO - Running setup.py (path:/tmp/pip-otwNB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:41:15 INFO - Running setup.py (path:/tmp/pip-RkJPo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:41:15 INFO - Running setup.py (path:/tmp/pip-kZ3ySU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:41:15 INFO - Running setup.py (path:/tmp/pip-KHEPFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:41:15 INFO - Running setup.py (path:/tmp/pip-k6j1d6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:41:15 INFO - Running setup.py (path:/tmp/pip-Qg17Ba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:41:15 INFO - Running setup.py (path:/tmp/pip-36xnL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:41:15 INFO - Running setup.py (path:/tmp/pip-3SeraX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:41:15 INFO - Running setup.py (path:/tmp/pip-ojcJiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:41:15 INFO - Running setup.py (path:/tmp/pip-SCGMzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:41:15 INFO - Running setup.py (path:/tmp/pip-Z6e_bP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:41:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:41:15 INFO - Running setup.py (path:/tmp/pip-WhLJXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:41:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:41:15 INFO - Running setup.py install for manifestparser 17:41:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:41:16 INFO - Running setup.py install for mozcrash 17:41:16 INFO - Running setup.py install for mozdebug 17:41:16 INFO - Running setup.py install for mozdevice 17:41:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:41:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:41:16 INFO - Running setup.py install for mozfile 17:41:16 INFO - Running setup.py install for mozhttpd 17:41:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:41:16 INFO - Running setup.py install for mozinfo 17:41:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:41:16 INFO - Running setup.py install for mozInstall 17:41:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:41:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:41:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:41:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:41:16 INFO - Running setup.py install for mozleak 17:41:16 INFO - Running setup.py install for mozlog 17:41:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:41:16 INFO - Running setup.py install for moznetwork 17:41:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:41:17 INFO - Running setup.py install for mozprocess 17:41:17 INFO - Running setup.py install for mozprofile 17:41:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:41:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:41:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:41:17 INFO - Running setup.py install for mozrunner 17:41:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:41:17 INFO - Running setup.py install for mozscreenshot 17:41:17 INFO - Running setup.py install for moztest 17:41:17 INFO - Running setup.py install for mozversion 17:41:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:41:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:41:17 INFO - Cleaning up... 17:41:17 INFO - Return code: 0 17:41:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:41:17 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:41:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:17 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:41:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:17 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 0x24d61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2773b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2771290>, '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 0x2771b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2772040>, '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': '0e2a256762fed810e2f0f810000001b3-1489538426.60049-1832119983', '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:41:17 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:41:17 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:41:17 INFO - Using env: {'DISPLAY': ':0', 17:41:17 INFO - 'HOME': '/home/cltbld', 17:41:17 INFO - 'LANG': 'en_US.UTF-8', 17:41:17 INFO - 'LANGUAGE': 'en_US:en', 17:41:17 INFO - 'LOGNAME': 'cltbld', 17:41:17 INFO - 'MAIL': '/var/mail/cltbld', 17:41:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:17 INFO - 'MOZ_NO_REMOTE': '1', 17:41:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:17 INFO - 'NO_EM_RESTART': '1', 17:41:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:17 INFO - 'PWD': '/builds/slave/test', 17:41:17 INFO - 'SHELL': '/bin/bash', 17:41:17 INFO - 'SHLVL': '1', 17:41:17 INFO - 'TERM': 'linux', 17:41:17 INFO - 'TMOUT': '86400', 17:41:17 INFO - 'USER': 'cltbld', 17:41:17 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1489538426.60049-1832119983', 17:41:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:17 INFO - '_': '/tools/buildbot/bin/python'} 17:41:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:41:17 INFO - Running setup.py (path:/tmp/pip-l7BWwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:41:18 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:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:41:18 INFO - Running setup.py (path:/tmp/pip-g4fkIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:41:18 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:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:41:18 INFO - Running setup.py (path:/tmp/pip-ViK_dC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:41:18 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:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:41:18 INFO - Running setup.py (path:/tmp/pip-WhmPZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:41:18 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:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:41:18 INFO - Running setup.py (path:/tmp/pip-QhxAy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:41:18 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:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:41:18 INFO - Running setup.py (path:/tmp/pip-V1c5a0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:41:18 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:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:41:18 INFO - Running setup.py (path:/tmp/pip-COcxfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:41:18 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:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:41:18 INFO - Running setup.py (path:/tmp/pip-oGQUz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:41:18 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:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:41:18 INFO - Running setup.py (path:/tmp/pip-wIv_VC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:41:18 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:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:41:18 INFO - Running setup.py (path:/tmp/pip-dVZHv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:41:18 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:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:41:18 INFO - Running setup.py (path:/tmp/pip-WuzUnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:41:18 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:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:41:18 INFO - Running setup.py (path:/tmp/pip-tOuagM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:41:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:41:18 INFO - Running setup.py (path:/tmp/pip-hiqQKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:41:18 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:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:41:18 INFO - Running setup.py (path:/tmp/pip-e9BEtX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:41:18 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:41:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:41:18 INFO - Running setup.py (path:/tmp/pip-zTO9h3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:41:19 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:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:41:19 INFO - Running setup.py (path:/tmp/pip-pPhfMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:41:19 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:41:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:41:19 INFO - Running setup.py (path:/tmp/pip-MNHTRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:41:19 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:41:19 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:41:19 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:41:19 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:41:19 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:41:19 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:41:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:41:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:41:19 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:41:19 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:41:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:41:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:41:21 INFO - Downloading blessings-1.6.tar.gz 17:41:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:41:21 INFO - Installing collected packages: blessings 17:41:21 INFO - Running setup.py install for blessings 17:41:21 INFO - Successfully installed blessings 17:41:21 INFO - Cleaning up... 17:41:21 INFO - Return code: 0 17:41:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:41:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:41:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:41:21 INFO - Reading from file tmpfile_stdout 17:41:21 INFO - Current package versions: 17:41:21 INFO - argparse == 1.2.1 17:41:21 INFO - blessings == 1.6 17:41:21 INFO - blobuploader == 1.2.4 17:41:21 INFO - docopt == 0.6.1 17:41:21 INFO - functools32 == 3.2.3-2 17:41:21 INFO - jsonschema == 2.5.1 17:41:21 INFO - manifestparser == 1.1 17:41:21 INFO - mozInstall == 1.12 17:41:21 INFO - mozcrash == 1.0 17:41:21 INFO - mozdebug == 0.1 17:41:21 INFO - mozdevice == 0.49 17:41:21 INFO - mozfile == 1.2 17:41:21 INFO - mozhttpd == 0.7 17:41:21 INFO - mozinfo == 0.9 17:41:21 INFO - mozleak == 0.1 17:41:21 INFO - mozlog == 3.4 17:41:21 INFO - moznetwork == 0.27 17:41:21 INFO - mozprocess == 0.25 17:41:21 INFO - mozprofile == 0.28 17:41:21 INFO - mozrunner == 6.13 17:41:21 INFO - mozscreenshot == 0.1 17:41:21 INFO - mozsystemmonitor == 0.3 17:41:21 INFO - moztest == 0.8 17:41:21 INFO - mozversion == 1.4 17:41:21 INFO - psutil == 3.1.1 17:41:21 INFO - requests == 1.2.3 17:41:21 INFO - wsgiref == 0.1.2 17:41:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:41:21 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:41:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:21 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:41:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:21 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 0x24d61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2773b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2771290>, '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 0x2771b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2772040>, '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': '0e2a256762fed810e2f0f810000001b3-1489538426.60049-1832119983', '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:41:21 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:41:21 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:41:21 INFO - Using env: {'DISPLAY': ':0', 17:41:21 INFO - 'HOME': '/home/cltbld', 17:41:21 INFO - 'LANG': 'en_US.UTF-8', 17:41:21 INFO - 'LANGUAGE': 'en_US:en', 17:41:21 INFO - 'LOGNAME': 'cltbld', 17:41:21 INFO - 'MAIL': '/var/mail/cltbld', 17:41:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:21 INFO - 'MOZ_NO_REMOTE': '1', 17:41:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:21 INFO - 'NO_EM_RESTART': '1', 17:41:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:21 INFO - 'PWD': '/builds/slave/test', 17:41:21 INFO - 'SHELL': '/bin/bash', 17:41:21 INFO - 'SHLVL': '1', 17:41:21 INFO - 'TERM': 'linux', 17:41:21 INFO - 'TMOUT': '86400', 17:41:21 INFO - 'USER': 'cltbld', 17:41:21 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1489538426.60049-1832119983', 17:41:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:21 INFO - '_': '/tools/buildbot/bin/python'} 17:41:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:21 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:41:21 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:41:21 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:41:21 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:41:21 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:41:21 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:41:21 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:41:21 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:41:21 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:41:21 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:41:21 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:41:21 INFO - Cleaning up... 17:41:21 INFO - Return code: 0 17:41:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:41:21 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:41:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:41:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:21 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:41:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:41:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:41:21 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 0x24d61f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25cea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2773b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2771290>, '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 0x2771b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2772040>, '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': '0e2a256762fed810e2f0f810000001b3-1489538426.60049-1832119983', '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:41:21 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:41:21 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:41:21 INFO - Using env: {'DISPLAY': ':0', 17:41:21 INFO - 'HOME': '/home/cltbld', 17:41:21 INFO - 'LANG': 'en_US.UTF-8', 17:41:21 INFO - 'LANGUAGE': 'en_US:en', 17:41:21 INFO - 'LOGNAME': 'cltbld', 17:41:21 INFO - 'MAIL': '/var/mail/cltbld', 17:41:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:21 INFO - 'MOZ_NO_REMOTE': '1', 17:41:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:21 INFO - 'NO_EM_RESTART': '1', 17:41:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:21 INFO - 'PWD': '/builds/slave/test', 17:41:21 INFO - 'SHELL': '/bin/bash', 17:41:21 INFO - 'SHLVL': '1', 17:41:21 INFO - 'TERM': 'linux', 17:41:21 INFO - 'TMOUT': '86400', 17:41:21 INFO - 'USER': 'cltbld', 17:41:21 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1489538426.60049-1832119983', 17:41:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:21 INFO - '_': '/tools/buildbot/bin/python'} 17:41:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:41:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:41:22 INFO - Cleaning up... 17:41:22 INFO - Return code: 0 17:41:22 INFO - Running post-action listener: _resource_record_post_action 17:41:22 INFO - Running post-action listener: _start_resource_monitoring 17:41:22 INFO - Starting resource monitoring. 17:41:22 INFO - [mozharness: 2017-03-15 00:41:22.224458Z] Finished create-virtualenv step (success) 17:41:22 INFO - [mozharness: 2017-03-15 00:41:22.225393Z] Running install step. 17:41:22 INFO - Running pre-action listener: _resource_record_pre_action 17:41:22 INFO - Running main action method: install 17:41:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:41:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:41:22 INFO - Reading from file tmpfile_stdout 17:41:22 INFO - Detecting whether we're running mozinstall >=1.0... 17:41:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:41:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:41:22 INFO - Reading from file tmpfile_stdout 17:41:22 INFO - Output received: 17:41:22 INFO - Usage: mozinstall [options] installer 17:41:22 INFO - Options: 17:41:22 INFO - -h, --help show this help message and exit 17:41:22 INFO - -d DEST, --destination=DEST 17:41:22 INFO - Directory to install application into. [default: 17:41:22 INFO - "/builds/slave/test"] 17:41:22 INFO - --app=APP Application being installed. [default: firefox] 17:41:22 INFO - mkdir: /builds/slave/test/build/application 17:41:22 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:41:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:41:39 INFO - Reading from file tmpfile_stdout 17:41:39 INFO - Output received: 17:41:39 INFO - /builds/slave/test/build/application/firefox/firefox 17:41:39 INFO - Running post-action listener: _resource_record_post_action 17:41:39 INFO - [mozharness: 2017-03-15 00:41:39.087670Z] Finished install step (success) 17:41:39 INFO - [mozharness: 2017-03-15 00:41:39.087940Z] Running run-tests step. 17:41:39 INFO - Running pre-action listener: _resource_record_pre_action 17:41:39 INFO - Running main action method: run_tests 17:41:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:41:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:41:39 INFO - Python 2.7.3 17:41:39 INFO - Return code: 0 17:41:39 INFO - grabbing minidump binary from tooltool 17:41: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:41:39 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 0x2771290>, '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 0x2771b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2772040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:41:39 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:41:39 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:41:39 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:41:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:41:39 INFO - Return code: 0 17:41:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:41:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:41:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:41:39 INFO - ENV: RUST_BACKTRACE is now 1 17:41:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:41:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:41:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aRlMdMDkQUSqK3Kpnp2-ig/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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:41:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aRlMdMDkQUSqK3Kpnp2-ig/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-058 --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:41:39 INFO - Using env: {'DISPLAY': ':0', 17:41:39 INFO - 'HOME': '/home/cltbld', 17:41:39 INFO - 'LANG': 'en_US.UTF-8', 17:41:39 INFO - 'LANGUAGE': 'en_US:en', 17:41:39 INFO - 'LOGNAME': 'cltbld', 17:41:39 INFO - 'MAIL': '/var/mail/cltbld', 17:41:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:41:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:41:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:41:39 INFO - 'MOZ_NO_REMOTE': '1', 17:41:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:41:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:41:39 INFO - 'NO_EM_RESTART': '1', 17:41:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:41:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:41:39 INFO - 'PWD': '/builds/slave/test', 17:41:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:41:39 INFO - 'RUST_BACKTRACE': '1', 17:41:39 INFO - 'SHELL': '/bin/bash', 17:41:39 INFO - 'SHLVL': '1', 17:41:39 INFO - 'TERM': 'linux', 17:41:39 INFO - 'TMOUT': '86400', 17:41:39 INFO - 'USER': 'cltbld', 17:41:39 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1489538426.60049-1832119983', 17:41:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:41:39 INFO - '_': '/tools/buildbot/bin/python'} 17:41:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aRlMdMDkQUSqK3Kpnp2-ig/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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:41:39 INFO - mozversion application_buildid: 20170314234252 17:41:39 INFO - mozversion application_changeset: fd8bdabb4813164e70b51d02b420e3659eb38536 17:41:39 INFO - mozversion application_display_name: FirefoxDeveloperEdition 17:41:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:41:39 INFO - mozversion application_name: Firefox 17:41:39 INFO - mozversion application_remotingname: firefox-dev 17:41:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:41:39 INFO - mozversion application_vendor: Mozilla 17:41:39 INFO - mozversion application_version: 54.0a2 17:41:39 INFO - mozversion platform_buildid: 20170314234252 17:41:39 INFO - mozversion platform_changeset: fd8bdabb4813164e70b51d02b420e3659eb38536 17:41:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:41:39 INFO - mozversion platform_version: 54.0a2 17:41:39 INFO - using testdate: 1489538499 17:41:39 INFO - actual date: 1489538499 17:41:39 INFO - starting webserver on 'localhost:58324' 17:41:39 INFO - SUITE-START | Running 2 tests 17:41:39 INFO - TEST-START | dromaeo_css 17:41:39 INFO - operating with platform_type : linux_ 17:41:39 INFO - Initialising browser for dromaeo_css test... 17:41:39 INFO - TEST-INFO | started process 3305 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYAF9WE/profile http://localhost:58324/getInfo.html) 17:41:43 INFO - PROCESS | 3305 | __metrics Screen width/height:1600/1200 17:41:43 INFO - PROCESS | 3305 | colorDepth:24 17:41:43 INFO - PROCESS | 3305 | Browser inner width/height: 1024/697 17:41:43 INFO - PROCESS | 3305 | __metrics 17:41:45 INFO - PROCESS | 3305 | 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:41:45 INFO - PROCESS | 3305 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:41:45 INFO - TEST-INFO | 3305: exit 0 17:41:45 INFO - Browser initialized. 17:41:45 INFO - Running cycle 1/1 for dromaeo_css test... 17:41:45 INFO - TEST-INFO | started process 3400 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYAF9WE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:41:57 INFO - PROCESS | 3400 | RSS: Main: 139255808 17:41:57 INFO - PROCESS | 3400 | 17:44:59 INFO - PROCESS | 3400 | Cycle 1(1): loaded http://localhost:58324/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58324/tests/dromaeo/cssquery-ext.html) 17:45:00 INFO - PROCESS | 3400 | RSS: Main: 246321152 17:45:00 INFO - PROCESS | 3400 | 17:46:47 INFO - PROCESS | 3400 | ************************* 17:46:47 INFO - PROCESS | 3400 | A coding exception was thrown and uncaught in a Task. 17:46:47 INFO - PROCESS | 3400 | 17:46:47 ERROR - PROCESS | 3400 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:46:47 INFO - PROCESS | 3400 | Full stack: 17:46:47 INFO - PROCESS | 3400 | ************************* 17:48:02 INFO - PROCESS | 3400 | Cycle 1(1): loaded http://localhost:58324/tests/dromaeo/cssquery-ext.html (next: http://localhost:58324/tests/dromaeo/cssquery-jquery.html) 17:48:03 INFO - PROCESS | 3400 | RSS: Main: 222896128 17:48:03 INFO - PROCESS | 3400 | 17:51:05 INFO - PROCESS | 3400 | Cycle 1(1): loaded http://localhost:58324/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58324/tests/dromaeo/cssquery-mootools.html) 17:51:05 INFO - PROCESS | 3400 | RSS: Main: 201375744 17:51:05 INFO - PROCESS | 3400 | 17:54:07 INFO - PROCESS | 3400 | Cycle 1(1): loaded http://localhost:58324/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58324/tests/dromaeo/cssquery-prototype.html) 17:54:08 INFO - PROCESS | 3400 | RSS: Main: 193933312 17:54:08 INFO - PROCESS | 3400 | 17:57:11 INFO - PROCESS | 3400 | Cycle 1(1): loaded http://localhost:58324/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58324/tests/dromaeo/cssquery-yui.html) 17:57:11 INFO - PROCESS | 3400 | RSS: Main: 174858240 17:57:11 INFO - PROCESS | 3400 | 18:00:14 INFO - PROCESS | 3400 | Cycle 1(1): loaded http://localhost:58324/tests/dromaeo/cssquery-yui.html (next: http://localhost:58324/tests/dromaeo/cssquery-dojo.html) 18:00:14 INFO - PROCESS | 3400 | RSS: Main: 268939264 18:00:14 INFO - PROCESS | 3400 | 18:00:14 INFO - PROCESS | 3400 | __start_tp_report 18:00:14 INFO - PROCESS | 3400 | _x_x_mozilla_page_load 18:00:14 INFO - PROCESS | 3400 | _x_x_mozilla_page_load_details 18:00:14 INFO - PROCESS | 3400 | |i|pagename|runs| 18:00:14 INFO - PROCESS | 3400 | |0;dojo.html;3401.0137060252537;3410.3861304965103;3446.9655303446975;3476.30473905219;3495.5805303363586;5753.884922301557;5769;5772.5670574706955;5798.420157984199;5812.360640329565;5775.162601422791;5830.679312637803;5832.825015249538;5837.182794408786;5842.853928651786;5144.871378215537;5148.897022059557;5186;5194.714290714028;5204.245384419257;5119.308893299412;5125.8462246132485;5132.358455193101;5253.080710875601;5259.526642602165;5139.126348520742;5194.220866869962;5205.557527610158;5218.373795144588;5230.032443997854;5204.76578553966;5208.088584497736;5208.453112423198;5211.635185537033;5241.42344342122;4940.061388336205;5026.447090820006;5132.948670513284;5142.07442660321;5203.089459344599;5651.039323315046;5656.151577263402;5740.942590574083;5815;5819.650820950714;6184.783532576338;6227.688615569249;6236.438720515175;6240.937590624127;6249.78125765596;6299.212598425197;6299.9370006299805;6307.243130824285;6312.021636646327;6313.715882785285;5645.689487078209;5648;5770.2498675171955;5799.82600521985;5840.269966254218;6338.651374174372;6344.936550634435;6359.268684101295;6364.427201551883;6370.968145159337;6138.938610613836;6139.2325959255095;6144.446999770043;6157.353477884758;6164.722587483574;5973.492253158443;5998.610090344201;6109.230455681918;6212.285587157535;6266.467350275187;6179.5056395488255;6191.938080619227;6219.595726277777;6220.720067596969;6228.252609686776;5961.046232602849;5981.760729570856;5985.730642121115;5993.640381577119;6033.095035744674;4618.884527886763;4623.722576645412;4628.467726211461;4681.485036646034;4713.8350157745;4246.639035682002;4260.339647354665;4273.294906340481;4273.465816772903;4310.030243195256;5781.219535362672;5820.70896455184;5883.441073098049;5963.075723262901;5970.164177015221;6137.193127861533;6138.1738283688655;6152.784652537229;6160.537959653044;6202.4417802398;5959.970200148971;5970.402959704082;5971.731272092767;5998.130271110752;6011.7595296187665;5265.131253343156;5296.364436267596;5300.3639563252655;5306;5306.071437498423;6241;6316.526260530571;6399.392057754506;6498.545101842826;6585.604863708193;6245;6249.34381889895;6256.5620406572925;6264.185655864709;6265.937340626535;6531.804045878631;6532.183477065367;6579.4736421085245;6580.967095164494;6585.670716464062;5931.881362372815;6199.721012554356;6204.472619827185;6206.472449841814;6209.192804935329;6103.145559621567;6167.876642467215;6180.072989051679;6290.559660823698;6301.275353334425;6082.9695851520455;6097.512199023979;6097.7072380913805;6097.725602347994;6122.663253521099;6022.66875321844;6042.879142417215;6081.969590152021;6096.268447786294;6108.08378743192;5892.027815410409;5937;5978.043513037893;5996.820095397145;6014.969925150522;6061.6666083365835;6066.848328791815;6070.575059745775;6071.5446341523675;6091.451769340781;5763;5810.041343178328;5818.981678206213;5904.734286957011;5952.285725712942 18:00:14 INFO - PROCESS | 3400 | |1;ext.html;762.6148794858595;831.5800520737027;834.1158372125545;893.6648756716231;900.6262401103543;30987.69012309879;31384;33534.49698254522;33601.327973440544;44276.557234427644;46074.76962615191;46302.536974630246;46327.76836115823;46347.53652463474;46349;9104.908950910489;9254.907450925506;9257.768555786091;9261.073892610751;9265.166135047844;7237.855242895139;7414.925850741504;10285.588576456932;10531.26281160319;10537.84193237102;10848.837267440995;10886.455677216147;10892.292001019909;10900.34597924127;10902.890971090266;10561;10597.788044239149;10599.046085852311;10604.363738175696;10610.893891061069;10498.107660848837;10542.367457952547;10560.683179504627;10566.207534434949;10570.682879513626;42088.78955605233;42233.57766422358;42320;42346;42363;4092.9181416371803;4116.361963895601;4142.316517774563;4193.685473589462;4219.852305169335;29318.267043323875;29439.85280073586;29805.701942980726;29852.55221171684;29975;4345.565443455661;4443.933340999887;4447.332900064984;4457.3091170868565;4551.112533056055;247796;248889;249504;251110;252009.99999999817;54276.45723542793;54470;54599.727001364736;54618.180727289124;54631.453685462635;56893;56961.43038569561;56983.14525282124;56988.71505642528;57081;15273.159976201194;15417.383304667912;15483.380664773507;15573.922130389275;15575.299111539782;13260.734785304432;13280.269585172715;13288.933555332162;13289.468421263235;13299.66750831237;10756.247062705692;10884.183686223407;13622.863771362358;13630.591082267549;14010.369533371022;5231.8168864089575;5321.175217841241;5326.227696983916;5333.946660533423;5347.171188465794;1012.6253286284121;1014.832552628808;1019.5267837974204;1047.4710271312938;1064.1327318235612;28148;28618.713812861606;29115.27211819679;29431.11706648804;29865.850670746506;1098.8956049175315;1107.545906178463;1115.1859142825783;1120.073473625363;1136.4090672850073;14775.92612036933;15589.376424943102;15727.292271847795;15765.68468630621;15792.131432771308;339843;343043;343827;344154;345094;58586;58673.413265867646;58755;58762;58788;1501.594569466238;1532.1113754022863;1532.785410042595;1557.3381312941954;1568.7176308264623;26683;27952.30119247035;28368.71631283661;28397.290067748472;28425.85787071134;42972.140557189305;43097;43114;43208;43215.78392108145;303204;303430;303584;304014;304277;26636.8668156658;34528;35045.29909401849;35107.64892351146;35213.471797923565;32643;32803.34393312168;43124.137517248855;47859.521404785504;48023;37693.81153094217;37877;38271.80864095662;38516.42225366566;39641.60358396379;38208.61791382162;38292.234155317296;38460.61539384682;38595.614043860325;38725.03187420337;35925;36152.4577131338;39463;39805.40291895566;39923;29846.701532985262;31355;32366.838165809022;32431.189220268738;32535.18662033468;25683.3579160515;25781.226563203134;25837.41625837401;26036.01326334927;26242.163048586415 18:00:14 INFO - PROCESS | 3400 | |2;jquery.html;450.24583822097975;459.7861994172709;460.6982426510635;481.5786187086299;484.8521201033686;19803.603927921435;19930;21332;21439.892800535996;21514.677279840816;21611.45971350717;21743.23898663547;22082.227122050732;22197.556048879054;22373.888130559364;6629.701663425158;6718.496112791548;6817.693203805816;6865.0732151159455;6890.931090689079;6727.058211850345;6790.762323318685;6823.965880170592;6826.829329266759;6829.453643708516;6488.416042556169;6671.5997040177745;6800.863982720342;6827.146606674166;6846.623435711034;6569.93430065698;6659.93340066598;6725.293844146343;6817.113775209215;6822.317768223163;6503.187101612299;6519.445847103002;6520.836979075513;6521.380468855451;6524.412802847766;24516.754832451625;25005;25039.24882253535;25242.49515009708;25248.49503009948;3025.183200535865;3083.6145481814774;3093.3967876264137;3143.2613335866054;3150.4329220740256;16263.674726505404;16507.422240221655;16639;16690.58273543159;16738.66522669552;2344.2732752846673;2350.4476448034698;2413;2460.729319774823;2464.322311364371;95204.52397738036;95282;95934.52032739861;97977;99157.50421247848;18600;18886.716699249522;18976.810231897503;19030.52423689391;19160.808391915903;33931.66068339335;33987.83006084954;34011.97964061082;34026.31947361039;34253.828730856185;10886.183536234656;10918.781624367468;10926.235163538477;11130.944345278222;11179.552817887356;9007.504587247764;9045.412048216846;9069.365144439826;9080.228180604723;9261.72214833556;9725.0761177688;10128.848067278997;10130.392176469435;10220.386776793417;10261.179105671528;3972.3514741382583;4059.7361171523758;4068.5117785865295;4187.181105022337;4200.432941552913;1010.6765834932751;1011.3375738891039;1012.8987101289812;1024.894569454554;1025.8358662613946;20947.79052209489;21117.366479005654;21416.143354265656;21659.458513537287;21730.239441619466;993.8211121997965;999.5202302894651;1011.1556850030161;1013.9695809125737;1018.5111146649501;11551;11892.405379730979;12232.81650775239;12376.257424554555;12457.813132803016;711425;711898;719061;734668;742722;112860.43569782098;119621;123723;124235.3788231053;127075;1340.7251513439917;1356.328617334406;1377.1736957825426;1383.3498255819748;1385.4873696732475;18390.81609183891;18962.43112706621;19168.61662766765;19241.4227573173;19355.322563710204;50051.749741251064;50213.49786502088;50702;50873.74563127161;51149.23276150935;65961.34038659552;67053.32946670472;67196;68193.3180668187;68440;9570.665026724031;11722.648320550397;11793.174477786473;11856.822147667619;12057.457414416196;13432.865671343552;13555.525556605471;13556.796648050089;13596.728065438834;13795.10331828428;11253;11718.179727419;12001.279923204636;12137.332446715516;12171.2697238166;10248.333858299187;10743.785124297627;11429.314241145557;11458;11636.12729045342;7108.751193708195;12457.439415226518;12465.688357791129;12887.806682899576;13291.468341266242;12200.938995304967;12289.692757680772;12322.568710095104;12378.75242495163;12774.425150868048;12015.819762703391;12299.69250768738;12374.195677280948;12451.937740311241;12547.121701480808 18:00:14 INFO - PROCESS | 3400 | |3;mootools.html;1453.462218978978;1581.4148764956967;1599.5761123302334;1610.9194540272988;1613.798275215598;9332.860007099891;11280.32318060917;11458.541658333677;11501.827472587918;11558.497395338594;11602.129840261992;11653.650390488277;11676.824847627271;11679.824802627967;11681.182317237775;1997.2011195521834;2430.2101816909485;2474.604063349864;2476.987615061922;2481.553320402327;2075.740532433446;2094.3298144593737;2095.486605781578;2241.932742017742;2317.6407656813135;2486.6643003194517;2501.4121681404945;2508.3227528567277;2509.046562306321;2509.4353770401694;2347.7417484076823;2369.1589485732575;2384.523095380931;2392.3062311929693;2393.365758074112;2320;2351.2123438648073;2354.5526349993447;2361.8937147828387;2393.6888204533475;11289.661310160709;11383.886161138365;11384.203105782599;11394.829077563843;11398.31610103388;5692.971535142339;5819.039858423397;5844.795432159896;5847;5854.20968169296;3429.777064490825;3501.3347463981763;3524.259905419865;3551.982240088783;3637.2725454909123;1324.6622111361637;1347.8921686265173;1378.421063153478;1383.6125884752184;1446.1034158821599;17024.999999999876;17191.742123868153;17195.484135475956;17236.56908577283;17345.566360840952;4781.947971446276;4906.70559766408;5001.324821149098;5009.949900501021;5035.471275516092;14049.227292498806;14052;14068.226247556278;14071.788923166161;14076.648083797782;6023.247094113236;6027.065804800175;6041.697915104315;6042.093685947055;6046.425589568984;5319.973400132974;5345.251664766935;5450.863728406743;5493.121100623881;5499.752511137009;3918.2359439909515;4022.054817117975;4324.978375108104;4381.3208952612395;4490.820367185342;1196.1447564991074;1209.1415095282273;1209.8427204463364;1224.6142465123457;1230.4893469210356;1012.5696578953915;1024.774549599087;1028.711960651019;1029.7425643589104;1030.6083688198587;6522.347765223534;6631.801045968628;6746.291639377893;6775.93224067753;6886.793396198022;1089.3899416326724;1094.1848322999417;1104.3373975614568;1123.612353737959;1132.796096702585;4593.54064593538;4678.274867395559;4771.33201351811;4784.354112194878;4851.34506841579;14539.92730036343;14757.262136893112;14772.48296309624;14873.107613543221;14942.477013304482;13166.670833229055;13679.042467027213;14799.786118704007;14801.925990369979;14809.259537023107;10096.747581310527;10245.129164021142;10299.691009269734;10318.019788120117;10332.173426125892;6959.61722105289;7188.3530482254755;7241.239669834592;7274.199838017708;7342.926570734225;12341.321227332583;12433.316167610506;12698.492060317853;12834.67913302175;12843.165194262343;12541.686457838627;12931.547395841477;13095.083344165816;13126.14680045794;13214.801777973531;9911.10800028001;9973.950130249303;10081.69754907354;10084.193264538966;10098.596056157672;8117.10711821711;8294.004719433706;10229.181665466893;10815.242932994615;11011.229213955266;9163.312751543794;9492.477913714813;9581.808363832824;9593.088656577615;9837.557309921214;9488;9501.904980950378;9511.952440237754;9525.57134928916;9532.380395274286;8586.871196931927;8643.265322447662;8734.825303493768;8735.344849136467;8743.213110820057;6538.8365290868105;6588.5058620604605;6599.967000164968;6655.667216639245;6660.966695166493;6159.876802464015;6160.9383906160365;6177.4749146323065;6328.272248691275;6351.047342898602 18:00:14 INFO - PROCESS | 3400 | |4;prototype.html;414.5067369829902;415.5096985557045;431.3055979872407;447.16380368710514;448.7038554553994;5184.53339199472;5252.6848389096585;5255.84232473026;5295.391030031547;5364.91952620711;5091.821786237482;5141.871453213662;5166.638335316529;5259.237410575464;5281.96287134897;4355.869323920271;4368.099876553693;4371.169477799224;4373.803178856943;4379.321205213181;4353.2599458092045;4389.670774691895;4401.471823381199;4423.137488189805;4426.380306757057;4257.489101307848;4296.5273819879785;4329.9567004329865;4363.236433624119;4378.321360189176;4326.372675961999;4326.6754993375625;4337.284348082594;4358.3244597087505;4359.258925982559;4125.1749650070105;4135.338345864678;4144.191882582898;4172.311568591179;4187.099773548671;4853.326206278734;5026.371703537058;5102.795888164469;5104.259882317043;5157.277981082651;5048.823291184827;5095.974520127413;5096.643234973553;5131.461196574343;5148.279240906276;5384.057789886793;5469.808556700496;5487.204355368489;5490.423505531901;5511.944880551223;4523.70595911268;4527.660425468103;4558.293464512973;4564.5435456454425;4611.584957353821;5363.249145119647;5455.318085239345;5564.026295398329;5639.436056394369;5665.487397813341;4661.254199328091;4668.929966050512;4685.071830106183;4688.882777930579;4702.694324868872;4552.449089710031;4762;4805.495422980606;4821.783019764119;4837.806487740521;4891.309779621194;4938.123513065012;4963.652544321935;4995;5033.6224783141415;5342.572594192456;5391.622586418992;5393.298871146726;5409.945900541023;5433.130699088206;1589.3007076886133;1625.2929975460713;1642.4005238088012;1658.427842394372;1662.7339625659836;1250.1623911978995;1271.313490715022;1271.618514445681;1276.3363051213503;1293.9417726202344;5328.387235467893;5331.226972089025;5347.973260133675;5363.544098751572;5365.6244062916;5607.448610882039;5625;5633.859153521113;5640.633358831745;5644.85887852807;5142.794288228429;5265.552428043659;5377.838664840061;5380.273663055437;5386.272853164773;2924.619799426061;2935.7669778693;2937.839553376404;2953.3797902440297;2959.91962933532;5664.433556644302;5806.054971584566;5810.820942146695;5841.678707671119;5899.351071382144;5678.943210567924;5688.658680479184;5689.459501347365;5692.231548740867;5727.255456790674;5877.265341832185;5877.471027607536;5899.262592175978;5900.970495147497;5920.851978700567;5323.973380133075;5550.306211723535;5597.608167428241;5604.663720176639;5642.266505354278;5503.284573005483;5508.3114610673665;5526.392096869422;5539.7784088636;5590.440955904377;5597.384287728428;5698.1452782083015;5708.457696518824;5783.421657834351;5858.8242352729485;4926.866820631347;5000.974995125001;5023.723695196799;5066.923996139987;5073.923891141562;5443.265159203615;5578.665280083208;5634.352049514358;5657.4908258256955;5666.15007748841;5407.891382266547;5431.11675152268;5443.183522471502;5475.561955043508;5537.667739935456;5481.9716704819475;5493.7802487900035;5529.4470552945995;5539.279893613804;5592.049351610155;5289.68261904287;5488.313960754906;5490.725463726718;5514.310711161105;5588.916166257428;5498.505134537911;5511.145772405283;5527.44725527444;5560.91658625129;5581.237287542693;5238.5547228486;5465.1034951475785;5470.64440811346;5484.945150548603;5501.834944951658 18:00:14 INFO - PROCESS | 3400 | |5;yui.html;839.3662784597628;851.8083431227974;903.1329923273659;906.2795077913054;914.9248986728127;16906.492805215847;17866.374676886313;17923.73114403285;17924.64150716985;18015.18931648076;10705.625303114393;16264.83735162648;16288.592785180377;16380.83619163808;16414.261358238877;855.2943821347397;869.8129902071054;869.9956500217522;871.5947084605657;871.6861929705301;857.4083882121347;860.7331727164599;861.2851333393269;862.1550880137469;863.8876945997011;903.0969030969031;903.5933829776594;905.6422713028383;905.8595917632778;905.995470022649;901.8602116671926;902.6930843513204;902.7517432705993;903.3495882964255;904.4166512599337;660.8645227728305;660.9471242300605;661.1801366305795;661.3518751623388;661.4278648968656;17760.644787104316;17764.55588610295;17802.643947121116;17913.19390627425;17968.550786230317;17153.485395438158;17230.396936107176;17288.913555432267;17822.55443613907;17829.375971840924;13775;13863.930680346635;14002.719945601031;14040.227787471686;14087.859121408757;4121.072758629284;4153.501579810442;4196.895077623053;4220.936685949713;4290.506591741959;87456;87896;88891.55554222252;89225.55387223023;90171.09828901758;12946.67633309156;13083.803742943863;13209.273489957952;13256.668583285495;13304.933475332562;26021.73978260231;26112.608310875352;26163.607545886825;26163.869180654354;26239.73760262411;9086.136817002374;9147.954260228656;9287.721368358825;9605.711828645151;9653.565589548487;5136.717480538607;5198.012377648235;5199.350081239845;5282.445343238982;5366.91949620756;3697.5378077740284;3874.1476875087437;3890.8638197663513;3904.1020565270146;3918.040080180374;618.6226401894841;619.2043224456642;619.3094699410125;633.0915136778738;638.7349250061266;843.5065486690355;868.7914900423852;876.2420506262165;893.4014210478995;895.5074708910073;10524.842127368096;11250.212485125963;11399.544018239343;12056.276623402624;12097.818532722016;860.7245681382022;873.8776571280026;879.7228872905015;885.4819930340823;898.8067565473324;5223.4776522347465;5421.810236641778;5486.204500347428;5568.3318001839225;5568.805091821767;65373;65991;66508.33491665118;66787.66606166938;67667;56264.593385165696;63769.04346434807;68885.31114688789;69513.3048669517;70780.64609676918;60847.08729369063;61652.38347616556;63190.597731347836;64976.675116624116;65955.67022164955;11709.941450292694;12028.578999734968;12200.084993625336;12235.877641223475;12265.853475641905;42375.3643695351;42864.785676072665;43188.568114318456;43444;43942.34086488641;43778.78110609554;44352;47993;48670.26994595013;48884;13903.721925561635;13961.930190348983;14080.225587592371;14186.077904936146;14195.929020354832;16428.390907694593;16669.333226671282;16825.24286407139;16913;17155.742663860303;15367.769483457534;15723.21383930776;16225.59436014109;16383.262753175897;16938.40715574949;15920.681586367977;16241.269142888363;16497.91751041237;16931.407400740914;17251.223694934008;14457.27713614294;15082.019668721498;15097.54707358781;16125.032498050154;16188.352465901233;12692.936535317263;13165.605031848676;13300.41920807418;13849.584512464642;14005.127213404126;12516;12584.685382865502;12644;12979.28613926243;12985.091043626855 18:00:14 INFO - PROCESS | 3400 | __end_tp_report 18:00:14 INFO - PROCESS | 3400 | __start_cc_report 18:00:14 INFO - PROCESS | 3400 | _x_x_mozilla_cycle_collect,1014 18:00:14 INFO - PROCESS | 3400 | __end_cc_report 18:00:14 INFO - PROCESS | 3400 | __startTimestamp1489539614603__endTimestamp 18:00:14 INFO - PROCESS | 3400 | 18:00:14 INFO - PROCESS | 3400 | ------- Summary: start ------- 18:00:14 INFO - PROCESS | 3400 | Number of tests: 6 18:00:14 INFO - PROCESS | 3400 | 18:00:14 INFO - PROCESS | 3400 | [#0] dojo.html Cycles:165 Average:5746.06 Median:5973.49 stddev:664.69 (11.1%) stddev-sans-first:640.77 18:00:14 INFO - PROCESS | 3400 | Values: 3401.0 3410.4 3447.0 3476.3 3495.6 5753.9 5769.0 5772.6 5798.4 5812.4 5775.2 5830.7 5832.8 5837.2 5842.9 5144.9 5148.9 5186.0 5194.7 5204.2 5119.3 5125.8 5132.4 5253.1 5259.5 5139.1 5194.2 5205.6 5218.4 5230.0 5204.8 5208.1 5208.5 5211.6 5241.4 4940.1 5026.4 5132.9 5142.1 5203.1 5651.0 5656.2 5740.9 5815.0 5819.7 6184.8 6227.7 6236.4 6240.9 6249.8 6299.2 6299.9 6307.2 6312.0 6313.7 5645.7 5648.0 5770.2 5799.8 5840.3 6338.7 6344.9 6359.3 6364.4 6371.0 6138.9 6139.2 6144.4 6157.4 6164.7 5973.5 5998.6 6109.2 6212.3 6266.5 6179.5 6191.9 6219.6 6220.7 6228.3 5961.0 5981.8 5985.7 5993.6 6033.1 4618.9 4623.7 4628.5 4681.5 4713.8 4246.6 4260.3 4273.3 4273.5 4310.0 5781.2 5820.7 5883.4 5963.1 5970.2 6137.2 6138.2 6152.8 6160.5 6202.4 5960.0 5970.4 5971.7 5998.1 6011.8 5265.1 5296.4 5300.4 5306.0 5306.1 6241.0 6316.5 6399.4 6498.5 6585.6 6245.0 6249.3 6256.6 6264.2 6265.9 6531.8 6532.2 6579.5 6581.0 6585.7 5931.9 6199.7 6204.5 6206.5 6209.2 6103.1 6167.9 6180.1 6290.6 6301.3 6083.0 6097.5 6097.7 6097.7 6122.7 6022.7 6042.9 6082.0 6096.3 6108.1 5892.0 5937.0 5978.0 5996.8 6015.0 6061.7 6066.8 6070.6 6071.5 6091.5 5763.0 5810.0 5819.0 5904.7 5952.3 18:00:14 INFO - PROCESS | 3400 | 18:00:14 INFO - PROCESS | 3400 | [#1] ext.html Cycles:180 Average:47021.40 Median:32589.09 stddev:78816.32 (241.8%) stddev-sans-first:78960.89 18:00:14 INFO - PROCESS | 3400 | Values: 762.6 831.6 834.1 893.7 900.6 30987.7 31384.0 33534.5 33601.3 44276.6 46074.8 46302.5 46327.8 46347.5 46349.0 9104.9 9254.9 9257.8 9261.1 9265.2 7237.9 7414.9 10285.6 10531.3 10537.8 10848.8 10886.5 10892.3 10900.3 10902.9 10561.0 10597.8 10599.0 10604.4 10610.9 10498.1 10542.4 10560.7 10566.2 10570.7 42088.8 42233.6 42320.0 42346.0 42363.0 4092.9 4116.4 4142.3 4193.7 4219.9 29318.3 29439.9 29805.7 29852.6 29975.0 4345.6 4443.9 4447.3 4457.3 4551.1 247796.0 248889.0 249504.0 251110.0 252010.0 54276.5 54470.0 54599.7 54618.2 54631.5 56893.0 56961.4 56983.1 56988.7 57081.0 15273.2 15417.4 15483.4 15573.9 15575.3 13260.7 13280.3 13288.9 13289.5 13299.7 10756.2 10884.2 13622.9 13630.6 14010.4 5231.8 5321.2 5326.2 5333.9 5347.2 1012.6 1014.8 1019.5 1047.5 1064.1 28148.0 28618.7 29115.3 29431.1 29865.9 1098.9 1107.5 1115.2 1120.1 1136.4 14775.9 15589.4 15727.3 15765.7 15792.1 339843.0 343043.0 343827.0 344154.0 345094.0 58586.0 58673.4 58755.0 58762.0 58788.0 1501.6 1532.1 1532.8 1557.3 1568.7 26683.0 27952.3 28368.7 28397.3 28425.9 42972.1 43097.0 43114.0 43208.0 43215.8 303204.0 303430.0 303584.0 304014.0 304277.0 26636.9 34528.0 35045.3 35107.6 35213.5 32643.0 32803.3 43124.1 47859.5 48023.0 37693.8 37877.0 38271.8 38516.4 39641.6 38208.6 38292.2 38460.6 38595.6 38725.0 35925.0 36152.5 39463.0 39805.4 39923.0 29846.7 31355.0 32366.8 32431.2 32535.2 25683.4 25781.2 25837.4 26036.0 26242.2 18:00:14 INFO - PROCESS | 3400 | 18:00:14 INFO - PROCESS | 3400 | [#2] jquery.html Cycles:180 Average:39208.86 Median:21736.74 stddev:118894.09 (547.0%) stddev-sans-first:119192.00 18:00:14 INFO - PROCESS | 3400 | Values: 450.2 459.8 460.7 481.6 484.9 19803.6 19930.0 21332.0 21439.9 21514.7 21611.5 21743.2 22082.2 22197.6 22373.9 6629.7 6718.5 6817.7 6865.1 6890.9 6727.1 6790.8 6824.0 6826.8 6829.5 6488.4 6671.6 6800.9 6827.1 6846.6 6569.9 6659.9 6725.3 6817.1 6822.3 6503.2 6519.4 6520.8 6521.4 6524.4 24516.8 25005.0 25039.2 25242.5 25248.5 3025.2 3083.6 3093.4 3143.3 3150.4 16263.7 16507.4 16639.0 16690.6 16738.7 2344.3 2350.4 2413.0 2460.7 2464.3 95204.5 95282.0 95934.5 97977.0 99157.5 18600.0 18886.7 18976.8 19030.5 19160.8 33931.7 33987.8 34012.0 34026.3 34253.8 10886.2 10918.8 10926.2 11130.9 11179.6 9007.5 9045.4 9069.4 9080.2 9261.7 9725.1 10128.8 10130.4 10220.4 10261.2 3972.4 4059.7 4068.5 4187.2 4200.4 1010.7 1011.3 1012.9 1024.9 1025.8 20947.8 21117.4 21416.1 21659.5 21730.2 993.8 999.5 1011.2 1014.0 1018.5 11551.0 11892.4 12232.8 12376.3 12457.8 711425.0 711898.0 719061.0 734668.0 742722.0 112860.4 119621.0 123723.0 124235.4 127075.0 1340.7 1356.3 1377.2 1383.3 1385.5 18390.8 18962.4 19168.6 19241.4 19355.3 50051.7 50213.5 50702.0 50873.7 51149.2 65961.3 67053.3 67196.0 68193.3 68440.0 9570.7 11722.6 11793.2 11856.8 12057.5 13432.9 13555.5 13556.8 13596.7 13795.1 11253.0 11718.2 12001.3 12137.3 12171.3 10248.3 10743.8 11429.3 11458.0 11636.1 7108.8 12457.4 12465.7 12887.8 13291.5 12200.9 12289.7 12322.6 12378.8 12774.4 12015.8 12299.7 12374.2 12451.9 12547.1 18:00:14 INFO - PROCESS | 3400 | 18:00:14 INFO - PROCESS | 3400 | [#3] mootools.html Cycles:180 Average:7144.75 Median:2365.53 stddev:4559.25 (192.7%) stddev-sans-first:4551.98 18:00:14 INFO - PROCESS | 3400 | Values: 1453.5 1581.4 1599.6 1610.9 1613.8 9332.9 11280.3 11458.5 11501.8 11558.5 11602.1 11653.7 11676.8 11679.8 11681.2 1997.2 2430.2 2474.6 2477.0 2481.6 2075.7 2094.3 2095.5 2241.9 2317.6 2486.7 2501.4 2508.3 2509.0 2509.4 2347.7 2369.2 2384.5 2392.3 2393.4 2320.0 2351.2 2354.6 2361.9 2393.7 11289.7 11383.9 11384.2 11394.8 11398.3 5693.0 5819.0 5844.8 5847.0 5854.2 3429.8 3501.3 3524.3 3552.0 3637.3 1324.7 1347.9 1378.4 1383.6 1446.1 17025.0 17191.7 17195.5 17236.6 17345.6 4781.9 4906.7 5001.3 5009.9 5035.5 14049.2 14052.0 14068.2 14071.8 14076.6 6023.2 6027.1 6041.7 6042.1 6046.4 5320.0 5345.3 5450.9 5493.1 5499.8 3918.2 4022.1 4325.0 4381.3 4490.8 1196.1 1209.1 1209.8 1224.6 1230.5 1012.6 1024.8 1028.7 1029.7 1030.6 6522.3 6631.8 6746.3 6775.9 6886.8 1089.4 1094.2 1104.3 1123.6 1132.8 4593.5 4678.3 4771.3 4784.4 4851.3 14539.9 14757.3 14772.5 14873.1 14942.5 13166.7 13679.0 14799.8 14801.9 14809.3 10096.7 10245.1 10299.7 10318.0 10332.2 6959.6 7188.4 7241.2 7274.2 7342.9 12341.3 12433.3 12698.5 12834.7 12843.2 12541.7 12931.5 13095.1 13126.1 13214.8 9911.1 9974.0 10081.7 10084.2 10098.6 8117.1 8294.0 10229.2 10815.2 11011.2 9163.3 9492.5 9581.8 9593.1 9837.6 9488.0 9501.9 9512.0 9525.6 9532.4 8586.9 8643.3 8734.8 8735.3 8743.2 6538.8 6588.5 6600.0 6655.7 6661.0 6159.9 6160.9 6177.5 6328.3 6351.0 18:00:14 INFO - PROCESS | 3400 | 18:00:14 INFO - PROCESS | 3400 | [#4] prototype.html Cycles:180 Average:4788.17 Median:5285.82 stddev:1267.80 (24.0%) stddev-sans-first:1228.12 18:00:14 INFO - PROCESS | 3400 | Values: 414.5 415.5 431.3 447.2 448.7 5184.5 5252.7 5255.8 5295.4 5364.9 5091.8 5141.9 5166.6 5259.2 5282.0 4355.9 4368.1 4371.2 4373.8 4379.3 4353.3 4389.7 4401.5 4423.1 4426.4 4257.5 4296.5 4330.0 4363.2 4378.3 4326.4 4326.7 4337.3 4358.3 4359.3 4125.2 4135.3 4144.2 4172.3 4187.1 4853.3 5026.4 5102.8 5104.3 5157.3 5048.8 5096.0 5096.6 5131.5 5148.3 5384.1 5469.8 5487.2 5490.4 5511.9 4523.7 4527.7 4558.3 4564.5 4611.6 5363.2 5455.3 5564.0 5639.4 5665.5 4661.3 4668.9 4685.1 4688.9 4702.7 4552.4 4762.0 4805.5 4821.8 4837.8 4891.3 4938.1 4963.7 4995.0 5033.6 5342.6 5391.6 5393.3 5409.9 5433.1 1589.3 1625.3 1642.4 1658.4 1662.7 1250.2 1271.3 1271.6 1276.3 1293.9 5328.4 5331.2 5348.0 5363.5 5365.6 5607.4 5625.0 5633.9 5640.6 5644.9 5142.8 5265.6 5377.8 5380.3 5386.3 2924.6 2935.8 2937.8 2953.4 2959.9 5664.4 5806.1 5810.8 5841.7 5899.4 5678.9 5688.7 5689.5 5692.2 5727.3 5877.3 5877.5 5899.3 5901.0 5920.9 5324.0 5550.3 5597.6 5604.7 5642.3 5503.3 5508.3 5526.4 5539.8 5590.4 5597.4 5698.1 5708.5 5783.4 5858.8 4926.9 5001.0 5023.7 5066.9 5073.9 5443.3 5578.7 5634.4 5657.5 5666.2 5407.9 5431.1 5443.2 5475.6 5537.7 5482.0 5493.8 5529.4 5539.3 5592.0 5289.7 5488.3 5490.7 5514.3 5588.9 5498.5 5511.1 5527.4 5560.9 5581.2 5238.6 5465.1 5470.6 5484.9 5501.8 18:00:14 INFO - PROCESS | 3400 | 18:00:14 INFO - PROCESS | 3400 | [#5] yui.html Cycles:180 Average:18332.48 Median:23577.65 stddev:21730.23 (92.2%) stddev-sans-first:21751.49 18:00:14 INFO - PROCESS | 3400 | Values: 839.4 851.8 903.1 906.3 914.9 16906.5 17866.4 17923.7 17924.6 18015.2 10705.6 16264.8 16288.6 16380.8 16414.3 855.3 869.8 870.0 871.6 871.7 857.4 860.7 861.3 862.2 863.9 903.1 903.6 905.6 905.9 906.0 901.9 902.7 902.8 903.3 904.4 660.9 660.9 661.2 661.4 661.4 17760.6 17764.6 17802.6 17913.2 17968.6 17153.5 17230.4 17288.9 17822.6 17829.4 13775.0 13863.9 14002.7 14040.2 14087.9 4121.1 4153.5 4196.9 4220.9 4290.5 87456.0 87896.0 88891.6 89225.6 90171.1 12946.7 13083.8 13209.3 13256.7 13304.9 26021.7 26112.6 26163.6 26163.9 26239.7 9086.1 9148.0 9287.7 9605.7 9653.6 5136.7 5198.0 5199.4 5282.4 5366.9 3697.5 3874.1 3890.9 3904.1 3918.0 618.6 619.2 619.3 633.1 638.7 843.5 868.8 876.2 893.4 895.5 10524.8 11250.2 11399.5 12056.3 12097.8 860.7 873.9 879.7 885.5 898.8 5223.5 5421.8 5486.2 5568.3 5568.8 65373.0 65991.0 66508.3 66787.7 67667.0 56264.6 63769.0 68885.3 69513.3 70780.6 60847.1 61652.4 63190.6 64976.7 65955.7 11709.9 12028.6 12200.1 12235.9 12265.9 42375.4 42864.8 43188.6 43444.0 43942.3 43778.8 44352.0 47993.0 48670.3 48884.0 13903.7 13961.9 14080.2 14186.1 14195.9 16428.4 16669.3 16825.2 16913.0 17155.7 15367.8 15723.2 16225.6 16383.3 16938.4 15920.7 16241.3 16497.9 16931.4 17251.2 14457.3 15082.0 15097.5 16125.0 16188.4 12692.9 13165.6 13300.4 13849.6 14005.1 12516.0 12584.7 12644.0 12979.3 12985.1 18:00:14 INFO - PROCESS | 3400 | -------- Summary: end -------- 18:00:14 INFO - PROCESS | 3400 | 18:00:15 INFO - TEST-INFO | 3400: exit 0 18:00:15 INFO - TEST-OK | dromaeo_css | took 1115859ms 18:00:15 INFO - TEST-START | kraken 18:00:15 INFO - operating with platform_type : linux_ 18:00:15 INFO - Initialising browser for kraken test... 18:00:15 INFO - TEST-INFO | started process 3721 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUo8lZB/profile http://localhost:58324/getInfo.html) 18:00:19 INFO - PROCESS | 3721 | __metrics Screen width/height:1600/1200 18:00:19 INFO - PROCESS | 3721 | colorDepth:24 18:00:19 INFO - PROCESS | 3721 | Browser inner width/height: 1024/697 18:00:19 INFO - PROCESS | 3721 | __metrics 18:00:20 INFO - PROCESS | 3721 | 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" 18:00:20 INFO - PROCESS | 3721 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:00:21 INFO - TEST-INFO | 3721: exit 0 18:00:21 INFO - Browser initialized. 18:00:21 INFO - Running cycle 1/1 for kraken test... 18:00:21 INFO - TEST-INFO | started process 3819 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUo8lZB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:00:33 INFO - PROCESS | 3819 | RSS: Main: 139522048 18:00:33 INFO - PROCESS | 3819 | 18:00:35 INFO - PROCESS | 3819 | Cycle 1(1): loaded http://localhost:58324/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58324/tests/kraken/driver.html?testName=audio-beat-detection) 18:00:36 INFO - PROCESS | 3819 | RSS: Main: 182378496 18:00:36 INFO - PROCESS | 3819 | 18:00:38 INFO - PROCESS | 3819 | Cycle 1(1): loaded http://localhost:58324/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58324/tests/kraken/driver.html?testName=audio-dft) 18:00:39 INFO - PROCESS | 3819 | RSS: Main: 174129152 18:00:39 INFO - PROCESS | 3819 | 18:00:42 INFO - PROCESS | 3819 | Cycle 1(1): loaded http://localhost:58324/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58324/tests/kraken/driver.html?testName=audio-fft) 18:00:42 INFO - PROCESS | 3819 | RSS: Main: 265703424 18:00:42 INFO - PROCESS | 3819 | 18:00:45 INFO - PROCESS | 3819 | Cycle 1(1): loaded http://localhost:58324/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58324/tests/kraken/driver.html?testName=audio-oscillator) 18:00:45 INFO - PROCESS | 3819 | RSS: Main: 171716608 18:00:45 INFO - PROCESS | 3819 | 18:00:47 INFO - PROCESS | 3819 | Cycle 1(1): loaded http://localhost:58324/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58324/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:00:48 INFO - PROCESS | 3819 | RSS: Main: 175058944 18:00:48 INFO - PROCESS | 3819 | 18:00:51 INFO - PROCESS | 3819 | Cycle 1(1): loaded http://localhost:58324/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58324/tests/kraken/driver.html?testName=imaging-darkroom) 18:00:51 INFO - PROCESS | 3819 | RSS: Main: 213569536 18:00:51 INFO - PROCESS | 3819 | 18:00:55 INFO - PROCESS | 3819 | Cycle 1(1): loaded http://localhost:58324/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58324/tests/kraken/driver.html?testName=imaging-desaturate) 18:00:55 INFO - PROCESS | 3819 | RSS: Main: 211820544 18:00:55 INFO - PROCESS | 3819 | 18:00:58 INFO - PROCESS | 3819 | Cycle 1(1): loaded http://localhost:58324/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58324/tests/kraken/driver.html?testName=json-parse-financial) 18:00:59 INFO - PROCESS | 3819 | RSS: Main: 210673664 18:00:59 INFO - PROCESS | 3819 | 18:01:00 INFO - PROCESS | 3819 | Cycle 1(1): loaded http://localhost:58324/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58324/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:01:01 INFO - PROCESS | 3819 | RSS: Main: 172969984 18:01:01 INFO - PROCESS | 3819 | 18:01:02 INFO - PROCESS | 3819 | Cycle 1(1): loaded http://localhost:58324/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58324/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:01:03 INFO - PROCESS | 3819 | RSS: Main: 179744768 18:01:03 INFO - PROCESS | 3819 | 18:01:05 INFO - PROCESS | 3819 | Cycle 1(1): loaded http://localhost:58324/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58324/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:01:06 INFO - PROCESS | 3819 | RSS: Main: 189911040 18:01:06 INFO - PROCESS | 3819 | 18:01:08 INFO - PROCESS | 3819 | Cycle 1(1): loaded http://localhost:58324/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58324/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:01:09 INFO - PROCESS | 3819 | RSS: Main: 197513216 18:01:09 INFO - PROCESS | 3819 | 18:01:12 INFO - PROCESS | 3819 | Cycle 1(1): loaded http://localhost:58324/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58324/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:01:12 INFO - PROCESS | 3819 | RSS: Main: 194781184 18:01:12 INFO - PROCESS | 3819 | 18:01:14 INFO - PROCESS | 3819 | Cycle 1(1): loaded http://localhost:58324/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58324/tests/kraken/driver.html?testName=ai-astar) 18:01:14 INFO - PROCESS | 3819 | RSS: Main: 246255616 18:01:14 INFO - PROCESS | 3819 | 18:01:14 INFO - PROCESS | 3819 | __start_tp_report 18:01:14 INFO - PROCESS | 3819 | _x_x_mozilla_page_load 18:01:14 INFO - PROCESS | 3819 | _x_x_mozilla_page_load_details 18:01:14 INFO - PROCESS | 3819 | |i|pagename|runs| 18:01:14 INFO - PROCESS | 3819 | |0;ai-astar;106;114;113;113;113;115;113;113;113;113 18:01:14 INFO - PROCESS | 3819 | |1;audio-beat-detection;142;116;117;151;117;117;120;120;150;117 18:01:14 INFO - PROCESS | 3819 | |2;audio-dft;163;162;161;161;162;160;160;161;161;161 18:01:14 INFO - PROCESS | 3819 | |3;audio-fft;76;75;76;107;77;77;76;75;90;76 18:01:14 INFO - PROCESS | 3819 | |4;audio-oscillator;81;82;103;82;83;82;102;82;82;107 18:01:14 INFO - PROCESS | 3819 | |5;imaging-gaussian-blur;113;113;114;113;113;113;112;113;113;114 18:01:14 INFO - PROCESS | 3819 | |6;imaging-darkroom;146;146;147;146;146;146;146;146;145;146 18:01:14 INFO - PROCESS | 3819 | |7;imaging-desaturate;94;94;94;94;94;93;93;94;95;93 18:01:14 INFO - PROCESS | 3819 | |8;json-parse-financial;58;54;54;53;55;55;57;55;64;54 18:01:14 INFO - PROCESS | 3819 | |9;json-stringify-tinderbox;53;52;53;55;53;52;52;52;53;53 18:01:14 INFO - PROCESS | 3819 | |10;stanford-crypto-aes;75;74;79;80;76;75;80;80;79;79 18:01:14 INFO - PROCESS | 3819 | |11;stanford-crypto-ccm;120;121;118;119;119;128;120;126;159;119 18:01:14 INFO - PROCESS | 3819 | |12;stanford-crypto-pbkdf2;165;163;161;161;163;161;163;165;161;159 18:01:14 INFO - PROCESS | 3819 | |13;stanford-crypto-sha256-iterative;62;61;59;61;65;59;60;59;60;59 18:01:14 INFO - PROCESS | 3819 | __end_tp_report 18:01:14 INFO - PROCESS | 3819 | __start_cc_report 18:01:14 INFO - PROCESS | 3819 | _x_x_mozilla_cycle_collect,1691 18:01:14 INFO - PROCESS | 3819 | __end_cc_report 18:01:14 INFO - PROCESS | 3819 | __startTimestamp1489539674489__endTimestamp 18:01:14 INFO - PROCESS | 3819 | 18:01:14 INFO - PROCESS | 3819 | ------- Summary: start ------- 18:01:14 INFO - PROCESS | 3819 | Number of tests: 14 18:01:14 INFO - PROCESS | 3819 | 18:01:14 INFO - PROCESS | 3819 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.00 stddev:2.41 (2.1%) stddev-sans-first:0.71 18:01:14 INFO - PROCESS | 3819 | Values: 106.0 114.0 113.0 113.0 113.0 115.0 113.0 113.0 113.0 113.0 18:01:14 INFO - PROCESS | 3819 | 18:01:14 INFO - PROCESS | 3819 | [#1] audio-beat-detection Cycles:10 Average:126.70 Median:120.00 stddev:14.71 (12.3%) stddev-sans-first:14.53 18:01:14 INFO - PROCESS | 3819 | Values: 142.0 116.0 117.0 151.0 117.0 117.0 120.0 120.0 150.0 117.0 18:01:14 INFO - PROCESS | 3819 | 18:01:14 INFO - PROCESS | 3819 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.71 18:01:14 INFO - PROCESS | 3819 | Values: 163.0 162.0 161.0 161.0 162.0 160.0 160.0 161.0 161.0 161.0 18:01:14 INFO - PROCESS | 3819 | 18:01:14 INFO - PROCESS | 3819 | [#3] audio-fft Cycles:10 Average:80.50 Median:76.00 stddev:10.32 (13.6%) stddev-sans-first:10.82 18:01:14 INFO - PROCESS | 3819 | Values: 76.0 75.0 76.0 107.0 77.0 77.0 76.0 75.0 90.0 76.0 18:01:14 INFO - PROCESS | 3819 | 18:01:14 INFO - PROCESS | 3819 | [#4] audio-oscillator Cycles:10 Average:88.60 Median:82.00 stddev:10.71 (13.1%) stddev-sans-first:11.00 18:01:14 INFO - PROCESS | 3819 | Values: 81.0 82.0 103.0 82.0 83.0 82.0 102.0 82.0 82.0 107.0 18:01:14 INFO - PROCESS | 3819 | 18:01:14 INFO - PROCESS | 3819 | [#5] imaging-gaussian-blur Cycles:10 Average:113.10 Median:113.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 18:01:14 INFO - PROCESS | 3819 | Values: 113.0 113.0 114.0 113.0 113.0 113.0 112.0 113.0 113.0 114.0 18:01:14 INFO - PROCESS | 3819 | 18:01:14 INFO - PROCESS | 3819 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 18:01:14 INFO - PROCESS | 3819 | Values: 146.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 145.0 146.0 18:01:14 INFO - PROCESS | 3819 | 18:01:14 INFO - PROCESS | 3819 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 18:01:14 INFO - PROCESS | 3819 | Values: 94.0 94.0 94.0 94.0 94.0 93.0 93.0 94.0 95.0 93.0 18:01:14 INFO - PROCESS | 3819 | 18:01:14 INFO - PROCESS | 3819 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:55.00 stddev:3.21 (5.8%) stddev-sans-first:3.32 18:01:14 INFO - PROCESS | 3819 | Values: 58.0 54.0 54.0 53.0 55.0 55.0 57.0 55.0 64.0 54.0 18:01:14 INFO - PROCESS | 3819 | 18:01:14 INFO - PROCESS | 3819 | [#9] json-stringify-tinderbox Cycles:10 Average:52.80 Median:53.00 stddev:0.92 (1.7%) stddev-sans-first:0.97 18:01:14 INFO - PROCESS | 3819 | Values: 53.0 52.0 53.0 55.0 53.0 52.0 52.0 52.0 53.0 53.0 18:01:14 INFO - PROCESS | 3819 | 18:01:14 INFO - PROCESS | 3819 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:79.00 stddev:2.41 (3.0%) stddev-sans-first:2.35 18:01:14 INFO - PROCESS | 3819 | Values: 75.0 74.0 79.0 80.0 76.0 75.0 80.0 80.0 79.0 79.0 18:01:14 INFO - PROCESS | 3819 | 18:01:14 INFO - PROCESS | 3819 | [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:120.50 stddev:12.42 (10.3%) stddev-sans-first:13.05 18:01:14 INFO - PROCESS | 3819 | Values: 120.0 121.0 118.0 119.0 119.0 128.0 120.0 126.0 159.0 119.0 18:01:14 INFO - PROCESS | 3819 | 18:01:14 INFO - PROCESS | 3819 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.20 Median:163.00 stddev:1.93 (1.2%) stddev-sans-first:1.76 18:01:14 INFO - PROCESS | 3819 | Values: 165.0 163.0 161.0 161.0 163.0 161.0 163.0 165.0 161.0 159.0 18:01:14 INFO - PROCESS | 3819 | 18:01:14 INFO - PROCESS | 3819 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.50 Median:60.50 stddev:1.90 (3.1%) stddev-sans-first:1.94 18:01:14 INFO - PROCESS | 3819 | Values: 62.0 61.0 59.0 61.0 65.0 59.0 60.0 59.0 60.0 59.0 18:01:14 INFO - PROCESS | 3819 | -------- Summary: end -------- 18:01:14 INFO - PROCESS | 3819 | 18:01:15 INFO - TEST-INFO | 3819: exit 0 18:01:15 INFO - TEST-OK | kraken | took 60164ms 18:01:15 INFO - SUITE-END | took 1176s 18:01:15 INFO - Completed test suite (00:19:36) 18:01:15 INFO - javascript benchmark 18:01:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7892.042521628064, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3401.0137060252537, 3410.3861304965103, 3446.9655303446975, 3476.30473905219, 3495.5805303363586, 5753.884922301557, 5769.0, 5772.5670574706955, 5798.420157984199, 5812.360640329565, 5775.162601422791, 5830.679312637803, 5832.825015249538, 5837.182794408786, 5842.853928651786, 5144.871378215537, 5148.897022059557, 5186.0, 5194.714290714028, 5204.245384419257, 5119.308893299412, 5125.8462246132485, 5132.358455193101, 5253.080710875601, 5259.526642602165, 5139.126348520742, 5194.220866869962, 5205.557527610158, 5218.373795144588, 5230.032443997854, 5204.76578553966, 5208.088584497736, 5208.453112423198, 5211.635185537033, 5241.42344342122, 4940.061388336205, 5026.447090820006, 5132.948670513284, 5142.07442660321, 5203.089459344599, 5651.039323315046, 5656.151577263402, 5740.942590574083, 5815.0, 5819.650820950714, 6184.783532576338, 6227.688615569249, 6236.438720515175, 6240.937590624127, 6249.78125765596, 6299.212598425197, 6299.9370006299805, 6307.243130824285, 6312.021636646327, 6313.715882785285, 5645.689487078209, 5648.0, 5770.2498675171955, 5799.82600521985, 5840.269966254218, 6338.651374174372, 6344.936550634435, 6359.268684101295, 6364.427201551883, 6370.968145159337, 6138.938610613836, 6139.2325959255095, 6144.446999770043, 6157.353477884758, 6164.722587483574, 5973.492253158443, 5998.610090344201, 6109.230455681918, 6212.285587157535, 6266.467350275187, 6179.5056395488255, 6191.938080619227, 6219.595726277777, 6220.720067596969, 6228.252609686776, 5961.046232602849, 5981.760729570856, 5985.730642121115, 5993.640381577119, 6033.095035744674, 4618.884527886763, 4623.722576645412, 4628.467726211461, 4681.485036646034, 4713.8350157745, 4246.639035682002, 4260.339647354665, 4273.294906340481, 4273.465816772903, 4310.030243195256, 5781.219535362672, 5820.70896455184, 5883.441073098049, 5963.075723262901, 5970.164177015221, 6137.193127861533, 6138.1738283688655, 6152.784652537229, 6160.537959653044, 6202.4417802398, 5959.970200148971, 5970.402959704082, 5971.731272092767, 5998.130271110752, 6011.7595296187665, 5265.131253343156, 5296.364436267596, 5300.3639563252655, 5306.0, 5306.071437498423, 6241.0, 6316.526260530571, 6399.392057754506, 6498.545101842826, 6585.604863708193, 6245.0, 6249.34381889895, 6256.5620406572925, 6264.185655864709, 6265.937340626535, 6531.804045878631, 6532.183477065367, 6579.4736421085245, 6580.967095164494, 6585.670716464062, 5931.881362372815, 6199.721012554356, 6204.472619827185, 6206.472449841814, 6209.192804935329, 6103.145559621567, 6167.876642467215, 6180.072989051679, 6290.559660823698, 6301.275353334425, 6082.9695851520455, 6097.512199023979, 6097.7072380913805, 6097.725602347994, 6122.663253521099, 6022.66875321844, 6042.879142417215, 6081.969590152021, 6096.268447786294, 6108.08378743192, 5892.027815410409, 5937.0, 5978.043513037893, 5996.820095397145, 6014.969925150522, 6061.6666083365835, 6066.848328791815, 6070.575059745775, 6071.5446341523675, 6091.451769340781, 5763.0, 5810.041343178328, 5818.981678206213, 5904.734286957011, 5952.285725712942], "value": 5701.461117211172, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [762.6148794858595, 831.5800520737027, 834.1158372125545, 893.6648756716231, 900.6262401103543, 30987.69012309879, 31384.0, 33534.49698254522, 33601.327973440544, 44276.557234427644, 46074.76962615191, 46302.536974630246, 46327.76836115823, 46347.53652463474, 46349.0, 9104.908950910489, 9254.907450925506, 9257.768555786091, 9261.073892610751, 9265.166135047844, 7237.855242895139, 7414.925850741504, 10285.588576456932, 10531.26281160319, 10537.84193237102, 10848.837267440995, 10886.455677216147, 10892.292001019909, 10900.34597924127, 10902.890971090266, 10561.0, 10597.788044239149, 10599.046085852311, 10604.363738175696, 10610.893891061069, 10498.107660848837, 10542.367457952547, 10560.683179504627, 10566.207534434949, 10570.682879513626, 42088.78955605233, 42233.57766422358, 42320.0, 42346.0, 42363.0, 4092.9181416371803, 4116.361963895601, 4142.316517774563, 4193.685473589462, 4219.852305169335, 29318.267043323875, 29439.85280073586, 29805.701942980726, 29852.55221171684, 29975.0, 4345.565443455661, 4443.933340999887, 4447.332900064984, 4457.3091170868565, 4551.112533056055, 247796.0, 248889.0, 249504.0, 251110.0, 252009.99999999817, 54276.45723542793, 54470.0, 54599.727001364736, 54618.180727289124, 54631.453685462635, 56893.0, 56961.43038569561, 56983.14525282124, 56988.71505642528, 57081.0, 15273.159976201194, 15417.383304667912, 15483.380664773507, 15573.922130389275, 15575.299111539782, 13260.734785304432, 13280.269585172715, 13288.933555332162, 13289.468421263235, 13299.66750831237, 10756.247062705692, 10884.183686223407, 13622.863771362358, 13630.591082267549, 14010.369533371022, 5231.8168864089575, 5321.175217841241, 5326.227696983916, 5333.946660533423, 5347.171188465794, 1012.6253286284121, 1014.832552628808, 1019.5267837974204, 1047.4710271312938, 1064.1327318235612, 28148.0, 28618.713812861606, 29115.27211819679, 29431.11706648804, 29865.850670746506, 1098.8956049175315, 1107.545906178463, 1115.1859142825783, 1120.073473625363, 1136.4090672850073, 14775.92612036933, 15589.376424943102, 15727.292271847795, 15765.68468630621, 15792.131432771308, 339843.0, 343043.0, 343827.0, 344154.0, 345094.0, 58586.0, 58673.413265867646, 58755.0, 58762.0, 58788.0, 1501.594569466238, 1532.1113754022863, 1532.785410042595, 1557.3381312941954, 1568.7176308264623, 26683.0, 27952.30119247035, 28368.71631283661, 28397.290067748472, 28425.85787071134, 42972.140557189305, 43097.0, 43114.0, 43208.0, 43215.78392108145, 303204.0, 303430.0, 303584.0, 304014.0, 304277.0, 26636.8668156658, 34528.0, 35045.29909401849, 35107.64892351146, 35213.471797923565, 32643.0, 32803.34393312168, 43124.137517248855, 47859.521404785504, 48023.0, 37693.81153094217, 37877.0, 38271.80864095662, 38516.42225366566, 39641.60358396379, 38208.61791382162, 38292.234155317296, 38460.61539384682, 38595.614043860325, 38725.03187420337, 35925.0, 36152.4577131338, 39463.0, 39805.40291895566, 39923.0, 29846.701532985262, 31355.0, 32366.838165809022, 32431.189220268738, 32535.18662033468, 25683.3579160515, 25781.226563203134, 25837.41625837401, 26036.01326334927, 26242.163048586415], "value": 19094.461748367874, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [450.24583822097975, 459.7861994172709, 460.6982426510635, 481.5786187086299, 484.8521201033686, 19803.603927921435, 19930.0, 21332.0, 21439.892800535996, 21514.677279840816, 21611.45971350717, 21743.23898663547, 22082.227122050732, 22197.556048879054, 22373.888130559364, 6629.701663425158, 6718.496112791548, 6817.693203805816, 6865.0732151159455, 6890.931090689079, 6727.058211850345, 6790.762323318685, 6823.965880170592, 6826.829329266759, 6829.453643708516, 6488.416042556169, 6671.5997040177745, 6800.863982720342, 6827.146606674166, 6846.623435711034, 6569.93430065698, 6659.93340066598, 6725.293844146343, 6817.113775209215, 6822.317768223163, 6503.187101612299, 6519.445847103002, 6520.836979075513, 6521.380468855451, 6524.412802847766, 24516.754832451625, 25005.0, 25039.24882253535, 25242.49515009708, 25248.49503009948, 3025.183200535865, 3083.6145481814774, 3093.3967876264137, 3143.2613335866054, 3150.4329220740256, 16263.674726505404, 16507.422240221655, 16639.0, 16690.58273543159, 16738.66522669552, 2344.2732752846673, 2350.4476448034698, 2413.0, 2460.729319774823, 2464.322311364371, 95204.52397738036, 95282.0, 95934.52032739861, 97977.0, 99157.50421247848, 18600.0, 18886.716699249522, 18976.810231897503, 19030.52423689391, 19160.808391915903, 33931.66068339335, 33987.83006084954, 34011.97964061082, 34026.31947361039, 34253.828730856185, 10886.183536234656, 10918.781624367468, 10926.235163538477, 11130.944345278222, 11179.552817887356, 9007.504587247764, 9045.412048216846, 9069.365144439826, 9080.228180604723, 9261.72214833556, 9725.0761177688, 10128.848067278997, 10130.392176469435, 10220.386776793417, 10261.179105671528, 3972.3514741382583, 4059.7361171523758, 4068.5117785865295, 4187.181105022337, 4200.432941552913, 1010.6765834932751, 1011.3375738891039, 1012.8987101289812, 1024.894569454554, 1025.8358662613946, 20947.79052209489, 21117.366479005654, 21416.143354265656, 21659.458513537287, 21730.239441619466, 993.8211121997965, 999.5202302894651, 1011.1556850030161, 1013.9695809125737, 1018.5111146649501, 11551.0, 11892.405379730979, 12232.81650775239, 12376.257424554555, 12457.813132803016, 711425.0, 711898.0, 719061.0, 734668.0, 742722.0, 112860.43569782098, 119621.0, 123723.0, 124235.3788231053, 127075.0, 1340.7251513439917, 1356.328617334406, 1377.1736957825426, 1383.3498255819748, 1385.4873696732475, 18390.81609183891, 18962.43112706621, 19168.61662766765, 19241.4227573173, 19355.322563710204, 50051.749741251064, 50213.49786502088, 50702.0, 50873.74563127161, 51149.23276150935, 65961.34038659552, 67053.32946670472, 67196.0, 68193.3180668187, 68440.0, 9570.665026724031, 11722.648320550397, 11793.174477786473, 11856.822147667619, 12057.457414416196, 13432.865671343552, 13555.525556605471, 13556.796648050089, 13596.728065438834, 13795.10331828428, 11253.0, 11718.179727419, 12001.279923204636, 12137.332446715516, 12171.2697238166, 10248.333858299187, 10743.785124297627, 11429.314241145557, 11458.0, 11636.12729045342, 7108.751193708195, 12457.439415226518, 12465.688357791129, 12887.806682899576, 13291.468341266242, 12200.938995304967, 12289.692757680772, 12322.568710095104, 12378.75242495163, 12774.425150868048, 12015.819762703391, 12299.69250768738, 12374.195677280948, 12451.937740311241, 12547.121701480808], "value": 11542.659523609585, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1453.462218978978, 1581.4148764956967, 1599.5761123302334, 1610.9194540272988, 1613.798275215598, 9332.860007099891, 11280.32318060917, 11458.541658333677, 11501.827472587918, 11558.497395338594, 11602.129840261992, 11653.650390488277, 11676.824847627271, 11679.824802627967, 11681.182317237775, 1997.2011195521834, 2430.2101816909485, 2474.604063349864, 2476.987615061922, 2481.553320402327, 2075.740532433446, 2094.3298144593737, 2095.486605781578, 2241.932742017742, 2317.6407656813135, 2486.6643003194517, 2501.4121681404945, 2508.3227528567277, 2509.046562306321, 2509.4353770401694, 2347.7417484076823, 2369.1589485732575, 2384.523095380931, 2392.3062311929693, 2393.365758074112, 2320.0, 2351.2123438648073, 2354.5526349993447, 2361.8937147828387, 2393.6888204533475, 11289.661310160709, 11383.886161138365, 11384.203105782599, 11394.829077563843, 11398.31610103388, 5692.971535142339, 5819.039858423397, 5844.795432159896, 5847.0, 5854.20968169296, 3429.777064490825, 3501.3347463981763, 3524.259905419865, 3551.982240088783, 3637.2725454909123, 1324.6622111361637, 1347.8921686265173, 1378.421063153478, 1383.6125884752184, 1446.1034158821599, 17024.999999999876, 17191.742123868153, 17195.484135475956, 17236.56908577283, 17345.566360840952, 4781.947971446276, 4906.70559766408, 5001.324821149098, 5009.949900501021, 5035.471275516092, 14049.227292498806, 14052.0, 14068.226247556278, 14071.788923166161, 14076.648083797782, 6023.247094113236, 6027.065804800175, 6041.697915104315, 6042.093685947055, 6046.425589568984, 5319.973400132974, 5345.251664766935, 5450.863728406743, 5493.121100623881, 5499.752511137009, 3918.2359439909515, 4022.054817117975, 4324.978375108104, 4381.3208952612395, 4490.820367185342, 1196.1447564991074, 1209.1415095282273, 1209.8427204463364, 1224.6142465123457, 1230.4893469210356, 1012.5696578953915, 1024.774549599087, 1028.711960651019, 1029.7425643589104, 1030.6083688198587, 6522.347765223534, 6631.801045968628, 6746.291639377893, 6775.93224067753, 6886.793396198022, 1089.3899416326724, 1094.1848322999417, 1104.3373975614568, 1123.612353737959, 1132.796096702585, 4593.54064593538, 4678.274867395559, 4771.33201351811, 4784.354112194878, 4851.34506841579, 14539.92730036343, 14757.262136893112, 14772.48296309624, 14873.107613543221, 14942.477013304482, 13166.670833229055, 13679.042467027213, 14799.786118704007, 14801.925990369979, 14809.259537023107, 10096.747581310527, 10245.129164021142, 10299.691009269734, 10318.019788120117, 10332.173426125892, 6959.61722105289, 7188.3530482254755, 7241.239669834592, 7274.199838017708, 7342.926570734225, 12341.321227332583, 12433.316167610506, 12698.492060317853, 12834.67913302175, 12843.165194262343, 12541.686457838627, 12931.547395841477, 13095.083344165816, 13126.14680045794, 13214.801777973531, 9911.10800028001, 9973.950130249303, 10081.69754907354, 10084.193264538966, 10098.596056157672, 8117.10711821711, 8294.004719433706, 10229.181665466893, 10815.242932994615, 11011.229213955266, 9163.312751543794, 9492.477913714813, 9581.808363832824, 9593.088656577615, 9837.557309921214, 9488.0, 9501.904980950378, 9511.952440237754, 9525.57134928916, 9532.380395274286, 8586.871196931927, 8643.265322447662, 8734.825303493768, 8735.344849136467, 8743.213110820057, 6538.8365290868105, 6588.5058620604605, 6599.967000164968, 6655.667216639245, 6660.966695166493, 6159.876802464015, 6160.9383906160365, 6177.4749146323065, 6328.272248691275, 6351.047342898602], "value": 5424.7281555972195, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.5067369829902, 415.5096985557045, 431.3055979872407, 447.16380368710514, 448.7038554553994, 5184.53339199472, 5252.6848389096585, 5255.84232473026, 5295.391030031547, 5364.91952620711, 5091.821786237482, 5141.871453213662, 5166.638335316529, 5259.237410575464, 5281.96287134897, 4355.869323920271, 4368.099876553693, 4371.169477799224, 4373.803178856943, 4379.321205213181, 4353.2599458092045, 4389.670774691895, 4401.471823381199, 4423.137488189805, 4426.380306757057, 4257.489101307848, 4296.5273819879785, 4329.9567004329865, 4363.236433624119, 4378.321360189176, 4326.372675961999, 4326.6754993375625, 4337.284348082594, 4358.3244597087505, 4359.258925982559, 4125.1749650070105, 4135.338345864678, 4144.191882582898, 4172.311568591179, 4187.099773548671, 4853.326206278734, 5026.371703537058, 5102.795888164469, 5104.259882317043, 5157.277981082651, 5048.823291184827, 5095.974520127413, 5096.643234973553, 5131.461196574343, 5148.279240906276, 5384.057789886793, 5469.808556700496, 5487.204355368489, 5490.423505531901, 5511.944880551223, 4523.70595911268, 4527.660425468103, 4558.293464512973, 4564.5435456454425, 4611.584957353821, 5363.249145119647, 5455.318085239345, 5564.026295398329, 5639.436056394369, 5665.487397813341, 4661.254199328091, 4668.929966050512, 4685.071830106183, 4688.882777930579, 4702.694324868872, 4552.449089710031, 4762.0, 4805.495422980606, 4821.783019764119, 4837.806487740521, 4891.309779621194, 4938.123513065012, 4963.652544321935, 4995.0, 5033.6224783141415, 5342.572594192456, 5391.622586418992, 5393.298871146726, 5409.945900541023, 5433.130699088206, 1589.3007076886133, 1625.2929975460713, 1642.4005238088012, 1658.427842394372, 1662.7339625659836, 1250.1623911978995, 1271.313490715022, 1271.618514445681, 1276.3363051213503, 1293.9417726202344, 5328.387235467893, 5331.226972089025, 5347.973260133675, 5363.544098751572, 5365.6244062916, 5607.448610882039, 5625.0, 5633.859153521113, 5640.633358831745, 5644.85887852807, 5142.794288228429, 5265.552428043659, 5377.838664840061, 5380.273663055437, 5386.272853164773, 2924.619799426061, 2935.7669778693, 2937.839553376404, 2953.3797902440297, 2959.91962933532, 5664.433556644302, 5806.054971584566, 5810.820942146695, 5841.678707671119, 5899.351071382144, 5678.943210567924, 5688.658680479184, 5689.459501347365, 5692.231548740867, 5727.255456790674, 5877.265341832185, 5877.471027607536, 5899.262592175978, 5900.970495147497, 5920.851978700567, 5323.973380133075, 5550.306211723535, 5597.608167428241, 5604.663720176639, 5642.266505354278, 5503.284573005483, 5508.3114610673665, 5526.392096869422, 5539.7784088636, 5590.440955904377, 5597.384287728428, 5698.1452782083015, 5708.457696518824, 5783.421657834351, 5858.8242352729485, 4926.866820631347, 5000.974995125001, 5023.723695196799, 5066.923996139987, 5073.923891141562, 5443.265159203615, 5578.665280083208, 5634.352049514358, 5657.4908258256955, 5666.15007748841, 5407.891382266547, 5431.11675152268, 5443.183522471502, 5475.561955043508, 5537.667739935456, 5481.9716704819475, 5493.7802487900035, 5529.4470552945995, 5539.279893613804, 5592.049351610155, 5289.68261904287, 5488.313960754906, 5490.725463726718, 5514.310711161105, 5588.916166257428, 5498.505134537911, 5511.145772405283, 5527.44725527444, 5560.91658625129, 5581.237287542693, 5238.5547228486, 5465.1034951475785, 5470.64440811346, 5484.945150548603, 5501.834944951658], "value": 4422.792712384171, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [839.3662784597628, 851.8083431227974, 903.1329923273659, 906.2795077913054, 914.9248986728127, 16906.492805215847, 17866.374676886313, 17923.73114403285, 17924.64150716985, 18015.18931648076, 10705.625303114393, 16264.83735162648, 16288.592785180377, 16380.83619163808, 16414.261358238877, 855.2943821347397, 869.8129902071054, 869.9956500217522, 871.5947084605657, 871.6861929705301, 857.4083882121347, 860.7331727164599, 861.2851333393269, 862.1550880137469, 863.8876945997011, 903.0969030969031, 903.5933829776594, 905.6422713028383, 905.8595917632778, 905.995470022649, 901.8602116671926, 902.6930843513204, 902.7517432705993, 903.3495882964255, 904.4166512599337, 660.8645227728305, 660.9471242300605, 661.1801366305795, 661.3518751623388, 661.4278648968656, 17760.644787104316, 17764.55588610295, 17802.643947121116, 17913.19390627425, 17968.550786230317, 17153.485395438158, 17230.396936107176, 17288.913555432267, 17822.55443613907, 17829.375971840924, 13775.0, 13863.930680346635, 14002.719945601031, 14040.227787471686, 14087.859121408757, 4121.072758629284, 4153.501579810442, 4196.895077623053, 4220.936685949713, 4290.506591741959, 87456.0, 87896.0, 88891.55554222252, 89225.55387223023, 90171.09828901758, 12946.67633309156, 13083.803742943863, 13209.273489957952, 13256.668583285495, 13304.933475332562, 26021.73978260231, 26112.608310875352, 26163.607545886825, 26163.869180654354, 26239.73760262411, 9086.136817002374, 9147.954260228656, 9287.721368358825, 9605.711828645151, 9653.565589548487, 5136.717480538607, 5198.012377648235, 5199.350081239845, 5282.445343238982, 5366.91949620756, 3697.5378077740284, 3874.1476875087437, 3890.8638197663513, 3904.1020565270146, 3918.040080180374, 618.6226401894841, 619.2043224456642, 619.3094699410125, 633.0915136778738, 638.7349250061266, 843.5065486690355, 868.7914900423852, 876.2420506262165, 893.4014210478995, 895.5074708910073, 10524.842127368096, 11250.212485125963, 11399.544018239343, 12056.276623402624, 12097.818532722016, 860.7245681382022, 873.8776571280026, 879.7228872905015, 885.4819930340823, 898.8067565473324, 5223.4776522347465, 5421.810236641778, 5486.204500347428, 5568.3318001839225, 5568.805091821767, 65373.0, 65991.0, 66508.33491665118, 66787.66606166938, 67667.0, 56264.593385165696, 63769.04346434807, 68885.31114688789, 69513.3048669517, 70780.64609676918, 60847.08729369063, 61652.38347616556, 63190.597731347836, 64976.675116624116, 65955.67022164955, 11709.941450292694, 12028.578999734968, 12200.084993625336, 12235.877641223475, 12265.853475641905, 42375.3643695351, 42864.785676072665, 43188.568114318456, 43444.0, 43942.34086488641, 43778.78110609554, 44352.0, 47993.0, 48670.26994595013, 48884.0, 13903.721925561635, 13961.930190348983, 14080.225587592371, 14186.077904936146, 14195.929020354832, 16428.390907694593, 16669.333226671282, 16825.24286407139, 16913.0, 17155.742663860303, 15367.769483457534, 15723.21383930776, 16225.59436014109, 16383.262753175897, 16938.40715574949, 15920.681586367977, 16241.269142888363, 16497.91751041237, 16931.407400740914, 17251.223694934008, 14457.27713614294, 15082.019668721498, 15097.54707358781, 16125.032498050154, 16188.352465901233, 12692.936535317263, 13165.605031848676, 13300.41920807418, 13849.584512464642, 14005.127213404126, 12516.0, 12584.685382865502, 12644.0, 12979.28613926243, 12985.091043626855], "value": 8013.52613009337, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1456.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 113.0, 113.0, 113.0, 115.0, 113.0, 113.0, 113.0, 113.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 116.0, 117.0, 151.0, 117.0, 117.0, 120.0, 120.0, 150.0, 117.0], "value": 126.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 161.0, 161.0, 162.0, 160.0, 160.0, 161.0, 161.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 107.0, 77.0, 77.0, 76.0, 75.0, 90.0, 76.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 103.0, 82.0, 83.0, 82.0, 102.0, 82.0, 82.0, 107.0], "value": 88.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 113.0, 113.0, 113.0, 112.0, 113.0, 113.0, 114.0], "value": 113.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 93.0, 94.0, 95.0, 93.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 54.0, 54.0, 53.0, 55.0, 55.0, 57.0, 55.0, 64.0, 54.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 55.0, 53.0, 52.0, 52.0, 52.0, 53.0, 53.0], "value": 52.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 79.0, 80.0, 76.0, 75.0, 80.0, 80.0, 79.0, 79.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 121.0, 118.0, 119.0, 119.0, 128.0, 120.0, 126.0, 159.0, 119.0], "value": 124.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 161.0, 161.0, 163.0, 161.0, 163.0, 165.0, 161.0, 159.0], "value": 162.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 59.0, 61.0, 65.0, 59.0, 60.0, 59.0, 60.0, 59.0], "value": 60.5, "unit": "score"}]}]} 18:01:15 INFO - Return code: 0 18:01:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:01:15 ERROR - # TBPL SUCCESS # 18:01:15 INFO - Running post-action listener: _resource_record_post_action 18:01:15 INFO - [mozharness: 2017-03-15 01:01:15.796265Z] Finished run-tests step (success) 18:01:15 INFO - Running post-run listener: _resource_record_post_run 18:01:15 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 7573504; Write bytes: 377282560; Read time: 1128; Write time: 318396 18:01:15 INFO - TinderboxPrint: CPU usage
13.1% 18:01:15 INFO - TinderboxPrint: I/O read bytes / time
7,573,504 / 1,128 18:01:15 INFO - TinderboxPrint: I/O write bytes / time
377,282,560 / 318,396 18:01:15 INFO - TinderboxPrint: CPU idle
8,270.6 (86.9%) 18:01:15 INFO - TinderboxPrint: CPU user
1,202.0 (12.6%) 18:01:15 INFO - TinderboxPrint: Swap in / out
0 / 0 18:01:15 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 122388480; Read time: 0; Write time: 100200 18:01:15 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 5828608; Write bytes: 254742528; Read time: 1036; Write time: 218136 18:01:16 INFO - Running post-run listener: _upload_blobber_files 18:01:16 INFO - Blob upload gear active. 18:01:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:01:16 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:01:16 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:01:16 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:01:16 INFO - (blobuploader) - INFO - Open directory for files ... 18:01:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:01:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:01:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:01:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:01:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:01:17 INFO - (blobuploader) - INFO - Done attempting. 18:01:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:01:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:01:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:01:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:01:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:01:18 INFO - (blobuploader) - INFO - Done attempting. 18:01:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:01:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:01:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:01:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:01:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:01:19 INFO - (blobuploader) - INFO - Done attempting. 18:01:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:01:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:01:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:01:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:01:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:01:22 INFO - (blobuploader) - INFO - Done attempting. 18:01:22 INFO - (blobuploader) - INFO - Iteration through files over. 18:01:22 INFO - Return code: 0 18:01:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:01:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:01:22 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39b2f1ede9dad2654fd4c2bea8766c6b5e9572c046e4f5ef3544f11ecd6e66019ca21b8405966e9e47ff03d28649c83b68d14d8e649b790805f0231a5efb817c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/713a241ad285681079180bcd55acde231a59ce2c57f60cd49f7d8d85c51318cdbb6eefe3df0e38f9be1a047b8b6b356083ee99b02b1d7e238db0b6b1ccc23bf2", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/54d6b98c408173794d9d7d49910f62cbe72b8981ed4884788788fcaaa5c2a99356c4f9f2b65a4bb2fd5025cce289212e50c5b2064471fd699e49b17e1c6c7c54", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/350d05aa459482d8cb69d39e59a6d100fbb08ba57aebcea137ec79ba0fc809142139d5d3c0050d3b89866d39965b13af3e9197ea96c6c6a23cd69125e59767e4"} 18:01:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:01:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:01:22 INFO - Contents: 18:01:22 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39b2f1ede9dad2654fd4c2bea8766c6b5e9572c046e4f5ef3544f11ecd6e66019ca21b8405966e9e47ff03d28649c83b68d14d8e649b790805f0231a5efb817c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/713a241ad285681079180bcd55acde231a59ce2c57f60cd49f7d8d85c51318cdbb6eefe3df0e38f9be1a047b8b6b356083ee99b02b1d7e238db0b6b1ccc23bf2", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/54d6b98c408173794d9d7d49910f62cbe72b8981ed4884788788fcaaa5c2a99356c4f9f2b65a4bb2fd5025cce289212e50c5b2064471fd699e49b17e1c6c7c54", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/350d05aa459482d8cb69d39e59a6d100fbb08ba57aebcea137ec79ba0fc809142139d5d3c0050d3b89866d39965b13af3e9197ea96c6c6a23cd69125e59767e4"} 18:01:22 INFO - Running post-run listener: copy_logs_to_upload_dir 18:01:22 INFO - Copying logs to upload dir... 18:01:22 INFO - mkdir: /builds/slave/test/build/upload/logs 18:01:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.680168 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-03-14 18:01:22.745073) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-14 18:01:22.748371) ========= 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=0e2a256762fed810e2f0f810000001b3-1489538426.60049-1832119983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39b2f1ede9dad2654fd4c2bea8766c6b5e9572c046e4f5ef3544f11ecd6e66019ca21b8405966e9e47ff03d28649c83b68d14d8e649b790805f0231a5efb817c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/713a241ad285681079180bcd55acde231a59ce2c57f60cd49f7d8d85c51318cdbb6eefe3df0e38f9be1a047b8b6b356083ee99b02b1d7e238db0b6b1ccc23bf2", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/54d6b98c408173794d9d7d49910f62cbe72b8981ed4884788788fcaaa5c2a99356c4f9f2b65a4bb2fd5025cce289212e50c5b2064471fd699e49b17e1c6c7c54", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/350d05aa459482d8cb69d39e59a6d100fbb08ba57aebcea137ec79ba0fc809142139d5d3c0050d3b89866d39965b13af3e9197ea96c6c6a23cd69125e59767e4"} build_url:https://queue.taskcluster.net/v1/task/aRlMdMDkQUSqK3Kpnp2-ig/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011274 build_url: 'https://queue.taskcluster.net/v1/task/aRlMdMDkQUSqK3Kpnp2-ig/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39b2f1ede9dad2654fd4c2bea8766c6b5e9572c046e4f5ef3544f11ecd6e66019ca21b8405966e9e47ff03d28649c83b68d14d8e649b790805f0231a5efb817c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/713a241ad285681079180bcd55acde231a59ce2c57f60cd49f7d8d85c51318cdbb6eefe3df0e38f9be1a047b8b6b356083ee99b02b1d7e238db0b6b1ccc23bf2", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/54d6b98c408173794d9d7d49910f62cbe72b8981ed4884788788fcaaa5c2a99356c4f9f2b65a4bb2fd5025cce289212e50c5b2064471fd699e49b17e1c6c7c54", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/350d05aa459482d8cb69d39e59a6d100fbb08ba57aebcea137ec79ba0fc809142139d5d3c0050d3b89866d39965b13af3e9197ea96c6c6a23cd69125e59767e4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-14 18:01:22.773246) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 18:01:22.773565) ========= 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=0e2a256762fed810e2f0f810000001b3-1489538426.60049-1832119983 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004413 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-14 18:01:22.858130) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-14 18:01:22.858473) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-14 18:01:22.858791) ========= ========= Total master_lag: 0.18 =========