builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-045 starttime: 1470981948.6 results: success (0) buildid: 20160811203012 builduid: cd3f4a0b9f4043bb81e3a97ecc1f1c4a revision: 6f2ba7787816fd01f77c30e3bdb68400db74bf0c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 23:05:48.596965) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 23:05:48.597338) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 23:05:48.597602) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 23:05:48.627994) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 23:05:48.628261) ========= 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=4300f881736b422476174874000001bc-1470978576.835875-337868573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-11 23:05:48-- 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% 70.7M=0s 2016-08-11 23:05:49 (70.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.072222 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 23:05:48.716467) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 23:05:48.716742) ========= 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=4300f881736b422476174874000001bc-1470978576.835875-337868573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018758 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 23:05:48.765549) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 23:05:48.765878) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6f2ba7787816fd01f77c30e3bdb68400db74bf0c --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 6f2ba7787816fd01f77c30e3bdb68400db74bf0c --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=4300f881736b422476174874000001bc-1470978576.835875-337868573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-11 23:05:49,174 truncating revision to first 12 chars 2016-08-11 23:05:49,174 Setting DEBUG logging. 2016-08-11 23:05:49,174 attempt 1/10 2016-08-11 23:05:49,174 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6f2ba7787816?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-11 23:05:49,502 unpacking tar archive at: fx-team-6f2ba7787816/testing/mozharness/ program finished with exit code 0 elapsedTime=0.667990 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 23:05:49.446859) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 23:05:49.447130) ========= script_repo_revision: 6f2ba7787816fd01f77c30e3bdb68400db74bf0c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 23:05:49.447509) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 23:05:49.447768) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 23:05:49.456595) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-11 23:05:49.456858) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=4300f881736b422476174874000001bc-1470978576.835875-337868573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:05:49 INFO - MultiFileLogger online at 20160811 23:05:49 in /builds/slave/test 23:05:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:05:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:05:49 INFO - {'append_to_log': False, 23:05:49 INFO - 'base_work_dir': '/builds/slave/test', 23:05:49 INFO - 'blob_upload_branch': 'Fx-Team', 23:05:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:05:49 INFO - 'branch': 'Fx-Team', 23:05:49 INFO - 'buildbot_json_path': 'buildprops.json', 23:05:49 INFO - 'config_files': ('talos/linux_config.py',), 23:05:49 INFO - 'default_actions': ('clobber', 23:05:49 INFO - 'read-buildbot-config', 23:05:49 INFO - 'download-and-extract', 23:05:49 INFO - 'populate-webroot', 23:05:49 INFO - 'create-virtualenv', 23:05:49 INFO - 'install', 23:05:49 INFO - 'run-tests'), 23:05:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:05:49 INFO - 'download_minidump_stackwalk': True, 23:05:49 INFO - 'download_symbols': 'ondemand', 23:05:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:05:49 INFO - 'tooltool.py': '/tools/tooltool.py', 23:05:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:05:49 INFO - '/tools/misc-python/virtualenv.py')}, 23:05:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:05:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:05:49 INFO - 'installer_path': 'installer.exe', 23:05:49 INFO - 'log_level': 'info', 23:05:49 INFO - 'log_name': 'talos', 23:05:49 INFO - 'log_to_console': True, 23:05:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:05:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:05:49 INFO - 'opt_config_files': (), 23:05:49 INFO - 'pip_index': False, 23:05:49 INFO - 'sps_profile': False, 23:05:49 INFO - 'sps_profile_interval': 0, 23:05:49 INFO - 'suite': 'dromaeojs', 23:05:49 INFO - 'system_bits': '32', 23:05:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:05:49 INFO - 'title': 'talos-linux64-ix-045', 23:05:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:05:49 INFO - 'use_talos_json': True, 23:05:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:05:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:05:49 INFO - 'work_dir': 'build'} 23:05:49 INFO - [mozharness: 2016-08-12 06:05:49.950771Z] Running clobber step. 23:05:49 INFO - Running pre-action listener: _resource_record_pre_action 23:05:49 INFO - Running main action method: clobber 23:05:49 INFO - rmtree: /builds/slave/test/build 23:05:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:05:50 INFO - Running post-action listener: _resource_record_post_action 23:05:50 INFO - [mozharness: 2016-08-12 06:05:50.406933Z] Finished clobber step (success) 23:05:50 INFO - [mozharness: 2016-08-12 06:05:50.407037Z] Running read-buildbot-config step. 23:05:50 INFO - Running pre-action listener: _resource_record_pre_action 23:05:50 INFO - Running main action method: read_buildbot_config 23:05:50 INFO - Using buildbot properties: 23:05:50 INFO - { 23:05:50 INFO - "project": "", 23:05:50 INFO - "product": "firefox", 23:05:50 INFO - "script_repo_revision": "production", 23:05:50 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:05:50 INFO - "repository": "", 23:05:50 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:05:50 INFO - "buildid": "20160811203012", 23:05:50 INFO - "pgo_build": "True", 23:05:50 INFO - "basedir": "/builds/slave/test", 23:05:50 INFO - "buildnumber": 976, 23:05:50 INFO - "slavename": "talos-linux64-ix-045", 23:05:50 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:05:50 INFO - "platform": "ubuntu64_hw", 23:05:50 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:05:50 INFO - "branch": "fx-team", 23:05:50 INFO - "repo_path": "integration/fx-team", 23:05:50 INFO - "revision": "6f2ba7787816fd01f77c30e3bdb68400db74bf0c", 23:05:50 INFO - "stage_platform": "linux64-pgo", 23:05:50 INFO - "builduid": "cd3f4a0b9f4043bb81e3a97ecc1f1c4a", 23:05:50 INFO - "slavebuilddir": "test" 23:05:50 INFO - } 23:05:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 23:05:50 INFO - Running post-action listener: _resource_record_post_action 23:05:50 INFO - [mozharness: 2016-08-12 06:05:50.409501Z] Finished read-buildbot-config step (success) 23:05:50 INFO - [mozharness: 2016-08-12 06:05:50.409591Z] Running download-and-extract step. 23:05:50 INFO - Running pre-action listener: _resource_record_pre_action 23:05:50 INFO - Running main action method: download_and_extract 23:05:50 INFO - mkdir: /builds/slave/test/build/tests 23:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:05:50 INFO - trying https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:05:50 INFO - Downloading https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/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 23:05:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/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 23:05:50 INFO - Downloaded 1361 bytes. 23:05:50 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:05:50 INFO - Using the following test package requirements: 23:05:50 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 23:05:50 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:50 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:05:50 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:50 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:05:50 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:50 INFO - u'jsshell-linux-x86_64.zip'], 23:05:50 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:50 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:05:50 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 23:05:50 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:50 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:05:50 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:50 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:05:50 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:50 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:05:50 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:05:50 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:05:50 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:05:50 INFO - trying https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:05:50 INFO - Downloading https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/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 23:05:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/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 23:05:52 INFO - Downloaded 21833162 bytes. 23:05:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:05:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:05:53 INFO - Return code: 0 23:05:53 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 23:05: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')]} 23:05:53 INFO - trying https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:05:53 INFO - Downloading https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/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 23:05:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/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 23:05:54 INFO - Downloaded 21833162 bytes. 23:05:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:05:54 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:05:55 INFO - Return code: 0 23:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:05:55 INFO - trying https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 23:05:55 INFO - Downloading https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/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 23:05:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/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 23:05:56 INFO - Downloaded 14413719 bytes. 23:05:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:05:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 23:05:56 INFO - Return code: 0 23:05:56 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')]} 23:05:56 INFO - trying https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:05:56 INFO - Downloading https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/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 23:05:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/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 23:05:58 INFO - Downloaded 59350629 bytes. 23:05:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:05:58 INFO - mkdir: /builds/slave/test/properties 23:05:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:05:58 INFO - Writing to file /builds/slave/test/properties/build_url 23:05:58 INFO - Contents: 23:05:58 INFO - build_url:https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:05:59 INFO - Running post-action listener: _resource_record_post_action 23:05:59 INFO - Running post-action listener: set_extra_try_arguments 23:05:59 INFO - [mozharness: 2016-08-12 06:05:59.525113Z] Finished download-and-extract step (success) 23:05:59 INFO - [mozharness: 2016-08-12 06:05:59.525351Z] Running populate-webroot step. 23:05:59 INFO - Running pre-action listener: _resource_record_pre_action 23:05:59 INFO - Running main action method: populate_webroot 23:05:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:05:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:05:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:05:59 INFO - '--tppagecycles', 23:05:59 INFO - '7'], 23:05:59 INFO - 'tests': ['tsvgm']}}, 23:05:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:05:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:05:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:05:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:05:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:05:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:05:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:59 INFO - 'talos_options': ['--disable-e10s'], 23:05:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:05:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:05:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:59 INFO - 'talos_options': ['--disable-e10s'], 23:05:59 INFO - 'tests': ['damp', 'tps']}, 23:05:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:59 INFO - 'tests': ['damp', 'tps']}, 23:05:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:05:59 INFO - 'tests': ['dromaeo_dom']}, 23:05:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:05:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:05:59 INFO - 'tests': ['basic_compositor_video']}, 23:05:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:05:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:05:59 INFO - 'tests': ['a11yr', 23:05:59 INFO - 'ts_paint', 23:05:59 INFO - 'tpaint', 23:05:59 INFO - 'sessionrestore', 23:05:59 INFO - 'sessionrestore_no_auto_restore', 23:05:59 INFO - 'tabpaint']}, 23:05:59 INFO - 'other-e10s': {'tests': ['a11yr', 23:05:59 INFO - 'ts_paint', 23:05:59 INFO - 'tpaint', 23:05:59 INFO - 'sessionrestore', 23:05:59 INFO - 'sessionrestore_no_auto_restore', 23:05:59 INFO - 'tabpaint']}, 23:05:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:05:59 INFO - 'ts_paint', 23:05:59 INFO - 'tpaint', 23:05:59 INFO - 'sessionrestore', 23:05:59 INFO - 'sessionrestore_no_auto_restore', 23:05:59 INFO - 'tabpaint']}, 23:05:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:05:59 INFO - 'ts_paint', 23:05:59 INFO - 'tpaint', 23:05:59 INFO - 'sessionrestore', 23:05:59 INFO - 'sessionrestore_no_auto_restore', 23:05:59 INFO - 'tabpaint']}, 23:05:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:05:59 INFO - 'tests': ['a11yr', 23:05:59 INFO - 'ts_paint', 23:05:59 INFO - 'tpaint', 23:05:59 INFO - 'sessionrestore', 23:05:59 INFO - 'sessionrestore_no_auto_restore', 23:05:59 INFO - 'tabpaint']}, 23:05:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:05:59 INFO - 'tests': ['a11yr', 23:05:59 INFO - 'ts_paint', 23:05:59 INFO - 'tpaint', 23:05:59 INFO - 'sessionrestore', 23:05:59 INFO - 'sessionrestore_no_auto_restore', 23:05:59 INFO - 'tabpaint']}, 23:05:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:05:59 INFO - 'tests': ['tsvgx', 23:05:59 INFO - 'tsvgr_opacity', 23:05:59 INFO - 'tart', 23:05:59 INFO - 'tscrollx', 23:05:59 INFO - 'cart']}, 23:05:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:05:59 INFO - 'tsvgr_opacity', 23:05:59 INFO - 'tart', 23:05:59 INFO - 'tscrollx', 23:05:59 INFO - 'cart']}, 23:05:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:59 INFO - 'talos_options': ['--disable-e10s'], 23:05:59 INFO - 'tests': ['tp5o']}, 23:05:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:59 INFO - 'tests': ['tp5o']}, 23:05:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:59 INFO - 'talos_options': ['--disable-e10s', 23:05:59 INFO - '--xperf_path', 23:05:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:05:59 INFO - 'tests': ['tp5n']}, 23:05:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:05:59 INFO - 'talos_options': ['--xperf_path', 23:05:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:05:59 INFO - 'tests': ['tp5n']}}, 23:05:59 INFO - 'talos.zip': {'path': '', 23:05:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:05:59 INFO - Running post-action listener: _resource_record_post_action 23:05:59 INFO - [mozharness: 2016-08-12 06:05:59.546126Z] Finished populate-webroot step (success) 23:05:59 INFO - [mozharness: 2016-08-12 06:05:59.546216Z] Running create-virtualenv step. 23:05:59 INFO - Running pre-action listener: _resource_record_pre_action 23:05:59 INFO - Running main action method: create_virtualenv 23:05:59 INFO - Creating virtualenv /builds/slave/test/build/venv 23:05:59 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 23:05:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:05:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:05:59 INFO - Using real prefix '/usr' 23:05:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:06:00 INFO - Installing distribute.............................................................................................................................................................................................done. 23:06:02 INFO - Installing pip.................done. 23:06:02 INFO - Return code: 0 23:06:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:02 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 0xe37030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f63b0>, '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 0x10f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7740>, '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': '4300f881736b422476174874000001bc-1470978576.835875-337868573', '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 23:06:02 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 23:06:02 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 23:06:02 INFO - Using env: {'DISPLAY': ':0', 23:06:02 INFO - 'HOME': '/home/cltbld', 23:06:02 INFO - 'LANG': 'en_US.UTF-8', 23:06:02 INFO - 'LANGUAGE': 'en_US:en', 23:06:02 INFO - 'LOGNAME': 'cltbld', 23:06:02 INFO - 'MAIL': '/var/mail/cltbld', 23:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:02 INFO - 'MOZ_NO_REMOTE': '1', 23:06:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:02 INFO - 'NO_EM_RESTART': '1', 23:06:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:02 INFO - 'PWD': '/builds/slave/test', 23:06:02 INFO - 'SHELL': '/bin/bash', 23:06:02 INFO - 'SHLVL': '1', 23:06:02 INFO - 'TERM': 'linux', 23:06:02 INFO - 'TMOUT': '86400', 23:06:02 INFO - 'USER': 'cltbld', 23:06:02 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470978576.835875-337868573', 23:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:02 INFO - '_': '/tools/buildbot/bin/python'} 23:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:02 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 23:06:02 INFO - Cleaning up... 23:06:02 INFO - Return code: 0 23:06:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:02 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 0xe37030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f63b0>, '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 0x10f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7740>, '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': '4300f881736b422476174874000001bc-1470978576.835875-337868573', '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 23:06:02 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 23:06:02 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 23:06:02 INFO - Using env: {'DISPLAY': ':0', 23:06:02 INFO - 'HOME': '/home/cltbld', 23:06:02 INFO - 'LANG': 'en_US.UTF-8', 23:06:02 INFO - 'LANGUAGE': 'en_US:en', 23:06:02 INFO - 'LOGNAME': 'cltbld', 23:06:02 INFO - 'MAIL': '/var/mail/cltbld', 23:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:02 INFO - 'MOZ_NO_REMOTE': '1', 23:06:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:02 INFO - 'NO_EM_RESTART': '1', 23:06:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:02 INFO - 'PWD': '/builds/slave/test', 23:06:02 INFO - 'SHELL': '/bin/bash', 23:06:02 INFO - 'SHLVL': '1', 23:06:02 INFO - 'TERM': 'linux', 23:06:02 INFO - 'TMOUT': '86400', 23:06:02 INFO - 'USER': 'cltbld', 23:06:02 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470978576.835875-337868573', 23:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:02 INFO - '_': '/tools/buildbot/bin/python'} 23:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:02 INFO - Downloading/unpacking psutil>=3.1.1 23:06:02 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 23:06:02 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 23:06:02 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 23:06:02 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 23:06:02 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 23:06:02 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 23:06:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:06:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:06:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:06:04 INFO - Installing collected packages: psutil 23:06:04 INFO - Running setup.py install for psutil 23:06:04 INFO - building 'psutil._psutil_linux' extension 23:06:04 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 23:06:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 23:06:04 INFO - building 'psutil._psutil_posix' extension 23:06:04 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 23:06:04 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 23:06:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:06:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:06:05 INFO - Successfully installed psutil 23:06:05 INFO - Cleaning up... 23:06:05 INFO - Return code: 0 23:06:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:06: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')]} 23:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06: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')]} 23:06:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe37030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f63b0>, '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 0x10f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7740>, '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': '4300f881736b422476174874000001bc-1470978576.835875-337868573', '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 23:06:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:06:05 INFO - Using env: {'DISPLAY': ':0', 23:06:05 INFO - 'HOME': '/home/cltbld', 23:06:05 INFO - 'LANG': 'en_US.UTF-8', 23:06:05 INFO - 'LANGUAGE': 'en_US:en', 23:06:05 INFO - 'LOGNAME': 'cltbld', 23:06:05 INFO - 'MAIL': '/var/mail/cltbld', 23:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:05 INFO - 'MOZ_NO_REMOTE': '1', 23:06:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:05 INFO - 'NO_EM_RESTART': '1', 23:06:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:05 INFO - 'PWD': '/builds/slave/test', 23:06:05 INFO - 'SHELL': '/bin/bash', 23:06:05 INFO - 'SHLVL': '1', 23:06:05 INFO - 'TERM': 'linux', 23:06:05 INFO - 'TMOUT': '86400', 23:06:05 INFO - 'USER': 'cltbld', 23:06:05 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470978576.835875-337868573', 23:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:05 INFO - '_': '/tools/buildbot/bin/python'} 23:06:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:06: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 23:06: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 23:06: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 23:06: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 23:06: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 23:06: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 23:06:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:06:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:06:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:06:07 INFO - Installing collected packages: mozsystemmonitor 23:06:07 INFO - Running setup.py install for mozsystemmonitor 23:06:07 INFO - Successfully installed mozsystemmonitor 23:06:07 INFO - Cleaning up... 23:06:07 INFO - Return code: 0 23:06:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:06:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:06:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe37030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f63b0>, '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 0x10f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7740>, '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': '4300f881736b422476174874000001bc-1470978576.835875-337868573', '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 23:06:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:06:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 23:06:07 INFO - Using env: {'DISPLAY': ':0', 23:06:07 INFO - 'HOME': '/home/cltbld', 23:06:07 INFO - 'LANG': 'en_US.UTF-8', 23:06:07 INFO - 'LANGUAGE': 'en_US:en', 23:06:07 INFO - 'LOGNAME': 'cltbld', 23:06:07 INFO - 'MAIL': '/var/mail/cltbld', 23:06:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:07 INFO - 'MOZ_NO_REMOTE': '1', 23:06:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:07 INFO - 'NO_EM_RESTART': '1', 23:06:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:07 INFO - 'PWD': '/builds/slave/test', 23:06:07 INFO - 'SHELL': '/bin/bash', 23:06:07 INFO - 'SHLVL': '1', 23:06:07 INFO - 'TERM': 'linux', 23:06:07 INFO - 'TMOUT': '86400', 23:06:07 INFO - 'USER': 'cltbld', 23:06:07 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470978576.835875-337868573', 23:06:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:07 INFO - '_': '/tools/buildbot/bin/python'} 23:06:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:07 INFO - Downloading/unpacking jsonschema==2.5.1 23:06: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 23:06: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 23:06: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 23:06: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 23:06: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 23:06: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 23:06:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:06:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:06:09 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 23:06:09 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 23:06:09 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 23:06:09 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 23:06:09 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 23:06:09 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 23:06:09 INFO - Downloading functools32-3.2.3-2.tar.gz 23:06:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:06:09 INFO - warning: no files found matching '*.txt' 23:06:09 INFO - no previously-included directories found matching 'build' 23:06:09 INFO - no previously-included directories found matching 'dist' 23:06:09 INFO - no previously-included directories found matching '.git*' 23:06:09 INFO - Installing collected packages: jsonschema, functools32 23:06:09 INFO - Running setup.py install for functools32 23:06:09 INFO - warning: no files found matching '*.txt' 23:06:09 INFO - no previously-included directories found matching 'build' 23:06:09 INFO - no previously-included directories found matching 'dist' 23:06:09 INFO - no previously-included directories found matching '.git*' 23:06:09 INFO - Successfully installed jsonschema functools32 23:06:09 INFO - Cleaning up... 23:06:09 INFO - Return code: 0 23:06:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:06:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:06:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe37030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f63b0>, '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 0x10f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7740>, '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': '4300f881736b422476174874000001bc-1470978576.835875-337868573', '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 23:06:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 23:06:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 23:06:09 INFO - Using env: {'DISPLAY': ':0', 23:06:09 INFO - 'HOME': '/home/cltbld', 23:06:09 INFO - 'LANG': 'en_US.UTF-8', 23:06:09 INFO - 'LANGUAGE': 'en_US:en', 23:06:09 INFO - 'LOGNAME': 'cltbld', 23:06:09 INFO - 'MAIL': '/var/mail/cltbld', 23:06:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:09 INFO - 'MOZ_NO_REMOTE': '1', 23:06:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:09 INFO - 'NO_EM_RESTART': '1', 23:06:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:09 INFO - 'PWD': '/builds/slave/test', 23:06:09 INFO - 'SHELL': '/bin/bash', 23:06:09 INFO - 'SHLVL': '1', 23:06:09 INFO - 'TERM': 'linux', 23:06:09 INFO - 'TMOUT': '86400', 23:06:09 INFO - 'USER': 'cltbld', 23:06:09 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470978576.835875-337868573', 23:06:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:09 INFO - '_': '/tools/buildbot/bin/python'} 23:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:06:10 INFO - Cleaning up... 23:06:10 INFO - Return code: 0 23:06:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe37030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f63b0>, '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 0x10f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7740>, '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': '4300f881736b422476174874000001bc-1470978576.835875-337868573', '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 23:06:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:06:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:06:10 INFO - Using env: {'DISPLAY': ':0', 23:06:10 INFO - 'HOME': '/home/cltbld', 23:06:10 INFO - 'LANG': 'en_US.UTF-8', 23:06:10 INFO - 'LANGUAGE': 'en_US:en', 23:06:10 INFO - 'LOGNAME': 'cltbld', 23:06:10 INFO - 'MAIL': '/var/mail/cltbld', 23:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:10 INFO - 'MOZ_NO_REMOTE': '1', 23:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:10 INFO - 'NO_EM_RESTART': '1', 23:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:10 INFO - 'PWD': '/builds/slave/test', 23:06:10 INFO - 'SHELL': '/bin/bash', 23:06:10 INFO - 'SHLVL': '1', 23:06:10 INFO - 'TERM': 'linux', 23:06:10 INFO - 'TMOUT': '86400', 23:06:10 INFO - 'USER': 'cltbld', 23:06:10 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470978576.835875-337868573', 23:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:10 INFO - '_': '/tools/buildbot/bin/python'} 23:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:10 INFO - Downloading/unpacking blobuploader==1.2.4 23:06: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 23:06: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 23:06: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 23:06: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 23:06: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 23:06: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 23:06:12 INFO - Downloading blobuploader-1.2.4.tar.gz 23:06:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:06:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:06:12 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 23:06:12 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 23:06:12 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 23:06:12 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 23:06:12 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 23:06:12 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 23:06:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:06:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:14 INFO - Downloading docopt-0.6.1.tar.gz 23:06:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:06:14 INFO - Installing collected packages: blobuploader, requests, docopt 23:06:14 INFO - Running setup.py install for blobuploader 23:06:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:06:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:06:14 INFO - Running setup.py install for requests 23:06:14 INFO - Running setup.py install for docopt 23:06:14 INFO - Successfully installed blobuploader requests docopt 23:06:14 INFO - Cleaning up... 23:06:14 INFO - Return code: 0 23:06:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:06:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:06:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe37030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f63b0>, '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 0x10f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7740>, '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': '4300f881736b422476174874000001bc-1470978576.835875-337868573', '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 23:06:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:06:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:06:14 INFO - Using env: {'DISPLAY': ':0', 23:06:14 INFO - 'HOME': '/home/cltbld', 23:06:14 INFO - 'LANG': 'en_US.UTF-8', 23:06:14 INFO - 'LANGUAGE': 'en_US:en', 23:06:14 INFO - 'LOGNAME': 'cltbld', 23:06:14 INFO - 'MAIL': '/var/mail/cltbld', 23:06:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:14 INFO - 'MOZ_NO_REMOTE': '1', 23:06:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:14 INFO - 'NO_EM_RESTART': '1', 23:06:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:14 INFO - 'PWD': '/builds/slave/test', 23:06:14 INFO - 'SHELL': '/bin/bash', 23:06:14 INFO - 'SHLVL': '1', 23:06:14 INFO - 'TERM': 'linux', 23:06:14 INFO - 'TMOUT': '86400', 23:06:14 INFO - 'USER': 'cltbld', 23:06:14 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470978576.835875-337868573', 23:06:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:14 INFO - '_': '/tools/buildbot/bin/python'} 23:06:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:06:14 INFO - Running setup.py (path:/tmp/pip-WxHvjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:06:15 INFO - Running setup.py (path:/tmp/pip-R3mGZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:06:15 INFO - Running setup.py (path:/tmp/pip-wzSG8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:06:15 INFO - Running setup.py (path:/tmp/pip-z003d9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:06:15 INFO - Running setup.py (path:/tmp/pip-sKKZZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:06:15 INFO - Running setup.py (path:/tmp/pip-gXtlCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:06:15 INFO - Running setup.py (path:/tmp/pip-DgENs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:06:15 INFO - Running setup.py (path:/tmp/pip-4dfmmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:06:15 INFO - Running setup.py (path:/tmp/pip-6ZOtqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:06:15 INFO - Running setup.py (path:/tmp/pip-N1uZR2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:06:15 INFO - Running setup.py (path:/tmp/pip-I6XdAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:06:15 INFO - Running setup.py (path:/tmp/pip-km90QS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:06:15 INFO - Running setup.py (path:/tmp/pip-anEIPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:06:15 INFO - Running setup.py (path:/tmp/pip-Ti2cjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:15 INFO - Running setup.py (path:/tmp/pip-eKL5im-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:06:16 INFO - Running setup.py (path:/tmp/pip-Hqxybt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:06:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:06:16 INFO - Running setup.py (path:/tmp/pip-nIjBwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:06:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:06:16 INFO - Running setup.py install for manifestparser 23:06:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:06:16 INFO - Running setup.py install for mozcrash 23:06:16 INFO - Running setup.py install for mozdebug 23:06:16 INFO - Running setup.py install for mozdevice 23:06:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:06:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:06:16 INFO - Running setup.py install for mozfile 23:06:16 INFO - Running setup.py install for mozhttpd 23:06:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:06:16 INFO - Running setup.py install for mozinfo 23:06:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:06:16 INFO - Running setup.py install for mozInstall 23:06:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:06:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:06:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:06:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:06:16 INFO - Running setup.py install for mozleak 23:06:17 INFO - Running setup.py install for mozlog 23:06:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:06:17 INFO - Running setup.py install for moznetwork 23:06:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:06:17 INFO - Running setup.py install for mozprocess 23:06:17 INFO - Running setup.py install for mozprofile 23:06:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:06:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:06:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:06:17 INFO - Running setup.py install for mozrunner 23:06:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:06:17 INFO - Running setup.py install for mozscreenshot 23:06:17 INFO - Running setup.py install for moztest 23:06:17 INFO - Running setup.py install for mozversion 23:06:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:06:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:06:17 INFO - Cleaning up... 23:06:17 INFO - Return code: 0 23:06:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:06:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:06:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe37030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f63b0>, '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 0x10f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7740>, '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': '4300f881736b422476174874000001bc-1470978576.835875-337868573', '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 23:06:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:06:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:06:17 INFO - Using env: {'DISPLAY': ':0', 23:06:17 INFO - 'HOME': '/home/cltbld', 23:06:17 INFO - 'LANG': 'en_US.UTF-8', 23:06:17 INFO - 'LANGUAGE': 'en_US:en', 23:06:17 INFO - 'LOGNAME': 'cltbld', 23:06:17 INFO - 'MAIL': '/var/mail/cltbld', 23:06:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:17 INFO - 'MOZ_NO_REMOTE': '1', 23:06:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:17 INFO - 'NO_EM_RESTART': '1', 23:06:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:17 INFO - 'PWD': '/builds/slave/test', 23:06:17 INFO - 'SHELL': '/bin/bash', 23:06:17 INFO - 'SHLVL': '1', 23:06:17 INFO - 'TERM': 'linux', 23:06:17 INFO - 'TMOUT': '86400', 23:06:17 INFO - 'USER': 'cltbld', 23:06:17 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470978576.835875-337868573', 23:06:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:17 INFO - '_': '/tools/buildbot/bin/python'} 23:06:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:06:18 INFO - Running setup.py (path:/tmp/pip-CKlblx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 23:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:06:18 INFO - Running setup.py (path:/tmp/pip-PQPvEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:06:18 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)) 23:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:06:18 INFO - Running setup.py (path:/tmp/pip-0X6fil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:06:18 INFO - Running setup.py (path:/tmp/pip-6gVrLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:06:18 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)) 23:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:06:18 INFO - Running setup.py (path:/tmp/pip-DtS_QM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 23:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:06:18 INFO - Running setup.py (path:/tmp/pip-jwYWn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 23:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:06:18 INFO - Running setup.py (path:/tmp/pip-ioNCox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 23:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:06:18 INFO - Running setup.py (path:/tmp/pip-1i6xkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 23:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:06:18 INFO - Running setup.py (path:/tmp/pip-zKao4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 23:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:06:18 INFO - Running setup.py (path:/tmp/pip-SwhCN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:06:18 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)) 23:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:06:18 INFO - Running setup.py (path:/tmp/pip-EAAt50-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 23:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:06:18 INFO - Running setup.py (path:/tmp/pip-NdHwy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:06:19 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)) 23:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:06:19 INFO - Running setup.py (path:/tmp/pip-X0nm7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:06:19 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)) 23:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:06:19 INFO - Running setup.py (path:/tmp/pip-bgmMQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:06:19 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)) 23:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:19 INFO - Running setup.py (path:/tmp/pip-jZF3zc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 23:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:06:19 INFO - Running setup.py (path:/tmp/pip-doVwU4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:06:19 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)) 23:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:06:19 INFO - Running setup.py (path:/tmp/pip-pa2lLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 23:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:06:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:06:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:06:22 INFO - Downloading blessings-1.6.tar.gz 23:06:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:06:22 INFO - Installing collected packages: blessings 23:06:22 INFO - Running setup.py install for blessings 23:06:22 INFO - Successfully installed blessings 23:06:22 INFO - Cleaning up... 23:06:22 INFO - Return code: 0 23:06:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:06:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:06:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:06:22 INFO - Reading from file tmpfile_stdout 23:06:22 INFO - Current package versions: 23:06:22 INFO - argparse == 1.2.1 23:06:22 INFO - blessings == 1.6 23:06:22 INFO - blobuploader == 1.2.4 23:06:22 INFO - docopt == 0.6.1 23:06:22 INFO - functools32 == 3.2.3-2 23:06:22 INFO - jsonschema == 2.5.1 23:06:22 INFO - manifestparser == 1.1 23:06:22 INFO - mozInstall == 1.12 23:06:22 INFO - mozcrash == 0.17 23:06:22 INFO - mozdebug == 0.1 23:06:22 INFO - mozdevice == 0.48 23:06:22 INFO - mozfile == 1.2 23:06:22 INFO - mozhttpd == 0.7 23:06:22 INFO - mozinfo == 0.9 23:06:22 INFO - mozleak == 0.1 23:06:22 INFO - mozlog == 3.3 23:06:22 INFO - moznetwork == 0.27 23:06:22 INFO - mozprocess == 0.23 23:06:22 INFO - mozprofile == 0.28 23:06:22 INFO - mozrunner == 6.12 23:06:22 INFO - mozscreenshot == 0.1 23:06:22 INFO - mozsystemmonitor == 0.3 23:06:22 INFO - moztest == 0.7 23:06:22 INFO - mozversion == 1.4 23:06:22 INFO - psutil == 3.1.1 23:06:22 INFO - requests == 1.2.3 23:06:22 INFO - wsgiref == 0.1.2 23:06:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:06:22 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')]} 23:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:22 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')]} 23:06:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:22 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 0xe37030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f63b0>, '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 0x10f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7740>, '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': '4300f881736b422476174874000001bc-1470978576.835875-337868573', '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 23:06:22 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 23:06:22 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 23:06:22 INFO - Using env: {'DISPLAY': ':0', 23:06:22 INFO - 'HOME': '/home/cltbld', 23:06:22 INFO - 'LANG': 'en_US.UTF-8', 23:06:22 INFO - 'LANGUAGE': 'en_US:en', 23:06:22 INFO - 'LOGNAME': 'cltbld', 23:06:22 INFO - 'MAIL': '/var/mail/cltbld', 23:06:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:22 INFO - 'MOZ_NO_REMOTE': '1', 23:06:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:22 INFO - 'NO_EM_RESTART': '1', 23:06:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:22 INFO - 'PWD': '/builds/slave/test', 23:06:22 INFO - 'SHELL': '/bin/bash', 23:06:22 INFO - 'SHLVL': '1', 23:06:22 INFO - 'TERM': 'linux', 23:06:22 INFO - 'TMOUT': '86400', 23:06:22 INFO - 'USER': 'cltbld', 23:06:22 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470978576.835875-337868573', 23:06:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:22 INFO - '_': '/tools/buildbot/bin/python'} 23:06:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:23 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)) 23:06:23 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)) 23:06:23 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)) 23:06:23 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)) 23:06:23 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)) 23:06:23 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)) 23:06:23 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)) 23:06:23 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)) 23:06:23 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)) 23:06:23 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)) 23:06:23 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)) 23:06:23 INFO - Cleaning up... 23:06:23 INFO - Return code: 0 23:06:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:06:23 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')]} 23:06:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:06:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:23 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')]} 23:06:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:06:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:06:23 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 0xe37030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f8180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f63b0>, '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 0x10f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7740>, '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': '4300f881736b422476174874000001bc-1470978576.835875-337868573', '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 23:06:23 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 23:06:23 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 23:06:23 INFO - Using env: {'DISPLAY': ':0', 23:06:23 INFO - 'HOME': '/home/cltbld', 23:06:23 INFO - 'LANG': 'en_US.UTF-8', 23:06:23 INFO - 'LANGUAGE': 'en_US:en', 23:06:23 INFO - 'LOGNAME': 'cltbld', 23:06:23 INFO - 'MAIL': '/var/mail/cltbld', 23:06:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:23 INFO - 'MOZ_NO_REMOTE': '1', 23:06:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:23 INFO - 'NO_EM_RESTART': '1', 23:06:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:23 INFO - 'PWD': '/builds/slave/test', 23:06:23 INFO - 'SHELL': '/bin/bash', 23:06:23 INFO - 'SHLVL': '1', 23:06:23 INFO - 'TERM': 'linux', 23:06:23 INFO - 'TMOUT': '86400', 23:06:23 INFO - 'USER': 'cltbld', 23:06:23 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470978576.835875-337868573', 23:06:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:23 INFO - '_': '/tools/buildbot/bin/python'} 23:06:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:06:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:06:23 INFO - Cleaning up... 23:06:23 INFO - Return code: 0 23:06:23 INFO - Running post-action listener: _resource_record_post_action 23:06:23 INFO - Running post-action listener: _start_resource_monitoring 23:06:23 INFO - Starting resource monitoring. 23:06:23 INFO - [mozharness: 2016-08-12 06:06:23.348379Z] Finished create-virtualenv step (success) 23:06:23 INFO - [mozharness: 2016-08-12 06:06:23.348819Z] Running install step. 23:06:23 INFO - Running pre-action listener: _resource_record_pre_action 23:06:23 INFO - Running main action method: install 23:06:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:06:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:06:23 INFO - Reading from file tmpfile_stdout 23:06:23 INFO - Detecting whether we're running mozinstall >=1.0... 23:06:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:06:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:06:23 INFO - Reading from file tmpfile_stdout 23:06:23 INFO - Output received: 23:06:23 INFO - Usage: mozinstall [options] installer 23:06:23 INFO - Options: 23:06:23 INFO - -h, --help show this help message and exit 23:06:23 INFO - -d DEST, --destination=DEST 23:06:23 INFO - Directory to install application into. [default: 23:06:23 INFO - "/builds/slave/test"] 23:06:23 INFO - --app=APP Application being installed. [default: firefox] 23:06:23 INFO - mkdir: /builds/slave/test/build/application 23:06:23 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'] 23:06:23 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 23:06:40 INFO - Reading from file tmpfile_stdout 23:06:40 INFO - Output received: 23:06:40 INFO - /builds/slave/test/build/application/firefox/firefox 23:06:40 INFO - Running post-action listener: _resource_record_post_action 23:06:40 INFO - [mozharness: 2016-08-12 06:06:40.547714Z] Finished install step (success) 23:06:40 INFO - [mozharness: 2016-08-12 06:06:40.547961Z] Running run-tests step. 23:06:40 INFO - Running pre-action listener: _resource_record_pre_action 23:06:40 INFO - Running main action method: run_tests 23:06:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:06:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:06:40 INFO - Python 2.7.3 23:06:40 INFO - Return code: 0 23:06:40 INFO - grabbing minidump binary from tooltool 23:06:40 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')]} 23:06:40 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 0x10f63b0>, '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 0x10f72b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f7740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:06:40 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 23:06:40 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 23:06:40 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 23:06:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:06:40 INFO - Return code: 0 23:06:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:06:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:06:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:06:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:06:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:06:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 23:06:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 23:06:40 INFO - Using env: {'DISPLAY': ':0', 23:06:40 INFO - 'HOME': '/home/cltbld', 23:06:40 INFO - 'LANG': 'en_US.UTF-8', 23:06:40 INFO - 'LANGUAGE': 'en_US:en', 23:06:40 INFO - 'LOGNAME': 'cltbld', 23:06:40 INFO - 'MAIL': '/var/mail/cltbld', 23:06:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:06:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:06:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:06:40 INFO - 'MOZ_NO_REMOTE': '1', 23:06:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:06:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:06:40 INFO - 'NO_EM_RESTART': '1', 23:06:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:06:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:06:40 INFO - 'PWD': '/builds/slave/test', 23:06:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:06:40 INFO - 'SHELL': '/bin/bash', 23:06:40 INFO - 'SHLVL': '1', 23:06:40 INFO - 'TERM': 'linux', 23:06:40 INFO - 'TMOUT': '86400', 23:06:40 INFO - 'USER': 'cltbld', 23:06:40 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1470978576.835875-337868573', 23:06:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:06:40 INFO - '_': '/tools/buildbot/bin/python'} 23:06:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 23:06:40 INFO - mozversion application_buildid: 20160811203012 23:06:40 INFO - mozversion application_changeset: 6f2ba7787816fd01f77c30e3bdb68400db74bf0c 23:06:40 INFO - mozversion application_display_name: Nightly 23:06:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:06:40 INFO - mozversion application_name: Firefox 23:06:40 INFO - mozversion application_remotingname: firefox 23:06:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:06:40 INFO - mozversion application_vendor: Mozilla 23:06:40 INFO - mozversion application_version: 51.0a1 23:06:40 INFO - mozversion platform_buildid: 20160811203012 23:06:40 INFO - mozversion platform_changeset: 6f2ba7787816fd01f77c30e3bdb68400db74bf0c 23:06:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:06:40 INFO - mozversion platform_version: 51.0a1 23:06:40 INFO - using testdate: 1470982000 23:06:40 INFO - actual date: 1470982000 23:06:40 INFO - starting webserver on 'localhost:53684' 23:06:40 INFO - SUITE-START | Running 2 tests 23:06:40 INFO - TEST-START | dromaeo_css 23:06:40 INFO - operating with platform_type : linux_ 23:06:40 INFO - Initialising browser for dromaeo_css test... 23:06:40 INFO - TEST-INFO | started process 1761 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjgP0Yq/profile http://localhost:53684/getInfo.html) 23:06:44 INFO - PROCESS | 1761 | __metrics Screen width/height:1600/1200 23:06:44 INFO - PROCESS | 1761 | colorDepth:24 23:06:44 INFO - PROCESS | 1761 | Browser inner width/height: 1024/697 23:06:44 INFO - PROCESS | 1761 | __metrics 23:06:45 INFO - PROCESS | 1761 | 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" 23:06:45 INFO - PROCESS | 1761 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:06:46 INFO - PROCESS | 1761 | console.error: PushService: 23:06:46 INFO - PROCESS | 1761 | stateChangeProcessEnqueue: Error transitioning state 23:06:46 INFO - PROCESS | 1761 | UnknownError 23:06:46 INFO - TEST-INFO | 1761: exit 0 23:06:46 INFO - Browser initialized. 23:06:46 INFO - Running cycle 1/1 for dromaeo_css test... 23:06:46 INFO - TEST-INFO | started process 1843 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjgP0Yq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:06:58 INFO - PROCESS | 1843 | RSS: Main: 155484160 23:06:58 INFO - PROCESS | 1843 | 23:07:50 INFO - PROCESS | 1843 | 1470982070351 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] 23:09:59 INFO - PROCESS | 1843 | Cycle 1(1): loaded http://localhost:53684/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53684/tests/dromaeo/cssquery-ext.html) 23:10:00 INFO - PROCESS | 1843 | RSS: Main: 268689408 23:10:00 INFO - PROCESS | 1843 | 23:13:03 INFO - PROCESS | 1843 | Cycle 1(1): loaded http://localhost:53684/tests/dromaeo/cssquery-ext.html (next: http://localhost:53684/tests/dromaeo/cssquery-jquery.html) 23:13:03 INFO - PROCESS | 1843 | RSS: Main: 243138560 23:13:03 INFO - PROCESS | 1843 | 23:16:05 INFO - PROCESS | 1843 | Cycle 1(1): loaded http://localhost:53684/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53684/tests/dromaeo/cssquery-mootools.html) 23:16:06 INFO - PROCESS | 1843 | RSS: Main: 215846912 23:16:06 INFO - PROCESS | 1843 | 23:19:08 INFO - PROCESS | 1843 | Cycle 1(1): loaded http://localhost:53684/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53684/tests/dromaeo/cssquery-prototype.html) 23:19:09 INFO - PROCESS | 1843 | RSS: Main: 219332608 23:19:09 INFO - PROCESS | 1843 | 23:22:11 INFO - PROCESS | 1843 | Cycle 1(1): loaded http://localhost:53684/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53684/tests/dromaeo/cssquery-yui.html) 23:22:12 INFO - PROCESS | 1843 | RSS: Main: 184774656 23:22:12 INFO - PROCESS | 1843 | 23:25:15 INFO - PROCESS | 1843 | Cycle 1(1): loaded http://localhost:53684/tests/dromaeo/cssquery-yui.html (next: http://localhost:53684/tests/dromaeo/cssquery-dojo.html) 23:25:15 INFO - PROCESS | 1843 | RSS: Main: 272269312 23:25:15 INFO - PROCESS | 1843 | 23:25:15 INFO - PROCESS | 1843 | __start_tp_report 23:25:15 INFO - PROCESS | 1843 | _x_x_mozilla_page_load 23:25:15 INFO - PROCESS | 1843 | _x_x_mozilla_page_load_details 23:25:15 INFO - PROCESS | 1843 | |i|pagename|runs| 23:25:15 INFO - PROCESS | 1843 | |0;dojo.html;3068.969310306896;3097.4269760094385;3112.0819358289305;3117.984410077952;3124.968750312496;5312.256284120226;5388.568914486841;5419.3225846769155;5428.4842939920745;5493.505584497394;5442.156465747806;5445.455454454553;5469.699166545848;5502.202180683808;5539.335279766424;4870.586000189979;4905.215165573509;4936.111499930011;4943.1102401567705;5143.81996630118;5063.772130254148;5091.898162036757;5111.13110771168;5123.103456895047;5124.8975020499565;4908.705477671351;4942.986687729007;4954.033963377143;5002.899942001176;5062.772175252104;4899.902001959977;4902.730349830758;4915.877103072416;5092;5093.872653183663;4951.90096198074;4958.380202474691;4959.727215003173;4969.428515720702;5002.799888004475;5297.549708274802;5411.242426060355;5459.426760190163;5492.972535137339;5536.806211782568;5818.127280907897;5828.06750919855;5838.883222335572;5900.232969713909;5903.144044113623;5887.0580707086665;5936.584439089265;5947.851303717398;5960.940390596082;5965.850853728692;5253.474652534716;5327;5412.377576578744;5498.065328894098;5529.281193444826;6002.6698531580305;6005.129256257818;6045.486133678599;6050.062240352752;6060.303065147476;5736.5123964462655;5753.079507278815;5801.129830525455;5803.709814509258;5806.361300256968;5629.183768353566;5773.076307790818;5816.592838501264;5894.115882617556;5904.76380944766;5821.068629019422;5829.47534721877;5831.825045248649;5874.765009399662;5883.61756485827;5787.305523337226;5842.941570584325;5847.3275573308765;5860.912086318709;5867.559933005042;4331.480222373272;4371.890702732457;4414.779261036935;4453.109378124388;4488.057507923308;3907.316219661548;3958.1687845552183;3963.128111815396;3993.0416699991792;4012.0371110933747;5556.86107847299;5561.610687251854;5563.693996830132;5563.860903477364;5600.467955544217;5614.101743720985;5805.10020946754;5844.26946631671;5907.527397808165;5913.201717768132;5498.367687715964;5507.311586051744;5508.64193827408;5524.751386187631;5525.226468294442;5083.135866902636;5087.720175390389;5101.846944591594;5102.08162530748;5144.588432925357;5890.941090589039;5971.193888824953;5996.940030599638;6064.727087281083;6075.2405949256345;5850.034744267148;5852.18069470283;5853.678047707247;5894.174815525916;5903.763849445974;6042.758289668364;6042.939570604238;6047.183630210041;6050.364711705208;6053.334133245251;5640.294963129609;5669.6314739541795;5702.657840529581;5704.543636508986;5738.626989245686;5794.304683438015;5836.795712150054;5842.1820945068575;5842.415758424294;5881.94118058831;5725.742341594555;5738.655680659173;5740.995325817881;5742.052561327334;5744.827655170351;5400.081986062457;5675.659460432387;5710.8001219957105;5720.485156335783;5724.141378793214;5702.942970570407;5703.258576385209;5703.714814259188;5744.569157313134;5758.452946970031;5783.334916484658;5791.420857914175;5842.795502157404;5851.1515830205235;5853.590248682722;5374.381946076252;5509.311336082989;5581.832545023656;5642.774289028393;5648.802291919763 23:25:15 INFO - PROCESS | 1843 | |1;ext.html;590.6072461812895;606.1392822192487;611.5932904618431;628.9779857704981;629.4649547884296;44671.77664111679;45856.77071614646;45915.311270330974;46010;48557.27164092541;44379.334309985374;44417.33373999393;44485.7775711121;44499;44540.55459445404;8939.687110951118;9121.726348209564;9125.543722813865;9127.589258483351;9128.40665356753;8997.505137217451;9081.318901082444;9086.409383390059;9093.909060909373;9094.590743416562;9083.364164508486;9129.406588571755;9136.771580710469;9136.771580710501;9137.040610735876;9036.096390360977;9085.500297483635;9088.227500662451;9091.27269818413;9100.044495328028;8920.152585504367;8983.685571004984;8990.235829954461;8994.415363001384;8998.415103018282;44137.33793993061;44433.89010263796;44475.55524444779;44552.554474455486;44562;3626.873059442933;3674.1365779041903;3722.3671975763914;3783.5838057813617;3793.393057110849;32200.67799322;34595.30809383798;34843.303133937436;34889.30221395583;34914;4364.869053928387;4457.576530229623;4468.218061839165;4486.910261794778;4615.284630882219;382367;391586;391809;391933;394479;34909;35939.28121437609;66721.66639166774;67499.66250168718;67548.66225668938;39410.21179576393;39432;39485.60514394877;39661.40507892384;39727.60272397239;13614;13887.166769993833;14030.649233769032;14161.29193540319;14388;12447.875521244852;12728.29994350301;12730.045246606356;12733.426995785212;12735.172213806072;7879.487833290817;7913.643886025027;8393.916060839436;8961.865572016424;9085.13691199335;3467.809270490097;3481.268933523938;3490.650934906489;3491.122488697313;3508.280802435546;1041.833306670929;1072.651388298806;1086.277625379114;1108.9409613818784;1113.3486910157487;33614.32771344559;34209;34305.14237144091;34313.4322405677;34330.31339373199;1107.1802282126696;1108.733903863067;1121.5681962444517;1122.7922834275685;1158.2529268621693;17358.218880150424;17686.292548297923;17856.285748569913;17865.642687146443;17885.821141788674;612203;622248;622668;623341;624546;40598;40688.59311406848;40834.18331633351;40993.38509922354;41028.79485602553;1207.2756346192214;1336.325155796336;1346.710457251676;1373.3545233740126;1381.4405165907824;32912.67087329192;35333.469997949534;35411.114722131126;35485.35118257899;35598.466023010194;51361.48638513716;52014;52082.739586301825;52094.21858672047;52133.7393313031;429505;432175;432181;433073;433730;26506.204813855617;30521.23696907595;30774.84612576923;31014;31553.21116972094;49703.25445118254;49814.50185498098;50264.49735502598;51039.48960510496;54650.45349546613;42515.7874210627;42914.78542607267;43245.3513197296;43419.782901085295;45087.32369014533;43097.13805723931;43916.560834391246;44122.338164928195;44680.77659611681;44779;43927;44782.77608611936;45015;45171;45206.32190517211;35865.64134358623;39131;39225.2154956905;39573.2085358297;39782.80108599438;30015;30086.849565752033;30098.548521771754;30210.84894575513;30408.239794005327 23:25:15 INFO - PROCESS | 1843 | |2;jquery.html;395.9683225341973;398.17577614338296;403.9373897045958;408.27938688215295;417.4197864967695;13567.864321356783;19114.23543058276;19963.401097967086;20808.16767329307;20808.99999999998;14678.559643210694;14995.800335973123;15496.612584685388;16791.16044197788;16958.83041169588;5692;5769.913451298234;5967.194428752106;5982.641041537521;5997.580169388123;5834.5040671542965;5888;5919.112133180036;5919.852003699921;5928.881422371572;5685.545156387479;5839.708014599253;5878;5893.292804863422;5900.498457631106;5861.443162899518;5877.794277200299;5890.705464726747;5896.852578685524;5897.174395584643;5081.466446023152;5211.843644690665;5252.842414727565;5284.2866213061125;5287.788488460457;23799.405014874766;24360.26919192427;24432.877835610707;24511.632325515133;24603.507929841482;2387.462820865309;2396.221228100874;2397.30478161333;2469.2468797016904;2553.3488960315;14523.128612283297;14608.269586520631;14716.33776480061;15044.473443429428;15763.605909852231;1953.6971769375768;1986.612610540945;1996.9700454493195;2040.36748607932;2046.4270004398793;87243.56378218069;89445;90067;90142;92090.5395473025;10537.367757934395;10802.297850639683;10806.189535784848;10844.240903136704;11455.59905403307;15370.077795332316;15510;15519;15519.844801552066;15521.844781552265;7858.253465920729;8220.8355832883;8338.166183381734;8413.789655258668;8489.533075680773;7946.602669866484;7988.640511177011;8047.396445266511;8223.424360294723;8241.134680858544;6659.733610655519;6779.254282028973;6808.489363297674;6842.794716158423;6912.447004239649;1948.2304489726762;1969.2910552201197;1980.7524059492564;2026.4528577284345;2027.5843452092286;929.2844509727472;1008.7326858382388;1016.6035246253966;1036.2694300518117;1098.5825386353135;20612.969351532363;21165.68251476229;21177.15291388358;21197.36407907765;21256.787432125482;999.9050090241416;1042.5829668132808;1045.268312181476;1045.8588090607823;1060.6340812419703;11123.888761112285;11687.94808467242;11769;11871;11872.525098996117;493885;494928;497833;503020;508484;86751;89331.17357090715;90654;91419.54290228506;91959.54020229857;1036.849656799775;1041.2086814021397;1046.7487802927394;1084.9132069434427;1102.8676558812833;17661.38185163513;17990.820091799436;18332.358367457076;18508.629827403645;18618.44144675662;41943.1611367777;42401;44007.119857603306;44468.55531444644;44816.775916121514;60820;61919.94332270584;62030.68984655048;62816.685916570124;63146.68426657837;5457.536109430743;6063.211782468251;7689.615519224129;7782.649780759766;8071.354291656771;9771.82738071436;13233.3383330835;13759.243241621807;13823.654408639462;13934.58196254114;11925.701857453287;11942.16404851652;12038.578649747216;12124.151309408257;12299.385030748606;11471.082313415074;11620.941895290469;11698.53768278965;11949.72008449894;12031.4585843639;12008;12114;12119.272843629411;12120.75758484843;12476.438560264629;7982.441229113906;7983.483138203723;8120.878186827084;8231.135730748185;8267.049289331804;8992.685256016008;11029.61396351124;11709.414529273672;11847.585334513251;12459.190152640049 23:25:15 INFO - PROCESS | 1843 | |3;mootools.html;1313.7963615639567;1446.4431193990317;1520.3082597418177;1587.3174534949974;1758.6218962922976;8007.399445041616;8389.161083891608;8454.49273043617;8644.56777161141;8645.135486451352;8419.158084191578;8546.743597692064;8562.529060901648;8562.957185214082;8564.65741370346;2383.3207535852284;2421.0315873650593;2422;2424.0667343072955;2427.0534491548224;2362.303120579433;2394.1740099665676;2416.0577374823833;2417.697787776528;2420.080369459603;2355.2463211772238;2388.355144111089;2388.4028992751814;2396.436837343223;2400.9639855402097;2334.6381310896836;2360.291912426274;2362.3975886148924;2372.596658568039;2379.3337865397716;2317.6755254264417;2323.848949818256;2329.813614910803;2338.3335749311364;2341.2273949596593;8456.577171141418;8626.525541095238;8632.266257368132;8653.567321633956;8664.740057798213;5308.495692909168;5493.697846618435;5506.64206826555;5509;5512.751926163332;3492.930141397158;3541.7072768439593;3568.3398571264397;3613.837377318027;3635.963640363589;1147.219890474477;1166.5217260923066;1227.2697744841805;1240.9069319801051;2164.5779073080757;11787.17489775716;11925.880741192565;11939.40302984856;11946.641600751991;11954.462049207807;4632.606228470618;4663.300504924288;4749.810007599726;4769.35613692154;4796.184648609745;9611.231101512001;9613.615455381707;9614.71155865325;9615.855762163574;9625.903740962642;5452.454754524516;5454.372747134051;5459.481349271813;5461.208124821878;5461.672299662033;4373.475182978063;4507.57178068083;4962.106820772296;5040.571551418097;5090.312807770903;3956.8219430125714;3990.780507072081;4027.9798601006805;4078.6125318094732;4082.510098788164;1186.371223251678;1212;1213.071999920062;1223.5839814463125;1224.1125184241355;960.558143254111;969.345691658128;978.9021097890296;988.3857197712155;990.2622546203124;5985.281766187998;6065.605735627259;6087.1173679816175;6108.602940808833;6131.6321020738005;480.1573238965593;480.6275136768962;482.1129122414774;486.77365025263424;495.6084693092417;4208.85269015583;4303.881630850637;4407.184670835842;4535.569120933506;4567.474740404896;10906.945465272782;10987.230893837515;11132.332060076422;11174.608888688857;11230.989210970889;11107.389093599768;11109.777804444027;11116.777154512996;11125.610603628835;11126.499307531181;7891.487053341514;8217.95891020541;8223.42436029484;8404.159584041668;8410.201030902055;6014.759409623566;6081.847953801191;6153.538484613582;6190.41191086846;6319.842003949938;10158.492075396349;10215.540300686636;10406.947965260126;10417.479126043516;10453.895461045597;10024.799504010025;10160.949195253976;10408.479576021016;10444.477776111316;10472.947635261775;7446.962765186139;7538.09542854861;7627.122880868549;7631.732889348847;7652.273034061755;8459.365547583833;8605.483670979762;8610.526421046903;8613.440126391764;8616.870746938675;7707.460477766503;7833.686652533835;7862.764117076496;7910.644021019183;8002.279794818494;7503.474756766974;7521.623918804147;7623.656935437808;7632.427567932538;7659.846803063796;7189.424846012411;7282.235365286569;7342.155652100077;7357;7357.411407087313;5164.431912489698;5294.549963253013;5309.309789727311;5342.557509472498;5527.198556209408;5315.5216030555885;5385.488378604183;5480.479354461319;5500.257465242141;5543 23:25:15 INFO - PROCESS | 1843 | |4;prototype.html;316.1117260497999;323.9271163988103;325.93481303739253;328.9703926646602;333.4348279665964;5233.241180028894;5258.158694608864;5263.289455923454;5267.341582302212;5269.416796578325;4972.9751351243285;5068.163752980763;5085.796568137279;5109.948900510994;5213.165893457048;4018.658414034803;4080.5511393746665;4090.9181816363653;4093.2427500912427;4133.979330103361;4093.5497095319492;4106.466159399289;4121.237571049351;4123.299039163335;4129.669626429878;3872.806359682019;4053.655439287649;4054.2499637567144;4110.732802367851;4129.772862492562;4040.7575545467366;4051.534073581517;4058.9188216235807;4063.2279866825356;4074.0629655179328;3574.303010912873;3589.2821435712963;3596.4245720684567;3596.514470546495;3607.5670919489567;4880.194767863299;5134.5378915897745;5139.717315547643;5145.536901678867;5146.8198613048735;4596.4254468191475;4613.400257966443;4625.4911959684405;4653.883068063674;4682.929756053662;5402.405735369106;5408.945910540923;5433.6196466247375;5435.972820135874;5441.945580544183;3855.575886652466;3919.804009799527;3925.509311336083;3928;3959.307121253769;5633.605717570057;5646.576506761969;5654.37801841797;5679.267823313888;5726.9713651431475;4017.3371393720295;4022.4770779798437;4023.979880100581;4024.959750402517;4026.2350153470748;4099.651529620016;4105.97947010263;4115.629593336614;4120.237756015147;4123.9175216495505;4586.518415566385;4617.307403889444;4622.399088118523;4659.2312268475325;4661.790219440133;5406.189071639285;5433.782648694087;5444.7822087116865;5445.9727701362035;5462.7268636568015;1317.571789168524;1365.1604263377951;1378.23507953085;1380.6341319550327;1383.633337165652;910.4582773249906;928.9628414863465;944.9102335278137;953.1993125774383;954.2175416158822;5207.140821764442;5217.530422262014;5241.737913104405;5249.816256431007;5253.763580638881;5516.365617953907;5532.75102620383;5545.892560826941;5550.58370622205;5550.7779688812;5135.6148288878485;5377.946220537823;5378.838634840961;5379.892402151935;5381.19282107687;2961.6742158362563;2973.52423612221;2984.910507664687;2999.5002498750623;3001.324701942089;5684.971575142181;5767.7404516796005;5825.417458254141;5839.970800145972;5867.442592953663;5655.406182350794;5667.943320566742;5670.5180059695385;5692.6299790513485;5703.173039909273;5700.287464066992;5715.199872017921;5724.969505489052;5726.656400615976;5726.79956201531;5394.78420863161;5549.500544950974;5559;5605.411431799603;5633.746481408264;5567.192757050286;5615.18579805934;5619.943800562106;5624.031588943837;5644.153376993484;5533.391326954113;5747.511461525817;5795.217645617788;5851.297844258716;5883.676397798162;3939.2121575684405;3953.2686453006286;3963.187546552892;3968.047668559467;3993.2013597281243;5636.857993962268;5657.886842263214;5659.773609055756;5695.658260504383;5713.514351280021;5410.21551874968;5463.836084917459;5504.201890725903;5577.163425486047;5578.2748242728185;5425.728713564227;5445.482679145475;5449.836504904859;5467.425920278313;5480.314960629921;5209.71346575942;5349.331333583302;5350.100714246387;5478.260434841245;5487.807926722546;4898.2652602109965;5381.784728610812;5500.789826238221;5505.421930697219;5508.394076651645;5353.705546194841;5378.838634840961;5392.573341996196;5394.9460505394445;5404.189371594292 23:25:15 INFO - PROCESS | 1843 | |5;yui.html;729.62424351459;771.5332224004474;805.842860642175;846.6740304982579;898.793277546164;16513.42203022893;17280.740788888175;17308.653826923455;17336.133193340345;17385.652286954253;15634.530964071068;15874.761878571831;15900.52298431046;15910.602234944132;15913.99999999997;645.886969780289;795.6300320351036;806.395203597302;817.480899628734;819.9385046121535;797.7606717984581;807.9980823778502;810.05628442864;817.342039658075;818.2880893622556;882.5543100734152;882.7175303902753;883.4964070479829;884.0496466298755;884.3588398411165;673.4713250098698;834.3575446905849;855.3969451536714;877.745453818395;878.6090189865513;633.2179757998867;633.3571425003626;633.4077637409038;633.575504412045;633.6388258692547;14307.213103279315;14393.640158996004;14409.927950360287;14415.927920360436;14448.49430269946;14491.347889345005;14592.124472531683;14736.263186840722;14817.18505482198;15034.097954122679;13512.662183445394;13625.182489050689;13677.658058548615;13868.722625547534;13971.510997115052;4413.404190434282;4497.505274419811;4527.139843429771;4529.7735113244535;4579.198640237945;83250;83317.58341208316;83902.16097839005;84282.57858710729;85723;11066.612668556561;11606.361650109156;11623.418829058513;11635.88364116365;11932.164748467698;22283.442913926956;22306.77693223047;22337.888310558345;22425.55148897013;22509.099636014704;8616.526091065052;8647.783805404915;8675.132486751274;8711.303095752324;9058.864117038249;4404.7357158570585;4471.8658440246845;4512.4133862597655;4523.2988886722615;4567.977160114178;3238.6923242292414;3342.131045928076;3346.113279980807;3348.8325583720716;3350.782199157047;610.6092101055328;611.5718996702237;617.102116420607;617.3147805935408;618.5793660311032;696.4150113904344;698.9965050174717;705.396885662751;709.2198581560345;725.7641266588274;9181.081891810765;9694;9847.261455390875;9994.500274986221;10021.699349019542;581.0180794457353;590.4184378387286;674.6828990374516;675.1297468511248;684.832216107057;4493.213687604656;4586.862394128181;4841.443234028132;4944.90110197794;4945.8021679132435;123554;123556;129822.45621403205;130743.34628326798;132689;108761;109349.45325273323;110112;112580;114667;91329.54335228415;93841.5307923456;94086;95137;98168.50915745518;10548.208884333859;10744.73138171552;10762.19283553721;10777.470542809331;10909.509072091616;55365.723171383885;55597;56088.71955640196;57401;57525.13712294403;74695.62652186705;85477;85576;86571;88056;13338.466461341437;13435.395407206895;14225.64435889111;14379.137251764927;14402.711945761235;15850.841491585397;16061.518154455385;16331.59171020734;16371.42700005494;17046.744298835776;14701.41194352214;14740.410383584536;14981.550553483414;15500.224988750742;15831.762523562385;14259.714805703621;14263.144211347353;14348;14726.410943562138;14980.700385992437;14611.707765844836;14612.78080828767;14786.482473113389;14874.77687834705;15153.482149493173;11104;11676.88323116758;12005.219660722025;12333.136680432284;12392.504299827906;12139.939300303442;12165.270083795001;12311.766175368473;12341.753164936472;12375.69060773452 23:25:15 INFO - PROCESS | 1843 | __end_tp_report 23:25:15 INFO - PROCESS | 1843 | __start_cc_report 23:25:15 INFO - PROCESS | 1843 | _x_x_mozilla_cycle_collect,1009 23:25:15 INFO - PROCESS | 1843 | __end_cc_report 23:25:15 INFO - PROCESS | 1843 | __startTimestamp1470983115411__endTimestamp 23:25:15 INFO - PROCESS | 1843 | 23:25:15 INFO - PROCESS | 1843 | ------- Summary: start ------- 23:25:15 INFO - PROCESS | 1843 | Number of tests: 6 23:25:15 INFO - PROCESS | 1843 | 23:25:15 INFO - PROCESS | 1843 | [#0] dojo.html Cycles:165 Average:5431.48 Median:5642.77 stddev:626.63 (11.1%) stddev-sans-first:600.52 23:25:15 INFO - PROCESS | 1843 | Values: 3069.0 3097.4 3112.1 3118.0 3125.0 5312.3 5388.6 5419.3 5428.5 5493.5 5442.2 5445.5 5469.7 5502.2 5539.3 4870.6 4905.2 4936.1 4943.1 5143.8 5063.8 5091.9 5111.1 5123.1 5124.9 4908.7 4943.0 4954.0 5002.9 5062.8 4899.9 4902.7 4915.9 5092.0 5093.9 4951.9 4958.4 4959.7 4969.4 5002.8 5297.5 5411.2 5459.4 5493.0 5536.8 5818.1 5828.1 5838.9 5900.2 5903.1 5887.1 5936.6 5947.9 5960.9 5965.9 5253.5 5327.0 5412.4 5498.1 5529.3 6002.7 6005.1 6045.5 6050.1 6060.3 5736.5 5753.1 5801.1 5803.7 5806.4 5629.2 5773.1 5816.6 5894.1 5904.8 5821.1 5829.5 5831.8 5874.8 5883.6 5787.3 5842.9 5847.3 5860.9 5867.6 4331.5 4371.9 4414.8 4453.1 4488.1 3907.3 3958.2 3963.1 3993.0 4012.0 5556.9 5561.6 5563.7 5563.9 5600.5 5614.1 5805.1 5844.3 5907.5 5913.2 5498.4 5507.3 5508.6 5524.8 5525.2 5083.1 5087.7 5101.8 5102.1 5144.6 5890.9 5971.2 5996.9 6064.7 6075.2 5850.0 5852.2 5853.7 5894.2 5903.8 6042.8 6042.9 6047.2 6050.4 6053.3 5640.3 5669.6 5702.7 5704.5 5738.6 5794.3 5836.8 5842.2 5842.4 5881.9 5725.7 5738.7 5741.0 5742.1 5744.8 5400.1 5675.7 5710.8 5720.5 5724.1 5702.9 5703.3 5703.7 5744.6 5758.5 5783.3 5791.4 5842.8 5851.2 5853.6 5374.4 5509.3 5581.8 5642.8 5648.8 23:25:15 INFO - PROCESS | 1843 | 23:25:15 INFO - PROCESS | 1843 | [#1] ext.html Cycles:180 Average:62926.75 Median:237636.07 stddev:130970.50 (55.1%) stddev-sans-first:131254.28 23:25:15 INFO - PROCESS | 1843 | Values: 590.6 606.1 611.6 629.0 629.5 44671.8 45856.8 45915.3 46010.0 48557.3 44379.3 44417.3 44485.8 44499.0 44540.6 8939.7 9121.7 9125.5 9127.6 9128.4 8997.5 9081.3 9086.4 9093.9 9094.6 9083.4 9129.4 9136.8 9136.8 9137.0 9036.1 9085.5 9088.2 9091.3 9100.0 8920.2 8983.7 8990.2 8994.4 8998.4 44137.3 44433.9 44475.6 44552.6 44562.0 3626.9 3674.1 3722.4 3783.6 3793.4 32200.7 34595.3 34843.3 34889.3 34914.0 4364.9 4457.6 4468.2 4486.9 4615.3 382367.0 391586.0 391809.0 391933.0 394479.0 34909.0 35939.3 66721.7 67499.7 67548.7 39410.2 39432.0 39485.6 39661.4 39727.6 13614.0 13887.2 14030.6 14161.3 14388.0 12447.9 12728.3 12730.0 12733.4 12735.2 7879.5 7913.6 8393.9 8961.9 9085.1 3467.8 3481.3 3490.7 3491.1 3508.3 1041.8 1072.7 1086.3 1108.9 1113.3 33614.3 34209.0 34305.1 34313.4 34330.3 1107.2 1108.7 1121.6 1122.8 1158.3 17358.2 17686.3 17856.3 17865.6 17885.8 612203.0 622248.0 622668.0 623341.0 624546.0 40598.0 40688.6 40834.2 40993.4 41028.8 1207.3 1336.3 1346.7 1373.4 1381.4 32912.7 35333.5 35411.1 35485.4 35598.5 51361.5 52014.0 52082.7 52094.2 52133.7 429505.0 432175.0 432181.0 433073.0 433730.0 26506.2 30521.2 30774.8 31014.0 31553.2 49703.3 49814.5 50264.5 51039.5 54650.5 42515.8 42914.8 43245.4 43419.8 45087.3 43097.1 43916.6 44122.3 44680.8 44779.0 43927.0 44782.8 45015.0 45171.0 45206.3 35865.6 39131.0 39225.2 39573.2 39782.8 30015.0 30086.8 30098.5 30210.8 30408.2 23:25:15 INFO - PROCESS | 1843 | 23:25:15 INFO - PROCESS | 1843 | [#2] jquery.html Cycles:180 Average:29818.13 Median:24396.57 stddev:82470.72 (338.0%) stddev-sans-first:82672.48 23:25:15 INFO - PROCESS | 1843 | Values: 396.0 398.2 403.9 408.3 417.4 13567.9 19114.2 19963.4 20808.2 20809.0 14678.6 14995.8 15496.6 16791.2 16958.8 5692.0 5769.9 5967.2 5982.6 5997.6 5834.5 5888.0 5919.1 5919.9 5928.9 5685.5 5839.7 5878.0 5893.3 5900.5 5861.4 5877.8 5890.7 5896.9 5897.2 5081.5 5211.8 5252.8 5284.3 5287.8 23799.4 24360.3 24432.9 24511.6 24603.5 2387.5 2396.2 2397.3 2469.2 2553.3 14523.1 14608.3 14716.3 15044.5 15763.6 1953.7 1986.6 1997.0 2040.4 2046.4 87243.6 89445.0 90067.0 90142.0 92090.5 10537.4 10802.3 10806.2 10844.2 11455.6 15370.1 15510.0 15519.0 15519.8 15521.8 7858.3 8220.8 8338.2 8413.8 8489.5 7946.6 7988.6 8047.4 8223.4 8241.1 6659.7 6779.3 6808.5 6842.8 6912.4 1948.2 1969.3 1980.8 2026.5 2027.6 929.3 1008.7 1016.6 1036.3 1098.6 20613.0 21165.7 21177.2 21197.4 21256.8 999.9 1042.6 1045.3 1045.9 1060.6 11123.9 11687.9 11769.0 11871.0 11872.5 493885.0 494928.0 497833.0 503020.0 508484.0 86751.0 89331.2 90654.0 91419.5 91959.5 1036.8 1041.2 1046.7 1084.9 1102.9 17661.4 17990.8 18332.4 18508.6 18618.4 41943.2 42401.0 44007.1 44468.6 44816.8 60820.0 61919.9 62030.7 62816.7 63146.7 5457.5 6063.2 7689.6 7782.6 8071.4 9771.8 13233.3 13759.2 13823.7 13934.6 11925.7 11942.2 12038.6 12124.2 12299.4 11471.1 11620.9 11698.5 11949.7 12031.5 12008.0 12114.0 12119.3 12120.8 12476.4 7982.4 7983.5 8120.9 8231.1 8267.0 8992.7 11029.6 11709.4 11847.6 12459.2 23:25:15 INFO - PROCESS | 1843 | 23:25:15 INFO - PROCESS | 1843 | [#3] mootools.html Cycles:180 Average:5833.47 Median:491.19 stddev:3257.91 (663.3%) stddev-sans-first:3249.34 23:25:15 INFO - PROCESS | 1843 | Values: 1313.8 1446.4 1520.3 1587.3 1758.6 8007.4 8389.2 8454.5 8644.6 8645.1 8419.2 8546.7 8562.5 8563.0 8564.7 2383.3 2421.0 2422.0 2424.1 2427.1 2362.3 2394.2 2416.1 2417.7 2420.1 2355.2 2388.4 2388.4 2396.4 2401.0 2334.6 2360.3 2362.4 2372.6 2379.3 2317.7 2323.8 2329.8 2338.3 2341.2 8456.6 8626.5 8632.3 8653.6 8664.7 5308.5 5493.7 5506.6 5509.0 5512.8 3492.9 3541.7 3568.3 3613.8 3636.0 1147.2 1166.5 1227.3 1240.9 2164.6 11787.2 11925.9 11939.4 11946.6 11954.5 4632.6 4663.3 4749.8 4769.4 4796.2 9611.2 9613.6 9614.7 9615.9 9625.9 5452.5 5454.4 5459.5 5461.2 5461.7 4373.5 4507.6 4962.1 5040.6 5090.3 3956.8 3990.8 4028.0 4078.6 4082.5 1186.4 1212.0 1213.1 1223.6 1224.1 960.6 969.3 978.9 988.4 990.3 5985.3 6065.6 6087.1 6108.6 6131.6 480.2 480.6 482.1 486.8 495.6 4208.9 4303.9 4407.2 4535.6 4567.5 10906.9 10987.2 11132.3 11174.6 11231.0 11107.4 11109.8 11116.8 11125.6 11126.5 7891.5 8218.0 8223.4 8404.2 8410.2 6014.8 6081.8 6153.5 6190.4 6319.8 10158.5 10215.5 10406.9 10417.5 10453.9 10024.8 10160.9 10408.5 10444.5 10472.9 7447.0 7538.1 7627.1 7631.7 7652.3 8459.4 8605.5 8610.5 8613.4 8616.9 7707.5 7833.7 7862.8 7910.6 8002.3 7503.5 7521.6 7623.7 7632.4 7659.8 7189.4 7282.2 7342.2 7357.0 7357.4 5164.4 5294.5 5309.3 5342.6 5527.2 5315.5 5385.5 5480.5 5500.3 5543.0 23:25:15 INFO - PROCESS | 1843 | 23:25:15 INFO - PROCESS | 1843 | [#4] prototype.html Cycles:180 Average:4603.64 Median:5265.32 stddev:1350.90 (25.7%) stddev-sans-first:1315.80 23:25:15 INFO - PROCESS | 1843 | Values: 316.1 323.9 325.9 329.0 333.4 5233.2 5258.2 5263.3 5267.3 5269.4 4973.0 5068.2 5085.8 5109.9 5213.2 4018.7 4080.6 4090.9 4093.2 4134.0 4093.5 4106.5 4121.2 4123.3 4129.7 3872.8 4053.7 4054.2 4110.7 4129.8 4040.8 4051.5 4058.9 4063.2 4074.1 3574.3 3589.3 3596.4 3596.5 3607.6 4880.2 5134.5 5139.7 5145.5 5146.8 4596.4 4613.4 4625.5 4653.9 4682.9 5402.4 5408.9 5433.6 5436.0 5441.9 3855.6 3919.8 3925.5 3928.0 3959.3 5633.6 5646.6 5654.4 5679.3 5727.0 4017.3 4022.5 4024.0 4025.0 4026.2 4099.7 4106.0 4115.6 4120.2 4123.9 4586.5 4617.3 4622.4 4659.2 4661.8 5406.2 5433.8 5444.8 5446.0 5462.7 1317.6 1365.2 1378.2 1380.6 1383.6 910.5 929.0 944.9 953.2 954.2 5207.1 5217.5 5241.7 5249.8 5253.8 5516.4 5532.8 5545.9 5550.6 5550.8 5135.6 5377.9 5378.8 5379.9 5381.2 2961.7 2973.5 2984.9 2999.5 3001.3 5685.0 5767.7 5825.4 5840.0 5867.4 5655.4 5667.9 5670.5 5692.6 5703.2 5700.3 5715.2 5725.0 5726.7 5726.8 5394.8 5549.5 5559.0 5605.4 5633.7 5567.2 5615.2 5619.9 5624.0 5644.2 5533.4 5747.5 5795.2 5851.3 5883.7 3939.2 3953.3 3963.2 3968.0 3993.2 5636.9 5657.9 5659.8 5695.7 5713.5 5410.2 5463.8 5504.2 5577.2 5578.3 5425.7 5445.5 5449.8 5467.4 5480.3 5209.7 5349.3 5350.1 5478.3 5487.8 4898.3 5381.8 5500.8 5505.4 5508.4 5353.7 5378.8 5392.6 5394.9 5404.2 23:25:15 INFO - PROCESS | 1843 | 23:25:15 INFO - PROCESS | 1843 | [#5] yui.html Cycles:180 Average:22778.57 Median:3877.76 stddev:33402.02 (861.4%) stddev-sans-first:33454.69 23:25:15 INFO - PROCESS | 1843 | Values: 729.6 771.5 805.8 846.7 898.8 16513.4 17280.7 17308.7 17336.1 17385.7 15634.5 15874.8 15900.5 15910.6 15914.0 645.9 795.6 806.4 817.5 819.9 797.8 808.0 810.1 817.3 818.3 882.6 882.7 883.5 884.0 884.4 673.5 834.4 855.4 877.7 878.6 633.2 633.4 633.4 633.6 633.6 14307.2 14393.6 14409.9 14415.9 14448.5 14491.3 14592.1 14736.3 14817.2 15034.1 13512.7 13625.2 13677.7 13868.7 13971.5 4413.4 4497.5 4527.1 4529.8 4579.2 83250.0 83317.6 83902.2 84282.6 85723.0 11066.6 11606.4 11623.4 11635.9 11932.2 22283.4 22306.8 22337.9 22425.6 22509.1 8616.5 8647.8 8675.1 8711.3 9058.9 4404.7 4471.9 4512.4 4523.3 4568.0 3238.7 3342.1 3346.1 3348.8 3350.8 610.6 611.6 617.1 617.3 618.6 696.4 699.0 705.4 709.2 725.8 9181.1 9694.0 9847.3 9994.5 10021.7 581.0 590.4 674.7 675.1 684.8 4493.2 4586.9 4841.4 4944.9 4945.8 123554.0 123556.0 129822.5 130743.3 132689.0 108761.0 109349.5 110112.0 112580.0 114667.0 91329.5 93841.5 94086.0 95137.0 98168.5 10548.2 10744.7 10762.2 10777.5 10909.5 55365.7 55597.0 56088.7 57401.0 57525.1 74695.6 85477.0 85576.0 86571.0 88056.0 13338.5 13435.4 14225.6 14379.1 14402.7 15850.8 16061.5 16331.6 16371.4 17046.7 14701.4 14740.4 14981.6 15500.2 15831.8 14259.7 14263.1 14348.0 14726.4 14980.7 14611.7 14612.8 14786.5 14874.8 15153.5 11104.0 11676.9 12005.2 12333.1 12392.5 12139.9 12165.3 12311.8 12341.8 12375.7 23:25:15 INFO - PROCESS | 1843 | -------- Summary: end -------- 23:25:15 INFO - PROCESS | 1843 | 23:25:16 INFO - TEST-INFO | 1843: exit 0 23:25:16 INFO - TEST-OK | dromaeo_css | took 1115371ms 23:25:16 INFO - TEST-START | kraken 23:25:16 INFO - operating with platform_type : linux_ 23:25:16 INFO - Initialising browser for kraken test... 23:25:16 INFO - TEST-INFO | started process 2043 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5jWdQu/profile http://localhost:53684/getInfo.html) 23:25:20 INFO - PROCESS | 2043 | __metrics Screen width/height:1600/1200 23:25:20 INFO - PROCESS | 2043 | colorDepth:24 23:25:20 INFO - PROCESS | 2043 | Browser inner width/height: 1024/697 23:25:20 INFO - PROCESS | 2043 | __metrics 23:25:21 INFO - PROCESS | 2043 | 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" 23:25:21 INFO - PROCESS | 2043 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:25:21 INFO - PROCESS | 2043 | console.error: PushService: 23:25:21 INFO - PROCESS | 2043 | stateChangeProcessEnqueue: Error transitioning state 23:25:21 INFO - PROCESS | 2043 | UnknownError 23:25:22 INFO - TEST-INFO | 2043: exit 0 23:25:22 INFO - Browser initialized. 23:25:22 INFO - Running cycle 1/1 for kraken test... 23:25:22 INFO - TEST-INFO | started process 2124 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5jWdQu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:25:33 INFO - PROCESS | 2124 | RSS: Main: 155742208 23:25:33 INFO - PROCESS | 2124 | 23:25:36 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:53684/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53684/tests/kraken/driver.html?testName=audio-beat-detection) 23:25:37 INFO - PROCESS | 2124 | RSS: Main: 211656704 23:25:37 INFO - PROCESS | 2124 | 23:25:39 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:53684/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53684/tests/kraken/driver.html?testName=audio-dft) 23:25:40 INFO - PROCESS | 2124 | RSS: Main: 191238144 23:25:40 INFO - PROCESS | 2124 | 23:25:43 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:53684/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53684/tests/kraken/driver.html?testName=audio-fft) 23:25:44 INFO - PROCESS | 2124 | RSS: Main: 268808192 23:25:44 INFO - PROCESS | 2124 | 23:25:46 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:53684/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53684/tests/kraken/driver.html?testName=audio-oscillator) 23:25:46 INFO - PROCESS | 2124 | RSS: Main: 178180096 23:25:46 INFO - PROCESS | 2124 | 23:25:49 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:53684/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53684/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:25:49 INFO - PROCESS | 2124 | RSS: Main: 182599680 23:25:49 INFO - PROCESS | 2124 | 23:25:52 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:53684/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53684/tests/kraken/driver.html?testName=imaging-darkroom) 23:25:53 INFO - PROCESS | 2124 | RSS: Main: 219516928 23:25:53 INFO - PROCESS | 2124 | 23:25:56 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:53684/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53684/tests/kraken/driver.html?testName=imaging-desaturate) 23:25:57 INFO - PROCESS | 2124 | RSS: Main: 218804224 23:25:57 INFO - PROCESS | 2124 | 23:26:00 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:53684/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53684/tests/kraken/driver.html?testName=json-parse-financial) 23:26:00 INFO - PROCESS | 2124 | RSS: Main: 218431488 23:26:00 INFO - PROCESS | 2124 | 23:26:02 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:53684/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53684/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:26:02 INFO - PROCESS | 2124 | RSS: Main: 183062528 23:26:02 INFO - PROCESS | 2124 | 23:26:04 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:53684/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53684/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:26:05 INFO - PROCESS | 2124 | RSS: Main: 189734912 23:26:05 INFO - PROCESS | 2124 | 23:26:07 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:53684/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53684/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:26:07 INFO - PROCESS | 2124 | RSS: Main: 192958464 23:26:07 INFO - PROCESS | 2124 | 23:26:10 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:53684/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53684/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:26:11 INFO - PROCESS | 2124 | RSS: Main: 186662912 23:26:11 INFO - PROCESS | 2124 | 23:26:13 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:53684/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53684/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:26:14 INFO - PROCESS | 2124 | RSS: Main: 191266816 23:26:14 INFO - PROCESS | 2124 | 23:26:16 INFO - PROCESS | 2124 | Cycle 1(1): loaded http://localhost:53684/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53684/tests/kraken/driver.html?testName=ai-astar) 23:26:16 INFO - PROCESS | 2124 | RSS: Main: 241618944 23:26:16 INFO - PROCESS | 2124 | 23:26:16 INFO - PROCESS | 2124 | __start_tp_report 23:26:16 INFO - PROCESS | 2124 | _x_x_mozilla_page_load 23:26:16 INFO - PROCESS | 2124 | _x_x_mozilla_page_load_details 23:26:16 INFO - PROCESS | 2124 | |i|pagename|runs| 23:26:16 INFO - PROCESS | 2124 | |0;ai-astar;103;114;112;112;111;113;111;111;111;112 23:26:16 INFO - PROCESS | 2124 | |1;audio-beat-detection;144;116;119;178;124;120;146;119;157;116 23:26:16 INFO - PROCESS | 2124 | |2;audio-dft;162;161;161;162;162;162;159;160;160;160 23:26:16 INFO - PROCESS | 2124 | |3;audio-fft;74;74;75;106;76;77;75;74;98;75 23:26:16 INFO - PROCESS | 2124 | |4;audio-oscillator;84;85;127;84;85;86;124;84;94;140 23:26:16 INFO - PROCESS | 2124 | |5;imaging-gaussian-blur;117;116;116;116;116;117;117;116;117;117 23:26:16 INFO - PROCESS | 2124 | |6;imaging-darkroom;146;147;145;145;146;147;145;146;146;145 23:26:16 INFO - PROCESS | 2124 | |7;imaging-desaturate;95;96;95;96;95;96;96;95;95;95 23:26:16 INFO - PROCESS | 2124 | |8;json-parse-financial;65;50;50;50;50;50;51;50;50;50 23:26:16 INFO - PROCESS | 2124 | |9;json-stringify-tinderbox;61;63;61;62;62;61;62;62;62;62 23:26:16 INFO - PROCESS | 2124 | |10;stanford-crypto-aes;75;76;75;75;74;75;75;80;76;76 23:26:16 INFO - PROCESS | 2124 | |11;stanford-crypto-ccm;122;142;120;121;127;124;120;121;146;124 23:26:16 INFO - PROCESS | 2124 | |12;stanford-crypto-pbkdf2;159;161;163;162;162;163;161;161;158;158 23:26:16 INFO - PROCESS | 2124 | |13;stanford-crypto-sha256-iterative;65;68;63;64;64;64;63;63;63;62 23:26:16 INFO - PROCESS | 2124 | __end_tp_report 23:26:16 INFO - PROCESS | 2124 | __start_cc_report 23:26:16 INFO - PROCESS | 2124 | _x_x_mozilla_cycle_collect,1677 23:26:16 INFO - PROCESS | 2124 | __end_cc_report 23:26:16 INFO - PROCESS | 2124 | __startTimestamp1470983176336__endTimestamp 23:26:16 INFO - PROCESS | 2124 | 23:26:16 INFO - PROCESS | 2124 | ------- Summary: start ------- 23:26:16 INFO - PROCESS | 2124 | Number of tests: 14 23:26:16 INFO - PROCESS | 2124 | 23:26:16 INFO - PROCESS | 2124 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:2.98 (2.7%) stddev-sans-first:1.05 23:26:16 INFO - PROCESS | 2124 | Values: 103.0 114.0 112.0 112.0 111.0 113.0 111.0 111.0 111.0 112.0 23:26:16 INFO - PROCESS | 2124 | 23:26:16 INFO - PROCESS | 2124 | [#1] audio-beat-detection Cycles:10 Average:133.90 Median:134.00 stddev:21.35 (15.9%) stddev-sans-first:22.33 23:26:16 INFO - PROCESS | 2124 | Values: 144.0 116.0 119.0 178.0 124.0 120.0 146.0 119.0 157.0 116.0 23:26:16 INFO - PROCESS | 2124 | 23:26:16 INFO - PROCESS | 2124 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.50 stddev:1.10 (0.7%) stddev-sans-first:1.09 23:26:16 INFO - PROCESS | 2124 | Values: 162.0 161.0 161.0 162.0 162.0 162.0 159.0 160.0 160.0 160.0 23:26:16 INFO - PROCESS | 2124 | 23:26:16 INFO - PROCESS | 2124 | [#3] audio-fft Cycles:10 Average:80.40 Median:75.00 stddev:11.58 (15.4%) stddev-sans-first:12.05 23:26:16 INFO - PROCESS | 2124 | Values: 74.0 74.0 75.0 106.0 76.0 77.0 75.0 74.0 98.0 75.0 23:26:16 INFO - PROCESS | 2124 | 23:26:16 INFO - PROCESS | 2124 | [#4] audio-oscillator Cycles:10 Average:99.30 Median:84.50 stddev:21.99 (26.0%) stddev-sans-first:22.61 23:26:16 INFO - PROCESS | 2124 | Values: 84.0 85.0 127.0 84.0 85.0 86.0 124.0 84.0 94.0 140.0 23:26:16 INFO - PROCESS | 2124 | 23:26:16 INFO - PROCESS | 2124 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 23:26:16 INFO - PROCESS | 2124 | Values: 117.0 116.0 116.0 116.0 116.0 117.0 117.0 116.0 117.0 117.0 23:26:16 INFO - PROCESS | 2124 | 23:26:16 INFO - PROCESS | 2124 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 23:26:16 INFO - PROCESS | 2124 | Values: 146.0 147.0 145.0 145.0 146.0 147.0 145.0 146.0 146.0 145.0 23:26:16 INFO - PROCESS | 2124 | 23:26:16 INFO - PROCESS | 2124 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 23:26:16 INFO - PROCESS | 2124 | Values: 95.0 96.0 95.0 96.0 95.0 96.0 96.0 95.0 95.0 95.0 23:26:16 INFO - PROCESS | 2124 | 23:26:16 INFO - PROCESS | 2124 | [#8] json-parse-financial Cycles:10 Average:51.60 Median:50.00 stddev:4.72 (9.4%) stddev-sans-first:0.33 23:26:16 INFO - PROCESS | 2124 | Values: 65.0 50.0 50.0 50.0 50.0 50.0 51.0 50.0 50.0 50.0 23:26:16 INFO - PROCESS | 2124 | 23:26:16 INFO - PROCESS | 2124 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 23:26:16 INFO - PROCESS | 2124 | Values: 61.0 63.0 61.0 62.0 62.0 61.0 62.0 62.0 62.0 62.0 23:26:16 INFO - PROCESS | 2124 | 23:26:16 INFO - PROCESS | 2124 | [#10] stanford-crypto-aes Cycles:10 Average:75.70 Median:75.50 stddev:1.64 (2.2%) stddev-sans-first:1.72 23:26:16 INFO - PROCESS | 2124 | Values: 75.0 76.0 75.0 75.0 74.0 75.0 75.0 80.0 76.0 76.0 23:26:16 INFO - PROCESS | 2124 | 23:26:16 INFO - PROCESS | 2124 | [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:124.00 stddev:9.42 (7.6%) stddev-sans-first:9.83 23:26:16 INFO - PROCESS | 2124 | Values: 122.0 142.0 120.0 121.0 127.0 124.0 120.0 121.0 146.0 124.0 23:26:16 INFO - PROCESS | 2124 | 23:26:16 INFO - PROCESS | 2124 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.80 Median:161.50 stddev:1.87 (1.2%) stddev-sans-first:1.87 23:26:16 INFO - PROCESS | 2124 | Values: 159.0 161.0 163.0 162.0 162.0 163.0 161.0 161.0 158.0 158.0 23:26:16 INFO - PROCESS | 2124 | 23:26:16 INFO - PROCESS | 2124 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.00 stddev:1.66 (2.6%) stddev-sans-first:1.72 23:26:16 INFO - PROCESS | 2124 | Values: 65.0 68.0 63.0 64.0 64.0 64.0 63.0 63.0 63.0 62.0 23:26:16 INFO - PROCESS | 2124 | -------- Summary: end -------- 23:26:16 INFO - PROCESS | 2124 | 23:26:17 INFO - TEST-INFO | 2124: exit 0 23:26:17 INFO - TEST-OK | kraken | took 61195ms 23:26:17 INFO - SUITE-END | took 1176s 23:26:17 INFO - Completed test suite (00:19:36) 23:26:17 INFO - javascript benchmark 23:26:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3068.969310306896, 3097.4269760094385, 3112.0819358289305, 3117.984410077952, 3124.968750312496, 5312.256284120226, 5388.568914486841, 5419.3225846769155, 5428.4842939920745, 5493.505584497394, 5442.156465747806, 5445.455454454553, 5469.699166545848, 5502.202180683808, 5539.335279766424, 4870.586000189979, 4905.215165573509, 4936.111499930011, 4943.1102401567705, 5143.81996630118, 5063.772130254148, 5091.898162036757, 5111.13110771168, 5123.103456895047, 5124.8975020499565, 4908.705477671351, 4942.986687729007, 4954.033963377143, 5002.899942001176, 5062.772175252104, 4899.902001959977, 4902.730349830758, 4915.877103072416, 5092.0, 5093.872653183663, 4951.90096198074, 4958.380202474691, 4959.727215003173, 4969.428515720702, 5002.799888004475, 5297.549708274802, 5411.242426060355, 5459.426760190163, 5492.972535137339, 5536.806211782568, 5818.127280907897, 5828.06750919855, 5838.883222335572, 5900.232969713909, 5903.144044113623, 5887.0580707086665, 5936.584439089265, 5947.851303717398, 5960.940390596082, 5965.850853728692, 5253.474652534716, 5327.0, 5412.377576578744, 5498.065328894098, 5529.281193444826, 6002.6698531580305, 6005.129256257818, 6045.486133678599, 6050.062240352752, 6060.303065147476, 5736.5123964462655, 5753.079507278815, 5801.129830525455, 5803.709814509258, 5806.361300256968, 5629.183768353566, 5773.076307790818, 5816.592838501264, 5894.115882617556, 5904.76380944766, 5821.068629019422, 5829.47534721877, 5831.825045248649, 5874.765009399662, 5883.61756485827, 5787.305523337226, 5842.941570584325, 5847.3275573308765, 5860.912086318709, 5867.559933005042, 4331.480222373272, 4371.890702732457, 4414.779261036935, 4453.109378124388, 4488.057507923308, 3907.316219661548, 3958.1687845552183, 3963.128111815396, 3993.0416699991792, 4012.0371110933747, 5556.86107847299, 5561.610687251854, 5563.693996830132, 5563.860903477364, 5600.467955544217, 5614.101743720985, 5805.10020946754, 5844.26946631671, 5907.527397808165, 5913.201717768132, 5498.367687715964, 5507.311586051744, 5508.64193827408, 5524.751386187631, 5525.226468294442, 5083.135866902636, 5087.720175390389, 5101.846944591594, 5102.08162530748, 5144.588432925357, 5890.941090589039, 5971.193888824953, 5996.940030599638, 6064.727087281083, 6075.2405949256345, 5850.034744267148, 5852.18069470283, 5853.678047707247, 5894.174815525916, 5903.763849445974, 6042.758289668364, 6042.939570604238, 6047.183630210041, 6050.364711705208, 6053.334133245251, 5640.294963129609, 5669.6314739541795, 5702.657840529581, 5704.543636508986, 5738.626989245686, 5794.304683438015, 5836.795712150054, 5842.1820945068575, 5842.415758424294, 5881.94118058831, 5725.742341594555, 5738.655680659173, 5740.995325817881, 5742.052561327334, 5744.827655170351, 5400.081986062457, 5675.659460432387, 5710.8001219957105, 5720.485156335783, 5724.141378793214, 5702.942970570407, 5703.258576385209, 5703.714814259188, 5744.569157313134, 5758.452946970031, 5783.334916484658, 5791.420857914175, 5842.795502157404, 5851.1515830205235, 5853.590248682722, 5374.381946076252, 5509.311336082989, 5581.832545023656, 5642.774289028393, 5648.802291919763], "value": 5388.109897869427, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.6072461812895, 606.1392822192487, 611.5932904618431, 628.9779857704981, 629.4649547884296, 44671.77664111679, 45856.77071614646, 45915.311270330974, 46010.0, 48557.27164092541, 44379.334309985374, 44417.33373999393, 44485.7775711121, 44499.0, 44540.55459445404, 8939.687110951118, 9121.726348209564, 9125.543722813865, 9127.589258483351, 9128.40665356753, 8997.505137217451, 9081.318901082444, 9086.409383390059, 9093.909060909373, 9094.590743416562, 9083.364164508486, 9129.406588571755, 9136.771580710469, 9136.771580710501, 9137.040610735876, 9036.096390360977, 9085.500297483635, 9088.227500662451, 9091.27269818413, 9100.044495328028, 8920.152585504367, 8983.685571004984, 8990.235829954461, 8994.415363001384, 8998.415103018282, 44137.33793993061, 44433.89010263796, 44475.55524444779, 44552.554474455486, 44562.0, 3626.873059442933, 3674.1365779041903, 3722.3671975763914, 3783.5838057813617, 3793.393057110849, 32200.67799322, 34595.30809383798, 34843.303133937436, 34889.30221395583, 34914.0, 4364.869053928387, 4457.576530229623, 4468.218061839165, 4486.910261794778, 4615.284630882219, 382367.0, 391586.0, 391809.0, 391933.0, 394479.0, 34909.0, 35939.28121437609, 66721.66639166774, 67499.66250168718, 67548.66225668938, 39410.21179576393, 39432.0, 39485.60514394877, 39661.40507892384, 39727.60272397239, 13614.0, 13887.166769993833, 14030.649233769032, 14161.29193540319, 14388.0, 12447.875521244852, 12728.29994350301, 12730.045246606356, 12733.426995785212, 12735.172213806072, 7879.487833290817, 7913.643886025027, 8393.916060839436, 8961.865572016424, 9085.13691199335, 3467.809270490097, 3481.268933523938, 3490.650934906489, 3491.122488697313, 3508.280802435546, 1041.833306670929, 1072.651388298806, 1086.277625379114, 1108.9409613818784, 1113.3486910157487, 33614.32771344559, 34209.0, 34305.14237144091, 34313.4322405677, 34330.31339373199, 1107.1802282126696, 1108.733903863067, 1121.5681962444517, 1122.7922834275685, 1158.2529268621693, 17358.218880150424, 17686.292548297923, 17856.285748569913, 17865.642687146443, 17885.821141788674, 612203.0, 622248.0, 622668.0, 623341.0, 624546.0, 40598.0, 40688.59311406848, 40834.18331633351, 40993.38509922354, 41028.79485602553, 1207.2756346192214, 1336.325155796336, 1346.710457251676, 1373.3545233740126, 1381.4405165907824, 32912.67087329192, 35333.469997949534, 35411.114722131126, 35485.35118257899, 35598.466023010194, 51361.48638513716, 52014.0, 52082.739586301825, 52094.21858672047, 52133.7393313031, 429505.0, 432175.0, 432181.0, 433073.0, 433730.0, 26506.204813855617, 30521.23696907595, 30774.84612576923, 31014.0, 31553.21116972094, 49703.25445118254, 49814.50185498098, 50264.49735502598, 51039.48960510496, 54650.45349546613, 42515.7874210627, 42914.78542607267, 43245.3513197296, 43419.782901085295, 45087.32369014533, 43097.13805723931, 43916.560834391246, 44122.338164928195, 44680.77659611681, 44779.0, 43927.0, 44782.77608611936, 45015.0, 45171.0, 45206.32190517211, 35865.64134358623, 39131.0, 39225.2154956905, 39573.2085358297, 39782.80108599438, 30015.0, 30086.849565752033, 30098.548521771754, 30210.84894575513, 30408.239794005327], "value": 19469.263270594918, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.9683225341973, 398.17577614338296, 403.9373897045958, 408.27938688215295, 417.4197864967695, 13567.864321356783, 19114.23543058276, 19963.401097967086, 20808.16767329307, 20808.99999999998, 14678.559643210694, 14995.800335973123, 15496.612584685388, 16791.16044197788, 16958.83041169588, 5692.0, 5769.913451298234, 5967.194428752106, 5982.641041537521, 5997.580169388123, 5834.5040671542965, 5888.0, 5919.112133180036, 5919.852003699921, 5928.881422371572, 5685.545156387479, 5839.708014599253, 5878.0, 5893.292804863422, 5900.498457631106, 5861.443162899518, 5877.794277200299, 5890.705464726747, 5896.852578685524, 5897.174395584643, 5081.466446023152, 5211.843644690665, 5252.842414727565, 5284.2866213061125, 5287.788488460457, 23799.405014874766, 24360.26919192427, 24432.877835610707, 24511.632325515133, 24603.507929841482, 2387.462820865309, 2396.221228100874, 2397.30478161333, 2469.2468797016904, 2553.3488960315, 14523.128612283297, 14608.269586520631, 14716.33776480061, 15044.473443429428, 15763.605909852231, 1953.6971769375768, 1986.612610540945, 1996.9700454493195, 2040.36748607932, 2046.4270004398793, 87243.56378218069, 89445.0, 90067.0, 90142.0, 92090.5395473025, 10537.367757934395, 10802.297850639683, 10806.189535784848, 10844.240903136704, 11455.59905403307, 15370.077795332316, 15510.0, 15519.0, 15519.844801552066, 15521.844781552265, 7858.253465920729, 8220.8355832883, 8338.166183381734, 8413.789655258668, 8489.533075680773, 7946.602669866484, 7988.640511177011, 8047.396445266511, 8223.424360294723, 8241.134680858544, 6659.733610655519, 6779.254282028973, 6808.489363297674, 6842.794716158423, 6912.447004239649, 1948.2304489726762, 1969.2910552201197, 1980.7524059492564, 2026.4528577284345, 2027.5843452092286, 929.2844509727472, 1008.7326858382388, 1016.6035246253966, 1036.2694300518117, 1098.5825386353135, 20612.969351532363, 21165.68251476229, 21177.15291388358, 21197.36407907765, 21256.787432125482, 999.9050090241416, 1042.5829668132808, 1045.268312181476, 1045.8588090607823, 1060.6340812419703, 11123.888761112285, 11687.94808467242, 11769.0, 11871.0, 11872.525098996117, 493885.0, 494928.0, 497833.0, 503020.0, 508484.0, 86751.0, 89331.17357090715, 90654.0, 91419.54290228506, 91959.54020229857, 1036.849656799775, 1041.2086814021397, 1046.7487802927394, 1084.9132069434427, 1102.8676558812833, 17661.38185163513, 17990.820091799436, 18332.358367457076, 18508.629827403645, 18618.44144675662, 41943.1611367777, 42401.0, 44007.119857603306, 44468.55531444644, 44816.775916121514, 60820.0, 61919.94332270584, 62030.68984655048, 62816.685916570124, 63146.68426657837, 5457.536109430743, 6063.211782468251, 7689.615519224129, 7782.649780759766, 8071.354291656771, 9771.82738071436, 13233.3383330835, 13759.243241621807, 13823.654408639462, 13934.58196254114, 11925.701857453287, 11942.16404851652, 12038.578649747216, 12124.151309408257, 12299.385030748606, 11471.082313415074, 11620.941895290469, 11698.53768278965, 11949.72008449894, 12031.4585843639, 12008.0, 12114.0, 12119.272843629411, 12120.75758484843, 12476.438560264629, 7982.441229113906, 7983.483138203723, 8120.878186827084, 8231.135730748185, 8267.049289331804, 8992.685256016008, 11029.61396351124, 11709.414529273672, 11847.585334513251, 12459.190152640049], "value": 9503.671026293086, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1313.7963615639567, 1446.4431193990317, 1520.3082597418177, 1587.3174534949974, 1758.6218962922976, 8007.399445041616, 8389.161083891608, 8454.49273043617, 8644.56777161141, 8645.135486451352, 8419.158084191578, 8546.743597692064, 8562.529060901648, 8562.957185214082, 8564.65741370346, 2383.3207535852284, 2421.0315873650593, 2422.0, 2424.0667343072955, 2427.0534491548224, 2362.303120579433, 2394.1740099665676, 2416.0577374823833, 2417.697787776528, 2420.080369459603, 2355.2463211772238, 2388.355144111089, 2388.4028992751814, 2396.436837343223, 2400.9639855402097, 2334.6381310896836, 2360.291912426274, 2362.3975886148924, 2372.596658568039, 2379.3337865397716, 2317.6755254264417, 2323.848949818256, 2329.813614910803, 2338.3335749311364, 2341.2273949596593, 8456.577171141418, 8626.525541095238, 8632.266257368132, 8653.567321633956, 8664.740057798213, 5308.495692909168, 5493.697846618435, 5506.64206826555, 5509.0, 5512.751926163332, 3492.930141397158, 3541.7072768439593, 3568.3398571264397, 3613.837377318027, 3635.963640363589, 1147.219890474477, 1166.5217260923066, 1227.2697744841805, 1240.9069319801051, 2164.5779073080757, 11787.17489775716, 11925.880741192565, 11939.40302984856, 11946.641600751991, 11954.462049207807, 4632.606228470618, 4663.300504924288, 4749.810007599726, 4769.35613692154, 4796.184648609745, 9611.231101512001, 9613.615455381707, 9614.71155865325, 9615.855762163574, 9625.903740962642, 5452.454754524516, 5454.372747134051, 5459.481349271813, 5461.208124821878, 5461.672299662033, 4373.475182978063, 4507.57178068083, 4962.106820772296, 5040.571551418097, 5090.312807770903, 3956.8219430125714, 3990.780507072081, 4027.9798601006805, 4078.6125318094732, 4082.510098788164, 1186.371223251678, 1212.0, 1213.071999920062, 1223.5839814463125, 1224.1125184241355, 960.558143254111, 969.345691658128, 978.9021097890296, 988.3857197712155, 990.2622546203124, 5985.281766187998, 6065.605735627259, 6087.1173679816175, 6108.602940808833, 6131.6321020738005, 480.1573238965593, 480.6275136768962, 482.1129122414774, 486.77365025263424, 495.6084693092417, 4208.85269015583, 4303.881630850637, 4407.184670835842, 4535.569120933506, 4567.474740404896, 10906.945465272782, 10987.230893837515, 11132.332060076422, 11174.608888688857, 11230.989210970889, 11107.389093599768, 11109.777804444027, 11116.777154512996, 11125.610603628835, 11126.499307531181, 7891.487053341514, 8217.95891020541, 8223.42436029484, 8404.159584041668, 8410.201030902055, 6014.759409623566, 6081.847953801191, 6153.538484613582, 6190.41191086846, 6319.842003949938, 10158.492075396349, 10215.540300686636, 10406.947965260126, 10417.479126043516, 10453.895461045597, 10024.799504010025, 10160.949195253976, 10408.479576021016, 10444.477776111316, 10472.947635261775, 7446.962765186139, 7538.09542854861, 7627.122880868549, 7631.732889348847, 7652.273034061755, 8459.365547583833, 8605.483670979762, 8610.526421046903, 8613.440126391764, 8616.870746938675, 7707.460477766503, 7833.686652533835, 7862.764117076496, 7910.644021019183, 8002.279794818494, 7503.474756766974, 7521.623918804147, 7623.656935437808, 7632.427567932538, 7659.846803063796, 7189.424846012411, 7282.235365286569, 7342.155652100077, 7357.0, 7357.411407087313, 5164.431912489698, 5294.549963253013, 5309.309789727311, 5342.557509472498, 5527.198556209408, 5315.5216030555885, 5385.488378604183, 5480.479354461319, 5500.257465242141, 5543.0], "value": 4633.1793391658175, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.1117260497999, 323.9271163988103, 325.93481303739253, 328.9703926646602, 333.4348279665964, 5233.241180028894, 5258.158694608864, 5263.289455923454, 5267.341582302212, 5269.416796578325, 4972.9751351243285, 5068.163752980763, 5085.796568137279, 5109.948900510994, 5213.165893457048, 4018.658414034803, 4080.5511393746665, 4090.9181816363653, 4093.2427500912427, 4133.979330103361, 4093.5497095319492, 4106.466159399289, 4121.237571049351, 4123.299039163335, 4129.669626429878, 3872.806359682019, 4053.655439287649, 4054.2499637567144, 4110.732802367851, 4129.772862492562, 4040.7575545467366, 4051.534073581517, 4058.9188216235807, 4063.2279866825356, 4074.0629655179328, 3574.303010912873, 3589.2821435712963, 3596.4245720684567, 3596.514470546495, 3607.5670919489567, 4880.194767863299, 5134.5378915897745, 5139.717315547643, 5145.536901678867, 5146.8198613048735, 4596.4254468191475, 4613.400257966443, 4625.4911959684405, 4653.883068063674, 4682.929756053662, 5402.405735369106, 5408.945910540923, 5433.6196466247375, 5435.972820135874, 5441.945580544183, 3855.575886652466, 3919.804009799527, 3925.509311336083, 3928.0, 3959.307121253769, 5633.605717570057, 5646.576506761969, 5654.37801841797, 5679.267823313888, 5726.9713651431475, 4017.3371393720295, 4022.4770779798437, 4023.979880100581, 4024.959750402517, 4026.2350153470748, 4099.651529620016, 4105.97947010263, 4115.629593336614, 4120.237756015147, 4123.9175216495505, 4586.518415566385, 4617.307403889444, 4622.399088118523, 4659.2312268475325, 4661.790219440133, 5406.189071639285, 5433.782648694087, 5444.7822087116865, 5445.9727701362035, 5462.7268636568015, 1317.571789168524, 1365.1604263377951, 1378.23507953085, 1380.6341319550327, 1383.633337165652, 910.4582773249906, 928.9628414863465, 944.9102335278137, 953.1993125774383, 954.2175416158822, 5207.140821764442, 5217.530422262014, 5241.737913104405, 5249.816256431007, 5253.763580638881, 5516.365617953907, 5532.75102620383, 5545.892560826941, 5550.58370622205, 5550.7779688812, 5135.6148288878485, 5377.946220537823, 5378.838634840961, 5379.892402151935, 5381.19282107687, 2961.6742158362563, 2973.52423612221, 2984.910507664687, 2999.5002498750623, 3001.324701942089, 5684.971575142181, 5767.7404516796005, 5825.417458254141, 5839.970800145972, 5867.442592953663, 5655.406182350794, 5667.943320566742, 5670.5180059695385, 5692.6299790513485, 5703.173039909273, 5700.287464066992, 5715.199872017921, 5724.969505489052, 5726.656400615976, 5726.79956201531, 5394.78420863161, 5549.500544950974, 5559.0, 5605.411431799603, 5633.746481408264, 5567.192757050286, 5615.18579805934, 5619.943800562106, 5624.031588943837, 5644.153376993484, 5533.391326954113, 5747.511461525817, 5795.217645617788, 5851.297844258716, 5883.676397798162, 3939.2121575684405, 3953.2686453006286, 3963.187546552892, 3968.047668559467, 3993.2013597281243, 5636.857993962268, 5657.886842263214, 5659.773609055756, 5695.658260504383, 5713.514351280021, 5410.21551874968, 5463.836084917459, 5504.201890725903, 5577.163425486047, 5578.2748242728185, 5425.728713564227, 5445.482679145475, 5449.836504904859, 5467.425920278313, 5480.314960629921, 5209.71346575942, 5349.331333583302, 5350.100714246387, 5478.260434841245, 5487.807926722546, 4898.2652602109965, 5381.784728610812, 5500.789826238221, 5505.421930697219, 5508.394076651645, 5353.705546194841, 5378.838634840961, 5392.573341996196, 5394.9460505394445, 5404.189371594292], "value": 4171.655938723024, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [729.62424351459, 771.5332224004474, 805.842860642175, 846.6740304982579, 898.793277546164, 16513.42203022893, 17280.740788888175, 17308.653826923455, 17336.133193340345, 17385.652286954253, 15634.530964071068, 15874.761878571831, 15900.52298431046, 15910.602234944132, 15913.99999999997, 645.886969780289, 795.6300320351036, 806.395203597302, 817.480899628734, 819.9385046121535, 797.7606717984581, 807.9980823778502, 810.05628442864, 817.342039658075, 818.2880893622556, 882.5543100734152, 882.7175303902753, 883.4964070479829, 884.0496466298755, 884.3588398411165, 673.4713250098698, 834.3575446905849, 855.3969451536714, 877.745453818395, 878.6090189865513, 633.2179757998867, 633.3571425003626, 633.4077637409038, 633.575504412045, 633.6388258692547, 14307.213103279315, 14393.640158996004, 14409.927950360287, 14415.927920360436, 14448.49430269946, 14491.347889345005, 14592.124472531683, 14736.263186840722, 14817.18505482198, 15034.097954122679, 13512.662183445394, 13625.182489050689, 13677.658058548615, 13868.722625547534, 13971.510997115052, 4413.404190434282, 4497.505274419811, 4527.139843429771, 4529.7735113244535, 4579.198640237945, 83250.0, 83317.58341208316, 83902.16097839005, 84282.57858710729, 85723.0, 11066.612668556561, 11606.361650109156, 11623.418829058513, 11635.88364116365, 11932.164748467698, 22283.442913926956, 22306.77693223047, 22337.888310558345, 22425.55148897013, 22509.099636014704, 8616.526091065052, 8647.783805404915, 8675.132486751274, 8711.303095752324, 9058.864117038249, 4404.7357158570585, 4471.8658440246845, 4512.4133862597655, 4523.2988886722615, 4567.977160114178, 3238.6923242292414, 3342.131045928076, 3346.113279980807, 3348.8325583720716, 3350.782199157047, 610.6092101055328, 611.5718996702237, 617.102116420607, 617.3147805935408, 618.5793660311032, 696.4150113904344, 698.9965050174717, 705.396885662751, 709.2198581560345, 725.7641266588274, 9181.081891810765, 9694.0, 9847.261455390875, 9994.500274986221, 10021.699349019542, 581.0180794457353, 590.4184378387286, 674.6828990374516, 675.1297468511248, 684.832216107057, 4493.213687604656, 4586.862394128181, 4841.443234028132, 4944.90110197794, 4945.8021679132435, 123554.0, 123556.0, 129822.45621403205, 130743.34628326798, 132689.0, 108761.0, 109349.45325273323, 110112.0, 112580.0, 114667.0, 91329.54335228415, 93841.5307923456, 94086.0, 95137.0, 98168.50915745518, 10548.208884333859, 10744.73138171552, 10762.19283553721, 10777.470542809331, 10909.509072091616, 55365.723171383885, 55597.0, 56088.71955640196, 57401.0, 57525.13712294403, 74695.62652186705, 85477.0, 85576.0, 86571.0, 88056.0, 13338.466461341437, 13435.395407206895, 14225.64435889111, 14379.137251764927, 14402.711945761235, 15850.841491585397, 16061.518154455385, 16331.59171020734, 16371.42700005494, 17046.744298835776, 14701.41194352214, 14740.410383584536, 14981.550553483414, 15500.224988750742, 15831.762523562385, 14259.714805703621, 14263.144211347353, 14348.0, 14726.410943562138, 14980.700385992437, 14611.707765844836, 14612.78080828767, 14786.482473113389, 14874.77687834705, 15153.482149493173, 11104.0, 11676.88323116758, 12005.219660722025, 12333.136680432284, 12392.504299827906, 12139.939300303442, 12165.270083795001, 12311.766175368473, 12341.753164936472, 12375.69060773452], "value": 7926.08764597496, "unit": "score"}], "name": "dromaeo_css", "value": 7311.302866845729, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 112.0, 112.0, 111.0, 113.0, 111.0, 111.0, 111.0, 112.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 116.0, 119.0, 178.0, 124.0, 120.0, 146.0, 119.0, 157.0, 116.0], "value": 133.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 161.0, 162.0, 162.0, 162.0, 159.0, 160.0, 160.0, 160.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 106.0, 76.0, 77.0, 75.0, 74.0, 98.0, 75.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 127.0, 84.0, 85.0, 86.0, 124.0, 84.0, 94.0, 140.0], "value": 99.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 145.0, 145.0, 146.0, 147.0, 145.0, 146.0, 146.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 50.0, 50.0, 50.0, 50.0, 50.0, 51.0, 50.0, 50.0, 50.0], "value": 51.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 61.0, 62.0, 62.0, 61.0, 62.0, 62.0, 62.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 75.0, 74.0, 75.0, 75.0, 80.0, 76.0, 76.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 142.0, 120.0, 121.0, 127.0, 124.0, 120.0, 121.0, 146.0, 124.0], "value": 126.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 163.0, 162.0, 162.0, 163.0, 161.0, 161.0, 158.0, 158.0], "value": 160.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 63.0, 64.0, 64.0, 64.0, 63.0, 63.0, 63.0, 62.0], "value": 63.9, "unit": "score"}], "name": "kraken", "value": 1483.7, "alertThreshold": 2.0}]} 23:26:17 INFO - Return code: 0 23:26:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:26:17 INFO - # TBPL SUCCESS # 23:26:17 INFO - Running post-action listener: _resource_record_post_action 23:26:17 INFO - [mozharness: 2016-08-12 06:26:17.633537Z] Finished run-tests step (success) 23:26:17 INFO - Running post-run listener: _resource_record_post_run 23:26:17 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 553242624; Read time: 0; Write time: 520872 23:26:17 INFO - TinderboxPrint: CPU usage
13.0% 23:26:17 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 23:26:17 INFO - TinderboxPrint: I/O write bytes / time
553,242,624 / 520,872 23:26:17 INFO - TinderboxPrint: CPU idle
8,287.5 (87.0%) 23:26:17 INFO - TinderboxPrint: CPU user
1,196.6 (12.6%) 23:26:17 INFO - TinderboxPrint: Swap in / out
0 / 0 23:26:17 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 257515520; Read time: 0; Write time: 275304 23:26:17 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 290902016; Read time: 0; Write time: 244948 23:26:18 INFO - Running post-run listener: _upload_blobber_files 23:26:18 INFO - Blob upload gear active. 23:26:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:26:18 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 23:26:18 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:26:18 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:26:18 INFO - (blobuploader) - INFO - Open directory for files ... 23:26:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:26:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:26:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:26:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:26:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:26:19 INFO - (blobuploader) - INFO - Done attempting. 23:26:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:26:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:26:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:26:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:26:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:26:25 INFO - (blobuploader) - INFO - Done attempting. 23:26:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:26:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:26:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:26:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:26:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:26:26 INFO - (blobuploader) - INFO - Done attempting. 23:26:26 INFO - (blobuploader) - INFO - Iteration through files over. 23:26:26 INFO - Return code: 0 23:26:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:26:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:26:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df444b5d3a96837ea6e6eb0120977ac624973c290a2f0b2cf4c733ea9bbf5e259fb8823507d75f4b936215979aaa636c2101dabc6fe0b3929ba1819022ef3153", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3395a810794c0d68aad09d629bec17e2a6e94be4cbfe2195176507a390fd322b224936b836080f61d60f800f389d35bcc19ed965aab76f4d0acddce071389fc2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c98ea78294d6ad9458f5bce0546be587e2899a36d047d951f27de3d46111fab029be96ff97e23c3b485b1ef2725873fa0f17f9b5b5804250120b2e6806653b76"} 23:26:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:26:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:26:26 INFO - Contents: 23:26:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/df444b5d3a96837ea6e6eb0120977ac624973c290a2f0b2cf4c733ea9bbf5e259fb8823507d75f4b936215979aaa636c2101dabc6fe0b3929ba1819022ef3153", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3395a810794c0d68aad09d629bec17e2a6e94be4cbfe2195176507a390fd322b224936b836080f61d60f800f389d35bcc19ed965aab76f4d0acddce071389fc2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c98ea78294d6ad9458f5bce0546be587e2899a36d047d951f27de3d46111fab029be96ff97e23c3b485b1ef2725873fa0f17f9b5b5804250120b2e6806653b76"} 23:26:26 INFO - Running post-run listener: copy_logs_to_upload_dir 23:26:26 INFO - Copying logs to upload dir... 23:26:26 INFO - mkdir: /builds/slave/test/build/upload/logs 23:26:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.065524 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-08-11 23:26:26.553022) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 23:26:26.556781) ========= 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=4300f881736b422476174874000001bc-1470978576.835875-337868573 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/sha512/df444b5d3a96837ea6e6eb0120977ac624973c290a2f0b2cf4c733ea9bbf5e259fb8823507d75f4b936215979aaa636c2101dabc6fe0b3929ba1819022ef3153", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3395a810794c0d68aad09d629bec17e2a6e94be4cbfe2195176507a390fd322b224936b836080f61d60f800f389d35bcc19ed965aab76f4d0acddce071389fc2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c98ea78294d6ad9458f5bce0546be587e2899a36d047d951f27de3d46111fab029be96ff97e23c3b485b1ef2725873fa0f17f9b5b5804250120b2e6806653b76"} build_url:https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011429 build_url: 'https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/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/sha512/df444b5d3a96837ea6e6eb0120977ac624973c290a2f0b2cf4c733ea9bbf5e259fb8823507d75f4b936215979aaa636c2101dabc6fe0b3929ba1819022ef3153", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3395a810794c0d68aad09d629bec17e2a6e94be4cbfe2195176507a390fd322b224936b836080f61d60f800f389d35bcc19ed965aab76f4d0acddce071389fc2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c98ea78294d6ad9458f5bce0546be587e2899a36d047d951f27de3d46111fab029be96ff97e23c3b485b1ef2725873fa0f17f9b5b5804250120b2e6806653b76"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 23:26:26.582620) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 23:26:26.582956) ========= 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=4300f881736b422476174874000001bc-1470978576.835875-337868573 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 23:26:26.667093) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 23:26:26.667476) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 23:26:26.667813) ========= ========= Total master_lag: 0.18 =========