builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-008 starttime: 1471911991.45 results: success (0) buildid: 20160822160116 builduid: 64502076e4324486ad1921174204d08b revision: 24763f58772d45279a935790f732d80851924b46 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 17:26:31.448912) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-22 17:26:31.450022) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 17:26:31.450765) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-22 17:26:31.466367) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 17:26:31.466692) ========= 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=32c5991c409366f7fec8a718000001d2-1471911990.836801-1443251870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-22 17:26:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.2M=0s 2016-08-22 17:26:31 (70.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132355 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 17:26:31.613333) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 17:26:31.613712) ========= 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=32c5991c409366f7fec8a718000001d2-1471911990.836801-1443251870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014438 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 17:26:31.663759) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 17:26:31.664120) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 24763f58772d45279a935790f732d80851924b46 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 24763f58772d45279a935790f732d80851924b46 --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=32c5991c409366f7fec8a718000001d2-1471911990.836801-1443251870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-22 17:26:32,056 truncating revision to first 12 chars 2016-08-22 17:26:32,056 Setting DEBUG logging. 2016-08-22 17:26:32,056 attempt 1/10 2016-08-22 17:26:32,056 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/24763f58772d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-22 17:26:33,047 unpacking tar archive at: mozilla-central-24763f58772d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.320847 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-22 17:26:33.002075) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 17:26:33.002474) ========= script_repo_revision: 24763f58772d45279a935790f732d80851924b46 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-22 17:26:33.002938) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 17:26:33.003277) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-22 17:26:33.014328) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-08-22 17:26:33.014795) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=32c5991c409366f7fec8a718000001d2-1471911990.836801-1443251870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:26:33 INFO - MultiFileLogger online at 20160822 17:26:33 in /builds/slave/test 17:26:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 17:26:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:26:33 INFO - {'append_to_log': False, 17:26:33 INFO - 'base_work_dir': '/builds/slave/test', 17:26:33 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:26:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:26:33 INFO - 'branch': 'Firefox-Non-PGO', 17:26:33 INFO - 'buildbot_json_path': 'buildprops.json', 17:26:33 INFO - 'config_files': ('talos/linux_config.py',), 17:26:33 INFO - 'default_actions': ('clobber', 17:26:33 INFO - 'read-buildbot-config', 17:26:33 INFO - 'download-and-extract', 17:26:33 INFO - 'populate-webroot', 17:26:33 INFO - 'create-virtualenv', 17:26:33 INFO - 'install', 17:26:33 INFO - 'run-tests'), 17:26:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:26:33 INFO - 'download_minidump_stackwalk': True, 17:26:33 INFO - 'download_symbols': 'ondemand', 17:26:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:26:33 INFO - 'tooltool.py': '/tools/tooltool.py', 17:26:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:26:33 INFO - '/tools/misc-python/virtualenv.py')}, 17:26:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:26:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:26:33 INFO - 'installer_path': 'installer.exe', 17:26:33 INFO - 'log_level': 'info', 17:26:33 INFO - 'log_name': 'talos', 17:26:33 INFO - 'log_to_console': True, 17:26:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:26:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:26:33 INFO - 'opt_config_files': (), 17:26:33 INFO - 'pip_index': False, 17:26:33 INFO - 'sps_profile': False, 17:26:33 INFO - 'sps_profile_interval': 0, 17:26:33 INFO - 'suite': 'dromaeojs', 17:26:33 INFO - 'system_bits': '32', 17:26:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:26:33 INFO - 'title': 'talos-linux64-ix-008', 17:26:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:26:33 INFO - 'use_talos_json': True, 17:26:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:26:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:26:33 INFO - 'work_dir': 'build'} 17:26:33 INFO - [mozharness: 2016-08-23 00:26:33.499930Z] Running clobber step. 17:26:33 INFO - Running pre-action listener: _resource_record_pre_action 17:26:33 INFO - Running main action method: clobber 17:26:33 INFO - rmtree: /builds/slave/test/build 17:26:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:26:33 INFO - Running post-action listener: _resource_record_post_action 17:26:33 INFO - [mozharness: 2016-08-23 00:26:33.960145Z] Finished clobber step (success) 17:26:33 INFO - [mozharness: 2016-08-23 00:26:33.960246Z] Running read-buildbot-config step. 17:26:33 INFO - Running pre-action listener: _resource_record_pre_action 17:26:33 INFO - Running main action method: read_buildbot_config 17:26:33 INFO - Using buildbot properties: 17:26:33 INFO - { 17:26:33 INFO - "project": "", 17:26:33 INFO - "product": "firefox", 17:26:33 INFO - "script_repo_revision": "production", 17:26:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 17:26:33 INFO - "repository": "", 17:26:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 17:26:33 INFO - "buildid": "20160822160116", 17:26:33 INFO - "pgo_build": "False", 17:26:33 INFO - "basedir": "/builds/slave/test", 17:26:33 INFO - "buildnumber": 604, 17:26:33 INFO - "slavename": "talos-linux64-ix-008", 17:26:33 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:26:33 INFO - "platform": "ubuntu64_hw", 17:26:33 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 17:26:33 INFO - "branch": "mozilla-central", 17:26:33 INFO - "repo_path": "mozilla-central", 17:26:33 INFO - "revision": "24763f58772d45279a935790f732d80851924b46", 17:26:33 INFO - "stage_platform": "linux64", 17:26:33 INFO - "builduid": "64502076e4324486ad1921174204d08b", 17:26:33 INFO - "slavebuilddir": "test" 17:26:33 INFO - } 17:26:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/AQfsKt6CSDCy6cyG1gSFgw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 17:26:33 INFO - Running post-action listener: _resource_record_post_action 17:26:33 INFO - [mozharness: 2016-08-23 00:26:33.962689Z] Finished read-buildbot-config step (success) 17:26:33 INFO - [mozharness: 2016-08-23 00:26:33.962777Z] Running download-and-extract step. 17:26:33 INFO - Running pre-action listener: _resource_record_pre_action 17:26:33 INFO - Running main action method: download_and_extract 17:26:33 INFO - mkdir: /builds/slave/test/build/tests 17:26:33 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:26:33 INFO - trying https://queue.taskcluster.net/v1/task/AQfsKt6CSDCy6cyG1gSFgw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:26:33 INFO - Downloading https://queue.taskcluster.net/v1/task/AQfsKt6CSDCy6cyG1gSFgw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:26:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AQfsKt6CSDCy6cyG1gSFgw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:26:34 INFO - Downloaded 1361 bytes. 17:26:34 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:26:34 INFO - Using the following test package requirements: 17:26:34 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 17:26:34 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:26:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:26:34 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:26:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:26:34 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:26:34 INFO - u'jsshell-linux-x86_64.zip'], 17:26:34 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:26:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:26:34 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 17:26:34 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:26:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:26:34 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:26:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:26:34 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:26:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:26:34 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:26:34 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:26:34 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:26:34 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:26:34 INFO - trying https://queue.taskcluster.net/v1/task/AQfsKt6CSDCy6cyG1gSFgw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:26:34 INFO - Downloading https://queue.taskcluster.net/v1/task/AQfsKt6CSDCy6cyG1gSFgw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:26:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AQfsKt6CSDCy6cyG1gSFgw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:26:35 INFO - Downloaded 20330659 bytes. 17:26:35 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 17:26:39 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:26: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:26:39 INFO - trying https://queue.taskcluster.net/v1/task/AQfsKt6CSDCy6cyG1gSFgw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:26:39 INFO - Downloading https://queue.taskcluster.net/v1/task/AQfsKt6CSDCy6cyG1gSFgw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:26:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AQfsKt6CSDCy6cyG1gSFgw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:26:40 INFO - Downloaded 20330659 bytes. 17:26:40 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 17:26:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:26:44 INFO - trying https://queue.taskcluster.net/v1/task/AQfsKt6CSDCy6cyG1gSFgw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 17:26:44 INFO - Downloading https://queue.taskcluster.net/v1/task/AQfsKt6CSDCy6cyG1gSFgw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 17:26:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AQfsKt6CSDCy6cyG1gSFgw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:26:45 INFO - Downloaded 14413981 bytes. 17:26:45 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 17:26:46 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:26:46 INFO - trying https://queue.taskcluster.net/v1/task/AQfsKt6CSDCy6cyG1gSFgw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:26:46 INFO - Downloading https://queue.taskcluster.net/v1/task/AQfsKt6CSDCy6cyG1gSFgw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:26:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AQfsKt6CSDCy6cyG1gSFgw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:26:47 INFO - Downloaded 55766765 bytes. 17:26:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AQfsKt6CSDCy6cyG1gSFgw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:26:47 INFO - mkdir: /builds/slave/test/properties 17:26:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:26:47 INFO - Writing to file /builds/slave/test/properties/build_url 17:26:47 INFO - Contents: 17:26:47 INFO - build_url:https://queue.taskcluster.net/v1/task/AQfsKt6CSDCy6cyG1gSFgw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:26:47 INFO - Running post-action listener: _resource_record_post_action 17:26:47 INFO - Running post-action listener: set_extra_try_arguments 17:26:47 INFO - [mozharness: 2016-08-23 00:26:47.803591Z] Finished download-and-extract step (success) 17:26:47 INFO - [mozharness: 2016-08-23 00:26:47.803814Z] Running populate-webroot step. 17:26:47 INFO - Running pre-action listener: _resource_record_pre_action 17:26:47 INFO - Running main action method: populate_webroot 17:26:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:26:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:26:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:26:47 INFO - '--tppagecycles', 17:26:47 INFO - '7'], 17:26:47 INFO - 'tests': ['tsvgm']}}, 17:26:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:26:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:26:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:26:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:26:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:26:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:26:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:47 INFO - 'talos_options': ['--disable-e10s'], 17:26:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:26:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:26:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:47 INFO - 'talos_options': ['--disable-e10s'], 17:26:47 INFO - 'tests': ['damp', 'tps']}, 17:26:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:47 INFO - 'tests': ['damp', 'tps']}, 17:26:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:26:47 INFO - 'tests': ['dromaeo_dom']}, 17:26:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:26:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:26:47 INFO - 'tests': ['basic_compositor_video']}, 17:26:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:26:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:26:47 INFO - 'tests': ['a11yr', 17:26:47 INFO - 'ts_paint', 17:26:47 INFO - 'tpaint', 17:26:47 INFO - 'sessionrestore', 17:26:47 INFO - 'sessionrestore_no_auto_restore', 17:26:47 INFO - 'tabpaint']}, 17:26:47 INFO - 'other-e10s': {'tests': ['a11yr', 17:26:47 INFO - 'ts_paint', 17:26:47 INFO - 'tpaint', 17:26:47 INFO - 'sessionrestore', 17:26:47 INFO - 'sessionrestore_no_auto_restore', 17:26:47 INFO - 'tabpaint']}, 17:26:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:26:47 INFO - 'ts_paint', 17:26:47 INFO - 'tpaint', 17:26:47 INFO - 'sessionrestore', 17:26:47 INFO - 'sessionrestore_no_auto_restore', 17:26:47 INFO - 'tabpaint']}, 17:26:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:26:47 INFO - 'ts_paint', 17:26:47 INFO - 'tpaint', 17:26:47 INFO - 'sessionrestore', 17:26:47 INFO - 'sessionrestore_no_auto_restore', 17:26:47 INFO - 'tabpaint']}, 17:26:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:26:47 INFO - 'tests': ['a11yr', 17:26:47 INFO - 'ts_paint', 17:26:47 INFO - 'tpaint', 17:26:47 INFO - 'sessionrestore', 17:26:47 INFO - 'sessionrestore_no_auto_restore', 17:26:47 INFO - 'tabpaint']}, 17:26:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:26:47 INFO - 'tests': ['a11yr', 17:26:47 INFO - 'ts_paint', 17:26:47 INFO - 'tpaint', 17:26:47 INFO - 'sessionrestore', 17:26:47 INFO - 'sessionrestore_no_auto_restore', 17:26:47 INFO - 'tabpaint']}, 17:26:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:26:47 INFO - 'tests': ['tsvgx', 17:26:47 INFO - 'tsvgr_opacity', 17:26:47 INFO - 'tart', 17:26:47 INFO - 'tscrollx', 17:26:47 INFO - 'cart']}, 17:26:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:26:47 INFO - 'tsvgr_opacity', 17:26:47 INFO - 'tart', 17:26:47 INFO - 'tscrollx', 17:26:47 INFO - 'cart']}, 17:26:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:47 INFO - 'talos_options': ['--disable-e10s'], 17:26:47 INFO - 'tests': ['tp5o']}, 17:26:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:47 INFO - 'tests': ['tp5o']}, 17:26:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:47 INFO - 'talos_options': ['--disable-e10s', 17:26:47 INFO - '--xperf_path', 17:26:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:26:47 INFO - 'tests': ['tp5n']}, 17:26:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:26:47 INFO - 'talos_options': ['--xperf_path', 17:26:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:26:47 INFO - 'tests': ['tp5n']}}, 17:26:47 INFO - 'talos.zip': {'path': '', 17:26:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:26:47 INFO - Running post-action listener: _resource_record_post_action 17:26:47 INFO - [mozharness: 2016-08-23 00:26:47.823784Z] Finished populate-webroot step (success) 17:26:47 INFO - [mozharness: 2016-08-23 00:26:47.823872Z] Running create-virtualenv step. 17:26:47 INFO - Running pre-action listener: _resource_record_pre_action 17:26:47 INFO - Running main action method: create_virtualenv 17:26:47 INFO - Creating virtualenv /builds/slave/test/build/venv 17:26:47 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:26:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:26:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:26:47 INFO - Using real prefix '/usr' 17:26:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:26:48 INFO - Installing distribute.............................................................................................................................................................................................done. 17:26:50 INFO - Installing pip.................done. 17:26:50 INFO - Return code: 0 17:26:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:26:50 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:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:50 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:26:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:50 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 0x7fe7c6ce4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf68090>, '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 0xf6b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6be40>, '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': '32c5991c409366f7fec8a718000001d2-1471911990.836801-1443251870', '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:26:50 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:26:50 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:26:50 INFO - Using env: {'DISPLAY': ':0', 17:26:50 INFO - 'HOME': '/home/cltbld', 17:26:50 INFO - 'LANG': 'en_US.UTF-8', 17:26:50 INFO - 'LANGUAGE': 'en_US:en', 17:26:50 INFO - 'LOGNAME': 'cltbld', 17:26:50 INFO - 'MAIL': '/var/mail/cltbld', 17:26:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:50 INFO - 'MOZ_NO_REMOTE': '1', 17:26:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:50 INFO - 'NO_EM_RESTART': '1', 17:26:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:50 INFO - 'PWD': '/builds/slave/test', 17:26:50 INFO - 'SHELL': '/bin/bash', 17:26:50 INFO - 'SHLVL': '1', 17:26:50 INFO - 'TERM': 'linux', 17:26:50 INFO - 'TMOUT': '86400', 17:26:50 INFO - 'USER': 'cltbld', 17:26:50 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471911990.836801-1443251870', 17:26:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:50 INFO - '_': '/tools/buildbot/bin/python'} 17:26:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:50 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:26:50 INFO - Cleaning up... 17:26:50 INFO - Return code: 0 17:26:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:26:50 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:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:50 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:26:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:50 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 0x7fe7c6ce4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf68090>, '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 0xf6b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6be40>, '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': '32c5991c409366f7fec8a718000001d2-1471911990.836801-1443251870', '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:26:50 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:26:50 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:26:50 INFO - Using env: {'DISPLAY': ':0', 17:26:50 INFO - 'HOME': '/home/cltbld', 17:26:50 INFO - 'LANG': 'en_US.UTF-8', 17:26:50 INFO - 'LANGUAGE': 'en_US:en', 17:26:50 INFO - 'LOGNAME': 'cltbld', 17:26:50 INFO - 'MAIL': '/var/mail/cltbld', 17:26:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:50 INFO - 'MOZ_NO_REMOTE': '1', 17:26:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:50 INFO - 'NO_EM_RESTART': '1', 17:26:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:50 INFO - 'PWD': '/builds/slave/test', 17:26:50 INFO - 'SHELL': '/bin/bash', 17:26:50 INFO - 'SHLVL': '1', 17:26:50 INFO - 'TERM': 'linux', 17:26:50 INFO - 'TMOUT': '86400', 17:26:50 INFO - 'USER': 'cltbld', 17:26:50 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471911990.836801-1443251870', 17:26:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:50 INFO - '_': '/tools/buildbot/bin/python'} 17:26:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:50 INFO - Downloading/unpacking psutil>=3.1.1 17:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:50 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:26:50 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:26:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:26:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:26:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:26:52 INFO - Installing collected packages: psutil 17:26:52 INFO - Running setup.py install for psutil 17:26:52 INFO - building 'psutil._psutil_linux' extension 17:26:52 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:26:53 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:26:53 INFO - building 'psutil._psutil_posix' extension 17:26:53 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:26:53 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:26:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:26:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:26:53 INFO - Successfully installed psutil 17:26:53 INFO - Cleaning up... 17:26:53 INFO - Return code: 0 17:26:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:26:53 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:26:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:53 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:26:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:53 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 0x7fe7c6ce4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf68090>, '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 0xf6b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6be40>, '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': '32c5991c409366f7fec8a718000001d2-1471911990.836801-1443251870', '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:26:53 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:26:53 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:26:53 INFO - Using env: {'DISPLAY': ':0', 17:26:53 INFO - 'HOME': '/home/cltbld', 17:26:53 INFO - 'LANG': 'en_US.UTF-8', 17:26:53 INFO - 'LANGUAGE': 'en_US:en', 17:26:53 INFO - 'LOGNAME': 'cltbld', 17:26:53 INFO - 'MAIL': '/var/mail/cltbld', 17:26:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:53 INFO - 'MOZ_NO_REMOTE': '1', 17:26:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:53 INFO - 'NO_EM_RESTART': '1', 17:26:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:53 INFO - 'PWD': '/builds/slave/test', 17:26:53 INFO - 'SHELL': '/bin/bash', 17:26:53 INFO - 'SHLVL': '1', 17:26:53 INFO - 'TERM': 'linux', 17:26:53 INFO - 'TMOUT': '86400', 17:26:53 INFO - 'USER': 'cltbld', 17:26:53 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471911990.836801-1443251870', 17:26:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:53 INFO - '_': '/tools/buildbot/bin/python'} 17:26:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:26:53 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:26:53 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:26:53 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:26:53 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:26:53 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:26:53 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:26:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:26:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:26:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:26:55 INFO - Installing collected packages: mozsystemmonitor 17:26:55 INFO - Running setup.py install for mozsystemmonitor 17:26:55 INFO - Successfully installed mozsystemmonitor 17:26:55 INFO - Cleaning up... 17:26:55 INFO - Return code: 0 17:26:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:26: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:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26: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:26:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:55 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 0x7fe7c6ce4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf68090>, '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 0xf6b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6be40>, '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': '32c5991c409366f7fec8a718000001d2-1471911990.836801-1443251870', '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:26:55 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:26:55 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:26:55 INFO - Using env: {'DISPLAY': ':0', 17:26:55 INFO - 'HOME': '/home/cltbld', 17:26:55 INFO - 'LANG': 'en_US.UTF-8', 17:26:55 INFO - 'LANGUAGE': 'en_US:en', 17:26:55 INFO - 'LOGNAME': 'cltbld', 17:26:55 INFO - 'MAIL': '/var/mail/cltbld', 17:26:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:55 INFO - 'MOZ_NO_REMOTE': '1', 17:26:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:55 INFO - 'NO_EM_RESTART': '1', 17:26:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:55 INFO - 'PWD': '/builds/slave/test', 17:26:55 INFO - 'SHELL': '/bin/bash', 17:26:55 INFO - 'SHLVL': '1', 17:26:55 INFO - 'TERM': 'linux', 17:26:55 INFO - 'TMOUT': '86400', 17:26:55 INFO - 'USER': 'cltbld', 17:26:55 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471911990.836801-1443251870', 17:26:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:55 INFO - '_': '/tools/buildbot/bin/python'} 17:26:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:55 INFO - Downloading/unpacking jsonschema==2.5.1 17:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:55 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:26:55 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:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:26:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:57 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:26:57 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:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:58 INFO - Downloading functools32-3.2.3-2.tar.gz 17:26:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:26:58 INFO - warning: no files found matching '*.txt' 17:26:58 INFO - no previously-included directories found matching 'build' 17:26:58 INFO - no previously-included directories found matching 'dist' 17:26:58 INFO - no previously-included directories found matching '.git*' 17:26:58 INFO - Installing collected packages: jsonschema, functools32 17:26:58 INFO - Running setup.py install for functools32 17:26:58 INFO - warning: no files found matching '*.txt' 17:26:58 INFO - no previously-included directories found matching 'build' 17:26:58 INFO - no previously-included directories found matching 'dist' 17:26:58 INFO - no previously-included directories found matching '.git*' 17:26:58 INFO - Successfully installed jsonschema functools32 17:26:58 INFO - Cleaning up... 17:26:58 INFO - Return code: 0 17:26:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:26:58 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:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:58 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:26:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:58 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 0x7fe7c6ce4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf68090>, '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 0xf6b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6be40>, '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': '32c5991c409366f7fec8a718000001d2-1471911990.836801-1443251870', '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:26:58 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:26:58 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:26:58 INFO - Using env: {'DISPLAY': ':0', 17:26:58 INFO - 'HOME': '/home/cltbld', 17:26:58 INFO - 'LANG': 'en_US.UTF-8', 17:26:58 INFO - 'LANGUAGE': 'en_US:en', 17:26:58 INFO - 'LOGNAME': 'cltbld', 17:26:58 INFO - 'MAIL': '/var/mail/cltbld', 17:26:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:58 INFO - 'MOZ_NO_REMOTE': '1', 17:26:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:58 INFO - 'NO_EM_RESTART': '1', 17:26:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:58 INFO - 'PWD': '/builds/slave/test', 17:26:58 INFO - 'SHELL': '/bin/bash', 17:26:58 INFO - 'SHLVL': '1', 17:26:58 INFO - 'TERM': 'linux', 17:26:58 INFO - 'TMOUT': '86400', 17:26:58 INFO - 'USER': 'cltbld', 17:26:58 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471911990.836801-1443251870', 17:26:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:58 INFO - '_': '/tools/buildbot/bin/python'} 17:26:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:26:58 INFO - Cleaning up... 17:26:58 INFO - Return code: 0 17:26:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:26:58 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:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:58 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:26:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26:58 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 0x7fe7c6ce4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf68090>, '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 0xf6b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6be40>, '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': '32c5991c409366f7fec8a718000001d2-1471911990.836801-1443251870', '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:26:58 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:26:58 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:26:58 INFO - Using env: {'DISPLAY': ':0', 17:26:58 INFO - 'HOME': '/home/cltbld', 17:26:58 INFO - 'LANG': 'en_US.UTF-8', 17:26:58 INFO - 'LANGUAGE': 'en_US:en', 17:26:58 INFO - 'LOGNAME': 'cltbld', 17:26:58 INFO - 'MAIL': '/var/mail/cltbld', 17:26:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:58 INFO - 'MOZ_NO_REMOTE': '1', 17:26:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:58 INFO - 'NO_EM_RESTART': '1', 17:26:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:58 INFO - 'PWD': '/builds/slave/test', 17:26:58 INFO - 'SHELL': '/bin/bash', 17:26:58 INFO - 'SHLVL': '1', 17:26:58 INFO - 'TERM': 'linux', 17:26:58 INFO - 'TMOUT': '86400', 17:26:58 INFO - 'USER': 'cltbld', 17:26:58 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471911990.836801-1443251870', 17:26:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:58 INFO - '_': '/tools/buildbot/bin/python'} 17:26:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:58 INFO - Downloading/unpacking blobuploader==1.2.4 17:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:26:58 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:26:58 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:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:27:00 INFO - Downloading blobuploader-1.2.4.tar.gz 17:27:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:27:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:27:00 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:27:00 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:27:00 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:27:00 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:27:00 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:27:00 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:27:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:27:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:27: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:27: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:27: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:27: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:27: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:27: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:27:01 INFO - Downloading docopt-0.6.1.tar.gz 17:27:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:27:01 INFO - Installing collected packages: blobuploader, requests, docopt 17:27:01 INFO - Running setup.py install for blobuploader 17:27:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:27:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:27:01 INFO - Running setup.py install for requests 17:27:01 INFO - Running setup.py install for docopt 17:27:01 INFO - Successfully installed blobuploader requests docopt 17:27:01 INFO - Cleaning up... 17:27:01 INFO - Return code: 0 17:27:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:27: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:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27: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:27:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:01 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 0x7fe7c6ce4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf68090>, '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 0xf6b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6be40>, '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': '32c5991c409366f7fec8a718000001d2-1471911990.836801-1443251870', '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:27:01 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:27:01 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:27:01 INFO - Using env: {'DISPLAY': ':0', 17:27:01 INFO - 'HOME': '/home/cltbld', 17:27:01 INFO - 'LANG': 'en_US.UTF-8', 17:27:01 INFO - 'LANGUAGE': 'en_US:en', 17:27:01 INFO - 'LOGNAME': 'cltbld', 17:27:01 INFO - 'MAIL': '/var/mail/cltbld', 17:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:01 INFO - 'MOZ_NO_REMOTE': '1', 17:27:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:01 INFO - 'NO_EM_RESTART': '1', 17:27:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:01 INFO - 'PWD': '/builds/slave/test', 17:27:01 INFO - 'SHELL': '/bin/bash', 17:27:01 INFO - 'SHLVL': '1', 17:27:01 INFO - 'TERM': 'linux', 17:27:01 INFO - 'TMOUT': '86400', 17:27:01 INFO - 'USER': 'cltbld', 17:27:01 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471911990.836801-1443251870', 17:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:01 INFO - '_': '/tools/buildbot/bin/python'} 17:27:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:27:02 INFO - Running setup.py (path:/tmp/pip-kYbvrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:27:02 INFO - Running setup.py (path:/tmp/pip-35Yk_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:27:02 INFO - Running setup.py (path:/tmp/pip-NEZSIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:27:02 INFO - Running setup.py (path:/tmp/pip-D3pBi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:27:02 INFO - Running setup.py (path:/tmp/pip-FL_3Cs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:27:02 INFO - Running setup.py (path:/tmp/pip-boMlxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:27:02 INFO - Running setup.py (path:/tmp/pip-cAaZQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:27:02 INFO - Running setup.py (path:/tmp/pip-8tREzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:27:02 INFO - Running setup.py (path:/tmp/pip-DhcV8K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:27:02 INFO - Running setup.py (path:/tmp/pip-Km1G6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:27:02 INFO - Running setup.py (path:/tmp/pip-wPatm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:27:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:27:02 INFO - Running setup.py (path:/tmp/pip-kUmxI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:27:03 INFO - Running setup.py (path:/tmp/pip-k6d0V4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:27:03 INFO - Running setup.py (path:/tmp/pip-HXaKtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:27:03 INFO - Running setup.py (path:/tmp/pip-Np_r_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:27:03 INFO - Running setup.py (path:/tmp/pip-cXWgEY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:27:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:27:03 INFO - Running setup.py (path:/tmp/pip-5Binbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:27:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:27:03 INFO - Running setup.py install for manifestparser 17:27:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:27:03 INFO - Running setup.py install for mozcrash 17:27:03 INFO - Running setup.py install for mozdebug 17:27:03 INFO - Running setup.py install for mozdevice 17:27:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:27:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:27:03 INFO - Running setup.py install for mozfile 17:27:03 INFO - Running setup.py install for mozhttpd 17:27:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:27:04 INFO - Running setup.py install for mozinfo 17:27:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:27:04 INFO - Running setup.py install for mozInstall 17:27:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:27:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:27:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:27:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:27:04 INFO - Running setup.py install for mozleak 17:27:04 INFO - Running setup.py install for mozlog 17:27:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:27:04 INFO - Running setup.py install for moznetwork 17:27:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:27:04 INFO - Running setup.py install for mozprocess 17:27:04 INFO - Running setup.py install for mozprofile 17:27:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:27:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:27:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:27:04 INFO - Running setup.py install for mozrunner 17:27:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:27:04 INFO - Running setup.py install for mozscreenshot 17:27:05 INFO - Running setup.py install for moztest 17:27:05 INFO - Running setup.py install for mozversion 17:27:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:27:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:27:05 INFO - Cleaning up... 17:27:05 INFO - Return code: 0 17:27:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:27: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:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27: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:27:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:05 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 0x7fe7c6ce4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf68090>, '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 0xf6b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6be40>, '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': '32c5991c409366f7fec8a718000001d2-1471911990.836801-1443251870', '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:27:05 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:27:05 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:27:05 INFO - Using env: {'DISPLAY': ':0', 17:27:05 INFO - 'HOME': '/home/cltbld', 17:27:05 INFO - 'LANG': 'en_US.UTF-8', 17:27:05 INFO - 'LANGUAGE': 'en_US:en', 17:27:05 INFO - 'LOGNAME': 'cltbld', 17:27:05 INFO - 'MAIL': '/var/mail/cltbld', 17:27:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:05 INFO - 'MOZ_NO_REMOTE': '1', 17:27:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:05 INFO - 'NO_EM_RESTART': '1', 17:27:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:05 INFO - 'PWD': '/builds/slave/test', 17:27:05 INFO - 'SHELL': '/bin/bash', 17:27:05 INFO - 'SHLVL': '1', 17:27:05 INFO - 'TERM': 'linux', 17:27:05 INFO - 'TMOUT': '86400', 17:27:05 INFO - 'USER': 'cltbld', 17:27:05 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471911990.836801-1443251870', 17:27:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:05 INFO - '_': '/tools/buildbot/bin/python'} 17:27:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:27:05 INFO - Running setup.py (path:/tmp/pip-HevC4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:27:05 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:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:27:05 INFO - Running setup.py (path:/tmp/pip-S3UGnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:27:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:27:05 INFO - Running setup.py (path:/tmp/pip-G4sTCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:27:05 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:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:27:05 INFO - Running setup.py (path:/tmp/pip-8vOWJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:27:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:27:05 INFO - Running setup.py (path:/tmp/pip-CHXEw3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:27:05 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:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:27:05 INFO - Running setup.py (path:/tmp/pip-l84wzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:27:05 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:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:27:05 INFO - Running setup.py (path:/tmp/pip-dQPkw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:27:05 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:27:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:27:05 INFO - Running setup.py (path:/tmp/pip-_ECLtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:27:06 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:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:27:06 INFO - Running setup.py (path:/tmp/pip-CtxI0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:27:06 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:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:27:06 INFO - Running setup.py (path:/tmp/pip-735TjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:27:06 INFO - Running setup.py (path:/tmp/pip-m0Vl2J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:27:06 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:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:27:06 INFO - Running setup.py (path:/tmp/pip-f5kmbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:27:06 INFO - Running setup.py (path:/tmp/pip-Zc8NM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:27:06 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:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:27:06 INFO - Running setup.py (path:/tmp/pip-gWsXmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:27:06 INFO - Running setup.py (path:/tmp/pip-0Rr7iQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:27:06 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:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:27:06 INFO - Running setup.py (path:/tmp/pip-ZGyYb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:27:06 INFO - Running setup.py (path:/tmp/pip-lREz5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:27:06 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:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:27:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:27:06 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:27:06 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:27:06 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:27:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:27:06 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:27:06 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:27:06 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:27:06 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:27:06 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:27:06 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:27:08 INFO - Downloading blessings-1.6.tar.gz 17:27:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:27:08 INFO - Installing collected packages: blessings 17:27:08 INFO - Running setup.py install for blessings 17:27:08 INFO - Successfully installed blessings 17:27:08 INFO - Cleaning up... 17:27:08 INFO - Return code: 0 17:27:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:27:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:27:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:27:09 INFO - Reading from file tmpfile_stdout 17:27:09 INFO - Current package versions: 17:27:09 INFO - argparse == 1.2.1 17:27:09 INFO - blessings == 1.6 17:27:09 INFO - blobuploader == 1.2.4 17:27:09 INFO - docopt == 0.6.1 17:27:09 INFO - functools32 == 3.2.3-2 17:27:09 INFO - jsonschema == 2.5.1 17:27:09 INFO - manifestparser == 1.1 17:27:09 INFO - mozInstall == 1.12 17:27:09 INFO - mozcrash == 0.17 17:27:09 INFO - mozdebug == 0.1 17:27:09 INFO - mozdevice == 0.48 17:27:09 INFO - mozfile == 1.2 17:27:09 INFO - mozhttpd == 0.7 17:27:09 INFO - mozinfo == 0.9 17:27:09 INFO - mozleak == 0.1 17:27:09 INFO - mozlog == 3.3 17:27:09 INFO - moznetwork == 0.27 17:27:09 INFO - mozprocess == 0.23 17:27:09 INFO - mozprofile == 0.28 17:27:09 INFO - mozrunner == 6.12 17:27:09 INFO - mozscreenshot == 0.1 17:27:09 INFO - mozsystemmonitor == 0.3 17:27:09 INFO - moztest == 0.7 17:27:09 INFO - mozversion == 1.4 17:27:09 INFO - psutil == 3.1.1 17:27:09 INFO - requests == 1.2.3 17:27:09 INFO - wsgiref == 0.1.2 17:27:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:27:09 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:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:09 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:27:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:09 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 0x7fe7c6ce4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf68090>, '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 0xf6b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6be40>, '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': '32c5991c409366f7fec8a718000001d2-1471911990.836801-1443251870', '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:27:09 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:27:09 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:27:09 INFO - Using env: {'DISPLAY': ':0', 17:27:09 INFO - 'HOME': '/home/cltbld', 17:27:09 INFO - 'LANG': 'en_US.UTF-8', 17:27:09 INFO - 'LANGUAGE': 'en_US:en', 17:27:09 INFO - 'LOGNAME': 'cltbld', 17:27:09 INFO - 'MAIL': '/var/mail/cltbld', 17:27:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:09 INFO - 'MOZ_NO_REMOTE': '1', 17:27:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:09 INFO - 'NO_EM_RESTART': '1', 17:27:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:09 INFO - 'PWD': '/builds/slave/test', 17:27:09 INFO - 'SHELL': '/bin/bash', 17:27:09 INFO - 'SHLVL': '1', 17:27:09 INFO - 'TERM': 'linux', 17:27:09 INFO - 'TMOUT': '86400', 17:27:09 INFO - 'USER': 'cltbld', 17:27:09 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471911990.836801-1443251870', 17:27:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:09 INFO - '_': '/tools/buildbot/bin/python'} 17:27:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:09 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:27:09 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:27:09 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:27:09 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:27:09 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:27:09 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:27:09 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:27:09 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:27:09 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:27:09 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:27:09 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:27:09 INFO - Cleaning up... 17:27:09 INFO - Return code: 0 17:27:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:27:09 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:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:27:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:09 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:27:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:27:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:27:09 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 0x7fe7c6ce4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe9f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf6e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf68090>, '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 0xf6b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6be40>, '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': '32c5991c409366f7fec8a718000001d2-1471911990.836801-1443251870', '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:27:09 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:27:09 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:27:09 INFO - Using env: {'DISPLAY': ':0', 17:27:09 INFO - 'HOME': '/home/cltbld', 17:27:09 INFO - 'LANG': 'en_US.UTF-8', 17:27:09 INFO - 'LANGUAGE': 'en_US:en', 17:27:09 INFO - 'LOGNAME': 'cltbld', 17:27:09 INFO - 'MAIL': '/var/mail/cltbld', 17:27:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:09 INFO - 'MOZ_NO_REMOTE': '1', 17:27:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:09 INFO - 'NO_EM_RESTART': '1', 17:27:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:09 INFO - 'PWD': '/builds/slave/test', 17:27:09 INFO - 'SHELL': '/bin/bash', 17:27:09 INFO - 'SHLVL': '1', 17:27:09 INFO - 'TERM': 'linux', 17:27:09 INFO - 'TMOUT': '86400', 17:27:09 INFO - 'USER': 'cltbld', 17:27:09 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471911990.836801-1443251870', 17:27:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:09 INFO - '_': '/tools/buildbot/bin/python'} 17:27:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:27:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:27:09 INFO - Cleaning up... 17:27:09 INFO - Return code: 0 17:27:09 INFO - Running post-action listener: _resource_record_post_action 17:27:09 INFO - Running post-action listener: _start_resource_monitoring 17:27:09 INFO - Starting resource monitoring. 17:27:09 INFO - [mozharness: 2016-08-23 00:27:09.500603Z] Finished create-virtualenv step (success) 17:27:09 INFO - [mozharness: 2016-08-23 00:27:09.501101Z] Running install step. 17:27:09 INFO - Running pre-action listener: _resource_record_pre_action 17:27:09 INFO - Running main action method: install 17:27:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:27:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:27:09 INFO - Reading from file tmpfile_stdout 17:27:09 INFO - Detecting whether we're running mozinstall >=1.0... 17:27:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:27:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:27:09 INFO - Reading from file tmpfile_stdout 17:27:09 INFO - Output received: 17:27:09 INFO - Usage: mozinstall [options] installer 17:27:09 INFO - Options: 17:27:09 INFO - -h, --help show this help message and exit 17:27:09 INFO - -d DEST, --destination=DEST 17:27:09 INFO - Directory to install application into. [default: 17:27:09 INFO - "/builds/slave/test"] 17:27:09 INFO - --app=APP Application being installed. [default: firefox] 17:27:09 INFO - mkdir: /builds/slave/test/build/application 17:27:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:27:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:27:25 INFO - Reading from file tmpfile_stdout 17:27:25 INFO - Output received: 17:27:25 INFO - /builds/slave/test/build/application/firefox/firefox 17:27:25 INFO - Running post-action listener: _resource_record_post_action 17:27:25 INFO - [mozharness: 2016-08-23 00:27:25.929798Z] Finished install step (success) 17:27:25 INFO - [mozharness: 2016-08-23 00:27:25.930045Z] Running run-tests step. 17:27:25 INFO - Running pre-action listener: _resource_record_pre_action 17:27:25 INFO - Running main action method: run_tests 17:27:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:27:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:27:25 INFO - Python 2.7.3 17:27:25 INFO - Return code: 0 17:27:25 INFO - grabbing minidump binary from tooltool 17:27:25 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:27:25 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 0xf68090>, '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 0xf6b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf6be40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:27:25 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:27:25 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:27:25 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:27:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:27:26 INFO - Return code: 0 17:27:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:27:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:27:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:27:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:27:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:27:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AQfsKt6CSDCy6cyG1gSFgw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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:27:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AQfsKt6CSDCy6cyG1gSFgw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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:27:26 INFO - Using env: {'DISPLAY': ':0', 17:27:26 INFO - 'HOME': '/home/cltbld', 17:27:26 INFO - 'LANG': 'en_US.UTF-8', 17:27:26 INFO - 'LANGUAGE': 'en_US:en', 17:27:26 INFO - 'LOGNAME': 'cltbld', 17:27:26 INFO - 'MAIL': '/var/mail/cltbld', 17:27:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:27:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:27:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:27:26 INFO - 'MOZ_NO_REMOTE': '1', 17:27:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:27:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:27:26 INFO - 'NO_EM_RESTART': '1', 17:27:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:27:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:27:26 INFO - 'PWD': '/builds/slave/test', 17:27:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:27:26 INFO - 'SHELL': '/bin/bash', 17:27:26 INFO - 'SHLVL': '1', 17:27:26 INFO - 'TERM': 'linux', 17:27:26 INFO - 'TMOUT': '86400', 17:27:26 INFO - 'USER': 'cltbld', 17:27:26 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1471911990.836801-1443251870', 17:27:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:27:26 INFO - '_': '/tools/buildbot/bin/python'} 17:27:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AQfsKt6CSDCy6cyG1gSFgw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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:27:26 INFO - mozversion application_buildid: 20160822160116 17:27:26 INFO - mozversion application_changeset: 24763f58772d45279a935790f732d80851924b46 17:27:26 INFO - mozversion application_display_name: Nightly 17:27:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:27:26 INFO - mozversion application_name: Firefox 17:27:26 INFO - mozversion application_remotingname: firefox 17:27:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:27:26 INFO - mozversion application_vendor: Mozilla 17:27:26 INFO - mozversion application_version: 51.0a1 17:27:26 INFO - mozversion platform_buildid: 20160822160116 17:27:26 INFO - mozversion platform_changeset: 24763f58772d45279a935790f732d80851924b46 17:27:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:27:26 INFO - mozversion platform_version: 51.0a1 17:27:26 INFO - using testdate: 1471912046 17:27:26 INFO - actual date: 1471912046 17:27:26 INFO - starting webserver on 'localhost:51714' 17:27:26 INFO - SUITE-START | Running 2 tests 17:27:26 INFO - TEST-START | dromaeo_css 17:27:26 INFO - operating with platform_type : linux_ 17:27:26 INFO - Initialising browser for dromaeo_css test... 17:27:26 INFO - TEST-INFO | started process 29684 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWkkdVf/profile http://localhost:51714/getInfo.html) 17:27:30 INFO - PROCESS | 29684 | __metrics Screen width/height:1600/1200 17:27:30 INFO - PROCESS | 29684 | colorDepth:24 17:27:30 INFO - PROCESS | 29684 | Browser inner width/height: 1024/697 17:27:30 INFO - PROCESS | 29684 | __metrics 17:27:31 INFO - PROCESS | 29684 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:27:31 INFO - PROCESS | 29684 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:27:31 INFO - PROCESS | 29684 | console.error: PushService: 17:27:31 INFO - PROCESS | 29684 | stateChangeProcessEnqueue: Error transitioning state 17:27:31 INFO - PROCESS | 29684 | UnknownError 17:27:32 INFO - TEST-INFO | 29684: exit 0 17:27:32 INFO - Browser initialized. 17:27:32 INFO - Running cycle 1/1 for dromaeo_css test... 17:27:32 INFO - TEST-INFO | started process 29762 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWkkdVf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:27:44 INFO - PROCESS | 29762 | RSS: Main: 175755264 17:27:44 INFO - PROCESS | 29762 | 17:28:36 INFO - PROCESS | 29762 | 1471912116260 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:30:48 INFO - PROCESS | 29762 | Cycle 1(1): loaded http://localhost:51714/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51714/tests/dromaeo/cssquery-ext.html) 17:30:49 INFO - PROCESS | 29762 | RSS: Main: 257310720 17:30:49 INFO - PROCESS | 29762 | 17:33:52 INFO - PROCESS | 29762 | Cycle 1(1): loaded http://localhost:51714/tests/dromaeo/cssquery-ext.html (next: http://localhost:51714/tests/dromaeo/cssquery-jquery.html) 17:33:52 INFO - PROCESS | 29762 | RSS: Main: 276582400 17:33:52 INFO - PROCESS | 29762 | 17:36:55 INFO - PROCESS | 29762 | Cycle 1(1): loaded http://localhost:51714/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51714/tests/dromaeo/cssquery-mootools.html) 17:36:55 INFO - PROCESS | 29762 | RSS: Main: 218038272 17:36:55 INFO - PROCESS | 29762 | 17:39:58 INFO - PROCESS | 29762 | Cycle 1(1): loaded http://localhost:51714/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51714/tests/dromaeo/cssquery-prototype.html) 17:39:58 INFO - PROCESS | 29762 | RSS: Main: 217878528 17:39:58 INFO - PROCESS | 29762 | 17:43:02 INFO - PROCESS | 29762 | Cycle 1(1): loaded http://localhost:51714/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51714/tests/dromaeo/cssquery-yui.html) 17:43:02 INFO - PROCESS | 29762 | RSS: Main: 219107328 17:43:02 INFO - PROCESS | 29762 | 17:46:05 INFO - PROCESS | 29762 | Cycle 1(1): loaded http://localhost:51714/tests/dromaeo/cssquery-yui.html (next: http://localhost:51714/tests/dromaeo/cssquery-dojo.html) 17:46:06 INFO - PROCESS | 29762 | RSS: Main: 310222848 17:46:06 INFO - PROCESS | 29762 | 17:46:06 INFO - PROCESS | 29762 | __start_tp_report 17:46:06 INFO - PROCESS | 29762 | _x_x_mozilla_page_load 17:46:06 INFO - PROCESS | 29762 | _x_x_mozilla_page_load_details 17:46:06 INFO - PROCESS | 29762 | |i|pagename|runs| 17:46:06 INFO - PROCESS | 29762 | |0;dojo.html;2560.2063360358284;2607.8044146689003;2608.334874606975;2615.973840261598;2630.1846427607443;4579.748113853737;4581.40441742573;4609.216433206355;4693.718376897388;4705.011947491027;4640.860774176772;4692.108499385115;4700.482946875841;4713.670043096985;4751.097291514609;4339.609435150835;4348.760818155;4413.668974826885;4431.534688857671;4459.33767184333;4407.757573333465;4446.466424029105;4453.087117140994;4454.732716037032;4455.331700244957;4183.5398106208295;4218.578142185787;4243.27864263076;4321.0709697414895;4330;4285.571442855689;4287.185434767384;4295.334223195409;4306.913861722748;4313.805878735465;4347.065380943112;4353.172897149531;4363.759993200372;4364.519902810688;4365.781710914442;4698.154332220199;4769.260764581495;4771.785269662839;4774.40319960005;4779.498152693952;4898.90202195954;4998.250262460624;5035.395752509686;5035.697858128524;5108.591312694975;5118.129917913963;5128.102582048164;5131.61512886535;5135.974320128375;5138.332016837787;4771.5467030632035;4784.114938736276;4784.952150478485;4803.763897351903;4808.0624278266105;5010;5175.637705360664;5181.766820493011;5215.58275337972;5237.188235823453;5035.79856805731;5070.4929507049;5073.568746656576;5076.060928728197;5079.161938280143;5150.48495150482;5154.896902061938;5158.793648254028;5162.767675454614;5166.070107380632;4855.781489832966;4888.804447822047;4957.603391728725;5081.4918508148885;5087.211482220262;4971.7016978980655;4986.601071914238;4988.426330971912;4989.451160372356;4995.550400463976;4319.632831209383;4319.97840010798;4321.308590625485;4323.221820072355;4329.328954012133;3682.1531047859144;3709.740318177756;3743.4384842273876;3753.9436908446396;3767.095896984704;4334.32817913224;4346.348047792856;4349.325854492558;4354;4356.455443069616;5064.164412871909;5066.645334826527;5092.949070509248;5097.643164978416;5101.668391554537;4256.638185754184;4312.159128969884;4362.367456718758;4367.519572846984;4375.431193944767;4630.3748993886065;4639.768011599406;4646.83736069236;4655.511171326962;4655.837045703384;4805.735684537314;4810.374651295309;4815.253635686474;4816.95183048179;4818.518148185223;4920.458749537476;4953.455119936732;4956.628252880976;5144.356955380577;5150.97424512875;4722.338872557913;4731.313959475926;4736.644751643572;4744.335792988915;4758.5241475852135;4961;4982.078315511642;4986.351774269322;4993.975030124971;5007.949920500749;4846.539578740014;4881.707097574015;4917.041176970456;5035.295058691713;5044.167712327425;4849.296851956376;4852.95147048525;4861.465238823797;4867.902641947212;4870.31815545831;4882.414110306786;4885.755712214446;4886.462489126122;4890.144224760582;4891.706497610155;4746.525347465364;4765.737884416251;4778.402699662543;4794.1130890783925;4801.255805350176;4980.775865086008;5002.099622068063;5011.599072074152;5012.774425150804;5023.246513023076;4896.314515967839;4896.608271338213;4898.314236007033;4901.09329773993;4905.2151655734915 17:46:06 INFO - PROCESS | 29762 | |1;ext.html;554.3015800091885;563.5547917145456;564.167852417684;564.7007086244289;576.7404667899445;28642.856785716067;29152.854235728846;31391.529127063113;31433.21416964577;38627.22745545088;38264.80867595665;42120.57879421205;42139.157216855645;42150.15699686012;42202.56873028326;7633.770986870389;7760.6895724171245;7771.727989520368;7774.766756997299;7777.5333479991095;7767.145613982458;7857.6856925722905;7862.646180921844;7863.488873223251;7864.68541258349;7765.339946104588;7777.572233527154;7798.8440231195345;7816.648250828698;7878.369730421553;7790.220977902193;7802.609869506558;7813.257740514642;7817;7827.960860195691;7665.8850117248285;7729;7729.420293478011;7731.884021739678;7760.844783104363;38375.232495349934;38638.613613864065;38688;38743.80628096841;38752.61247387518;2590.5855063189797;2592.662953815992;2627.4351014531776;2641.392479729673;3074.415860986428;29376.8531157345;29479.70520294791;29552.408951821057;29724.70275297241;29756.10731678053;3279.3234781485994;3395.439752440844;3458.5849698036145;3501.072215862798;3521.8239088045752;246817;247357;247952.76023619948;249524.2571361431;249688;51887;52115.739421303406;52165.47834521682;52184.47815521872;52285.73857130766;32437.675623243937;33094.863142107235;33298;35070;54944;12891.742165156644;13079.280639564726;13086.2802545859;13091.083624146218;13095.279759613313;9712.417254964725;9849.261305402124;9855.408675479493;9861.506924653739;9865.901340986498;17623.206955687026;17777.46667599974;17781.288748450177;17809.46571602854;17821.37625183138;6589.4069533742195;6617.4706023518;6760.83097922546;6782.423494003065;6810.62541560219;789.8657228271207;882.6601758322963;887.1527691055156;911.6535716427848;971.8396464583406;27488.17535473939;27731.810841753053;28055.298617534318;28223.858880705466;28893.42213155725;942.137943781446;956.6747305915883;998.3859926145514;1014.4978235773192;1042.3016578892161;13995.440182392591;14780.556583302518;14894.553163405115;15118.546443606709;15144.394224230908;367050;367837;369109;369333;370665;48338;48687.269690954665;48793;48985.26522102171;49039.50960490349;964.5804075227159;1037.8287582548946;1097.5280629329466;1165.469711281382;1166.3526742657737;27079.458410831277;28340.85829570839;28909.421811564072;29036.7096329034;29451.852740736158;41204.58795412008;41725;41761.58238417577;41782.58217417787;41850.79074604729;282904;283649;283713;283762;284334;20504.487387815425;24999.750002499743;25015.49969000646;26177.60733589036;26475.07337243187;34771.430706758874;35204;35455.290894182486;36094;36292.818535908205;35704.64295357013;35856.10359741027;36120.819395903905;36129.819350903075;36242.27515449729;35371;35556.82221588876;35589.64410355863;35680;35753.82123089472;31691;33037.83481082579;34270.48594271038;34796;35393;29869.402611948073;32577;32684.346313074082;32754.344913102083;32872.34255314928;24912.875435622707;25017;25340;25361;25736.8713156433 17:46:06 INFO - PROCESS | 29762 | |2;jquery.html;361.54084312922583;363.9763415378;364.69912322334073;380.87621523005;384.5097500686624;15867.285972131252;17048.23282952267;17734.73397899031;17919.82080179198;17932.55168620785;15578.844211557882;15671.529854104396;16261.918690406561;16369.263383147758;16374.508764737047;4769.976150119253;5011.774470148852;5024.145895197825;5025.3467049283545;5027.044861476326;3654.3239500692325;3838.961610383902;4892.168331383656;5638.689872057035;5875.177475153482;5979.103134529833;5988.8502787430225;5991.970040149815;5995.580309378323;5995.6102853314615;5769.82690519283;5961.195238642793;5970.641761494281;5986.5210783137245;5987.461128498456;5092.9236061459105;5252.737363131828;5260.2372655965055;5263.289455923478;5265.052290587692;19516.219351225933;20326;21291.467713307135;21713;21716.34850954474;1854.9536261593432;1870.7006878899447;1917.712343148525;1944;2341.988290058539;9006.549672516414;9047.864282035775;9118.726438206799;9191.540422978891;9478;1754.2369069454828;1792.2521705777758;1895.4787433455772;1904.5530877978006;1914.5979344337707;67183;68884;69588.3041169587;70038.64980675065;70929.64535177343;10149.086582207638;10176.592936282614;10241.795164096677;10464.21518386124;10542.52558634848;14045.578632641038;14129.538263125394;14143.787843182361;14174.716505670036;14176.716465670836;6632.801015969529;6794.524383293221;6829.760958366433;7060.576365418091;7062.329078737512;6285.214348206474;6311.495080393557;6496.545241833026;6503.837404064841;6505.024246363083;4386.298192289219;4413.117376524708;4418.094290670405;4443.933340999887;4546.181687296318;1568.7882135911507;1611.1138873619464;1630.7146249406308;1775.485109318309;1782.5098098023147;649.7177943320866;842.4566154830101;926.9953650231706;928.7213835849218;939.2908354192678;16024.679506409806;16396.590085247964;16599.585010374594;16913.154342282836;17884.55288617769;853.8249658819927;867.4708427859001;867.9651425198674;870.2907130688469;905.1310741687921;9633.566489507988;9636.518174091407;9858.704238872846;9870.111689947938;10118.645847395306;300143;303656;304947;383415.23894273915;399518;80307.19692803115;82502.58748706218;84202;84395;86503;874.6982291109557;939.6147579492375;943.9056094390643;977.94621295828;980.7057882635181;12151.453184606537;15867;15900.8409915904;16102.677946440772;16955.406560770312;27054.917803287648;29060;35222.64777352194;35230;36570.8171459141;47262;48141.5185848151;48702;49944.50055499398;49947.50052499574;7557.811054723676;7688.615569221628;7801.102873169658;7889.2110788920645;7938.24586664266;8407.033191182847;9161.450312981242;10432.321899076536;11511.884881151082;12449;9415.05849415053;9490.620375184915;9704.2721795867;9725.124738773544;9929.304948653813;9755.463449510346;10027.298089133983;10175.338602990782;10330.380177189392;10557.841632375674;9379.531023448937;9451.763705907133;9840.55717492729;10333.47688134499;10470;7442.776716698508;7481.289277518627;7544.886826697494;7547.433942454228;7633.274838890296;9465.858012129685;9568.234541236545;9753.804923901624;10015.749606259902;10202.380125259207 17:46:06 INFO - PROCESS | 29762 | |3;mootools.html;1125.2123513540523;1126.5155982927342;1279.9248631149833;1340.8860246879015;1340.9128406653567;6680.966595167018;6952.721891124349;7456.440766942481;8056.516609003456;8056.91943080569;7214.891776623342;7425.294597013275;7427.665755041023;7540.698372065124;7548.849023019537;2177.673348997655;2201.6257236269794;2211.3255457085584;2211.447138215446;2212.61279276126;1836.7795864496213;2098.7691353951054;2126.138913739938;2163.080690706451;2175.869447833135;2135.1032566322106;2159.85960912541;2162.1783722185546;2163.0374483354913;2170.468235282358;2096.4444422228044;2105.4525823285903;2135.3593921823544;2138.4760733620205;2144.1423430627874;2055.8663686860305;2063.6388631989494;2073.7304150460495;2078.7297651305385;2114.3762590035976;7862.764117076496;7963.402744794105;8001.679932802681;8021.438499305051;8030.718924837603;4347.956520434786;4486.349479325512;4489.281714925596;4491.640668746525;4500.504944456107;2816.225537977052;2934.339773550955;2977.032464449063;2982.910512684623;3017.8792848286043;882.3955590420583;925.3013974449315;938.7887725261829;944.0606596436521;954.608610469711;10880.782384352347;10905.454727263605;10908;10915.836262456069;10918.563257469692;3741.5323084614424;3992.782201428592;4229.471316085489;4237.406763053175;4274.615284624399;9434.575444104894;9439.150476457151;9447.669331573363;9448.527573621428;9451.102145296185;4422.823087076481;4428.756418397019;4435.82256709728;4442.3336499524685;4442.42248507692;4005.1589166274825;4010;4010.2781499329817;4012.378081397388;4013.337799263147;3311.453610154346;3416.6241713411505;3453.9827300863335;3490.3193877194212;3492.4586689063235;966.9758256043515;1025.876894772632;1035.9585616575253;1046.8900765419673;1052.5633159236343;718.2314923032305;732.6263605561202;751.8721817291074;759.5822297736223;766.6588368176108;5128.666636668605;5175.9741201293755;5243.239730239094;5257.447967963385;5459.235707001023;824.9463784853965;843.2663582683105;878.6485405837716;895.1093661806544;895.6917228132703;3468.3583537045224;3518.138056176253;3540.963945731215;3660.286244182359;3778.6221377862544;9928.106470417553;9954.402735835873;10045.69862904114;10074.294799364121;10081.49592520371;9695.757606059906;9768.169705574963;9952.054554817281;10032.498375081217;10032.899671003197;7350.2649735027135;7537.321641052332;7551.433642476836;7554.546727196386;7558.962205189049;5348.304720386325;5356.196570514454;5398.1902714593125;5456.645318054314;5528.811305569322;8926.86609700868;9041.18629323364;9068.138526839939;9087.454752714859;9158.67944621935;8657.696980605648;8803.295736341206;9200.493972831558;9300.953495232481;9350.672726454814;6542.8364290893105;6725.8991115134295;6727.327267273234;6727.629980351127;6729.495287853529;7395.482316237812;7404.407647388303;7425.851482970203;7452.254774522505;7511.737089201852;4923.778429970732;6612.570182938093;6646.202455705346;6670.499712521483;6877.518573699993;6358;6446.871062578628;6492.156019717407;6494.512911531559;6559;6038.094285857156;6175.073738939195;6220.782272620437;6224.190855188796;6235.781747638811;4479.776011199492;4594.150082234797;4690.882727931693;4723.110755697749;4778.880527986828;4418.4918734345965;4419.823207071681;4511.684182107221;4567.1779079765965;4591.403117594691 17:46:06 INFO - PROCESS | 29762 | |4;prototype.html;296.0718148604127;297.1101550855189;305.856247563645;306.7791190342953;307.8183871515805;4756.714597124171;4767.7341021400325;4773.474917759044;4782.904341913159;4786.7606619669;4704.294355846625;4727.858164255069;4727.90544189116;4740.90518189636;4744.786484608192;3580.4987301777774;3685.373486507287;3718.3307004739136;3754.8685795997144;3772.226693527834;3770.189409277005;3775.18833450808;3792.886213413602;3798.9240215195678;3803.239352129571;3746.700263978889;3751.5873253942045;3754.718396120288;3759.586445490994;3771.3400154972906;3519.524864143359;3581.409067503872;3627.2382799612114;3704.6110158433244;3767.886963391089;3288.6053673559086;3292.720118789882;3304.96695033049;3307.9173020674434;3315.602127744686;4594.908101837945;4606.838760643362;4608.470025946992;4618.907621847544;4647.163510568096;4153.190127925056;4247.341662042389;4288.635465985364;4298.720583162116;4303.591158839905;4878.389921524161;4910.803567857317;4921.056182807807;4921.704697718148;4926.881440980377;3598.1904071583685;3601.6398360164035;3607.134287770916;3614.114541937216;3622.492851000862;5092.532741972355;5171.586273098181;5187.351581052369;5209.7134657593815;5248.134057880445;3599.370110230699;3680.2639472105684;3698.7965661888857;3710.276496083238;3711.777293362407;3774.2640185164178;3775.622437756257;3777.433384992218;3788.507494025759;3805.296020236265;4256.87229383119;4266.719984004786;4267;4268.16770729711;4272.722273052242;4637.559431854036;4900.583450406684;4940.481249468826;4956.702597844141;4956.909479914413;1259.6976725585976;1276.7765641012786;1277.2464246094848;1278.6611547939804;1279.6736832107754;796.6454927557181;814.5682788122305;826.7561069484517;826.9710560130367;832.76682528892;3965.940510892339;3968.1548080142293;4182.728122672017;4263.486462305898;4370.431843860341;5089.3638295213095;5097.362829646294;5098.286239926413;5117.820876269313;5119.462456442095;4398.142362239332;4411.139827733626;4412.889677758082;4420.237351655215;4426.734395936254;2594.987025064863;2695.595660650918;2695.865206739655;2696.8516731579557;2721.6597925259343;4796.160671882407;4801.18379875415;4820.517948205152;4827.300041494034;4830.227163653799;5174.611904107207;5187;5217.608679349064;5220;5221.034108689829;4559;4765.4996225395835;4828.589569886599;4837.637177211724;4838.612910967114;5096.923546146737;5128.512791284822;5131.589472842089;5132.8460146195675;5147.79026928664;4990.276409920614;5020.87447813793;5027.497250274943;5040.395152581714;5042.495750424928;4596.793144308447;4796.352492413619;4832.323474713613;4841.201201801804;4863.489333619919;3720.6093360197874;3731.5149030625844;3732.64539868712;3733.8319775610707;3742.419924911643;5128.512671354316;5136;5144.459831717765;5148.510891465305;5152.587792976478;4733.650909490779;4907.730074845917;4947.529984651453;4964.386574363274;5007.7746501408255;4904.8773780655765;4972.975135124301;4975.253711943093;4979;4989.725565093955;4912.48418916023;4918.336024636628;4926.901461970812;4927.581155601814;4939.209726443752;4721.22099853534;4879.292502587034;4955.2567114933045;4976.855323275595;5032.974835125801;4799.9760001199775;4852.902941941212;4867.95132048675;4869.488703686062;4875.390576177978 17:46:06 INFO - PROCESS | 29762 | |5;yui.html;528.3395755305868;566.3006187358611;570.3469527391137;579.4813641790597;618.8638499530108;11162.386068766225;11843.348615826126;12437.067219958517;12442.19125756825;12446.133080037998;11989.880101198985;12002.339871307075;12018.399080046007;12019.579314723986;12024;612.301975747648;736.4844608773853;750.0436942897794;750.302218936389;750.4671683105003;719.9352058314751;720.0639169080201;727.938125259351;756.1719916691214;757.2843662738715;791.3155120820478;797.178905727102;797.2466019611469;798.022422532396;798.1061211443192;629.4555209743539;788.9723859664913;791.1929831571764;791.7783020754198;793.4366599714181;547.9780808767645;548.5173047718023;558.0596694569663;575.9308882934033;580.1413907417046;11415;11439.656810295704;11441.141914356373;11443.771124577463;11467.77064458706;12021.278723276631;12135.332556709378;12303.384830758516;12751.234925904475;13614.727705445935;11954;11960.222585531912;12252.81620775689;12308.753824923451;12933;4178.289690752549;4191.077962848199;4204.362436124309;4441.222786012435;4452.955470445287;68768;70430.64784676096;70510;70579.29420705778;70705.64647176783;10257.58969641206;10417.531211095518;10429.165666746641;10521.84217236742;10872.347659140476;18393.080345982646;18441.354552590594;18613.627727445375;18723;18723.157457914425;6479.773207937699;6507.219133703986;6572.572782769104;6675.232348279913;6864.279250678607;3671.4492826076303;3795.891107367489;3833.290841194388;3875.147467557133;3896.883093507143;2797.9300517487227;2900.7099290070823;2903.129061281607;2917.2560996945645;2919.5328747400313;506.73396466855195;510.8441925212846;515.9355080614923;516.8811173430132;528.0626887275117;492.66498780828664;512.5566385076881;514.1157209599482;526.2658591265164;527.2434057128033;7997;8094.433389662667;8160.224778646019;8186.304164145995;8296;448.0747256914526;479.0419161676647;497.6367251906129;536.87651840077;550.7356468894953;3645.744797864177;3875.069983204011;3921.274564205631;4162.895927601834;4201.495820501498;52609.210861837106;52884;53580.46419535833;53725;54125.72937135289;76271;77942;78337;79073.62779116636;82600;42477.57522424798;42550.57449425466;64192.35807641957;68364.65817671079;68412.99999999901;7170.784876453715;7498.775036748906;7541.135504311516;7646.273604007611;7718.382529397747;37302.44046339253;37430.43854342242;43408.565914341714;43758;44350.33474497821;56473.71763141158;57669;59357.70321148367;60229.698851507215;60567.69716151567;11292.661220163409;11588.273356228956;11624.476898539417;11806;11949.088145896614;13033.608991730263;13151.671208219872;13496.392662330023;13904.374303156585;14082.155070695791;10845.924453280319;11389.145814064144;11693.490319152526;11928.284302941851;11967.461464233957;11492.195546311677;11915.463804128662;11930.582429614922;12476.376181191086;12478.5008599655;11352.829707554558;11666.941665291619;11749.941250294036;12355.75288494243;12356.505739770308;9402.106799854002;9742.220622350053;9811.362261452983;10101.49492525356;10279.17766578657;9844.114029737359;10126.797464050826;10127.392356458637;10183.13443357323;10253.769547654329 17:46:06 INFO - PROCESS | 29762 | __end_tp_report 17:46:06 INFO - PROCESS | 29762 | __start_cc_report 17:46:06 INFO - PROCESS | 29762 | _x_x_mozilla_cycle_collect,885 17:46:06 INFO - PROCESS | 29762 | __end_cc_report 17:46:06 INFO - PROCESS | 29762 | __startTimestamp1471913166217__endTimestamp 17:46:06 INFO - PROCESS | 29762 | 17:46:06 INFO - PROCESS | 29762 | ------- Summary: start ------- 17:46:06 INFO - PROCESS | 29762 | Number of tests: 6 17:46:06 INFO - PROCESS | 29762 | 17:46:06 INFO - PROCESS | 29762 | [#0] dojo.html Cycles:165 Average:4671.12 Median:4801.26 stddev:494.35 (10.3%) stddev-sans-first:467.31 17:46:06 INFO - PROCESS | 29762 | Values: 2560.2 2607.8 2608.3 2616.0 2630.2 4579.7 4581.4 4609.2 4693.7 4705.0 4640.9 4692.1 4700.5 4713.7 4751.1 4339.6 4348.8 4413.7 4431.5 4459.3 4407.8 4446.5 4453.1 4454.7 4455.3 4183.5 4218.6 4243.3 4321.1 4330.0 4285.6 4287.2 4295.3 4306.9 4313.8 4347.1 4353.2 4363.8 4364.5 4365.8 4698.2 4769.3 4771.8 4774.4 4779.5 4898.9 4998.3 5035.4 5035.7 5108.6 5118.1 5128.1 5131.6 5136.0 5138.3 4771.5 4784.1 4785.0 4803.8 4808.1 5010.0 5175.6 5181.8 5215.6 5237.2 5035.8 5070.5 5073.6 5076.1 5079.2 5150.5 5154.9 5158.8 5162.8 5166.1 4855.8 4888.8 4957.6 5081.5 5087.2 4971.7 4986.6 4988.4 4989.5 4995.6 4319.6 4320.0 4321.3 4323.2 4329.3 3682.2 3709.7 3743.4 3753.9 3767.1 4334.3 4346.3 4349.3 4354.0 4356.5 5064.2 5066.6 5092.9 5097.6 5101.7 4256.6 4312.2 4362.4 4367.5 4375.4 4630.4 4639.8 4646.8 4655.5 4655.8 4805.7 4810.4 4815.3 4817.0 4818.5 4920.5 4953.5 4956.6 5144.4 5151.0 4722.3 4731.3 4736.6 4744.3 4758.5 4961.0 4982.1 4986.4 4994.0 5007.9 4846.5 4881.7 4917.0 5035.3 5044.2 4849.3 4853.0 4861.5 4867.9 4870.3 4882.4 4885.8 4886.5 4890.1 4891.7 4746.5 4765.7 4778.4 4794.1 4801.3 4980.8 5002.1 5011.6 5012.8 5023.2 4896.3 4896.6 4898.3 4901.1 4905.2 17:46:06 INFO - PROCESS | 29762 | 17:46:06 INFO - PROCESS | 29762 | [#1] ext.html Cycles:180 Average:44804.15 Median:35692.32 stddev:80037.63 (224.2%) stddev-sans-first:80193.20 17:46:06 INFO - PROCESS | 29762 | Values: 554.3 563.6 564.2 564.7 576.7 28642.9 29152.9 31391.5 31433.2 38627.2 38264.8 42120.6 42139.2 42150.2 42202.6 7633.8 7760.7 7771.7 7774.8 7777.5 7767.1 7857.7 7862.6 7863.5 7864.7 7765.3 7777.6 7798.8 7816.6 7878.4 7790.2 7802.6 7813.3 7817.0 7828.0 7665.9 7729.0 7729.4 7731.9 7760.8 38375.2 38638.6 38688.0 38743.8 38752.6 2590.6 2592.7 2627.4 2641.4 3074.4 29376.9 29479.7 29552.4 29724.7 29756.1 3279.3 3395.4 3458.6 3501.1 3521.8 246817.0 247357.0 247952.8 249524.3 249688.0 51887.0 52115.7 52165.5 52184.5 52285.7 32437.7 33094.9 33298.0 35070.0 54944.0 12891.7 13079.3 13086.3 13091.1 13095.3 9712.4 9849.3 9855.4 9861.5 9865.9 17623.2 17777.5 17781.3 17809.5 17821.4 6589.4 6617.5 6760.8 6782.4 6810.6 789.9 882.7 887.2 911.7 971.8 27488.2 27731.8 28055.3 28223.9 28893.4 942.1 956.7 998.4 1014.5 1042.3 13995.4 14780.6 14894.6 15118.5 15144.4 367050.0 367837.0 369109.0 369333.0 370665.0 48338.0 48687.3 48793.0 48985.3 49039.5 964.6 1037.8 1097.5 1165.5 1166.4 27079.5 28340.9 28909.4 29036.7 29451.9 41204.6 41725.0 41761.6 41782.6 41850.8 282904.0 283649.0 283713.0 283762.0 284334.0 20504.5 24999.8 25015.5 26177.6 26475.1 34771.4 35204.0 35455.3 36094.0 36292.8 35704.6 35856.1 36120.8 36129.8 36242.3 35371.0 35556.8 35589.6 35680.0 35753.8 31691.0 33037.8 34270.5 34796.0 35393.0 29869.4 32577.0 32684.3 32754.3 32872.3 24912.9 25017.0 25340.0 25361.0 25736.9 17:46:06 INFO - PROCESS | 29762 | 17:46:06 INFO - PROCESS | 29762 | [#2] jquery.html Cycles:180 Average:22804.12 Median:27479.64 stddev:56876.28 (207.0%) stddev-sans-first:57010.87 17:46:06 INFO - PROCESS | 29762 | Values: 361.5 364.0 364.7 380.9 384.5 15867.3 17048.2 17734.7 17919.8 17932.6 15578.8 15671.5 16261.9 16369.3 16374.5 4770.0 5011.8 5024.1 5025.3 5027.0 3654.3 3839.0 4892.2 5638.7 5875.2 5979.1 5988.9 5992.0 5995.6 5995.6 5769.8 5961.2 5970.6 5986.5 5987.5 5092.9 5252.7 5260.2 5263.3 5265.1 19516.2 20326.0 21291.5 21713.0 21716.3 1855.0 1870.7 1917.7 1944.0 2342.0 9006.5 9047.9 9118.7 9191.5 9478.0 1754.2 1792.3 1895.5 1904.6 1914.6 67183.0 68884.0 69588.3 70038.6 70929.6 10149.1 10176.6 10241.8 10464.2 10542.5 14045.6 14129.5 14143.8 14174.7 14176.7 6632.8 6794.5 6829.8 7060.6 7062.3 6285.2 6311.5 6496.5 6503.8 6505.0 4386.3 4413.1 4418.1 4443.9 4546.2 1568.8 1611.1 1630.7 1775.5 1782.5 649.7 842.5 927.0 928.7 939.3 16024.7 16396.6 16599.6 16913.2 17884.6 853.8 867.5 868.0 870.3 905.1 9633.6 9636.5 9858.7 9870.1 10118.6 300143.0 303656.0 304947.0 383415.2 399518.0 80307.2 82502.6 84202.0 84395.0 86503.0 874.7 939.6 943.9 977.9 980.7 12151.5 15867.0 15900.8 16102.7 16955.4 27054.9 29060.0 35222.6 35230.0 36570.8 47262.0 48141.5 48702.0 49944.5 49947.5 7557.8 7688.6 7801.1 7889.2 7938.2 8407.0 9161.5 10432.3 11511.9 12449.0 9415.1 9490.6 9704.3 9725.1 9929.3 9755.5 10027.3 10175.3 10330.4 10557.8 9379.5 9451.8 9840.6 10333.5 10470.0 7442.8 7481.3 7544.9 7547.4 7633.3 9465.9 9568.2 9753.8 10015.7 10202.4 17:46:06 INFO - PROCESS | 29762 | 17:46:06 INFO - PROCESS | 29762 | [#3] mootools.html Cycles:180 Average:5114.39 Median:5152.32 stddev:2957.46 (57.4%) stddev-sans-first:2950.56 17:46:06 INFO - PROCESS | 29762 | Values: 1125.2 1126.5 1279.9 1340.9 1340.9 6681.0 6952.7 7456.4 8056.5 8056.9 7214.9 7425.3 7427.7 7540.7 7548.8 2177.7 2201.6 2211.3 2211.4 2212.6 1836.8 2098.8 2126.1 2163.1 2175.9 2135.1 2159.9 2162.2 2163.0 2170.5 2096.4 2105.5 2135.4 2138.5 2144.1 2055.9 2063.6 2073.7 2078.7 2114.4 7862.8 7963.4 8001.7 8021.4 8030.7 4348.0 4486.3 4489.3 4491.6 4500.5 2816.2 2934.3 2977.0 2982.9 3017.9 882.4 925.3 938.8 944.1 954.6 10880.8 10905.5 10908.0 10915.8 10918.6 3741.5 3992.8 4229.5 4237.4 4274.6 9434.6 9439.2 9447.7 9448.5 9451.1 4422.8 4428.8 4435.8 4442.3 4442.4 4005.2 4010.0 4010.3 4012.4 4013.3 3311.5 3416.6 3454.0 3490.3 3492.5 967.0 1025.9 1036.0 1046.9 1052.6 718.2 732.6 751.9 759.6 766.7 5128.7 5176.0 5243.2 5257.4 5459.2 824.9 843.3 878.6 895.1 895.7 3468.4 3518.1 3541.0 3660.3 3778.6 9928.1 9954.4 10045.7 10074.3 10081.5 9695.8 9768.2 9952.1 10032.5 10032.9 7350.3 7537.3 7551.4 7554.5 7559.0 5348.3 5356.2 5398.2 5456.6 5528.8 8926.9 9041.2 9068.1 9087.5 9158.7 8657.7 8803.3 9200.5 9301.0 9350.7 6542.8 6725.9 6727.3 6727.6 6729.5 7395.5 7404.4 7425.9 7452.3 7511.7 4923.8 6612.6 6646.2 6670.5 6877.5 6358.0 6446.9 6492.2 6494.5 6559.0 6038.1 6175.1 6220.8 6224.2 6235.8 4479.8 4594.2 4690.9 4723.1 4778.9 4418.5 4419.8 4511.7 4567.2 4591.4 17:46:06 INFO - PROCESS | 29762 | 17:46:06 INFO - PROCESS | 29762 | [#4] prototype.html Cycles:180 Average:4132.99 Median:4727.88 stddev:1191.12 (25.2%) stddev-sans-first:1159.12 17:46:06 INFO - PROCESS | 29762 | Values: 296.1 297.1 305.9 306.8 307.8 4756.7 4767.7 4773.5 4782.9 4786.8 4704.3 4727.9 4727.9 4740.9 4744.8 3580.5 3685.4 3718.3 3754.9 3772.2 3770.2 3775.2 3792.9 3798.9 3803.2 3746.7 3751.6 3754.7 3759.6 3771.3 3519.5 3581.4 3627.2 3704.6 3767.9 3288.6 3292.7 3305.0 3307.9 3315.6 4594.9 4606.8 4608.5 4618.9 4647.2 4153.2 4247.3 4288.6 4298.7 4303.6 4878.4 4910.8 4921.1 4921.7 4926.9 3598.2 3601.6 3607.1 3614.1 3622.5 5092.5 5171.6 5187.4 5209.7 5248.1 3599.4 3680.3 3698.8 3710.3 3711.8 3774.3 3775.6 3777.4 3788.5 3805.3 4256.9 4266.7 4267.0 4268.2 4272.7 4637.6 4900.6 4940.5 4956.7 4956.9 1259.7 1276.8 1277.2 1278.7 1279.7 796.6 814.6 826.8 827.0 832.8 3965.9 3968.2 4182.7 4263.5 4370.4 5089.4 5097.4 5098.3 5117.8 5119.5 4398.1 4411.1 4412.9 4420.2 4426.7 2595.0 2695.6 2695.9 2696.9 2721.7 4796.2 4801.2 4820.5 4827.3 4830.2 5174.6 5187.0 5217.6 5220.0 5221.0 4559.0 4765.5 4828.6 4837.6 4838.6 5096.9 5128.5 5131.6 5132.8 5147.8 4990.3 5020.9 5027.5 5040.4 5042.5 4596.8 4796.4 4832.3 4841.2 4863.5 3720.6 3731.5 3732.6 3733.8 3742.4 5128.5 5136.0 5144.5 5148.5 5152.6 4733.7 4907.7 4947.5 4964.4 5007.8 4904.9 4973.0 4975.3 4979.0 4989.7 4912.5 4918.3 4926.9 4927.6 4939.2 4721.2 4879.3 4955.3 4976.9 5033.0 4800.0 4852.9 4868.0 4869.5 4875.4 17:46:06 INFO - PROCESS | 29762 | 17:46:06 INFO - PROCESS | 29762 | [#5] yui.html Cycles:180 Average:15910.54 Median:24395.78 stddev:21031.98 (86.2%) stddev-sans-first:21059.26 17:46:06 INFO - PROCESS | 29762 | Values: 528.3 566.3 570.3 579.5 618.9 11162.4 11843.3 12437.1 12442.2 12446.1 11989.9 12002.3 12018.4 12019.6 12024.0 612.3 736.5 750.0 750.3 750.5 719.9 720.1 727.9 756.2 757.3 791.3 797.2 797.2 798.0 798.1 629.5 789.0 791.2 791.8 793.4 548.0 548.5 558.1 575.9 580.1 11415.0 11439.7 11441.1 11443.8 11467.8 12021.3 12135.3 12303.4 12751.2 13614.7 11954.0 11960.2 12252.8 12308.8 12933.0 4178.3 4191.1 4204.4 4441.2 4453.0 68768.0 70430.6 70510.0 70579.3 70705.6 10257.6 10417.5 10429.2 10521.8 10872.3 18393.1 18441.4 18613.6 18723.0 18723.2 6479.8 6507.2 6572.6 6675.2 6864.3 3671.4 3795.9 3833.3 3875.1 3896.9 2797.9 2900.7 2903.1 2917.3 2919.5 506.7 510.8 515.9 516.9 528.1 492.7 512.6 514.1 526.3 527.2 7997.0 8094.4 8160.2 8186.3 8296.0 448.1 479.0 497.6 536.9 550.7 3645.7 3875.1 3921.3 4162.9 4201.5 52609.2 52884.0 53580.5 53725.0 54125.7 76271.0 77942.0 78337.0 79073.6 82600.0 42477.6 42550.6 64192.4 68364.7 68413.0 7170.8 7498.8 7541.1 7646.3 7718.4 37302.4 37430.4 43408.6 43758.0 44350.3 56473.7 57669.0 59357.7 60229.7 60567.7 11292.7 11588.3 11624.5 11806.0 11949.1 13033.6 13151.7 13496.4 13904.4 14082.2 10845.9 11389.1 11693.5 11928.3 11967.5 11492.2 11915.5 11930.6 12476.4 12478.5 11352.8 11666.9 11749.9 12355.8 12356.5 9402.1 9742.2 9811.4 10101.5 10279.2 9844.1 10126.8 10127.4 10183.1 10253.8 17:46:06 INFO - PROCESS | 29762 | -------- Summary: end -------- 17:46:06 INFO - PROCESS | 29762 | 17:46:07 INFO - TEST-INFO | 29762: exit 0 17:46:07 INFO - TEST-OK | dromaeo_css | took 1121024ms 17:46:07 INFO - TEST-START | kraken 17:46:07 INFO - operating with platform_type : linux_ 17:46:07 INFO - Initialising browser for kraken test... 17:46:07 INFO - TEST-INFO | started process 30068 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRitHI3/profile http://localhost:51714/getInfo.html) 17:46:11 INFO - PROCESS | 30068 | __metrics Screen width/height:1600/1200 17:46:11 INFO - PROCESS | 30068 | colorDepth:24 17:46:11 INFO - PROCESS | 30068 | Browser inner width/height: 1024/697 17:46:11 INFO - PROCESS | 30068 | __metrics 17:46:12 INFO - PROCESS | 30068 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:46:12 INFO - PROCESS | 30068 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:46:12 INFO - PROCESS | 30068 | console.error: PushService: 17:46:12 INFO - PROCESS | 30068 | stateChangeProcessEnqueue: Error transitioning state 17:46:12 INFO - PROCESS | 30068 | UnknownError 17:46:13 INFO - TEST-INFO | 30068: exit 0 17:46:13 INFO - Browser initialized. 17:46:13 INFO - Running cycle 1/1 for kraken test... 17:46:13 INFO - TEST-INFO | started process 30148 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRitHI3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:46:25 INFO - PROCESS | 30148 | RSS: Main: 175624192 17:46:25 INFO - PROCESS | 30148 | 17:46:28 INFO - PROCESS | 30148 | Cycle 1(1): loaded http://localhost:51714/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51714/tests/kraken/driver.html?testName=audio-beat-detection) 17:46:29 INFO - PROCESS | 30148 | RSS: Main: 244215808 17:46:29 INFO - PROCESS | 30148 | 17:46:32 INFO - PROCESS | 30148 | Cycle 1(1): loaded http://localhost:51714/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51714/tests/kraken/driver.html?testName=audio-dft) 17:46:32 INFO - PROCESS | 30148 | RSS: Main: 226930688 17:46:32 INFO - PROCESS | 30148 | 17:46:36 INFO - PROCESS | 30148 | Cycle 1(1): loaded http://localhost:51714/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51714/tests/kraken/driver.html?testName=audio-fft) 17:46:36 INFO - PROCESS | 30148 | RSS: Main: 302530560 17:46:36 INFO - PROCESS | 30148 | 17:46:39 INFO - PROCESS | 30148 | Cycle 1(1): loaded http://localhost:51714/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51714/tests/kraken/driver.html?testName=audio-oscillator) 17:46:39 INFO - PROCESS | 30148 | RSS: Main: 210698240 17:46:39 INFO - PROCESS | 30148 | 17:46:42 INFO - PROCESS | 30148 | Cycle 1(1): loaded http://localhost:51714/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51714/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:46:42 INFO - PROCESS | 30148 | RSS: Main: 214097920 17:46:42 INFO - PROCESS | 30148 | 17:46:45 INFO - PROCESS | 30148 | Cycle 1(1): loaded http://localhost:51714/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51714/tests/kraken/driver.html?testName=imaging-darkroom) 17:46:46 INFO - PROCESS | 30148 | RSS: Main: 251248640 17:46:46 INFO - PROCESS | 30148 | 17:46:50 INFO - PROCESS | 30148 | Cycle 1(1): loaded http://localhost:51714/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51714/tests/kraken/driver.html?testName=imaging-desaturate) 17:46:50 INFO - PROCESS | 30148 | RSS: Main: 243863552 17:46:50 INFO - PROCESS | 30148 | 17:46:53 INFO - PROCESS | 30148 | Cycle 1(1): loaded http://localhost:51714/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51714/tests/kraken/driver.html?testName=json-parse-financial) 17:46:54 INFO - PROCESS | 30148 | RSS: Main: 247607296 17:46:54 INFO - PROCESS | 30148 | 17:46:55 INFO - PROCESS | 30148 | Cycle 1(1): loaded http://localhost:51714/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51714/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:46:56 INFO - PROCESS | 30148 | RSS: Main: 211218432 17:46:56 INFO - PROCESS | 30148 | 17:46:58 INFO - PROCESS | 30148 | Cycle 1(1): loaded http://localhost:51714/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51714/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:46:59 INFO - PROCESS | 30148 | RSS: Main: 218357760 17:46:59 INFO - PROCESS | 30148 | 17:47:01 INFO - PROCESS | 30148 | Cycle 1(1): loaded http://localhost:51714/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51714/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:47:02 INFO - PROCESS | 30148 | RSS: Main: 223793152 17:47:02 INFO - PROCESS | 30148 | 17:47:04 INFO - PROCESS | 30148 | Cycle 1(1): loaded http://localhost:51714/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51714/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:47:05 INFO - PROCESS | 30148 | RSS: Main: 218730496 17:47:05 INFO - PROCESS | 30148 | 17:47:08 INFO - PROCESS | 30148 | Cycle 1(1): loaded http://localhost:51714/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51714/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:47:09 INFO - PROCESS | 30148 | RSS: Main: 221351936 17:47:09 INFO - PROCESS | 30148 | 17:47:10 INFO - PROCESS | 30148 | Cycle 1(1): loaded http://localhost:51714/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51714/tests/kraken/driver.html?testName=ai-astar) 17:47:11 INFO - PROCESS | 30148 | RSS: Main: 272936960 17:47:11 INFO - PROCESS | 30148 | 17:47:11 INFO - PROCESS | 30148 | __start_tp_report 17:47:11 INFO - PROCESS | 30148 | _x_x_mozilla_page_load 17:47:11 INFO - PROCESS | 30148 | _x_x_mozilla_page_load_details 17:47:11 INFO - PROCESS | 30148 | |i|pagename|runs| 17:47:11 INFO - PROCESS | 30148 | |0;ai-astar;102;114;111;114;115;114;120;115;113;113 17:47:11 INFO - PROCESS | 30148 | |1;audio-beat-detection;144;122;153;183;128;147;144;124;184;121 17:47:11 INFO - PROCESS | 30148 | |2;audio-dft;162;163;163;161;161;161;161;162;161;161 17:47:11 INFO - PROCESS | 30148 | |3;audio-fft;77;76;75;166;76;76;76;128;119;76 17:47:11 INFO - PROCESS | 30148 | |4;audio-oscillator;87;87;155;86;86;86;134;86;86;140 17:47:11 INFO - PROCESS | 30148 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;116;117;117 17:47:11 INFO - PROCESS | 30148 | |6;imaging-darkroom;148;147;147;146;147;147;147;147;147;147 17:47:11 INFO - PROCESS | 30148 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 17:47:11 INFO - PROCESS | 30148 | |8;json-parse-financial;63;65;67;66;65;66;65;65;66;65 17:47:11 INFO - PROCESS | 30148 | |9;json-stringify-tinderbox;68;66;66;68;67;67;66;67;67;68 17:47:11 INFO - PROCESS | 30148 | |10;stanford-crypto-aes;82;83;84;82;83;82;82;83;81;83 17:47:11 INFO - PROCESS | 30148 | |11;stanford-crypto-ccm;135;133;133;134;135;132;134;142;149;146 17:47:11 INFO - PROCESS | 30148 | |12;stanford-crypto-pbkdf2;171;172;170;169;170;169;175;174;172;171 17:47:11 INFO - PROCESS | 30148 | |13;stanford-crypto-sha256-iterative;69;68;69;69;67;75;68;72;67;68 17:47:11 INFO - PROCESS | 30148 | __end_tp_report 17:47:11 INFO - PROCESS | 30148 | __start_cc_report 17:47:11 INFO - PROCESS | 30148 | _x_x_mozilla_cycle_collect,1992 17:47:11 INFO - PROCESS | 30148 | __end_cc_report 17:47:11 INFO - PROCESS | 30148 | __startTimestamp1471913231121__endTimestamp 17:47:11 INFO - PROCESS | 30148 | 17:47:11 INFO - PROCESS | 30148 | ------- Summary: start ------- 17:47:11 INFO - PROCESS | 30148 | Number of tests: 14 17:47:11 INFO - PROCESS | 30148 | 17:47:11 INFO - PROCESS | 30148 | [#0] ai-astar Cycles:10 Average:113.10 Median:114.00 stddev:4.53 (4.0%) stddev-sans-first:2.45 17:47:11 INFO - PROCESS | 30148 | Values: 102.0 114.0 111.0 114.0 115.0 114.0 120.0 115.0 113.0 113.0 17:47:11 INFO - PROCESS | 30148 | 17:47:11 INFO - PROCESS | 30148 | [#1] audio-beat-detection Cycles:10 Average:145.00 Median:145.50 stddev:23.26 (16.0%) stddev-sans-first:24.67 17:47:11 INFO - PROCESS | 30148 | Values: 144.0 122.0 153.0 183.0 128.0 147.0 144.0 124.0 184.0 121.0 17:47:11 INFO - PROCESS | 30148 | 17:47:11 INFO - PROCESS | 30148 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:0.84 (0.5%) stddev-sans-first:0.88 17:47:11 INFO - PROCESS | 30148 | Values: 162.0 163.0 163.0 161.0 161.0 161.0 161.0 162.0 161.0 161.0 17:47:11 INFO - PROCESS | 30148 | 17:47:11 INFO - PROCESS | 30148 | [#3] audio-fft Cycles:10 Average:94.50 Median:76.00 stddev:32.03 (42.1%) stddev-sans-first:33.34 17:47:11 INFO - PROCESS | 30148 | Values: 77.0 76.0 75.0 166.0 76.0 76.0 76.0 128.0 119.0 76.0 17:47:11 INFO - PROCESS | 30148 | 17:47:11 INFO - PROCESS | 30148 | [#4] audio-oscillator Cycles:10 Average:103.30 Median:86.00 stddev:27.87 (32.4%) stddev-sans-first:28.93 17:47:11 INFO - PROCESS | 30148 | Values: 87.0 87.0 155.0 86.0 86.0 86.0 134.0 86.0 86.0 140.0 17:47:11 INFO - PROCESS | 30148 | 17:47:11 INFO - PROCESS | 30148 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 17:47:11 INFO - PROCESS | 30148 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 17:47:11 INFO - PROCESS | 30148 | 17:47:11 INFO - PROCESS | 30148 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.47 (0.3%) stddev-sans-first:0.33 17:47:11 INFO - PROCESS | 30148 | Values: 148.0 147.0 147.0 146.0 147.0 147.0 147.0 147.0 147.0 147.0 17:47:11 INFO - PROCESS | 30148 | 17:47:11 INFO - PROCESS | 30148 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 17:47:11 INFO - PROCESS | 30148 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 17:47:11 INFO - PROCESS | 30148 | 17:47:11 INFO - PROCESS | 30148 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:65.50 stddev:1.06 (1.6%) stddev-sans-first:0.73 17:47:11 INFO - PROCESS | 30148 | Values: 63.0 65.0 67.0 66.0 65.0 66.0 65.0 65.0 66.0 65.0 17:47:11 INFO - PROCESS | 30148 | 17:47:11 INFO - PROCESS | 30148 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 17:47:11 INFO - PROCESS | 30148 | Values: 68.0 66.0 66.0 68.0 67.0 67.0 66.0 67.0 67.0 68.0 17:47:11 INFO - PROCESS | 30148 | 17:47:11 INFO - PROCESS | 30148 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:83.00 stddev:0.85 (1.0%) stddev-sans-first:0.88 17:47:11 INFO - PROCESS | 30148 | Values: 82.0 83.0 84.0 82.0 83.0 82.0 82.0 83.0 81.0 83.0 17:47:11 INFO - PROCESS | 30148 | 17:47:11 INFO - PROCESS | 30148 | [#11] stanford-crypto-ccm Cycles:10 Average:137.30 Median:135.00 stddev:6.07 (4.5%) stddev-sans-first:6.39 17:47:11 INFO - PROCESS | 30148 | Values: 135.0 133.0 133.0 134.0 135.0 132.0 134.0 142.0 149.0 146.0 17:47:11 INFO - PROCESS | 30148 | 17:47:11 INFO - PROCESS | 30148 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.30 Median:171.50 stddev:2.00 (1.2%) stddev-sans-first:2.12 17:47:11 INFO - PROCESS | 30148 | Values: 171.0 172.0 170.0 169.0 170.0 169.0 175.0 174.0 172.0 171.0 17:47:11 INFO - PROCESS | 30148 | 17:47:11 INFO - PROCESS | 30148 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.00 stddev:2.49 (3.6%) stddev-sans-first:2.64 17:47:11 INFO - PROCESS | 30148 | Values: 69.0 68.0 69.0 69.0 67.0 75.0 68.0 72.0 67.0 68.0 17:47:11 INFO - PROCESS | 30148 | -------- Summary: end -------- 17:47:11 INFO - PROCESS | 30148 | 17:47:12 INFO - TEST-INFO | 30148: exit 0 17:47:12 INFO - TEST-OK | kraken | took 65075ms 17:47:12 INFO - SUITE-END | took 1186s 17:47:12 INFO - Completed test suite (00:19:46) 17:47:12 INFO - javascript benchmark 17:47:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2560.2063360358284, 2607.8044146689003, 2608.334874606975, 2615.973840261598, 2630.1846427607443, 4579.748113853737, 4581.40441742573, 4609.216433206355, 4693.718376897388, 4705.011947491027, 4640.860774176772, 4692.108499385115, 4700.482946875841, 4713.670043096985, 4751.097291514609, 4339.609435150835, 4348.760818155, 4413.668974826885, 4431.534688857671, 4459.33767184333, 4407.757573333465, 4446.466424029105, 4453.087117140994, 4454.732716037032, 4455.331700244957, 4183.5398106208295, 4218.578142185787, 4243.27864263076, 4321.0709697414895, 4330.0, 4285.571442855689, 4287.185434767384, 4295.334223195409, 4306.913861722748, 4313.805878735465, 4347.065380943112, 4353.172897149531, 4363.759993200372, 4364.519902810688, 4365.781710914442, 4698.154332220199, 4769.260764581495, 4771.785269662839, 4774.40319960005, 4779.498152693952, 4898.90202195954, 4998.250262460624, 5035.395752509686, 5035.697858128524, 5108.591312694975, 5118.129917913963, 5128.102582048164, 5131.61512886535, 5135.974320128375, 5138.332016837787, 4771.5467030632035, 4784.114938736276, 4784.952150478485, 4803.763897351903, 4808.0624278266105, 5010.0, 5175.637705360664, 5181.766820493011, 5215.58275337972, 5237.188235823453, 5035.79856805731, 5070.4929507049, 5073.568746656576, 5076.060928728197, 5079.161938280143, 5150.48495150482, 5154.896902061938, 5158.793648254028, 5162.767675454614, 5166.070107380632, 4855.781489832966, 4888.804447822047, 4957.603391728725, 5081.4918508148885, 5087.211482220262, 4971.7016978980655, 4986.601071914238, 4988.426330971912, 4989.451160372356, 4995.550400463976, 4319.632831209383, 4319.97840010798, 4321.308590625485, 4323.221820072355, 4329.328954012133, 3682.1531047859144, 3709.740318177756, 3743.4384842273876, 3753.9436908446396, 3767.095896984704, 4334.32817913224, 4346.348047792856, 4349.325854492558, 4354.0, 4356.455443069616, 5064.164412871909, 5066.645334826527, 5092.949070509248, 5097.643164978416, 5101.668391554537, 4256.638185754184, 4312.159128969884, 4362.367456718758, 4367.519572846984, 4375.431193944767, 4630.3748993886065, 4639.768011599406, 4646.83736069236, 4655.511171326962, 4655.837045703384, 4805.735684537314, 4810.374651295309, 4815.253635686474, 4816.95183048179, 4818.518148185223, 4920.458749537476, 4953.455119936732, 4956.628252880976, 5144.356955380577, 5150.97424512875, 4722.338872557913, 4731.313959475926, 4736.644751643572, 4744.335792988915, 4758.5241475852135, 4961.0, 4982.078315511642, 4986.351774269322, 4993.975030124971, 5007.949920500749, 4846.539578740014, 4881.707097574015, 4917.041176970456, 5035.295058691713, 5044.167712327425, 4849.296851956376, 4852.95147048525, 4861.465238823797, 4867.902641947212, 4870.31815545831, 4882.414110306786, 4885.755712214446, 4886.462489126122, 4890.144224760582, 4891.706497610155, 4746.525347465364, 4765.737884416251, 4778.402699662543, 4794.1130890783925, 4801.255805350176, 4980.775865086008, 5002.099622068063, 5011.599072074152, 5012.774425150804, 5023.246513023076, 4896.314515967839, 4896.608271338213, 4898.314236007033, 4901.09329773993, 4905.2151655734915], "value": 4638.9285504907175, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.3015800091885, 563.5547917145456, 564.167852417684, 564.7007086244289, 576.7404667899445, 28642.856785716067, 29152.854235728846, 31391.529127063113, 31433.21416964577, 38627.22745545088, 38264.80867595665, 42120.57879421205, 42139.157216855645, 42150.15699686012, 42202.56873028326, 7633.770986870389, 7760.6895724171245, 7771.727989520368, 7774.766756997299, 7777.5333479991095, 7767.145613982458, 7857.6856925722905, 7862.646180921844, 7863.488873223251, 7864.68541258349, 7765.339946104588, 7777.572233527154, 7798.8440231195345, 7816.648250828698, 7878.369730421553, 7790.220977902193, 7802.609869506558, 7813.257740514642, 7817.0, 7827.960860195691, 7665.8850117248285, 7729.0, 7729.420293478011, 7731.884021739678, 7760.844783104363, 38375.232495349934, 38638.613613864065, 38688.0, 38743.80628096841, 38752.61247387518, 2590.5855063189797, 2592.662953815992, 2627.4351014531776, 2641.392479729673, 3074.415860986428, 29376.8531157345, 29479.70520294791, 29552.408951821057, 29724.70275297241, 29756.10731678053, 3279.3234781485994, 3395.439752440844, 3458.5849698036145, 3501.072215862798, 3521.8239088045752, 246817.0, 247357.0, 247952.76023619948, 249524.2571361431, 249688.0, 51887.0, 52115.739421303406, 52165.47834521682, 52184.47815521872, 52285.73857130766, 32437.675623243937, 33094.863142107235, 33298.0, 35070.0, 54944.0, 12891.742165156644, 13079.280639564726, 13086.2802545859, 13091.083624146218, 13095.279759613313, 9712.417254964725, 9849.261305402124, 9855.408675479493, 9861.506924653739, 9865.901340986498, 17623.206955687026, 17777.46667599974, 17781.288748450177, 17809.46571602854, 17821.37625183138, 6589.4069533742195, 6617.4706023518, 6760.83097922546, 6782.423494003065, 6810.62541560219, 789.8657228271207, 882.6601758322963, 887.1527691055156, 911.6535716427848, 971.8396464583406, 27488.17535473939, 27731.810841753053, 28055.298617534318, 28223.858880705466, 28893.42213155725, 942.137943781446, 956.6747305915883, 998.3859926145514, 1014.4978235773192, 1042.3016578892161, 13995.440182392591, 14780.556583302518, 14894.553163405115, 15118.546443606709, 15144.394224230908, 367050.0, 367837.0, 369109.0, 369333.0, 370665.0, 48338.0, 48687.269690954665, 48793.0, 48985.26522102171, 49039.50960490349, 964.5804075227159, 1037.8287582548946, 1097.5280629329466, 1165.469711281382, 1166.3526742657737, 27079.458410831277, 28340.85829570839, 28909.421811564072, 29036.7096329034, 29451.852740736158, 41204.58795412008, 41725.0, 41761.58238417577, 41782.58217417787, 41850.79074604729, 282904.0, 283649.0, 283713.0, 283762.0, 284334.0, 20504.487387815425, 24999.750002499743, 25015.49969000646, 26177.60733589036, 26475.07337243187, 34771.430706758874, 35204.0, 35455.290894182486, 36094.0, 36292.818535908205, 35704.64295357013, 35856.10359741027, 36120.819395903905, 36129.819350903075, 36242.27515449729, 35371.0, 35556.82221588876, 35589.64410355863, 35680.0, 35753.82123089472, 31691.0, 33037.83481082579, 34270.48594271038, 34796.0, 35393.0, 29869.402611948073, 32577.0, 32684.346313074082, 32754.344913102083, 32872.34255314928, 24912.875435622707, 25017.0, 25340.0, 25361.0, 25736.8713156433], "value": 16789.42157614482, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.54084312922583, 363.9763415378, 364.69912322334073, 380.87621523005, 384.5097500686624, 15867.285972131252, 17048.23282952267, 17734.73397899031, 17919.82080179198, 17932.55168620785, 15578.844211557882, 15671.529854104396, 16261.918690406561, 16369.263383147758, 16374.508764737047, 4769.976150119253, 5011.774470148852, 5024.145895197825, 5025.3467049283545, 5027.044861476326, 3654.3239500692325, 3838.961610383902, 4892.168331383656, 5638.689872057035, 5875.177475153482, 5979.103134529833, 5988.8502787430225, 5991.970040149815, 5995.580309378323, 5995.6102853314615, 5769.82690519283, 5961.195238642793, 5970.641761494281, 5986.5210783137245, 5987.461128498456, 5092.9236061459105, 5252.737363131828, 5260.2372655965055, 5263.289455923478, 5265.052290587692, 19516.219351225933, 20326.0, 21291.467713307135, 21713.0, 21716.34850954474, 1854.9536261593432, 1870.7006878899447, 1917.712343148525, 1944.0, 2341.988290058539, 9006.549672516414, 9047.864282035775, 9118.726438206799, 9191.540422978891, 9478.0, 1754.2369069454828, 1792.2521705777758, 1895.4787433455772, 1904.5530877978006, 1914.5979344337707, 67183.0, 68884.0, 69588.3041169587, 70038.64980675065, 70929.64535177343, 10149.086582207638, 10176.592936282614, 10241.795164096677, 10464.21518386124, 10542.52558634848, 14045.578632641038, 14129.538263125394, 14143.787843182361, 14174.716505670036, 14176.716465670836, 6632.801015969529, 6794.524383293221, 6829.760958366433, 7060.576365418091, 7062.329078737512, 6285.214348206474, 6311.495080393557, 6496.545241833026, 6503.837404064841, 6505.024246363083, 4386.298192289219, 4413.117376524708, 4418.094290670405, 4443.933340999887, 4546.181687296318, 1568.7882135911507, 1611.1138873619464, 1630.7146249406308, 1775.485109318309, 1782.5098098023147, 649.7177943320866, 842.4566154830101, 926.9953650231706, 928.7213835849218, 939.2908354192678, 16024.679506409806, 16396.590085247964, 16599.585010374594, 16913.154342282836, 17884.55288617769, 853.8249658819927, 867.4708427859001, 867.9651425198674, 870.2907130688469, 905.1310741687921, 9633.566489507988, 9636.518174091407, 9858.704238872846, 9870.111689947938, 10118.645847395306, 300143.0, 303656.0, 304947.0, 383415.23894273915, 399518.0, 80307.19692803115, 82502.58748706218, 84202.0, 84395.0, 86503.0, 874.6982291109557, 939.6147579492375, 943.9056094390643, 977.94621295828, 980.7057882635181, 12151.453184606537, 15867.0, 15900.8409915904, 16102.677946440772, 16955.406560770312, 27054.917803287648, 29060.0, 35222.64777352194, 35230.0, 36570.8171459141, 47262.0, 48141.5185848151, 48702.0, 49944.50055499398, 49947.50052499574, 7557.811054723676, 7688.615569221628, 7801.102873169658, 7889.2110788920645, 7938.24586664266, 8407.033191182847, 9161.450312981242, 10432.321899076536, 11511.884881151082, 12449.0, 9415.05849415053, 9490.620375184915, 9704.2721795867, 9725.124738773544, 9929.304948653813, 9755.463449510346, 10027.298089133983, 10175.338602990782, 10330.380177189392, 10557.841632375674, 9379.531023448937, 9451.763705907133, 9840.55717492729, 10333.47688134499, 10470.0, 7442.776716698508, 7481.289277518627, 7544.886826697494, 7547.433942454228, 7633.274838890296, 9465.858012129685, 9568.234541236545, 9753.804923901624, 10015.749606259902, 10202.380125259207], "value": 8096.712519158713, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1125.2123513540523, 1126.5155982927342, 1279.9248631149833, 1340.8860246879015, 1340.9128406653567, 6680.966595167018, 6952.721891124349, 7456.440766942481, 8056.516609003456, 8056.91943080569, 7214.891776623342, 7425.294597013275, 7427.665755041023, 7540.698372065124, 7548.849023019537, 2177.673348997655, 2201.6257236269794, 2211.3255457085584, 2211.447138215446, 2212.61279276126, 1836.7795864496213, 2098.7691353951054, 2126.138913739938, 2163.080690706451, 2175.869447833135, 2135.1032566322106, 2159.85960912541, 2162.1783722185546, 2163.0374483354913, 2170.468235282358, 2096.4444422228044, 2105.4525823285903, 2135.3593921823544, 2138.4760733620205, 2144.1423430627874, 2055.8663686860305, 2063.6388631989494, 2073.7304150460495, 2078.7297651305385, 2114.3762590035976, 7862.764117076496, 7963.402744794105, 8001.679932802681, 8021.438499305051, 8030.718924837603, 4347.956520434786, 4486.349479325512, 4489.281714925596, 4491.640668746525, 4500.504944456107, 2816.225537977052, 2934.339773550955, 2977.032464449063, 2982.910512684623, 3017.8792848286043, 882.3955590420583, 925.3013974449315, 938.7887725261829, 944.0606596436521, 954.608610469711, 10880.782384352347, 10905.454727263605, 10908.0, 10915.836262456069, 10918.563257469692, 3741.5323084614424, 3992.782201428592, 4229.471316085489, 4237.406763053175, 4274.615284624399, 9434.575444104894, 9439.150476457151, 9447.669331573363, 9448.527573621428, 9451.102145296185, 4422.823087076481, 4428.756418397019, 4435.82256709728, 4442.3336499524685, 4442.42248507692, 4005.1589166274825, 4010.0, 4010.2781499329817, 4012.378081397388, 4013.337799263147, 3311.453610154346, 3416.6241713411505, 3453.9827300863335, 3490.3193877194212, 3492.4586689063235, 966.9758256043515, 1025.876894772632, 1035.9585616575253, 1046.8900765419673, 1052.5633159236343, 718.2314923032305, 732.6263605561202, 751.8721817291074, 759.5822297736223, 766.6588368176108, 5128.666636668605, 5175.9741201293755, 5243.239730239094, 5257.447967963385, 5459.235707001023, 824.9463784853965, 843.2663582683105, 878.6485405837716, 895.1093661806544, 895.6917228132703, 3468.3583537045224, 3518.138056176253, 3540.963945731215, 3660.286244182359, 3778.6221377862544, 9928.106470417553, 9954.402735835873, 10045.69862904114, 10074.294799364121, 10081.49592520371, 9695.757606059906, 9768.169705574963, 9952.054554817281, 10032.498375081217, 10032.899671003197, 7350.2649735027135, 7537.321641052332, 7551.433642476836, 7554.546727196386, 7558.962205189049, 5348.304720386325, 5356.196570514454, 5398.1902714593125, 5456.645318054314, 5528.811305569322, 8926.86609700868, 9041.18629323364, 9068.138526839939, 9087.454752714859, 9158.67944621935, 8657.696980605648, 8803.295736341206, 9200.493972831558, 9300.953495232481, 9350.672726454814, 6542.8364290893105, 6725.8991115134295, 6727.327267273234, 6727.629980351127, 6729.495287853529, 7395.482316237812, 7404.407647388303, 7425.851482970203, 7452.254774522505, 7511.737089201852, 4923.778429970732, 6612.570182938093, 6646.202455705346, 6670.499712521483, 6877.518573699993, 6358.0, 6446.871062578628, 6492.156019717407, 6494.512911531559, 6559.0, 6038.094285857156, 6175.073738939195, 6220.782272620437, 6224.190855188796, 6235.781747638811, 4479.776011199492, 4594.150082234797, 4690.882727931693, 4723.110755697749, 4778.880527986828, 4418.4918734345965, 4419.823207071681, 4511.684182107221, 4567.1779079765965, 4591.403117594691], "value": 4062.8291769831994, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.0718148604127, 297.1101550855189, 305.856247563645, 306.7791190342953, 307.8183871515805, 4756.714597124171, 4767.7341021400325, 4773.474917759044, 4782.904341913159, 4786.7606619669, 4704.294355846625, 4727.858164255069, 4727.90544189116, 4740.90518189636, 4744.786484608192, 3580.4987301777774, 3685.373486507287, 3718.3307004739136, 3754.8685795997144, 3772.226693527834, 3770.189409277005, 3775.18833450808, 3792.886213413602, 3798.9240215195678, 3803.239352129571, 3746.700263978889, 3751.5873253942045, 3754.718396120288, 3759.586445490994, 3771.3400154972906, 3519.524864143359, 3581.409067503872, 3627.2382799612114, 3704.6110158433244, 3767.886963391089, 3288.6053673559086, 3292.720118789882, 3304.96695033049, 3307.9173020674434, 3315.602127744686, 4594.908101837945, 4606.838760643362, 4608.470025946992, 4618.907621847544, 4647.163510568096, 4153.190127925056, 4247.341662042389, 4288.635465985364, 4298.720583162116, 4303.591158839905, 4878.389921524161, 4910.803567857317, 4921.056182807807, 4921.704697718148, 4926.881440980377, 3598.1904071583685, 3601.6398360164035, 3607.134287770916, 3614.114541937216, 3622.492851000862, 5092.532741972355, 5171.586273098181, 5187.351581052369, 5209.7134657593815, 5248.134057880445, 3599.370110230699, 3680.2639472105684, 3698.7965661888857, 3710.276496083238, 3711.777293362407, 3774.2640185164178, 3775.622437756257, 3777.433384992218, 3788.507494025759, 3805.296020236265, 4256.87229383119, 4266.719984004786, 4267.0, 4268.16770729711, 4272.722273052242, 4637.559431854036, 4900.583450406684, 4940.481249468826, 4956.702597844141, 4956.909479914413, 1259.6976725585976, 1276.7765641012786, 1277.2464246094848, 1278.6611547939804, 1279.6736832107754, 796.6454927557181, 814.5682788122305, 826.7561069484517, 826.9710560130367, 832.76682528892, 3965.940510892339, 3968.1548080142293, 4182.728122672017, 4263.486462305898, 4370.431843860341, 5089.3638295213095, 5097.362829646294, 5098.286239926413, 5117.820876269313, 5119.462456442095, 4398.142362239332, 4411.139827733626, 4412.889677758082, 4420.237351655215, 4426.734395936254, 2594.987025064863, 2695.595660650918, 2695.865206739655, 2696.8516731579557, 2721.6597925259343, 4796.160671882407, 4801.18379875415, 4820.517948205152, 4827.300041494034, 4830.227163653799, 5174.611904107207, 5187.0, 5217.608679349064, 5220.0, 5221.034108689829, 4559.0, 4765.4996225395835, 4828.589569886599, 4837.637177211724, 4838.612910967114, 5096.923546146737, 5128.512791284822, 5131.589472842089, 5132.8460146195675, 5147.79026928664, 4990.276409920614, 5020.87447813793, 5027.497250274943, 5040.395152581714, 5042.495750424928, 4596.793144308447, 4796.352492413619, 4832.323474713613, 4841.201201801804, 4863.489333619919, 3720.6093360197874, 3731.5149030625844, 3732.64539868712, 3733.8319775610707, 3742.419924911643, 5128.512671354316, 5136.0, 5144.459831717765, 5148.510891465305, 5152.587792976478, 4733.650909490779, 4907.730074845917, 4947.529984651453, 4964.386574363274, 5007.7746501408255, 4904.8773780655765, 4972.975135124301, 4975.253711943093, 4979.0, 4989.725565093955, 4912.48418916023, 4918.336024636628, 4926.901461970812, 4927.581155601814, 4939.209726443752, 4721.22099853534, 4879.292502587034, 4955.2567114933045, 4976.855323275595, 5032.974835125801, 4799.9760001199775, 4852.902941941212, 4867.95132048675, 4869.488703686062, 4875.390576177978], "value": 3754.160795538517, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [528.3395755305868, 566.3006187358611, 570.3469527391137, 579.4813641790597, 618.8638499530108, 11162.386068766225, 11843.348615826126, 12437.067219958517, 12442.19125756825, 12446.133080037998, 11989.880101198985, 12002.339871307075, 12018.399080046007, 12019.579314723986, 12024.0, 612.301975747648, 736.4844608773853, 750.0436942897794, 750.302218936389, 750.4671683105003, 719.9352058314751, 720.0639169080201, 727.938125259351, 756.1719916691214, 757.2843662738715, 791.3155120820478, 797.178905727102, 797.2466019611469, 798.022422532396, 798.1061211443192, 629.4555209743539, 788.9723859664913, 791.1929831571764, 791.7783020754198, 793.4366599714181, 547.9780808767645, 548.5173047718023, 558.0596694569663, 575.9308882934033, 580.1413907417046, 11415.0, 11439.656810295704, 11441.141914356373, 11443.771124577463, 11467.77064458706, 12021.278723276631, 12135.332556709378, 12303.384830758516, 12751.234925904475, 13614.727705445935, 11954.0, 11960.222585531912, 12252.81620775689, 12308.753824923451, 12933.0, 4178.289690752549, 4191.077962848199, 4204.362436124309, 4441.222786012435, 4452.955470445287, 68768.0, 70430.64784676096, 70510.0, 70579.29420705778, 70705.64647176783, 10257.58969641206, 10417.531211095518, 10429.165666746641, 10521.84217236742, 10872.347659140476, 18393.080345982646, 18441.354552590594, 18613.627727445375, 18723.0, 18723.157457914425, 6479.773207937699, 6507.219133703986, 6572.572782769104, 6675.232348279913, 6864.279250678607, 3671.4492826076303, 3795.891107367489, 3833.290841194388, 3875.147467557133, 3896.883093507143, 2797.9300517487227, 2900.7099290070823, 2903.129061281607, 2917.2560996945645, 2919.5328747400313, 506.73396466855195, 510.8441925212846, 515.9355080614923, 516.8811173430132, 528.0626887275117, 492.66498780828664, 512.5566385076881, 514.1157209599482, 526.2658591265164, 527.2434057128033, 7997.0, 8094.433389662667, 8160.224778646019, 8186.304164145995, 8296.0, 448.0747256914526, 479.0419161676647, 497.6367251906129, 536.87651840077, 550.7356468894953, 3645.744797864177, 3875.069983204011, 3921.274564205631, 4162.895927601834, 4201.495820501498, 52609.210861837106, 52884.0, 53580.46419535833, 53725.0, 54125.72937135289, 76271.0, 77942.0, 78337.0, 79073.62779116636, 82600.0, 42477.57522424798, 42550.57449425466, 64192.35807641957, 68364.65817671079, 68412.99999999901, 7170.784876453715, 7498.775036748906, 7541.135504311516, 7646.273604007611, 7718.382529397747, 37302.44046339253, 37430.43854342242, 43408.565914341714, 43758.0, 44350.33474497821, 56473.71763141158, 57669.0, 59357.70321148367, 60229.698851507215, 60567.69716151567, 11292.661220163409, 11588.273356228956, 11624.476898539417, 11806.0, 11949.088145896614, 13033.608991730263, 13151.671208219872, 13496.392662330023, 13904.374303156585, 14082.155070695791, 10845.924453280319, 11389.145814064144, 11693.490319152526, 11928.284302941851, 11967.461464233957, 11492.195546311677, 11915.463804128662, 11930.582429614922, 12476.376181191086, 12478.5008599655, 11352.829707554558, 11666.941665291619, 11749.941250294036, 12355.75288494243, 12356.505739770308, 9402.106799854002, 9742.220622350053, 9811.362261452983, 10101.49492525356, 10279.17766578657, 9844.114029737359, 10126.797464050826, 10127.392356458637, 10183.13443357323, 10253.769547654329], "value": 6290.141279036807, "unit": "score"}], "name": "dromaeo_css", "value": 6265.688554759282, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 114.0, 111.0, 114.0, 115.0, 114.0, 120.0, 115.0, 113.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 122.0, 153.0, 183.0, 128.0, 147.0, 144.0, 124.0, 184.0, 121.0], "value": 145.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 161.0, 161.0, 161.0, 161.0, 162.0, 161.0, 161.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 166.0, 76.0, 76.0, 76.0, 128.0, 119.0, 76.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 155.0, 86.0, 86.0, 86.0, 134.0, 86.0, 86.0, 140.0], "value": 103.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 67.0, 66.0, 65.0, 66.0, 65.0, 65.0, 66.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 66.0, 68.0, 67.0, 67.0, 66.0, 67.0, 67.0, 68.0], "value": 67.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 84.0, 82.0, 83.0, 82.0, 82.0, 83.0, 81.0, 83.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 133.0, 133.0, 134.0, 135.0, 132.0, 134.0, 142.0, 149.0, 146.0], "value": 137.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 172.0, 170.0, 169.0, 170.0, 169.0, 175.0, 174.0, 172.0, 171.0], "value": 171.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 69.0, 69.0, 67.0, 75.0, 68.0, 72.0, 67.0, 68.0], "value": 69.2, "unit": "score"}], "name": "kraken", "value": 1569.0, "alertThreshold": 2.0}]} 17:47:12 INFO - Return code: 0 17:47:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:47:12 INFO - # TBPL SUCCESS # 17:47:12 INFO - Running post-action listener: _resource_record_post_action 17:47:12 INFO - [mozharness: 2016-08-23 00:47:12.913942Z] Finished run-tests step (success) 17:47:12 INFO - Running post-run listener: _resource_record_post_run 17:47:12 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 414023680; Read time: 8; Write time: 351228 17:47:12 INFO - TinderboxPrint: CPU usage
13.2% 17:47:12 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 17:47:12 INFO - TinderboxPrint: I/O write bytes / time
414,023,680 / 351,228 17:47:12 INFO - TinderboxPrint: CPU idle
8,326.9 (86.7%) 17:47:12 INFO - TinderboxPrint: CPU user
1,205.3 (12.6%) 17:47:12 INFO - TinderboxPrint: Swap in / out
0 / 0 17:47:12 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 124874752; Read time: 0; Write time: 95504 17:47:13 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289148928; Read time: 8; Write time: 255724 17:47:13 INFO - Running post-run listener: _upload_blobber_files 17:47:13 INFO - Blob upload gear active. 17:47:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:47:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:47:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:47:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:47:14 INFO - (blobuploader) - INFO - Open directory for files ... 17:47:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:47:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:47:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:47:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:47:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:47:20 INFO - (blobuploader) - INFO - Done attempting. 17:47:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:47:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:47:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:47:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:47:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:47:20 INFO - (blobuploader) - INFO - Done attempting. 17:47:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:47:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:47:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:47:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:47:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:47:21 INFO - (blobuploader) - INFO - Done attempting. 17:47:21 INFO - (blobuploader) - INFO - Iteration through files over. 17:47:21 INFO - Return code: 0 17:47:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:47:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:47:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e80fc083ea5e8a958fb2db8a129a0d66fe4670733bd90d7b93fc1ad296a37667e99dd5efb1c781077ccfc99c210fbf406eaec6fcf79c46e8395bc15235b3e5b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/72d94a7248abbb2342134d57771a100b7f45889d8b3e922447adfad3c8855b302c92b0ffb3b0da2884858df9f71ac911e142c726588d158209064b0cb084fe6c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7eab28a5dbde9ea0a70af4cee9f8de0ab46fef5f287acffb58bf3fec817c97a0db2e1de67fe4f6be2f865a04a12520a96a2c2cc465f2c9c82946a539e3870984"} 17:47:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:47:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:47:21 INFO - Contents: 17:47:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e80fc083ea5e8a958fb2db8a129a0d66fe4670733bd90d7b93fc1ad296a37667e99dd5efb1c781077ccfc99c210fbf406eaec6fcf79c46e8395bc15235b3e5b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/72d94a7248abbb2342134d57771a100b7f45889d8b3e922447adfad3c8855b302c92b0ffb3b0da2884858df9f71ac911e142c726588d158209064b0cb084fe6c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7eab28a5dbde9ea0a70af4cee9f8de0ab46fef5f287acffb58bf3fec817c97a0db2e1de67fe4f6be2f865a04a12520a96a2c2cc465f2c9c82946a539e3870984"} 17:47:21 INFO - Running post-run listener: copy_logs_to_upload_dir 17:47:21 INFO - Copying logs to upload dir... 17:47:21 INFO - mkdir: /builds/slave/test/build/upload/logs 17:47:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.313770 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-08-22 17:47:21.348769) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 17:47:21.352581) ========= 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=32c5991c409366f7fec8a718000001d2-1471911990.836801-1443251870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e80fc083ea5e8a958fb2db8a129a0d66fe4670733bd90d7b93fc1ad296a37667e99dd5efb1c781077ccfc99c210fbf406eaec6fcf79c46e8395bc15235b3e5b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/72d94a7248abbb2342134d57771a100b7f45889d8b3e922447adfad3c8855b302c92b0ffb3b0da2884858df9f71ac911e142c726588d158209064b0cb084fe6c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7eab28a5dbde9ea0a70af4cee9f8de0ab46fef5f287acffb58bf3fec817c97a0db2e1de67fe4f6be2f865a04a12520a96a2c2cc465f2c9c82946a539e3870984"} build_url:https://queue.taskcluster.net/v1/task/AQfsKt6CSDCy6cyG1gSFgw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011392 build_url: 'https://queue.taskcluster.net/v1/task/AQfsKt6CSDCy6cyG1gSFgw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7e80fc083ea5e8a958fb2db8a129a0d66fe4670733bd90d7b93fc1ad296a37667e99dd5efb1c781077ccfc99c210fbf406eaec6fcf79c46e8395bc15235b3e5b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/72d94a7248abbb2342134d57771a100b7f45889d8b3e922447adfad3c8855b302c92b0ffb3b0da2884858df9f71ac911e142c726588d158209064b0cb084fe6c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7eab28a5dbde9ea0a70af4cee9f8de0ab46fef5f287acffb58bf3fec817c97a0db2e1de67fe4f6be2f865a04a12520a96a2c2cc465f2c9c82946a539e3870984"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-22 17:47:21.378452) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 17:47:21.378833) ========= 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=32c5991c409366f7fec8a718000001d2-1471911990.836801-1443251870 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004489 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-22 17:47:21.462962) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 17:47:21.463325) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-22 17:47:21.463648) ========= ========= Total master_lag: 0.18 =========