builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-015 starttime: 1472495499.42 results: success (0) buildid: 20160829095731 builduid: 58530b7bb9fb404a85ea453aaed558f4 revision: 2ec2538353807a17b8b23f2440c9a52ec3f3ccc5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 11:31:39.416233) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-29 11:31:39.416926) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 11:31:39.417435) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-29 11:31:39.440390) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 11:31:39.440663) ========= 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=20e666a3d4cfbb71505a330e000001b4-1472494767.395345-317815114 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-29 11:31:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 23.2M=0.001s 2016-08-29 11:31:40 (23.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096007 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 11:31:39.550575) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 11:31:39.550865) ========= 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=20e666a3d4cfbb71505a330e000001b4-1472494767.395345-317815114 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014204 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 11:31:39.600790) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 11:31:39.601184) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2ec2538353807a17b8b23f2440c9a52ec3f3ccc5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 2ec2538353807a17b8b23f2440c9a52ec3f3ccc5 --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=20e666a3d4cfbb71505a330e000001b4-1472494767.395345-317815114 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-29 11:31:40,147 truncating revision to first 12 chars 2016-08-29 11:31:40,147 Setting DEBUG logging. 2016-08-29 11:31:40,147 attempt 1/10 2016-08-29 11:31:40,147 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2ec253835380?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-29 11:31:40,498 unpacking tar archive at: fx-team-2ec253835380/testing/mozharness/ program finished with exit code 0 elapsedTime=0.685705 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 11:31:40.300315) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 11:31:40.300643) ========= script_repo_revision: 2ec2538353807a17b8b23f2440c9a52ec3f3ccc5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-29 11:31:40.301057) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 11:31:40.301361) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-29 11:31:40.310550) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-29 11:31:40.310923) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=20e666a3d4cfbb71505a330e000001b4-1472494767.395345-317815114 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:31:40 INFO - MultiFileLogger online at 20160829 11:31:40 in /builds/slave/test 11:31:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 11:31:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:31:40 INFO - {'append_to_log': False, 11:31:40 INFO - 'base_work_dir': '/builds/slave/test', 11:31:40 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:31:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:31:40 INFO - 'branch': 'Fx-Team-Non-PGO', 11:31:40 INFO - 'buildbot_json_path': 'buildprops.json', 11:31:40 INFO - 'config_files': ('talos/linux_config.py',), 11:31:40 INFO - 'default_actions': ('clobber', 11:31:40 INFO - 'read-buildbot-config', 11:31:40 INFO - 'download-and-extract', 11:31:40 INFO - 'populate-webroot', 11:31:40 INFO - 'create-virtualenv', 11:31:40 INFO - 'install', 11:31:40 INFO - 'run-tests'), 11:31:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:31:40 INFO - 'download_minidump_stackwalk': True, 11:31:40 INFO - 'download_symbols': 'ondemand', 11:31:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:31:40 INFO - 'tooltool.py': '/tools/tooltool.py', 11:31:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:31:40 INFO - '/tools/misc-python/virtualenv.py')}, 11:31:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:31:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:31:40 INFO - 'installer_path': 'installer.exe', 11:31:40 INFO - 'log_level': 'info', 11:31:40 INFO - 'log_name': 'talos', 11:31:40 INFO - 'log_to_console': True, 11:31:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:31:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:31:40 INFO - 'opt_config_files': (), 11:31:40 INFO - 'pip_index': False, 11:31:40 INFO - 'sps_profile': False, 11:31:40 INFO - 'sps_profile_interval': 0, 11:31:40 INFO - 'suite': 'dromaeojs', 11:31:40 INFO - 'system_bits': '32', 11:31:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:31:40 INFO - 'title': 'talos-linux64-ix-015', 11:31:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:31:40 INFO - 'use_talos_json': True, 11:31:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:31:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:31:40 INFO - 'work_dir': 'build'} 11:31:40 INFO - [mozharness: 2016-08-29 18:31:40.953960Z] Running clobber step. 11:31:40 INFO - Running pre-action listener: _resource_record_pre_action 11:31:40 INFO - Running main action method: clobber 11:31:40 INFO - rmtree: /builds/slave/test/build 11:31:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:31:41 INFO - Running post-action listener: _resource_record_post_action 11:31:41 INFO - [mozharness: 2016-08-29 18:31:41.419733Z] Finished clobber step (success) 11:31:41 INFO - [mozharness: 2016-08-29 18:31:41.419836Z] Running read-buildbot-config step. 11:31:41 INFO - Running pre-action listener: _resource_record_pre_action 11:31:41 INFO - Running main action method: read_buildbot_config 11:31:41 INFO - Using buildbot properties: 11:31:41 INFO - { 11:31:41 INFO - "project": "", 11:31:41 INFO - "product": "firefox", 11:31:41 INFO - "script_repo_revision": "production", 11:31:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:31:41 INFO - "repository": "", 11:31:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:31:41 INFO - "buildid": "20160829095731", 11:31:41 INFO - "pgo_build": "False", 11:31:41 INFO - "basedir": "/builds/slave/test", 11:31:41 INFO - "buildnumber": 2126, 11:31:41 INFO - "slavename": "talos-linux64-ix-015", 11:31:41 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:31:41 INFO - "platform": "ubuntu64_hw", 11:31:41 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:31:41 INFO - "branch": "fx-team", 11:31:41 INFO - "repo_path": "integration/fx-team", 11:31:41 INFO - "revision": "2ec2538353807a17b8b23f2440c9a52ec3f3ccc5", 11:31:41 INFO - "stage_platform": "linux64", 11:31:41 INFO - "builduid": "58530b7bb9fb404a85ea453aaed558f4", 11:31:41 INFO - "slavebuilddir": "test" 11:31:41 INFO - } 11:31:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 11:31:41 INFO - Running post-action listener: _resource_record_post_action 11:31:41 INFO - [mozharness: 2016-08-29 18:31:41.422354Z] Finished read-buildbot-config step (success) 11:31:41 INFO - [mozharness: 2016-08-29 18:31:41.422443Z] Running download-and-extract step. 11:31:41 INFO - Running pre-action listener: _resource_record_pre_action 11:31:41 INFO - Running main action method: download_and_extract 11:31:41 INFO - mkdir: /builds/slave/test/build/tests 11:31:41 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')]} 11:31:41 INFO - trying https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:31:41 INFO - Downloading https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/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 11:31:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/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 11:31:41 INFO - Downloaded 1361 bytes. 11:31:41 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:31:41 INFO - Using the following test package requirements: 11:31:41 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:31:41 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:31:41 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:31:41 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:31:41 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:31:41 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:31:41 INFO - u'jsshell-linux-x86_64.zip'], 11:31:41 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:31:41 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:31:41 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:31:41 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:31:41 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:31:41 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:31:41 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:31:41 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:31:41 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:31:41 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:31:41 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:31:41 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:31:41 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')]} 11:31:41 INFO - trying https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:31:41 INFO - Downloading https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/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 11:31:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/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 11:31:43 INFO - Downloaded 20305082 bytes. 11:31:43 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 11:31:47 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 11:31:47 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')]} 11:31:47 INFO - trying https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:31:47 INFO - Downloading https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/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 11:31:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/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 11:31:48 INFO - Downloaded 20305082 bytes. 11:31:48 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 11:31: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')]} 11:31:53 INFO - trying https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:31:53 INFO - Downloading https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/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 11:31:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/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 11:31:54 INFO - Downloaded 14413998 bytes. 11:31:54 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 11:31:54 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')]} 11:31:54 INFO - trying https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:31:54 INFO - Downloading https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/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 11:31:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/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 11:31:56 INFO - Downloaded 55869688 bytes. 11:31:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:31:56 INFO - mkdir: /builds/slave/test/properties 11:31:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:31:56 INFO - Writing to file /builds/slave/test/properties/build_url 11:31:56 INFO - Contents: 11:31:56 INFO - build_url:https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:31:57 INFO - Running post-action listener: _resource_record_post_action 11:31:57 INFO - Running post-action listener: set_extra_try_arguments 11:31:57 INFO - [mozharness: 2016-08-29 18:31:57.659867Z] Finished download-and-extract step (success) 11:31:57 INFO - [mozharness: 2016-08-29 18:31:57.660094Z] Running populate-webroot step. 11:31:57 INFO - Running pre-action listener: _resource_record_pre_action 11:31:57 INFO - Running main action method: populate_webroot 11:31:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:31:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:31:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:31:57 INFO - '--tppagecycles', 11:31:57 INFO - '7'], 11:31:57 INFO - 'tests': ['tsvgm']}}, 11:31:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:31:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:31:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:31:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:31:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:31:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:31:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:57 INFO - 'talos_options': ['--disable-e10s'], 11:31:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:31:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:31:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:57 INFO - 'talos_options': ['--disable-e10s'], 11:31:57 INFO - 'tests': ['damp', 'tps']}, 11:31:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:57 INFO - 'tests': ['damp', 'tps']}, 11:31:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:31:57 INFO - 'tests': ['dromaeo_dom']}, 11:31:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:31:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:31:57 INFO - 'tests': ['basic_compositor_video']}, 11:31:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:31:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:31:57 INFO - 'tests': ['a11yr', 11:31:57 INFO - 'ts_paint', 11:31:57 INFO - 'tpaint', 11:31:57 INFO - 'sessionrestore', 11:31:57 INFO - 'sessionrestore_no_auto_restore', 11:31:57 INFO - 'tabpaint']}, 11:31:57 INFO - 'other-e10s': {'tests': ['a11yr', 11:31:57 INFO - 'ts_paint', 11:31:57 INFO - 'tpaint', 11:31:57 INFO - 'sessionrestore', 11:31:57 INFO - 'sessionrestore_no_auto_restore', 11:31:57 INFO - 'tabpaint']}, 11:31:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:31:57 INFO - 'ts_paint', 11:31:57 INFO - 'tpaint', 11:31:57 INFO - 'sessionrestore', 11:31:57 INFO - 'sessionrestore_no_auto_restore', 11:31:57 INFO - 'tabpaint']}, 11:31:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:31:57 INFO - 'ts_paint', 11:31:57 INFO - 'tpaint', 11:31:57 INFO - 'sessionrestore', 11:31:57 INFO - 'sessionrestore_no_auto_restore', 11:31:57 INFO - 'tabpaint']}, 11:31:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:31:57 INFO - 'tests': ['a11yr', 11:31:57 INFO - 'ts_paint', 11:31:57 INFO - 'tpaint', 11:31:57 INFO - 'sessionrestore', 11:31:57 INFO - 'sessionrestore_no_auto_restore', 11:31:57 INFO - 'tabpaint']}, 11:31:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:31:57 INFO - 'tests': ['a11yr', 11:31:57 INFO - 'ts_paint', 11:31:57 INFO - 'tpaint', 11:31:57 INFO - 'sessionrestore', 11:31:57 INFO - 'sessionrestore_no_auto_restore', 11:31:57 INFO - 'tabpaint']}, 11:31:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:31:57 INFO - 'tests': ['tsvgx', 11:31:57 INFO - 'tsvgr_opacity', 11:31:57 INFO - 'tart', 11:31:57 INFO - 'tscrollx', 11:31:57 INFO - 'cart']}, 11:31:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:31:57 INFO - 'tsvgr_opacity', 11:31:57 INFO - 'tart', 11:31:57 INFO - 'tscrollx', 11:31:57 INFO - 'cart']}, 11:31:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:57 INFO - 'talos_options': ['--disable-e10s'], 11:31:57 INFO - 'tests': ['tp5o']}, 11:31:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:57 INFO - 'tests': ['tp5o']}, 11:31:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:57 INFO - 'talos_options': ['--disable-e10s', 11:31:57 INFO - '--xperf_path', 11:31:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:31:57 INFO - 'tests': ['tp5n']}, 11:31:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:57 INFO - 'talos_options': ['--xperf_path', 11:31:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:31:57 INFO - 'tests': ['tp5n']}}, 11:31:57 INFO - 'talos.zip': {'path': '', 11:31:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:31:57 INFO - Running post-action listener: _resource_record_post_action 11:31:57 INFO - [mozharness: 2016-08-29 18:31:57.679300Z] Finished populate-webroot step (success) 11:31:57 INFO - [mozharness: 2016-08-29 18:31:57.679389Z] Running create-virtualenv step. 11:31:57 INFO - Running pre-action listener: _resource_record_pre_action 11:31:57 INFO - Running main action method: create_virtualenv 11:31:57 INFO - Creating virtualenv /builds/slave/test/build/venv 11:31:57 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:31:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:31:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:31:57 INFO - Using real prefix '/usr' 11:31:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:31:58 INFO - Installing distribute.............................................................................................................................................................................................done. 11:32:00 INFO - Installing pip.................done. 11:32:00 INFO - Return code: 0 11:32:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:32:00 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')]} 11:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:00 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')]} 11:32:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:00 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 0x7f840907ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058090>, '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 0x105b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105be40>, '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': '20e666a3d4cfbb71505a330e000001b4-1472494767.395345-317815114', '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 11:32:00 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 11:32:00 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 11:32:00 INFO - Using env: {'DISPLAY': ':0', 11:32:00 INFO - 'HOME': '/home/cltbld', 11:32:00 INFO - 'LANG': 'en_US.UTF-8', 11:32:00 INFO - 'LANGUAGE': 'en_US:en', 11:32:00 INFO - 'LOGNAME': 'cltbld', 11:32:00 INFO - 'MAIL': '/var/mail/cltbld', 11:32:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:00 INFO - 'MOZ_NO_REMOTE': '1', 11:32:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:00 INFO - 'NO_EM_RESTART': '1', 11:32:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:00 INFO - 'PWD': '/builds/slave/test', 11:32:00 INFO - 'SHELL': '/bin/bash', 11:32:00 INFO - 'SHLVL': '1', 11:32:00 INFO - 'TERM': 'linux', 11:32:00 INFO - 'TMOUT': '86400', 11:32:00 INFO - 'USER': 'cltbld', 11:32:00 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1472494767.395345-317815114', 11:32:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:00 INFO - '_': '/tools/buildbot/bin/python'} 11:32:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:00 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 11:32:00 INFO - Cleaning up... 11:32:00 INFO - Return code: 0 11:32:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:32:00 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')]} 11:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:00 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')]} 11:32:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:00 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 0x7f840907ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058090>, '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 0x105b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105be40>, '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': '20e666a3d4cfbb71505a330e000001b4-1472494767.395345-317815114', '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 11:32:00 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 11:32:00 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 11:32:00 INFO - Using env: {'DISPLAY': ':0', 11:32:00 INFO - 'HOME': '/home/cltbld', 11:32:00 INFO - 'LANG': 'en_US.UTF-8', 11:32:00 INFO - 'LANGUAGE': 'en_US:en', 11:32:00 INFO - 'LOGNAME': 'cltbld', 11:32:00 INFO - 'MAIL': '/var/mail/cltbld', 11:32:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:00 INFO - 'MOZ_NO_REMOTE': '1', 11:32:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:00 INFO - 'NO_EM_RESTART': '1', 11:32:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:00 INFO - 'PWD': '/builds/slave/test', 11:32:00 INFO - 'SHELL': '/bin/bash', 11:32:00 INFO - 'SHLVL': '1', 11:32:00 INFO - 'TERM': 'linux', 11:32:00 INFO - 'TMOUT': '86400', 11:32:00 INFO - 'USER': 'cltbld', 11:32:00 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1472494767.395345-317815114', 11:32:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:00 INFO - '_': '/tools/buildbot/bin/python'} 11:32:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:00 INFO - Downloading/unpacking psutil>=3.1.1 11:32: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 11:32: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 11:32: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 11:32: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 11:32: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 11:32: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 11:32:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:32:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:32:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:32:02 INFO - Installing collected packages: psutil 11:32:02 INFO - Running setup.py install for psutil 11:32:02 INFO - building 'psutil._psutil_linux' extension 11:32:02 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 11:32:02 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 11:32:02 INFO - building 'psutil._psutil_posix' extension 11:32:02 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 11:32:03 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 11:32:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:32:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:32:03 INFO - Successfully installed psutil 11:32:03 INFO - Cleaning up... 11:32:03 INFO - Return code: 0 11:32:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:32:03 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')]} 11:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:03 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')]} 11:32:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:03 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 0x7f840907ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058090>, '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 0x105b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105be40>, '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': '20e666a3d4cfbb71505a330e000001b4-1472494767.395345-317815114', '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 11:32:03 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 11:32:03 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 11:32:03 INFO - Using env: {'DISPLAY': ':0', 11:32:03 INFO - 'HOME': '/home/cltbld', 11:32:03 INFO - 'LANG': 'en_US.UTF-8', 11:32:03 INFO - 'LANGUAGE': 'en_US:en', 11:32:03 INFO - 'LOGNAME': 'cltbld', 11:32:03 INFO - 'MAIL': '/var/mail/cltbld', 11:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:03 INFO - 'MOZ_NO_REMOTE': '1', 11:32:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:03 INFO - 'NO_EM_RESTART': '1', 11:32:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:03 INFO - 'PWD': '/builds/slave/test', 11:32:03 INFO - 'SHELL': '/bin/bash', 11:32:03 INFO - 'SHLVL': '1', 11:32:03 INFO - 'TERM': 'linux', 11:32:03 INFO - 'TMOUT': '86400', 11:32:03 INFO - 'USER': 'cltbld', 11:32:03 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1472494767.395345-317815114', 11:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:03 INFO - '_': '/tools/buildbot/bin/python'} 11:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:32:03 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 11:32:03 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 11:32:03 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 11:32:03 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 11:32:03 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 11:32:03 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 11:32:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:32:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:32:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:32:05 INFO - Installing collected packages: mozsystemmonitor 11:32:05 INFO - Running setup.py install for mozsystemmonitor 11:32:05 INFO - Successfully installed mozsystemmonitor 11:32:05 INFO - Cleaning up... 11:32:05 INFO - Return code: 0 11:32:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:32: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')]} 11:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32: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')]} 11:32:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f840907ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058090>, '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 0x105b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105be40>, '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': '20e666a3d4cfbb71505a330e000001b4-1472494767.395345-317815114', '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 11:32:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:32:05 INFO - Using env: {'DISPLAY': ':0', 11:32:05 INFO - 'HOME': '/home/cltbld', 11:32:05 INFO - 'LANG': 'en_US.UTF-8', 11:32:05 INFO - 'LANGUAGE': 'en_US:en', 11:32:05 INFO - 'LOGNAME': 'cltbld', 11:32:05 INFO - 'MAIL': '/var/mail/cltbld', 11:32:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:05 INFO - 'MOZ_NO_REMOTE': '1', 11:32:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:05 INFO - 'NO_EM_RESTART': '1', 11:32:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:05 INFO - 'PWD': '/builds/slave/test', 11:32:05 INFO - 'SHELL': '/bin/bash', 11:32:05 INFO - 'SHLVL': '1', 11:32:05 INFO - 'TERM': 'linux', 11:32:05 INFO - 'TMOUT': '86400', 11:32:05 INFO - 'USER': 'cltbld', 11:32:05 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1472494767.395345-317815114', 11:32:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:05 INFO - '_': '/tools/buildbot/bin/python'} 11:32:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:05 INFO - Downloading/unpacking jsonschema==2.5.1 11:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:32:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:32:07 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 11:32:07 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 11:32:07 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 11:32:07 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 11:32:07 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 11:32:07 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 11:32:07 INFO - Downloading functools32-3.2.3-2.tar.gz 11:32:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:32:07 INFO - warning: no files found matching '*.txt' 11:32:07 INFO - no previously-included directories found matching 'build' 11:32:07 INFO - no previously-included directories found matching 'dist' 11:32:07 INFO - no previously-included directories found matching '.git*' 11:32:07 INFO - Installing collected packages: jsonschema, functools32 11:32:07 INFO - Running setup.py install for functools32 11:32:07 INFO - warning: no files found matching '*.txt' 11:32:07 INFO - no previously-included directories found matching 'build' 11:32:07 INFO - no previously-included directories found matching 'dist' 11:32:07 INFO - no previously-included directories found matching '.git*' 11:32:07 INFO - Successfully installed jsonschema functools32 11:32:07 INFO - Cleaning up... 11:32:08 INFO - Return code: 0 11:32:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:32:08 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')]} 11:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:08 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')]} 11:32:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:08 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 0x7f840907ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058090>, '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 0x105b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105be40>, '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': '20e666a3d4cfbb71505a330e000001b4-1472494767.395345-317815114', '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 11:32:08 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 11:32:08 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 11:32:08 INFO - Using env: {'DISPLAY': ':0', 11:32:08 INFO - 'HOME': '/home/cltbld', 11:32:08 INFO - 'LANG': 'en_US.UTF-8', 11:32:08 INFO - 'LANGUAGE': 'en_US:en', 11:32:08 INFO - 'LOGNAME': 'cltbld', 11:32:08 INFO - 'MAIL': '/var/mail/cltbld', 11:32:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:08 INFO - 'MOZ_NO_REMOTE': '1', 11:32:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:08 INFO - 'NO_EM_RESTART': '1', 11:32:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:08 INFO - 'PWD': '/builds/slave/test', 11:32:08 INFO - 'SHELL': '/bin/bash', 11:32:08 INFO - 'SHLVL': '1', 11:32:08 INFO - 'TERM': 'linux', 11:32:08 INFO - 'TMOUT': '86400', 11:32:08 INFO - 'USER': 'cltbld', 11:32:08 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1472494767.395345-317815114', 11:32:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:08 INFO - '_': '/tools/buildbot/bin/python'} 11:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:32:08 INFO - Cleaning up... 11:32:08 INFO - Return code: 0 11:32:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:32:08 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')]} 11:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:08 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')]} 11:32:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:08 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 0x7f840907ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058090>, '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 0x105b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105be40>, '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': '20e666a3d4cfbb71505a330e000001b4-1472494767.395345-317815114', '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 11:32:08 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 11:32:08 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 11:32:08 INFO - Using env: {'DISPLAY': ':0', 11:32:08 INFO - 'HOME': '/home/cltbld', 11:32:08 INFO - 'LANG': 'en_US.UTF-8', 11:32:08 INFO - 'LANGUAGE': 'en_US:en', 11:32:08 INFO - 'LOGNAME': 'cltbld', 11:32:08 INFO - 'MAIL': '/var/mail/cltbld', 11:32:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:08 INFO - 'MOZ_NO_REMOTE': '1', 11:32:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:08 INFO - 'NO_EM_RESTART': '1', 11:32:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:08 INFO - 'PWD': '/builds/slave/test', 11:32:08 INFO - 'SHELL': '/bin/bash', 11:32:08 INFO - 'SHLVL': '1', 11:32:08 INFO - 'TERM': 'linux', 11:32:08 INFO - 'TMOUT': '86400', 11:32:08 INFO - 'USER': 'cltbld', 11:32:08 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1472494767.395345-317815114', 11:32:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:08 INFO - '_': '/tools/buildbot/bin/python'} 11:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:08 INFO - Downloading/unpacking blobuploader==1.2.4 11:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:10 INFO - Downloading blobuploader-1.2.4.tar.gz 11:32:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:32:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:32:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:11 INFO - Downloading docopt-0.6.1.tar.gz 11:32:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:32:11 INFO - Installing collected packages: blobuploader, requests, docopt 11:32:11 INFO - Running setup.py install for blobuploader 11:32:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:32:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:32:11 INFO - Running setup.py install for requests 11:32:11 INFO - Running setup.py install for docopt 11:32:11 INFO - Successfully installed blobuploader requests docopt 11:32:11 INFO - Cleaning up... 11:32:11 INFO - Return code: 0 11:32:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:32:11 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')]} 11:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:11 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')]} 11:32:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:11 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 0x7f840907ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058090>, '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 0x105b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105be40>, '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': '20e666a3d4cfbb71505a330e000001b4-1472494767.395345-317815114', '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 11:32:11 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 11:32:11 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 11:32:11 INFO - Using env: {'DISPLAY': ':0', 11:32:11 INFO - 'HOME': '/home/cltbld', 11:32:11 INFO - 'LANG': 'en_US.UTF-8', 11:32:11 INFO - 'LANGUAGE': 'en_US:en', 11:32:11 INFO - 'LOGNAME': 'cltbld', 11:32:11 INFO - 'MAIL': '/var/mail/cltbld', 11:32:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:11 INFO - 'MOZ_NO_REMOTE': '1', 11:32:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:11 INFO - 'NO_EM_RESTART': '1', 11:32:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:11 INFO - 'PWD': '/builds/slave/test', 11:32:11 INFO - 'SHELL': '/bin/bash', 11:32:11 INFO - 'SHLVL': '1', 11:32:11 INFO - 'TERM': 'linux', 11:32:11 INFO - 'TMOUT': '86400', 11:32:11 INFO - 'USER': 'cltbld', 11:32:11 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1472494767.395345-317815114', 11:32:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:11 INFO - '_': '/tools/buildbot/bin/python'} 11:32:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:32:11 INFO - Running setup.py (path:/tmp/pip-mJmDJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:32:12 INFO - Running setup.py (path:/tmp/pip-woRdNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:32:12 INFO - Running setup.py (path:/tmp/pip-Q7PuLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:32:12 INFO - Running setup.py (path:/tmp/pip-WcOGwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:32:12 INFO - Running setup.py (path:/tmp/pip-ebWXjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:32:12 INFO - Running setup.py (path:/tmp/pip-vJaHEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:32:12 INFO - Running setup.py (path:/tmp/pip-OxZnW_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:32:12 INFO - Running setup.py (path:/tmp/pip-aO3QlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:32:12 INFO - Running setup.py (path:/tmp/pip-CJUilE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:32:12 INFO - Running setup.py (path:/tmp/pip-E7rrDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:32:12 INFO - Running setup.py (path:/tmp/pip-j0ifHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:32:12 INFO - Running setup.py (path:/tmp/pip-orfTS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:32:12 INFO - Running setup.py (path:/tmp/pip-raaljz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:32:12 INFO - Running setup.py (path:/tmp/pip-P2dftq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:32:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:12 INFO - Running setup.py (path:/tmp/pip-9MZ_WM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:32:13 INFO - Running setup.py (path:/tmp/pip-Tms3EC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:32:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:32:13 INFO - Running setup.py (path:/tmp/pip-03pNRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:32:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:32:13 INFO - Running setup.py install for manifestparser 11:32:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:32:13 INFO - Running setup.py install for mozcrash 11:32:13 INFO - Running setup.py install for mozdebug 11:32:13 INFO - Running setup.py install for mozdevice 11:32:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:32:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:32:13 INFO - Running setup.py install for mozfile 11:32:13 INFO - Running setup.py install for mozhttpd 11:32:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:32:13 INFO - Running setup.py install for mozinfo 11:32:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:32:13 INFO - Running setup.py install for mozInstall 11:32:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:32:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:32:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:32:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:32:14 INFO - Running setup.py install for mozleak 11:32:14 INFO - Running setup.py install for mozlog 11:32:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:32:14 INFO - Running setup.py install for moznetwork 11:32:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:32:14 INFO - Running setup.py install for mozprocess 11:32:14 INFO - Running setup.py install for mozprofile 11:32:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:32:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:32:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:32:14 INFO - Running setup.py install for mozrunner 11:32:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:32:14 INFO - Running setup.py install for mozscreenshot 11:32:14 INFO - Running setup.py install for moztest 11:32:14 INFO - Running setup.py install for mozversion 11:32:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:32:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:32:14 INFO - Cleaning up... 11:32:15 INFO - Return code: 0 11:32:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:32:15 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')]} 11:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:15 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')]} 11:32:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:15 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 0x7f840907ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058090>, '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 0x105b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105be40>, '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': '20e666a3d4cfbb71505a330e000001b4-1472494767.395345-317815114', '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 11:32:15 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 11:32:15 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 11:32:15 INFO - Using env: {'DISPLAY': ':0', 11:32:15 INFO - 'HOME': '/home/cltbld', 11:32:15 INFO - 'LANG': 'en_US.UTF-8', 11:32:15 INFO - 'LANGUAGE': 'en_US:en', 11:32:15 INFO - 'LOGNAME': 'cltbld', 11:32:15 INFO - 'MAIL': '/var/mail/cltbld', 11:32:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:15 INFO - 'MOZ_NO_REMOTE': '1', 11:32:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:15 INFO - 'NO_EM_RESTART': '1', 11:32:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:15 INFO - 'PWD': '/builds/slave/test', 11:32:15 INFO - 'SHELL': '/bin/bash', 11:32:15 INFO - 'SHLVL': '1', 11:32:15 INFO - 'TERM': 'linux', 11:32:15 INFO - 'TMOUT': '86400', 11:32:15 INFO - 'USER': 'cltbld', 11:32:15 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1472494767.395345-317815114', 11:32:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:15 INFO - '_': '/tools/buildbot/bin/python'} 11:32:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:32:15 INFO - Running setup.py (path:/tmp/pip-CjbAyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:32:15 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)) 11:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:32:15 INFO - Running setup.py (path:/tmp/pip-tolTH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:32:15 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)) 11:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:32:15 INFO - Running setup.py (path:/tmp/pip-aFKxI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:32:15 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)) 11:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:32:15 INFO - Running setup.py (path:/tmp/pip-hi3JBf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:32:15 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)) 11:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:32:15 INFO - Running setup.py (path:/tmp/pip-XujQMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:32:15 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)) 11:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:32:15 INFO - Running setup.py (path:/tmp/pip-iaZ4Gx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:32:15 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)) 11:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:32:15 INFO - Running setup.py (path:/tmp/pip-ZPNIS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:32:15 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)) 11:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:32:15 INFO - Running setup.py (path:/tmp/pip-Au_T6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:32:15 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)) 11:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:32:15 INFO - Running setup.py (path:/tmp/pip-3aHAeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:32:15 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)) 11:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:32:15 INFO - Running setup.py (path:/tmp/pip-iGbCV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:32:15 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)) 11:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:32:15 INFO - Running setup.py (path:/tmp/pip-ZWOqN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:32:16 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)) 11:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:32:16 INFO - Running setup.py (path:/tmp/pip-kNUaPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:32:16 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)) 11:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:32:16 INFO - Running setup.py (path:/tmp/pip-WHMv0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:32:16 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)) 11:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:32:16 INFO - Running setup.py (path:/tmp/pip-HC7rZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:32:16 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)) 11:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:16 INFO - Running setup.py (path:/tmp/pip-pOjR5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:16 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)) 11:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:32:16 INFO - Running setup.py (path:/tmp/pip-uSbmY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:32:16 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)) 11:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:32:16 INFO - Running setup.py (path:/tmp/pip-ZygCgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:32:16 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)) 11:32:16 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)) 11:32:16 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)) 11:32:16 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)) 11:32:16 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)) 11:32:16 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)) 11:32:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:32:16 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 11:32:16 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 11:32:16 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 11:32:16 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 11:32:16 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 11:32:16 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 11:32:18 INFO - Downloading blessings-1.6.tar.gz 11:32:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:32:18 INFO - Installing collected packages: blessings 11:32:18 INFO - Running setup.py install for blessings 11:32:18 INFO - Successfully installed blessings 11:32:18 INFO - Cleaning up... 11:32:18 INFO - Return code: 0 11:32:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:32:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:32:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:32:18 INFO - Reading from file tmpfile_stdout 11:32:18 INFO - Current package versions: 11:32:18 INFO - argparse == 1.2.1 11:32:18 INFO - blessings == 1.6 11:32:18 INFO - blobuploader == 1.2.4 11:32:18 INFO - docopt == 0.6.1 11:32:18 INFO - functools32 == 3.2.3-2 11:32:18 INFO - jsonschema == 2.5.1 11:32:18 INFO - manifestparser == 1.1 11:32:18 INFO - mozInstall == 1.12 11:32:18 INFO - mozcrash == 0.17 11:32:18 INFO - mozdebug == 0.1 11:32:18 INFO - mozdevice == 0.48 11:32:18 INFO - mozfile == 1.2 11:32:18 INFO - mozhttpd == 0.7 11:32:18 INFO - mozinfo == 0.9 11:32:18 INFO - mozleak == 0.1 11:32:18 INFO - mozlog == 3.3 11:32:18 INFO - moznetwork == 0.27 11:32:18 INFO - mozprocess == 0.23 11:32:18 INFO - mozprofile == 0.28 11:32:18 INFO - mozrunner == 6.12 11:32:18 INFO - mozscreenshot == 0.1 11:32:18 INFO - mozsystemmonitor == 0.3 11:32:18 INFO - moztest == 0.7 11:32:18 INFO - mozversion == 1.4 11:32:18 INFO - psutil == 3.1.1 11:32:18 INFO - requests == 1.2.3 11:32:18 INFO - wsgiref == 0.1.2 11:32:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:32:18 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')]} 11:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:18 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')]} 11:32:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:18 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 0x7f840907ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058090>, '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 0x105b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105be40>, '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': '20e666a3d4cfbb71505a330e000001b4-1472494767.395345-317815114', '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 11:32:18 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 11:32:18 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 11:32:18 INFO - Using env: {'DISPLAY': ':0', 11:32:18 INFO - 'HOME': '/home/cltbld', 11:32:18 INFO - 'LANG': 'en_US.UTF-8', 11:32:18 INFO - 'LANGUAGE': 'en_US:en', 11:32:18 INFO - 'LOGNAME': 'cltbld', 11:32:18 INFO - 'MAIL': '/var/mail/cltbld', 11:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:18 INFO - 'MOZ_NO_REMOTE': '1', 11:32:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:18 INFO - 'NO_EM_RESTART': '1', 11:32:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:18 INFO - 'PWD': '/builds/slave/test', 11:32:18 INFO - 'SHELL': '/bin/bash', 11:32:18 INFO - 'SHLVL': '1', 11:32:18 INFO - 'TERM': 'linux', 11:32:18 INFO - 'TMOUT': '86400', 11:32:18 INFO - 'USER': 'cltbld', 11:32:18 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1472494767.395345-317815114', 11:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:18 INFO - '_': '/tools/buildbot/bin/python'} 11:32:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:19 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)) 11:32:19 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)) 11:32:19 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)) 11:32:19 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)) 11:32:19 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)) 11:32:19 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)) 11:32:19 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)) 11:32:19 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)) 11:32:19 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)) 11:32:19 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)) 11:32:19 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)) 11:32:19 INFO - Cleaning up... 11:32:19 INFO - Return code: 0 11:32:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:32:19 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')]} 11:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:19 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')]} 11:32:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x7f840907ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf8f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105e230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1058090>, '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 0x105b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105be40>, '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': '20e666a3d4cfbb71505a330e000001b4-1472494767.395345-317815114', '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 11:32:19 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 11:32:19 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 11:32:19 INFO - Using env: {'DISPLAY': ':0', 11:32:19 INFO - 'HOME': '/home/cltbld', 11:32:19 INFO - 'LANG': 'en_US.UTF-8', 11:32:19 INFO - 'LANGUAGE': 'en_US:en', 11:32:19 INFO - 'LOGNAME': 'cltbld', 11:32:19 INFO - 'MAIL': '/var/mail/cltbld', 11:32:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:19 INFO - 'MOZ_NO_REMOTE': '1', 11:32:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:19 INFO - 'NO_EM_RESTART': '1', 11:32:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:19 INFO - 'PWD': '/builds/slave/test', 11:32:19 INFO - 'SHELL': '/bin/bash', 11:32:19 INFO - 'SHLVL': '1', 11:32:19 INFO - 'TERM': 'linux', 11:32:19 INFO - 'TMOUT': '86400', 11:32:19 INFO - 'USER': 'cltbld', 11:32:19 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1472494767.395345-317815114', 11:32:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:19 INFO - '_': '/tools/buildbot/bin/python'} 11:32:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:32:19 INFO - Cleaning up... 11:32:19 INFO - Return code: 0 11:32:19 INFO - Running post-action listener: _resource_record_post_action 11:32:19 INFO - Running post-action listener: _start_resource_monitoring 11:32:19 INFO - Starting resource monitoring. 11:32:19 INFO - [mozharness: 2016-08-29 18:32:19.295268Z] Finished create-virtualenv step (success) 11:32:19 INFO - [mozharness: 2016-08-29 18:32:19.295725Z] Running install step. 11:32:19 INFO - Running pre-action listener: _resource_record_pre_action 11:32:19 INFO - Running main action method: install 11:32:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:32:19 INFO - Reading from file tmpfile_stdout 11:32:19 INFO - Detecting whether we're running mozinstall >=1.0... 11:32:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:32:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:32:19 INFO - Reading from file tmpfile_stdout 11:32:19 INFO - Output received: 11:32:19 INFO - Usage: mozinstall [options] installer 11:32:19 INFO - Options: 11:32:19 INFO - -h, --help show this help message and exit 11:32:19 INFO - -d DEST, --destination=DEST 11:32:19 INFO - Directory to install application into. [default: 11:32:19 INFO - "/builds/slave/test"] 11:32:19 INFO - --app=APP Application being installed. [default: firefox] 11:32:19 INFO - mkdir: /builds/slave/test/build/application 11:32:19 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'] 11:32:19 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 11:32:35 INFO - Reading from file tmpfile_stdout 11:32:35 INFO - Output received: 11:32:35 INFO - /builds/slave/test/build/application/firefox/firefox 11:32:35 INFO - Running post-action listener: _resource_record_post_action 11:32:35 INFO - [mozharness: 2016-08-29 18:32:35.736372Z] Finished install step (success) 11:32:35 INFO - [mozharness: 2016-08-29 18:32:35.736657Z] Running run-tests step. 11:32:35 INFO - Running pre-action listener: _resource_record_pre_action 11:32:35 INFO - Running main action method: run_tests 11:32:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:32:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:32:35 INFO - Python 2.7.3 11:32:35 INFO - Return code: 0 11:32:35 INFO - grabbing minidump binary from tooltool 11:32:35 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')]} 11:32:35 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 0x1058090>, '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 0x105b9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105be40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:32:35 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 11:32:35 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 11:32:35 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 11:32:35 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:32:35 INFO - Return code: 0 11:32:35 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:32:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:32:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:32:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:32:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:32:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 11:32:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 11:32:35 INFO - Using env: {'DISPLAY': ':0', 11:32:35 INFO - 'HOME': '/home/cltbld', 11:32:35 INFO - 'LANG': 'en_US.UTF-8', 11:32:35 INFO - 'LANGUAGE': 'en_US:en', 11:32:35 INFO - 'LOGNAME': 'cltbld', 11:32:35 INFO - 'MAIL': '/var/mail/cltbld', 11:32:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:32:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:32:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:35 INFO - 'MOZ_NO_REMOTE': '1', 11:32:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:32:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:35 INFO - 'NO_EM_RESTART': '1', 11:32:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:35 INFO - 'PWD': '/builds/slave/test', 11:32:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:32:35 INFO - 'SHELL': '/bin/bash', 11:32:35 INFO - 'SHLVL': '1', 11:32:35 INFO - 'TERM': 'linux', 11:32:35 INFO - 'TMOUT': '86400', 11:32:35 INFO - 'USER': 'cltbld', 11:32:35 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1472494767.395345-317815114', 11:32:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:35 INFO - '_': '/tools/buildbot/bin/python'} 11:32:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 11:32:36 INFO - mozversion application_buildid: 20160829095731 11:32:36 INFO - mozversion application_changeset: 2ec2538353807a17b8b23f2440c9a52ec3f3ccc5 11:32:36 INFO - mozversion application_display_name: Nightly 11:32:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:32:36 INFO - mozversion application_name: Firefox 11:32:36 INFO - mozversion application_remotingname: firefox 11:32:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:32:36 INFO - mozversion application_vendor: Mozilla 11:32:36 INFO - mozversion application_version: 51.0a1 11:32:36 INFO - mozversion platform_buildid: 20160829095731 11:32:36 INFO - mozversion platform_changeset: 2ec2538353807a17b8b23f2440c9a52ec3f3ccc5 11:32:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:32:36 INFO - mozversion platform_version: 51.0a1 11:32:36 INFO - using testdate: 1472495556 11:32:36 INFO - actual date: 1472495556 11:32:36 INFO - starting webserver on 'localhost:53143' 11:32:36 INFO - SUITE-START | Running 2 tests 11:32:36 INFO - TEST-START | dromaeo_css 11:32:36 INFO - operating with platform_type : linux_ 11:32:36 INFO - Initialising browser for dromaeo_css test... 11:32:36 INFO - TEST-INFO | started process 22277 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwlu0mJ/profile http://localhost:53143/getInfo.html) 11:32:40 INFO - PROCESS | 22277 | __metrics Screen width/height:1600/1200 11:32:40 INFO - PROCESS | 22277 | colorDepth:24 11:32:40 INFO - PROCESS | 22277 | Browser inner width/height: 1024/697 11:32:40 INFO - PROCESS | 22277 | __metrics 11:32:41 INFO - PROCESS | 22277 | 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" 11:32:41 INFO - PROCESS | 22277 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:32:41 INFO - PROCESS | 22277 | console.error: PushService: 11:32:41 INFO - PROCESS | 22277 | stateChangeProcessEnqueue: Error transitioning state 11:32:41 INFO - PROCESS | 22277 | UnknownError 11:32:42 INFO - TEST-INFO | 22277: exit 0 11:32:42 INFO - Browser initialized. 11:32:42 INFO - Running cycle 1/1 for dromaeo_css test... 11:32:42 INFO - TEST-INFO | started process 22359 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwlu0mJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:32:54 INFO - PROCESS | 22359 | RSS: Main: 182243328 11:32:54 INFO - PROCESS | 22359 | 11:33:45 INFO - PROCESS | 22359 | 1472495625328 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] 11:35:58 INFO - PROCESS | 22359 | Cycle 1(1): loaded http://localhost:53143/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53143/tests/dromaeo/cssquery-ext.html) 11:35:59 INFO - PROCESS | 22359 | RSS: Main: 286081024 11:35:59 INFO - PROCESS | 22359 | 11:39:02 INFO - PROCESS | 22359 | Cycle 1(1): loaded http://localhost:53143/tests/dromaeo/cssquery-ext.html (next: http://localhost:53143/tests/dromaeo/cssquery-jquery.html) 11:39:02 INFO - PROCESS | 22359 | RSS: Main: 280035328 11:39:02 INFO - PROCESS | 22359 | 11:42:04 INFO - PROCESS | 22359 | Cycle 1(1): loaded http://localhost:53143/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53143/tests/dromaeo/cssquery-mootools.html) 11:42:05 INFO - PROCESS | 22359 | RSS: Main: 220913664 11:42:05 INFO - PROCESS | 22359 | 11:45:07 INFO - PROCESS | 22359 | Cycle 1(1): loaded http://localhost:53143/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53143/tests/dromaeo/cssquery-prototype.html) 11:45:08 INFO - PROCESS | 22359 | RSS: Main: 218902528 11:45:08 INFO - PROCESS | 22359 | 11:48:11 INFO - PROCESS | 22359 | Cycle 1(1): loaded http://localhost:53143/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53143/tests/dromaeo/cssquery-yui.html) 11:48:12 INFO - PROCESS | 22359 | RSS: Main: 218693632 11:48:12 INFO - PROCESS | 22359 | 11:51:15 INFO - PROCESS | 22359 | Cycle 1(1): loaded http://localhost:53143/tests/dromaeo/cssquery-yui.html (next: http://localhost:53143/tests/dromaeo/cssquery-dojo.html) 11:51:15 INFO - PROCESS | 22359 | RSS: Main: 310423552 11:51:15 INFO - PROCESS | 22359 | 11:51:15 INFO - PROCESS | 22359 | __start_tp_report 11:51:15 INFO - PROCESS | 22359 | _x_x_mozilla_page_load 11:51:15 INFO - PROCESS | 22359 | _x_x_mozilla_page_load_details 11:51:15 INFO - PROCESS | 22359 | |i|pagename|runs| 11:51:15 INFO - PROCESS | 22359 | |0;dojo.html;2575.729548397418;2579.2391244582846;2590.7538783815544;2615.0324379979406;2625.251803236078;4499.492669955564;4556.339330797033;4591.977040114794;4603.654725895559;4651.4650815156265;4608.10142022305;4655.301704744282;4664.533546645333;4667.649926255527;4689.132510485562;4277.0376665250305;4356.651467882578;4377.518472967987;4381.101874115799;4381.474223093233;4289.227938970984;4307.030918043447;4326;4326.545712700168;4388.583084606973;4272.1028583997395;4491.214037543416;4496.707713998596;4497.685162038659;4501.144782491317;4386.473623165209;4397.780110994469;4420.557944205586;4424.269995450747;4502.819887204508;4196.055887425336;4229.984803647102;4234.9364759528635;4245.97877010613;4289.313709806447;4557.9772101139615;4575.931361029588;4577.198990176739;4642.466116396624;4689.2966055091665;4972.0801651694555;4978.402591688984;4989.900201995976;4991.975040124812;5044.621653376012;4878.585320247747;4930.03864246472;4992.201247800371;5008.273800298936;5085.5931525478245;4638.397008388922;4687.67186296956;4689.812407503729;4697.10754956564;4697.459792123881;5127.179651255781;5130.102232109366;5137.460443037916;5158.3552055993005;5217.426083130853;4800.0639875224;4866.367372241586;4920.753962301942;4927.187014142698;4932.654714169974;4963.305137280783;4998.375203099613;5004.774785134678;5053.9241911371355;5076.263941728503;4927.802887884444;4959.82640607577;4968.4286307075145;4973.179425394769;5019.121653710586;4776.996830665599;4815.109204797123;4945.307656928033;4958.9504104959215;5019.347484826949;4235.597618226264;4249.46881639795;4250.086231460189;4250.574942505725;4253.128108737701;3676.816159192083;3703.6481534254203;3713.5543734751463;3749.49381833449;3798.4682144499793;4307.418498502662;4310.504292006397;4310.590493903074;4358.564143585616;4371.191329604034;4816.686915350491;4994.650374473752;4995.500449955048;5000;5002.324686167393;4297.376880352332;4335.371371151228;4338.067315527113;4354.477462704495;4403.075354175659;4541.2733962565835;4546.363509108727;4557.72653640776;4557.931631025537;4614.054118905617;4613.976930115328;4745.14587374269;4747.810087596457;4752.500987396274;4786.880327991758;4950.2079667253065;4976.2286845539;4995.400551933792;5017.4731653175895;5022.296878437095;4708.246680531099;4736.881577960578;4737.829848129995;4740.2178640523925;4796.544328288807;4813.855584332476;4944.505549445027;4951.752412379438;4958.206686930074;5013.899722005466;4909.877253068702;4944.3572335596145;4949.406071271471;4953.133201689762;5031.9245211322595;4827.734474603931;4836.516348365135;4848.927266090941;4871.561559459666;4903;4722;4829.5653391194965;4840.394950631171;4846.854594362175;4906.705597664151;4752.809887604595;4789.95210047909;4799.136155491905;4832.589229915497;4867.464578896248;4896.877578060577;4901.779419926183;4926.605871530341;4927.482614325444;4984.651074424755;4686.390769199982;4789.425268967607;4807.326974223542;4810.903781924272;4871.3667223260745 11:51:15 INFO - PROCESS | 22359 | |1;ext.html;553.9999999999999;568.5025602597727;575.6172145523229;576.7779404929101;590.743026783349;28311;38967.22065558687;40639.39040914385;40659.79670101653;44429.555704442944;41200.58799412005;41813;41823.37264941028;41837.37243941343;41863.79068104663;7731.961340193306;7879.606019698992;7882.960585197095;7886.2113788621255;7888.171741967097;7501.28737769911;7567.545947243156;7581;7592;7597.430192735539;7790.8441831163345;7867.48861324015;7867.881981770278;7867.960660196691;7874;7750.418718596128;7753.922460775405;7786.143524212361;7816.960915195445;7834.647440865175;7731.806704832368;7770.883436748453;7785.3771698264;7790.065192176919;7794.415418843552;38592.61407385946;38819.41770873439;38852.41721374181;38878.805605971786;38928;2888.734831897779;2932.736053755151;2934.618499595039;2951.557266410034;2978;25584.74415255842;25624.615630765555;25861;25893.611595826078;26159.869200653873;3480.686738193575;3493.7205023598053;3545.3618348697223;3610.295992281506;3773.52830896138;248899;249485;250068;250598;250693;53296.20055699167;53937;53937;53953;53953.46046539563;32484.350312993607;33174;33339.83330083334;55497.44502554923;55698.16452753212;12627.179233349803;12727.554535591209;12743.681407964876;12754.362281886055;12759;9448.527573621428;9513.381630194015;9523.28575356851;9545.665901693408;9560.043995600385;18012.639747205245;18065.7290140648;18114.547136321435;18279.268829246947;18310.17604207814;6655.234648015444;6690.933090669031;6710.07460635524;6771.762988295484;6983.301669832976;775.7362496751132;837.5770236030766;865.7532603208056;879.5514287713185;930.8836395450569;24551.26346209581;24701;25287.22989390725;25384.746152538606;25616.487670246865;757.5454727163658;939.6899023322287;949.4398304999945;961.3174646001418;995.8157740817827;13861.23763193034;14762.892783041314;14936.25318734059;15110.320035598425;15227.619309517351;181476;181844;183328;183388;359087;48490.757546212044;48915.75542122267;48981;49011;49137.50862491401;1060.931039482431;1100.02098132662;1122.6463663945995;1159.2754528419737;1167.7430965187646;26383.868080659475;29161.125166245045;29844.253893652833;29867.402651947275;30138.397232055675;41847;42446;42462;42492.36261456019;42510.149797003265;299498;302959;303576;304121;304809;21942.341729748132;22650.660240096084;22774.20290289832;23581.410464738517;23680.881595591913;41245.38131927964;41621;41621.37567936544;41760.37359439672;41981.37027944522;35249.06130162763;35330.82334588311;35586.64413355937;35880;36007.27985440329;35212;35405.82297088498;35573.64426355807;35956;36092.819535902156;35303.47044794279;35592.46611300884;35648.64351356453;35694.64305357017;35923.46114808332;30749;31842;32468;32574.674253258112;33269;25135.43551176444;25138.37154071163;25346.493070138862;25352.74647253504;25963.350916227246 11:51:15 INFO - PROCESS | 22359 | |2;jquery.html;332.4663914417359;346.39726875237096;353.7152592163308;354.0899887289666;373.4472979989615;12742.362881855905;15647.295871685774;16325.755113673304;16435.753463698038;17185.484435466926;15422.228888555583;15590.376384944588;15676.608084797886;15886.443974460895;15892.84107158928;4874.512548745124;4887.242477415988;5082.161443361841;5096.133657278253;5096.617753668471;4953.083679519283;5078.771455284521;5086.898262034757;5090.643654944155;5090.796368145288;4998.475160108191;5050.671706339094;5051.343325367716;5057.924131138036;5058.620603454756;5179.896402071956;5358.4641535846295;5400.351957765054;5466.34403871534;5477.424870388591;4713.198756211452;5319.308489896327;5326.254324394549;5326.280952071459;5335.279737235463;11819.468123934443;13595.116317439433;19297.22811087555;19945.10247038887;19970.30103946355;1792.09499202903;1818.5726354306728;1870.51366644672;2077.3248694174454;2283.7602051784656;8208.671653133868;8969.237614802749;9216.400933939272;9387.451070573346;9464.148226659565;1629.771831943529;1705.84647381735;1715.1252861040834;1725.7842769653794;1742.712452445345;64152.3584764151;70232.648836756;70250.64874675593;71458.64270678665;74394.25605743927;7945.721899733481;8499.150084991452;8553.059163492011;9273.953630231807;9552.761180970392;10926.508307126198;11021.338719676845;11038.944805276084;11074.224804263786;11077.889221107847;6348.936595606447;6418.711157997808;6494.480441564663;6528.902066469007;6560;6417.96791016042;6424.807255782334;6580.40776330123;6592.538522303488;6623.138991931018;3391.629549535276;3459.238967427162;3477.982610086933;3646.462087226944;3694.519712437366;1629.714799910011;1643.4001589419777;1652.702513547573;1685.502776680882;1685.612309168898;774.44240147094;817.7097130518699;875.7898104454885;888.7778055486128;946.8958414574391;16313.673726525403;16744.99530028178;17067.573310667332;17491;17847.46457606274;818.3453237410048;847.9364047696324;855.8930133733284;890.3767362846033;912.748994026648;8973.775655608531;9251.814963700688;9315.953420232856;9840.803183936281;9868.30921835479;337662;342140;361786;368262;371928;78473;79549.20450795419;79592;80772.59613702011;82024;846.090452763282;869.0397111192168;871.8561437362764;875.3916028360355;877.9604917778715;14443.638909027359;14571.198584077978;14623;14711.485098021518;15092;37203.07527837829;37509;37858.24283514259;38430;39604.405933910435;49853;49976.50023499864;50237.246441302676;50685.493145068074;53185.46814531805;7590.1650818408825;7740.806479837824;7753.689852405841;7785.493942893694;7788.688452461838;10399.076170908103;11409.885901140882;11671.35807530594;11726.589569365031;12057.758844823229;10107.444090574794;10152.238582106223;10276.897231027595;10762.515686793957;10877.891221088004;10002.24983126254;10227.897721022695;10476.895231047896;10503.212259080447;10511.94744026275;10536.10443112344;10571.312864663772;10673.8932610676;11076.224664273423;11089.001989820956;7494.362979146834;7516.436267279866;7651.770446886602;7681.577513236825;7790.14387878004;10064;10368.481575921023;10432.74807023162;10596.258261921592;11004.724881877697 11:51:15 INFO - PROCESS | 22359 | |3;mootools.html;1199.6161228406902;1333.1201407071333;1375.4910683047274;1432.9570112896618;1690.8985460872357;7310.34206921377;7637.618119094044;7675.04061992251;7927.445078844469;7947.761567152995;7757.185495522974;7840.215978402157;7866.056073271216;7883.763487095382;7884.093329267136;2162.372911855564;2168.902399392031;2186.180182431588;2188.037263604017;2188.84678072535;2112.9366119016454;2168.111074459472;2205.5588882223537;2211.0492488230057;2211.469247380625;2125.298651445027;2154.806067453929;2161.7513985891665;2168.1977668262684;2205.44863784054;2123.957520849582;2127.117246342766;2127.2448280860303;2133.786621337854;2135.1459416233474;2068.565601223745;2099.8215151712125;2105.3473423238693;2105.610462064523;2146.334636262748;7494.21310762373;7715.151333353327;7751.379889608874;7848;7850.803729906798;4313.82744690212;4428.003699167693;4443.688941774077;4445.088756804847;4450.35469856869;2803.8738256778493;2902.6226590543306;2947.7347038766397;2947.882084716609;2959.3785305085958;928.331601247101;940.3276657190141;944.4946953379978;952.066974365126;965.9758506037335;10235.897641023568;10258.589656413735;10311.84532232017;10327;10390.532426040847;3938.822752976123;4030.8992275193355;4049.9595004049584;4055.0876052887866;4280.336547835091;8126.553039582762;8274.048484424367;8276.917230827736;8278.793030174173;8292.12932642076;4465.263231566755;4469.4636643602325;4478.9552104478535;4483.08096840147;4489.775511224491;3588.4437912123662;3952.782596957195;4103.8974025649595;4177.582241775798;4180.414741936132;3471.89584312471;3596.352656521799;3619.420892657215;3627.619099994515;3782.394816829294;1189.8096304591397;1213.4721396192508;1215.7203843115956;1229.674136353867;1229.9016078713682;703.2440126863642;791.2364568191723;798.2057852436747;806.4234072638092;816.8611336072881;4872.098661747588;5033.0688822567945;5034.823781167642;5086.491350864884;5385.703786291713;404.3873531599629;418.76549132485906;426.5585119401405;428.98972918776457;429.9204647140289;3508.9824550877083;3532.911677208039;3567.1438854674693;3570.892873213808;3629.909252268714;8739.825203496022;8942.50816205115;9024.548772561346;9038.548072596344;9058.048904865025;8993.865092023625;9004.954975225082;9006.909930900738;9008.684696035607;9038;6732.225794033651;6793.354631310018;6874.381305682413;6891.448684105259;6932.896006559906;4760.714607056007;4793.185158523129;4807.326974223542;4875.7074575525585;4939.431965324034;8134.023917129983;8245.093039765501;8275.420720549504;8280.792980175544;8318.875216871631;8365;8377.204165604258;8723.781905452415;8730.432521886058;9144.954275228582;6133.907991380043;6542.149520562297;6571.211454625475;6703.128593283037;6717.496187785838;7310.853782924205;7569.1673915868105;7632.122305934889;7637.427192960439;7646.388288936761;6566.770163044271;6577.375149360803;6645.235797883305;6713.899291510534;6718.8320291993095;6381.712822923072;6510.576812507172;6550.672466376567;6726.125603671687;6764.28974957642;6146.969265153645;6184.690765461619;6185.41238582334;6200.534959877937;6275.278342990615;4435.955640443554;4454.443194600675;4567.794449249858;4575.6339492839825;4638.953610463852;4409.757463339419;4465;4589.977050114728;4590.288505281686;4689.507601701772 11:51:15 INFO - PROCESS | 22359 | |4;prototype.html;288.9682134965153;298.37341582676385;303.7645824486023;307.2135333546122;307.97074277943585;4645.465771436286;4646.233371493704;4663.976680116594;4670.743109128996;4708.52914708529;4616.630669546436;4629.259318509039;4657.231556793134;4676.508966558505;4676.859694209179;3487.8256087195728;3522.7357948153863;3627.6009638939695;3679.7240206984447;3718.293524230401;3679.5584529856455;3702.944455833151;3745.8127093645344;3747.6627103560672;3763.435484677293;3654.2143439160577;3658.5426821647293;3682.2451397463456;3701.8889433317045;3723.869664561741;3450.9654903450896;3528.3416794106856;3586.9282614347567;3614.5120408744747;3623.47813918155;3200.1199670090678;3206.118317462693;3207.631122420905;3210.839458027089;3225.3388055448577;4516.954830451687;4530.909381812378;4532.753492789477;4564.383808185886;4573.233193917665;3932.88201353957;4170.91658166835;4190.622843944059;4191.706580539363;4192.643625291854;4856.150173719585;4859.80560777572;4866.296796121364;4869.561739443432;4870.464248932614;3536.275063611979;3540.805255710935;3548.449990251515;3553.893383198508;3556.3776339140804;5028.773705183312;5134.460881607415;5173.2669555698885;5175.81884634036;5184.792608295664;3575.5888072871953;3597.1366871950545;3607.494950706903;3621.167131559756;3626.1325417410053;3657.5552656700456;3673.8530458781884;3674.0814796300924;3677.4483827425565;3679.392900171495;4124.711270211116;4139;4153.273177193979;4188.958110418856;4196.265653510623;4818.590419814285;4863.902721945541;4924.384451943507;4934.703917764946;4944.851654450372;1250.1374051904156;1260.036072404611;1262.4066688656317;1263.4946021591436;1269.079917060124;761.2425636491727;787.1656044592636;787.6180052674448;792.1880072925297;799.1209669363769;4313;4410.1400226956075;4416.183006143874;4421.712588681726;4428.9813342930665;4994.725290109079;5001.999200319901;5012.172991456368;5023.673461225008;5065.442801291855;4377.868663940087;4385.101054283928;4394.890127746768;4407.889802754957;4452.688311818141;2533.518631460017;2668.9733102669115;2675.3579141006016;2703.4998525272886;2706.134037108146;4858.441279252931;4860.392450943632;4863.148948933993;4865.153884977257;4895.632827537949;4974.253861920669;5200.72354416715;5213.504717051874;5217.399999000164;5217.686938783685;4815;4817.710937343771;4828.493008234155;4832.9275060874115;4834.081524510332;5060.722674796283;5076.492350764894;5077.1876499759865;5085.694858308513;5097.949020509747;4684.414448193976;4969.180085285887;4992.72540010303;5002.574266334077;5011.924821127759;4811.254255590389;4839.7096174229655;4841.281345122431;4841.346418233635;4846.345743324606;3614.4397618369194;3621.2576421833987;3629.528161339009;3653.1049892775377;3667.339878821838;5016.2224855147515;5111.974440127776;5136;5150.356205474316;5153.896922061613;4866.221404575251;4876.4392094909535;4894.730789806595;4931.72875491837;4935.827246046371;4856.781444835062;4898.706077635354;4904.2643603459765;4907.877303067452;4951.282064100757;4851.708897466164;4852.490488498798;4863.197572400514;4883.340748998982;4898.24077268024;4700.754300110405;4703.74129422885;4799.784009719641;4886.560209581155;4910.484399138039;4788.281757736368;4808.422989241313;4812.799488340214;4815.7847390200905;4822.9758851205515 11:51:15 INFO - PROCESS | 22359 | |5;yui.html;597.0089651179044;614.6895817612105;634.9714262858168;685.4036987820597;695.1206723494778;10833.29583577068;11530.711732206699;11598;11603.941980290097;11611.419429028558;12534.373281335942;12661.620151395473;12667.176633518815;12698.93650531746;12711.36443177842;601.2754630670054;712.8752468318049;714.8034290570083;731.0386841303668;731.5537522111508;741.6736635880222;741.9517731347472;743.1156923261302;744.2185705009745;745.2361329637112;794.8688466403037;795.0896223823719;795.5187111797366;795.9482633628825;796.0845028217539;634.7461015593731;651.7034749189107;654.8297442664893;655.8688262347549;793.1790596732354;553.883684426271;571.2801869644237;571.8456016875462;577.757341916392;578.3089208395968;11239;11287.49206285719;11298.378589177591;11315.377654229014;11321.886781132249;10915;11471.13966452511;11492.425378731114;11570.479328430241;12106.213096148722;9150.40522366044;9331.953340233324;9356.532173391302;9404.24766018717;9534.570944307523;4020.7386519876113;4038.51537815464;4038.676905847525;4090.6931980101613;4097.959020409788;61456.692716536134;64747;65675.34324656788;66277.00584491284;66601.33398666;8985.191332780081;9175.036621154683;9201.76995575116;9305.022972587916;9463.101005404476;16937.491875243762;16958.830411695973;16967.49097527076;16973.321067157423;17048.74426883573;6275.497960163176;6305.558610897285;6374.107624932513;6617.338266173344;6639.502037347122;3516.5406356362337;3609.6029436761937;3619.873304434332;3739.476473293741;3777.527809023872;2643.722409147012;2732.740389662979;2736.3569561153113;2738.548139556951;2746.7115952825066;456.4385805459304;459.3362591055959;460.930860370947;468.3606876613466;470.9905801883943;426.6330955378372;496.0327361644807;499.99004003904827;506.70104638263604;514.1824499046534;7027.43780497559;7207.603581803051;7359.190489046201;7419.59192244421;7421.888671669929;418.7738621144609;471.03908027623265;472.76361819090454;490.55359622743134;491.0645220854278;3513.314903593826;3693.279810436939;3723.832427540767;3786.2427514497213;3827.559830619459;61170.694146528986;61468.077978830355;76580.61709691415;98669.50665246628;99225;84125;85331.49914770194;85398.59510536735;86120.56939715262;88399.55800220958;72605.27394726091;77455;79030;79203.60398197972;79551.60224198842;6758.7296508139125;6774.390304872585;6889.965550172217;7058.894116588152;7091.468139889425;44126.33810492781;44244.778776105915;46738.532614673415;46841;47022;60989;66081.66959165173;66813;67053.66473167604;69453;9319;9328.160465558132;9405.24758019343;9524.761880953032;9889.703308900744;10470.371777693363;10585.8941410588;10782.460876955964;11089.39008354516;11124.721881952692;10077.244206684381;10091.848622270525;10243.692689219335;10831.837522437327;11081.947215014561;9725.513724313898;9860.753481163028;9899.950500247453;9913.801723965336;10414.166866650497;9630.229581633592;9676.225901927688;9830.75423114428;9931.453770042717;10426.895731042592;7973.681052757825;8081.9191808083515;8178.67285308581;8303.4602750821;8405.285550728257;8051.1948805121365;8324.209200125979;8412.537310447984;8490.957545212234;8675.696350627697 11:51:15 INFO - PROCESS | 22359 | __end_tp_report 11:51:15 INFO - PROCESS | 22359 | __start_cc_report 11:51:15 INFO - PROCESS | 22359 | _x_x_mozilla_cycle_collect,989 11:51:15 INFO - PROCESS | 22359 | __end_cc_report 11:51:15 INFO - PROCESS | 22359 | __startTimestamp1472496675340__endTimestamp 11:51:15 INFO - PROCESS | 22359 | 11:51:15 INFO - PROCESS | 22359 | ------- Summary: start ------- 11:51:15 INFO - PROCESS | 22359 | Number of tests: 6 11:51:15 INFO - PROCESS | 22359 | 11:51:15 INFO - PROCESS | 22359 | [#0] dojo.html Cycles:165 Average:4623.91 Median:4745.15 stddev:474.28 (10.0%) stddev-sans-first:447.69 11:51:15 INFO - PROCESS | 22359 | Values: 2575.7 2579.2 2590.8 2615.0 2625.3 4499.5 4556.3 4592.0 4603.7 4651.5 4608.1 4655.3 4664.5 4667.6 4689.1 4277.0 4356.7 4377.5 4381.1 4381.5 4289.2 4307.0 4326.0 4326.5 4388.6 4272.1 4491.2 4496.7 4497.7 4501.1 4386.5 4397.8 4420.6 4424.3 4502.8 4196.1 4230.0 4234.9 4246.0 4289.3 4558.0 4575.9 4577.2 4642.5 4689.3 4972.1 4978.4 4989.9 4992.0 5044.6 4878.6 4930.0 4992.2 5008.3 5085.6 4638.4 4687.7 4689.8 4697.1 4697.5 5127.2 5130.1 5137.5 5158.4 5217.4 4800.1 4866.4 4920.8 4927.2 4932.7 4963.3 4998.4 5004.8 5053.9 5076.3 4927.8 4959.8 4968.4 4973.2 5019.1 4777.0 4815.1 4945.3 4959.0 5019.3 4235.6 4249.5 4250.1 4250.6 4253.1 3676.8 3703.6 3713.6 3749.5 3798.5 4307.4 4310.5 4310.6 4358.6 4371.2 4816.7 4994.7 4995.5 5000.0 5002.3 4297.4 4335.4 4338.1 4354.5 4403.1 4541.3 4546.4 4557.7 4557.9 4614.1 4614.0 4745.1 4747.8 4752.5 4786.9 4950.2 4976.2 4995.4 5017.5 5022.3 4708.2 4736.9 4737.8 4740.2 4796.5 4813.9 4944.5 4951.8 4958.2 5013.9 4909.9 4944.4 4949.4 4953.1 5031.9 4827.7 4836.5 4848.9 4871.6 4903.0 4722.0 4829.6 4840.4 4846.9 4906.7 4752.8 4790.0 4799.1 4832.6 4867.5 4896.9 4901.8 4926.6 4927.5 4984.7 4686.4 4789.4 4807.3 4810.9 4871.4 11:51:15 INFO - PROCESS | 22359 | 11:51:15 INFO - PROCESS | 22359 | [#1] ext.html Cycles:180 Average:41578.16 Median:36050.05 stddev:68766.20 (190.8%) stddev-sans-first:68890.12 11:51:15 INFO - PROCESS | 22359 | Values: 554.0 568.5 575.6 576.8 590.7 28311.0 38967.2 40639.4 40659.8 44429.6 41200.6 41813.0 41823.4 41837.4 41863.8 7732.0 7879.6 7883.0 7886.2 7888.2 7501.3 7567.5 7581.0 7592.0 7597.4 7790.8 7867.5 7867.9 7868.0 7874.0 7750.4 7753.9 7786.1 7817.0 7834.6 7731.8 7770.9 7785.4 7790.1 7794.4 38592.6 38819.4 38852.4 38878.8 38928.0 2888.7 2932.7 2934.6 2951.6 2978.0 25584.7 25624.6 25861.0 25893.6 26159.9 3480.7 3493.7 3545.4 3610.3 3773.5 248899.0 249485.0 250068.0 250598.0 250693.0 53296.2 53937.0 53937.0 53953.0 53953.5 32484.4 33174.0 33339.8 55497.4 55698.2 12627.2 12727.6 12743.7 12754.4 12759.0 9448.5 9513.4 9523.3 9545.7 9560.0 18012.6 18065.7 18114.5 18279.3 18310.2 6655.2 6690.9 6710.1 6771.8 6983.3 775.7 837.6 865.8 879.6 930.9 24551.3 24701.0 25287.2 25384.7 25616.5 757.5 939.7 949.4 961.3 995.8 13861.2 14762.9 14936.3 15110.3 15227.6 181476.0 181844.0 183328.0 183388.0 359087.0 48490.8 48915.8 48981.0 49011.0 49137.5 1060.9 1100.0 1122.6 1159.3 1167.7 26383.9 29161.1 29844.3 29867.4 30138.4 41847.0 42446.0 42462.0 42492.4 42510.1 299498.0 302959.0 303576.0 304121.0 304809.0 21942.3 22650.7 22774.2 23581.4 23680.9 41245.4 41621.0 41621.4 41760.4 41981.4 35249.1 35330.8 35586.6 35880.0 36007.3 35212.0 35405.8 35573.6 35956.0 36092.8 35303.5 35592.5 35648.6 35694.6 35923.5 30749.0 31842.0 32468.0 32574.7 33269.0 25135.4 25138.4 25346.5 25352.7 25963.4 11:51:15 INFO - PROCESS | 22359 | 11:51:15 INFO - PROCESS | 22359 | [#2] jquery.html Cycles:180 Average:23143.85 Median:4793.86 stddev:59297.19 (1236.9%) stddev-sans-first:59438.80 11:51:15 INFO - PROCESS | 22359 | Values: 332.5 346.4 353.7 354.1 373.4 12742.4 15647.3 16325.8 16435.8 17185.5 15422.2 15590.4 15676.6 15886.4 15892.8 4874.5 4887.2 5082.2 5096.1 5096.6 4953.1 5078.8 5086.9 5090.6 5090.8 4998.5 5050.7 5051.3 5057.9 5058.6 5179.9 5358.5 5400.4 5466.3 5477.4 4713.2 5319.3 5326.3 5326.3 5335.3 11819.5 13595.1 19297.2 19945.1 19970.3 1792.1 1818.6 1870.5 2077.3 2283.8 8208.7 8969.2 9216.4 9387.5 9464.1 1629.8 1705.8 1715.1 1725.8 1742.7 64152.4 70232.6 70250.6 71458.6 74394.3 7945.7 8499.2 8553.1 9274.0 9552.8 10926.5 11021.3 11038.9 11074.2 11077.9 6348.9 6418.7 6494.5 6528.9 6560.0 6418.0 6424.8 6580.4 6592.5 6623.1 3391.6 3459.2 3478.0 3646.5 3694.5 1629.7 1643.4 1652.7 1685.5 1685.6 774.4 817.7 875.8 888.8 946.9 16313.7 16745.0 17067.6 17491.0 17847.5 818.3 847.9 855.9 890.4 912.7 8973.8 9251.8 9316.0 9840.8 9868.3 337662.0 342140.0 361786.0 368262.0 371928.0 78473.0 79549.2 79592.0 80772.6 82024.0 846.1 869.0 871.9 875.4 878.0 14443.6 14571.2 14623.0 14711.5 15092.0 37203.1 37509.0 37858.2 38430.0 39604.4 49853.0 49976.5 50237.2 50685.5 53185.5 7590.2 7740.8 7753.7 7785.5 7788.7 10399.1 11409.9 11671.4 11726.6 12057.8 10107.4 10152.2 10276.9 10762.5 10877.9 10002.2 10227.9 10476.9 10503.2 10511.9 10536.1 10571.3 10673.9 11076.2 11089.0 7494.4 7516.4 7651.8 7681.6 7790.1 10064.0 10368.5 10432.7 10596.3 11004.7 11:51:15 INFO - PROCESS | 22359 | 11:51:15 INFO - PROCESS | 22359 | [#3] mootools.html Cycles:180 Average:4963.38 Median:4776.95 stddev:2751.01 (57.6%) stddev-sans-first:2744.18 11:51:15 INFO - PROCESS | 22359 | Values: 1199.6 1333.1 1375.5 1433.0 1690.9 7310.3 7637.6 7675.0 7927.4 7947.8 7757.2 7840.2 7866.1 7883.8 7884.1 2162.4 2168.9 2186.2 2188.0 2188.8 2112.9 2168.1 2205.6 2211.0 2211.5 2125.3 2154.8 2161.8 2168.2 2205.4 2124.0 2127.1 2127.2 2133.8 2135.1 2068.6 2099.8 2105.3 2105.6 2146.3 7494.2 7715.2 7751.4 7848.0 7850.8 4313.8 4428.0 4443.7 4445.1 4450.4 2803.9 2902.6 2947.7 2947.9 2959.4 928.3 940.3 944.5 952.1 966.0 10235.9 10258.6 10311.8 10327.0 10390.5 3938.8 4030.9 4050.0 4055.1 4280.3 8126.6 8274.0 8276.9 8278.8 8292.1 4465.3 4469.5 4479.0 4483.1 4489.8 3588.4 3952.8 4103.9 4177.6 4180.4 3471.9 3596.4 3619.4 3627.6 3782.4 1189.8 1213.5 1215.7 1229.7 1229.9 703.2 791.2 798.2 806.4 816.9 4872.1 5033.1 5034.8 5086.5 5385.7 404.4 418.8 426.6 429.0 429.9 3509.0 3532.9 3567.1 3570.9 3629.9 8739.8 8942.5 9024.5 9038.5 9058.0 8993.9 9005.0 9006.9 9008.7 9038.0 6732.2 6793.4 6874.4 6891.4 6932.9 4760.7 4793.2 4807.3 4875.7 4939.4 8134.0 8245.1 8275.4 8280.8 8318.9 8365.0 8377.2 8723.8 8730.4 9145.0 6133.9 6542.1 6571.2 6703.1 6717.5 7310.9 7569.2 7632.1 7637.4 7646.4 6566.8 6577.4 6645.2 6713.9 6718.8 6381.7 6510.6 6550.7 6726.1 6764.3 6147.0 6184.7 6185.4 6200.5 6275.3 4436.0 4454.4 4567.8 4575.6 4639.0 4409.8 4465.0 4590.0 4590.3 4689.5 11:51:15 INFO - PROCESS | 22359 | 11:51:15 INFO - PROCESS | 22359 | [#4] prototype.html Cycles:180 Average:4090.09 Median:4667.36 stddev:1190.24 (25.5%) stddev-sans-first:1158.88 11:51:15 INFO - PROCESS | 22359 | Values: 289.0 298.4 303.8 307.2 308.0 4645.5 4646.2 4664.0 4670.7 4708.5 4616.6 4629.3 4657.2 4676.5 4676.9 3487.8 3522.7 3627.6 3679.7 3718.3 3679.6 3702.9 3745.8 3747.7 3763.4 3654.2 3658.5 3682.2 3701.9 3723.9 3451.0 3528.3 3586.9 3614.5 3623.5 3200.1 3206.1 3207.6 3210.8 3225.3 4517.0 4530.9 4532.8 4564.4 4573.2 3932.9 4170.9 4190.6 4191.7 4192.6 4856.2 4859.8 4866.3 4869.6 4870.5 3536.3 3540.8 3548.4 3553.9 3556.4 5028.8 5134.5 5173.3 5175.8 5184.8 3575.6 3597.1 3607.5 3621.2 3626.1 3657.6 3673.9 3674.1 3677.4 3679.4 4124.7 4139.0 4153.3 4189.0 4196.3 4818.6 4863.9 4924.4 4934.7 4944.9 1250.1 1260.0 1262.4 1263.5 1269.1 761.2 787.2 787.6 792.2 799.1 4313.0 4410.1 4416.2 4421.7 4429.0 4994.7 5002.0 5012.2 5023.7 5065.4 4377.9 4385.1 4394.9 4407.9 4452.7 2533.5 2669.0 2675.4 2703.5 2706.1 4858.4 4860.4 4863.1 4865.2 4895.6 4974.3 5200.7 5213.5 5217.4 5217.7 4815.0 4817.7 4828.5 4832.9 4834.1 5060.7 5076.5 5077.2 5085.7 5097.9 4684.4 4969.2 4992.7 5002.6 5011.9 4811.3 4839.7 4841.3 4841.3 4846.3 3614.4 3621.3 3629.5 3653.1 3667.3 5016.2 5112.0 5136.0 5150.4 5153.9 4866.2 4876.4 4894.7 4931.7 4935.8 4856.8 4898.7 4904.3 4907.9 4951.3 4851.7 4852.5 4863.2 4883.3 4898.2 4700.8 4703.7 4799.8 4886.6 4910.5 4788.3 4808.4 4812.8 4815.8 4823.0 11:51:15 INFO - PROCESS | 22359 | 11:51:15 INFO - PROCESS | 22359 | [#5] yui.html Cycles:180 Average:16935.80 Median:3470.15 stddev:24915.34 (718.0%) stddev-sans-first:24955.03 11:51:15 INFO - PROCESS | 22359 | Values: 597.0 614.7 635.0 685.4 695.1 10833.3 11530.7 11598.0 11603.9 11611.4 12534.4 12661.6 12667.2 12698.9 12711.4 601.3 712.9 714.8 731.0 731.6 741.7 742.0 743.1 744.2 745.2 794.9 795.1 795.5 795.9 796.1 634.7 651.7 654.8 655.9 793.2 553.9 571.3 571.8 577.8 578.3 11239.0 11287.5 11298.4 11315.4 11321.9 10915.0 11471.1 11492.4 11570.5 12106.2 9150.4 9332.0 9356.5 9404.2 9534.6 4020.7 4038.5 4038.7 4090.7 4098.0 61456.7 64747.0 65675.3 66277.0 66601.3 8985.2 9175.0 9201.8 9305.0 9463.1 16937.5 16958.8 16967.5 16973.3 17048.7 6275.5 6305.6 6374.1 6617.3 6639.5 3516.5 3609.6 3619.9 3739.5 3777.5 2643.7 2732.7 2736.4 2738.5 2746.7 456.4 459.3 460.9 468.4 471.0 426.6 496.0 500.0 506.7 514.2 7027.4 7207.6 7359.2 7419.6 7421.9 418.8 471.0 472.8 490.6 491.1 3513.3 3693.3 3723.8 3786.2 3827.6 61170.7 61468.1 76580.6 98669.5 99225.0 84125.0 85331.5 85398.6 86120.6 88399.6 72605.3 77455.0 79030.0 79203.6 79551.6 6758.7 6774.4 6890.0 7058.9 7091.5 44126.3 44244.8 46738.5 46841.0 47022.0 60989.0 66081.7 66813.0 67053.7 69453.0 9319.0 9328.2 9405.2 9524.8 9889.7 10470.4 10585.9 10782.5 11089.4 11124.7 10077.2 10091.8 10243.7 10831.8 11081.9 9725.5 9860.8 9900.0 9913.8 10414.2 9630.2 9676.2 9830.8 9931.5 10426.9 7973.7 8081.9 8178.7 8303.5 8405.3 8051.2 8324.2 8412.5 8491.0 8675.7 11:51:15 INFO - PROCESS | 22359 | -------- Summary: end -------- 11:51:15 INFO - PROCESS | 22359 | 11:51:16 INFO - TEST-INFO | 22359: exit 0 11:51:16 INFO - TEST-OK | dromaeo_css | took 1120364ms 11:51:16 INFO - TEST-START | kraken 11:51:16 INFO - operating with platform_type : linux_ 11:51:16 INFO - Initialising browser for kraken test... 11:51:16 INFO - TEST-INFO | started process 22665 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoKqBpT/profile http://localhost:53143/getInfo.html) 11:51:20 INFO - PROCESS | 22665 | __metrics Screen width/height:1600/1200 11:51:20 INFO - PROCESS | 22665 | colorDepth:24 11:51:20 INFO - PROCESS | 22665 | Browser inner width/height: 1024/697 11:51:20 INFO - PROCESS | 22665 | __metrics 11:51:21 INFO - PROCESS | 22665 | 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" 11:51:21 INFO - PROCESS | 22665 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:51:21 INFO - PROCESS | 22665 | console.error: PushService: 11:51:21 INFO - PROCESS | 22665 | stateChangeProcessEnqueue: Error transitioning state 11:51:21 INFO - PROCESS | 22665 | UnknownError 11:51:22 INFO - TEST-INFO | 22665: exit 0 11:51:22 INFO - Browser initialized. 11:51:22 INFO - Running cycle 1/1 for kraken test... 11:51:22 INFO - TEST-INFO | started process 22745 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoKqBpT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:51:34 INFO - PROCESS | 22745 | RSS: Main: 182087680 11:51:34 INFO - PROCESS | 22745 | 11:51:37 INFO - PROCESS | 22745 | Cycle 1(1): loaded http://localhost:53143/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53143/tests/kraken/driver.html?testName=audio-beat-detection) 11:51:38 INFO - PROCESS | 22745 | RSS: Main: 235331584 11:51:38 INFO - PROCESS | 22745 | 11:51:41 INFO - PROCESS | 22745 | Cycle 1(1): loaded http://localhost:53143/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53143/tests/kraken/driver.html?testName=audio-dft) 11:51:41 INFO - PROCESS | 22745 | RSS: Main: 225476608 11:51:41 INFO - PROCESS | 22745 | 11:51:44 INFO - PROCESS | 22745 | Cycle 1(1): loaded http://localhost:53143/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53143/tests/kraken/driver.html?testName=audio-fft) 11:51:45 INFO - PROCESS | 22745 | RSS: Main: 303456256 11:51:45 INFO - PROCESS | 22745 | 11:51:47 INFO - PROCESS | 22745 | Cycle 1(1): loaded http://localhost:53143/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53143/tests/kraken/driver.html?testName=audio-oscillator) 11:51:48 INFO - PROCESS | 22745 | RSS: Main: 213389312 11:51:48 INFO - PROCESS | 22745 | 11:51:50 INFO - PROCESS | 22745 | Cycle 1(1): loaded http://localhost:53143/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53143/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:51:51 INFO - PROCESS | 22745 | RSS: Main: 215367680 11:51:51 INFO - PROCESS | 22745 | 11:51:54 INFO - PROCESS | 22745 | Cycle 1(1): loaded http://localhost:53143/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53143/tests/kraken/driver.html?testName=imaging-darkroom) 11:51:54 INFO - PROCESS | 22745 | RSS: Main: 253886464 11:51:54 INFO - PROCESS | 22745 | 11:51:58 INFO - PROCESS | 22745 | Cycle 1(1): loaded http://localhost:53143/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53143/tests/kraken/driver.html?testName=imaging-desaturate) 11:51:59 INFO - PROCESS | 22745 | RSS: Main: 247599104 11:51:59 INFO - PROCESS | 22745 | 11:52:02 INFO - PROCESS | 22745 | Cycle 1(1): loaded http://localhost:53143/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53143/tests/kraken/driver.html?testName=json-parse-financial) 11:52:02 INFO - PROCESS | 22745 | RSS: Main: 250798080 11:52:02 INFO - PROCESS | 22745 | 11:52:04 INFO - PROCESS | 22745 | Cycle 1(1): loaded http://localhost:53143/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53143/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:52:05 INFO - PROCESS | 22745 | RSS: Main: 214478848 11:52:05 INFO - PROCESS | 22745 | 11:52:06 INFO - PROCESS | 22745 | Cycle 1(1): loaded http://localhost:53143/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53143/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:52:07 INFO - PROCESS | 22745 | RSS: Main: 222244864 11:52:07 INFO - PROCESS | 22745 | 11:52:09 INFO - PROCESS | 22745 | Cycle 1(1): loaded http://localhost:53143/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53143/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:52:10 INFO - PROCESS | 22745 | RSS: Main: 222900224 11:52:10 INFO - PROCESS | 22745 | 11:52:13 INFO - PROCESS | 22745 | Cycle 1(1): loaded http://localhost:53143/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53143/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:52:13 INFO - PROCESS | 22745 | RSS: Main: 224587776 11:52:13 INFO - PROCESS | 22745 | 11:52:16 INFO - PROCESS | 22745 | Cycle 1(1): loaded http://localhost:53143/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53143/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:52:17 INFO - PROCESS | 22745 | RSS: Main: 222298112 11:52:17 INFO - PROCESS | 22745 | 11:52:19 INFO - PROCESS | 22745 | Cycle 1(1): loaded http://localhost:53143/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53143/tests/kraken/driver.html?testName=ai-astar) 11:52:19 INFO - PROCESS | 22745 | RSS: Main: 272904192 11:52:19 INFO - PROCESS | 22745 | 11:52:19 INFO - PROCESS | 22745 | __start_tp_report 11:52:19 INFO - PROCESS | 22745 | _x_x_mozilla_page_load 11:52:19 INFO - PROCESS | 22745 | _x_x_mozilla_page_load_details 11:52:19 INFO - PROCESS | 22745 | |i|pagename|runs| 11:52:19 INFO - PROCESS | 22745 | |0;ai-astar;115;117;132;116;114;116;116;114;113;115 11:52:19 INFO - PROCESS | 22745 | |1;audio-beat-detection;157;125;153;202;124;152;151;125;198;124 11:52:19 INFO - PROCESS | 22745 | |2;audio-dft;161;164;162;162;162;161;162;161;162;160 11:52:19 INFO - PROCESS | 22745 | |3;audio-fft;77;87;76;177;78;76;76;75;175;76 11:52:19 INFO - PROCESS | 22745 | |4;audio-oscillator;85;85;145;83;83;83;144;83;83;147 11:52:19 INFO - PROCESS | 22745 | |5;imaging-gaussian-blur;118;118;118;117;118;118;118;119;117;117 11:52:19 INFO - PROCESS | 22745 | |6;imaging-darkroom;148;147;146;147;147;148;148;147;148;148 11:52:19 INFO - PROCESS | 22745 | |7;imaging-desaturate;95;95;95;94;94;95;95;94;95;94 11:52:19 INFO - PROCESS | 22745 | |8;json-parse-financial;65;64;65;64;68;66;67;65;65;65 11:52:19 INFO - PROCESS | 22745 | |9;json-stringify-tinderbox;65;65;65;65;67;65;74;65;65;65 11:52:19 INFO - PROCESS | 22745 | |10;stanford-crypto-aes;82;82;81;90;85;83;85;82;81;82 11:52:19 INFO - PROCESS | 22745 | |11;stanford-crypto-ccm;136;133;129;140;131;137;132;131;168;136 11:52:19 INFO - PROCESS | 22745 | |12;stanford-crypto-pbkdf2;171;171;178;176;174;171;173;174;170;170 11:52:19 INFO - PROCESS | 22745 | |13;stanford-crypto-sha256-iterative;71;69;70;70;71;68;77;68;68;69 11:52:19 INFO - PROCESS | 22745 | __end_tp_report 11:52:19 INFO - PROCESS | 22745 | __start_cc_report 11:52:19 INFO - PROCESS | 22745 | _x_x_mozilla_cycle_collect,2021 11:52:19 INFO - PROCESS | 22745 | __end_cc_report 11:52:19 INFO - PROCESS | 22745 | __startTimestamp1472496739419__endTimestamp 11:52:19 INFO - PROCESS | 22745 | 11:52:19 INFO - PROCESS | 22745 | ------- Summary: start ------- 11:52:19 INFO - PROCESS | 22745 | Number of tests: 14 11:52:19 INFO - PROCESS | 22745 | 11:52:19 INFO - PROCESS | 22745 | [#0] ai-astar Cycles:10 Average:116.80 Median:116.00 stddev:5.47 (4.7%) stddev-sans-first:5.77 11:52:19 INFO - PROCESS | 22745 | Values: 115.0 117.0 132.0 116.0 114.0 116.0 116.0 114.0 113.0 115.0 11:52:19 INFO - PROCESS | 22745 | 11:52:19 INFO - PROCESS | 22745 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:152.50 stddev:29.18 (19.1%) stddev-sans-first:30.87 11:52:19 INFO - PROCESS | 22745 | Values: 157.0 125.0 153.0 202.0 124.0 152.0 151.0 125.0 198.0 124.0 11:52:19 INFO - PROCESS | 22745 | 11:52:19 INFO - PROCESS | 22745 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.06 (0.7%) stddev-sans-first:1.09 11:52:19 INFO - PROCESS | 22745 | Values: 161.0 164.0 162.0 162.0 162.0 161.0 162.0 161.0 162.0 160.0 11:52:19 INFO - PROCESS | 22745 | 11:52:19 INFO - PROCESS | 22745 | [#3] audio-fft Cycles:10 Average:97.30 Median:76.00 stddev:41.62 (54.8%) stddev-sans-first:43.49 11:52:19 INFO - PROCESS | 22745 | Values: 77.0 87.0 76.0 177.0 78.0 76.0 76.0 75.0 175.0 76.0 11:52:19 INFO - PROCESS | 22745 | 11:52:19 INFO - PROCESS | 22745 | [#4] audio-oscillator Cycles:10 Average:102.10 Median:83.00 stddev:29.85 (36.0%) stddev-sans-first:31.02 11:52:19 INFO - PROCESS | 22745 | Values: 85.0 85.0 145.0 83.0 83.0 83.0 144.0 83.0 83.0 147.0 11:52:19 INFO - PROCESS | 22745 | 11:52:19 INFO - PROCESS | 22745 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 11:52:19 INFO - PROCESS | 22745 | Values: 118.0 118.0 118.0 117.0 118.0 118.0 118.0 119.0 117.0 117.0 11:52:19 INFO - PROCESS | 22745 | 11:52:19 INFO - PROCESS | 22745 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 11:52:19 INFO - PROCESS | 22745 | Values: 148.0 147.0 146.0 147.0 147.0 148.0 148.0 147.0 148.0 148.0 11:52:19 INFO - PROCESS | 22745 | 11:52:19 INFO - PROCESS | 22745 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 11:52:19 INFO - PROCESS | 22745 | Values: 95.0 95.0 95.0 94.0 94.0 95.0 95.0 94.0 95.0 94.0 11:52:19 INFO - PROCESS | 22745 | 11:52:19 INFO - PROCESS | 22745 | [#8] json-parse-financial Cycles:10 Average:65.40 Median:65.00 stddev:1.26 (1.9%) stddev-sans-first:1.33 11:52:19 INFO - PROCESS | 22745 | Values: 65.0 64.0 65.0 64.0 68.0 66.0 67.0 65.0 65.0 65.0 11:52:19 INFO - PROCESS | 22745 | 11:52:19 INFO - PROCESS | 22745 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:65.00 stddev:2.85 (4.4%) stddev-sans-first:2.99 11:52:19 INFO - PROCESS | 22745 | Values: 65.0 65.0 65.0 65.0 67.0 65.0 74.0 65.0 65.0 65.0 11:52:19 INFO - PROCESS | 22745 | 11:52:19 INFO - PROCESS | 22745 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:82.50 stddev:2.75 (3.3%) stddev-sans-first:2.88 11:52:19 INFO - PROCESS | 22745 | Values: 82.0 82.0 81.0 90.0 85.0 83.0 85.0 82.0 81.0 82.0 11:52:19 INFO - PROCESS | 22745 | 11:52:19 INFO - PROCESS | 22745 | [#11] stanford-crypto-ccm Cycles:10 Average:137.30 Median:136.00 stddev:11.29 (8.3%) stddev-sans-first:11.97 11:52:19 INFO - PROCESS | 22745 | Values: 136.0 133.0 129.0 140.0 131.0 137.0 132.0 131.0 168.0 136.0 11:52:19 INFO - PROCESS | 22745 | 11:52:19 INFO - PROCESS | 22745 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.80 Median:173.50 stddev:2.70 (1.6%) stddev-sans-first:2.78 11:52:19 INFO - PROCESS | 22745 | Values: 171.0 171.0 178.0 176.0 174.0 171.0 173.0 174.0 170.0 170.0 11:52:19 INFO - PROCESS | 22745 | 11:52:19 INFO - PROCESS | 22745 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.00 stddev:2.69 (3.8%) stddev-sans-first:2.83 11:52:19 INFO - PROCESS | 22745 | Values: 71.0 69.0 70.0 70.0 71.0 68.0 77.0 68.0 68.0 69.0 11:52:19 INFO - PROCESS | 22745 | -------- Summary: end -------- 11:52:19 INFO - PROCESS | 22745 | 11:52:20 INFO - TEST-INFO | 22745: exit 0 11:52:20 INFO - TEST-OK | kraken | took 64382ms 11:52:20 INFO - SUITE-END | took 1184s 11:52:21 INFO - Completed test suite (00:19:45) 11:52:21 INFO - javascript benchmark 11:52:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2575.729548397418, 2579.2391244582846, 2590.7538783815544, 2615.0324379979406, 2625.251803236078, 4499.492669955564, 4556.339330797033, 4591.977040114794, 4603.654725895559, 4651.4650815156265, 4608.10142022305, 4655.301704744282, 4664.533546645333, 4667.649926255527, 4689.132510485562, 4277.0376665250305, 4356.651467882578, 4377.518472967987, 4381.101874115799, 4381.474223093233, 4289.227938970984, 4307.030918043447, 4326.0, 4326.545712700168, 4388.583084606973, 4272.1028583997395, 4491.214037543416, 4496.707713998596, 4497.685162038659, 4501.144782491317, 4386.473623165209, 4397.780110994469, 4420.557944205586, 4424.269995450747, 4502.819887204508, 4196.055887425336, 4229.984803647102, 4234.9364759528635, 4245.97877010613, 4289.313709806447, 4557.9772101139615, 4575.931361029588, 4577.198990176739, 4642.466116396624, 4689.2966055091665, 4972.0801651694555, 4978.402591688984, 4989.900201995976, 4991.975040124812, 5044.621653376012, 4878.585320247747, 4930.03864246472, 4992.201247800371, 5008.273800298936, 5085.5931525478245, 4638.397008388922, 4687.67186296956, 4689.812407503729, 4697.10754956564, 4697.459792123881, 5127.179651255781, 5130.102232109366, 5137.460443037916, 5158.3552055993005, 5217.426083130853, 4800.0639875224, 4866.367372241586, 4920.753962301942, 4927.187014142698, 4932.654714169974, 4963.305137280783, 4998.375203099613, 5004.774785134678, 5053.9241911371355, 5076.263941728503, 4927.802887884444, 4959.82640607577, 4968.4286307075145, 4973.179425394769, 5019.121653710586, 4776.996830665599, 4815.109204797123, 4945.307656928033, 4958.9504104959215, 5019.347484826949, 4235.597618226264, 4249.46881639795, 4250.086231460189, 4250.574942505725, 4253.128108737701, 3676.816159192083, 3703.6481534254203, 3713.5543734751463, 3749.49381833449, 3798.4682144499793, 4307.418498502662, 4310.504292006397, 4310.590493903074, 4358.564143585616, 4371.191329604034, 4816.686915350491, 4994.650374473752, 4995.500449955048, 5000.0, 5002.324686167393, 4297.376880352332, 4335.371371151228, 4338.067315527113, 4354.477462704495, 4403.075354175659, 4541.2733962565835, 4546.363509108727, 4557.72653640776, 4557.931631025537, 4614.054118905617, 4613.976930115328, 4745.14587374269, 4747.810087596457, 4752.500987396274, 4786.880327991758, 4950.2079667253065, 4976.2286845539, 4995.400551933792, 5017.4731653175895, 5022.296878437095, 4708.246680531099, 4736.881577960578, 4737.829848129995, 4740.2178640523925, 4796.544328288807, 4813.855584332476, 4944.505549445027, 4951.752412379438, 4958.206686930074, 5013.899722005466, 4909.877253068702, 4944.3572335596145, 4949.406071271471, 4953.133201689762, 5031.9245211322595, 4827.734474603931, 4836.516348365135, 4848.927266090941, 4871.561559459666, 4903.0, 4722.0, 4829.5653391194965, 4840.394950631171, 4846.854594362175, 4906.705597664151, 4752.809887604595, 4789.95210047909, 4799.136155491905, 4832.589229915497, 4867.464578896248, 4896.877578060577, 4901.779419926183, 4926.605871530341, 4927.482614325444, 4984.651074424755, 4686.390769199982, 4789.425268967607, 4807.326974223542, 4810.903781924272, 4871.3667223260745], "value": 4593.897124844346, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.9999999999999, 568.5025602597727, 575.6172145523229, 576.7779404929101, 590.743026783349, 28311.0, 38967.22065558687, 40639.39040914385, 40659.79670101653, 44429.555704442944, 41200.58799412005, 41813.0, 41823.37264941028, 41837.37243941343, 41863.79068104663, 7731.961340193306, 7879.606019698992, 7882.960585197095, 7886.2113788621255, 7888.171741967097, 7501.28737769911, 7567.545947243156, 7581.0, 7592.0, 7597.430192735539, 7790.8441831163345, 7867.48861324015, 7867.881981770278, 7867.960660196691, 7874.0, 7750.418718596128, 7753.922460775405, 7786.143524212361, 7816.960915195445, 7834.647440865175, 7731.806704832368, 7770.883436748453, 7785.3771698264, 7790.065192176919, 7794.415418843552, 38592.61407385946, 38819.41770873439, 38852.41721374181, 38878.805605971786, 38928.0, 2888.734831897779, 2932.736053755151, 2934.618499595039, 2951.557266410034, 2978.0, 25584.74415255842, 25624.615630765555, 25861.0, 25893.611595826078, 26159.869200653873, 3480.686738193575, 3493.7205023598053, 3545.3618348697223, 3610.295992281506, 3773.52830896138, 248899.0, 249485.0, 250068.0, 250598.0, 250693.0, 53296.20055699167, 53937.0, 53937.0, 53953.0, 53953.46046539563, 32484.350312993607, 33174.0, 33339.83330083334, 55497.44502554923, 55698.16452753212, 12627.179233349803, 12727.554535591209, 12743.681407964876, 12754.362281886055, 12759.0, 9448.527573621428, 9513.381630194015, 9523.28575356851, 9545.665901693408, 9560.043995600385, 18012.639747205245, 18065.7290140648, 18114.547136321435, 18279.268829246947, 18310.17604207814, 6655.234648015444, 6690.933090669031, 6710.07460635524, 6771.762988295484, 6983.301669832976, 775.7362496751132, 837.5770236030766, 865.7532603208056, 879.5514287713185, 930.8836395450569, 24551.26346209581, 24701.0, 25287.22989390725, 25384.746152538606, 25616.487670246865, 757.5454727163658, 939.6899023322287, 949.4398304999945, 961.3174646001418, 995.8157740817827, 13861.23763193034, 14762.892783041314, 14936.25318734059, 15110.320035598425, 15227.619309517351, 181476.0, 181844.0, 183328.0, 183388.0, 359087.0, 48490.757546212044, 48915.75542122267, 48981.0, 49011.0, 49137.50862491401, 1060.931039482431, 1100.02098132662, 1122.6463663945995, 1159.2754528419737, 1167.7430965187646, 26383.868080659475, 29161.125166245045, 29844.253893652833, 29867.402651947275, 30138.397232055675, 41847.0, 42446.0, 42462.0, 42492.36261456019, 42510.149797003265, 299498.0, 302959.0, 303576.0, 304121.0, 304809.0, 21942.341729748132, 22650.660240096084, 22774.20290289832, 23581.410464738517, 23680.881595591913, 41245.38131927964, 41621.0, 41621.37567936544, 41760.37359439672, 41981.37027944522, 35249.06130162763, 35330.82334588311, 35586.64413355937, 35880.0, 36007.27985440329, 35212.0, 35405.82297088498, 35573.64426355807, 35956.0, 36092.819535902156, 35303.47044794279, 35592.46611300884, 35648.64351356453, 35694.64305357017, 35923.46114808332, 30749.0, 31842.0, 32468.0, 32574.674253258112, 33269.0, 25135.43551176444, 25138.37154071163, 25346.493070138862, 25352.74647253504, 25963.350916227246], "value": 16713.1253821467, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.4663914417359, 346.39726875237096, 353.7152592163308, 354.0899887289666, 373.4472979989615, 12742.362881855905, 15647.295871685774, 16325.755113673304, 16435.753463698038, 17185.484435466926, 15422.228888555583, 15590.376384944588, 15676.608084797886, 15886.443974460895, 15892.84107158928, 4874.512548745124, 4887.242477415988, 5082.161443361841, 5096.133657278253, 5096.617753668471, 4953.083679519283, 5078.771455284521, 5086.898262034757, 5090.643654944155, 5090.796368145288, 4998.475160108191, 5050.671706339094, 5051.343325367716, 5057.924131138036, 5058.620603454756, 5179.896402071956, 5358.4641535846295, 5400.351957765054, 5466.34403871534, 5477.424870388591, 4713.198756211452, 5319.308489896327, 5326.254324394549, 5326.280952071459, 5335.279737235463, 11819.468123934443, 13595.116317439433, 19297.22811087555, 19945.10247038887, 19970.30103946355, 1792.09499202903, 1818.5726354306728, 1870.51366644672, 2077.3248694174454, 2283.7602051784656, 8208.671653133868, 8969.237614802749, 9216.400933939272, 9387.451070573346, 9464.148226659565, 1629.771831943529, 1705.84647381735, 1715.1252861040834, 1725.7842769653794, 1742.712452445345, 64152.3584764151, 70232.648836756, 70250.64874675593, 71458.64270678665, 74394.25605743927, 7945.721899733481, 8499.150084991452, 8553.059163492011, 9273.953630231807, 9552.761180970392, 10926.508307126198, 11021.338719676845, 11038.944805276084, 11074.224804263786, 11077.889221107847, 6348.936595606447, 6418.711157997808, 6494.480441564663, 6528.902066469007, 6560.0, 6417.96791016042, 6424.807255782334, 6580.40776330123, 6592.538522303488, 6623.138991931018, 3391.629549535276, 3459.238967427162, 3477.982610086933, 3646.462087226944, 3694.519712437366, 1629.714799910011, 1643.4001589419777, 1652.702513547573, 1685.502776680882, 1685.612309168898, 774.44240147094, 817.7097130518699, 875.7898104454885, 888.7778055486128, 946.8958414574391, 16313.673726525403, 16744.99530028178, 17067.573310667332, 17491.0, 17847.46457606274, 818.3453237410048, 847.9364047696324, 855.8930133733284, 890.3767362846033, 912.748994026648, 8973.775655608531, 9251.814963700688, 9315.953420232856, 9840.803183936281, 9868.30921835479, 337662.0, 342140.0, 361786.0, 368262.0, 371928.0, 78473.0, 79549.20450795419, 79592.0, 80772.59613702011, 82024.0, 846.090452763282, 869.0397111192168, 871.8561437362764, 875.3916028360355, 877.9604917778715, 14443.638909027359, 14571.198584077978, 14623.0, 14711.485098021518, 15092.0, 37203.07527837829, 37509.0, 37858.24283514259, 38430.0, 39604.405933910435, 49853.0, 49976.50023499864, 50237.246441302676, 50685.493145068074, 53185.46814531805, 7590.1650818408825, 7740.806479837824, 7753.689852405841, 7785.493942893694, 7788.688452461838, 10399.076170908103, 11409.885901140882, 11671.35807530594, 11726.589569365031, 12057.758844823229, 10107.444090574794, 10152.238582106223, 10276.897231027595, 10762.515686793957, 10877.891221088004, 10002.24983126254, 10227.897721022695, 10476.895231047896, 10503.212259080447, 10511.94744026275, 10536.10443112344, 10571.312864663772, 10673.8932610676, 11076.224664273423, 11089.001989820956, 7494.362979146834, 7516.436267279866, 7651.770446886602, 7681.577513236825, 7790.14387878004, 10064.0, 10368.481575921023, 10432.74807023162, 10596.258261921592, 11004.724881877697], "value": 7879.365226568262, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1199.6161228406902, 1333.1201407071333, 1375.4910683047274, 1432.9570112896618, 1690.8985460872357, 7310.34206921377, 7637.618119094044, 7675.04061992251, 7927.445078844469, 7947.761567152995, 7757.185495522974, 7840.215978402157, 7866.056073271216, 7883.763487095382, 7884.093329267136, 2162.372911855564, 2168.902399392031, 2186.180182431588, 2188.037263604017, 2188.84678072535, 2112.9366119016454, 2168.111074459472, 2205.5588882223537, 2211.0492488230057, 2211.469247380625, 2125.298651445027, 2154.806067453929, 2161.7513985891665, 2168.1977668262684, 2205.44863784054, 2123.957520849582, 2127.117246342766, 2127.2448280860303, 2133.786621337854, 2135.1459416233474, 2068.565601223745, 2099.8215151712125, 2105.3473423238693, 2105.610462064523, 2146.334636262748, 7494.21310762373, 7715.151333353327, 7751.379889608874, 7848.0, 7850.803729906798, 4313.82744690212, 4428.003699167693, 4443.688941774077, 4445.088756804847, 4450.35469856869, 2803.8738256778493, 2902.6226590543306, 2947.7347038766397, 2947.882084716609, 2959.3785305085958, 928.331601247101, 940.3276657190141, 944.4946953379978, 952.066974365126, 965.9758506037335, 10235.897641023568, 10258.589656413735, 10311.84532232017, 10327.0, 10390.532426040847, 3938.822752976123, 4030.8992275193355, 4049.9595004049584, 4055.0876052887866, 4280.336547835091, 8126.553039582762, 8274.048484424367, 8276.917230827736, 8278.793030174173, 8292.12932642076, 4465.263231566755, 4469.4636643602325, 4478.9552104478535, 4483.08096840147, 4489.775511224491, 3588.4437912123662, 3952.782596957195, 4103.8974025649595, 4177.582241775798, 4180.414741936132, 3471.89584312471, 3596.352656521799, 3619.420892657215, 3627.619099994515, 3782.394816829294, 1189.8096304591397, 1213.4721396192508, 1215.7203843115956, 1229.674136353867, 1229.9016078713682, 703.2440126863642, 791.2364568191723, 798.2057852436747, 806.4234072638092, 816.8611336072881, 4872.098661747588, 5033.0688822567945, 5034.823781167642, 5086.491350864884, 5385.703786291713, 404.3873531599629, 418.76549132485906, 426.5585119401405, 428.98972918776457, 429.9204647140289, 3508.9824550877083, 3532.911677208039, 3567.1438854674693, 3570.892873213808, 3629.909252268714, 8739.825203496022, 8942.50816205115, 9024.548772561346, 9038.548072596344, 9058.048904865025, 8993.865092023625, 9004.954975225082, 9006.909930900738, 9008.684696035607, 9038.0, 6732.225794033651, 6793.354631310018, 6874.381305682413, 6891.448684105259, 6932.896006559906, 4760.714607056007, 4793.185158523129, 4807.326974223542, 4875.7074575525585, 4939.431965324034, 8134.023917129983, 8245.093039765501, 8275.420720549504, 8280.792980175544, 8318.875216871631, 8365.0, 8377.204165604258, 8723.781905452415, 8730.432521886058, 9144.954275228582, 6133.907991380043, 6542.149520562297, 6571.211454625475, 6703.128593283037, 6717.496187785838, 7310.853782924205, 7569.1673915868105, 7632.122305934889, 7637.427192960439, 7646.388288936761, 6566.770163044271, 6577.375149360803, 6645.235797883305, 6713.899291510534, 6718.8320291993095, 6381.712822923072, 6510.576812507172, 6550.672466376567, 6726.125603671687, 6764.28974957642, 6146.969265153645, 6184.690765461619, 6185.41238582334, 6200.534959877937, 6275.278342990615, 4435.955640443554, 4454.443194600675, 4567.794449249858, 4575.6339492839825, 4638.953610463852, 4409.757463339419, 4465.0, 4589.977050114728, 4590.288505281686, 4689.507601701772], "value": 3956.5848885175856, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.9682134965153, 298.37341582676385, 303.7645824486023, 307.2135333546122, 307.97074277943585, 4645.465771436286, 4646.233371493704, 4663.976680116594, 4670.743109128996, 4708.52914708529, 4616.630669546436, 4629.259318509039, 4657.231556793134, 4676.508966558505, 4676.859694209179, 3487.8256087195728, 3522.7357948153863, 3627.6009638939695, 3679.7240206984447, 3718.293524230401, 3679.5584529856455, 3702.944455833151, 3745.8127093645344, 3747.6627103560672, 3763.435484677293, 3654.2143439160577, 3658.5426821647293, 3682.2451397463456, 3701.8889433317045, 3723.869664561741, 3450.9654903450896, 3528.3416794106856, 3586.9282614347567, 3614.5120408744747, 3623.47813918155, 3200.1199670090678, 3206.118317462693, 3207.631122420905, 3210.839458027089, 3225.3388055448577, 4516.954830451687, 4530.909381812378, 4532.753492789477, 4564.383808185886, 4573.233193917665, 3932.88201353957, 4170.91658166835, 4190.622843944059, 4191.706580539363, 4192.643625291854, 4856.150173719585, 4859.80560777572, 4866.296796121364, 4869.561739443432, 4870.464248932614, 3536.275063611979, 3540.805255710935, 3548.449990251515, 3553.893383198508, 3556.3776339140804, 5028.773705183312, 5134.460881607415, 5173.2669555698885, 5175.81884634036, 5184.792608295664, 3575.5888072871953, 3597.1366871950545, 3607.494950706903, 3621.167131559756, 3626.1325417410053, 3657.5552656700456, 3673.8530458781884, 3674.0814796300924, 3677.4483827425565, 3679.392900171495, 4124.711270211116, 4139.0, 4153.273177193979, 4188.958110418856, 4196.265653510623, 4818.590419814285, 4863.902721945541, 4924.384451943507, 4934.703917764946, 4944.851654450372, 1250.1374051904156, 1260.036072404611, 1262.4066688656317, 1263.4946021591436, 1269.079917060124, 761.2425636491727, 787.1656044592636, 787.6180052674448, 792.1880072925297, 799.1209669363769, 4313.0, 4410.1400226956075, 4416.183006143874, 4421.712588681726, 4428.9813342930665, 4994.725290109079, 5001.999200319901, 5012.172991456368, 5023.673461225008, 5065.442801291855, 4377.868663940087, 4385.101054283928, 4394.890127746768, 4407.889802754957, 4452.688311818141, 2533.518631460017, 2668.9733102669115, 2675.3579141006016, 2703.4998525272886, 2706.134037108146, 4858.441279252931, 4860.392450943632, 4863.148948933993, 4865.153884977257, 4895.632827537949, 4974.253861920669, 5200.72354416715, 5213.504717051874, 5217.399999000164, 5217.686938783685, 4815.0, 4817.710937343771, 4828.493008234155, 4832.9275060874115, 4834.081524510332, 5060.722674796283, 5076.492350764894, 5077.1876499759865, 5085.694858308513, 5097.949020509747, 4684.414448193976, 4969.180085285887, 4992.72540010303, 5002.574266334077, 5011.924821127759, 4811.254255590389, 4839.7096174229655, 4841.281345122431, 4841.346418233635, 4846.345743324606, 3614.4397618369194, 3621.2576421833987, 3629.528161339009, 3653.1049892775377, 3667.339878821838, 5016.2224855147515, 5111.974440127776, 5136.0, 5150.356205474316, 5153.896922061613, 4866.221404575251, 4876.4392094909535, 4894.730789806595, 4931.72875491837, 4935.827246046371, 4856.781444835062, 4898.706077635354, 4904.2643603459765, 4907.877303067452, 4951.282064100757, 4851.708897466164, 4852.490488498798, 4863.197572400514, 4883.340748998982, 4898.24077268024, 4700.754300110405, 4703.74129422885, 4799.784009719641, 4886.560209581155, 4910.484399138039, 4788.281757736368, 4808.422989241313, 4812.799488340214, 4815.7847390200905, 4822.9758851205515], "value": 3710.480741145282, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.0089651179044, 614.6895817612105, 634.9714262858168, 685.4036987820597, 695.1206723494778, 10833.29583577068, 11530.711732206699, 11598.0, 11603.941980290097, 11611.419429028558, 12534.373281335942, 12661.620151395473, 12667.176633518815, 12698.93650531746, 12711.36443177842, 601.2754630670054, 712.8752468318049, 714.8034290570083, 731.0386841303668, 731.5537522111508, 741.6736635880222, 741.9517731347472, 743.1156923261302, 744.2185705009745, 745.2361329637112, 794.8688466403037, 795.0896223823719, 795.5187111797366, 795.9482633628825, 796.0845028217539, 634.7461015593731, 651.7034749189107, 654.8297442664893, 655.8688262347549, 793.1790596732354, 553.883684426271, 571.2801869644237, 571.8456016875462, 577.757341916392, 578.3089208395968, 11239.0, 11287.49206285719, 11298.378589177591, 11315.377654229014, 11321.886781132249, 10915.0, 11471.13966452511, 11492.425378731114, 11570.479328430241, 12106.213096148722, 9150.40522366044, 9331.953340233324, 9356.532173391302, 9404.24766018717, 9534.570944307523, 4020.7386519876113, 4038.51537815464, 4038.676905847525, 4090.6931980101613, 4097.959020409788, 61456.692716536134, 64747.0, 65675.34324656788, 66277.00584491284, 66601.33398666, 8985.191332780081, 9175.036621154683, 9201.76995575116, 9305.022972587916, 9463.101005404476, 16937.491875243762, 16958.830411695973, 16967.49097527076, 16973.321067157423, 17048.74426883573, 6275.497960163176, 6305.558610897285, 6374.107624932513, 6617.338266173344, 6639.502037347122, 3516.5406356362337, 3609.6029436761937, 3619.873304434332, 3739.476473293741, 3777.527809023872, 2643.722409147012, 2732.740389662979, 2736.3569561153113, 2738.548139556951, 2746.7115952825066, 456.4385805459304, 459.3362591055959, 460.930860370947, 468.3606876613466, 470.9905801883943, 426.6330955378372, 496.0327361644807, 499.99004003904827, 506.70104638263604, 514.1824499046534, 7027.43780497559, 7207.603581803051, 7359.190489046201, 7419.59192244421, 7421.888671669929, 418.7738621144609, 471.03908027623265, 472.76361819090454, 490.55359622743134, 491.0645220854278, 3513.314903593826, 3693.279810436939, 3723.832427540767, 3786.2427514497213, 3827.559830619459, 61170.694146528986, 61468.077978830355, 76580.61709691415, 98669.50665246628, 99225.0, 84125.0, 85331.49914770194, 85398.59510536735, 86120.56939715262, 88399.55800220958, 72605.27394726091, 77455.0, 79030.0, 79203.60398197972, 79551.60224198842, 6758.7296508139125, 6774.390304872585, 6889.965550172217, 7058.894116588152, 7091.468139889425, 44126.33810492781, 44244.778776105915, 46738.532614673415, 46841.0, 47022.0, 60989.0, 66081.66959165173, 66813.0, 67053.66473167604, 69453.0, 9319.0, 9328.160465558132, 9405.24758019343, 9524.761880953032, 9889.703308900744, 10470.371777693363, 10585.8941410588, 10782.460876955964, 11089.39008354516, 11124.721881952692, 10077.244206684381, 10091.848622270525, 10243.692689219335, 10831.837522437327, 11081.947215014561, 9725.513724313898, 9860.753481163028, 9899.950500247453, 9913.801723965336, 10414.166866650497, 9630.229581633592, 9676.225901927688, 9830.75423114428, 9931.453770042717, 10426.895731042592, 7973.681052757825, 8081.9191808083515, 8178.67285308581, 8303.4602750821, 8405.285550728257, 8051.1948805121365, 8324.209200125979, 8412.537310447984, 8490.957545212234, 8675.696350627697], "value": 6013.943311545018, "unit": "score"}], "name": "dromaeo_css", "value": 6136.890417661318, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 117.0, 132.0, 116.0, 114.0, 116.0, 116.0, 114.0, 113.0, 115.0], "value": 116.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 125.0, 153.0, 202.0, 124.0, 152.0, 151.0, 125.0, 198.0, 124.0], "value": 151.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 162.0, 162.0, 162.0, 161.0, 162.0, 161.0, 162.0, 160.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 87.0, 76.0, 177.0, 78.0, 76.0, 76.0, 75.0, 175.0, 76.0], "value": 97.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 145.0, 83.0, 83.0, 83.0, 144.0, 83.0, 83.0, 147.0], "value": 102.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 118.0, 118.0, 118.0, 119.0, 117.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 147.0, 147.0, 148.0, 148.0, 147.0, 148.0, 148.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 64.0, 68.0, 66.0, 67.0, 65.0, 65.0, 65.0], "value": 65.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 67.0, 65.0, 74.0, 65.0, 65.0, 65.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 81.0, 90.0, 85.0, 83.0, 85.0, 82.0, 81.0, 82.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 133.0, 129.0, 140.0, 131.0, 137.0, 132.0, 131.0, 168.0, 136.0], "value": 137.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 178.0, 176.0, 174.0, 171.0, 173.0, 174.0, 170.0, 170.0], "value": 172.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 70.0, 70.0, 71.0, 68.0, 77.0, 68.0, 68.0, 69.0], "value": 70.1, "unit": "score"}], "name": "kraken", "value": 1583.7999999999997, "alertThreshold": 2.0}]} 11:52:21 INFO - Return code: 0 11:52:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:52:21 INFO - # TBPL SUCCESS # 11:52:21 INFO - Running post-action listener: _resource_record_post_action 11:52:21 INFO - [mozharness: 2016-08-29 18:52:21.232250Z] Finished run-tests step (success) 11:52:21 INFO - Running post-run listener: _resource_record_post_run 11:52:21 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 418443264; Read time: 44; Write time: 260452 11:52:21 INFO - TinderboxPrint: CPU usage
13.0% 11:52:21 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 44 11:52:21 INFO - TinderboxPrint: I/O write bytes / time
418,443,264 / 260,452 11:52:21 INFO - TinderboxPrint: CPU idle
8,335.3 (87.0%) 11:52:21 INFO - TinderboxPrint: CPU user
1,199.5 (12.5%) 11:52:21 INFO - TinderboxPrint: Swap in / out
0 / 0 11:52:21 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 114479104; Read time: 0; Write time: 91360 11:52:21 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292691968; Read time: 44; Write time: 167124 11:52:21 INFO - Running post-run listener: _upload_blobber_files 11:52:21 INFO - Blob upload gear active. 11:52:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:52:21 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 11:52:21 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:52:21 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:52:22 INFO - (blobuploader) - INFO - Open directory for files ... 11:52:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:52:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:52:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:27 INFO - (blobuploader) - INFO - Done attempting. 11:52:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:52:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:52:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:27 INFO - (blobuploader) - INFO - Done attempting. 11:52:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:52:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:52:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:28 INFO - (blobuploader) - INFO - Done attempting. 11:52:28 INFO - (blobuploader) - INFO - Iteration through files over. 11:52:28 INFO - Return code: 0 11:52:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:52:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:52:28 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7baf7745b7eb91cd8ad6b54efa78da81cd530fbbfbfcf16350688c72ae5aad82e4df2f879cc06321ba72a867d5fb10728094c040ca2ffc761f027d03e2abede1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f86e0d5eb70b7279fb670879bf640fc92bc94061248a86c667c9f873899b6b753d49ed29cfe3a9dc2433134c078bb077e0dae8d3de7ac57ba9fba3075216802f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/41ee4f86a098118c098e65e314f062c78f52a4f4fc3b8b97f5dfe63aaa69b6573adf73494b30e914442d9bac41150b2299f9e118600009d859f4a551dc16618a"} 11:52:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:52:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:52:28 INFO - Contents: 11:52:28 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7baf7745b7eb91cd8ad6b54efa78da81cd530fbbfbfcf16350688c72ae5aad82e4df2f879cc06321ba72a867d5fb10728094c040ca2ffc761f027d03e2abede1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f86e0d5eb70b7279fb670879bf640fc92bc94061248a86c667c9f873899b6b753d49ed29cfe3a9dc2433134c078bb077e0dae8d3de7ac57ba9fba3075216802f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/41ee4f86a098118c098e65e314f062c78f52a4f4fc3b8b97f5dfe63aaa69b6573adf73494b30e914442d9bac41150b2299f9e118600009d859f4a551dc16618a"} 11:52:28 INFO - Running post-run listener: copy_logs_to_upload_dir 11:52:28 INFO - Copying logs to upload dir... 11:52:28 INFO - mkdir: /builds/slave/test/build/upload/logs 11:52:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.827758 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-08-29 11:52:28.160107) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 11:52:28.163576) ========= 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=20e666a3d4cfbb71505a330e000001b4-1472494767.395345-317815114 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7baf7745b7eb91cd8ad6b54efa78da81cd530fbbfbfcf16350688c72ae5aad82e4df2f879cc06321ba72a867d5fb10728094c040ca2ffc761f027d03e2abede1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f86e0d5eb70b7279fb670879bf640fc92bc94061248a86c667c9f873899b6b753d49ed29cfe3a9dc2433134c078bb077e0dae8d3de7ac57ba9fba3075216802f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/41ee4f86a098118c098e65e314f062c78f52a4f4fc3b8b97f5dfe63aaa69b6573adf73494b30e914442d9bac41150b2299f9e118600009d859f4a551dc16618a"} build_url:https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011353 build_url: 'https://queue.taskcluster.net/v1/task/epGNwNYrT4KvqqUMg1uE9g/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/Fx-Team-Non-PGO/sha512/7baf7745b7eb91cd8ad6b54efa78da81cd530fbbfbfcf16350688c72ae5aad82e4df2f879cc06321ba72a867d5fb10728094c040ca2ffc761f027d03e2abede1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f86e0d5eb70b7279fb670879bf640fc92bc94061248a86c667c9f873899b6b753d49ed29cfe3a9dc2433134c078bb077e0dae8d3de7ac57ba9fba3075216802f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/41ee4f86a098118c098e65e314f062c78f52a4f4fc3b8b97f5dfe63aaa69b6573adf73494b30e914442d9bac41150b2299f9e118600009d859f4a551dc16618a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-29 11:52:28.190027) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 11:52:28.190423) ========= 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=20e666a3d4cfbb71505a330e000001b4-1472494767.395345-317815114 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004363 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-29 11:52:28.274336) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 11:52:28.274694) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-29 11:52:28.275052) ========= ========= Total master_lag: 0.18 =========