builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-028 starttime: 1475129704.17 results: success (0) buildid: 20160928213041 builduid: eadfd7b3ced64665bc2b308476313eeb revision: 7b8d79f7786ad56b4c2e71ee45a5fcb308f88722 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 23:15:04.166544) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 23:15:04.167072) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 23:15:04.167426) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 23:15:04.186274) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 23:15:04.186619) ========= 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=836cfdc75598d54cb747368e000001a9-1475127228.629529-1968606689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-28 23:15:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 82.6K=0.1s 2016-09-28 23:15:04 (82.6 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.271739 ========= master_lag: 0.20 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 23:15:04.658425) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 23:15:04.658817) ========= 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=836cfdc75598d54cb747368e000001a9-1475127228.629529-1968606689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020005 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 23:15:04.700566) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 23:15:04.700959) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7b8d79f7786ad56b4c2e71ee45a5fcb308f88722 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 7b8d79f7786ad56b4c2e71ee45a5fcb308f88722 --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=836cfdc75598d54cb747368e000001a9-1475127228.629529-1968606689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-28 23:15:04,961 truncating revision to first 12 chars 2016-09-28 23:15:04,961 Setting DEBUG logging. 2016-09-28 23:15:04,961 attempt 1/10 2016-09-28 23:15:04,962 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7b8d79f7786a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-28 23:15:06,287 unpacking tar archive at: fx-team-7b8d79f7786a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.681629 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 23:15:06.395918) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 23:15:06.396226) ========= script_repo_revision: 7b8d79f7786ad56b4c2e71ee45a5fcb308f88722 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 23:15:06.396623) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 23:15:06.396917) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 23:15:06.408467) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-09-28 23:15:06.408990) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1475127228.629529-1968606689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:15:06 INFO - MultiFileLogger online at 20160928 23:15:06 in /builds/slave/test 23:15:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:15:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:15:06 INFO - {'append_to_log': False, 23:15:06 INFO - 'base_work_dir': '/builds/slave/test', 23:15:06 INFO - 'blob_upload_branch': 'Fx-Team', 23:15:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:15:06 INFO - 'branch': 'Fx-Team', 23:15:06 INFO - 'buildbot_json_path': 'buildprops.json', 23:15:06 INFO - 'config_files': ('talos/linux_config.py',), 23:15:06 INFO - 'default_actions': ('clobber', 23:15:06 INFO - 'read-buildbot-config', 23:15:06 INFO - 'download-and-extract', 23:15:06 INFO - 'populate-webroot', 23:15:06 INFO - 'create-virtualenv', 23:15:06 INFO - 'install', 23:15:06 INFO - 'run-tests'), 23:15:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:15:06 INFO - 'download_minidump_stackwalk': True, 23:15:06 INFO - 'download_symbols': 'ondemand', 23:15:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:15:06 INFO - 'tooltool.py': '/tools/tooltool.py', 23:15:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:15:06 INFO - '/tools/misc-python/virtualenv.py')}, 23:15:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:15:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:15:06 INFO - 'installer_path': 'installer.exe', 23:15:06 INFO - 'log_level': 'info', 23:15:06 INFO - 'log_name': 'talos', 23:15:06 INFO - 'log_to_console': True, 23:15:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:15:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:15:06 INFO - 'opt_config_files': (), 23:15:06 INFO - 'pip_index': False, 23:15:06 INFO - 'sps_profile': False, 23:15:06 INFO - 'sps_profile_interval': 0, 23:15:06 INFO - 'suite': 'dromaeojs', 23:15:06 INFO - 'system_bits': '32', 23:15:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:15:06 INFO - 'title': 'talos-linux64-ix-028', 23:15:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:15:06 INFO - 'use_talos_json': True, 23:15:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:15:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:15:06 INFO - 'work_dir': 'build'} 23:15:06 INFO - [mozharness: 2016-09-29 06:15:06.765987Z] Running clobber step. 23:15:06 INFO - Running pre-action listener: _resource_record_pre_action 23:15:06 INFO - Running main action method: clobber 23:15:06 INFO - rmtree: /builds/slave/test/build 23:15:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:15:07 INFO - Running post-action listener: _resource_record_post_action 23:15:07 INFO - [mozharness: 2016-09-29 06:15:07.223865Z] Finished clobber step (success) 23:15:07 INFO - [mozharness: 2016-09-29 06:15:07.223965Z] Running read-buildbot-config step. 23:15:07 INFO - Running pre-action listener: _resource_record_pre_action 23:15:07 INFO - Running main action method: read_buildbot_config 23:15:07 INFO - Using buildbot properties: 23:15:07 INFO - { 23:15:07 INFO - "project": "", 23:15:07 INFO - "product": "firefox", 23:15:07 INFO - "script_repo_revision": "production", 23:15:07 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:15:07 INFO - "repository": "", 23:15:07 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:15:07 INFO - "buildid": "20160928213041", 23:15:07 INFO - "pgo_build": "True", 23:15:07 INFO - "basedir": "/builds/slave/test", 23:15:07 INFO - "buildnumber": 1088, 23:15:07 INFO - "slavename": "talos-linux64-ix-028", 23:15:07 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:15:07 INFO - "platform": "ubuntu64_hw", 23:15:07 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:15:07 INFO - "branch": "fx-team", 23:15:07 INFO - "repo_path": "integration/fx-team", 23:15:07 INFO - "revision": "7b8d79f7786ad56b4c2e71ee45a5fcb308f88722", 23:15:07 INFO - "stage_platform": "linux64-pgo", 23:15:07 INFO - "builduid": "eadfd7b3ced64665bc2b308476313eeb", 23:15:07 INFO - "slavebuilddir": "test" 23:15:07 INFO - } 23:15:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/OmJKwMUVQ2mbzhwfav8yQA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 23:15:07 INFO - Running post-action listener: _resource_record_post_action 23:15:07 INFO - [mozharness: 2016-09-29 06:15:07.226383Z] Finished read-buildbot-config step (success) 23:15:07 INFO - [mozharness: 2016-09-29 06:15:07.226472Z] Running download-and-extract step. 23:15:07 INFO - Running pre-action listener: _resource_record_pre_action 23:15:07 INFO - Running main action method: download_and_extract 23:15:07 INFO - mkdir: /builds/slave/test/build/tests 23:15:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:07 INFO - trying https://queue.taskcluster.net/v1/task/OmJKwMUVQ2mbzhwfav8yQA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 23:15:07 INFO - Downloading https://queue.taskcluster.net/v1/task/OmJKwMUVQ2mbzhwfav8yQA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 23:15:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OmJKwMUVQ2mbzhwfav8yQA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:15:07 INFO - Downloaded 1361 bytes. 23:15:07 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 23:15:07 INFO - Using the following test package requirements: 23:15:07 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 23:15:07 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:15:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:15:07 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:15:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:15:07 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:15:07 INFO - u'jsshell-linux-x86_64.zip'], 23:15:07 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:15:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:15:07 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 23:15:07 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:15:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:15:07 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:15:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:15:07 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:15:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:15:07 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:15:07 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:15:07 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:15:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OmJKwMUVQ2mbzhwfav8yQA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 23:15:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OmJKwMUVQ2mbzhwfav8yQA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:15:07 INFO - Fetch https://queue.taskcluster.net/v1/task/OmJKwMUVQ2mbzhwfav8yQA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 23:15:08 INFO - Expected file size: 21987076 23:15:08 INFO - Content-Encoding None 23:15:08 INFO - Content-Type application/zip 23:15:08 INFO - Http code 200 23:15:12 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:15:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OmJKwMUVQ2mbzhwfav8yQA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 23:15:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OmJKwMUVQ2mbzhwfav8yQA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:15:12 INFO - Fetch https://queue.taskcluster.net/v1/task/OmJKwMUVQ2mbzhwfav8yQA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 23:15:13 INFO - Expected file size: 21987076 23:15:13 INFO - Content-Encoding None 23:15:13 INFO - Content-Type application/zip 23:15:13 INFO - Http code 200 23:15:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OmJKwMUVQ2mbzhwfav8yQA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 23:15:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OmJKwMUVQ2mbzhwfav8yQA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:15:18 INFO - Fetch https://queue.taskcluster.net/v1/task/OmJKwMUVQ2mbzhwfav8yQA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 23:15:18 INFO - Expected file size: 14414067 23:15:18 INFO - Content-Encoding None 23:15:18 INFO - Content-Type application/zip 23:15:18 INFO - Http code 200 23:15: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')]} 23:15:19 INFO - trying https://queue.taskcluster.net/v1/task/OmJKwMUVQ2mbzhwfav8yQA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:15:19 INFO - Downloading https://queue.taskcluster.net/v1/task/OmJKwMUVQ2mbzhwfav8yQA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:15:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OmJKwMUVQ2mbzhwfav8yQA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:15:21 INFO - Downloaded 59750346 bytes. 23:15:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OmJKwMUVQ2mbzhwfav8yQA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:15:21 INFO - mkdir: /builds/slave/test/properties 23:15:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:15:21 INFO - Writing to file /builds/slave/test/properties/build_url 23:15:21 INFO - Contents: 23:15:21 INFO - build_url:https://queue.taskcluster.net/v1/task/OmJKwMUVQ2mbzhwfav8yQA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:15:22 INFO - Running post-action listener: _resource_record_post_action 23:15:22 INFO - Running post-action listener: set_extra_try_arguments 23:15:22 INFO - [mozharness: 2016-09-29 06:15:22.053528Z] Finished download-and-extract step (success) 23:15:22 INFO - [mozharness: 2016-09-29 06:15:22.053754Z] Running populate-webroot step. 23:15:22 INFO - Running pre-action listener: _resource_record_pre_action 23:15:22 INFO - Running main action method: populate_webroot 23:15:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:15:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:15:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:15:22 INFO - '--tppagecycles', 23:15:22 INFO - '7'], 23:15:22 INFO - 'tests': ['tsvgm']}}, 23:15:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:15:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:15:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:15:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:15:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:15:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:15:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:15:22 INFO - 'talos_options': ['--disable-e10s'], 23:15:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:15:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:15:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:15:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:15:22 INFO - 'talos_options': ['--disable-e10s'], 23:15:22 INFO - 'tests': ['damp', 'tps']}, 23:15:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:15:22 INFO - 'tests': ['damp', 'tps']}, 23:15:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:15:22 INFO - 'tests': ['dromaeo_dom']}, 23:15:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:15:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:15:22 INFO - 'tests': ['basic_compositor_video']}, 23:15:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:15:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:15:22 INFO - 'tests': ['a11yr', 23:15:22 INFO - 'ts_paint', 23:15:22 INFO - 'tpaint', 23:15:22 INFO - 'sessionrestore', 23:15:22 INFO - 'sessionrestore_no_auto_restore', 23:15:22 INFO - 'tabpaint']}, 23:15:22 INFO - 'other-e10s': {'tests': ['a11yr', 23:15:22 INFO - 'ts_paint', 23:15:22 INFO - 'tpaint', 23:15:22 INFO - 'sessionrestore', 23:15:22 INFO - 'sessionrestore_no_auto_restore', 23:15:22 INFO - 'tabpaint']}, 23:15:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:15:22 INFO - 'ts_paint', 23:15:22 INFO - 'tpaint', 23:15:22 INFO - 'sessionrestore', 23:15:22 INFO - 'sessionrestore_no_auto_restore', 23:15:22 INFO - 'tabpaint']}, 23:15:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:15:22 INFO - 'ts_paint', 23:15:22 INFO - 'tpaint', 23:15:22 INFO - 'sessionrestore', 23:15:22 INFO - 'sessionrestore_no_auto_restore', 23:15:22 INFO - 'tabpaint']}, 23:15:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:15:22 INFO - 'tests': ['a11yr', 23:15:22 INFO - 'ts_paint', 23:15:22 INFO - 'tpaint', 23:15:22 INFO - 'sessionrestore', 23:15:22 INFO - 'sessionrestore_no_auto_restore', 23:15:22 INFO - 'tabpaint']}, 23:15:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:15:22 INFO - 'tests': ['a11yr', 23:15:22 INFO - 'ts_paint', 23:15:22 INFO - 'tpaint', 23:15:22 INFO - 'sessionrestore', 23:15:22 INFO - 'sessionrestore_no_auto_restore', 23:15:22 INFO - 'tabpaint']}, 23:15:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:15:22 INFO - 'tests': ['tsvgx', 23:15:22 INFO - 'tsvgr_opacity', 23:15:22 INFO - 'tart', 23:15:22 INFO - 'tscrollx', 23:15:22 INFO - 'cart']}, 23:15:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:15:22 INFO - 'tsvgr_opacity', 23:15:22 INFO - 'tart', 23:15:22 INFO - 'tscrollx', 23:15:22 INFO - 'cart']}, 23:15:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:15:22 INFO - 'talos_options': ['--disable-e10s'], 23:15:22 INFO - 'tests': ['tp5o']}, 23:15:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:15:22 INFO - 'tests': ['tp5o']}, 23:15:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:15:22 INFO - 'talos_options': ['--disable-e10s', 23:15:22 INFO - '--xperf_path', 23:15:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:15:22 INFO - 'tests': ['tp5n']}, 23:15:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:15:22 INFO - 'talos_options': ['--xperf_path', 23:15:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:15:22 INFO - 'tests': ['tp5n']}}, 23:15:22 INFO - 'talos.zip': {'path': '', 23:15:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:15:22 INFO - Running post-action listener: _resource_record_post_action 23:15:22 INFO - [mozharness: 2016-09-29 06:15:22.072387Z] Finished populate-webroot step (success) 23:15:22 INFO - [mozharness: 2016-09-29 06:15:22.072475Z] Running create-virtualenv step. 23:15:22 INFO - Running pre-action listener: _resource_record_pre_action 23:15:22 INFO - Running main action method: create_virtualenv 23:15:22 INFO - Creating virtualenv /builds/slave/test/build/venv 23:15:22 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 23:15:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:15:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:15:22 INFO - Using real prefix '/usr' 23:15:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:15:22 INFO - Installing distribute.............................................................................................................................................................................................done. 23:15:24 INFO - Installing pip.................done. 23:15:24 INFO - Return code: 0 23:15:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:15:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:15:24 INFO - Reading from file tmpfile_stdout 23:15:24 INFO - Output received: 23:15:24 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 23:15:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:15:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:24 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 0x7fc7159fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf67790>, '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 0xf68690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf68b20>, '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': '836cfdc75598d54cb747368e000001a9-1475127228.629529-1968606689', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:15:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:15:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:15:24 INFO - Using env: {'DISPLAY': ':0', 23:15:24 INFO - 'HOME': '/home/cltbld', 23:15:24 INFO - 'LANG': 'en_US.UTF-8', 23:15:24 INFO - 'LANGUAGE': 'en_US:en', 23:15:24 INFO - 'LOGNAME': 'cltbld', 23:15:24 INFO - 'MAIL': '/var/mail/cltbld', 23:15:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:24 INFO - 'MOZ_NO_REMOTE': '1', 23:15:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:24 INFO - 'NO_EM_RESTART': '1', 23:15:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:24 INFO - 'PWD': '/builds/slave/test', 23:15:24 INFO - 'SHELL': '/bin/bash', 23:15:24 INFO - 'SHLVL': '1', 23:15:24 INFO - 'TERM': 'linux', 23:15:24 INFO - 'TMOUT': '86400', 23:15:24 INFO - 'USER': 'cltbld', 23:15:24 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475127228.629529-1968606689', 23:15:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:24 INFO - '_': '/tools/buildbot/bin/python'} 23:15:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:25 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 23:15:25 INFO - Cleaning up... 23:15:25 INFO - Return code: 0 23:15:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:15:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:25 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 0x7fc7159fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf67790>, '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 0xf68690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf68b20>, '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': '836cfdc75598d54cb747368e000001a9-1475127228.629529-1968606689', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:15:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:15:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:15:25 INFO - Using env: {'DISPLAY': ':0', 23:15:25 INFO - 'HOME': '/home/cltbld', 23:15:25 INFO - 'LANG': 'en_US.UTF-8', 23:15:25 INFO - 'LANGUAGE': 'en_US:en', 23:15:25 INFO - 'LOGNAME': 'cltbld', 23:15:25 INFO - 'MAIL': '/var/mail/cltbld', 23:15:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:25 INFO - 'MOZ_NO_REMOTE': '1', 23:15:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:25 INFO - 'NO_EM_RESTART': '1', 23:15:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:25 INFO - 'PWD': '/builds/slave/test', 23:15:25 INFO - 'SHELL': '/bin/bash', 23:15:25 INFO - 'SHLVL': '1', 23:15:25 INFO - 'TERM': 'linux', 23:15:25 INFO - 'TMOUT': '86400', 23:15:25 INFO - 'USER': 'cltbld', 23:15:25 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475127228.629529-1968606689', 23:15:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:25 INFO - '_': '/tools/buildbot/bin/python'} 23:15:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:25 INFO - Downloading/unpacking psutil>=3.1.1 23:15:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:15:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:15:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:15:27 INFO - Installing collected packages: psutil 23:15:27 INFO - Running setup.py install for psutil 23:15:27 INFO - building 'psutil._psutil_linux' extension 23:15:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 23:15:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 23:15:27 INFO - building 'psutil._psutil_posix' extension 23:15:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 23:15:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 23:15:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:15:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:15:27 INFO - Successfully installed psutil 23:15:27 INFO - Cleaning up... 23:15:27 INFO - Return code: 0 23:15:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:15:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:27 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 0x7fc7159fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf67790>, '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 0xf68690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf68b20>, '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': '836cfdc75598d54cb747368e000001a9-1475127228.629529-1968606689', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:15:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:15:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:15:27 INFO - Using env: {'DISPLAY': ':0', 23:15:27 INFO - 'HOME': '/home/cltbld', 23:15:27 INFO - 'LANG': 'en_US.UTF-8', 23:15:27 INFO - 'LANGUAGE': 'en_US:en', 23:15:27 INFO - 'LOGNAME': 'cltbld', 23:15:27 INFO - 'MAIL': '/var/mail/cltbld', 23:15:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:27 INFO - 'MOZ_NO_REMOTE': '1', 23:15:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:27 INFO - 'NO_EM_RESTART': '1', 23:15:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:27 INFO - 'PWD': '/builds/slave/test', 23:15:27 INFO - 'SHELL': '/bin/bash', 23:15:27 INFO - 'SHLVL': '1', 23:15:27 INFO - 'TERM': 'linux', 23:15:27 INFO - 'TMOUT': '86400', 23:15:27 INFO - 'USER': 'cltbld', 23:15:27 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475127228.629529-1968606689', 23:15:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:27 INFO - '_': '/tools/buildbot/bin/python'} 23:15:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:15:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:15:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:15:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:15:30 INFO - Installing collected packages: mozsystemmonitor 23:15:30 INFO - Running setup.py install for mozsystemmonitor 23:15:30 INFO - Successfully installed mozsystemmonitor 23:15:30 INFO - Cleaning up... 23:15:30 INFO - Return code: 0 23:15:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:15: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')]} 23:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15: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')]} 23:15:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc7159fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf67790>, '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 0xf68690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf68b20>, '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': '836cfdc75598d54cb747368e000001a9-1475127228.629529-1968606689', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:15: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==2.5.1'] in /builds/slave/test/build 23:15: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==2.5.1 23:15:30 INFO - Using env: {'DISPLAY': ':0', 23:15:30 INFO - 'HOME': '/home/cltbld', 23:15:30 INFO - 'LANG': 'en_US.UTF-8', 23:15:30 INFO - 'LANGUAGE': 'en_US:en', 23:15:30 INFO - 'LOGNAME': 'cltbld', 23:15:30 INFO - 'MAIL': '/var/mail/cltbld', 23:15:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:30 INFO - 'MOZ_NO_REMOTE': '1', 23:15:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:30 INFO - 'NO_EM_RESTART': '1', 23:15:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:30 INFO - 'PWD': '/builds/slave/test', 23:15:30 INFO - 'SHELL': '/bin/bash', 23:15:30 INFO - 'SHLVL': '1', 23:15:30 INFO - 'TERM': 'linux', 23:15:30 INFO - 'TMOUT': '86400', 23:15:30 INFO - 'USER': 'cltbld', 23:15:30 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475127228.629529-1968606689', 23:15:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:30 INFO - '_': '/tools/buildbot/bin/python'} 23:15:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:30 INFO - Downloading/unpacking jsonschema==2.5.1 23:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:15:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:15:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:32 INFO - Downloading functools32-3.2.3-2.tar.gz 23:15:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:15:32 INFO - warning: no files found matching '*.txt' 23:15:32 INFO - no previously-included directories found matching 'build' 23:15:32 INFO - no previously-included directories found matching 'dist' 23:15:32 INFO - no previously-included directories found matching '.git*' 23:15:32 INFO - Installing collected packages: jsonschema, functools32 23:15:32 INFO - Running setup.py install for functools32 23:15:32 INFO - warning: no files found matching '*.txt' 23:15:32 INFO - no previously-included directories found matching 'build' 23:15:32 INFO - no previously-included directories found matching 'dist' 23:15:32 INFO - no previously-included directories found matching '.git*' 23:15:32 INFO - Successfully installed jsonschema functools32 23:15:32 INFO - Cleaning up... 23:15:32 INFO - Return code: 0 23:15:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:32 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 0x7fc7159fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf67790>, '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 0xf68690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf68b20>, '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': '836cfdc75598d54cb747368e000001a9-1475127228.629529-1968606689', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:15:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 23:15:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 23:15:32 INFO - Using env: {'DISPLAY': ':0', 23:15:32 INFO - 'HOME': '/home/cltbld', 23:15:32 INFO - 'LANG': 'en_US.UTF-8', 23:15:32 INFO - 'LANGUAGE': 'en_US:en', 23:15:32 INFO - 'LOGNAME': 'cltbld', 23:15:32 INFO - 'MAIL': '/var/mail/cltbld', 23:15:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:32 INFO - 'MOZ_NO_REMOTE': '1', 23:15:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:32 INFO - 'NO_EM_RESTART': '1', 23:15:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:32 INFO - 'PWD': '/builds/slave/test', 23:15:32 INFO - 'SHELL': '/bin/bash', 23:15:32 INFO - 'SHLVL': '1', 23:15:32 INFO - 'TERM': 'linux', 23:15:32 INFO - 'TMOUT': '86400', 23:15:32 INFO - 'USER': 'cltbld', 23:15:32 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475127228.629529-1968606689', 23:15:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:32 INFO - '_': '/tools/buildbot/bin/python'} 23:15:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:15:32 INFO - Cleaning up... 23:15:32 INFO - Return code: 0 23:15:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:32 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 0x7fc7159fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf67790>, '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 0xf68690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf68b20>, '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': '836cfdc75598d54cb747368e000001a9-1475127228.629529-1968606689', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:15:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:15:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:15:32 INFO - Using env: {'DISPLAY': ':0', 23:15:32 INFO - 'HOME': '/home/cltbld', 23:15:32 INFO - 'LANG': 'en_US.UTF-8', 23:15:32 INFO - 'LANGUAGE': 'en_US:en', 23:15:32 INFO - 'LOGNAME': 'cltbld', 23:15:32 INFO - 'MAIL': '/var/mail/cltbld', 23:15:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:32 INFO - 'MOZ_NO_REMOTE': '1', 23:15:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:32 INFO - 'NO_EM_RESTART': '1', 23:15:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:32 INFO - 'PWD': '/builds/slave/test', 23:15:32 INFO - 'SHELL': '/bin/bash', 23:15:32 INFO - 'SHLVL': '1', 23:15:32 INFO - 'TERM': 'linux', 23:15:32 INFO - 'TMOUT': '86400', 23:15:32 INFO - 'USER': 'cltbld', 23:15:32 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475127228.629529-1968606689', 23:15:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:32 INFO - '_': '/tools/buildbot/bin/python'} 23:15:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:33 INFO - Downloading/unpacking blobuploader==1.2.4 23:15:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:35 INFO - Downloading blobuploader-1.2.4.tar.gz 23:15:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:15:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:15:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:35 INFO - Downloading docopt-0.6.1.tar.gz 23:15:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:15:35 INFO - Installing collected packages: blobuploader, requests, docopt 23:15:35 INFO - Running setup.py install for blobuploader 23:15:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:15:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:15:35 INFO - Running setup.py install for requests 23:15:36 INFO - Running setup.py install for docopt 23:15:36 INFO - Successfully installed blobuploader requests docopt 23:15:36 INFO - Cleaning up... 23:15:36 INFO - Return code: 0 23:15:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:15:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:36 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 0x7fc7159fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf67790>, '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 0xf68690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf68b20>, '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': '836cfdc75598d54cb747368e000001a9-1475127228.629529-1968606689', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:15:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:15:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:15:36 INFO - Using env: {'DISPLAY': ':0', 23:15:36 INFO - 'HOME': '/home/cltbld', 23:15:36 INFO - 'LANG': 'en_US.UTF-8', 23:15:36 INFO - 'LANGUAGE': 'en_US:en', 23:15:36 INFO - 'LOGNAME': 'cltbld', 23:15:36 INFO - 'MAIL': '/var/mail/cltbld', 23:15:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:36 INFO - 'MOZ_NO_REMOTE': '1', 23:15:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:36 INFO - 'NO_EM_RESTART': '1', 23:15:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:36 INFO - 'PWD': '/builds/slave/test', 23:15:36 INFO - 'SHELL': '/bin/bash', 23:15:36 INFO - 'SHLVL': '1', 23:15:36 INFO - 'TERM': 'linux', 23:15:36 INFO - 'TMOUT': '86400', 23:15:36 INFO - 'USER': 'cltbld', 23:15:36 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475127228.629529-1968606689', 23:15:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:36 INFO - '_': '/tools/buildbot/bin/python'} 23:15:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:15:36 INFO - Running setup.py (path:/tmp/pip-ZyIDRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:15:36 INFO - Running setup.py (path:/tmp/pip-3goSUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:15:36 INFO - Running setup.py (path:/tmp/pip-dA1zuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:15:36 INFO - Running setup.py (path:/tmp/pip-MpAwHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:15:36 INFO - Running setup.py (path:/tmp/pip-FMaXhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:15:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:15:37 INFO - Running setup.py (path:/tmp/pip-8a8sVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:15:37 INFO - Running setup.py (path:/tmp/pip-If8N_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:15:37 INFO - Running setup.py (path:/tmp/pip-AKik_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:15:37 INFO - Running setup.py (path:/tmp/pip-ZtEy2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:15:37 INFO - Running setup.py (path:/tmp/pip-tyq0tJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:15:37 INFO - Running setup.py (path:/tmp/pip-qGCnCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:15:37 INFO - Running setup.py (path:/tmp/pip-rOCtqA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:15:37 INFO - Running setup.py (path:/tmp/pip-qtq4jS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:15:37 INFO - Running setup.py (path:/tmp/pip-ZfH7nJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:15:37 INFO - Running setup.py (path:/tmp/pip-DtvwqC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:15:37 INFO - Running setup.py (path:/tmp/pip-SWsMUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:15:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:15:37 INFO - Running setup.py (path:/tmp/pip-GqF1Xi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:15:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:15:37 INFO - Running setup.py install for manifestparser 23:15:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:15:37 INFO - Running setup.py install for mozcrash 23:15:38 INFO - Running setup.py install for mozdebug 23:15:38 INFO - Running setup.py install for mozdevice 23:15:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:15:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:15:38 INFO - Running setup.py install for mozfile 23:15:38 INFO - Running setup.py install for mozhttpd 23:15:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:15:38 INFO - Running setup.py install for mozinfo 23:15:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:15:38 INFO - Running setup.py install for mozInstall 23:15:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:15:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:15:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:15:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:15:38 INFO - Running setup.py install for mozleak 23:15:38 INFO - Running setup.py install for mozlog 23:15:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:15:38 INFO - Running setup.py install for moznetwork 23:15:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:15:38 INFO - Running setup.py install for mozprocess 23:15:39 INFO - Running setup.py install for mozprofile 23:15:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:15:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:15:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:15:39 INFO - Running setup.py install for mozrunner 23:15:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:15:39 INFO - Running setup.py install for mozscreenshot 23:15:39 INFO - Running setup.py install for moztest 23:15:39 INFO - Running setup.py install for mozversion 23:15:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:15:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:15:39 INFO - Cleaning up... 23:15:39 INFO - Return code: 0 23:15:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:39 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 0x7fc7159fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf67790>, '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 0xf68690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf68b20>, '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': '836cfdc75598d54cb747368e000001a9-1475127228.629529-1968606689', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:15:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 23:15:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:15:39 INFO - Using env: {'DISPLAY': ':0', 23:15:39 INFO - 'HOME': '/home/cltbld', 23:15:39 INFO - 'LANG': 'en_US.UTF-8', 23:15:39 INFO - 'LANGUAGE': 'en_US:en', 23:15:39 INFO - 'LOGNAME': 'cltbld', 23:15:39 INFO - 'MAIL': '/var/mail/cltbld', 23:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:39 INFO - 'MOZ_NO_REMOTE': '1', 23:15:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:39 INFO - 'NO_EM_RESTART': '1', 23:15:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:39 INFO - 'PWD': '/builds/slave/test', 23:15:39 INFO - 'SHELL': '/bin/bash', 23:15:39 INFO - 'SHLVL': '1', 23:15:39 INFO - 'TERM': 'linux', 23:15:39 INFO - 'TMOUT': '86400', 23:15:39 INFO - 'USER': 'cltbld', 23:15:39 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475127228.629529-1968606689', 23:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:39 INFO - '_': '/tools/buildbot/bin/python'} 23:15:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:15:39 INFO - Running setup.py (path:/tmp/pip-DCiOKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:15:39 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 23:15:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:15:39 INFO - Running setup.py (path:/tmp/pip-D566At-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:15:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:15:40 INFO - Running setup.py (path:/tmp/pip-r7xqIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:15:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:15:40 INFO - Running setup.py (path:/tmp/pip-i166xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:15:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:15:40 INFO - Running setup.py (path:/tmp/pip-hSH2W5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:15:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 23:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:15:40 INFO - Running setup.py (path:/tmp/pip-LxIU9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:15:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 23:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:15:40 INFO - Running setup.py (path:/tmp/pip-sUhHvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:15:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 23:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:15:40 INFO - Running setup.py (path:/tmp/pip-NlcaxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:15:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 23:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:15:40 INFO - Running setup.py (path:/tmp/pip-Yqdpe6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:15:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 23:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:15:40 INFO - Running setup.py (path:/tmp/pip-KuWAgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:15:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:15:40 INFO - Running setup.py (path:/tmp/pip-fob_xJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:15:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 23:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:15:40 INFO - Running setup.py (path:/tmp/pip-5aJkJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:15:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:15:40 INFO - Running setup.py (path:/tmp/pip-5l3T4P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:15:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 23:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:15:40 INFO - Running setup.py (path:/tmp/pip-2iCgTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:15:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:15:40 INFO - Running setup.py (path:/tmp/pip-meUi1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:15:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 23:15:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:15:40 INFO - Running setup.py (path:/tmp/pip-lGjh7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:15:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 23:15:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:15:41 INFO - Running setup.py (path:/tmp/pip-38sFIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:15:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 23:15:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:15:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:15:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 23:15:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:15:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:15:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:15:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:15:43 INFO - Downloading blessings-1.6.tar.gz 23:15:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:15:43 INFO - Installing collected packages: blessings 23:15:43 INFO - Running setup.py install for blessings 23:15:43 INFO - Successfully installed blessings 23:15:43 INFO - Cleaning up... 23:15:43 INFO - Return code: 0 23:15:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:15:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:15:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:15:43 INFO - Reading from file tmpfile_stdout 23:15:43 INFO - Current package versions: 23:15:43 INFO - argparse == 1.2.1 23:15:43 INFO - blessings == 1.6 23:15:43 INFO - blobuploader == 1.2.4 23:15:43 INFO - docopt == 0.6.1 23:15:43 INFO - functools32 == 3.2.3-2 23:15:43 INFO - jsonschema == 2.5.1 23:15:43 INFO - manifestparser == 1.1 23:15:43 INFO - mozInstall == 1.12 23:15:43 INFO - mozcrash == 0.17 23:15:43 INFO - mozdebug == 0.1 23:15:43 INFO - mozdevice == 0.48 23:15:43 INFO - mozfile == 1.2 23:15:43 INFO - mozhttpd == 0.7 23:15:43 INFO - mozinfo == 0.9 23:15:43 INFO - mozleak == 0.1 23:15:43 INFO - mozlog == 3.4 23:15:43 INFO - moznetwork == 0.27 23:15:43 INFO - mozprocess == 0.23 23:15:43 INFO - mozprofile == 0.28 23:15:43 INFO - mozrunner == 6.12 23:15:43 INFO - mozscreenshot == 0.1 23:15:43 INFO - mozsystemmonitor == 0.3 23:15:43 INFO - moztest == 0.7 23:15:43 INFO - mozversion == 1.4 23:15:43 INFO - psutil == 3.1.1 23:15:43 INFO - requests == 1.2.3 23:15:43 INFO - wsgiref == 0.1.2 23:15:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:43 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 0x7fc7159fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf67790>, '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 0xf68690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf68b20>, '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': '836cfdc75598d54cb747368e000001a9-1475127228.629529-1968606689', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:15:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 23:15:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 23:15:43 INFO - Using env: {'DISPLAY': ':0', 23:15:43 INFO - 'HOME': '/home/cltbld', 23:15:43 INFO - 'LANG': 'en_US.UTF-8', 23:15:43 INFO - 'LANGUAGE': 'en_US:en', 23:15:43 INFO - 'LOGNAME': 'cltbld', 23:15:43 INFO - 'MAIL': '/var/mail/cltbld', 23:15:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:43 INFO - 'MOZ_NO_REMOTE': '1', 23:15:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:43 INFO - 'NO_EM_RESTART': '1', 23:15:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:43 INFO - 'PWD': '/builds/slave/test', 23:15:43 INFO - 'SHELL': '/bin/bash', 23:15:43 INFO - 'SHLVL': '1', 23:15:43 INFO - 'TERM': 'linux', 23:15:43 INFO - 'TMOUT': '86400', 23:15:43 INFO - 'USER': 'cltbld', 23:15:43 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475127228.629529-1968606689', 23:15:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:43 INFO - '_': '/tools/buildbot/bin/python'} 23:15:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 23:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 23:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 23:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 23:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 23:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 23:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 23:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 23:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 23:15:43 INFO - Cleaning up... 23:15:43 INFO - Return code: 0 23:15:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:43 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 0x7fc7159fdf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe0c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf67790>, '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 0xf68690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf68b20>, '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': '836cfdc75598d54cb747368e000001a9-1475127228.629529-1968606689', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 23:15:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:15:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:15:43 INFO - Using env: {'DISPLAY': ':0', 23:15:43 INFO - 'HOME': '/home/cltbld', 23:15:43 INFO - 'LANG': 'en_US.UTF-8', 23:15:43 INFO - 'LANGUAGE': 'en_US:en', 23:15:43 INFO - 'LOGNAME': 'cltbld', 23:15:43 INFO - 'MAIL': '/var/mail/cltbld', 23:15:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:43 INFO - 'MOZ_NO_REMOTE': '1', 23:15:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:43 INFO - 'NO_EM_RESTART': '1', 23:15:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:43 INFO - 'PWD': '/builds/slave/test', 23:15:43 INFO - 'SHELL': '/bin/bash', 23:15:43 INFO - 'SHLVL': '1', 23:15:43 INFO - 'TERM': 'linux', 23:15:43 INFO - 'TMOUT': '86400', 23:15:43 INFO - 'USER': 'cltbld', 23:15:43 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475127228.629529-1968606689', 23:15:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:43 INFO - '_': '/tools/buildbot/bin/python'} 23:15:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:15:43 INFO - Cleaning up... 23:15:43 INFO - Return code: 0 23:15:43 INFO - Running post-action listener: _resource_record_post_action 23:15:43 INFO - Running post-action listener: _start_resource_monitoring 23:15:44 INFO - Starting resource monitoring. 23:15:44 INFO - [mozharness: 2016-09-29 06:15:44.014419Z] Finished create-virtualenv step (success) 23:15:44 INFO - [mozharness: 2016-09-29 06:15:44.014890Z] Running install step. 23:15:44 INFO - Running pre-action listener: _resource_record_pre_action 23:15:44 INFO - Running main action method: install 23:15:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:15:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:15:44 INFO - Reading from file tmpfile_stdout 23:15:44 INFO - Detecting whether we're running mozinstall >=1.0... 23:15:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:15:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:15:44 INFO - Reading from file tmpfile_stdout 23:15:44 INFO - Output received: 23:15:44 INFO - Usage: mozinstall [options] installer 23:15:44 INFO - Options: 23:15:44 INFO - -h, --help show this help message and exit 23:15:44 INFO - -d DEST, --destination=DEST 23:15:44 INFO - Directory to install application into. [default: 23:15:44 INFO - "/builds/slave/test"] 23:15:44 INFO - --app=APP Application being installed. [default: firefox] 23:15:44 INFO - mkdir: /builds/slave/test/build/application 23:15:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:15:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:16:01 INFO - Reading from file tmpfile_stdout 23:16:01 INFO - Output received: 23:16:01 INFO - /builds/slave/test/build/application/firefox/firefox 23:16:01 INFO - Running post-action listener: _resource_record_post_action 23:16:01 INFO - [mozharness: 2016-09-29 06:16:01.973449Z] Finished install step (success) 23:16:01 INFO - [mozharness: 2016-09-29 06:16:01.973696Z] Running run-tests step. 23:16:01 INFO - Running pre-action listener: _resource_record_pre_action 23:16:01 INFO - Running main action method: run_tests 23:16:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:16:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:16:01 INFO - Python 2.7.3 23:16:01 INFO - Return code: 0 23:16:01 INFO - grabbing minidump binary from tooltool 23:16:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:01 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 0xf67790>, '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 0xf68690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf68b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:16:01 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 23:16:01 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 23:16:01 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 23:16:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:16:02 INFO - Return code: 0 23:16:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:16:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:16:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:16:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:16:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:16:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OmJKwMUVQ2mbzhwfav8yQA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 23:16:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OmJKwMUVQ2mbzhwfav8yQA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 23:16:02 INFO - Using env: {'DISPLAY': ':0', 23:16:02 INFO - 'HOME': '/home/cltbld', 23:16:02 INFO - 'LANG': 'en_US.UTF-8', 23:16:02 INFO - 'LANGUAGE': 'en_US:en', 23:16:02 INFO - 'LOGNAME': 'cltbld', 23:16:02 INFO - 'MAIL': '/var/mail/cltbld', 23:16:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:16:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:16:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:02 INFO - 'MOZ_NO_REMOTE': '1', 23:16:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:16:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:02 INFO - 'NO_EM_RESTART': '1', 23:16:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:02 INFO - 'PWD': '/builds/slave/test', 23:16:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:16:02 INFO - 'SHELL': '/bin/bash', 23:16:02 INFO - 'SHLVL': '1', 23:16:02 INFO - 'TERM': 'linux', 23:16:02 INFO - 'TMOUT': '86400', 23:16:02 INFO - 'USER': 'cltbld', 23:16:02 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1475127228.629529-1968606689', 23:16:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:02 INFO - '_': '/tools/buildbot/bin/python'} 23:16:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OmJKwMUVQ2mbzhwfav8yQA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 23:16:02 INFO - mozversion application_buildid: 20160928213041 23:16:02 INFO - mozversion application_changeset: 7b8d79f7786ad56b4c2e71ee45a5fcb308f88722 23:16:02 INFO - mozversion application_display_name: Nightly 23:16:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:16:02 INFO - mozversion application_name: Firefox 23:16:02 INFO - mozversion application_remotingname: firefox 23:16:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:16:02 INFO - mozversion application_vendor: Mozilla 23:16:02 INFO - mozversion application_version: 52.0a1 23:16:02 INFO - mozversion platform_buildid: 20160928213041 23:16:02 INFO - mozversion platform_changeset: 7b8d79f7786ad56b4c2e71ee45a5fcb308f88722 23:16:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:16:02 INFO - mozversion platform_version: 52.0a1 23:16:02 INFO - using testdate: 1475129762 23:16:02 INFO - actual date: 1475129762 23:16:02 INFO - starting webserver on 'localhost:36791' 23:16:02 INFO - SUITE-START | Running 2 tests 23:16:02 INFO - TEST-START | dromaeo_css 23:16:02 INFO - operating with platform_type : linux_ 23:16:02 INFO - Initialising browser for dromaeo_css test... 23:16:02 INFO - TEST-INFO | started process 29893 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWOK05z/profile http://localhost:36791/getInfo.html) 23:16:06 INFO - PROCESS | 29893 | __metrics Screen width/height:1600/1200 23:16:06 INFO - PROCESS | 29893 | colorDepth:24 23:16:06 INFO - PROCESS | 29893 | Browser inner width/height: 1024/697 23:16:06 INFO - PROCESS | 29893 | __metrics 23:16:07 INFO - PROCESS | 29893 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:16:07 INFO - PROCESS | 29893 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:16:08 INFO - PROCESS | 29893 | console.error: PushService: 23:16:08 INFO - PROCESS | 29893 | stateChangeProcessEnqueue: Error transitioning state 23:16:08 INFO - PROCESS | 29893 | UnknownError 23:16:08 INFO - TEST-INFO | 29893: exit 0 23:16:08 INFO - Browser initialized. 23:16:08 INFO - Running cycle 1/1 for dromaeo_css test... 23:16:08 INFO - TEST-INFO | started process 29976 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWOK05z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:16:20 INFO - PROCESS | 29976 | RSS: Main: 173989888 23:16:20 INFO - PROCESS | 29976 | 23:17:11 INFO - PROCESS | 29976 | 1475129831696 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 23:19:21 INFO - PROCESS | 29976 | Cycle 1(1): loaded http://localhost:36791/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36791/tests/dromaeo/cssquery-ext.html) 23:19:23 INFO - PROCESS | 29976 | RSS: Main: 285528064 23:19:23 INFO - PROCESS | 29976 | 23:22:25 INFO - PROCESS | 29976 | Cycle 1(1): loaded http://localhost:36791/tests/dromaeo/cssquery-ext.html (next: http://localhost:36791/tests/dromaeo/cssquery-jquery.html) 23:22:26 INFO - PROCESS | 29976 | RSS: Main: 270807040 23:22:26 INFO - PROCESS | 29976 | 23:25:28 INFO - PROCESS | 29976 | Cycle 1(1): loaded http://localhost:36791/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36791/tests/dromaeo/cssquery-mootools.html) 23:25:28 INFO - PROCESS | 29976 | RSS: Main: 259715072 23:25:28 INFO - PROCESS | 29976 | 23:28:30 INFO - PROCESS | 29976 | Cycle 1(1): loaded http://localhost:36791/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36791/tests/dromaeo/cssquery-prototype.html) 23:28:31 INFO - PROCESS | 29976 | RSS: Main: 243515392 23:28:31 INFO - PROCESS | 29976 | 23:31:34 INFO - PROCESS | 29976 | Cycle 1(1): loaded http://localhost:36791/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36791/tests/dromaeo/cssquery-yui.html) 23:31:34 INFO - PROCESS | 29976 | RSS: Main: 218480640 23:31:34 INFO - PROCESS | 29976 | 23:34:37 INFO - PROCESS | 29976 | Cycle 1(1): loaded http://localhost:36791/tests/dromaeo/cssquery-yui.html (next: http://localhost:36791/tests/dromaeo/cssquery-dojo.html) 23:34:37 INFO - PROCESS | 29976 | RSS: Main: 307568640 23:34:37 INFO - PROCESS | 29976 | 23:34:37 INFO - PROCESS | 29976 | __start_tp_report 23:34:37 INFO - PROCESS | 29976 | _x_x_mozilla_page_load 23:34:37 INFO - PROCESS | 29976 | _x_x_mozilla_page_load_details 23:34:37 INFO - PROCESS | 29976 | |i|pagename|runs| 23:34:37 INFO - PROCESS | 29976 | |0;dojo.html;3005.203621040424;3025.924351891204;3031.3028003559175;3063.9080827575153;3088.6756890526494;5264.631475796696;5336.866578335544;5372.4090350061515;5397.568194544437;5409.621326507141;5380.300560927084;5410.864728381793;5428.782848686058;5478.315210598676;5525.640833345829;4647.387013293709;4901.877453063684;4924.876878078059;4968.180250258703;4979.053979743855;5042.672226305279;5049.192129259319;5060.165072762989;5063.6202284828605;5064.1390963536105;4816.951830481686;4842.5157484251295;4854.951450485485;4988.02733466974;5020.523050310233;4886.53577910098;4905.2887331337115;4915.655904086715;4920.0651876143775;4922.630802689812;4857.902841943177;4864.124457597666;4881.8535443936735;4888;4895;5306.92039619406;5326;5359.5444387227135;5371.248025276464;5393.946060539383;5731;5734.655920644775;5752.28096487939;5823.242978412779;5825.970870145622;5844.503217226541;5848.41515848416;5850.736716847752;5867.413258674141;5867.647941123546;5289.3652761668845;5336.973315133399;5375.139977603565;5395.163749618776;5462.071447853875;5913.02435098204;5973;6003.669798161143;6005.159277701126;6065.8180254592435;5738.167965644958;5738.368779434259;5750.25246717924;5751.252337196222;5752.165935939265;5580.19087232349;5622.606417550732;5741.684207368551;5807.883842323215;5822.359540450547;5780.132980053026;5813.360530341659;5826.65040097587;5879.853003674857;5897.144913987448;5826.038703613856;5835.44563266489;5837.387074357216;5841.591088623755;5910.34986151523;4367.30123180296;4400.867973960786;4417.1828211780285;4499.257622492318;4501.459824820977;3928.0965377962657;3932.8820135395986;3978.5424676162033;3986.282469155522;4011.3180759270995;5406.053940560386;5433.239346491494;5446.754896029688;5471.781128754885;5475.863103422446;5639.069553523705;5718.771249150071;5721.113227449752;5754.136879468113;5769.624974376652;5340.145576707708;5408.8377348679605;5434.049041417736;5459.972700136474;5510.201020851954;4922.433920099163;4938.111464221383;4941.061198372297;4944.90110197794;4996.850094497171;5915.171875937286;5917.053271476543;5919.4080591940465;5921.970390148022;5926.851828704231;5723.399043100581;5769.826905192851;5784.363719990713;5791.884162316815;5877.970610146922;5963.91054134197;6007.339192688888;6010.939890601038;6013.759449621966;6013.9699301503215;5630.774769009194;5687.630304030225;5699.601027928005;5702.087665973424;5702.37273899879;5633.2113504110275;5677.3471050829685;5701.315842098975;5761.279840019997;5798.739056742373;5666.688332141772;5670.773169073191;5674.858128546654;5684.8294551163535;5726.856828579319;5621.80323688669;5648.124540696199;5667.206591077335;5668.773249069991;5675.545956323402;5465.152901300305;5469.316335458067;5479.123340265538;5507.972460137674;5578.107502799533;5593;5640.746166422603;5642.125470552071;5688.11834165705;5704.286964129484;5477.397486276427;5509.393966663583;5515.696636685021;5525.226468294361;5528.419515950767 23:34:37 INFO - PROCESS | 29976 | |1;ext.html;562.9926791571582;575.9164921086442;606.9059295809149;609.878024395121;616.0420546050889;30916.227094322625;33719.831400843024;34004;34101.48847767282;45286;43124;43752.343714844304;43769.343459848045;43776.781116094375;43780;8910.955445222764;9058.094190580956;9066.229370503515;9068.8639670405;9070.682526111588;8810.911890881072;8885.111488851127;8901.955490222539;8903.332250081237;8905.020447750741;8926.553672316391;8971.596278167466;8973.77565560863;8975.685850995216;8977.416467929565;8863.645454181826;8895.599698013604;8907.198352148305;8908.73273801787;8912.509811960339;8848.601812918434;8911.910880891173;8920.46477211363;8924.152205540464;8926.553672316359;36740.26519469622;38739.03152421184;40485.1902961942;40884.79557602193;41316.793416033026;2883.4521440926364;3392.694657480814;3595.4247320428867;3654.634536546351;3694.649008344203;30710.69289307123;31270;31797.205069873206;31885.840570796998;31953;4172.3532852407625;4271.402003719481;4344.578921076447;4478.93281600773;4541.86374408765;245874;249441;249558;249593;249597;56875.43124568784;57050.42949570451;57092.00355975042;57165.42834571601;57205.71397143071;59536;59653.40346596479;59659;59695.40304596898;59706.40293597095;13822.93088534571;14037;14046.789298160536;14049.086809357359;14065;10378.169746420419;10485.056344928993;10599.735006624896;10625.787484250272;10644.89355106439;15957.44148954781;16844.410445634345;16922.830771692126;17071.317147314217;17109.743353849703;5738.340090889601;5745.68398738065;5838.649681019152;5859.091840764689;5907.350191478934;942.6323733743845;1002.2032484175098;1007.385494848142;1030.8402197659375;1043.1915265669168;31953.20116997047;32129;32327.702197637725;32393;32493.67506324954;1103.4096758234466;1135.8580177477816;1149.6493569461227;1167.9182457227912;1171.5723760827407;15731.921340393454;16649.91675041617;16709.16454177286;16769.580760481087;16793.412230572114;506125;506325;507486;511548;512838;56320;56418.43581564214;56537.71731141318;56605;56774.7161264191;1066.653337665262;1187.8774558042567;1244.0545185658784;1259.389196239823;1277.7189018415934;27951.58072628953;32852.507212391356;32854.671453286115;33063.50404743883;33575.664243357256;47954.28068578905;48303.516964829905;48503;48562;48582.27126593175;396178;400966;401311;401458;402559;33551.23524917237;33595.32809343848;35453.46819797654;40239.396409054476;40486.59513404828;42142.57857421387;45394.77302613466;45695.77152114218;46581;46689.29966050444;38745.22509549737;39404.80297598494;39701;39751.204975900895;41172.176556469305;38321.4251786229;38928.80535597304;38946.2210755789;39467.605323946394;40234.79882600685;33270.667293326755;33734.3253134931;34510;38693.806530967166;39585.60414395819;32625.34749305048;35802;36159;36213.27573448569;36468.45297320595;26987.595186072616;27602.585961211;27767.30581735473;27932.720672793825;28013.439731205668 23:34:37 INFO - PROCESS | 29976 | |2;jquery.html;361.2449979542755;378.53629304102463;380.5224443323629;386.9361555343369;391.9706022048345;14144.646383840396;18165.545861353472;18710.71933920992;18751;20372.286969956054;16606.25271862766;16777.832221677778;16828.242729077192;17188.656226875453;17414.651706965855;4909.803607855682;5148.047611191922;5185.403678576974;5238.292830467895;5243.659162154467;3871.3805791073432;3968.4047392891152;5190.299309593213;5217.530422261995;5239.423663397023;5753.050746626802;5822.563307751914;5834.445727655866;5868.618539794921;5881.3530511643685;5643.520300774439;5765.798197063083;5802.013657678205;5866.061430171173;5872.530197584183;5613.354464236624;5616.98894199044;5619.662820230799;5620.662760234399;5623.353314368859;12905.16116452437;12970.80543791844;13262.801057984138;13294.268815215159;13312.600621981355;2183.1267493002765;2194.7914948079906;2205.514786746913;2241.9215327463626;2739.5890616407696;9243.815123697488;9536.28477864163;9641.614335426575;9818;10051.648192313234;1796.3353559183056;1812.4834422189745;1817.5456135966008;1878.6712325343146;1885.3966730646198;85818.74484928664;85863.99999999937;86071.56964215201;87418.5629071857;87656.56171719101;9925.305228633926;9967;10104.74738131538;10147.49262536885;10685.946570267099;15099.39602415891;15121.621959450882;15133.772993405108;15152.863535234901;15186.924065379824;6967.442604591621;7002.614856182857;7029.789106326818;7301.488895777351;7529.058867641545;6455.903161452582;6496.138900699082;7057.294270572902;7058.823529411806;7082.220955694869;4572.497025327211;4621.745803980746;4646;4690.202665546797;4802.471728109905;1822.2528763207022;1876.91553880073;1931.864769466152;1940.3111895276973;2002.67957126859;709.4848761141765;856.9100244474365;889.755317287751;918.8805455290769;935.9438433694;17124.23592680884;18258.817411825712;20004.49988750264;20447.897760511103;20897.268595599384;941.6986564299358;946.9668561600449;951.8143961927358;978.3933960944261;986.5954958466995;10595.470226488645;11017.614383496699;11057.579961119596;11117.332960022424;11162.330260184415;435114;447727;488573;491301;493055;99051.50474247582;99666.5016674912;101574;104480.99999999849;105649;883.6067949762294;906.5603182456504;938.029139840262;940.4357385568741;953.0088707743869;13858.307084645929;16051.638411310336;16615.50153495397;18174.45476635703;18337.72493412573;42629.786851065546;42812.35781463218;43437;43948.56051439445;45112;55180.724096380865;55538.72230638983;59219.407805921386;59315;60389.396106040134;7180.892286615601;7589.810254743676;7750.7674769756995;7917.614417477033;8351.457155284887;11746.236494627821;12246.693832654255;12249.510019599116;12395.665252295734;13207.933960330136;10943.781124377309;10946.781064378827;11155.498002590066;11470.44163094434;11593.043773837617;10287.53706083213;10575.206859485415;10890.23768336209;11039;11207.71980700489;10893.727656808325;11019.72450688707;11146.554137834395;11164.553417863195;11476.827847582459;7451.478396512409;7560.206178351194;7567.583782891994;7609.733659322119;7738.883916741141;9562.904370956201;10735.892641073802;10966.561337546727;11044.834327484934;11392.145589081018 23:34:37 INFO - PROCESS | 29976 | |3;mootools.html;1299.571141523297;1385.8267716535433;1440.8991370604058;1452.2526586225663;1636.2473262299334;7999.960000199991;8301;8579.871301930469;9286.02496737842;9287.953560232198;8596.140385961417;8891.733248002554;8901.465912045282;9160.954195229031;9163.358564900444;2338.964915526264;2352.5530149271667;2355.646653002046;2376.58409778289;2380.8928598213124;2042.6527490326605;2104.084723145429;2310.6187479065934;2335.8948847301913;2353.1646265575732;2265.8980345884393;2328.976710232893;2336.88315584221;2345.6364263539094;2352.2590384029063;2332.8483648562874;2332.8600283983014;2347.460084180648;2354.917577884783;2360.846544974588;2334.5914464968564;2339.3449834046496;2339.4502291961376;2345.3081341004445;2379.595468770296;9122.22461090808;9193.264538836944;9194.586243619053;9195.724128276095;9197.678081267124;4836.830710925101;4920.360353154103;4972.403311602631;4977.1538838397555;4983.750812459399;3288.704016638514;3450.8274586270586;3513.4729790531624;3516.472529120627;3531.2407832315916;1113.8551988241477;1157.6411312493153;1161.169763619008;1180.2977228549084;1183.8993685536739;12516.06129540279;12614;12650.936745316214;12665.176763510342;12672.049596280223;4272.6795490338345;4475.85159123616;4630.907381852344;4670.439547254351;4695.060987802453;10526.789464210673;10542.209334299958;10551.94724026375;10552.630657926935;10574.841377379345;5012.198048312325;5014.17266151081;5029.7736601852275;5057.8229761958155;5069.543741063322;4575.084983003413;4598.609118224988;4675.3220782986955;4708.293755936637;4709.434867815884;3896.279188350164;3901.4733011043713;3933.9968308081257;3941.763494190358;4006.4991876015497;1173.3605185174101;1237.5297386992886;1271.9554815581596;1276.2852802430668;1298.6300002495295;756.4440136499668;926.073926073926;935.2845073518764;939.2439086535268;968.733598260484;6052.515798736179;6132.141500189977;6158.199434073542;6206.503479721701;6339.144215530844;901.9729408117767;912.7581190984395;937.095702646949;942.6889126588346;951.4434056077134;4180.665546756252;4202.894927626772;4238.046439551138;4293;4303.289957157097;10864.076553492883;11302.660920172408;11315.773684526263;11317.773644527064;11324.32054076758;10689.198310126772;11187.4965626547;11190.94404527972;11223.775524489465;11258.155638327158;7787.610619469004;7890.684372625031;7973.401994850294;7974.760757177294;7978.3218426434405;5902.822915312548;5916.674582897982;6025.457708806229;6119.357467465852;6339.492840572835;10011.799764004825;10295.53670084833;10476.319039262424;10488.05607495329;10693.9465302673;10688.41213733221;10689.572417103229;10729.839052414063;10799.298045627009;10825.67522974312;7535.095788505414;7599.202083781123;7620.80947976305;7852.175521570153;7938.960305198668;8676.045634980273;8698.173673501007;8706;8722.171393717586;8724.520151391735;7463.104427468738;7466.514676546007;7494.70021199146;7749.186335434923;8100.2304781045705;7471.439642026761;7565.962170189334;7593.240675932362;7605.467617266738;7662.11885633137;7004;7092.148942126978;7103.928960710534;7106.751263705745;7115.501914865909;5069.695818250917;5142.948570514247;5159.974200128975;5214.608904332266;5456.399796022355;5183.704073981505;5221.112410890082;5233.319668443078;5367.543758780547;5516.255305533701 23:34:37 INFO - PROCESS | 29976 | |4;prototype.html;299.11909426738254;309.6686545396426;313.1966505912333;316.52205170193;316.60108263587887;5077.416097148829;5238.3713954325485;5239.423663397033;5325.760340784665;5333.906549157418;5041.269015992679;5171.388448833343;5199.740012999345;5208.479152084789;5210.5310522053005;4075.7962101894936;4081.4081958116053;4092.9590704093025;4109.21924834282;4123.587641235882;3896.8246428910625;4043.433919251307;4097.160082183145;4118.423420721101;4141.855035073773;3999.3800960851113;4013.1171142348635;4024;4030.879073627781;4043.6967227457912;3997.541511970132;4004.6195611417015;4011.7191796574252;4011.799410029487;4039.2931237033404;3450.3099380124077;3525.735569832247;3549.7515173937836;3555.6444355564236;3589.300086483137;5135.768890399941;5140.460251673595;5146.691198528063;5150.815312478114;5165.1219292720325;4659.510751371125;4660.650451216173;4663.790129444184;4668.509806470306;4670.416197975253;5378.193271009341;5440.123157510652;5506.284183056217;5519.199716041192;5572.972135139298;3845.4231865220163;3860.4365232081054;3867.1298957734284;3874.3607304794955;3876.3604005339084;5645.689487078209;5718.085106382959;5735.426457354273;5752.36723960364;5795.275590551181;3782.508273924372;3967.5518435770737;3971.5035620547433;3977.6817854571564;3979.3633018716864;4016.6184212499766;4016.879493615196;4019.658329042064;4035.959640403617;4037.333839916381;4638.652101092432;4640.23671005016;4659.370984916993;4664.533546645376;4670.7664616769025;5355.250264962909;5505.201745746845;5555.2778138841695;5576.219329293902;5627.184058311522;1311.1608570514877;1321.5903070048316;1378.7793952967477;1410.985890141106;1411.978820317696;901.1574178143456;904.6064961741663;919.2370332623906;919.7378747057056;935.4995077633433;4694.967107236403;4719.622430205575;4735.739534325645;4737.2287211981375;4761.214399624023;4894.437139728905;4946.010797840447;4956.603471722254;4982.007197121108;5046.905534203338;4574.313852922089;4709.340692303081;4724.834630787906;4737.715737055788;4742.905141897143;2602.1803132013356;2633.6436735081447;2636.3409147713073;2644.9420231907006;2650.5229058769605;5003.4746351633285;5059.56993655536;5100.480668338909;5116.616253780981;5129.35838043408;4814.711117332971;4961.82633607822;5018.5985121190215;5043.671177023147;5133.22805684926;5050.636328191368;5077;5088.618353623493;5094.847154585368;5135.820246291362;4891.241857512091;4915.820203151289;4930.531599498042;4965.45380008206;4999.500049994971;4627.583517483308;4884.8046078157895;4911.484294149206;4940.8764780880765;4962.652614316963;5053.772580233972;5056.595472362275;5080.8221712241375;5095.382278582249;5105.987467394255;3696.5748938871297;3713.461548075568;3724.5530536335814;3730.981345093257;3744.831482583236;4798.664093513421;4975.975120124376;4981.75456135966;5032.521910418504;5046.293518907282;4828.7102773833685;4837.903241935212;4855.417349918032;4876.366072410564;4904.94543673112;4768.904621907473;4861.319415281934;4884.65807393479;4885.682430641997;4887;4743.525647435229;4786.018866132365;4787.569118779187;4826.00787511745;5095.490450955023;5577.135543990688;5589.441055894378;5593.272874526286;5595.972020139873;5600.383957764724;5453.7545810439415;5461.754221059982;5488.204210389391;5521.889562208814;5530.834074977757 23:34:37 INFO - PROCESS | 29976 | |5;yui.html;621.5214285000549;645.3739872323847;682.5665702279058;688.8209065642932;725.3544345532474;14855.257237138141;15940.760888586681;16009.439669611565;16418.42535511256;17034;14450;14783.778243326331;14802.333894974725;14843.628909277273;14853.108813471199;571.971401429929;600.3516202501288;672.9966350168243;696.1889398850333;725.1008749151055;620.2835724737935;634.6636282770139;659.6833519910446;669.1334721535599;707.056080133023;749.0861149397754;774.6552784011118;774.7791879314397;781.527176058485;785.3442375616368;646.1051443750392;694.2918223412116;764.8011517005563;775.4998026273079;776.1539921485607;484.20831939778714;516.4345042178808;518.1528201390715;531.2350215689395;556.1241045353585;14628.634284142876;14646;14651.926740366336;14654.780178297335;14666.56000319992;12655.493780248871;12975.480980760758;13274.203547787067;13427.3957671905;14008.649783755487;12248.142630015902;12336.444859981322;12621.684457888627;12905.548305809345;12979.935100324532;4367.432233809616;4374.300111982099;4456;4457.888552786207;4461.375407442961;77976.03275623263;78324;78841.60579197068;79090;80519.19480805176;10678.252522323362;10720.195985300978;10765.515551800188;10902.454877256265;11215.271007384494;20947;21068;21315.457980924763;21332.680009799864;21346.78653213479;8274.213949674771;8435.746927592181;8545;8685.565721713889;8696.869546956801;4487.730736155841;4576.954230457719;4596.2416201326405;4622.491525932145;4666.066786642685;3579.2125732338845;3619.6561326673923;3652.214773823641;3670.46778217157;3702.81485925708;621.9875602487925;627.4791922704236;628.6950828848005;630.9558330916883;644.7678835619173;570.9828705138852;673.8281738156738;685.4002747595854;687.8950411740092;693.3046860234936;8477.321814254969;8836.381453298336;8841.60212790426;8892.8666070009;9181.357304988587;578.7424596054715;585.0405335250193;616.8427051101941;671.9865602687919;692.6605963078056;4275.772939655993;4572.1770081385;4576.58810707038;4587.954120458753;4640.141573808856;73585.6320718393;74759.62620186973;81069;127625.3618731919;129172;65461;66965.3303466959;106412;106452;109799.45100274448;73884;92893.53553232191;94055;95671.52164239134;97136.51431742938;8306.958465207636;8624;8683.956580217058;8702.347323950602;8751.91248087511;55140.44859551353;55707.164392534956;55911.44088559225;56446;57285.42714572801;78842;80873;81881.59059204666;84136;85082.57458712667;11093.445327733742;11288.774224515628;11342.319460832376;11423.543058277575;11744.236624619372;12772.808407874076;13084.149530280501;13458.394372253077;13548.119372240773;14031.29843507841;12195.695107622381;12277.877221228031;12704.491820327083;12857.292848893401;13049.739005220032;11305.208635395444;11790.764184716429;11875.94062029719;12136.33250171249;12322.815157772462;12069.155159138776;12507.374631268582;12611.87388126107;12628.684282892633;12646;9600.807983840425;9743.366681165702;9851.359661621971;9910.117077755203;9928.950355248178;9698.515074246401;10163.23775716839;10222.693319200138;10311.381317120997;10339.689809305733 23:34:37 INFO - PROCESS | 29976 | __end_tp_report 23:34:37 INFO - PROCESS | 29976 | __start_cc_report 23:34:37 INFO - PROCESS | 29976 | _x_x_mozilla_cycle_collect,920 23:34:37 INFO - PROCESS | 29976 | __end_cc_report 23:34:37 INFO - PROCESS | 29976 | __startTimestamp1475130877944__endTimestamp 23:34:37 INFO - PROCESS | 29976 | 23:34:37 INFO - PROCESS | 29976 | ------- Summary: start ------- 23:34:37 INFO - PROCESS | 29976 | Number of tests: 6 23:34:37 INFO - PROCESS | 29976 | 23:34:37 INFO - PROCESS | 29976 | [#0] dojo.html Cycles:165 Average:5364.82 Median:5525.64 stddev:618.20 (11.2%) stddev-sans-first:591.73 23:34:37 INFO - PROCESS | 29976 | Values: 3005.2 3025.9 3031.3 3063.9 3088.7 5264.6 5336.9 5372.4 5397.6 5409.6 5380.3 5410.9 5428.8 5478.3 5525.6 4647.4 4901.9 4924.9 4968.2 4979.1 5042.7 5049.2 5060.2 5063.6 5064.1 4817.0 4842.5 4855.0 4988.0 5020.5 4886.5 4905.3 4915.7 4920.1 4922.6 4857.9 4864.1 4881.9 4888.0 4895.0 5306.9 5326.0 5359.5 5371.2 5393.9 5731.0 5734.7 5752.3 5823.2 5826.0 5844.5 5848.4 5850.7 5867.4 5867.6 5289.4 5337.0 5375.1 5395.2 5462.1 5913.0 5973.0 6003.7 6005.2 6065.8 5738.2 5738.4 5750.3 5751.3 5752.2 5580.2 5622.6 5741.7 5807.9 5822.4 5780.1 5813.4 5826.7 5879.9 5897.1 5826.0 5835.4 5837.4 5841.6 5910.3 4367.3 4400.9 4417.2 4499.3 4501.5 3928.1 3932.9 3978.5 3986.3 4011.3 5406.1 5433.2 5446.8 5471.8 5475.9 5639.1 5718.8 5721.1 5754.1 5769.6 5340.1 5408.8 5434.0 5460.0 5510.2 4922.4 4938.1 4941.1 4944.9 4996.9 5915.2 5917.1 5919.4 5922.0 5926.9 5723.4 5769.8 5784.4 5791.9 5878.0 5963.9 6007.3 6010.9 6013.8 6014.0 5630.8 5687.6 5699.6 5702.1 5702.4 5633.2 5677.3 5701.3 5761.3 5798.7 5666.7 5670.8 5674.9 5684.8 5726.9 5621.8 5648.1 5667.2 5668.8 5675.5 5465.2 5469.3 5479.1 5508.0 5578.1 5593.0 5640.7 5642.1 5688.1 5704.3 5477.4 5509.4 5515.7 5525.2 5528.4 23:34:37 INFO - PROCESS | 29976 | 23:34:37 INFO - PROCESS | 29976 | [#1] ext.html Cycles:180 Average:54850.86 Median:39726.10 stddev:106272.79 (267.5%) stddev-sans-first:106492.75 23:34:37 INFO - PROCESS | 29976 | Values: 563.0 575.9 606.9 609.9 616.0 30916.2 33719.8 34004.0 34101.5 45286.0 43124.0 43752.3 43769.3 43776.8 43780.0 8911.0 9058.1 9066.2 9068.9 9070.7 8810.9 8885.1 8902.0 8903.3 8905.0 8926.6 8971.6 8973.8 8975.7 8977.4 8863.6 8895.6 8907.2 8908.7 8912.5 8848.6 8911.9 8920.5 8924.2 8926.6 36740.3 38739.0 40485.2 40884.8 41316.8 2883.5 3392.7 3595.4 3654.6 3694.6 30710.7 31270.0 31797.2 31885.8 31953.0 4172.4 4271.4 4344.6 4478.9 4541.9 245874.0 249441.0 249558.0 249593.0 249597.0 56875.4 57050.4 57092.0 57165.4 57205.7 59536.0 59653.4 59659.0 59695.4 59706.4 13822.9 14037.0 14046.8 14049.1 14065.0 10378.2 10485.1 10599.7 10625.8 10644.9 15957.4 16844.4 16922.8 17071.3 17109.7 5738.3 5745.7 5838.6 5859.1 5907.4 942.6 1002.2 1007.4 1030.8 1043.2 31953.2 32129.0 32327.7 32393.0 32493.7 1103.4 1135.9 1149.6 1167.9 1171.6 15731.9 16649.9 16709.2 16769.6 16793.4 506125.0 506325.0 507486.0 511548.0 512838.0 56320.0 56418.4 56537.7 56605.0 56774.7 1066.7 1187.9 1244.1 1259.4 1277.7 27951.6 32852.5 32854.7 33063.5 33575.7 47954.3 48303.5 48503.0 48562.0 48582.3 396178.0 400966.0 401311.0 401458.0 402559.0 33551.2 33595.3 35453.5 40239.4 40486.6 42142.6 45394.8 45695.8 46581.0 46689.3 38745.2 39404.8 39701.0 39751.2 41172.2 38321.4 38928.8 38946.2 39467.6 40234.8 33270.7 33734.3 34510.0 38693.8 39585.6 32625.3 35802.0 36159.0 36213.3 36468.5 26987.6 27602.6 27767.3 27932.7 28013.4 23:34:37 INFO - PROCESS | 29976 | 23:34:37 INFO - PROCESS | 29976 | [#2] jquery.html Cycles:180 Average:28275.67 Median:239275.50 stddev:78395.71 (32.8%) stddev-sans-first:78587.62 23:34:37 INFO - PROCESS | 29976 | Values: 361.2 378.5 380.5 386.9 392.0 14144.6 18165.5 18710.7 18751.0 20372.3 16606.3 16777.8 16828.2 17188.7 17414.7 4909.8 5148.0 5185.4 5238.3 5243.7 3871.4 3968.4 5190.3 5217.5 5239.4 5753.1 5822.6 5834.4 5868.6 5881.4 5643.5 5765.8 5802.0 5866.1 5872.5 5613.4 5617.0 5619.7 5620.7 5623.4 12905.2 12970.8 13262.8 13294.3 13312.6 2183.1 2194.8 2205.5 2241.9 2739.6 9243.8 9536.3 9641.6 9818.0 10051.6 1796.3 1812.5 1817.5 1878.7 1885.4 85818.7 85864.0 86071.6 87418.6 87656.6 9925.3 9967.0 10104.7 10147.5 10685.9 15099.4 15121.6 15133.8 15152.9 15186.9 6967.4 7002.6 7029.8 7301.5 7529.1 6455.9 6496.1 7057.3 7058.8 7082.2 4572.5 4621.7 4646.0 4690.2 4802.5 1822.3 1876.9 1931.9 1940.3 2002.7 709.5 856.9 889.8 918.9 935.9 17124.2 18258.8 20004.5 20447.9 20897.3 941.7 947.0 951.8 978.4 986.6 10595.5 11017.6 11057.6 11117.3 11162.3 435114.0 447727.0 488573.0 491301.0 493055.0 99051.5 99666.5 101574.0 104481.0 105649.0 883.6 906.6 938.0 940.4 953.0 13858.3 16051.6 16615.5 18174.5 18337.7 42629.8 42812.4 43437.0 43948.6 45112.0 55180.7 55538.7 59219.4 59315.0 60389.4 7180.9 7589.8 7750.8 7917.6 8351.5 11746.2 12246.7 12249.5 12395.7 13207.9 10943.8 10946.8 11155.5 11470.4 11593.0 10287.5 10575.2 10890.2 11039.0 11207.7 10893.7 11019.7 11146.6 11164.6 11476.8 7451.5 7560.2 7567.6 7609.7 7738.9 9562.9 10735.9 10966.6 11044.8 11392.1 23:34:37 INFO - PROCESS | 29976 | 23:34:37 INFO - PROCESS | 29976 | [#3] mootools.html Cycles:180 Average:5860.64 Median:4672.88 stddev:3397.16 (72.7%) stddev-sans-first:3389.39 23:34:37 INFO - PROCESS | 29976 | Values: 1299.6 1385.8 1440.9 1452.3 1636.2 8000.0 8301.0 8579.9 9286.0 9288.0 8596.1 8891.7 8901.5 9161.0 9163.4 2339.0 2352.6 2355.6 2376.6 2380.9 2042.7 2104.1 2310.6 2335.9 2353.2 2265.9 2329.0 2336.9 2345.6 2352.3 2332.8 2332.9 2347.5 2354.9 2360.8 2334.6 2339.3 2339.5 2345.3 2379.6 9122.2 9193.3 9194.6 9195.7 9197.7 4836.8 4920.4 4972.4 4977.2 4983.8 3288.7 3450.8 3513.5 3516.5 3531.2 1113.9 1157.6 1161.2 1180.3 1183.9 12516.1 12614.0 12650.9 12665.2 12672.0 4272.7 4475.9 4630.9 4670.4 4695.1 10526.8 10542.2 10551.9 10552.6 10574.8 5012.2 5014.2 5029.8 5057.8 5069.5 4575.1 4598.6 4675.3 4708.3 4709.4 3896.3 3901.5 3934.0 3941.8 4006.5 1173.4 1237.5 1272.0 1276.3 1298.6 756.4 926.1 935.3 939.2 968.7 6052.5 6132.1 6158.2 6206.5 6339.1 902.0 912.8 937.1 942.7 951.4 4180.7 4202.9 4238.0 4293.0 4303.3 10864.1 11302.7 11315.8 11317.8 11324.3 10689.2 11187.5 11190.9 11223.8 11258.2 7787.6 7890.7 7973.4 7974.8 7978.3 5902.8 5916.7 6025.5 6119.4 6339.5 10011.8 10295.5 10476.3 10488.1 10693.9 10688.4 10689.6 10729.8 10799.3 10825.7 7535.1 7599.2 7620.8 7852.2 7939.0 8676.0 8698.2 8706.0 8722.2 8724.5 7463.1 7466.5 7494.7 7749.2 8100.2 7471.4 7566.0 7593.2 7605.5 7662.1 7004.0 7092.1 7103.9 7106.8 7115.5 5069.7 5142.9 5160.0 5214.6 5456.4 5183.7 5221.1 5233.3 5367.5 5516.3 23:34:37 INFO - PROCESS | 29976 | 23:34:37 INFO - PROCESS | 29976 | [#4] prototype.html Cycles:180 Average:4365.89 Median:4858.37 stddev:1252.15 (25.8%) stddev-sans-first:1217.89 23:34:37 INFO - PROCESS | 29976 | Values: 299.1 309.7 313.2 316.5 316.6 5077.4 5238.4 5239.4 5325.8 5333.9 5041.3 5171.4 5199.7 5208.5 5210.5 4075.8 4081.4 4093.0 4109.2 4123.6 3896.8 4043.4 4097.2 4118.4 4141.9 3999.4 4013.1 4024.0 4030.9 4043.7 3997.5 4004.6 4011.7 4011.8 4039.3 3450.3 3525.7 3549.8 3555.6 3589.3 5135.8 5140.5 5146.7 5150.8 5165.1 4659.5 4660.7 4663.8 4668.5 4670.4 5378.2 5440.1 5506.3 5519.2 5573.0 3845.4 3860.4 3867.1 3874.4 3876.4 5645.7 5718.1 5735.4 5752.4 5795.3 3782.5 3967.6 3971.5 3977.7 3979.4 4016.6 4016.9 4019.7 4036.0 4037.3 4638.7 4640.2 4659.4 4664.5 4670.8 5355.3 5505.2 5555.3 5576.2 5627.2 1311.2 1321.6 1378.8 1411.0 1412.0 901.2 904.6 919.2 919.7 935.5 4695.0 4719.6 4735.7 4737.2 4761.2 4894.4 4946.0 4956.6 4982.0 5046.9 4574.3 4709.3 4724.8 4737.7 4742.9 2602.2 2633.6 2636.3 2644.9 2650.5 5003.5 5059.6 5100.5 5116.6 5129.4 4814.7 4961.8 5018.6 5043.7 5133.2 5050.6 5077.0 5088.6 5094.8 5135.8 4891.2 4915.8 4930.5 4965.5 4999.5 4627.6 4884.8 4911.5 4940.9 4962.7 5053.8 5056.6 5080.8 5095.4 5106.0 3696.6 3713.5 3724.6 3731.0 3744.8 4798.7 4976.0 4981.8 5032.5 5046.3 4828.7 4837.9 4855.4 4876.4 4904.9 4768.9 4861.3 4884.7 4885.7 4887.0 4743.5 4786.0 4787.6 4826.0 5095.5 5577.1 5589.4 5593.3 5596.0 5600.4 5453.8 5461.8 5488.2 5521.9 5530.8 23:34:37 INFO - PROCESS | 29976 | 23:34:37 INFO - PROCESS | 29976 | [#5] yui.html Cycles:180 Average:20289.10 Median:517.29 stddev:29564.01 (5715.1%) stddev-sans-first:29610.06 23:34:37 INFO - PROCESS | 29976 | Values: 621.5 645.4 682.6 688.8 725.4 14855.3 15940.8 16009.4 16418.4 17034.0 14450.0 14783.8 14802.3 14843.6 14853.1 572.0 600.4 673.0 696.2 725.1 620.3 634.7 659.7 669.1 707.1 749.1 774.7 774.8 781.5 785.3 646.1 694.3 764.8 775.5 776.2 484.2 516.4 518.2 531.2 556.1 14628.6 14646.0 14651.9 14654.8 14666.6 12655.5 12975.5 13274.2 13427.4 14008.6 12248.1 12336.4 12621.7 12905.5 12979.9 4367.4 4374.3 4456.0 4457.9 4461.4 77976.0 78324.0 78841.6 79090.0 80519.2 10678.3 10720.2 10765.5 10902.5 11215.3 20947.0 21068.0 21315.5 21332.7 21346.8 8274.2 8435.7 8545.0 8685.6 8696.9 4487.7 4577.0 4596.2 4622.5 4666.1 3579.2 3619.7 3652.2 3670.5 3702.8 622.0 627.5 628.7 631.0 644.8 571.0 673.8 685.4 687.9 693.3 8477.3 8836.4 8841.6 8892.9 9181.4 578.7 585.0 616.8 672.0 692.7 4275.8 4572.2 4576.6 4588.0 4640.1 73585.6 74759.6 81069.0 127625.4 129172.0 65461.0 66965.3 106412.0 106452.0 109799.5 73884.0 92893.5 94055.0 95671.5 97136.5 8307.0 8624.0 8684.0 8702.3 8751.9 55140.4 55707.2 55911.4 56446.0 57285.4 78842.0 80873.0 81881.6 84136.0 85082.6 11093.4 11288.8 11342.3 11423.5 11744.2 12772.8 13084.1 13458.4 13548.1 14031.3 12195.7 12277.9 12704.5 12857.3 13049.7 11305.2 11790.8 11875.9 12136.3 12322.8 12069.2 12507.4 12611.9 12628.7 12646.0 9600.8 9743.4 9851.4 9910.1 9929.0 9698.5 10163.2 10222.7 10311.4 10339.7 23:34:37 INFO - PROCESS | 29976 | -------- Summary: end -------- 23:34:37 INFO - PROCESS | 29976 | 23:34:38 INFO - TEST-INFO | 29976: exit 0 23:34:38 INFO - TEST-OK | dromaeo_css | took 1116603ms 23:34:38 INFO - TEST-START | kraken 23:34:38 INFO - operating with platform_type : linux_ 23:34:38 INFO - Initialising browser for kraken test... 23:34:38 INFO - TEST-INFO | started process 30285 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIjYqHH/profile http://localhost:36791/getInfo.html) 23:34:43 INFO - PROCESS | 30285 | __metrics Screen width/height:1600/1200 23:34:43 INFO - PROCESS | 30285 | colorDepth:24 23:34:43 INFO - PROCESS | 30285 | Browser inner width/height: 1024/697 23:34:43 INFO - PROCESS | 30285 | __metrics 23:34:43 INFO - PROCESS | 30285 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:34:43 INFO - PROCESS | 30285 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:34:44 INFO - PROCESS | 30285 | console.error: PushService: 23:34:44 INFO - PROCESS | 30285 | stateChangeProcessEnqueue: Error transitioning state 23:34:44 INFO - PROCESS | 30285 | UnknownError 23:34:45 INFO - TEST-INFO | 30285: exit 0 23:34:45 INFO - Browser initialized. 23:34:45 INFO - Running cycle 1/1 for kraken test... 23:34:45 INFO - TEST-INFO | started process 30369 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIjYqHH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:34:57 INFO - PROCESS | 30369 | RSS: Main: 173940736 23:34:57 INFO - PROCESS | 30369 | 23:34:59 INFO - PROCESS | 30369 | Cycle 1(1): loaded http://localhost:36791/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36791/tests/kraken/driver.html?testName=audio-beat-detection) 23:35:00 INFO - PROCESS | 30369 | RSS: Main: 233713664 23:35:00 INFO - PROCESS | 30369 | 23:35:03 INFO - PROCESS | 30369 | Cycle 1(1): loaded http://localhost:36791/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36791/tests/kraken/driver.html?testName=audio-dft) 23:35:03 INFO - PROCESS | 30369 | RSS: Main: 217120768 23:35:03 INFO - PROCESS | 30369 | 23:35:06 INFO - PROCESS | 30369 | Cycle 1(1): loaded http://localhost:36791/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36791/tests/kraken/driver.html?testName=audio-fft) 23:35:07 INFO - PROCESS | 30369 | RSS: Main: 299323392 23:35:07 INFO - PROCESS | 30369 | 23:35:09 INFO - PROCESS | 30369 | Cycle 1(1): loaded http://localhost:36791/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36791/tests/kraken/driver.html?testName=audio-oscillator) 23:35:10 INFO - PROCESS | 30369 | RSS: Main: 209031168 23:35:10 INFO - PROCESS | 30369 | 23:35:12 INFO - PROCESS | 30369 | Cycle 1(1): loaded http://localhost:36791/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36791/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:35:12 INFO - PROCESS | 30369 | RSS: Main: 213397504 23:35:12 INFO - PROCESS | 30369 | 23:35:15 INFO - PROCESS | 30369 | Cycle 1(1): loaded http://localhost:36791/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36791/tests/kraken/driver.html?testName=imaging-darkroom) 23:35:16 INFO - PROCESS | 30369 | RSS: Main: 249868288 23:35:16 INFO - PROCESS | 30369 | 23:35:19 INFO - PROCESS | 30369 | Cycle 1(1): loaded http://localhost:36791/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36791/tests/kraken/driver.html?testName=imaging-desaturate) 23:35:20 INFO - PROCESS | 30369 | RSS: Main: 248549376 23:35:20 INFO - PROCESS | 30369 | 23:35:23 INFO - PROCESS | 30369 | Cycle 1(1): loaded http://localhost:36791/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36791/tests/kraken/driver.html?testName=json-parse-financial) 23:35:23 INFO - PROCESS | 30369 | RSS: Main: 248733696 23:35:23 INFO - PROCESS | 30369 | 23:35:25 INFO - PROCESS | 30369 | Cycle 1(1): loaded http://localhost:36791/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36791/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:35:26 INFO - PROCESS | 30369 | RSS: Main: 210419712 23:35:26 INFO - PROCESS | 30369 | 23:35:27 INFO - PROCESS | 30369 | Cycle 1(1): loaded http://localhost:36791/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36791/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:35:28 INFO - PROCESS | 30369 | RSS: Main: 217563136 23:35:28 INFO - PROCESS | 30369 | 23:35:30 INFO - PROCESS | 30369 | Cycle 1(1): loaded http://localhost:36791/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36791/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:35:31 INFO - PROCESS | 30369 | RSS: Main: 222613504 23:35:31 INFO - PROCESS | 30369 | 23:35:33 INFO - PROCESS | 30369 | Cycle 1(1): loaded http://localhost:36791/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36791/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:35:34 INFO - PROCESS | 30369 | RSS: Main: 217600000 23:35:34 INFO - PROCESS | 30369 | 23:35:37 INFO - PROCESS | 30369 | Cycle 1(1): loaded http://localhost:36791/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36791/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:35:37 INFO - PROCESS | 30369 | RSS: Main: 221134848 23:35:37 INFO - PROCESS | 30369 | 23:35:39 INFO - PROCESS | 30369 | Cycle 1(1): loaded http://localhost:36791/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36791/tests/kraken/driver.html?testName=ai-astar) 23:35:39 INFO - PROCESS | 30369 | RSS: Main: 273244160 23:35:39 INFO - PROCESS | 30369 | 23:35:39 INFO - PROCESS | 30369 | __start_tp_report 23:35:39 INFO - PROCESS | 30369 | _x_x_mozilla_page_load 23:35:39 INFO - PROCESS | 30369 | _x_x_mozilla_page_load_details 23:35:39 INFO - PROCESS | 30369 | |i|pagename|runs| 23:35:39 INFO - PROCESS | 30369 | |0;ai-astar;109;111;111;110;110;111;112;112;111;111 23:35:39 INFO - PROCESS | 30369 | |1;audio-beat-detection;147;119;117;165;120;123;122;119;167;121 23:35:39 INFO - PROCESS | 30369 | |2;audio-dft;161;161;160;161;160;160;160;161;161;162 23:35:39 INFO - PROCESS | 30369 | |3;audio-fft;76;76;75;111;76;78;77;76;117;77 23:35:39 INFO - PROCESS | 30369 | |4;audio-oscillator;84;82;127;83;83;82;110;83;83;123 23:35:39 INFO - PROCESS | 30369 | |5;imaging-gaussian-blur;117;116;117;117;116;117;116;116;116;117 23:35:39 INFO - PROCESS | 30369 | |6;imaging-darkroom;147;149;148;150;149;150;148;148;148;148 23:35:39 INFO - PROCESS | 30369 | |7;imaging-desaturate;96;95;95;95;96;96;97;96;95;96 23:35:39 INFO - PROCESS | 30369 | |8;json-parse-financial;51;51;52;52;53;53;53;52;52;53 23:35:39 INFO - PROCESS | 30369 | |9;json-stringify-tinderbox;60;61;61;61;60;60;60;59;60;59 23:35:39 INFO - PROCESS | 30369 | |10;stanford-crypto-aes;79;79;77;81;79;79;82;78;83;79 23:35:39 INFO - PROCESS | 30369 | |11;stanford-crypto-ccm;125;128;138;129;122;131;133;129;152;135 23:35:39 INFO - PROCESS | 30369 | |12;stanford-crypto-pbkdf2;168;165;162;165;165;166;170;165;166;168 23:35:39 INFO - PROCESS | 30369 | |13;stanford-crypto-sha256-iterative;66;65;67;66;65;63;67;63;65;65 23:35:39 INFO - PROCESS | 30369 | __end_tp_report 23:35:39 INFO - PROCESS | 30369 | __start_cc_report 23:35:39 INFO - PROCESS | 30369 | _x_x_mozilla_cycle_collect,1644 23:35:39 INFO - PROCESS | 30369 | __end_cc_report 23:35:39 INFO - PROCESS | 30369 | __startTimestamp1475130939652__endTimestamp 23:35:39 INFO - PROCESS | 30369 | 23:35:39 INFO - PROCESS | 30369 | ------- Summary: start ------- 23:35:39 INFO - PROCESS | 30369 | Number of tests: 14 23:35:39 INFO - PROCESS | 30369 | 23:35:39 INFO - PROCESS | 30369 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:0.92 (0.8%) stddev-sans-first:0.71 23:35:39 INFO - PROCESS | 30369 | Values: 109.0 111.0 111.0 110.0 110.0 111.0 112.0 112.0 111.0 111.0 23:35:39 INFO - PROCESS | 30369 | 23:35:39 INFO - PROCESS | 30369 | [#1] audio-beat-detection Cycles:10 Average:132.00 Median:122.50 stddev:19.86 (16.2%) stddev-sans-first:20.30 23:35:39 INFO - PROCESS | 30369 | Values: 147.0 119.0 117.0 165.0 120.0 123.0 122.0 119.0 167.0 121.0 23:35:39 INFO - PROCESS | 30369 | 23:35:39 INFO - PROCESS | 30369 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 23:35:39 INFO - PROCESS | 30369 | Values: 161.0 161.0 160.0 161.0 160.0 160.0 160.0 161.0 161.0 162.0 23:35:39 INFO - PROCESS | 30369 | 23:35:39 INFO - PROCESS | 30369 | [#3] audio-fft Cycles:10 Average:83.90 Median:76.00 stddev:15.95 (21.0%) stddev-sans-first:16.66 23:35:39 INFO - PROCESS | 30369 | Values: 76.0 76.0 75.0 111.0 76.0 78.0 77.0 76.0 117.0 77.0 23:35:39 INFO - PROCESS | 30369 | 23:35:39 INFO - PROCESS | 30369 | [#4] audio-oscillator Cycles:10 Average:94.00 Median:83.00 stddev:18.43 (22.2%) stddev-sans-first:19.19 23:35:39 INFO - PROCESS | 30369 | Values: 84.0 82.0 127.0 83.0 83.0 82.0 110.0 83.0 83.0 123.0 23:35:39 INFO - PROCESS | 30369 | 23:35:39 INFO - PROCESS | 30369 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 23:35:39 INFO - PROCESS | 30369 | Values: 117.0 116.0 117.0 117.0 116.0 117.0 116.0 116.0 116.0 117.0 23:35:39 INFO - PROCESS | 30369 | 23:35:39 INFO - PROCESS | 30369 | [#6] imaging-darkroom Cycles:10 Average:148.50 Median:148.50 stddev:0.97 (0.7%) stddev-sans-first:0.87 23:35:39 INFO - PROCESS | 30369 | Values: 147.0 149.0 148.0 150.0 149.0 150.0 148.0 148.0 148.0 148.0 23:35:39 INFO - PROCESS | 30369 | 23:35:39 INFO - PROCESS | 30369 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 23:35:39 INFO - PROCESS | 30369 | Values: 96.0 95.0 95.0 95.0 96.0 96.0 97.0 96.0 95.0 96.0 23:35:39 INFO - PROCESS | 30369 | 23:35:39 INFO - PROCESS | 30369 | [#8] json-parse-financial Cycles:10 Average:52.20 Median:52.50 stddev:0.79 (1.5%) stddev-sans-first:0.71 23:35:39 INFO - PROCESS | 30369 | Values: 51.0 51.0 52.0 52.0 53.0 53.0 53.0 52.0 52.0 53.0 23:35:39 INFO - PROCESS | 30369 | 23:35:39 INFO - PROCESS | 30369 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:60.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 23:35:39 INFO - PROCESS | 30369 | Values: 60.0 61.0 61.0 61.0 60.0 60.0 60.0 59.0 60.0 59.0 23:35:39 INFO - PROCESS | 30369 | 23:35:39 INFO - PROCESS | 30369 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:79.00 stddev:1.84 (2.3%) stddev-sans-first:1.94 23:35:39 INFO - PROCESS | 30369 | Values: 79.0 79.0 77.0 81.0 79.0 79.0 82.0 78.0 83.0 79.0 23:35:39 INFO - PROCESS | 30369 | 23:35:39 INFO - PROCESS | 30369 | [#11] stanford-crypto-ccm Cycles:10 Average:132.20 Median:132.00 stddev:8.36 (6.3%) stddev-sans-first:8.46 23:35:39 INFO - PROCESS | 30369 | Values: 125.0 128.0 138.0 129.0 122.0 131.0 133.0 129.0 152.0 135.0 23:35:39 INFO - PROCESS | 30369 | 23:35:39 INFO - PROCESS | 30369 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.00 Median:166.00 stddev:2.21 (1.3%) stddev-sans-first:2.22 23:35:39 INFO - PROCESS | 30369 | Values: 168.0 165.0 162.0 165.0 165.0 166.0 170.0 165.0 166.0 168.0 23:35:39 INFO - PROCESS | 30369 | 23:35:39 INFO - PROCESS | 30369 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.20 Median:65.50 stddev:1.40 (2.1%) stddev-sans-first:1.45 23:35:39 INFO - PROCESS | 30369 | Values: 66.0 65.0 67.0 66.0 65.0 63.0 67.0 63.0 65.0 65.0 23:35:39 INFO - PROCESS | 30369 | -------- Summary: end -------- 23:35:39 INFO - PROCESS | 30369 | 23:35:40 INFO - TEST-INFO | 30369: exit 0 23:35:40 INFO - TEST-OK | kraken | took 61920ms 23:35:40 INFO - SUITE-END | took 1178s 23:35:40 INFO - Completed test suite (00:19:38) 23:35:40 INFO - javascript benchmark 23:35:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3005.203621040424, 3025.924351891204, 3031.3028003559175, 3063.9080827575153, 3088.6756890526494, 5264.631475796696, 5336.866578335544, 5372.4090350061515, 5397.568194544437, 5409.621326507141, 5380.300560927084, 5410.864728381793, 5428.782848686058, 5478.315210598676, 5525.640833345829, 4647.387013293709, 4901.877453063684, 4924.876878078059, 4968.180250258703, 4979.053979743855, 5042.672226305279, 5049.192129259319, 5060.165072762989, 5063.6202284828605, 5064.1390963536105, 4816.951830481686, 4842.5157484251295, 4854.951450485485, 4988.02733466974, 5020.523050310233, 4886.53577910098, 4905.2887331337115, 4915.655904086715, 4920.0651876143775, 4922.630802689812, 4857.902841943177, 4864.124457597666, 4881.8535443936735, 4888.0, 4895.0, 5306.92039619406, 5326.0, 5359.5444387227135, 5371.248025276464, 5393.946060539383, 5731.0, 5734.655920644775, 5752.28096487939, 5823.242978412779, 5825.970870145622, 5844.503217226541, 5848.41515848416, 5850.736716847752, 5867.413258674141, 5867.647941123546, 5289.3652761668845, 5336.973315133399, 5375.139977603565, 5395.163749618776, 5462.071447853875, 5913.02435098204, 5973.0, 6003.669798161143, 6005.159277701126, 6065.8180254592435, 5738.167965644958, 5738.368779434259, 5750.25246717924, 5751.252337196222, 5752.165935939265, 5580.19087232349, 5622.606417550732, 5741.684207368551, 5807.883842323215, 5822.359540450547, 5780.132980053026, 5813.360530341659, 5826.65040097587, 5879.853003674857, 5897.144913987448, 5826.038703613856, 5835.44563266489, 5837.387074357216, 5841.591088623755, 5910.34986151523, 4367.30123180296, 4400.867973960786, 4417.1828211780285, 4499.257622492318, 4501.459824820977, 3928.0965377962657, 3932.8820135395986, 3978.5424676162033, 3986.282469155522, 4011.3180759270995, 5406.053940560386, 5433.239346491494, 5446.754896029688, 5471.781128754885, 5475.863103422446, 5639.069553523705, 5718.771249150071, 5721.113227449752, 5754.136879468113, 5769.624974376652, 5340.145576707708, 5408.8377348679605, 5434.049041417736, 5459.972700136474, 5510.201020851954, 4922.433920099163, 4938.111464221383, 4941.061198372297, 4944.90110197794, 4996.850094497171, 5915.171875937286, 5917.053271476543, 5919.4080591940465, 5921.970390148022, 5926.851828704231, 5723.399043100581, 5769.826905192851, 5784.363719990713, 5791.884162316815, 5877.970610146922, 5963.91054134197, 6007.339192688888, 6010.939890601038, 6013.759449621966, 6013.9699301503215, 5630.774769009194, 5687.630304030225, 5699.601027928005, 5702.087665973424, 5702.37273899879, 5633.2113504110275, 5677.3471050829685, 5701.315842098975, 5761.279840019997, 5798.739056742373, 5666.688332141772, 5670.773169073191, 5674.858128546654, 5684.8294551163535, 5726.856828579319, 5621.80323688669, 5648.124540696199, 5667.206591077335, 5668.773249069991, 5675.545956323402, 5465.152901300305, 5469.316335458067, 5479.123340265538, 5507.972460137674, 5578.107502799533, 5593.0, 5640.746166422603, 5642.125470552071, 5688.11834165705, 5704.286964129484, 5477.397486276427, 5509.393966663583, 5515.696636685021, 5525.226468294361, 5528.419515950767], "value": 5321.971696550402, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.9926791571582, 575.9164921086442, 606.9059295809149, 609.878024395121, 616.0420546050889, 30916.227094322625, 33719.831400843024, 34004.0, 34101.48847767282, 45286.0, 43124.0, 43752.343714844304, 43769.343459848045, 43776.781116094375, 43780.0, 8910.955445222764, 9058.094190580956, 9066.229370503515, 9068.8639670405, 9070.682526111588, 8810.911890881072, 8885.111488851127, 8901.955490222539, 8903.332250081237, 8905.020447750741, 8926.553672316391, 8971.596278167466, 8973.77565560863, 8975.685850995216, 8977.416467929565, 8863.645454181826, 8895.599698013604, 8907.198352148305, 8908.73273801787, 8912.509811960339, 8848.601812918434, 8911.910880891173, 8920.46477211363, 8924.152205540464, 8926.553672316359, 36740.26519469622, 38739.03152421184, 40485.1902961942, 40884.79557602193, 41316.793416033026, 2883.4521440926364, 3392.694657480814, 3595.4247320428867, 3654.634536546351, 3694.649008344203, 30710.69289307123, 31270.0, 31797.205069873206, 31885.840570796998, 31953.0, 4172.3532852407625, 4271.402003719481, 4344.578921076447, 4478.93281600773, 4541.86374408765, 245874.0, 249441.0, 249558.0, 249593.0, 249597.0, 56875.43124568784, 57050.42949570451, 57092.00355975042, 57165.42834571601, 57205.71397143071, 59536.0, 59653.40346596479, 59659.0, 59695.40304596898, 59706.40293597095, 13822.93088534571, 14037.0, 14046.789298160536, 14049.086809357359, 14065.0, 10378.169746420419, 10485.056344928993, 10599.735006624896, 10625.787484250272, 10644.89355106439, 15957.44148954781, 16844.410445634345, 16922.830771692126, 17071.317147314217, 17109.743353849703, 5738.340090889601, 5745.68398738065, 5838.649681019152, 5859.091840764689, 5907.350191478934, 942.6323733743845, 1002.2032484175098, 1007.385494848142, 1030.8402197659375, 1043.1915265669168, 31953.20116997047, 32129.0, 32327.702197637725, 32393.0, 32493.67506324954, 1103.4096758234466, 1135.8580177477816, 1149.6493569461227, 1167.9182457227912, 1171.5723760827407, 15731.921340393454, 16649.91675041617, 16709.16454177286, 16769.580760481087, 16793.412230572114, 506125.0, 506325.0, 507486.0, 511548.0, 512838.0, 56320.0, 56418.43581564214, 56537.71731141318, 56605.0, 56774.7161264191, 1066.653337665262, 1187.8774558042567, 1244.0545185658784, 1259.389196239823, 1277.7189018415934, 27951.58072628953, 32852.507212391356, 32854.671453286115, 33063.50404743883, 33575.664243357256, 47954.28068578905, 48303.516964829905, 48503.0, 48562.0, 48582.27126593175, 396178.0, 400966.0, 401311.0, 401458.0, 402559.0, 33551.23524917237, 33595.32809343848, 35453.46819797654, 40239.396409054476, 40486.59513404828, 42142.57857421387, 45394.77302613466, 45695.77152114218, 46581.0, 46689.29966050444, 38745.22509549737, 39404.80297598494, 39701.0, 39751.204975900895, 41172.176556469305, 38321.4251786229, 38928.80535597304, 38946.2210755789, 39467.605323946394, 40234.79882600685, 33270.667293326755, 33734.3253134931, 34510.0, 38693.806530967166, 39585.60414395819, 32625.34749305048, 35802.0, 36159.0, 36213.27573448569, 36468.45297320595, 26987.595186072616, 27602.585961211, 27767.30581735473, 27932.720672793825, 28013.439731205668], "value": 19159.67125933338, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.2449979542755, 378.53629304102463, 380.5224443323629, 386.9361555343369, 391.9706022048345, 14144.646383840396, 18165.545861353472, 18710.71933920992, 18751.0, 20372.286969956054, 16606.25271862766, 16777.832221677778, 16828.242729077192, 17188.656226875453, 17414.651706965855, 4909.803607855682, 5148.047611191922, 5185.403678576974, 5238.292830467895, 5243.659162154467, 3871.3805791073432, 3968.4047392891152, 5190.299309593213, 5217.530422261995, 5239.423663397023, 5753.050746626802, 5822.563307751914, 5834.445727655866, 5868.618539794921, 5881.3530511643685, 5643.520300774439, 5765.798197063083, 5802.013657678205, 5866.061430171173, 5872.530197584183, 5613.354464236624, 5616.98894199044, 5619.662820230799, 5620.662760234399, 5623.353314368859, 12905.16116452437, 12970.80543791844, 13262.801057984138, 13294.268815215159, 13312.600621981355, 2183.1267493002765, 2194.7914948079906, 2205.514786746913, 2241.9215327463626, 2739.5890616407696, 9243.815123697488, 9536.28477864163, 9641.614335426575, 9818.0, 10051.648192313234, 1796.3353559183056, 1812.4834422189745, 1817.5456135966008, 1878.6712325343146, 1885.3966730646198, 85818.74484928664, 85863.99999999937, 86071.56964215201, 87418.5629071857, 87656.56171719101, 9925.305228633926, 9967.0, 10104.74738131538, 10147.49262536885, 10685.946570267099, 15099.39602415891, 15121.621959450882, 15133.772993405108, 15152.863535234901, 15186.924065379824, 6967.442604591621, 7002.614856182857, 7029.789106326818, 7301.488895777351, 7529.058867641545, 6455.903161452582, 6496.138900699082, 7057.294270572902, 7058.823529411806, 7082.220955694869, 4572.497025327211, 4621.745803980746, 4646.0, 4690.202665546797, 4802.471728109905, 1822.2528763207022, 1876.91553880073, 1931.864769466152, 1940.3111895276973, 2002.67957126859, 709.4848761141765, 856.9100244474365, 889.755317287751, 918.8805455290769, 935.9438433694, 17124.23592680884, 18258.817411825712, 20004.49988750264, 20447.897760511103, 20897.268595599384, 941.6986564299358, 946.9668561600449, 951.8143961927358, 978.3933960944261, 986.5954958466995, 10595.470226488645, 11017.614383496699, 11057.579961119596, 11117.332960022424, 11162.330260184415, 435114.0, 447727.0, 488573.0, 491301.0, 493055.0, 99051.50474247582, 99666.5016674912, 101574.0, 104480.99999999849, 105649.0, 883.6067949762294, 906.5603182456504, 938.029139840262, 940.4357385568741, 953.0088707743869, 13858.307084645929, 16051.638411310336, 16615.50153495397, 18174.45476635703, 18337.72493412573, 42629.786851065546, 42812.35781463218, 43437.0, 43948.56051439445, 45112.0, 55180.724096380865, 55538.72230638983, 59219.407805921386, 59315.0, 60389.396106040134, 7180.892286615601, 7589.810254743676, 7750.7674769756995, 7917.614417477033, 8351.457155284887, 11746.236494627821, 12246.693832654255, 12249.510019599116, 12395.665252295734, 13207.933960330136, 10943.781124377309, 10946.781064378827, 11155.498002590066, 11470.44163094434, 11593.043773837617, 10287.53706083213, 10575.206859485415, 10890.23768336209, 11039.0, 11207.71980700489, 10893.727656808325, 11019.72450688707, 11146.554137834395, 11164.553417863195, 11476.827847582459, 7451.478396512409, 7560.206178351194, 7567.583782891994, 7609.733659322119, 7738.883916741141, 9562.904370956201, 10735.892641073802, 10966.561337546727, 11044.834327484934, 11392.145589081018], "value": 8668.98854485769, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1299.571141523297, 1385.8267716535433, 1440.8991370604058, 1452.2526586225663, 1636.2473262299334, 7999.960000199991, 8301.0, 8579.871301930469, 9286.02496737842, 9287.953560232198, 8596.140385961417, 8891.733248002554, 8901.465912045282, 9160.954195229031, 9163.358564900444, 2338.964915526264, 2352.5530149271667, 2355.646653002046, 2376.58409778289, 2380.8928598213124, 2042.6527490326605, 2104.084723145429, 2310.6187479065934, 2335.8948847301913, 2353.1646265575732, 2265.8980345884393, 2328.976710232893, 2336.88315584221, 2345.6364263539094, 2352.2590384029063, 2332.8483648562874, 2332.8600283983014, 2347.460084180648, 2354.917577884783, 2360.846544974588, 2334.5914464968564, 2339.3449834046496, 2339.4502291961376, 2345.3081341004445, 2379.595468770296, 9122.22461090808, 9193.264538836944, 9194.586243619053, 9195.724128276095, 9197.678081267124, 4836.830710925101, 4920.360353154103, 4972.403311602631, 4977.1538838397555, 4983.750812459399, 3288.704016638514, 3450.8274586270586, 3513.4729790531624, 3516.472529120627, 3531.2407832315916, 1113.8551988241477, 1157.6411312493153, 1161.169763619008, 1180.2977228549084, 1183.8993685536739, 12516.06129540279, 12614.0, 12650.936745316214, 12665.176763510342, 12672.049596280223, 4272.6795490338345, 4475.85159123616, 4630.907381852344, 4670.439547254351, 4695.060987802453, 10526.789464210673, 10542.209334299958, 10551.94724026375, 10552.630657926935, 10574.841377379345, 5012.198048312325, 5014.17266151081, 5029.7736601852275, 5057.8229761958155, 5069.543741063322, 4575.084983003413, 4598.609118224988, 4675.3220782986955, 4708.293755936637, 4709.434867815884, 3896.279188350164, 3901.4733011043713, 3933.9968308081257, 3941.763494190358, 4006.4991876015497, 1173.3605185174101, 1237.5297386992886, 1271.9554815581596, 1276.2852802430668, 1298.6300002495295, 756.4440136499668, 926.073926073926, 935.2845073518764, 939.2439086535268, 968.733598260484, 6052.515798736179, 6132.141500189977, 6158.199434073542, 6206.503479721701, 6339.144215530844, 901.9729408117767, 912.7581190984395, 937.095702646949, 942.6889126588346, 951.4434056077134, 4180.665546756252, 4202.894927626772, 4238.046439551138, 4293.0, 4303.289957157097, 10864.076553492883, 11302.660920172408, 11315.773684526263, 11317.773644527064, 11324.32054076758, 10689.198310126772, 11187.4965626547, 11190.94404527972, 11223.775524489465, 11258.155638327158, 7787.610619469004, 7890.684372625031, 7973.401994850294, 7974.760757177294, 7978.3218426434405, 5902.822915312548, 5916.674582897982, 6025.457708806229, 6119.357467465852, 6339.492840572835, 10011.799764004825, 10295.53670084833, 10476.319039262424, 10488.05607495329, 10693.9465302673, 10688.41213733221, 10689.572417103229, 10729.839052414063, 10799.298045627009, 10825.67522974312, 7535.095788505414, 7599.202083781123, 7620.80947976305, 7852.175521570153, 7938.960305198668, 8676.045634980273, 8698.173673501007, 8706.0, 8722.171393717586, 8724.520151391735, 7463.104427468738, 7466.514676546007, 7494.70021199146, 7749.186335434923, 8100.2304781045705, 7471.439642026761, 7565.962170189334, 7593.240675932362, 7605.467617266738, 7662.11885633137, 7004.0, 7092.148942126978, 7103.928960710534, 7106.751263705745, 7115.501914865909, 5069.695818250917, 5142.948570514247, 5159.974200128975, 5214.608904332266, 5456.399796022355, 5183.704073981505, 5221.112410890082, 5233.319668443078, 5367.543758780547, 5516.255305533701], "value": 4651.989437289274, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.11909426738254, 309.6686545396426, 313.1966505912333, 316.52205170193, 316.60108263587887, 5077.416097148829, 5238.3713954325485, 5239.423663397033, 5325.760340784665, 5333.906549157418, 5041.269015992679, 5171.388448833343, 5199.740012999345, 5208.479152084789, 5210.5310522053005, 4075.7962101894936, 4081.4081958116053, 4092.9590704093025, 4109.21924834282, 4123.587641235882, 3896.8246428910625, 4043.433919251307, 4097.160082183145, 4118.423420721101, 4141.855035073773, 3999.3800960851113, 4013.1171142348635, 4024.0, 4030.879073627781, 4043.6967227457912, 3997.541511970132, 4004.6195611417015, 4011.7191796574252, 4011.799410029487, 4039.2931237033404, 3450.3099380124077, 3525.735569832247, 3549.7515173937836, 3555.6444355564236, 3589.300086483137, 5135.768890399941, 5140.460251673595, 5146.691198528063, 5150.815312478114, 5165.1219292720325, 4659.510751371125, 4660.650451216173, 4663.790129444184, 4668.509806470306, 4670.416197975253, 5378.193271009341, 5440.123157510652, 5506.284183056217, 5519.199716041192, 5572.972135139298, 3845.4231865220163, 3860.4365232081054, 3867.1298957734284, 3874.3607304794955, 3876.3604005339084, 5645.689487078209, 5718.085106382959, 5735.426457354273, 5752.36723960364, 5795.275590551181, 3782.508273924372, 3967.5518435770737, 3971.5035620547433, 3977.6817854571564, 3979.3633018716864, 4016.6184212499766, 4016.879493615196, 4019.658329042064, 4035.959640403617, 4037.333839916381, 4638.652101092432, 4640.23671005016, 4659.370984916993, 4664.533546645376, 4670.7664616769025, 5355.250264962909, 5505.201745746845, 5555.2778138841695, 5576.219329293902, 5627.184058311522, 1311.1608570514877, 1321.5903070048316, 1378.7793952967477, 1410.985890141106, 1411.978820317696, 901.1574178143456, 904.6064961741663, 919.2370332623906, 919.7378747057056, 935.4995077633433, 4694.967107236403, 4719.622430205575, 4735.739534325645, 4737.2287211981375, 4761.214399624023, 4894.437139728905, 4946.010797840447, 4956.603471722254, 4982.007197121108, 5046.905534203338, 4574.313852922089, 4709.340692303081, 4724.834630787906, 4737.715737055788, 4742.905141897143, 2602.1803132013356, 2633.6436735081447, 2636.3409147713073, 2644.9420231907006, 2650.5229058769605, 5003.4746351633285, 5059.56993655536, 5100.480668338909, 5116.616253780981, 5129.35838043408, 4814.711117332971, 4961.82633607822, 5018.5985121190215, 5043.671177023147, 5133.22805684926, 5050.636328191368, 5077.0, 5088.618353623493, 5094.847154585368, 5135.820246291362, 4891.241857512091, 4915.820203151289, 4930.531599498042, 4965.45380008206, 4999.500049994971, 4627.583517483308, 4884.8046078157895, 4911.484294149206, 4940.8764780880765, 4962.652614316963, 5053.772580233972, 5056.595472362275, 5080.8221712241375, 5095.382278582249, 5105.987467394255, 3696.5748938871297, 3713.461548075568, 3724.5530536335814, 3730.981345093257, 3744.831482583236, 4798.664093513421, 4975.975120124376, 4981.75456135966, 5032.521910418504, 5046.293518907282, 4828.7102773833685, 4837.903241935212, 4855.417349918032, 4876.366072410564, 4904.94543673112, 4768.904621907473, 4861.319415281934, 4884.65807393479, 4885.682430641997, 4887.0, 4743.525647435229, 4786.018866132365, 4787.569118779187, 4826.00787511745, 5095.490450955023, 5577.135543990688, 5589.441055894378, 5593.272874526286, 5595.972020139873, 5600.383957764724, 5453.7545810439415, 5461.754221059982, 5488.204210389391, 5521.889562208814, 5530.834074977757], "value": 3968.3849310605738, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.5214285000549, 645.3739872323847, 682.5665702279058, 688.8209065642932, 725.3544345532474, 14855.257237138141, 15940.760888586681, 16009.439669611565, 16418.42535511256, 17034.0, 14450.0, 14783.778243326331, 14802.333894974725, 14843.628909277273, 14853.108813471199, 571.971401429929, 600.3516202501288, 672.9966350168243, 696.1889398850333, 725.1008749151055, 620.2835724737935, 634.6636282770139, 659.6833519910446, 669.1334721535599, 707.056080133023, 749.0861149397754, 774.6552784011118, 774.7791879314397, 781.527176058485, 785.3442375616368, 646.1051443750392, 694.2918223412116, 764.8011517005563, 775.4998026273079, 776.1539921485607, 484.20831939778714, 516.4345042178808, 518.1528201390715, 531.2350215689395, 556.1241045353585, 14628.634284142876, 14646.0, 14651.926740366336, 14654.780178297335, 14666.56000319992, 12655.493780248871, 12975.480980760758, 13274.203547787067, 13427.3957671905, 14008.649783755487, 12248.142630015902, 12336.444859981322, 12621.684457888627, 12905.548305809345, 12979.935100324532, 4367.432233809616, 4374.300111982099, 4456.0, 4457.888552786207, 4461.375407442961, 77976.03275623263, 78324.0, 78841.60579197068, 79090.0, 80519.19480805176, 10678.252522323362, 10720.195985300978, 10765.515551800188, 10902.454877256265, 11215.271007384494, 20947.0, 21068.0, 21315.457980924763, 21332.680009799864, 21346.78653213479, 8274.213949674771, 8435.746927592181, 8545.0, 8685.565721713889, 8696.869546956801, 4487.730736155841, 4576.954230457719, 4596.2416201326405, 4622.491525932145, 4666.066786642685, 3579.2125732338845, 3619.6561326673923, 3652.214773823641, 3670.46778217157, 3702.81485925708, 621.9875602487925, 627.4791922704236, 628.6950828848005, 630.9558330916883, 644.7678835619173, 570.9828705138852, 673.8281738156738, 685.4002747595854, 687.8950411740092, 693.3046860234936, 8477.321814254969, 8836.381453298336, 8841.60212790426, 8892.8666070009, 9181.357304988587, 578.7424596054715, 585.0405335250193, 616.8427051101941, 671.9865602687919, 692.6605963078056, 4275.772939655993, 4572.1770081385, 4576.58810707038, 4587.954120458753, 4640.141573808856, 73585.6320718393, 74759.62620186973, 81069.0, 127625.3618731919, 129172.0, 65461.0, 66965.3303466959, 106412.0, 106452.0, 109799.45100274448, 73884.0, 92893.53553232191, 94055.0, 95671.52164239134, 97136.51431742938, 8306.958465207636, 8624.0, 8683.956580217058, 8702.347323950602, 8751.91248087511, 55140.44859551353, 55707.164392534956, 55911.44088559225, 56446.0, 57285.42714572801, 78842.0, 80873.0, 81881.59059204666, 84136.0, 85082.57458712667, 11093.445327733742, 11288.774224515628, 11342.319460832376, 11423.543058277575, 11744.236624619372, 12772.808407874076, 13084.149530280501, 13458.394372253077, 13548.119372240773, 14031.29843507841, 12195.695107622381, 12277.877221228031, 12704.491820327083, 12857.292848893401, 13049.739005220032, 11305.208635395444, 11790.764184716429, 11875.94062029719, 12136.33250171249, 12322.815157772462, 12069.155159138776, 12507.374631268582, 12611.87388126107, 12628.684282892633, 12646.0, 9600.807983840425, 9743.366681165702, 9851.359661621971, 9910.117077755203, 9928.950355248178, 9698.515074246401, 10163.23775716839, 10222.693319200138, 10311.381317120997, 10339.689809305733], "value": 7142.204782086465, "unit": "score"}], "name": "dromaeo_css", "value": 6989.1843710719095, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 111.0, 111.0, 110.0, 110.0, 111.0, 112.0, 112.0, 111.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 119.0, 117.0, 165.0, 120.0, 123.0, 122.0, 119.0, 167.0, 121.0], "value": 132.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 161.0, 160.0, 160.0, 160.0, 161.0, 161.0, 162.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 111.0, 76.0, 78.0, 77.0, 76.0, 117.0, 77.0], "value": 83.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 127.0, 83.0, 83.0, 82.0, 110.0, 83.0, 83.0, 123.0], "value": 94.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 149.0, 148.0, 150.0, 149.0, 150.0, 148.0, 148.0, 148.0, 148.0], "value": 148.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 97.0, 96.0, 95.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 52.0, 52.0, 53.0, 53.0, 53.0, 52.0, 52.0, 53.0], "value": 52.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 60.0, 60.0, 60.0, 59.0, 60.0, 59.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 77.0, 81.0, 79.0, 79.0, 82.0, 78.0, 83.0, 79.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 128.0, 138.0, 129.0, 122.0, 131.0, 133.0, 129.0, 152.0, 135.0], "value": 132.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 165.0, 162.0, 165.0, 165.0, 166.0, 170.0, 165.0, 166.0, 168.0], "value": 166.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 66.0, 65.0, 63.0, 67.0, 63.0, 65.0, 65.0], "value": 65.2, "unit": "score"}], "name": "kraken", "value": 1497.4, "alertThreshold": 2.0}]} 23:35:40 INFO - Return code: 0 23:35:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:35:40 INFO - # TBPL SUCCESS # 23:35:40 INFO - Running post-action listener: _resource_record_post_action 23:35:40 INFO - [mozharness: 2016-09-29 06:35:40.969299Z] Finished run-tests step (success) 23:35:40 INFO - Running post-run listener: _resource_record_post_run 23:35:41 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393015296; Read time: 12; Write time: 251396 23:35:41 INFO - TinderboxPrint: CPU usage
13.1% 23:35:41 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 23:35:41 INFO - TinderboxPrint: I/O write bytes / time
393,015,296 / 251,396 23:35:41 INFO - TinderboxPrint: CPU idle
8,286.6 (86.8%) 23:35:41 INFO - TinderboxPrint: CPU user
1,203.7 (12.6%) 23:35:41 INFO - TinderboxPrint: Swap in / out
0 / 0 23:35:41 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 103948288; Read time: 0; Write time: 77536 23:35:41 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289067008; Read time: 12; Write time: 173860 23:35:41 INFO - Running post-run listener: _upload_blobber_files 23:35:41 INFO - Blob upload gear active. 23:35:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:35:41 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 23:35:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:35:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:35:42 INFO - (blobuploader) - INFO - Open directory for files ... 23:35:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:35:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:35:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:35:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:35:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:35:42 INFO - (blobuploader) - INFO - Done attempting. 23:35:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:35:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:35:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:35:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:35:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:35:47 INFO - (blobuploader) - INFO - Done attempting. 23:35:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:35:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:35:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:35:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:35:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:35:49 INFO - (blobuploader) - INFO - Done attempting. 23:35:49 INFO - (blobuploader) - INFO - Iteration through files over. 23:35:49 INFO - Return code: 0 23:35:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:35:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:35:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0984a0f43eb45d07cc2f4c581cb32238046418c1fe1529bb6d0dfb809467dd7fe96fd5e4f735db9761c4af0238066513c0d55c9d2e259a1bbbfb788fe15454c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/02cbe25e98fac6a9bd54ca928af5e21d19ffffeba20d485228f7390ab69d0c4548addd6b290053ac963fed39c28478047d6f5877fb5dcceb525369ac3513ab40", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/52e840eb0454d61cd71443a57d460f71c401bba9e5f8255595effdbc486024ebf3c9b5d40134527ea6e811fd8448c0c276d7d0da2a2a769186b04e74f47ac1e6"} 23:35:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:35:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:35:49 INFO - Contents: 23:35:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0984a0f43eb45d07cc2f4c581cb32238046418c1fe1529bb6d0dfb809467dd7fe96fd5e4f735db9761c4af0238066513c0d55c9d2e259a1bbbfb788fe15454c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/02cbe25e98fac6a9bd54ca928af5e21d19ffffeba20d485228f7390ab69d0c4548addd6b290053ac963fed39c28478047d6f5877fb5dcceb525369ac3513ab40", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/52e840eb0454d61cd71443a57d460f71c401bba9e5f8255595effdbc486024ebf3c9b5d40134527ea6e811fd8448c0c276d7d0da2a2a769186b04e74f47ac1e6"} 23:35:49 INFO - Running post-run listener: copy_logs_to_upload_dir 23:35:49 INFO - Copying logs to upload dir... 23:35:49 INFO - mkdir: /builds/slave/test/build/upload/logs 23:35:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.601615 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-09-28 23:35:49.024534) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 23:35:49.028238) ========= 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=836cfdc75598d54cb747368e000001a9-1475127228.629529-1968606689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0984a0f43eb45d07cc2f4c581cb32238046418c1fe1529bb6d0dfb809467dd7fe96fd5e4f735db9761c4af0238066513c0d55c9d2e259a1bbbfb788fe15454c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/02cbe25e98fac6a9bd54ca928af5e21d19ffffeba20d485228f7390ab69d0c4548addd6b290053ac963fed39c28478047d6f5877fb5dcceb525369ac3513ab40", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/52e840eb0454d61cd71443a57d460f71c401bba9e5f8255595effdbc486024ebf3c9b5d40134527ea6e811fd8448c0c276d7d0da2a2a769186b04e74f47ac1e6"} build_url:https://queue.taskcluster.net/v1/task/OmJKwMUVQ2mbzhwfav8yQA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011487 build_url: 'https://queue.taskcluster.net/v1/task/OmJKwMUVQ2mbzhwfav8yQA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0984a0f43eb45d07cc2f4c581cb32238046418c1fe1529bb6d0dfb809467dd7fe96fd5e4f735db9761c4af0238066513c0d55c9d2e259a1bbbfb788fe15454c6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/02cbe25e98fac6a9bd54ca928af5e21d19ffffeba20d485228f7390ab69d0c4548addd6b290053ac963fed39c28478047d6f5877fb5dcceb525369ac3513ab40", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/52e840eb0454d61cd71443a57d460f71c401bba9e5f8255595effdbc486024ebf3c9b5d40134527ea6e811fd8448c0c276d7d0da2a2a769186b04e74f47ac1e6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 23:35:49.057420) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 23:35:49.058045) ========= 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=836cfdc75598d54cb747368e000001a9-1475127228.629529-1968606689 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004539 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 23:35:49.140231) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 23:35:49.140612) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 23:35:49.140975) ========= ========= Total master_lag: 0.34 =========