builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-045 starttime: 1472172351.09 results: success (0) buildid: 20160825165318 builduid: 8175499750e041a8987b356b5870ac0a revision: cd4ed9909dc9da71e07af183e4293d95ed5e9160 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 17:45:51.093186) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 17:45:51.093617) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 17:45:51.093949) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 17:45:51.143112) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 17:45:51.143489) ========= 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-1472170911.656271-671159167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-25 17:45:51-- 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% 223M=0s 2016-08-25 17:45:51 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.364697 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 17:45:51.531169) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 17:45:51.531500) ========= 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-1472170911.656271-671159167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020455 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 17:45:51.592208) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-25 17:45:51.592559) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev cd4ed9909dc9da71e07af183e4293d95ed5e9160 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev cd4ed9909dc9da71e07af183e4293d95ed5e9160 --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-1472170911.656271-671159167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-25 17:45:51,943 truncating revision to first 12 chars 2016-08-25 17:45:51,944 Setting DEBUG logging. 2016-08-25 17:45:51,944 attempt 1/10 2016-08-25 17:45:51,944 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/cd4ed9909dc9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-25 17:45:52,985 unpacking tar archive at: mozilla-central-cd4ed9909dc9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.391513 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-25 17:45:53.000789) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 17:45:53.001569) ========= script_repo_revision: cd4ed9909dc9da71e07af183e4293d95ed5e9160 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 17:45:53.002519) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 17:45:53.003421) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 17:45:53.015493) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-08-25 17:45:53.015792) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4300f881736b422476174874000001bc-1472170911.656271-671159167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:45:53 INFO - MultiFileLogger online at 20160825 17:45:53 in /builds/slave/test 17:45:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 17:45:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:45:53 INFO - {'append_to_log': False, 17:45:53 INFO - 'base_work_dir': '/builds/slave/test', 17:45:53 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:45:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:45:53 INFO - 'branch': 'Firefox-Non-PGO', 17:45:53 INFO - 'buildbot_json_path': 'buildprops.json', 17:45:53 INFO - 'config_files': ('talos/linux_config.py',), 17:45:53 INFO - 'default_actions': ('clobber', 17:45:53 INFO - 'read-buildbot-config', 17:45:53 INFO - 'download-and-extract', 17:45:53 INFO - 'populate-webroot', 17:45:53 INFO - 'create-virtualenv', 17:45:53 INFO - 'install', 17:45:53 INFO - 'run-tests'), 17:45:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:45:53 INFO - 'download_minidump_stackwalk': True, 17:45:53 INFO - 'download_symbols': 'ondemand', 17:45:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:45:53 INFO - 'tooltool.py': '/tools/tooltool.py', 17:45:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:45:53 INFO - '/tools/misc-python/virtualenv.py')}, 17:45:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:45:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:45:53 INFO - 'installer_path': 'installer.exe', 17:45:53 INFO - 'log_level': 'info', 17:45:53 INFO - 'log_name': 'talos', 17:45:53 INFO - 'log_to_console': True, 17:45:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:45:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:45:53 INFO - 'opt_config_files': (), 17:45:53 INFO - 'pip_index': False, 17:45:53 INFO - 'sps_profile': False, 17:45:53 INFO - 'sps_profile_interval': 0, 17:45:53 INFO - 'suite': 'dromaeojs', 17:45:53 INFO - 'system_bits': '32', 17:45:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:45:53 INFO - 'title': 'talos-linux64-ix-045', 17:45:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:45:53 INFO - 'use_talos_json': True, 17:45:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:45:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:45:53 INFO - 'work_dir': 'build'} 17:45:53 INFO - [mozharness: 2016-08-26 00:45:53.460198Z] Running clobber step. 17:45:53 INFO - Running pre-action listener: _resource_record_pre_action 17:45:53 INFO - Running main action method: clobber 17:45:53 INFO - rmtree: /builds/slave/test/build 17:45:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:45:54 INFO - Running post-action listener: _resource_record_post_action 17:45:54 INFO - [mozharness: 2016-08-26 00:45:54.447999Z] Finished clobber step (success) 17:45:54 INFO - [mozharness: 2016-08-26 00:45:54.448103Z] Running read-buildbot-config step. 17:45:54 INFO - Running pre-action listener: _resource_record_pre_action 17:45:54 INFO - Running main action method: read_buildbot_config 17:45:54 INFO - Using buildbot properties: 17:45:54 INFO - { 17:45:54 INFO - "project": "", 17:45:54 INFO - "product": "firefox", 17:45:54 INFO - "script_repo_revision": "production", 17:45:54 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 17:45:54 INFO - "repository": "", 17:45:54 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 17:45:54 INFO - "buildid": "20160825165318", 17:45:54 INFO - "pgo_build": "False", 17:45:54 INFO - "basedir": "/builds/slave/test", 17:45:54 INFO - "buildnumber": 616, 17:45:54 INFO - "slavename": "talos-linux64-ix-045", 17:45:54 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:45:54 INFO - "platform": "ubuntu64_hw", 17:45:54 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 17:45:54 INFO - "branch": "mozilla-central", 17:45:54 INFO - "repo_path": "mozilla-central", 17:45:54 INFO - "revision": "cd4ed9909dc9da71e07af183e4293d95ed5e9160", 17:45:54 INFO - "stage_platform": "linux64", 17:45:54 INFO - "builduid": "8175499750e041a8987b356b5870ac0a", 17:45:54 INFO - "slavebuilddir": "test" 17:45:54 INFO - } 17:45:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/RVgfo78BQ-GH7JW-rq9Lrg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 17:45:54 INFO - Running post-action listener: _resource_record_post_action 17:45:54 INFO - [mozharness: 2016-08-26 00:45:54.450615Z] Finished read-buildbot-config step (success) 17:45:54 INFO - [mozharness: 2016-08-26 00:45:54.450703Z] Running download-and-extract step. 17:45:54 INFO - Running pre-action listener: _resource_record_pre_action 17:45:54 INFO - Running main action method: download_and_extract 17:45:54 INFO - mkdir: /builds/slave/test/build/tests 17:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:45:54 INFO - trying https://queue.taskcluster.net/v1/task/RVgfo78BQ-GH7JW-rq9Lrg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:45:54 INFO - Downloading https://queue.taskcluster.net/v1/task/RVgfo78BQ-GH7JW-rq9Lrg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:45:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RVgfo78BQ-GH7JW-rq9Lrg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:45:55 INFO - Downloaded 1361 bytes. 17:45:55 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 17:45:55 INFO - Using the following test package requirements: 17:45:55 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 17:45:55 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:45:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:45:55 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:45:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:45:55 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:45:55 INFO - u'jsshell-linux-x86_64.zip'], 17:45:55 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:45:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:45:55 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 17:45:55 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:45:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:45:55 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:45:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:45:55 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:45:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:45:55 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 17:45:55 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:45:55 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:45:55 INFO - trying https://queue.taskcluster.net/v1/task/RVgfo78BQ-GH7JW-rq9Lrg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:45:55 INFO - Downloading https://queue.taskcluster.net/v1/task/RVgfo78BQ-GH7JW-rq9Lrg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:45:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RVgfo78BQ-GH7JW-rq9Lrg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:45:55 INFO - Downloaded 20325112 bytes. 17:45:55 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 17:46:00 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:46:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:46:00 INFO - trying https://queue.taskcluster.net/v1/task/RVgfo78BQ-GH7JW-rq9Lrg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:46:00 INFO - Downloading https://queue.taskcluster.net/v1/task/RVgfo78BQ-GH7JW-rq9Lrg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 17:46:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RVgfo78BQ-GH7JW-rq9Lrg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:46:01 INFO - Downloaded 20325112 bytes. 17:46:01 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 17:46:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:46:05 INFO - trying https://queue.taskcluster.net/v1/task/RVgfo78BQ-GH7JW-rq9Lrg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 17:46:05 INFO - Downloading https://queue.taskcluster.net/v1/task/RVgfo78BQ-GH7JW-rq9Lrg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 17:46:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RVgfo78BQ-GH7JW-rq9Lrg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:46:06 INFO - Downloaded 14413981 bytes. 17:46:06 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 17:46:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:46:06 INFO - trying https://queue.taskcluster.net/v1/task/RVgfo78BQ-GH7JW-rq9Lrg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:46:06 INFO - Downloading https://queue.taskcluster.net/v1/task/RVgfo78BQ-GH7JW-rq9Lrg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:46:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RVgfo78BQ-GH7JW-rq9Lrg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:46:08 INFO - Downloaded 55755053 bytes. 17:46:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RVgfo78BQ-GH7JW-rq9Lrg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:46:08 INFO - mkdir: /builds/slave/test/properties 17:46:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:46:08 INFO - Writing to file /builds/slave/test/properties/build_url 17:46:08 INFO - Contents: 17:46:08 INFO - build_url:https://queue.taskcluster.net/v1/task/RVgfo78BQ-GH7JW-rq9Lrg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 17:46:08 INFO - Running post-action listener: _resource_record_post_action 17:46:08 INFO - Running post-action listener: set_extra_try_arguments 17:46:08 INFO - [mozharness: 2016-08-26 00:46:08.750580Z] Finished download-and-extract step (success) 17:46:08 INFO - [mozharness: 2016-08-26 00:46:08.750803Z] Running populate-webroot step. 17:46:08 INFO - Running pre-action listener: _resource_record_pre_action 17:46:08 INFO - Running main action method: populate_webroot 17:46:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:46:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:46:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:46:08 INFO - '--tppagecycles', 17:46:08 INFO - '7'], 17:46:08 INFO - 'tests': ['tsvgm']}}, 17:46:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:46:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:46:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:46:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:46:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:46:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:46:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:46:08 INFO - 'talos_options': ['--disable-e10s'], 17:46:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:46:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:46:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:46:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:46:08 INFO - 'talos_options': ['--disable-e10s'], 17:46:08 INFO - 'tests': ['damp', 'tps']}, 17:46:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:46:08 INFO - 'tests': ['damp', 'tps']}, 17:46:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:46:08 INFO - 'tests': ['dromaeo_dom']}, 17:46:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:46:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:46:08 INFO - 'tests': ['basic_compositor_video']}, 17:46:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:46:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:46:08 INFO - 'tests': ['a11yr', 17:46:08 INFO - 'ts_paint', 17:46:08 INFO - 'tpaint', 17:46:08 INFO - 'sessionrestore', 17:46:08 INFO - 'sessionrestore_no_auto_restore', 17:46:08 INFO - 'tabpaint']}, 17:46:08 INFO - 'other-e10s': {'tests': ['a11yr', 17:46:08 INFO - 'ts_paint', 17:46:08 INFO - 'tpaint', 17:46:08 INFO - 'sessionrestore', 17:46:08 INFO - 'sessionrestore_no_auto_restore', 17:46:08 INFO - 'tabpaint']}, 17:46:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:46:08 INFO - 'ts_paint', 17:46:08 INFO - 'tpaint', 17:46:08 INFO - 'sessionrestore', 17:46:08 INFO - 'sessionrestore_no_auto_restore', 17:46:08 INFO - 'tabpaint']}, 17:46:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:46:08 INFO - 'ts_paint', 17:46:08 INFO - 'tpaint', 17:46:08 INFO - 'sessionrestore', 17:46:08 INFO - 'sessionrestore_no_auto_restore', 17:46:08 INFO - 'tabpaint']}, 17:46:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:46:08 INFO - 'tests': ['a11yr', 17:46:08 INFO - 'ts_paint', 17:46:08 INFO - 'tpaint', 17:46:08 INFO - 'sessionrestore', 17:46:08 INFO - 'sessionrestore_no_auto_restore', 17:46:08 INFO - 'tabpaint']}, 17:46:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:46:08 INFO - 'tests': ['a11yr', 17:46:08 INFO - 'ts_paint', 17:46:08 INFO - 'tpaint', 17:46:08 INFO - 'sessionrestore', 17:46:08 INFO - 'sessionrestore_no_auto_restore', 17:46:08 INFO - 'tabpaint']}, 17:46:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:46:08 INFO - 'tests': ['tsvgx', 17:46:08 INFO - 'tsvgr_opacity', 17:46:08 INFO - 'tart', 17:46:08 INFO - 'tscrollx', 17:46:08 INFO - 'cart']}, 17:46:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:46:08 INFO - 'tsvgr_opacity', 17:46:08 INFO - 'tart', 17:46:08 INFO - 'tscrollx', 17:46:08 INFO - 'cart']}, 17:46:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:46:08 INFO - 'talos_options': ['--disable-e10s'], 17:46:08 INFO - 'tests': ['tp5o']}, 17:46:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:46:08 INFO - 'tests': ['tp5o']}, 17:46:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:46:08 INFO - 'talos_options': ['--disable-e10s', 17:46:08 INFO - '--xperf_path', 17:46:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:46:08 INFO - 'tests': ['tp5n']}, 17:46:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:46:08 INFO - 'talos_options': ['--xperf_path', 17:46:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:46:08 INFO - 'tests': ['tp5n']}}, 17:46:08 INFO - 'talos.zip': {'path': '', 17:46:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:46:08 INFO - Running post-action listener: _resource_record_post_action 17:46:08 INFO - [mozharness: 2016-08-26 00:46:08.768319Z] Finished populate-webroot step (success) 17:46:08 INFO - [mozharness: 2016-08-26 00:46:08.768407Z] Running create-virtualenv step. 17:46:08 INFO - Running pre-action listener: _resource_record_pre_action 17:46:08 INFO - Running main action method: create_virtualenv 17:46:08 INFO - Creating virtualenv /builds/slave/test/build/venv 17:46:08 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:46:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:46:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:46:08 INFO - Using real prefix '/usr' 17:46:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:46:09 INFO - Installing distribute.............................................................................................................................................................................................done. 17:46:11 INFO - Installing pip.................done. 17:46:11 INFO - Return code: 0 17:46:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:46:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:46:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:46:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:11 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 0x7f10ba75bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2617420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a5d20>, '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 0x26a6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a70b0>, '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-1472170911.656271-671159167', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:46:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:46:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:46:11 INFO - Using env: {'DISPLAY': ':0', 17:46:11 INFO - 'HOME': '/home/cltbld', 17:46:11 INFO - 'LANG': 'en_US.UTF-8', 17:46:11 INFO - 'LANGUAGE': 'en_US:en', 17:46:11 INFO - 'LOGNAME': 'cltbld', 17:46:11 INFO - 'MAIL': '/var/mail/cltbld', 17:46:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:11 INFO - 'MOZ_NO_REMOTE': '1', 17:46:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:46:11 INFO - 'NO_EM_RESTART': '1', 17:46:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:46:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:11 INFO - 'PWD': '/builds/slave/test', 17:46:11 INFO - 'SHELL': '/bin/bash', 17:46:11 INFO - 'SHLVL': '1', 17:46:11 INFO - 'TERM': 'linux', 17:46:11 INFO - 'TMOUT': '86400', 17:46:11 INFO - 'USER': 'cltbld', 17:46:11 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472170911.656271-671159167', 17:46:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:11 INFO - '_': '/tools/buildbot/bin/python'} 17:46:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:46:11 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:46:11 INFO - Cleaning up... 17:46:11 INFO - Return code: 0 17:46:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:46:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:46:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:46:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:11 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 0x7f10ba75bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2617420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a5d20>, '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 0x26a6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a70b0>, '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-1472170911.656271-671159167', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:46:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:46:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:46:11 INFO - Using env: {'DISPLAY': ':0', 17:46:11 INFO - 'HOME': '/home/cltbld', 17:46:11 INFO - 'LANG': 'en_US.UTF-8', 17:46:11 INFO - 'LANGUAGE': 'en_US:en', 17:46:11 INFO - 'LOGNAME': 'cltbld', 17:46:11 INFO - 'MAIL': '/var/mail/cltbld', 17:46:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:11 INFO - 'MOZ_NO_REMOTE': '1', 17:46:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:46:11 INFO - 'NO_EM_RESTART': '1', 17:46:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:46:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:11 INFO - 'PWD': '/builds/slave/test', 17:46:11 INFO - 'SHELL': '/bin/bash', 17:46:11 INFO - 'SHLVL': '1', 17:46:11 INFO - 'TERM': 'linux', 17:46:11 INFO - 'TMOUT': '86400', 17:46:11 INFO - 'USER': 'cltbld', 17:46:11 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472170911.656271-671159167', 17:46:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:11 INFO - '_': '/tools/buildbot/bin/python'} 17:46:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:46:11 INFO - Downloading/unpacking psutil>=3.1.1 17:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:46:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:46:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:46:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:46:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:46:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:46:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:46:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:46:13 INFO - Installing collected packages: psutil 17:46:13 INFO - Running setup.py install for psutil 17:46:13 INFO - building 'psutil._psutil_linux' extension 17:46:13 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:46:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:46:14 INFO - building 'psutil._psutil_posix' extension 17:46:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:46:14 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:46:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:46:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:46:14 INFO - Successfully installed psutil 17:46:14 INFO - Cleaning up... 17:46:14 INFO - Return code: 0 17:46:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:46:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:46:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:46:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:46:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:14 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 0x7f10ba75bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2617420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a5d20>, '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 0x26a6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a70b0>, '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-1472170911.656271-671159167', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:46:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:46:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:46:14 INFO - Using env: {'DISPLAY': ':0', 17:46:14 INFO - 'HOME': '/home/cltbld', 17:46:14 INFO - 'LANG': 'en_US.UTF-8', 17:46:14 INFO - 'LANGUAGE': 'en_US:en', 17:46:14 INFO - 'LOGNAME': 'cltbld', 17:46:14 INFO - 'MAIL': '/var/mail/cltbld', 17:46:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:14 INFO - 'MOZ_NO_REMOTE': '1', 17:46:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:46:14 INFO - 'NO_EM_RESTART': '1', 17:46:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:46:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:14 INFO - 'PWD': '/builds/slave/test', 17:46:14 INFO - 'SHELL': '/bin/bash', 17:46:14 INFO - 'SHLVL': '1', 17:46:14 INFO - 'TERM': 'linux', 17:46:14 INFO - 'TMOUT': '86400', 17:46:14 INFO - 'USER': 'cltbld', 17:46:14 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472170911.656271-671159167', 17:46:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:14 INFO - '_': '/tools/buildbot/bin/python'} 17:46:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:46:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:46:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:46:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:46:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:46:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:46:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:46:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:46:16 INFO - Installing collected packages: mozsystemmonitor 17:46:16 INFO - Running setup.py install for mozsystemmonitor 17:46:16 INFO - Successfully installed mozsystemmonitor 17:46:16 INFO - Cleaning up... 17:46:16 INFO - Return code: 0 17:46:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:46:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:46:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:46:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:46:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:16 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 0x7f10ba75bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2617420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a5d20>, '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 0x26a6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a70b0>, '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-1472170911.656271-671159167', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:46:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:46:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:46:16 INFO - Using env: {'DISPLAY': ':0', 17:46:16 INFO - 'HOME': '/home/cltbld', 17:46:16 INFO - 'LANG': 'en_US.UTF-8', 17:46:16 INFO - 'LANGUAGE': 'en_US:en', 17:46:16 INFO - 'LOGNAME': 'cltbld', 17:46:16 INFO - 'MAIL': '/var/mail/cltbld', 17:46:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:16 INFO - 'MOZ_NO_REMOTE': '1', 17:46:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:46:16 INFO - 'NO_EM_RESTART': '1', 17:46:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:46:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:16 INFO - 'PWD': '/builds/slave/test', 17:46:16 INFO - 'SHELL': '/bin/bash', 17:46:16 INFO - 'SHLVL': '1', 17:46:16 INFO - 'TERM': 'linux', 17:46:16 INFO - 'TMOUT': '86400', 17:46:16 INFO - 'USER': 'cltbld', 17:46:16 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472170911.656271-671159167', 17:46:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:16 INFO - '_': '/tools/buildbot/bin/python'} 17:46:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:46:16 INFO - Downloading/unpacking jsonschema==2.5.1 17:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:46:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:46:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:46:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:46:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:46:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:46:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:46:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:46:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:46:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:46:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:46:18 INFO - Downloading functools32-3.2.3-2.tar.gz 17:46:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:46:19 INFO - warning: no files found matching '*.txt' 17:46:19 INFO - no previously-included directories found matching 'build' 17:46:19 INFO - no previously-included directories found matching 'dist' 17:46:19 INFO - no previously-included directories found matching '.git*' 17:46:19 INFO - Installing collected packages: jsonschema, functools32 17:46:19 INFO - Running setup.py install for functools32 17:46:19 INFO - warning: no files found matching '*.txt' 17:46:19 INFO - no previously-included directories found matching 'build' 17:46:19 INFO - no previously-included directories found matching 'dist' 17:46:19 INFO - no previously-included directories found matching '.git*' 17:46:19 INFO - Successfully installed jsonschema functools32 17:46:19 INFO - Cleaning up... 17:46:19 INFO - Return code: 0 17:46:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:46:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:46:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:46:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:46:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f10ba75bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2617420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a5d20>, '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 0x26a6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a70b0>, '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-1472170911.656271-671159167', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:46:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:46:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:46:19 INFO - Using env: {'DISPLAY': ':0', 17:46:19 INFO - 'HOME': '/home/cltbld', 17:46:19 INFO - 'LANG': 'en_US.UTF-8', 17:46:19 INFO - 'LANGUAGE': 'en_US:en', 17:46:19 INFO - 'LOGNAME': 'cltbld', 17:46:19 INFO - 'MAIL': '/var/mail/cltbld', 17:46:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:19 INFO - 'MOZ_NO_REMOTE': '1', 17:46:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:46:19 INFO - 'NO_EM_RESTART': '1', 17:46:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:46:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:19 INFO - 'PWD': '/builds/slave/test', 17:46:19 INFO - 'SHELL': '/bin/bash', 17:46:19 INFO - 'SHLVL': '1', 17:46:19 INFO - 'TERM': 'linux', 17:46:19 INFO - 'TMOUT': '86400', 17:46:19 INFO - 'USER': 'cltbld', 17:46:19 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472170911.656271-671159167', 17:46:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:19 INFO - '_': '/tools/buildbot/bin/python'} 17:46:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:46:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:46:19 INFO - Cleaning up... 17:46:19 INFO - Return code: 0 17:46:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:46:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:46:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:46:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:46:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f10ba75bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2617420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a5d20>, '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 0x26a6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a70b0>, '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-1472170911.656271-671159167', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:46:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:46:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:46:19 INFO - Using env: {'DISPLAY': ':0', 17:46:19 INFO - 'HOME': '/home/cltbld', 17:46:19 INFO - 'LANG': 'en_US.UTF-8', 17:46:19 INFO - 'LANGUAGE': 'en_US:en', 17:46:19 INFO - 'LOGNAME': 'cltbld', 17:46:19 INFO - 'MAIL': '/var/mail/cltbld', 17:46:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:19 INFO - 'MOZ_NO_REMOTE': '1', 17:46:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:46:19 INFO - 'NO_EM_RESTART': '1', 17:46:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:46:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:19 INFO - 'PWD': '/builds/slave/test', 17:46:19 INFO - 'SHELL': '/bin/bash', 17:46:19 INFO - 'SHLVL': '1', 17:46:19 INFO - 'TERM': 'linux', 17:46:19 INFO - 'TMOUT': '86400', 17:46:19 INFO - 'USER': 'cltbld', 17:46:19 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472170911.656271-671159167', 17:46:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:19 INFO - '_': '/tools/buildbot/bin/python'} 17:46:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:46:19 INFO - Downloading/unpacking blobuploader==1.2.4 17:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:46:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:46:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:46:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:46:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:46:21 INFO - Downloading blobuploader-1.2.4.tar.gz 17:46:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:46:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:46:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:46:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:46:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:46:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:46:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:46:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:46:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:46:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:46:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:46:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:46:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:46:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:46:22 INFO - Downloading docopt-0.6.1.tar.gz 17:46:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:46:22 INFO - Installing collected packages: blobuploader, requests, docopt 17:46:22 INFO - Running setup.py install for blobuploader 17:46:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:46:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:46:22 INFO - Running setup.py install for requests 17:46:22 INFO - Running setup.py install for docopt 17:46:22 INFO - Successfully installed blobuploader requests docopt 17:46:22 INFO - Cleaning up... 17:46:22 INFO - Return code: 0 17:46:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:46: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')]} 17:46:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:46:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46: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')]} 17:46:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:46:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:22 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 0x7f10ba75bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2617420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a5d20>, '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 0x26a6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a70b0>, '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-1472170911.656271-671159167', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:46:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:46:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:46:22 INFO - Using env: {'DISPLAY': ':0', 17:46:22 INFO - 'HOME': '/home/cltbld', 17:46:22 INFO - 'LANG': 'en_US.UTF-8', 17:46:22 INFO - 'LANGUAGE': 'en_US:en', 17:46:22 INFO - 'LOGNAME': 'cltbld', 17:46:22 INFO - 'MAIL': '/var/mail/cltbld', 17:46:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:22 INFO - 'MOZ_NO_REMOTE': '1', 17:46:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:46:22 INFO - 'NO_EM_RESTART': '1', 17:46:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:46:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:22 INFO - 'PWD': '/builds/slave/test', 17:46:22 INFO - 'SHELL': '/bin/bash', 17:46:22 INFO - 'SHLVL': '1', 17:46:22 INFO - 'TERM': 'linux', 17:46:22 INFO - 'TMOUT': '86400', 17:46:22 INFO - 'USER': 'cltbld', 17:46:22 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472170911.656271-671159167', 17:46:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:22 INFO - '_': '/tools/buildbot/bin/python'} 17:46:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:46:23 INFO - Running setup.py (path:/tmp/pip-aTibCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:46:23 INFO - Running setup.py (path:/tmp/pip-uRlKle-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:46:23 INFO - Running setup.py (path:/tmp/pip-GMc0im-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:46:23 INFO - Running setup.py (path:/tmp/pip-eWOOAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:46:23 INFO - Running setup.py (path:/tmp/pip-IgIcvg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:46:23 INFO - Running setup.py (path:/tmp/pip-n424Nc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:46:23 INFO - Running setup.py (path:/tmp/pip-yWJQrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:46:23 INFO - Running setup.py (path:/tmp/pip-czhPb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:46:23 INFO - Running setup.py (path:/tmp/pip-ojQbDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:46:23 INFO - Running setup.py (path:/tmp/pip-54mIoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:46:23 INFO - Running setup.py (path:/tmp/pip-alAtbG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:46:23 INFO - Running setup.py (path:/tmp/pip-0dOrTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:46:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:46:24 INFO - Running setup.py (path:/tmp/pip-BTUmAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:46:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:46:24 INFO - Running setup.py (path:/tmp/pip-rSOenU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:46:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:46:24 INFO - Running setup.py (path:/tmp/pip-gW3lTK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:46:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:46:24 INFO - Running setup.py (path:/tmp/pip-KiE_zo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:46:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:46:24 INFO - Running setup.py (path:/tmp/pip-wC89zY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:46:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:46:24 INFO - Running setup.py install for manifestparser 17:46:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:46:24 INFO - Running setup.py install for mozcrash 17:46:24 INFO - Running setup.py install for mozdebug 17:46:24 INFO - Running setup.py install for mozdevice 17:46:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:46:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:46:24 INFO - Running setup.py install for mozfile 17:46:24 INFO - Running setup.py install for mozhttpd 17:46:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:46:25 INFO - Running setup.py install for mozinfo 17:46:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:46:25 INFO - Running setup.py install for mozInstall 17:46:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:46:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:46:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:46:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:46:25 INFO - Running setup.py install for mozleak 17:46:25 INFO - Running setup.py install for mozlog 17:46:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:46:25 INFO - Running setup.py install for moznetwork 17:46:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:46:25 INFO - Running setup.py install for mozprocess 17:46:25 INFO - Running setup.py install for mozprofile 17:46:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:46:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:46:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:46:25 INFO - Running setup.py install for mozrunner 17:46:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:46:25 INFO - Running setup.py install for mozscreenshot 17:46:25 INFO - Running setup.py install for moztest 17:46:26 INFO - Running setup.py install for mozversion 17:46:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:46:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:46:26 INFO - Cleaning up... 17:46:26 INFO - Return code: 0 17:46:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:46:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:46:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:46:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:46:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:26 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 0x7f10ba75bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2617420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a5d20>, '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 0x26a6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a70b0>, '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-1472170911.656271-671159167', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:46:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:46:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:46:26 INFO - Using env: {'DISPLAY': ':0', 17:46:26 INFO - 'HOME': '/home/cltbld', 17:46:26 INFO - 'LANG': 'en_US.UTF-8', 17:46:26 INFO - 'LANGUAGE': 'en_US:en', 17:46:26 INFO - 'LOGNAME': 'cltbld', 17:46:26 INFO - 'MAIL': '/var/mail/cltbld', 17:46:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:26 INFO - 'MOZ_NO_REMOTE': '1', 17:46:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:46:26 INFO - 'NO_EM_RESTART': '1', 17:46:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:46:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:26 INFO - 'PWD': '/builds/slave/test', 17:46:26 INFO - 'SHELL': '/bin/bash', 17:46:26 INFO - 'SHLVL': '1', 17:46:26 INFO - 'TERM': 'linux', 17:46:26 INFO - 'TMOUT': '86400', 17:46:26 INFO - 'USER': 'cltbld', 17:46:26 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472170911.656271-671159167', 17:46:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:26 INFO - '_': '/tools/buildbot/bin/python'} 17:46:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:46:26 INFO - Running setup.py (path:/tmp/pip-Y4zFV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:46:26 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:46:26 INFO - Running setup.py (path:/tmp/pip-Rj1H3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:46:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:46:26 INFO - Running setup.py (path:/tmp/pip-fFX_4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:46:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:46:26 INFO - Running setup.py (path:/tmp/pip-ecyIwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:46:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:46:26 INFO - Running setup.py (path:/tmp/pip-IjlgUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:46:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:46:26 INFO - Running setup.py (path:/tmp/pip-AauPCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:46:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:46:26 INFO - Running setup.py (path:/tmp/pip-o3cos4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:46:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:46:26 INFO - Running setup.py (path:/tmp/pip-iUKNTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:46:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:46:27 INFO - Running setup.py (path:/tmp/pip-4t5w1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:46:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:46:27 INFO - Running setup.py (path:/tmp/pip-QRPfYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:46:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:46:27 INFO - Running setup.py (path:/tmp/pip-WNnixi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:46:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:46:27 INFO - Running setup.py (path:/tmp/pip-v_WgA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:46:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:46:27 INFO - Running setup.py (path:/tmp/pip-D_Ljcq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:46:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:46:27 INFO - Running setup.py (path:/tmp/pip-FCRdIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:46:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:46:27 INFO - Running setup.py (path:/tmp/pip-d4ghAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:46:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:46:27 INFO - Running setup.py (path:/tmp/pip-ccH32f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:46:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:46:27 INFO - Running setup.py (path:/tmp/pip-xQhqA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:46:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:46:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:46:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:46:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:46:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:46:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:46:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:46:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:46:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:46:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:46:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:46:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:46:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:46:29 INFO - Downloading blessings-1.6.tar.gz 17:46:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:46:29 INFO - Installing collected packages: blessings 17:46:29 INFO - Running setup.py install for blessings 17:46:29 INFO - Successfully installed blessings 17:46:29 INFO - Cleaning up... 17:46:29 INFO - Return code: 0 17:46:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:46:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:46:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:46:29 INFO - Reading from file tmpfile_stdout 17:46:29 INFO - Current package versions: 17:46:29 INFO - argparse == 1.2.1 17:46:29 INFO - blessings == 1.6 17:46:29 INFO - blobuploader == 1.2.4 17:46:29 INFO - docopt == 0.6.1 17:46:29 INFO - functools32 == 3.2.3-2 17:46:30 INFO - jsonschema == 2.5.1 17:46:30 INFO - manifestparser == 1.1 17:46:30 INFO - mozInstall == 1.12 17:46:30 INFO - mozcrash == 0.17 17:46:30 INFO - mozdebug == 0.1 17:46:30 INFO - mozdevice == 0.48 17:46:30 INFO - mozfile == 1.2 17:46:30 INFO - mozhttpd == 0.7 17:46:30 INFO - mozinfo == 0.9 17:46:30 INFO - mozleak == 0.1 17:46:30 INFO - mozlog == 3.3 17:46:30 INFO - moznetwork == 0.27 17:46:30 INFO - mozprocess == 0.23 17:46:30 INFO - mozprofile == 0.28 17:46:30 INFO - mozrunner == 6.12 17:46:30 INFO - mozscreenshot == 0.1 17:46:30 INFO - mozsystemmonitor == 0.3 17:46:30 INFO - moztest == 0.7 17:46:30 INFO - mozversion == 1.4 17:46:30 INFO - psutil == 3.1.1 17:46:30 INFO - requests == 1.2.3 17:46:30 INFO - wsgiref == 0.1.2 17:46:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:46:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:46:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:46:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:46:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:30 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 0x7f10ba75bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2617420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a5d20>, '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 0x26a6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a70b0>, '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-1472170911.656271-671159167', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:46:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:46:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:46:30 INFO - Using env: {'DISPLAY': ':0', 17:46:30 INFO - 'HOME': '/home/cltbld', 17:46:30 INFO - 'LANG': 'en_US.UTF-8', 17:46:30 INFO - 'LANGUAGE': 'en_US:en', 17:46:30 INFO - 'LOGNAME': 'cltbld', 17:46:30 INFO - 'MAIL': '/var/mail/cltbld', 17:46:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:30 INFO - 'MOZ_NO_REMOTE': '1', 17:46:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:46:30 INFO - 'NO_EM_RESTART': '1', 17:46:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:46:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:30 INFO - 'PWD': '/builds/slave/test', 17:46:30 INFO - 'SHELL': '/bin/bash', 17:46:30 INFO - 'SHLVL': '1', 17:46:30 INFO - 'TERM': 'linux', 17:46:30 INFO - 'TMOUT': '86400', 17:46:30 INFO - 'USER': 'cltbld', 17:46:30 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472170911.656271-671159167', 17:46:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:30 INFO - '_': '/tools/buildbot/bin/python'} 17:46:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:46:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:46:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:46:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:46:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:46:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:46:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:46:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:46:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:46:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:46:30 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:46:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:46:30 INFO - Cleaning up... 17:46:30 INFO - Return code: 0 17:46:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:46:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:46:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:46:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:46:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:46:30 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 0x7f10ba75bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2617420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26a5d20>, '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 0x26a6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a70b0>, '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-1472170911.656271-671159167', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:46:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:46:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:46:30 INFO - Using env: {'DISPLAY': ':0', 17:46:30 INFO - 'HOME': '/home/cltbld', 17:46:30 INFO - 'LANG': 'en_US.UTF-8', 17:46:30 INFO - 'LANGUAGE': 'en_US:en', 17:46:30 INFO - 'LOGNAME': 'cltbld', 17:46:30 INFO - 'MAIL': '/var/mail/cltbld', 17:46:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:30 INFO - 'MOZ_NO_REMOTE': '1', 17:46:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:46:30 INFO - 'NO_EM_RESTART': '1', 17:46:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:46:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:30 INFO - 'PWD': '/builds/slave/test', 17:46:30 INFO - 'SHELL': '/bin/bash', 17:46:30 INFO - 'SHLVL': '1', 17:46:30 INFO - 'TERM': 'linux', 17:46:30 INFO - 'TMOUT': '86400', 17:46:30 INFO - 'USER': 'cltbld', 17:46:30 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472170911.656271-671159167', 17:46:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:30 INFO - '_': '/tools/buildbot/bin/python'} 17:46:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:46:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:46:30 INFO - Cleaning up... 17:46:30 INFO - Return code: 0 17:46:30 INFO - Running post-action listener: _resource_record_post_action 17:46:30 INFO - Running post-action listener: _start_resource_monitoring 17:46:30 INFO - Starting resource monitoring. 17:46:30 INFO - [mozharness: 2016-08-26 00:46:30.468870Z] Finished create-virtualenv step (success) 17:46:30 INFO - [mozharness: 2016-08-26 00:46:30.469460Z] Running install step. 17:46:30 INFO - Running pre-action listener: _resource_record_pre_action 17:46:30 INFO - Running main action method: install 17:46:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:46:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:46:30 INFO - Reading from file tmpfile_stdout 17:46:30 INFO - Detecting whether we're running mozinstall >=1.0... 17:46:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:46:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:46:30 INFO - Reading from file tmpfile_stdout 17:46:30 INFO - Output received: 17:46:30 INFO - Usage: mozinstall [options] installer 17:46:30 INFO - Options: 17:46:30 INFO - -h, --help show this help message and exit 17:46:30 INFO - -d DEST, --destination=DEST 17:46:30 INFO - Directory to install application into. [default: 17:46:30 INFO - "/builds/slave/test"] 17:46:30 INFO - --app=APP Application being installed. [default: firefox] 17:46:30 INFO - mkdir: /builds/slave/test/build/application 17:46:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:46:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:46:46 INFO - Reading from file tmpfile_stdout 17:46:46 INFO - Output received: 17:46:46 INFO - /builds/slave/test/build/application/firefox/firefox 17:46:46 INFO - Running post-action listener: _resource_record_post_action 17:46:46 INFO - [mozharness: 2016-08-26 00:46:46.872635Z] Finished install step (success) 17:46:46 INFO - [mozharness: 2016-08-26 00:46:46.872886Z] Running run-tests step. 17:46:46 INFO - Running pre-action listener: _resource_record_pre_action 17:46:46 INFO - Running main action method: run_tests 17:46:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:46:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:46:46 INFO - Python 2.7.3 17:46:46 INFO - Return code: 0 17:46:46 INFO - grabbing minidump binary from tooltool 17:46:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:46:46 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 0x26a5d20>, '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 0x26a6c20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26a70b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:46:46 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:46:46 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:46:46 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:46:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:46:46 INFO - Return code: 0 17:46:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:46:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:46:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:46:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:46:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:46:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RVgfo78BQ-GH7JW-rq9Lrg/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 17:46:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RVgfo78BQ-GH7JW-rq9Lrg/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 17:46:46 INFO - Using env: {'DISPLAY': ':0', 17:46:46 INFO - 'HOME': '/home/cltbld', 17:46:46 INFO - 'LANG': 'en_US.UTF-8', 17:46:46 INFO - 'LANGUAGE': 'en_US:en', 17:46:46 INFO - 'LOGNAME': 'cltbld', 17:46:46 INFO - 'MAIL': '/var/mail/cltbld', 17:46:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:46:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:46:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:46:46 INFO - 'MOZ_NO_REMOTE': '1', 17:46:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:46:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:46:46 INFO - 'NO_EM_RESTART': '1', 17:46:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:46:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:46:46 INFO - 'PWD': '/builds/slave/test', 17:46:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:46:46 INFO - 'SHELL': '/bin/bash', 17:46:46 INFO - 'SHLVL': '1', 17:46:46 INFO - 'TERM': 'linux', 17:46:46 INFO - 'TMOUT': '86400', 17:46:46 INFO - 'USER': 'cltbld', 17:46:46 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1472170911.656271-671159167', 17:46:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:46:46 INFO - '_': '/tools/buildbot/bin/python'} 17:46:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RVgfo78BQ-GH7JW-rq9Lrg/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 17:46:47 INFO - mozversion application_buildid: 20160825165318 17:46:47 INFO - mozversion application_changeset: cd4ed9909dc9da71e07af183e4293d95ed5e9160 17:46:47 INFO - mozversion application_display_name: Nightly 17:46:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:46:47 INFO - mozversion application_name: Firefox 17:46:47 INFO - mozversion application_remotingname: firefox 17:46:47 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:46:47 INFO - mozversion application_vendor: Mozilla 17:46:47 INFO - mozversion application_version: 51.0a1 17:46:47 INFO - mozversion platform_buildid: 20160825165318 17:46:47 INFO - mozversion platform_changeset: cd4ed9909dc9da71e07af183e4293d95ed5e9160 17:46:47 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:46:47 INFO - mozversion platform_version: 51.0a1 17:46:47 INFO - using testdate: 1472172407 17:46:47 INFO - actual date: 1472172407 17:46:47 INFO - starting webserver on 'localhost:35144' 17:46:47 INFO - SUITE-START | Running 2 tests 17:46:47 INFO - TEST-START | dromaeo_css 17:46:47 INFO - operating with platform_type : linux_ 17:46:47 INFO - Initialising browser for dromaeo_css test... 17:46:47 INFO - TEST-INFO | started process 27532 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI2FlFQ/profile http://localhost:35144/getInfo.html) 17:46:51 INFO - PROCESS | 27532 | __metrics Screen width/height:1600/1200 17:46:51 INFO - PROCESS | 27532 | colorDepth:24 17:46:51 INFO - PROCESS | 27532 | Browser inner width/height: 1024/697 17:46:51 INFO - PROCESS | 27532 | __metrics 17:46:52 INFO - PROCESS | 27532 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:46:52 INFO - PROCESS | 27532 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:46:53 INFO - PROCESS | 27532 | console.error: PushService: 17:46:53 INFO - PROCESS | 27532 | stateChangeProcessEnqueue: Error transitioning state 17:46:53 INFO - PROCESS | 27532 | UnknownError 17:46:53 INFO - TEST-INFO | 27532: exit 0 17:46:53 INFO - Browser initialized. 17:46:53 INFO - Running cycle 1/1 for dromaeo_css test... 17:46:53 INFO - TEST-INFO | started process 27613 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI2FlFQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:47:05 INFO - PROCESS | 27613 | RSS: Main: 179040256 17:47:05 INFO - PROCESS | 27613 | 17:47:56 INFO - PROCESS | 27613 | 1472172476956 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:50:10 INFO - PROCESS | 27613 | Cycle 1(1): loaded http://localhost:35144/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35144/tests/dromaeo/cssquery-ext.html) 17:50:11 INFO - PROCESS | 27613 | RSS: Main: 269971456 17:50:11 INFO - PROCESS | 27613 | 17:53:14 INFO - PROCESS | 27613 | Cycle 1(1): loaded http://localhost:35144/tests/dromaeo/cssquery-ext.html (next: http://localhost:35144/tests/dromaeo/cssquery-jquery.html) 17:53:14 INFO - PROCESS | 27613 | RSS: Main: 272646144 17:53:14 INFO - PROCESS | 27613 | 17:56:17 INFO - PROCESS | 27613 | Cycle 1(1): loaded http://localhost:35144/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35144/tests/dromaeo/cssquery-mootools.html) 17:56:17 INFO - PROCESS | 27613 | RSS: Main: 249356288 17:56:17 INFO - PROCESS | 27613 | 17:59:20 INFO - PROCESS | 27613 | Cycle 1(1): loaded http://localhost:35144/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35144/tests/dromaeo/cssquery-prototype.html) 17:59:20 INFO - PROCESS | 27613 | RSS: Main: 217272320 17:59:20 INFO - PROCESS | 27613 | 18:02:23 INFO - PROCESS | 27613 | Cycle 1(1): loaded http://localhost:35144/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35144/tests/dromaeo/cssquery-yui.html) 18:02:24 INFO - PROCESS | 27613 | RSS: Main: 217456640 18:02:24 INFO - PROCESS | 27613 | 18:05:27 INFO - PROCESS | 27613 | Cycle 1(1): loaded http://localhost:35144/tests/dromaeo/cssquery-yui.html (next: http://localhost:35144/tests/dromaeo/cssquery-dojo.html) 18:05:27 INFO - PROCESS | 27613 | RSS: Main: 307671040 18:05:27 INFO - PROCESS | 27613 | 18:05:27 INFO - PROCESS | 27613 | __start_tp_report 18:05:27 INFO - PROCESS | 27613 | _x_x_mozilla_page_load 18:05:27 INFO - PROCESS | 27613 | _x_x_mozilla_page_load_details 18:05:27 INFO - PROCESS | 27613 | |i|pagename|runs| 18:05:27 INFO - PROCESS | 27613 | |0;dojo.html;2537.632043353715;2542.504211678722;2544.2240116764387;2566.884490197941;2568.6532318137047;4597.448306203256;4627.329037289591;4657.953420465798;4665.253559430487;4675.345451636774;4683.437987441512;4757.333973243749;4762.833300834472;4763.833265835697;4836.588889944359;4324.481062272532;4331.155424692186;4404.713693609921;4465;4575.725456472605;4463.330500424946;4506.031203291292;4521.660875434339;4546.340780586813;4556.521565235652;4243.045314804175;4279.379489973936;4285.078708077747;4393.53867843875;4403.119376124788;4372.693911426201;4409.801558929824;4499.4150760400935;4508.706934049276;4516.254817955033;4322.330038843984;4400.163968845941;4409.0520538084465;4413.646908247332;4458.8885277867985;4762.28565715142;4797.376341075673;4801.063792560452;4812.398450193726;4873.8781530461665;4929.235968424864;4942.555170034714;5036.722980236085;5044.2937988681615;5054.671446355975;5041.924371134436;5062.721550314731;5076.289319495274;5076.6192535559985;5080.034793389244;4595.931061034087;4715.599174070242;4719.457262414866;4724.692894961817;4772.308015337791;5201.063808514428;5253.894922101536;5258.027264955996;5325.893482130413;5339.46605339463;5045.041442125985;5053.140966035709;5054.418741844662;5055.09008378488;5057.115004874132;5147;5147.6654017488745;5149.330587023663;5152.072626927189;5200.349956255468;4858.659893807399;4997.100521906092;5020.523050310215;5022.949770502321;5103.081445339874;5032.471590482946;5052.595792336604;5052.621053420935;5053.166227572409;5113.258577506315;4231.111466591989;4246.936295955563;4250.851220207278;4254.340577210537;4301.44081269433;3619.873304434332;3650.7809531428197;3680.300742858848;3701.40777475608;3755.887323380303;4418.8453404130705;4449.866504004885;4451.866444006685;4497.865064048018;4499.10017996402;5092.9745351273;5102.846914592568;5106.948930510722;5113.53978141969;5161.483851614884;4278.828846846091;4390.934135987963;4427.468703755506;4432.180046691373;4437;4565.885852853638;4570.702904311209;4604.493505714368;4619.145458090264;4622.791974361162;4850.320955066223;4853.854384368475;4855.101806165871;4858.854234372974;4920.360353154067;5000.349954505891;5112.3865136183895;5112.872178195575;5124.769385377593;5140.228965655182;4866.367372241586;4888.462269150319;4897.338859254098;4949.232868905326;4949.505049495022;5069.112905241494;5074.82238121664;5078.162103253069;5078.339815823919;5139.6145289104215;4924.187509060965;5068.138416469283;5142.537171654569;5165.535101840853;5170.1727723564045;4903.803847846046;5000.77496512665;5001.399832020181;5044.0920634286185;5050.797968081236;4992.02655482192;5002.524760147926;5004.299398084198;5006.62450316235;5067.037262920034;4770.7137571744415;4905.288733133747;4924.581410579997;4944.184209605375;4987.900241995212;5011.799528018984;5080.974595127001;5081.8475445736685;5110.233464980282;5112.693238405707;4963.900721985612;4971.154903666457;4973.701577905337;4974.278729584263;5036.571891389126 18:05:27 INFO - PROCESS | 27613 | |1;ext.html;576.363118753777;581.5318668471879;587.7560812262911;599.5113982104584;606.9590652031765;38458.61541384585;40478;40617.79691101548;44101.33847992275;44162.33756493647;41060.17879642405;41534;41559.37660935081;41640;41751.79124104383;7380.520266182708;7710;7817.921820781805;7840.176781437953;7857;7422.851542969137;7642.235776422369;7642.235776422369;9888.456134912576;10151.137153341975;10145.746356341113;10187.337823041516;10192.541335639915;10203.642872499464;10207.438590877498;10206.540705668225;10217.744556386075;10266.178705703525;10266.691999240034;10270;10031.097201251849;10087.949560252151;10090.192784577217;10091.142252908512;10092.293539452241;37251.62748372536;37576.06059848498;37590.24819503622;37639.8118009411;37657.81171094127;2872.8850845966135;2873.195505258531;3433.9484907726405;3464.168599536093;3476.1309672581856;27014.1895743128;27857.86071069652;29606;29788.255293617618;29817.10548683543;3564.7148228141687;3594.946075808839;3646.8541258349633;3670.082479380155;3723.1995121048835;249881;255631;256287;256919;257028;56366.436335636936;57039.429605703415;57160.71419642875;57185.42814571884;57201;59656.70171649114;60056.699716502015;60094.69952650209;60141.39858601358;60180.699096505115;14145.080569763139;14359.641008974859;14366.13803171813;14375.856241437661;14379.496717615042;10824.404657743742;10938.56245750177;10966.670999870017;10983.890161098447;11001.834972475419;16343.509694709177;18442.63114737698;18671.626567468575;18888.81111188898;19326;7025.613591252428;7181.13826340832;7207.9639601801655;7209.927900721031;7332.706691732271;736.8415790605046;864.8659457784054;918.7427520294328;995.7112437393075;1030.3251370352432;27697.169084927486;27775.30561735973;28439.71560284412;28446.431071378458;28558.571621425694;908.5956749246654;914.0630853375344;923.4736200365727;933.8412469880137;970.6360114956891;14013;14871.735902448198;15038.248087595577;15234.3906243749;15272.38910443592;396113;401616;401694;401965;402013;48185.5181448188;48620;48681.756591216814;48752.26871596929;48757.26864097041;1056.4823236614156;1116.564539829467;1130.6834086455806;1147.3861484105964;1154.261272785418;26937.86531067332;29139.12582622525;29242.853785730935;29768;29782.553261701527;41279.1744165109;41778;41844.79077604593;41895;41902;305996;306818;308378;308645;308660;25352.746472535775;25607.615885761355;25917.481650367263;26759.464810703288;37988.81005594954;40750.184996299315;41006.589934101474;41200;41288.38067429051;41871.53449629249;35100;35466;35546.46680299746;35990.82004590065;36157.63842361648;34514.654853451146;35194.47208291826;35423.29153416866;35742.821285893406;35822.28355432825;34392;35081.82459087688;35084.824575876955;35339.29321413609;35977.46033809547;30707;33001.83499082489;33114;33223.83388083044;33310.333793323516;24448.633270501312;24554.75445245596;25351.492970140123;25566.233013009638;26171.607425889008 18:05:27 INFO - PROCESS | 27613 | |2;jquery.html;349.3920578193943;369.5233149237483;372.67018688460706;372.8303621852058;398.8145512336763;12515.311657858825;13814.861851381484;16302.83697163031;16415.67168656626;16566.917165414157;16343.91828040861;16526.504204873843;16558.83441165588;16844.24200910959;16999.320027198897;4780.80876764929;5051.116054690433;5059.241113832918;5061.44324124346;5062.190049592066;3767.077066118805;5038.7228702421535;5121.820736274212;5754.395788442195;6020.488258498033;6105.664188469633;6105.725242364104;6118.449339559439;6118.938810611904;6120.265568131808;5896.174535565025;5925.614835035709;5927.466528012456;5930.318013428468;6024.879502409971;5141.948580514184;5327;5327.30745003151;5331.733413329357;5331.946680533222;20054.699179512172;20131.19475221004;20178.091985860672;20199.980001999684;20343;1762.9471115866415;1904.838088762457;2005.8696184748092;2430.0887167312258;2479.528889511005;8929.151730585649;9118.133777291147;9119.726408207764;9260.536973151382;9625.51872406377;1713.9828601713948;1732.965340693179;1753.2373417563274;1759.820426487093;1787.294018862555;69866;70114;70193;70195.29804701939;70374.64812675955;9520.23838092951;9579.568919398644;9835.262355323379;9875.60497580103;9961.252906031932;13922.51271205503;13923.094998825043;13940.233287169303;13982.790258146137;13986.930065349812;7060.939740878545;7243.203247642755;7271.363943112758;7464.216257293015;7555;6997.378306464199;7020.227774944752;7103.644817759091;7111.644417779194;7193.712251509985;4254.87235382939;4350.564943505624;4368.322909948963;4482.5069242383315;4513;1765.2788531182252;1821.1804687890237;1851.1669748613178;1861.5904501009757;1914.2484626566536;618.848382146377;707.3209718670031;728.4682182007165;794.527256282511;859.9723330619975;15769.211539422982;16065.839341606668;16429.83570164307;16834.831651683326;16852.07313597764;769.1846642558905;811.0429692962362;825.4675734151439;827.995860020708;904.8552231642906;8927.776805579913;9513.238940884712;9557.61769529211;9573.712788616353;9700.320977531504;370771;393622;405724;409576;412191;74754.87867681989;76455.8531622026;76625.23374766292;77553.61223193847;80098.19901801024;879.463527248378;889.2752406788446;910.3809409601535;910.658503061352;910.899801021887;15036.849631503545;15416.306266217824;16087.276072576527;16373.91813040927;16378.099204543389;37025.6297437033;37459.314330854635;37469.81265093657;38255.42616860805;38298.617013829506;48367.27449088337;48469.75765121152;48692.513074870214;51256.74371628267;51818.48181518137;7166.140063192451;7578.280063393969;7685.116211635734;7707.614619269127;7772.339351154989;11029.525699404983;11495.425228738697;11912.34482103458;11948.76102477963;12275.93862030684;8803.867941981003;9700.6119755209;9831.508424578886;10064.798704026025;10163.034511721671;9026.142516460926;9607.711768646952;9791.412515249107;9919.752006199902;9945.751356216153;10043.296969212377;10304.948475257575;10449.111825494918;10686.625968091079;10891.836622450512;6566.868662626816;6782.898256526255;6861.279565645735;6865.313468653095;7022.40309573692;8175.468594541336;9954.850677239703;10078.697639070839;10310.690679279634;10560.419176945034 18:05:27 INFO - PROCESS | 27613 | |3;mootools.html;1340.282948622487;1404.8665376789204;1427.4004917934467;1614.4268784581466;1661.8088919774223;6913.61975091371;7414.25857414259;7502.249775022495;7958.084820245666;8034.477758945664;7636.885446718304;7923.722669706562;7940.722074727386;7941.761747147595;7942.245486678771;2221.3335999200217;2247;2248.696425982496;2250.729912410513;2252.4594097416584;1863.506170864722;2159.8704077755383;2201.4606421426693;2226.955460890781;2230.7769223077644;2231.4867580456503;2255.740589832174;2257.8306627002958;2257.9209727659536;2258.9322320330416;2163.9026243819067;2172.511184983374;2179.869207847534;2184.4648061224943;2186.0162926683056;2196.967045494319;2210.0938615167706;2212.7012853264764;2221.8111460525874;2228.621134407155;7949.364050875916;7997.720079797179;8011.319037881787;8016;8016.879746803803;4465.285554311295;4584.6561507887045;4608.400907881987;4636.09596128755;4637.559431853969;2756.4073724149403;2898.507253766865;2919.8102123362128;2941.3381989052505;2959.4525012872687;861.586438509519;908.5956749246587;911.9680811171577;920.397139873384;945.5555888732284;10834.891651083468;10875.238733288674;10899.073578745816;10901.29141605801;10925.180611454172;3961.782101984361;4273.444452221192;4344.283193273138;4350.608445239944;4373.081652852873;9309;9312.674056407994;9315.254779617615;9320.533973301308;9338.719838404859;4724.480307166209;4725.125851717443;4727.669063165614;4730.976345118322;4735.100330937111;4120.2583534964;4214.978925105416;4220.050488640031;4221.873343799691;4225.704200705921;3622.728295377857;3691.9261614767556;3761.9059523511582;3763.284975854579;3791.469194312798;1102.1953973599157;1187.8633957095044;1202.4168278384977;1242.1491278474275;1258.2827788160844;779.9103103143098;784.4273680213477;791.3748138970265;811.9715809946623;815.1685281013333;5126.102931986888;5134.358205224347;5167.173252279617;5260.92108618371;5303.867403314948;832.6710949175042;845.2772879188328;849.2017503546647;863.5293764898146;889.6396959231522;3422.982885085559;3475.09647491654;3503.8948831535095;3513.841877115536;3646.5259516262718;9490.762730931643;9942.254330925209;9944.950275248577;9967.750806229902;9971.700848974542;8602.311815054905;9881.160101391462;9893.65372211969;9897.703068907944;9903.554340054714;7064.752733654297;7297;7362.595057271795;7540.509866858746;7549.6225188740345;5242.737863106753;5286.392064912584;5338.75975581092;5340.065488539568;5525.4474552546035;8906.86639700392;8999.595018224327;9052.909470905206;9065.68270110543;9150.176484116462;9095.226905713089;9162.67930622425;9330.393524420891;9370;9380.859287110563;6839.2818754032105;6941.097657304518;6948.5483443576;6953.617551034742;6957.443404527525;7064.15230172362;7509.88735168962;7523.473356864967;7530.058742657168;7535.660895259617;6769.187697476137;6781.186257649114;6818.897716534355;6962.7911162665205;7021.297870212938;6621.768238111643;6686.431653309523;6783.559068660521;6790.864182716219;6906.240313565403;5930.436608522184;5998.310194327533;6065.120557519223;6067.24159480065;6074.119252708244;4375.978120109379;4452.799624016862;4554.157480866051;4601.516840731675;4602.470715867584;4315.78421078951;4472.284434490466;4529.84145554904;4538.228501154877;4551.658625603027 18:05:27 INFO - PROCESS | 27613 | |4;prototype.html;302.63834717512566;305.7431757323848;307.0573339846671;311.8986329442932;312.55773081090274;4804.447488538819;4812.494688057752;4827.686200396972;4852.29641701953;4867.53758392953;4810.470848206694;4817.6145908327335;4828.7585620719;4830.661853670235;4832.347633069535;3868.6711629511524;3875.8062096895183;3883.495145631064;3891.5135608048995;3894.9805250973704;3752.643498867617;3811.390177571589;3840.1743625120594;3885.630865067814;3895.18201177753;3801.8479260829536;3805;3812.866549670762;3824.6366595173413;3827.4450204720297;3785.1861849702173;3786.318462676717;3787.7159213058853;3788.8673896413493;3812.3709587918097;3194.5048517479827;3269.9836500817582;3378.4594464885745;3384.170878134848;3397.915052123692;4654.418197725285;4657.115148121846;4666.23007203811;4682.133805246006;4683.88290292742;4315.417418648473;4326.437563116775;4328.134373125387;4332.371806088099;4337.479502459725;4697.365855609483;4758.833440829554;4953.653244272902;4979.655493016865;4997.90004199914;3614.765040272374;3631.509746184258;3651.379265524867;3655.4882316475714;3665.4318580620047;5153.716545589991;5171.37943446785;5171.741412929338;5198.636095473318;5198.960207958424;3491.1621210909707;3677.9448308275396;3695.3533131701843;3745.382011968049;3754.6245375462236;3731.552213734315;3734.058289689346;3742.9438558421643;3745.569259535134;3746.4942232798767;4244.87265382039;4251.744895306291;4261.190373829025;4263.637590804754;4267.786610669454;4841.830535931225;5042.722650254198;5047.722375269322;5049.863780649324;5050.318207042076;1277.2272774971195;1280.8591054983945;1295.216394081586;1298.8636193199577;1300.5513097981182;775.991211425145;799.2207597592417;815.7144999250215;818.5620692929255;821.9178082191733;4026.1213232538876;4026.1947610477437;4042.6967977401223;4044.66526046404;4047.91904161921;4552.635789136927;4580.602916110618;4585.587297143273;4592.402987611589;4593.885152871205;4044.5753195914003;4046.3121269384274;4047.6559492442884;4054.5134583849535;4056.858009969696;2329.8369114161846;2400.4838959623767;2406.7966016991504;2444.205633169227;2450.424150324672;4676.205045142334;4811.446683631357;4926.802927882916;4964.180910149785;4965.950340496621;5315.255864178941;5324.653897496651;5334;5335.706536140472;5335.839924802262;4724.8971111199135;4930.926036109461;4945.752712364368;4950.356453661001;4956.256561515802;5145.61407894402;5193.818216362409;5206.921896171636;5212.263561630174;5222.814083409042;5101.489851014869;5110.770015349392;5113.667611605234;5113.948860511347;5119.206522988943;4706.9095527246445;4896.1921282987905;4923.778429970732;4933.322670291975;4948.307236986897;3604.6575575320303;3624.456331550183;3628.3468975584647;3641.7997010164695;3644.617315181974;5161.870953226199;5180.585553155664;5181.974090129525;5186.040582492251;5189.273501709839;4785.952140478551;5022.296878436949;5032.471590482946;5056.82301119459;5078.923816142835;4948.826791062295;4993.425756038102;5011.574016208663;5018.146915024382;5018.799248030038;4936.296977542742;4961.355023846877;4981.775820088033;4995.125852975787;4996.725180115129;4798.592119669727;5049.368828896388;5067.315912351785;5068.315777370008;5073.945052253843;4953.975230123826;4980.352554167935;4982.900341993212;4983.875403114951;4986.202207646759 18:05:27 INFO - PROCESS | 27613 | |5;yui.html;587.1134586773971;623.9157713708648;647.4981889035994;674.5229135038103;684.0504561998303;11330.830037549433;11822.527098916054;11834.230774999629;11970.760584788299;12128.151029427943;12983.350832458387;13085.21488710678;13124.934375328134;13134.868651313483;13188.208707477557;624.6470744029609;746.2052913646949;764.4190415284369;766.7584710816103;767.029707420114;625.5996162456032;633.1294470103608;633.904914262862;737.4137560639305;761.3490465651871;791.9683212671487;793.2464159048898;798.6885114805231;799.8880156778056;800.1638287989036;783.4006984656713;785.1481142959896;787.6731156570074;788.184229322654;788.333857890082;479.856043187046;486.4527406667499;488.01908164589076;577.7631171219822;578.8523926398741;9854.605815767361;10546.789064218749;10768.78462430755;10896.673099807018;11250.437478126061;12673.746525069448;13223.33883305831;13226.86773132266;13459.528916487876;13874.583762487142;10059.798804023952;10236.334638248565;10344.844827327595;10369.585216591327;10443.164546836235;3229.951550726741;3265;3291.308825146722;3394.79631222125;3403.1662242750435;62705.68647156781;62834;62870.68564657193;62896.68551657258;63648.999999999534;9665.855012174823;9730.424771616152;9825.241753051547;9967.601295948225;10311.1235544978;18195.81804181968;18200.544986375447;18201.36295229687;18201.908990454962;18213.908930455527;6494.1232933553365;6566.146400967844;6694.665266736643;6731.798046058626;6769.3907548320885;3607.4408466687705;3691.741578089508;3707.480952666629;3722.813859307024;3736.439534069911;2789.693133755285;2893.9131826045254;2902.796804223726;2903.9419211616073;2905.4624894394606;484.7455086079766;493.7457209537091;495.7843338147917;505;509.9133147364957;422.7717032802314;561.3852831149884;562.4825160851944;568.903286441306;570.4267211452463;7535.7362492313605;7758.728444504415;7769.339606133542;7785.416093792988;8057.234562716532;533.5838046323873;543.7520889558473;552.7208759576469;581.3459857660132;583.8540364908773;3764.3976963686227;3807.7334586579227;3834.213986132892;3869.96130038696;3898.941515877264;99961.50019249857;100537.49731251298;104046;104696.47651761693;105503.94496055094;88908.11091889128;90849.54575227082;91328.54335728411;91564;92164;73093.26906730971;75015;75573.62213188899;78640.60679696564;79240.20759792444;7419.517731347445;7429;7465.813354666177;7527.623618818928;7556.093268807778;44665;46794.53205468038;46898.53101468942;47602.28596570985;47823;52951.73524132355;53444.73277633587;55079;61041.694791525755;61192.38807611867;9822.361546499455;10309.164979630661;10629.149668026694;10679.733006674895;10952.123830093415;11191.44042797873;11258.437078146224;11316.26444281119;11724.941375293069;12273.202241854251;10387.68836934893;10505.894941050492;10580.523876425425;10587.788244234918;10632.468376581295;9510.667126650535;9670.984546622503;9776.657816976372;9903.059209375098;9966.202703783825;10294;10625.9468702656;10867.891321087005;10946.562137514411;11302.208845380745;9447.858282125912;9591.280653950842;9642.42145471274;9999.35004224723;10089.545970431202;9085.13691199335;9164.175224229852;9184.403013804082;9360.53197340144;9503.952480237831 18:05:27 INFO - PROCESS | 27613 | __end_tp_report 18:05:27 INFO - PROCESS | 27613 | __start_cc_report 18:05:27 INFO - PROCESS | 27613 | _x_x_mozilla_cycle_collect,970 18:05:27 INFO - PROCESS | 27613 | __end_cc_report 18:05:27 INFO - PROCESS | 27613 | __startTimestamp1472173527620__endTimestamp 18:05:27 INFO - PROCESS | 27613 | 18:05:27 INFO - PROCESS | 27613 | ------- Summary: start ------- 18:05:27 INFO - PROCESS | 27613 | Number of tests: 6 18:05:27 INFO - PROCESS | 27613 | 18:05:27 INFO - PROCESS | 27613 | [#0] dojo.html Cycles:165 Average:4720.09 Median:4888.46 stddev:517.01 (10.6%) stddev-sans-first:489.42 18:05:27 INFO - PROCESS | 27613 | Values: 2537.6 2542.5 2544.2 2566.9 2568.7 4597.4 4627.3 4658.0 4665.3 4675.3 4683.4 4757.3 4762.8 4763.8 4836.6 4324.5 4331.2 4404.7 4465.0 4575.7 4463.3 4506.0 4521.7 4546.3 4556.5 4243.0 4279.4 4285.1 4393.5 4403.1 4372.7 4409.8 4499.4 4508.7 4516.3 4322.3 4400.2 4409.1 4413.6 4458.9 4762.3 4797.4 4801.1 4812.4 4873.9 4929.2 4942.6 5036.7 5044.3 5054.7 5041.9 5062.7 5076.3 5076.6 5080.0 4595.9 4715.6 4719.5 4724.7 4772.3 5201.1 5253.9 5258.0 5325.9 5339.5 5045.0 5053.1 5054.4 5055.1 5057.1 5147.0 5147.7 5149.3 5152.1 5200.3 4858.7 4997.1 5020.5 5022.9 5103.1 5032.5 5052.6 5052.6 5053.2 5113.3 4231.1 4246.9 4250.9 4254.3 4301.4 3619.9 3650.8 3680.3 3701.4 3755.9 4418.8 4449.9 4451.9 4497.9 4499.1 5093.0 5102.8 5106.9 5113.5 5161.5 4278.8 4390.9 4427.5 4432.2 4437.0 4565.9 4570.7 4604.5 4619.1 4622.8 4850.3 4853.9 4855.1 4858.9 4920.4 5000.3 5112.4 5112.9 5124.8 5140.2 4866.4 4888.5 4897.3 4949.2 4949.5 5069.1 5074.8 5078.2 5078.3 5139.6 4924.2 5068.1 5142.5 5165.5 5170.2 4903.8 5000.8 5001.4 5044.1 5050.8 4992.0 5002.5 5004.3 5006.6 5067.0 4770.7 4905.3 4924.6 4944.2 4987.9 5011.8 5081.0 5081.8 5110.2 5112.7 4963.9 4971.2 4973.7 4974.3 5036.6 18:05:27 INFO - PROCESS | 27613 | 18:05:27 INFO - PROCESS | 27613 | [#1] ext.html Cycles:180 Average:48165.47 Median:35147.24 stddev:85955.69 (244.6%) stddev-sans-first:86122.56 18:05:27 INFO - PROCESS | 27613 | Values: 576.4 581.5 587.8 599.5 607.0 38458.6 40478.0 40617.8 44101.3 44162.3 41060.2 41534.0 41559.4 41640.0 41751.8 7380.5 7710.0 7817.9 7840.2 7857.0 7422.9 7642.2 7642.2 9888.5 10151.1 10145.7 10187.3 10192.5 10203.6 10207.4 10206.5 10217.7 10266.2 10266.7 10270.0 10031.1 10087.9 10090.2 10091.1 10092.3 37251.6 37576.1 37590.2 37639.8 37657.8 2872.9 2873.2 3433.9 3464.2 3476.1 27014.2 27857.9 29606.0 29788.3 29817.1 3564.7 3594.9 3646.9 3670.1 3723.2 249881.0 255631.0 256287.0 256919.0 257028.0 56366.4 57039.4 57160.7 57185.4 57201.0 59656.7 60056.7 60094.7 60141.4 60180.7 14145.1 14359.6 14366.1 14375.9 14379.5 10824.4 10938.6 10966.7 10983.9 11001.8 16343.5 18442.6 18671.6 18888.8 19326.0 7025.6 7181.1 7208.0 7209.9 7332.7 736.8 864.9 918.7 995.7 1030.3 27697.2 27775.3 28439.7 28446.4 28558.6 908.6 914.1 923.5 933.8 970.6 14013.0 14871.7 15038.2 15234.4 15272.4 396113.0 401616.0 401694.0 401965.0 402013.0 48185.5 48620.0 48681.8 48752.3 48757.3 1056.5 1116.6 1130.7 1147.4 1154.3 26937.9 29139.1 29242.9 29768.0 29782.6 41279.2 41778.0 41844.8 41895.0 41902.0 305996.0 306818.0 308378.0 308645.0 308660.0 25352.7 25607.6 25917.5 26759.5 37988.8 40750.2 41006.6 41200.0 41288.4 41871.5 35100.0 35466.0 35546.5 35990.8 36157.6 34514.7 35194.5 35423.3 35742.8 35822.3 34392.0 35081.8 35084.8 35339.3 35977.5 30707.0 33001.8 33114.0 33223.8 33310.3 24448.6 24554.8 25351.5 25566.2 26171.6 18:05:27 INFO - PROCESS | 27613 | 18:05:27 INFO - PROCESS | 27613 | [#2] jquery.html Cycles:180 Average:24451.66 Median:28189.28 stddev:65800.20 (233.4%) stddev-sans-first:65959.90 18:05:27 INFO - PROCESS | 27613 | Values: 349.4 369.5 372.7 372.8 398.8 12515.3 13814.9 16302.8 16415.7 16566.9 16343.9 16526.5 16558.8 16844.2 16999.3 4780.8 5051.1 5059.2 5061.4 5062.2 3767.1 5038.7 5121.8 5754.4 6020.5 6105.7 6105.7 6118.4 6118.9 6120.3 5896.2 5925.6 5927.5 5930.3 6024.9 5141.9 5327.0 5327.3 5331.7 5331.9 20054.7 20131.2 20178.1 20200.0 20343.0 1762.9 1904.8 2005.9 2430.1 2479.5 8929.2 9118.1 9119.7 9260.5 9625.5 1714.0 1733.0 1753.2 1759.8 1787.3 69866.0 70114.0 70193.0 70195.3 70374.6 9520.2 9579.6 9835.3 9875.6 9961.3 13922.5 13923.1 13940.2 13982.8 13986.9 7060.9 7243.2 7271.4 7464.2 7555.0 6997.4 7020.2 7103.6 7111.6 7193.7 4254.9 4350.6 4368.3 4482.5 4513.0 1765.3 1821.2 1851.2 1861.6 1914.2 618.8 707.3 728.5 794.5 860.0 15769.2 16065.8 16429.8 16834.8 16852.1 769.2 811.0 825.5 828.0 904.9 8927.8 9513.2 9557.6 9573.7 9700.3 370771.0 393622.0 405724.0 409576.0 412191.0 74754.9 76455.9 76625.2 77553.6 80098.2 879.5 889.3 910.4 910.7 910.9 15036.8 15416.3 16087.3 16373.9 16378.1 37025.6 37459.3 37469.8 38255.4 38298.6 48367.3 48469.8 48692.5 51256.7 51818.5 7166.1 7578.3 7685.1 7707.6 7772.3 11029.5 11495.4 11912.3 11948.8 12275.9 8803.9 9700.6 9831.5 10064.8 10163.0 9026.1 9607.7 9791.4 9919.8 9945.8 10043.3 10304.9 10449.1 10686.6 10891.8 6566.9 6782.9 6861.3 6865.3 7022.4 8175.5 9954.9 10078.7 10310.7 10560.4 18:05:27 INFO - PROCESS | 27613 | 18:05:27 INFO - PROCESS | 27613 | [#3] mootools.html Cycles:180 Average:5182.12 Median:5295.13 stddev:2928.13 (55.3%) stddev-sans-first:2922.11 18:05:27 INFO - PROCESS | 27613 | Values: 1340.3 1404.9 1427.4 1614.4 1661.8 6913.6 7414.3 7502.2 7958.1 8034.5 7636.9 7923.7 7940.7 7941.8 7942.2 2221.3 2247.0 2248.7 2250.7 2252.5 1863.5 2159.9 2201.5 2227.0 2230.8 2231.5 2255.7 2257.8 2257.9 2258.9 2163.9 2172.5 2179.9 2184.5 2186.0 2197.0 2210.1 2212.7 2221.8 2228.6 7949.4 7997.7 8011.3 8016.0 8016.9 4465.3 4584.7 4608.4 4636.1 4637.6 2756.4 2898.5 2919.8 2941.3 2959.5 861.6 908.6 912.0 920.4 945.6 10834.9 10875.2 10899.1 10901.3 10925.2 3961.8 4273.4 4344.3 4350.6 4373.1 9309.0 9312.7 9315.3 9320.5 9338.7 4724.5 4725.1 4727.7 4731.0 4735.1 4120.3 4215.0 4220.1 4221.9 4225.7 3622.7 3691.9 3761.9 3763.3 3791.5 1102.2 1187.9 1202.4 1242.1 1258.3 779.9 784.4 791.4 812.0 815.2 5126.1 5134.4 5167.2 5260.9 5303.9 832.7 845.3 849.2 863.5 889.6 3423.0 3475.1 3503.9 3513.8 3646.5 9490.8 9942.3 9945.0 9967.8 9971.7 8602.3 9881.2 9893.7 9897.7 9903.6 7064.8 7297.0 7362.6 7540.5 7549.6 5242.7 5286.4 5338.8 5340.1 5525.4 8906.9 8999.6 9052.9 9065.7 9150.2 9095.2 9162.7 9330.4 9370.0 9380.9 6839.3 6941.1 6948.5 6953.6 6957.4 7064.2 7509.9 7523.5 7530.1 7535.7 6769.2 6781.2 6818.9 6962.8 7021.3 6621.8 6686.4 6783.6 6790.9 6906.2 5930.4 5998.3 6065.1 6067.2 6074.1 4376.0 4452.8 4554.2 4601.5 4602.5 4315.8 4472.3 4529.8 4538.2 4551.7 18:05:27 INFO - PROCESS | 27613 | 18:05:27 INFO - PROCESS | 27613 | [#4] prototype.html Cycles:180 Average:4144.91 Median:4690.62 stddev:1212.84 (25.9%) stddev-sans-first:1181.46 18:05:27 INFO - PROCESS | 27613 | Values: 302.6 305.7 307.1 311.9 312.6 4804.4 4812.5 4827.7 4852.3 4867.5 4810.5 4817.6 4828.8 4830.7 4832.3 3868.7 3875.8 3883.5 3891.5 3895.0 3752.6 3811.4 3840.2 3885.6 3895.2 3801.8 3805.0 3812.9 3824.6 3827.4 3785.2 3786.3 3787.7 3788.9 3812.4 3194.5 3270.0 3378.5 3384.2 3397.9 4654.4 4657.1 4666.2 4682.1 4683.9 4315.4 4326.4 4328.1 4332.4 4337.5 4697.4 4758.8 4953.7 4979.7 4997.9 3614.8 3631.5 3651.4 3655.5 3665.4 5153.7 5171.4 5171.7 5198.6 5199.0 3491.2 3677.9 3695.4 3745.4 3754.6 3731.6 3734.1 3742.9 3745.6 3746.5 4244.9 4251.7 4261.2 4263.6 4267.8 4841.8 5042.7 5047.7 5049.9 5050.3 1277.2 1280.9 1295.2 1298.9 1300.6 776.0 799.2 815.7 818.6 821.9 4026.1 4026.2 4042.7 4044.7 4047.9 4552.6 4580.6 4585.6 4592.4 4593.9 4044.6 4046.3 4047.7 4054.5 4056.9 2329.8 2400.5 2406.8 2444.2 2450.4 4676.2 4811.4 4926.8 4964.2 4966.0 5315.3 5324.7 5334.0 5335.7 5335.8 4724.9 4930.9 4945.8 4950.4 4956.3 5145.6 5193.8 5206.9 5212.3 5222.8 5101.5 5110.8 5113.7 5113.9 5119.2 4706.9 4896.2 4923.8 4933.3 4948.3 3604.7 3624.5 3628.3 3641.8 3644.6 5161.9 5180.6 5182.0 5186.0 5189.3 4786.0 5022.3 5032.5 5056.8 5078.9 4948.8 4993.4 5011.6 5018.1 5018.8 4936.3 4961.4 4981.8 4995.1 4996.7 4798.6 5049.4 5067.3 5068.3 5073.9 4954.0 4980.4 4982.9 4983.9 4986.2 18:05:27 INFO - PROCESS | 27613 | 18:05:27 INFO - PROCESS | 27613 | [#5] yui.html Cycles:180 Average:17709.21 Median:26994.24 stddev:26374.93 (97.7%) stddev-sans-first:26417.59 18:05:27 INFO - PROCESS | 27613 | Values: 587.1 623.9 647.5 674.5 684.1 11330.8 11822.5 11834.2 11970.8 12128.2 12983.4 13085.2 13124.9 13134.9 13188.2 624.6 746.2 764.4 766.8 767.0 625.6 633.1 633.9 737.4 761.3 792.0 793.2 798.7 799.9 800.2 783.4 785.1 787.7 788.2 788.3 479.9 486.5 488.0 577.8 578.9 9854.6 10546.8 10768.8 10896.7 11250.4 12673.7 13223.3 13226.9 13459.5 13874.6 10059.8 10236.3 10344.8 10369.6 10443.2 3230.0 3265.0 3291.3 3394.8 3403.2 62705.7 62834.0 62870.7 62896.7 63649.0 9665.9 9730.4 9825.2 9967.6 10311.1 18195.8 18200.5 18201.4 18201.9 18213.9 6494.1 6566.1 6694.7 6731.8 6769.4 3607.4 3691.7 3707.5 3722.8 3736.4 2789.7 2893.9 2902.8 2903.9 2905.5 484.7 493.7 495.8 505.0 509.9 422.8 561.4 562.5 568.9 570.4 7535.7 7758.7 7769.3 7785.4 8057.2 533.6 543.8 552.7 581.3 583.9 3764.4 3807.7 3834.2 3870.0 3898.9 99961.5 100537.5 104046.0 104696.5 105503.9 88908.1 90849.5 91328.5 91564.0 92164.0 73093.3 75015.0 75573.6 78640.6 79240.2 7419.5 7429.0 7465.8 7527.6 7556.1 44665.0 46794.5 46898.5 47602.3 47823.0 52951.7 53444.7 55079.0 61041.7 61192.4 9822.4 10309.2 10629.1 10679.7 10952.1 11191.4 11258.4 11316.3 11724.9 12273.2 10387.7 10505.9 10580.5 10587.8 10632.5 9510.7 9671.0 9776.7 9903.1 9966.2 10294.0 10625.9 10867.9 10946.6 11302.2 9447.9 9591.3 9642.4 9999.4 10089.5 9085.1 9164.2 9184.4 9360.5 9504.0 18:05:27 INFO - PROCESS | 27613 | -------- Summary: end -------- 18:05:27 INFO - PROCESS | 27613 | 18:05:28 INFO - TEST-INFO | 27613: exit 0 18:05:28 INFO - TEST-OK | dromaeo_css | took 1121376ms 18:05:28 INFO - TEST-START | kraken 18:05:28 INFO - operating with platform_type : linux_ 18:05:28 INFO - Initialising browser for kraken test... 18:05:28 INFO - TEST-INFO | started process 27917 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgxw5K4/profile http://localhost:35144/getInfo.html) 18:05:33 INFO - PROCESS | 27917 | __metrics Screen width/height:1600/1200 18:05:33 INFO - PROCESS | 27917 | colorDepth:24 18:05:33 INFO - PROCESS | 27917 | Browser inner width/height: 1024/697 18:05:33 INFO - PROCESS | 27917 | __metrics 18:05:33 INFO - PROCESS | 27917 | 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" 18:05:33 INFO - PROCESS | 27917 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:05:34 INFO - PROCESS | 27917 | console.error: PushService: 18:05:34 INFO - PROCESS | 27917 | stateChangeProcessEnqueue: Error transitioning state 18:05:34 INFO - PROCESS | 27917 | UnknownError 18:05:35 INFO - TEST-INFO | 27917: exit 0 18:05:35 INFO - Browser initialized. 18:05:35 INFO - Running cycle 1/1 for kraken test... 18:05:35 INFO - TEST-INFO | started process 27999 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgxw5K4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:05:47 INFO - PROCESS | 27999 | RSS: Main: 179535872 18:05:47 INFO - PROCESS | 27999 | 18:05:49 INFO - PROCESS | 27999 | Cycle 1(1): loaded http://localhost:35144/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35144/tests/kraken/driver.html?testName=audio-beat-detection) 18:05:50 INFO - PROCESS | 27999 | RSS: Main: 233201664 18:05:50 INFO - PROCESS | 27999 | 18:05:53 INFO - PROCESS | 27999 | Cycle 1(1): loaded http://localhost:35144/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35144/tests/kraken/driver.html?testName=audio-dft) 18:05:54 INFO - PROCESS | 27999 | RSS: Main: 223748096 18:05:54 INFO - PROCESS | 27999 | 18:05:57 INFO - PROCESS | 27999 | Cycle 1(1): loaded http://localhost:35144/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35144/tests/kraken/driver.html?testName=audio-fft) 18:05:58 INFO - PROCESS | 27999 | RSS: Main: 301846528 18:05:58 INFO - PROCESS | 27999 | 18:06:00 INFO - PROCESS | 27999 | Cycle 1(1): loaded http://localhost:35144/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35144/tests/kraken/driver.html?testName=audio-oscillator) 18:06:00 INFO - PROCESS | 27999 | RSS: Main: 212070400 18:06:00 INFO - PROCESS | 27999 | 18:06:03 INFO - PROCESS | 27999 | Cycle 1(1): loaded http://localhost:35144/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35144/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:06:03 INFO - PROCESS | 27999 | RSS: Main: 212664320 18:06:03 INFO - PROCESS | 27999 | 18:06:06 INFO - PROCESS | 27999 | Cycle 1(1): loaded http://localhost:35144/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35144/tests/kraken/driver.html?testName=imaging-darkroom) 18:06:07 INFO - PROCESS | 27999 | RSS: Main: 251600896 18:06:07 INFO - PROCESS | 27999 | 18:06:10 INFO - PROCESS | 27999 | Cycle 1(1): loaded http://localhost:35144/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35144/tests/kraken/driver.html?testName=imaging-desaturate) 18:06:11 INFO - PROCESS | 27999 | RSS: Main: 251281408 18:06:11 INFO - PROCESS | 27999 | 18:06:14 INFO - PROCESS | 27999 | Cycle 1(1): loaded http://localhost:35144/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35144/tests/kraken/driver.html?testName=json-parse-financial) 18:06:15 INFO - PROCESS | 27999 | RSS: Main: 251260928 18:06:15 INFO - PROCESS | 27999 | 18:06:16 INFO - PROCESS | 27999 | Cycle 1(1): loaded http://localhost:35144/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35144/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:06:17 INFO - PROCESS | 27999 | RSS: Main: 214085632 18:06:17 INFO - PROCESS | 27999 | 18:06:19 INFO - PROCESS | 27999 | Cycle 1(1): loaded http://localhost:35144/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35144/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:06:20 INFO - PROCESS | 27999 | RSS: Main: 221564928 18:06:20 INFO - PROCESS | 27999 | 18:06:22 INFO - PROCESS | 27999 | Cycle 1(1): loaded http://localhost:35144/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35144/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:06:22 INFO - PROCESS | 27999 | RSS: Main: 222580736 18:06:22 INFO - PROCESS | 27999 | 18:06:25 INFO - PROCESS | 27999 | Cycle 1(1): loaded http://localhost:35144/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35144/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:06:26 INFO - PROCESS | 27999 | RSS: Main: 222613504 18:06:26 INFO - PROCESS | 27999 | 18:06:29 INFO - PROCESS | 27999 | Cycle 1(1): loaded http://localhost:35144/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35144/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:06:29 INFO - PROCESS | 27999 | RSS: Main: 220844032 18:06:29 INFO - PROCESS | 27999 | 18:06:31 INFO - PROCESS | 27999 | Cycle 1(1): loaded http://localhost:35144/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35144/tests/kraken/driver.html?testName=ai-astar) 18:06:32 INFO - PROCESS | 27999 | RSS: Main: 271667200 18:06:32 INFO - PROCESS | 27999 | 18:06:32 INFO - PROCESS | 27999 | __start_tp_report 18:06:32 INFO - PROCESS | 27999 | _x_x_mozilla_page_load 18:06:32 INFO - PROCESS | 27999 | _x_x_mozilla_page_load_details 18:06:32 INFO - PROCESS | 27999 | |i|pagename|runs| 18:06:32 INFO - PROCESS | 27999 | |0;ai-astar;115;114;128;115;113;113;113;113;113;113 18:06:32 INFO - PROCESS | 27999 | |1;audio-beat-detection;156;122;147;190;122;159;152;124;185;121 18:06:32 INFO - PROCESS | 27999 | |2;audio-dft;161;162;163;163;163;162;163;162;163;162 18:06:32 INFO - PROCESS | 27999 | |3;audio-fft;74;77;75;167;76;77;77;78;161;78 18:06:32 INFO - PROCESS | 27999 | |4;audio-oscillator;86;87;146;86;87;87;132;87;87;140 18:06:32 INFO - PROCESS | 27999 | |5;imaging-gaussian-blur;118;117;117;117;118;118;118;117;118;117 18:06:32 INFO - PROCESS | 27999 | |6;imaging-darkroom;146;147;146;146;146;146;146;146;146;146 18:06:32 INFO - PROCESS | 27999 | |7;imaging-desaturate;95;95;94;95;95;95;95;95;95;94 18:06:32 INFO - PROCESS | 27999 | |8;json-parse-financial;65;66;66;66;66;67;67;65;66;66 18:06:32 INFO - PROCESS | 27999 | |9;json-stringify-tinderbox;65;67;66;66;66;65;66;65;66;69 18:06:32 INFO - PROCESS | 27999 | |10;stanford-crypto-aes;81;91;82;81;86;82;81;83;83;83 18:06:32 INFO - PROCESS | 27999 | |11;stanford-crypto-ccm;136;132;139;132;143;146;133;133;178;135 18:06:32 INFO - PROCESS | 27999 | |12;stanford-crypto-pbkdf2;173;174;171;171;177;171;176;176;175;172 18:06:32 INFO - PROCESS | 27999 | |13;stanford-crypto-sha256-iterative;71;74;69;68;72;68;68;68;70;68 18:06:32 INFO - PROCESS | 27999 | __end_tp_report 18:06:32 INFO - PROCESS | 27999 | __start_cc_report 18:06:32 INFO - PROCESS | 27999 | _x_x_mozilla_cycle_collect,2060 18:06:32 INFO - PROCESS | 27999 | __end_cc_report 18:06:32 INFO - PROCESS | 27999 | __startTimestamp1472173592024__endTimestamp 18:06:32 INFO - PROCESS | 27999 | 18:06:32 INFO - PROCESS | 27999 | ------- Summary: start ------- 18:06:32 INFO - PROCESS | 27999 | Number of tests: 14 18:06:32 INFO - PROCESS | 27999 | 18:06:32 INFO - PROCESS | 27999 | [#0] ai-astar Cycles:10 Average:115.00 Median:113.50 stddev:4.64 (4.1%) stddev-sans-first:4.92 18:06:32 INFO - PROCESS | 27999 | Values: 115.0 114.0 128.0 115.0 113.0 113.0 113.0 113.0 113.0 113.0 18:06:32 INFO - PROCESS | 27999 | 18:06:32 INFO - PROCESS | 27999 | [#1] audio-beat-detection Cycles:10 Average:147.80 Median:154.00 stddev:25.80 (16.8%) stddev-sans-first:27.20 18:06:32 INFO - PROCESS | 27999 | Values: 156.0 122.0 147.0 190.0 122.0 159.0 152.0 124.0 185.0 121.0 18:06:32 INFO - PROCESS | 27999 | 18:06:32 INFO - PROCESS | 27999 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:0.70 (0.4%) stddev-sans-first:0.53 18:06:32 INFO - PROCESS | 27999 | Values: 161.0 162.0 163.0 163.0 163.0 162.0 163.0 162.0 163.0 162.0 18:06:32 INFO - PROCESS | 27999 | 18:06:32 INFO - PROCESS | 27999 | [#3] audio-fft Cycles:10 Average:94.00 Median:77.00 stddev:36.94 (48.0%) stddev-sans-first:38.47 18:06:32 INFO - PROCESS | 27999 | Values: 74.0 77.0 75.0 167.0 76.0 77.0 77.0 78.0 161.0 78.0 18:06:32 INFO - PROCESS | 27999 | 18:06:32 INFO - PROCESS | 27999 | [#4] audio-oscillator Cycles:10 Average:102.50 Median:87.00 stddev:25.64 (29.5%) stddev-sans-first:26.49 18:06:32 INFO - PROCESS | 27999 | Values: 86.0 87.0 146.0 86.0 87.0 87.0 132.0 87.0 87.0 140.0 18:06:32 INFO - PROCESS | 27999 | 18:06:32 INFO - PROCESS | 27999 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 18:06:32 INFO - PROCESS | 27999 | Values: 118.0 117.0 117.0 117.0 118.0 118.0 118.0 117.0 118.0 117.0 18:06:32 INFO - PROCESS | 27999 | 18:06:32 INFO - PROCESS | 27999 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 18:06:32 INFO - PROCESS | 27999 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 18:06:32 INFO - PROCESS | 27999 | 18:06:32 INFO - PROCESS | 27999 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 18:06:32 INFO - PROCESS | 27999 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 18:06:32 INFO - PROCESS | 27999 | 18:06:32 INFO - PROCESS | 27999 | [#8] json-parse-financial Cycles:10 Average:66.00 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 18:06:32 INFO - PROCESS | 27999 | Values: 65.0 66.0 66.0 66.0 66.0 67.0 67.0 65.0 66.0 66.0 18:06:32 INFO - PROCESS | 27999 | 18:06:32 INFO - PROCESS | 27999 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:1.20 (1.8%) stddev-sans-first:1.20 18:06:32 INFO - PROCESS | 27999 | Values: 65.0 67.0 66.0 66.0 66.0 65.0 66.0 65.0 66.0 69.0 18:06:32 INFO - PROCESS | 27999 | 18:06:32 INFO - PROCESS | 27999 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.00 stddev:3.09 (3.7%) stddev-sans-first:3.17 18:06:32 INFO - PROCESS | 27999 | Values: 81.0 91.0 82.0 81.0 86.0 82.0 81.0 83.0 83.0 83.0 18:06:32 INFO - PROCESS | 27999 | 18:06:32 INFO - PROCESS | 27999 | [#11] stanford-crypto-ccm Cycles:10 Average:140.70 Median:137.50 stddev:13.95 (10.1%) stddev-sans-first:14.70 18:06:32 INFO - PROCESS | 27999 | Values: 136.0 132.0 139.0 132.0 143.0 146.0 133.0 133.0 178.0 135.0 18:06:32 INFO - PROCESS | 27999 | 18:06:32 INFO - PROCESS | 27999 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.60 Median:174.50 stddev:2.32 (1.3%) stddev-sans-first:2.45 18:06:32 INFO - PROCESS | 27999 | Values: 173.0 174.0 171.0 171.0 177.0 171.0 176.0 176.0 175.0 172.0 18:06:32 INFO - PROCESS | 27999 | 18:06:32 INFO - PROCESS | 27999 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:69.50 stddev:2.12 (3.0%) stddev-sans-first:2.19 18:06:32 INFO - PROCESS | 27999 | Values: 71.0 74.0 69.0 68.0 72.0 68.0 68.0 68.0 70.0 68.0 18:06:32 INFO - PROCESS | 27999 | -------- Summary: end -------- 18:06:32 INFO - PROCESS | 27999 | 18:06:33 INFO - TEST-INFO | 27999: exit 0 18:06:33 INFO - TEST-OK | kraken | took 64847ms 18:06:33 INFO - SUITE-END | took 1186s 18:06:33 INFO - Completed test suite (00:19:46) 18:06:33 INFO - javascript benchmark 18:06:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2537.632043353715, 2542.504211678722, 2544.2240116764387, 2566.884490197941, 2568.6532318137047, 4597.448306203256, 4627.329037289591, 4657.953420465798, 4665.253559430487, 4675.345451636774, 4683.437987441512, 4757.333973243749, 4762.833300834472, 4763.833265835697, 4836.588889944359, 4324.481062272532, 4331.155424692186, 4404.713693609921, 4465.0, 4575.725456472605, 4463.330500424946, 4506.031203291292, 4521.660875434339, 4546.340780586813, 4556.521565235652, 4243.045314804175, 4279.379489973936, 4285.078708077747, 4393.53867843875, 4403.119376124788, 4372.693911426201, 4409.801558929824, 4499.4150760400935, 4508.706934049276, 4516.254817955033, 4322.330038843984, 4400.163968845941, 4409.0520538084465, 4413.646908247332, 4458.8885277867985, 4762.28565715142, 4797.376341075673, 4801.063792560452, 4812.398450193726, 4873.8781530461665, 4929.235968424864, 4942.555170034714, 5036.722980236085, 5044.2937988681615, 5054.671446355975, 5041.924371134436, 5062.721550314731, 5076.289319495274, 5076.6192535559985, 5080.034793389244, 4595.931061034087, 4715.599174070242, 4719.457262414866, 4724.692894961817, 4772.308015337791, 5201.063808514428, 5253.894922101536, 5258.027264955996, 5325.893482130413, 5339.46605339463, 5045.041442125985, 5053.140966035709, 5054.418741844662, 5055.09008378488, 5057.115004874132, 5147.0, 5147.6654017488745, 5149.330587023663, 5152.072626927189, 5200.349956255468, 4858.659893807399, 4997.100521906092, 5020.523050310215, 5022.949770502321, 5103.081445339874, 5032.471590482946, 5052.595792336604, 5052.621053420935, 5053.166227572409, 5113.258577506315, 4231.111466591989, 4246.936295955563, 4250.851220207278, 4254.340577210537, 4301.44081269433, 3619.873304434332, 3650.7809531428197, 3680.300742858848, 3701.40777475608, 3755.887323380303, 4418.8453404130705, 4449.866504004885, 4451.866444006685, 4497.865064048018, 4499.10017996402, 5092.9745351273, 5102.846914592568, 5106.948930510722, 5113.53978141969, 5161.483851614884, 4278.828846846091, 4390.934135987963, 4427.468703755506, 4432.180046691373, 4437.0, 4565.885852853638, 4570.702904311209, 4604.493505714368, 4619.145458090264, 4622.791974361162, 4850.320955066223, 4853.854384368475, 4855.101806165871, 4858.854234372974, 4920.360353154067, 5000.349954505891, 5112.3865136183895, 5112.872178195575, 5124.769385377593, 5140.228965655182, 4866.367372241586, 4888.462269150319, 4897.338859254098, 4949.232868905326, 4949.505049495022, 5069.112905241494, 5074.82238121664, 5078.162103253069, 5078.339815823919, 5139.6145289104215, 4924.187509060965, 5068.138416469283, 5142.537171654569, 5165.535101840853, 5170.1727723564045, 4903.803847846046, 5000.77496512665, 5001.399832020181, 5044.0920634286185, 5050.797968081236, 4992.02655482192, 5002.524760147926, 5004.299398084198, 5006.62450316235, 5067.037262920034, 4770.7137571744415, 4905.288733133747, 4924.581410579997, 4944.184209605375, 4987.900241995212, 5011.799528018984, 5080.974595127001, 5081.8475445736685, 5110.233464980282, 5112.693238405707, 4963.900721985612, 4971.154903666457, 4973.701577905337, 4974.278729584263, 5036.571891389126], "value": 4684.7282717963, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.363118753777, 581.5318668471879, 587.7560812262911, 599.5113982104584, 606.9590652031765, 38458.61541384585, 40478.0, 40617.79691101548, 44101.33847992275, 44162.33756493647, 41060.17879642405, 41534.0, 41559.37660935081, 41640.0, 41751.79124104383, 7380.520266182708, 7710.0, 7817.921820781805, 7840.176781437953, 7857.0, 7422.851542969137, 7642.235776422369, 7642.235776422369, 9888.456134912576, 10151.137153341975, 10145.746356341113, 10187.337823041516, 10192.541335639915, 10203.642872499464, 10207.438590877498, 10206.540705668225, 10217.744556386075, 10266.178705703525, 10266.691999240034, 10270.0, 10031.097201251849, 10087.949560252151, 10090.192784577217, 10091.142252908512, 10092.293539452241, 37251.62748372536, 37576.06059848498, 37590.24819503622, 37639.8118009411, 37657.81171094127, 2872.8850845966135, 2873.195505258531, 3433.9484907726405, 3464.168599536093, 3476.1309672581856, 27014.1895743128, 27857.86071069652, 29606.0, 29788.255293617618, 29817.10548683543, 3564.7148228141687, 3594.946075808839, 3646.8541258349633, 3670.082479380155, 3723.1995121048835, 249881.0, 255631.0, 256287.0, 256919.0, 257028.0, 56366.436335636936, 57039.429605703415, 57160.71419642875, 57185.42814571884, 57201.0, 59656.70171649114, 60056.699716502015, 60094.69952650209, 60141.39858601358, 60180.699096505115, 14145.080569763139, 14359.641008974859, 14366.13803171813, 14375.856241437661, 14379.496717615042, 10824.404657743742, 10938.56245750177, 10966.670999870017, 10983.890161098447, 11001.834972475419, 16343.509694709177, 18442.63114737698, 18671.626567468575, 18888.81111188898, 19326.0, 7025.613591252428, 7181.13826340832, 7207.9639601801655, 7209.927900721031, 7332.706691732271, 736.8415790605046, 864.8659457784054, 918.7427520294328, 995.7112437393075, 1030.3251370352432, 27697.169084927486, 27775.30561735973, 28439.71560284412, 28446.431071378458, 28558.571621425694, 908.5956749246654, 914.0630853375344, 923.4736200365727, 933.8412469880137, 970.6360114956891, 14013.0, 14871.735902448198, 15038.248087595577, 15234.3906243749, 15272.38910443592, 396113.0, 401616.0, 401694.0, 401965.0, 402013.0, 48185.5181448188, 48620.0, 48681.756591216814, 48752.26871596929, 48757.26864097041, 1056.4823236614156, 1116.564539829467, 1130.6834086455806, 1147.3861484105964, 1154.261272785418, 26937.86531067332, 29139.12582622525, 29242.853785730935, 29768.0, 29782.553261701527, 41279.1744165109, 41778.0, 41844.79077604593, 41895.0, 41902.0, 305996.0, 306818.0, 308378.0, 308645.0, 308660.0, 25352.746472535775, 25607.615885761355, 25917.481650367263, 26759.464810703288, 37988.81005594954, 40750.184996299315, 41006.589934101474, 41200.0, 41288.38067429051, 41871.53449629249, 35100.0, 35466.0, 35546.46680299746, 35990.82004590065, 36157.63842361648, 34514.654853451146, 35194.47208291826, 35423.29153416866, 35742.821285893406, 35822.28355432825, 34392.0, 35081.82459087688, 35084.824575876955, 35339.29321413609, 35977.46033809547, 30707.0, 33001.83499082489, 33114.0, 33223.83388083044, 33310.333793323516, 24448.633270501312, 24554.75445245596, 25351.492970140123, 25566.233013009638, 26171.607425889008], "value": 18128.70319448143, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.3920578193943, 369.5233149237483, 372.67018688460706, 372.8303621852058, 398.8145512336763, 12515.311657858825, 13814.861851381484, 16302.83697163031, 16415.67168656626, 16566.917165414157, 16343.91828040861, 16526.504204873843, 16558.83441165588, 16844.24200910959, 16999.320027198897, 4780.80876764929, 5051.116054690433, 5059.241113832918, 5061.44324124346, 5062.190049592066, 3767.077066118805, 5038.7228702421535, 5121.820736274212, 5754.395788442195, 6020.488258498033, 6105.664188469633, 6105.725242364104, 6118.449339559439, 6118.938810611904, 6120.265568131808, 5896.174535565025, 5925.614835035709, 5927.466528012456, 5930.318013428468, 6024.879502409971, 5141.948580514184, 5327.0, 5327.30745003151, 5331.733413329357, 5331.946680533222, 20054.699179512172, 20131.19475221004, 20178.091985860672, 20199.980001999684, 20343.0, 1762.9471115866415, 1904.838088762457, 2005.8696184748092, 2430.0887167312258, 2479.528889511005, 8929.151730585649, 9118.133777291147, 9119.726408207764, 9260.536973151382, 9625.51872406377, 1713.9828601713948, 1732.965340693179, 1753.2373417563274, 1759.820426487093, 1787.294018862555, 69866.0, 70114.0, 70193.0, 70195.29804701939, 70374.64812675955, 9520.23838092951, 9579.568919398644, 9835.262355323379, 9875.60497580103, 9961.252906031932, 13922.51271205503, 13923.094998825043, 13940.233287169303, 13982.790258146137, 13986.930065349812, 7060.939740878545, 7243.203247642755, 7271.363943112758, 7464.216257293015, 7555.0, 6997.378306464199, 7020.227774944752, 7103.644817759091, 7111.644417779194, 7193.712251509985, 4254.87235382939, 4350.564943505624, 4368.322909948963, 4482.5069242383315, 4513.0, 1765.2788531182252, 1821.1804687890237, 1851.1669748613178, 1861.5904501009757, 1914.2484626566536, 618.848382146377, 707.3209718670031, 728.4682182007165, 794.527256282511, 859.9723330619975, 15769.211539422982, 16065.839341606668, 16429.83570164307, 16834.831651683326, 16852.07313597764, 769.1846642558905, 811.0429692962362, 825.4675734151439, 827.995860020708, 904.8552231642906, 8927.776805579913, 9513.238940884712, 9557.61769529211, 9573.712788616353, 9700.320977531504, 370771.0, 393622.0, 405724.0, 409576.0, 412191.0, 74754.87867681989, 76455.8531622026, 76625.23374766292, 77553.61223193847, 80098.19901801024, 879.463527248378, 889.2752406788446, 910.3809409601535, 910.658503061352, 910.899801021887, 15036.849631503545, 15416.306266217824, 16087.276072576527, 16373.91813040927, 16378.099204543389, 37025.6297437033, 37459.314330854635, 37469.81265093657, 38255.42616860805, 38298.617013829506, 48367.27449088337, 48469.75765121152, 48692.513074870214, 51256.74371628267, 51818.48181518137, 7166.140063192451, 7578.280063393969, 7685.116211635734, 7707.614619269127, 7772.339351154989, 11029.525699404983, 11495.425228738697, 11912.34482103458, 11948.76102477963, 12275.93862030684, 8803.867941981003, 9700.6119755209, 9831.508424578886, 10064.798704026025, 10163.034511721671, 9026.142516460926, 9607.711768646952, 9791.412515249107, 9919.752006199902, 9945.751356216153, 10043.296969212377, 10304.948475257575, 10449.111825494918, 10686.625968091079, 10891.836622450512, 6566.868662626816, 6782.898256526255, 6861.279565645735, 6865.313468653095, 7022.40309573692, 8175.468594541336, 9954.850677239703, 10078.697639070839, 10310.690679279634, 10560.419176945034], "value": 8133.765951137038, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1340.282948622487, 1404.8665376789204, 1427.4004917934467, 1614.4268784581466, 1661.8088919774223, 6913.61975091371, 7414.25857414259, 7502.249775022495, 7958.084820245666, 8034.477758945664, 7636.885446718304, 7923.722669706562, 7940.722074727386, 7941.761747147595, 7942.245486678771, 2221.3335999200217, 2247.0, 2248.696425982496, 2250.729912410513, 2252.4594097416584, 1863.506170864722, 2159.8704077755383, 2201.4606421426693, 2226.955460890781, 2230.7769223077644, 2231.4867580456503, 2255.740589832174, 2257.8306627002958, 2257.9209727659536, 2258.9322320330416, 2163.9026243819067, 2172.511184983374, 2179.869207847534, 2184.4648061224943, 2186.0162926683056, 2196.967045494319, 2210.0938615167706, 2212.7012853264764, 2221.8111460525874, 2228.621134407155, 7949.364050875916, 7997.720079797179, 8011.319037881787, 8016.0, 8016.879746803803, 4465.285554311295, 4584.6561507887045, 4608.400907881987, 4636.09596128755, 4637.559431853969, 2756.4073724149403, 2898.507253766865, 2919.8102123362128, 2941.3381989052505, 2959.4525012872687, 861.586438509519, 908.5956749246587, 911.9680811171577, 920.397139873384, 945.5555888732284, 10834.891651083468, 10875.238733288674, 10899.073578745816, 10901.29141605801, 10925.180611454172, 3961.782101984361, 4273.444452221192, 4344.283193273138, 4350.608445239944, 4373.081652852873, 9309.0, 9312.674056407994, 9315.254779617615, 9320.533973301308, 9338.719838404859, 4724.480307166209, 4725.125851717443, 4727.669063165614, 4730.976345118322, 4735.100330937111, 4120.2583534964, 4214.978925105416, 4220.050488640031, 4221.873343799691, 4225.704200705921, 3622.728295377857, 3691.9261614767556, 3761.9059523511582, 3763.284975854579, 3791.469194312798, 1102.1953973599157, 1187.8633957095044, 1202.4168278384977, 1242.1491278474275, 1258.2827788160844, 779.9103103143098, 784.4273680213477, 791.3748138970265, 811.9715809946623, 815.1685281013333, 5126.102931986888, 5134.358205224347, 5167.173252279617, 5260.92108618371, 5303.867403314948, 832.6710949175042, 845.2772879188328, 849.2017503546647, 863.5293764898146, 889.6396959231522, 3422.982885085559, 3475.09647491654, 3503.8948831535095, 3513.841877115536, 3646.5259516262718, 9490.762730931643, 9942.254330925209, 9944.950275248577, 9967.750806229902, 9971.700848974542, 8602.311815054905, 9881.160101391462, 9893.65372211969, 9897.703068907944, 9903.554340054714, 7064.752733654297, 7297.0, 7362.595057271795, 7540.509866858746, 7549.6225188740345, 5242.737863106753, 5286.392064912584, 5338.75975581092, 5340.065488539568, 5525.4474552546035, 8906.86639700392, 8999.595018224327, 9052.909470905206, 9065.68270110543, 9150.176484116462, 9095.226905713089, 9162.67930622425, 9330.393524420891, 9370.0, 9380.859287110563, 6839.2818754032105, 6941.097657304518, 6948.5483443576, 6953.617551034742, 6957.443404527525, 7064.15230172362, 7509.88735168962, 7523.473356864967, 7530.058742657168, 7535.660895259617, 6769.187697476137, 6781.186257649114, 6818.897716534355, 6962.7911162665205, 7021.297870212938, 6621.768238111643, 6686.431653309523, 6783.559068660521, 6790.864182716219, 6906.240313565403, 5930.436608522184, 5998.310194327533, 6065.120557519223, 6067.24159480065, 6074.119252708244, 4375.978120109379, 4452.799624016862, 4554.157480866051, 4601.516840731675, 4602.470715867584, 4315.78421078951, 4472.284434490466, 4529.84145554904, 4538.228501154877, 4551.658625603027], "value": 4160.974062322986, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.63834717512566, 305.7431757323848, 307.0573339846671, 311.8986329442932, 312.55773081090274, 4804.447488538819, 4812.494688057752, 4827.686200396972, 4852.29641701953, 4867.53758392953, 4810.470848206694, 4817.6145908327335, 4828.7585620719, 4830.661853670235, 4832.347633069535, 3868.6711629511524, 3875.8062096895183, 3883.495145631064, 3891.5135608048995, 3894.9805250973704, 3752.643498867617, 3811.390177571589, 3840.1743625120594, 3885.630865067814, 3895.18201177753, 3801.8479260829536, 3805.0, 3812.866549670762, 3824.6366595173413, 3827.4450204720297, 3785.1861849702173, 3786.318462676717, 3787.7159213058853, 3788.8673896413493, 3812.3709587918097, 3194.5048517479827, 3269.9836500817582, 3378.4594464885745, 3384.170878134848, 3397.915052123692, 4654.418197725285, 4657.115148121846, 4666.23007203811, 4682.133805246006, 4683.88290292742, 4315.417418648473, 4326.437563116775, 4328.134373125387, 4332.371806088099, 4337.479502459725, 4697.365855609483, 4758.833440829554, 4953.653244272902, 4979.655493016865, 4997.90004199914, 3614.765040272374, 3631.509746184258, 3651.379265524867, 3655.4882316475714, 3665.4318580620047, 5153.716545589991, 5171.37943446785, 5171.741412929338, 5198.636095473318, 5198.960207958424, 3491.1621210909707, 3677.9448308275396, 3695.3533131701843, 3745.382011968049, 3754.6245375462236, 3731.552213734315, 3734.058289689346, 3742.9438558421643, 3745.569259535134, 3746.4942232798767, 4244.87265382039, 4251.744895306291, 4261.190373829025, 4263.637590804754, 4267.786610669454, 4841.830535931225, 5042.722650254198, 5047.722375269322, 5049.863780649324, 5050.318207042076, 1277.2272774971195, 1280.8591054983945, 1295.216394081586, 1298.8636193199577, 1300.5513097981182, 775.991211425145, 799.2207597592417, 815.7144999250215, 818.5620692929255, 821.9178082191733, 4026.1213232538876, 4026.1947610477437, 4042.6967977401223, 4044.66526046404, 4047.91904161921, 4552.635789136927, 4580.602916110618, 4585.587297143273, 4592.402987611589, 4593.885152871205, 4044.5753195914003, 4046.3121269384274, 4047.6559492442884, 4054.5134583849535, 4056.858009969696, 2329.8369114161846, 2400.4838959623767, 2406.7966016991504, 2444.205633169227, 2450.424150324672, 4676.205045142334, 4811.446683631357, 4926.802927882916, 4964.180910149785, 4965.950340496621, 5315.255864178941, 5324.653897496651, 5334.0, 5335.706536140472, 5335.839924802262, 4724.8971111199135, 4930.926036109461, 4945.752712364368, 4950.356453661001, 4956.256561515802, 5145.61407894402, 5193.818216362409, 5206.921896171636, 5212.263561630174, 5222.814083409042, 5101.489851014869, 5110.770015349392, 5113.667611605234, 5113.948860511347, 5119.206522988943, 4706.9095527246445, 4896.1921282987905, 4923.778429970732, 4933.322670291975, 4948.307236986897, 3604.6575575320303, 3624.456331550183, 3628.3468975584647, 3641.7997010164695, 3644.617315181974, 5161.870953226199, 5180.585553155664, 5181.974090129525, 5186.040582492251, 5189.273501709839, 4785.952140478551, 5022.296878436949, 5032.471590482946, 5056.82301119459, 5078.923816142835, 4948.826791062295, 4993.425756038102, 5011.574016208663, 5018.146915024382, 5018.799248030038, 4936.296977542742, 4961.355023846877, 4981.775820088033, 4995.125852975787, 4996.725180115129, 4798.592119669727, 5049.368828896388, 5067.315912351785, 5068.315777370008, 5073.945052253843, 4953.975230123826, 4980.352554167935, 4982.900341993212, 4983.875403114951, 4986.202207646759], "value": 3759.448778139876, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.1134586773971, 623.9157713708648, 647.4981889035994, 674.5229135038103, 684.0504561998303, 11330.830037549433, 11822.527098916054, 11834.230774999629, 11970.760584788299, 12128.151029427943, 12983.350832458387, 13085.21488710678, 13124.934375328134, 13134.868651313483, 13188.208707477557, 624.6470744029609, 746.2052913646949, 764.4190415284369, 766.7584710816103, 767.029707420114, 625.5996162456032, 633.1294470103608, 633.904914262862, 737.4137560639305, 761.3490465651871, 791.9683212671487, 793.2464159048898, 798.6885114805231, 799.8880156778056, 800.1638287989036, 783.4006984656713, 785.1481142959896, 787.6731156570074, 788.184229322654, 788.333857890082, 479.856043187046, 486.4527406667499, 488.01908164589076, 577.7631171219822, 578.8523926398741, 9854.605815767361, 10546.789064218749, 10768.78462430755, 10896.673099807018, 11250.437478126061, 12673.746525069448, 13223.33883305831, 13226.86773132266, 13459.528916487876, 13874.583762487142, 10059.798804023952, 10236.334638248565, 10344.844827327595, 10369.585216591327, 10443.164546836235, 3229.951550726741, 3265.0, 3291.308825146722, 3394.79631222125, 3403.1662242750435, 62705.68647156781, 62834.0, 62870.68564657193, 62896.68551657258, 63648.999999999534, 9665.855012174823, 9730.424771616152, 9825.241753051547, 9967.601295948225, 10311.1235544978, 18195.81804181968, 18200.544986375447, 18201.36295229687, 18201.908990454962, 18213.908930455527, 6494.1232933553365, 6566.146400967844, 6694.665266736643, 6731.798046058626, 6769.3907548320885, 3607.4408466687705, 3691.741578089508, 3707.480952666629, 3722.813859307024, 3736.439534069911, 2789.693133755285, 2893.9131826045254, 2902.796804223726, 2903.9419211616073, 2905.4624894394606, 484.7455086079766, 493.7457209537091, 495.7843338147917, 505.0, 509.9133147364957, 422.7717032802314, 561.3852831149884, 562.4825160851944, 568.903286441306, 570.4267211452463, 7535.7362492313605, 7758.728444504415, 7769.339606133542, 7785.416093792988, 8057.234562716532, 533.5838046323873, 543.7520889558473, 552.7208759576469, 581.3459857660132, 583.8540364908773, 3764.3976963686227, 3807.7334586579227, 3834.213986132892, 3869.96130038696, 3898.941515877264, 99961.50019249857, 100537.49731251298, 104046.0, 104696.47651761693, 105503.94496055094, 88908.11091889128, 90849.54575227082, 91328.54335728411, 91564.0, 92164.0, 73093.26906730971, 75015.0, 75573.62213188899, 78640.60679696564, 79240.20759792444, 7419.517731347445, 7429.0, 7465.813354666177, 7527.623618818928, 7556.093268807778, 44665.0, 46794.53205468038, 46898.53101468942, 47602.28596570985, 47823.0, 52951.73524132355, 53444.73277633587, 55079.0, 61041.694791525755, 61192.38807611867, 9822.361546499455, 10309.164979630661, 10629.149668026694, 10679.733006674895, 10952.123830093415, 11191.44042797873, 11258.437078146224, 11316.26444281119, 11724.941375293069, 12273.202241854251, 10387.68836934893, 10505.894941050492, 10580.523876425425, 10587.788244234918, 10632.468376581295, 9510.667126650535, 9670.984546622503, 9776.657816976372, 9903.059209375098, 9966.202703783825, 10294.0, 10625.9468702656, 10867.891321087005, 10946.562137514411, 11302.208845380745, 9447.858282125912, 9591.280653950842, 9642.42145471274, 9999.35004224723, 10089.545970431202, 9085.13691199335, 9164.175224229852, 9184.403013804082, 9360.53197340144, 9503.952480237831], "value": 6265.660316184449, "unit": "score"}], "name": "dromaeo_css", "value": 6384.300535691846, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 128.0, 115.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 122.0, 147.0, 190.0, 122.0, 159.0, 152.0, 124.0, 185.0, 121.0], "value": 147.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 163.0, 163.0, 163.0, 162.0, 163.0, 162.0, 163.0, 162.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 75.0, 167.0, 76.0, 77.0, 77.0, 78.0, 161.0, 78.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 146.0, 86.0, 87.0, 87.0, 132.0, 87.0, 87.0, 140.0], "value": 102.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 117.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 66.0, 67.0, 67.0, 65.0, 66.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 66.0, 66.0, 66.0, 65.0, 66.0, 65.0, 66.0, 69.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 91.0, 82.0, 81.0, 86.0, 82.0, 81.0, 83.0, 83.0, 83.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 132.0, 139.0, 132.0, 143.0, 146.0, 133.0, 133.0, 178.0, 135.0], "value": 140.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 174.0, 171.0, 171.0, 177.0, 171.0, 176.0, 176.0, 175.0, 172.0], "value": 173.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 74.0, 69.0, 68.0, 72.0, 68.0, 68.0, 68.0, 70.0, 68.0], "value": 69.6, "unit": "score"}], "name": "kraken", "value": 1579.3999999999996, "alertThreshold": 2.0}]} 18:06:33 INFO - Return code: 0 18:06:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:06:33 INFO - # TBPL SUCCESS # 18:06:33 INFO - Running post-action listener: _resource_record_post_action 18:06:33 INFO - [mozharness: 2016-08-26 01:06:33.817783Z] Finished run-tests step (success) 18:06:33 INFO - Running post-run listener: _resource_record_post_run 18:06:33 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 0; Write bytes: 421834752; Read time: 0; Write time: 342440 18:06:33 INFO - TinderboxPrint: CPU usage
13.1% 18:06:33 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 18:06:33 INFO - TinderboxPrint: I/O write bytes / time
421,834,752 / 342,440 18:06:33 INFO - TinderboxPrint: CPU idle
8,343.4 (86.9%) 18:06:33 INFO - TinderboxPrint: CPU user
1,203.7 (12.5%) 18:06:33 INFO - TinderboxPrint: Swap in / out
0 / 0 18:06:33 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 116514816; Read time: 0; Write time: 148668 18:06:33 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 290840576; Read time: 0; Write time: 189284 18:06:34 INFO - Running post-run listener: _upload_blobber_files 18:06:34 INFO - Blob upload gear active. 18:06:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:06:34 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 18:06:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:06:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:06:34 INFO - (blobuploader) - INFO - Open directory for files ... 18:06:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:06:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:06:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:06:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:06:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:06:35 INFO - (blobuploader) - INFO - Done attempting. 18:06:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:06:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:06:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:06:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:06:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:06:39 INFO - (blobuploader) - INFO - Done attempting. 18:06:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:06:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:06:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:06:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:06:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:06:39 INFO - (blobuploader) - INFO - Done attempting. 18:06:39 INFO - (blobuploader) - INFO - Iteration through files over. 18:06:40 INFO - Return code: 0 18:06:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:06:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:06:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/32702f69d9922577852b84d3fec67700df460f074ef5ae5a309be4beb9d18adafc41d9583213c7940209c16bd44dc8992200ec5b499d8a5f38396d8b014152e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2a2438051a45722dd649ef7b3fbf574f4efb853d58c695032249c3fc8f7a498da3ec9a2c5a9c72bc731dce13013525e60c26e54fa201395dbca9abf784702c16", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/78b7ca9d247c11f39389d33342edb8d678b00045554e5daaedbc45a9a124a5ca53fd815fd1b88ae3f1b1408785942005a6b5237117df1ce63e6f2dc479125040"} 18:06:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:06:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:06:40 INFO - Contents: 18:06:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/32702f69d9922577852b84d3fec67700df460f074ef5ae5a309be4beb9d18adafc41d9583213c7940209c16bd44dc8992200ec5b499d8a5f38396d8b014152e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2a2438051a45722dd649ef7b3fbf574f4efb853d58c695032249c3fc8f7a498da3ec9a2c5a9c72bc731dce13013525e60c26e54fa201395dbca9abf784702c16", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/78b7ca9d247c11f39389d33342edb8d678b00045554e5daaedbc45a9a124a5ca53fd815fd1b88ae3f1b1408785942005a6b5237117df1ce63e6f2dc479125040"} 18:06:40 INFO - Running post-run listener: copy_logs_to_upload_dir 18:06:40 INFO - Copying logs to upload dir... 18:06:40 INFO - mkdir: /builds/slave/test/build/upload/logs 18:06:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.717204 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-08-25 18:06:39.746631) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 18:06:39.750418) ========= 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-1472170911.656271-671159167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/32702f69d9922577852b84d3fec67700df460f074ef5ae5a309be4beb9d18adafc41d9583213c7940209c16bd44dc8992200ec5b499d8a5f38396d8b014152e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2a2438051a45722dd649ef7b3fbf574f4efb853d58c695032249c3fc8f7a498da3ec9a2c5a9c72bc731dce13013525e60c26e54fa201395dbca9abf784702c16", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/78b7ca9d247c11f39389d33342edb8d678b00045554e5daaedbc45a9a124a5ca53fd815fd1b88ae3f1b1408785942005a6b5237117df1ce63e6f2dc479125040"} build_url:https://queue.taskcluster.net/v1/task/RVgfo78BQ-GH7JW-rq9Lrg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011339 build_url: 'https://queue.taskcluster.net/v1/task/RVgfo78BQ-GH7JW-rq9Lrg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/32702f69d9922577852b84d3fec67700df460f074ef5ae5a309be4beb9d18adafc41d9583213c7940209c16bd44dc8992200ec5b499d8a5f38396d8b014152e7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2a2438051a45722dd649ef7b3fbf574f4efb853d58c695032249c3fc8f7a498da3ec9a2c5a9c72bc731dce13013525e60c26e54fa201395dbca9abf784702c16", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/78b7ca9d247c11f39389d33342edb8d678b00045554e5daaedbc45a9a124a5ca53fd815fd1b88ae3f1b1408785942005a6b5237117df1ce63e6f2dc479125040"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 18:06:39.775137) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 18:06:39.775462) ========= 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-1472170911.656271-671159167 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004421 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 18:06:39.856817) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 18:06:39.857140) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 18:06:39.857424) ========= ========= Total master_lag: 0.18 =========