builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-006 starttime: 1475109352.38 results: success (0) buildid: 20160928170428 builduid: 79d3a3b73ade421fa35e0d9b8799b27d revision: 182fd3e63603ca64d166a08c86a3347af1ff7385 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 17:35:52.384273) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 17:35:52.384740) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 17:35:52.385017) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 17:35:52.400154) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 17:35:52.400854) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1475109103.809288-1054666275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-28 17:35:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-09-28 17:35:52 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113694 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 17:35:52.527792) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 17:35:52.528064) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1475109103.809288-1054666275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016944 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 17:35:52.581540) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 17:35:52.582213) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 182fd3e63603ca64d166a08c86a3347af1ff7385 --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 182fd3e63603ca64d166a08c86a3347af1ff7385 --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=e31afd3c0f0de4e86ebe4d94000001b5-1475109103.809288-1054666275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-28 17:35:52,751 truncating revision to first 12 chars 2016-09-28 17:35:52,752 Setting DEBUG logging. 2016-09-28 17:35:52,752 attempt 1/10 2016-09-28 17:35:52,752 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/182fd3e63603?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-28 17:35:53,518 unpacking tar archive at: fx-team-182fd3e63603/testing/mozharness/ program finished with exit code 0 elapsedTime=1.185469 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 17:35:53.783612) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 17:35:53.783990) ========= script_repo_revision: 182fd3e63603ca64d166a08c86a3347af1ff7385 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 17:35:53.784457) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 17:35:53.784778) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 17:35:53.794222) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-09-28 17:35:53.794525) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1475109103.809288-1054666275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:35:54 INFO - MultiFileLogger online at 20160928 17:35:54 in /builds/slave/test 17:35:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 17:35:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:35:54 INFO - {'append_to_log': False, 17:35:54 INFO - 'base_work_dir': '/builds/slave/test', 17:35:54 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:35:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:35:54 INFO - 'branch': 'Fx-Team-Non-PGO', 17:35:54 INFO - 'buildbot_json_path': 'buildprops.json', 17:35:54 INFO - 'config_files': ('talos/linux_config.py',), 17:35:54 INFO - 'default_actions': ('clobber', 17:35:54 INFO - 'read-buildbot-config', 17:35:54 INFO - 'download-and-extract', 17:35:54 INFO - 'populate-webroot', 17:35:54 INFO - 'create-virtualenv', 17:35:54 INFO - 'install', 17:35:54 INFO - 'run-tests'), 17:35:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:35:54 INFO - 'download_minidump_stackwalk': True, 17:35:54 INFO - 'download_symbols': 'ondemand', 17:35:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:35:54 INFO - 'tooltool.py': '/tools/tooltool.py', 17:35:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:35:54 INFO - '/tools/misc-python/virtualenv.py')}, 17:35:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:35:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:35:54 INFO - 'installer_path': 'installer.exe', 17:35:54 INFO - 'log_level': 'info', 17:35:54 INFO - 'log_name': 'talos', 17:35:54 INFO - 'log_to_console': True, 17:35:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:35:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:35:54 INFO - 'opt_config_files': (), 17:35:54 INFO - 'pip_index': False, 17:35:54 INFO - 'sps_profile': False, 17:35:54 INFO - 'sps_profile_interval': 0, 17:35:54 INFO - 'suite': 'dromaeojs', 17:35:54 INFO - 'system_bits': '32', 17:35:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:35:54 INFO - 'title': 'talos-linux64-ix-006', 17:35:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:35:54 INFO - 'use_talos_json': True, 17:35:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:35:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:35:54 INFO - 'work_dir': 'build'} 17:35:54 INFO - [mozharness: 2016-09-29 00:35:54.064090Z] Running clobber step. 17:35:54 INFO - Running pre-action listener: _resource_record_pre_action 17:35:54 INFO - Running main action method: clobber 17:35:54 INFO - rmtree: /builds/slave/test/build 17:35:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:35:55 INFO - Running post-action listener: _resource_record_post_action 17:35:55 INFO - [mozharness: 2016-09-29 00:35:55.019940Z] Finished clobber step (success) 17:35:55 INFO - [mozharness: 2016-09-29 00:35:55.020040Z] Running read-buildbot-config step. 17:35:55 INFO - Running pre-action listener: _resource_record_pre_action 17:35:55 INFO - Running main action method: read_buildbot_config 17:35:55 INFO - Using buildbot properties: 17:35:55 INFO - { 17:35:55 INFO - "project": "", 17:35:55 INFO - "product": "firefox", 17:35:55 INFO - "script_repo_revision": "production", 17:35:55 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:35:55 INFO - "repository": "", 17:35:55 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 17:35:55 INFO - "buildid": "20160928170428", 17:35:55 INFO - "pgo_build": "False", 17:35:55 INFO - "basedir": "/builds/slave/test", 17:35:55 INFO - "buildnumber": 3356, 17:35:55 INFO - "slavename": "talos-linux64-ix-006", 17:35:55 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:35:55 INFO - "platform": "ubuntu64_hw", 17:35:55 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:35:55 INFO - "branch": "fx-team", 17:35:55 INFO - "repo_path": "integration/fx-team", 17:35:55 INFO - "revision": "182fd3e63603ca64d166a08c86a3347af1ff7385", 17:35:55 INFO - "stage_platform": "linux64", 17:35:55 INFO - "builduid": "79d3a3b73ade421fa35e0d9b8799b27d", 17:35:55 INFO - "slavebuilddir": "test" 17:35:55 INFO - } 17:35:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/KvnrEVyiRI2zvV4li8TF9g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 17:35:55 INFO - Running post-action listener: _resource_record_post_action 17:35:55 INFO - [mozharness: 2016-09-29 00:35:55.022460Z] Finished read-buildbot-config step (success) 17:35:55 INFO - [mozharness: 2016-09-29 00:35:55.022548Z] Running download-and-extract step. 17:35:55 INFO - Running pre-action listener: _resource_record_pre_action 17:35:55 INFO - Running main action method: download_and_extract 17:35:55 INFO - mkdir: /builds/slave/test/build/tests 17:35:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:35:55 INFO - trying https://queue.taskcluster.net/v1/task/KvnrEVyiRI2zvV4li8TF9g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 17:35:55 INFO - Downloading https://queue.taskcluster.net/v1/task/KvnrEVyiRI2zvV4li8TF9g/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 17:35:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KvnrEVyiRI2zvV4li8TF9g/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 17:35:55 INFO - Downloaded 1361 bytes. 17:35:55 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 17:35:55 INFO - Using the following test package requirements: 17:35:55 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 17:35:55 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:35:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:35:55 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:35:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:35:55 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:35:55 INFO - u'jsshell-linux-x86_64.zip'], 17:35:55 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:35:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:35:55 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 17:35:55 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:35:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:35:55 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:35:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:35:55 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:35:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:35:55 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:35:55 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:35:55 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:35:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KvnrEVyiRI2zvV4li8TF9g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 17:35:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KvnrEVyiRI2zvV4li8TF9g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:35:55 INFO - Fetch https://queue.taskcluster.net/v1/task/KvnrEVyiRI2zvV4li8TF9g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 17:35:56 INFO - Expected file size: 20415656 17:35:56 INFO - Content-Encoding None 17:35:56 INFO - Content-Type application/zip 17:35:56 INFO - Http code 200 17:36:00 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 17:36:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KvnrEVyiRI2zvV4li8TF9g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 17:36:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KvnrEVyiRI2zvV4li8TF9g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:36:00 INFO - Fetch https://queue.taskcluster.net/v1/task/KvnrEVyiRI2zvV4li8TF9g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 17:36:01 INFO - Expected file size: 20415656 17:36:01 INFO - Content-Encoding None 17:36:01 INFO - Content-Type application/zip 17:36:01 INFO - Http code 200 17:36:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KvnrEVyiRI2zvV4li8TF9g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 17:36:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KvnrEVyiRI2zvV4li8TF9g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:36:05 INFO - Fetch https://queue.taskcluster.net/v1/task/KvnrEVyiRI2zvV4li8TF9g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 17:36:06 INFO - Expected file size: 14414067 17:36:06 INFO - Content-Encoding None 17:36:06 INFO - Content-Type application/zip 17:36:06 INFO - Http code 200 17:36:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:06 INFO - trying https://queue.taskcluster.net/v1/task/KvnrEVyiRI2zvV4li8TF9g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 17:36:06 INFO - Downloading https://queue.taskcluster.net/v1/task/KvnrEVyiRI2zvV4li8TF9g/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 17:36:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KvnrEVyiRI2zvV4li8TF9g/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 17:36:08 INFO - Downloaded 55739134 bytes. 17:36:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KvnrEVyiRI2zvV4li8TF9g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 17:36:08 INFO - mkdir: /builds/slave/test/properties 17:36:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:36:08 INFO - Writing to file /builds/slave/test/properties/build_url 17:36:08 INFO - Contents: 17:36:08 INFO - build_url:https://queue.taskcluster.net/v1/task/KvnrEVyiRI2zvV4li8TF9g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 17:36:09 INFO - Running post-action listener: _resource_record_post_action 17:36:09 INFO - Running post-action listener: set_extra_try_arguments 17:36:09 INFO - [mozharness: 2016-09-29 00:36:09.601583Z] Finished download-and-extract step (success) 17:36:09 INFO - [mozharness: 2016-09-29 00:36:09.601796Z] Running populate-webroot step. 17:36:09 INFO - Running pre-action listener: _resource_record_pre_action 17:36:09 INFO - Running main action method: populate_webroot 17:36:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:36:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:36:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:36:09 INFO - '--tppagecycles', 17:36:09 INFO - '7'], 17:36:09 INFO - 'tests': ['tsvgm']}}, 17:36:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:36:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:36:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:36:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:36:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:36:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:36:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:09 INFO - 'talos_options': ['--disable-e10s'], 17:36:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:36:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:36:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:09 INFO - 'talos_options': ['--disable-e10s'], 17:36:09 INFO - 'tests': ['damp', 'tps']}, 17:36:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:09 INFO - 'tests': ['damp', 'tps']}, 17:36:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:36:09 INFO - 'tests': ['dromaeo_dom']}, 17:36:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:36:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:36:09 INFO - 'tests': ['basic_compositor_video']}, 17:36:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:36:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:36:09 INFO - 'tests': ['a11yr', 17:36:09 INFO - 'ts_paint', 17:36:09 INFO - 'tpaint', 17:36:09 INFO - 'sessionrestore', 17:36:09 INFO - 'sessionrestore_no_auto_restore', 17:36:09 INFO - 'tabpaint']}, 17:36:09 INFO - 'other-e10s': {'tests': ['a11yr', 17:36:09 INFO - 'ts_paint', 17:36:09 INFO - 'tpaint', 17:36:09 INFO - 'sessionrestore', 17:36:09 INFO - 'sessionrestore_no_auto_restore', 17:36:09 INFO - 'tabpaint']}, 17:36:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:36:09 INFO - 'ts_paint', 17:36:09 INFO - 'tpaint', 17:36:09 INFO - 'sessionrestore', 17:36:09 INFO - 'sessionrestore_no_auto_restore', 17:36:09 INFO - 'tabpaint']}, 17:36:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:36:09 INFO - 'ts_paint', 17:36:09 INFO - 'tpaint', 17:36:09 INFO - 'sessionrestore', 17:36:09 INFO - 'sessionrestore_no_auto_restore', 17:36:09 INFO - 'tabpaint']}, 17:36:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:36:09 INFO - 'tests': ['a11yr', 17:36:09 INFO - 'ts_paint', 17:36:09 INFO - 'tpaint', 17:36:09 INFO - 'sessionrestore', 17:36:09 INFO - 'sessionrestore_no_auto_restore', 17:36:09 INFO - 'tabpaint']}, 17:36:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:36:09 INFO - 'tests': ['a11yr', 17:36:09 INFO - 'ts_paint', 17:36:09 INFO - 'tpaint', 17:36:09 INFO - 'sessionrestore', 17:36:09 INFO - 'sessionrestore_no_auto_restore', 17:36:09 INFO - 'tabpaint']}, 17:36:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:36:09 INFO - 'tests': ['tsvgx', 17:36:09 INFO - 'tsvgr_opacity', 17:36:09 INFO - 'tart', 17:36:09 INFO - 'tscrollx', 17:36:09 INFO - 'cart']}, 17:36:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:36:09 INFO - 'tsvgr_opacity', 17:36:09 INFO - 'tart', 17:36:09 INFO - 'tscrollx', 17:36:09 INFO - 'cart']}, 17:36:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:09 INFO - 'talos_options': ['--disable-e10s'], 17:36:09 INFO - 'tests': ['tp5o']}, 17:36:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:09 INFO - 'tests': ['tp5o']}, 17:36:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:09 INFO - 'talos_options': ['--disable-e10s', 17:36:09 INFO - '--xperf_path', 17:36:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:36:09 INFO - 'tests': ['tp5n']}, 17:36:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:36:09 INFO - 'talos_options': ['--xperf_path', 17:36:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:36:09 INFO - 'tests': ['tp5n']}}, 17:36:09 INFO - 'talos.zip': {'path': '', 17:36:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:36:09 INFO - Running post-action listener: _resource_record_post_action 17:36:09 INFO - [mozharness: 2016-09-29 00:36:09.621843Z] Finished populate-webroot step (success) 17:36:09 INFO - [mozharness: 2016-09-29 00:36:09.621931Z] Running create-virtualenv step. 17:36:09 INFO - Running pre-action listener: _resource_record_pre_action 17:36:09 INFO - Running main action method: create_virtualenv 17:36:09 INFO - Creating virtualenv /builds/slave/test/build/venv 17:36:09 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 17:36:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:36:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:36:09 INFO - Using real prefix '/usr' 17:36:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:36:10 INFO - Installing distribute.............................................................................................................................................................................................done. 17:36:12 INFO - Installing pip.................done. 17:36:12 INFO - Return code: 0 17:36:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:36:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:36:12 INFO - Reading from file tmpfile_stdout 17:36:12 INFO - Output received: 17:36:12 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) 17:36:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:36:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:12 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 0x7f2ba0a3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2862ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285ff60>, '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 0x2860d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28611d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475109103.809288-1054666275', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:36:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:36:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:36:12 INFO - Using env: {'DISPLAY': ':0', 17:36:12 INFO - 'HOME': '/home/cltbld', 17:36:12 INFO - 'LANG': 'en_US.UTF-8', 17:36:12 INFO - 'LANGUAGE': 'en_US:en', 17:36:12 INFO - 'LOGNAME': 'cltbld', 17:36:12 INFO - 'MAIL': '/var/mail/cltbld', 17:36:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:12 INFO - 'MOZ_NO_REMOTE': '1', 17:36:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:12 INFO - 'NO_EM_RESTART': '1', 17:36:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:12 INFO - 'PWD': '/builds/slave/test', 17:36:12 INFO - 'SHELL': '/bin/bash', 17:36:12 INFO - 'SHLVL': '1', 17:36:12 INFO - 'TERM': 'linux', 17:36:12 INFO - 'TMOUT': '86400', 17:36:12 INFO - 'USER': 'cltbld', 17:36:12 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475109103.809288-1054666275', 17:36:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:12 INFO - '_': '/tools/buildbot/bin/python'} 17:36:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:12 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 17:36:12 INFO - Cleaning up... 17:36:12 INFO - Return code: 0 17:36:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:36:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:12 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 0x7f2ba0a3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2862ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285ff60>, '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 0x2860d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28611d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475109103.809288-1054666275', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:36:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:36:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:36:12 INFO - Using env: {'DISPLAY': ':0', 17:36:12 INFO - 'HOME': '/home/cltbld', 17:36:12 INFO - 'LANG': 'en_US.UTF-8', 17:36:12 INFO - 'LANGUAGE': 'en_US:en', 17:36:12 INFO - 'LOGNAME': 'cltbld', 17:36:12 INFO - 'MAIL': '/var/mail/cltbld', 17:36:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:12 INFO - 'MOZ_NO_REMOTE': '1', 17:36:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:12 INFO - 'NO_EM_RESTART': '1', 17:36:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:12 INFO - 'PWD': '/builds/slave/test', 17:36:12 INFO - 'SHELL': '/bin/bash', 17:36:12 INFO - 'SHLVL': '1', 17:36:12 INFO - 'TERM': 'linux', 17:36:12 INFO - 'TMOUT': '86400', 17:36:12 INFO - 'USER': 'cltbld', 17:36:12 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475109103.809288-1054666275', 17:36:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:12 INFO - '_': '/tools/buildbot/bin/python'} 17:36:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:12 INFO - Downloading/unpacking psutil>=3.1.1 17:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:36:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:36:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:36:14 INFO - Installing collected packages: psutil 17:36:14 INFO - Running setup.py install for psutil 17:36:14 INFO - building 'psutil._psutil_linux' extension 17:36:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 17:36:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 17:36:15 INFO - building 'psutil._psutil_posix' extension 17:36:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 17:36:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 17:36:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:36:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:36:15 INFO - Successfully installed psutil 17:36:15 INFO - Cleaning up... 17:36:15 INFO - Return code: 0 17:36:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:36:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:15 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 0x7f2ba0a3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2862ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285ff60>, '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 0x2860d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28611d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475109103.809288-1054666275', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:36:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:36:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:36:15 INFO - Using env: {'DISPLAY': ':0', 17:36:15 INFO - 'HOME': '/home/cltbld', 17:36:15 INFO - 'LANG': 'en_US.UTF-8', 17:36:15 INFO - 'LANGUAGE': 'en_US:en', 17:36:15 INFO - 'LOGNAME': 'cltbld', 17:36:15 INFO - 'MAIL': '/var/mail/cltbld', 17:36:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:15 INFO - 'MOZ_NO_REMOTE': '1', 17:36:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:15 INFO - 'NO_EM_RESTART': '1', 17:36:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:15 INFO - 'PWD': '/builds/slave/test', 17:36:15 INFO - 'SHELL': '/bin/bash', 17:36:15 INFO - 'SHLVL': '1', 17:36:15 INFO - 'TERM': 'linux', 17:36:15 INFO - 'TMOUT': '86400', 17:36:15 INFO - 'USER': 'cltbld', 17:36:15 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475109103.809288-1054666275', 17:36:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:15 INFO - '_': '/tools/buildbot/bin/python'} 17:36:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:36:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:36:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:36:17 INFO - Installing collected packages: mozsystemmonitor 17:36:17 INFO - Running setup.py install for mozsystemmonitor 17:36:17 INFO - Successfully installed mozsystemmonitor 17:36:17 INFO - Cleaning up... 17:36:17 INFO - Return code: 0 17:36:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:17 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 0x7f2ba0a3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2862ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285ff60>, '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 0x2860d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28611d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475109103.809288-1054666275', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:36:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:36:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:36:17 INFO - Using env: {'DISPLAY': ':0', 17:36:17 INFO - 'HOME': '/home/cltbld', 17:36:17 INFO - 'LANG': 'en_US.UTF-8', 17:36:17 INFO - 'LANGUAGE': 'en_US:en', 17:36:17 INFO - 'LOGNAME': 'cltbld', 17:36:17 INFO - 'MAIL': '/var/mail/cltbld', 17:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:17 INFO - 'MOZ_NO_REMOTE': '1', 17:36:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:17 INFO - 'NO_EM_RESTART': '1', 17:36:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:17 INFO - 'PWD': '/builds/slave/test', 17:36:17 INFO - 'SHELL': '/bin/bash', 17:36:17 INFO - 'SHLVL': '1', 17:36:17 INFO - 'TERM': 'linux', 17:36:17 INFO - 'TMOUT': '86400', 17:36:17 INFO - 'USER': 'cltbld', 17:36:17 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475109103.809288-1054666275', 17:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:17 INFO - '_': '/tools/buildbot/bin/python'} 17:36:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:17 INFO - Downloading/unpacking jsonschema==2.5.1 17:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:36:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:19 INFO - Downloading functools32-3.2.3-2.tar.gz 17:36:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:36:20 INFO - warning: no files found matching '*.txt' 17:36:20 INFO - no previously-included directories found matching 'build' 17:36:20 INFO - no previously-included directories found matching 'dist' 17:36:20 INFO - no previously-included directories found matching '.git*' 17:36:20 INFO - Installing collected packages: jsonschema, functools32 17:36:20 INFO - Running setup.py install for functools32 17:36:20 INFO - warning: no files found matching '*.txt' 17:36:20 INFO - no previously-included directories found matching 'build' 17:36:20 INFO - no previously-included directories found matching 'dist' 17:36:20 INFO - no previously-included directories found matching '.git*' 17:36:20 INFO - Successfully installed jsonschema functools32 17:36:20 INFO - Cleaning up... 17:36:20 INFO - Return code: 0 17:36:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:36:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:20 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 0x7f2ba0a3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2862ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285ff60>, '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 0x2860d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28611d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475109103.809288-1054666275', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:36:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:36:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:36:20 INFO - Using env: {'DISPLAY': ':0', 17:36:20 INFO - 'HOME': '/home/cltbld', 17:36:20 INFO - 'LANG': 'en_US.UTF-8', 17:36:20 INFO - 'LANGUAGE': 'en_US:en', 17:36:20 INFO - 'LOGNAME': 'cltbld', 17:36:20 INFO - 'MAIL': '/var/mail/cltbld', 17:36:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:20 INFO - 'MOZ_NO_REMOTE': '1', 17:36:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:20 INFO - 'NO_EM_RESTART': '1', 17:36:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:20 INFO - 'PWD': '/builds/slave/test', 17:36:20 INFO - 'SHELL': '/bin/bash', 17:36:20 INFO - 'SHLVL': '1', 17:36:20 INFO - 'TERM': 'linux', 17:36:20 INFO - 'TMOUT': '86400', 17:36:20 INFO - 'USER': 'cltbld', 17:36:20 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475109103.809288-1054666275', 17:36:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:20 INFO - '_': '/tools/buildbot/bin/python'} 17:36:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:36:20 INFO - Cleaning up... 17:36:20 INFO - Return code: 0 17:36:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:36:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:20 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 0x7f2ba0a3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2862ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285ff60>, '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 0x2860d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28611d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475109103.809288-1054666275', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:36:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:36:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:36:20 INFO - Using env: {'DISPLAY': ':0', 17:36:20 INFO - 'HOME': '/home/cltbld', 17:36:20 INFO - 'LANG': 'en_US.UTF-8', 17:36:20 INFO - 'LANGUAGE': 'en_US:en', 17:36:20 INFO - 'LOGNAME': 'cltbld', 17:36:20 INFO - 'MAIL': '/var/mail/cltbld', 17:36:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:20 INFO - 'MOZ_NO_REMOTE': '1', 17:36:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:20 INFO - 'NO_EM_RESTART': '1', 17:36:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:20 INFO - 'PWD': '/builds/slave/test', 17:36:20 INFO - 'SHELL': '/bin/bash', 17:36:20 INFO - 'SHLVL': '1', 17:36:20 INFO - 'TERM': 'linux', 17:36:20 INFO - 'TMOUT': '86400', 17:36:20 INFO - 'USER': 'cltbld', 17:36:20 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475109103.809288-1054666275', 17:36:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:20 INFO - '_': '/tools/buildbot/bin/python'} 17:36:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:20 INFO - Downloading/unpacking blobuploader==1.2.4 17:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:22 INFO - Downloading blobuploader-1.2.4.tar.gz 17:36:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:36:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:36:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:36:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:36:23 INFO - Downloading docopt-0.6.1.tar.gz 17:36:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:36:23 INFO - Installing collected packages: blobuploader, requests, docopt 17:36:23 INFO - Running setup.py install for blobuploader 17:36:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:36:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:36:23 INFO - Running setup.py install for requests 17:36:23 INFO - Running setup.py install for docopt 17:36:23 INFO - Successfully installed blobuploader requests docopt 17:36:23 INFO - Cleaning up... 17:36:23 INFO - Return code: 0 17:36:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:36:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:23 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 0x7f2ba0a3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2862ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285ff60>, '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 0x2860d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28611d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475109103.809288-1054666275', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:36:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:36:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:36:23 INFO - Using env: {'DISPLAY': ':0', 17:36:23 INFO - 'HOME': '/home/cltbld', 17:36:23 INFO - 'LANG': 'en_US.UTF-8', 17:36:23 INFO - 'LANGUAGE': 'en_US:en', 17:36:23 INFO - 'LOGNAME': 'cltbld', 17:36:23 INFO - 'MAIL': '/var/mail/cltbld', 17:36:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:23 INFO - 'MOZ_NO_REMOTE': '1', 17:36:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:23 INFO - 'NO_EM_RESTART': '1', 17:36:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:23 INFO - 'PWD': '/builds/slave/test', 17:36:23 INFO - 'SHELL': '/bin/bash', 17:36:23 INFO - 'SHLVL': '1', 17:36:23 INFO - 'TERM': 'linux', 17:36:23 INFO - 'TMOUT': '86400', 17:36:23 INFO - 'USER': 'cltbld', 17:36:23 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475109103.809288-1054666275', 17:36:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:23 INFO - '_': '/tools/buildbot/bin/python'} 17:36:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:36:24 INFO - Running setup.py (path:/tmp/pip-ycnlbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:36:24 INFO - Running setup.py (path:/tmp/pip-FFue2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:36:24 INFO - Running setup.py (path:/tmp/pip-k_ci3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:36:24 INFO - Running setup.py (path:/tmp/pip-vmb4KW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:36:24 INFO - Running setup.py (path:/tmp/pip-ZRbxFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:36:24 INFO - Running setup.py (path:/tmp/pip-_o9isH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:36:24 INFO - Running setup.py (path:/tmp/pip-d5yCuE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:36:24 INFO - Running setup.py (path:/tmp/pip-eSQ0k0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:36:24 INFO - Running setup.py (path:/tmp/pip-Z0Me1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:36:24 INFO - Running setup.py (path:/tmp/pip-LWW7F6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:36:24 INFO - Running setup.py (path:/tmp/pip-IslzpH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:36:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:36:24 INFO - Running setup.py (path:/tmp/pip-rmfv28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:36:25 INFO - Running setup.py (path:/tmp/pip-RggshW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:36:25 INFO - Running setup.py (path:/tmp/pip-kjAu0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:36:25 INFO - Running setup.py (path:/tmp/pip-orON2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:36:25 INFO - Running setup.py (path:/tmp/pip-FmetVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:36:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:36:25 INFO - Running setup.py (path:/tmp/pip-kU2sNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:36:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:36:25 INFO - Running setup.py install for manifestparser 17:36:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:36:25 INFO - Running setup.py install for mozcrash 17:36:25 INFO - Running setup.py install for mozdebug 17:36:25 INFO - Running setup.py install for mozdevice 17:36:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:36:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:36:25 INFO - Running setup.py install for mozfile 17:36:25 INFO - Running setup.py install for mozhttpd 17:36:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:36:26 INFO - Running setup.py install for mozinfo 17:36:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:36:26 INFO - Running setup.py install for mozInstall 17:36:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:36:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:36:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:36:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:36:26 INFO - Running setup.py install for mozleak 17:36:26 INFO - Running setup.py install for mozlog 17:36:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:36:26 INFO - Running setup.py install for moznetwork 17:36:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:36:26 INFO - Running setup.py install for mozprocess 17:36:26 INFO - Running setup.py install for mozprofile 17:36:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:36:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:36:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:36:26 INFO - Running setup.py install for mozrunner 17:36:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:36:26 INFO - Running setup.py install for mozscreenshot 17:36:26 INFO - Running setup.py install for moztest 17:36:27 INFO - Running setup.py install for mozversion 17:36:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:36:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:36:27 INFO - Cleaning up... 17:36:27 INFO - Return code: 0 17:36:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:36: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')]} 17:36:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36: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')]} 17:36:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:27 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 0x7f2ba0a3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2862ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285ff60>, '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 0x2860d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28611d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475109103.809288-1054666275', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:36:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 17:36:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:36:27 INFO - Using env: {'DISPLAY': ':0', 17:36:27 INFO - 'HOME': '/home/cltbld', 17:36:27 INFO - 'LANG': 'en_US.UTF-8', 17:36:27 INFO - 'LANGUAGE': 'en_US:en', 17:36:27 INFO - 'LOGNAME': 'cltbld', 17:36:27 INFO - 'MAIL': '/var/mail/cltbld', 17:36:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:27 INFO - 'MOZ_NO_REMOTE': '1', 17:36:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:27 INFO - 'NO_EM_RESTART': '1', 17:36:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:27 INFO - 'PWD': '/builds/slave/test', 17:36:27 INFO - 'SHELL': '/bin/bash', 17:36:27 INFO - 'SHLVL': '1', 17:36:27 INFO - 'TERM': 'linux', 17:36:27 INFO - 'TMOUT': '86400', 17:36:27 INFO - 'USER': 'cltbld', 17:36:27 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475109103.809288-1054666275', 17:36:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:27 INFO - '_': '/tools/buildbot/bin/python'} 17:36:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:36:27 INFO - Running setup.py (path:/tmp/pip-KNBMQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:36:27 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 17:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:36:27 INFO - Running setup.py (path:/tmp/pip-mwbs8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:36:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:36:27 INFO - Running setup.py (path:/tmp/pip-7RUGLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:36:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:36:27 INFO - Running setup.py (path:/tmp/pip-geewMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:36:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:36:27 INFO - Running setup.py (path:/tmp/pip-WtKS0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:36:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 17:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:36:27 INFO - Running setup.py (path:/tmp/pip-hi5Oi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:36:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 17:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:36:27 INFO - Running setup.py (path:/tmp/pip-j4J2mX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:36:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 17:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:36:27 INFO - Running setup.py (path:/tmp/pip-ZT6sfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:36:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 17:36:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:36:27 INFO - Running setup.py (path:/tmp/pip-ndj0mz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:36:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 17:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:36:28 INFO - Running setup.py (path:/tmp/pip-G5cmGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:36:28 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)) 17:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:36:28 INFO - Running setup.py (path:/tmp/pip-5krV2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:36:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 17:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:36:28 INFO - Running setup.py (path:/tmp/pip-3_Hr3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:36:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 17:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:36:28 INFO - Running setup.py (path:/tmp/pip-ozvBrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:36:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 17:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:36:28 INFO - Running setup.py (path:/tmp/pip-cpG8uB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:36:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 17:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:36:28 INFO - Running setup.py (path:/tmp/pip-nKDjCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:36:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 17:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:36:28 INFO - Running setup.py (path:/tmp/pip-iWnOJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:36:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 17:36:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:36:28 INFO - Running setup.py (path:/tmp/pip-TQA4O0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:36:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 17:36:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:36:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:36:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 17:36:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:36:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:36:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:36: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 17:36: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 17:36: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 17:36: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 17:36: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 17:36: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 17:36:30 INFO - Downloading blessings-1.6.tar.gz 17:36:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:36:30 INFO - Installing collected packages: blessings 17:36:30 INFO - Running setup.py install for blessings 17:36:30 INFO - Successfully installed blessings 17:36:30 INFO - Cleaning up... 17:36:30 INFO - Return code: 0 17:36:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:36:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:36:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:36:30 INFO - Reading from file tmpfile_stdout 17:36:30 INFO - Current package versions: 17:36:30 INFO - argparse == 1.2.1 17:36:30 INFO - blessings == 1.6 17:36:30 INFO - blobuploader == 1.2.4 17:36:30 INFO - docopt == 0.6.1 17:36:30 INFO - functools32 == 3.2.3-2 17:36:30 INFO - jsonschema == 2.5.1 17:36:30 INFO - manifestparser == 1.1 17:36:30 INFO - mozInstall == 1.12 17:36:30 INFO - mozcrash == 0.17 17:36:30 INFO - mozdebug == 0.1 17:36:30 INFO - mozdevice == 0.48 17:36:30 INFO - mozfile == 1.2 17:36:30 INFO - mozhttpd == 0.7 17:36:30 INFO - mozinfo == 0.9 17:36:30 INFO - mozleak == 0.1 17:36:30 INFO - mozlog == 3.4 17:36:30 INFO - moznetwork == 0.27 17:36:30 INFO - mozprocess == 0.23 17:36:30 INFO - mozprofile == 0.28 17:36:30 INFO - mozrunner == 6.12 17:36:30 INFO - mozscreenshot == 0.1 17:36:30 INFO - mozsystemmonitor == 0.3 17:36:30 INFO - moztest == 0.7 17:36:30 INFO - mozversion == 1.4 17:36:30 INFO - psutil == 3.1.1 17:36:30 INFO - requests == 1.2.3 17:36:30 INFO - wsgiref == 0.1.2 17:36:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:36:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2ba0a3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2862ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285ff60>, '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 0x2860d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28611d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475109103.809288-1054666275', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:36:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 17:36:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 17:36:30 INFO - Using env: {'DISPLAY': ':0', 17:36:30 INFO - 'HOME': '/home/cltbld', 17:36:30 INFO - 'LANG': 'en_US.UTF-8', 17:36:30 INFO - 'LANGUAGE': 'en_US:en', 17:36:30 INFO - 'LOGNAME': 'cltbld', 17:36:30 INFO - 'MAIL': '/var/mail/cltbld', 17:36:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:30 INFO - 'MOZ_NO_REMOTE': '1', 17:36:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:30 INFO - 'NO_EM_RESTART': '1', 17:36:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:30 INFO - 'PWD': '/builds/slave/test', 17:36:30 INFO - 'SHELL': '/bin/bash', 17:36:30 INFO - 'SHLVL': '1', 17:36:30 INFO - 'TERM': 'linux', 17:36:30 INFO - 'TMOUT': '86400', 17:36:30 INFO - 'USER': 'cltbld', 17:36:30 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475109103.809288-1054666275', 17:36:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:30 INFO - '_': '/tools/buildbot/bin/python'} 17:36:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 17:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 17:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 17:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 17:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 17:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 17:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 17:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 17:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 17:36:31 INFO - Cleaning up... 17:36:31 INFO - Return code: 0 17:36:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:36:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:36:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:36:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:36:31 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 0x7f2ba0a3df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2862ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x285ff60>, '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 0x2860d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28611d0>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1475109103.809288-1054666275', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 17:36:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:36:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:36:31 INFO - Using env: {'DISPLAY': ':0', 17:36:31 INFO - 'HOME': '/home/cltbld', 17:36:31 INFO - 'LANG': 'en_US.UTF-8', 17:36:31 INFO - 'LANGUAGE': 'en_US:en', 17:36:31 INFO - 'LOGNAME': 'cltbld', 17:36:31 INFO - 'MAIL': '/var/mail/cltbld', 17:36:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:31 INFO - 'MOZ_NO_REMOTE': '1', 17:36:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:31 INFO - 'NO_EM_RESTART': '1', 17:36:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:31 INFO - 'PWD': '/builds/slave/test', 17:36:31 INFO - 'SHELL': '/bin/bash', 17:36:31 INFO - 'SHLVL': '1', 17:36:31 INFO - 'TERM': 'linux', 17:36:31 INFO - 'TMOUT': '86400', 17:36:31 INFO - 'USER': 'cltbld', 17:36:31 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475109103.809288-1054666275', 17:36:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:31 INFO - '_': '/tools/buildbot/bin/python'} 17:36:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:36:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:36:31 INFO - Cleaning up... 17:36:31 INFO - Return code: 0 17:36:31 INFO - Running post-action listener: _resource_record_post_action 17:36:31 INFO - Running post-action listener: _start_resource_monitoring 17:36:31 INFO - Starting resource monitoring. 17:36:31 INFO - [mozharness: 2016-09-29 00:36:31.434374Z] Finished create-virtualenv step (success) 17:36:31 INFO - [mozharness: 2016-09-29 00:36:31.434830Z] Running install step. 17:36:31 INFO - Running pre-action listener: _resource_record_pre_action 17:36:31 INFO - Running main action method: install 17:36:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:36:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:36:31 INFO - Reading from file tmpfile_stdout 17:36:31 INFO - Detecting whether we're running mozinstall >=1.0... 17:36:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:36:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:36:31 INFO - Reading from file tmpfile_stdout 17:36:31 INFO - Output received: 17:36:31 INFO - Usage: mozinstall [options] installer 17:36:31 INFO - Options: 17:36:31 INFO - -h, --help show this help message and exit 17:36:31 INFO - -d DEST, --destination=DEST 17:36:31 INFO - Directory to install application into. [default: 17:36:31 INFO - "/builds/slave/test"] 17:36:31 INFO - --app=APP Application being installed. [default: firefox] 17:36:31 INFO - mkdir: /builds/slave/test/build/application 17:36:31 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'] 17:36:31 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 17:36:48 INFO - Reading from file tmpfile_stdout 17:36:48 INFO - Output received: 17:36:48 INFO - /builds/slave/test/build/application/firefox/firefox 17:36:48 INFO - Running post-action listener: _resource_record_post_action 17:36:48 INFO - [mozharness: 2016-09-29 00:36:48.152158Z] Finished install step (success) 17:36:48 INFO - [mozharness: 2016-09-29 00:36:48.152403Z] Running run-tests step. 17:36:48 INFO - Running pre-action listener: _resource_record_pre_action 17:36:48 INFO - Running main action method: run_tests 17:36:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:36:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:36:48 INFO - Python 2.7.3 17:36:48 INFO - Return code: 0 17:36:48 INFO - grabbing minidump binary from tooltool 17:36:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:36:48 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 0x285ff60>, '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 0x2860d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28611d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:36:48 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 17:36:48 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 17:36:48 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 17:36:48 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:36:48 INFO - Return code: 0 17:36:48 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:36:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:36:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:36:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:36:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:36:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KvnrEVyiRI2zvV4li8TF9g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 17:36:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KvnrEVyiRI2zvV4li8TF9g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 17:36:48 INFO - Using env: {'DISPLAY': ':0', 17:36:48 INFO - 'HOME': '/home/cltbld', 17:36:48 INFO - 'LANG': 'en_US.UTF-8', 17:36:48 INFO - 'LANGUAGE': 'en_US:en', 17:36:48 INFO - 'LOGNAME': 'cltbld', 17:36:48 INFO - 'MAIL': '/var/mail/cltbld', 17:36:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:36:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:36:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:48 INFO - 'MOZ_NO_REMOTE': '1', 17:36:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:36:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:36:48 INFO - 'NO_EM_RESTART': '1', 17:36:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:36:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:48 INFO - 'PWD': '/builds/slave/test', 17:36:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:36:48 INFO - 'SHELL': '/bin/bash', 17:36:48 INFO - 'SHLVL': '1', 17:36:48 INFO - 'TERM': 'linux', 17:36:48 INFO - 'TMOUT': '86400', 17:36:48 INFO - 'USER': 'cltbld', 17:36:48 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1475109103.809288-1054666275', 17:36:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:48 INFO - '_': '/tools/buildbot/bin/python'} 17:36:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KvnrEVyiRI2zvV4li8TF9g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 17:36:48 INFO - mozversion application_buildid: 20160928170428 17:36:48 INFO - mozversion application_changeset: 182fd3e63603ca64d166a08c86a3347af1ff7385 17:36:48 INFO - mozversion application_display_name: Nightly 17:36:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:36:48 INFO - mozversion application_name: Firefox 17:36:48 INFO - mozversion application_remotingname: firefox 17:36:48 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 17:36:48 INFO - mozversion application_vendor: Mozilla 17:36:48 INFO - mozversion application_version: 52.0a1 17:36:48 INFO - mozversion platform_buildid: 20160928170428 17:36:48 INFO - mozversion platform_changeset: 182fd3e63603ca64d166a08c86a3347af1ff7385 17:36:48 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 17:36:48 INFO - mozversion platform_version: 52.0a1 17:36:48 INFO - using testdate: 1475109408 17:36:48 INFO - actual date: 1475109408 17:36:48 INFO - starting webserver on 'localhost:33531' 17:36:48 INFO - SUITE-START | Running 2 tests 17:36:48 INFO - TEST-START | dromaeo_css 17:36:48 INFO - operating with platform_type : linux_ 17:36:48 INFO - Initialising browser for dromaeo_css test... 17:36:48 INFO - TEST-INFO | started process 21666 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHEzTJi/profile http://localhost:33531/getInfo.html) 17:36:52 INFO - PROCESS | 21666 | __metrics Screen width/height:1600/1200 17:36:52 INFO - PROCESS | 21666 | colorDepth:24 17:36:52 INFO - PROCESS | 21666 | Browser inner width/height: 1024/697 17:36:52 INFO - PROCESS | 21666 | __metrics 17:36:53 INFO - PROCESS | 21666 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:36:53 INFO - PROCESS | 21666 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:36:53 INFO - PROCESS | 21666 | console.error: PushService: 17:36:53 INFO - PROCESS | 21666 | stateChangeProcessEnqueue: Error transitioning state 17:36:53 INFO - PROCESS | 21666 | UnknownError 17:36:54 INFO - TEST-INFO | 21666: exit 0 17:36:54 INFO - Browser initialized. 17:36:54 INFO - Running cycle 1/1 for dromaeo_css test... 17:36:54 INFO - TEST-INFO | started process 21746 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHEzTJi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:37:06 INFO - PROCESS | 21746 | RSS: Main: 175570944 17:37:06 INFO - PROCESS | 21746 | 17:37:58 INFO - PROCESS | 21746 | 1475109478576 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 17:40:10 INFO - PROCESS | 21746 | Cycle 1(1): loaded http://localhost:33531/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33531/tests/dromaeo/cssquery-ext.html) 17:40:12 INFO - PROCESS | 21746 | RSS: Main: 311144448 17:40:12 INFO - PROCESS | 21746 | 17:43:15 INFO - PROCESS | 21746 | Cycle 1(1): loaded http://localhost:33531/tests/dromaeo/cssquery-ext.html (next: http://localhost:33531/tests/dromaeo/cssquery-jquery.html) 17:43:15 INFO - PROCESS | 21746 | RSS: Main: 277868544 17:43:15 INFO - PROCESS | 21746 | 17:46:17 INFO - PROCESS | 21746 | Cycle 1(1): loaded http://localhost:33531/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33531/tests/dromaeo/cssquery-mootools.html) 17:46:18 INFO - PROCESS | 21746 | RSS: Main: 252006400 17:46:18 INFO - PROCESS | 21746 | 17:49:20 INFO - PROCESS | 21746 | Cycle 1(1): loaded http://localhost:33531/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33531/tests/dromaeo/cssquery-prototype.html) 17:49:21 INFO - PROCESS | 21746 | RSS: Main: 221220864 17:49:21 INFO - PROCESS | 21746 | 17:52:24 INFO - PROCESS | 21746 | Cycle 1(1): loaded http://localhost:33531/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33531/tests/dromaeo/cssquery-yui.html) 17:52:25 INFO - PROCESS | 21746 | RSS: Main: 220233728 17:52:25 INFO - PROCESS | 21746 | 17:55:28 INFO - PROCESS | 21746 | Cycle 1(1): loaded http://localhost:33531/tests/dromaeo/cssquery-yui.html (next: http://localhost:33531/tests/dromaeo/cssquery-dojo.html) 17:55:28 INFO - PROCESS | 21746 | RSS: Main: 308690944 17:55:28 INFO - PROCESS | 21746 | 17:55:28 INFO - PROCESS | 21746 | __start_tp_report 17:55:28 INFO - PROCESS | 21746 | _x_x_mozilla_page_load 17:55:28 INFO - PROCESS | 21746 | _x_x_mozilla_page_load_details 17:55:28 INFO - PROCESS | 21746 | |i|pagename|runs| 17:55:28 INFO - PROCESS | 21746 | |0;dojo.html;2573.7940964722825;2603.3231359846436;2632;2643.3788059805943;2656.5616673248915;4637.304404339351;4721.551452611996;4749.833755818543;4754.976225118874;4765.046990601881;4728.574428301452;4751.999999999991;4754.310624959378;4788.473267940523;4793.880152996177;4355;4387.605115539601;4389.078293558357;4403.141387429452;4480.260756975095;4446.844360447385;4465.665075119363;4471.172833025885;4475.462944446671;4491.6855820092605;4262.808173632194;4323.956760432387;4435.223835828717;4470.8882277942985;4493.146302202571;4348.608625223714;4351.8694439166875;4360.912781744379;4366.4105345778235;4380.474343078851;4358.542353052915;4427.9557204427865;4436.356728274414;4442.2892337225885;4448.777561121931;4743.667943243974;4761.880952976203;4766.189747742857;4766.404199475066;4778.976105119487;4920.532549407801;5096.159133742928;5101.7194054327;5108.565771909392;5158.200478925773;4999.875003124915;5057.671251368686;5068.037072956126;5068.797248110071;5075.492450754932;4729.266963620645;4733.195356789354;4736.597389221886;4736.8578942631775;4740.241561350167;5168.560672342893;5204.9739751301;5224.111900976843;5249.370075590953;5293.073712100444;4948.703077815343;4952.554270115635;5005.249212618136;5011.398632164163;5078.314427552307;5055.721935293521;5076.74616269185;5076.898462030738;5081.110805609003;5135.97432012845;4834.879128021757;4891.853244402602;4996.225585034325;5034.320366750515;5061.417936937226;5009.223570346602;5010.423801262901;5013.348264725562;5013.623978201649;5058.418281897629;4275.46556680415;4275.657947364203;4281.678874084456;4293.97853010733;4330.328799036154;3658.32321020612;3668.2846844864994;3701.148735790783;3708.072981754561;3716.832742526539;4269.829206831754;4290.120525292307;4306.1172459645695;4344.978275108604;4349.673774466928;4991.625628077836;5011.173156429221;5014.52362025607;5015.398152221756;5070.416902056237;4288.764117973541;4292.248856450171;4302.548232435549;4347.108842687241;4356.6732495063;4519.18654642161;4557.521460246693;4591.44902611682;4651.325557794101;4651.906961860744;4675.158471475167;4675.696079754805;4731.243001119942;4733.313669517969;4791.712497250176;5030.773615187252;5085.211792172219;5094.592432605308;5098.082345177903;5157.303763991813;4594.196015697306;4643.883902902319;4688.484266730725;4716.174669432767;4762.095201911626;5000.324956131021;5019.372578427697;5020.47285035066;5026.899462010812;5072.771725272298;5086.847394578169;5087.3386459759995;5090.032893750175;5103.591712663052;5140.30605868203;4769.856904292877;4778.617710583076;4785.282207668738;4791.233402655558;4887.291342755351;4833.613310935047;4836.709797412166;4837.177679794373;4875.439324477588;4907.877303067452;4769.928451073168;4796.544328288807;4800.879978000578;4801.471838097877;4817.662763606514;4760.714357138444;4823.155947709067;4860.781264843161;4890.462049174659;4936.284238785428;4789.976050119727;4818.590419814215;4886.657933944732;4890.510948905223;4892.241702536113 17:55:28 INFO - PROCESS | 21746 | |1;ext.html;550.5100460590074;573.9697243448011;577.091081546564;580.2833500626725;580.9651420914743;27076.323091922688;27846.582301265473;30313.84843075787;30359.39281214377;30362.696373036262;30397;38491.61508384915;39634.8018259909;39719.80140099303;43557.34663980043;7661.655225514837;7786.065672119354;7789.844203115963;7790.922090779105;7791;7683.308502234798;7782.299593036626;7782.571958542278;7782.961085194566;7785.805354866117;7804.492707973964;7836.177201393857;7844.9215507844765;7845.568493732842;7848.2151784821635;7743.845123097534;7764.22357764219;7771.572563509005;7772.300492955605;7775.4168437367425;7704.807379815494;7784.377249820058;7786.377089832857;7789.532628042279;7790.844183116306;38172;38576.61423385758;38616.227675446615;38630.420543691864;38631.61368386336;2871.454423659498;2959.881604735808;2973.7026297370307;2988.2977500287416;3079.7536197104178;27744.861275693493;28492.572611410844;29145.12564623065;29194;29490.557641635394;3471.3230919970615;3542.079059444537;3546.6453354664586;3548.2193917338145;3630.6187850275605;237621.99999999828;237874;238139;238254;238839.80580097163;44984.77507612441;45130;45140;45220;45275.77362113168;32202.35595288081;32930;33080.66919330824;35019;35038.64961350354;13074.280914549601;13165.275909825052;13166.736665266833;13167.53913613019;13187.274699891406;10481.528331225114;10582.788344233073;10598.629047983284;10602.787944241072;10607.310524815863;17663.55841103957;17735.960364557985;17741.580673546086;17750.733738993924;17830.46508604718;6750.063722280824;6786.287439818748;6834;6973.3375329343635;7062.717491300393;758.3364556013488;905.7826121730737;929.2658799548416;947.5641205045756;954.1269738189618;26956.460870782474;27565.17304480869;27621.447571048466;28209.43581128407;28643.28391790222;916.4180745226829;920.5765347939889;952.319091849331;979.637534112383;983.0611765763679;13959.511417100353;14652.633684157769;14843.777343339858;15044.172570508508;15235.314410851539;113608.43195783968;113837;113914;114157;114538.42730786293;49152;49882.25176622353;49899;49904.500954989984;49936.250956235686;1065.9040686337958;1071.0253669161182;1081.3403823667556;1177.6349331707197;1178.9705257368635;27619.86190069037;30690.84654576713;31423.84288078545;31558.368832623677;31714.270078259087;46129.76935115303;46825;46860.76569617267;46871.76564117157;46899.765501172275;337071;337840;338137;338713;340521;22031.33905982823;22767.08931642782;23941.52116957616;24823.379415514755;24971.87514062418;38971.41542876802;40681.1863762729;40802.1839563213;41149.382759259235;41222.1755564881;34958;35388.292234155684;35550.82224588861;35622.28755424929;35747;34499.31001380009;34835.65164348324;35020.47469287912;35230.295394092485;35481.82259088688;28380.432391351645;29395.85302073476;29895.55156672608;35210.647893520734;35389;29974.400511990076;32202.35595288128;32210.516842246918;32730.50904236486;32898.342033158726;24536.263912082664;24648.876755616107;24969.37576560528;25540.74459255458;25581.23256302314 17:55:28 INFO - PROCESS | 21746 | |2;jquery.html;344.7621141412427;362.6989598633134;364.7319220373027;366.69930656861374;383.2870860200029;12255;16418.34326626935;16488.83511164888;16803.495895123135;17751;14674.192919389456;14932.925335373335;15267.465638702648;15832.525024249262;16105.516834494983;4995.5753760930365;5002.574781143607;5151.6908985460805;5187.533122019017;5210.739463026834;3689.966809293389;3853.5183102112237;5069.619778516608;5148.948510514903;5157.7936882524655;3836.040989752562;3897.337452633059;3902.804859757015;3907.433422153786;5476.685595457101;3888.2612303662354;6115.388461153893;6138.570300078952;6138.785142520012;6142.508599312045;5183.429822719498;5268.578513718893;5314.309139811839;5391.29913111293;5398.217258497535;20281;20536.281230156874;20686.482837929023;20903.58192836135;21053.684194737092;1835.2292037344214;1850.3061351993003;1863.5620629152138;2162.48100455891;2231.141010710872;13163;13213.33933303331;13327.933360333232;13461.932690336584;13980.650483737887;1722.5435259656201;1737.8175291594453;1751.9386821461187;1803.1074618064142;1807.6475087357971;46094.76952615249;62931;70480.6475967622;72357;72860;9300.11648893354;9559.426434413957;9568;9679.951600241953;9894.455804930798;13355.666108347368;13364.19814811095;13364.599062028155;13372.73254534904;13379.197248165141;6897.448204143657;6963.4777391695825;7042.894356584656;7080.716771329192;7204.9639751800905;6676.499262555328;6691.765788197487;6800.285969973181;6832.624205668736;6856.760013399507;5939.940600593939;5961.821145365646;6040.879182416327;6083.270007599028;6148.877022459616;1676.5640933357415;1704.8039475460232;1713.2119225156318;1737.3658614605579;1748.9912550437166;694.4132208283992;790.7864876483317;854.6154230596256;901.3735453859636;1009.6920439265947;17119.572010699583;18310.54223644393;18498.445046648623;18771.624567508574;18779.624407511772;908.7001289574424;916.093067862811;920.9447433153898;926.4256161179977;930.6835675870101;9831.508424578742;10175.796484070424;10383.740406489747;10401.947990260152;10402.739931501621;374444;378361;384938;387533;388601;43709.169432240815;76429;77428.61285693536;77858.61070694723;78823.60588197137;872.2019352292708;884.4030279561271;891.9598618062203;896.7175339768082;900.1403659505288;15793.605159871095;15802.76295855586;16387.59031024234;16402.26189821437;16696.081715505763;24440.75559244385;27096.864515677295;29675;35365.82317088398;35888.10279743027;45611.54388456206;45741.771291143334;45747.77126114348;46738;48061.75969120132;6931.68807403658;7019.6841142147705;7200.819979500555;7388.704451822082;7445.702171913063;11023.724406889893;11247.212695111264;11271.943640282074;11334.263272887236;11630.825537617111;9661.71014869555;9947.452890091114;10115;10148.492575371349;10354;9653.131218190396;9742.220622350053;9755.707328780149;9814.65648702292;9841.507924603884;9834.950825246115;10109.140723038625;10295;10321.948390258001;10556.683299501028;7163.8567228656175;7256.673449694671;7359.411247100326;7441.293077157661;7572.924270757222;9666.806663866824;9825.950870245602;9830.4101753895;10007.749806254611;10163.796724065329 17:55:28 INFO - PROCESS | 21746 | |3;mootools.html;1351.7093824827664;1395.0931894268726;1411.9929400352996;1633.2813562032711;1670.9081000544966;7000.859982800341;7249.311315425026;7499.775006749793;8074.677012919484;8104.027516697997;7426;7743.2643898829665;7745.070591529025;7940.40446966477;7948.523088614687;2123.734533183352;2135.4341099608614;2143.5498545305504;2153.633882240023;2159.7192364992607;1832.4411054628333;1897.2505860185288;2092.79072092791;2142.2609199826034;2160;1864.1797609052041;1892.3187652445179;1896;2063.2056658186557;2151.408362700254;2053.9486512837148;2056.0439395680933;2061.4846288427966;2063.9690404643943;2066.60734460452;1999.0604415924493;2007.076744697441;2015.7681866585383;2049.846261530391;2061.8865962372065;7525.661345239422;7566.43251756115;7570.735024274124;7594.126675432341;7594.31651151399;4417.602415782595;4437.5340589237985;4480.126375356806;4492.281235002417;4586.816527338902;2871.7415432610956;2878.064628995585;2963.125877866035;2975.4792911240447;2978.5085460898927;954.5395544816442;984.2175470500969;985.1084768284713;991.4992928571097;996.6113215845826;10695.090917271964;10740.462976851204;10741.731456713567;10757.83863242052;10786.298890572089;3907.257621052048;3977;4128.710990230655;4156.397322388237;4165;9164.816703665889;9170.037146099698;9175.357724959322;9183.77040573991;9199.35604507678;4546.40896683429;4568.680192386501;4569.725816451024;4574.611158051603;4577.496475387705;4083.1629515949157;4138.13099249155;4161.875143745692;4169.3120635094865;4176.853810116692;3534.770239934396;3591.586967498719;3668.486411902336;3680.392735198716;3707.295613833363;1134.4214450630238;1159.8086315757973;1165.6036947437913;1211.3216598704753;1214.392803598201;698.584342316321;816.346922462028;820.782492639451;822.4859462835727;831.476170012888;5018.949810501921;5036.294918711384;5138.306328645585;5164.122099243138;5190.142320005594;387.79059307973944;390.2292971381499;401.19159892816;407.1937563623982;411.0299692725166;3535.1869070114017;3577.2487777567003;3585.31878943;3599.2441587266444;3705.3515634763808;9028;9279;9418.293627977791;9447.811043779224;9507.66723164686;9333.90666093344;9341.439513629068;9345.345825792128;9349.953250233706;9350.158485736316;6911.410375613637;7166.605836679033;7266.237045110293;7375.225601311892;7387.926120738832;4972.0801651694555;5130.51260130287;5237.659552129099;5323.228131920772;5393.595480339069;8922.241609463268;9043.593038313424;9054.909450905407;9073.95463022707;9165.54172291396;8832.735017949472;9114.36199466031;9130.817383652156;9236.399634023766;9239.815203695754;6702.664866756741;6809.965950170217;6829.453643708392;6871.725130994704;6878.415334696607;7421.925780742124;7515.13575938774;7518.624068796647;7523.360514356341;7528.585927773806;6578;6585.473162147113;6626.5030122741955;6689.230738464944;6716.32836716344;6574.8356291093105;6643.269240383457;6762.830929226809;6791.72833086671;6805.945078512838;6197.783077592263;6276.905846412216;6285.120083188449;6286.622802631857;6298.401651843067;4320.092780516126;4373.365861950063;4463.241248987615;4463.4420697412825;4562.954370456253;4427.180971520279;4463.821447142078;4580;4677.953220467888;4715.882102947454 17:55:28 INFO - PROCESS | 21746 | |4;prototype.html;291.5844920987592;295.13819646631833;298.17257111515556;298.467235983769;300.5611806762127;4908.435529914061;4959.1569433196355;4973.229149481836;4983.950160498394;4995.200767877141;4867.2942423348595;4869.050535145648;4886.682365646239;4896.55930966213;4905.779239934202;3834.386498160295;3841.654251117399;3870.3033453978273;3884.475595794574;3884.864029758959;3742.812859357035;3775.9811200943955;3879.642125256166;3886.8639597614088;3896.318144324746;3782.9432558511644;3793.60167182446;3804.9239015219678;3823.4073718573527;3839.9232015359676;3775.8112094395447;3781.5651200112065;3787.110029143163;3793.639604237593;3794.1083845296334;3172.682731726832;3224.9677503224902;3245.9188520286943;3374.4432168692138;3389.3390788796196;4653.278741795028;4655.674102812804;4659.976700116512;4669.7898594562985;4694.906101877978;4269.210196113729;4284.400183974246;4295.463067116611;4317.417148684919;4322.416473776031;4804.279358096279;4914.4839791821705;4941.283513890466;5018.874528136789;5075.847724568232;3644.2529281497227;3659.1583935694675;3662.1577037281572;3678;3687.8524859005606;5267.86740850719;5293.788248470018;5296.602754793406;5336.893262134774;5338.386085600128;3465.653434656514;3603.675669189733;3638.7089032877307;3712.8514859405323;3716.832742526593;3672.7245456590863;3709.7403181777017;3716.8699095532065;3722.4044152935944;3724.2923844469465;4202.663786897041;4229.281022226229;4260.169266992969;4278.443802305743;4285.871423857289;4962.528559786814;5100;5104.693718376835;5114.28400023997;5122.8975420492125;1262.62374012327;1268.898488120948;1276.8850803427736;1277.3421687830776;1278.2041232068957;788.5584072919183;801.2628381888676;819.5001049359886;828.8798124271947;832.7168762620738;3895.824687889052;3931.724779265424;3950.486436763202;3964.2467931093;3968;4557.316402539579;4572.268437050056;4592.862214133581;4614.215583350839;4628.375169352162;3962.841486340514;3966.2067586482817;3969.5511138434263;3998.7200895937585;4009.7594144351433;2326.1509549014486;2454.3678453828006;2467.728549859514;2481.255623312999;2485.6768620079274;4643.628509719214;4706.294055891575;4739.549742774431;4861.714993952836;4862.78117484714;5328.147496400557;5340.946590534123;5342.866428339323;5345.224942383333;5366.302380690485;4715.198416269311;4792.976035119802;4861.416630004422;4862.440819305825;4872.707637541688;5184.274201611702;5201.477283517415;5212.687238765686;5237.973810130925;5243;5153.222138362259;5156.690598564098;5161.690298582097;5169.379674438941;5173.215240741938;4688.507706690748;4834.5890599299455;4835.806567737392;4852;4878.63410244226;3598.370285200132;3626.9274614507035;3631.3826649469124;3637.363461394298;3638.1268495561403;5218.739063046908;5227.3465816772905;5230.476952304739;5233.712145832016;5262.158054711228;4793;5023.572996295356;5035.144025515744;5043.9747801260755;5045.823396181116;4940.777665005012;4946.901061978669;4959.156943319716;4959.950400495949;4963.131451995814;4904.4605093440405;4905.313256144072;4946.579540739078;4947.1342515059005;4950.257461380822;4785.353977213032;5012.872103776621;5015.398152221756;5016.212759366655;5029.516292693737;4926.8568172844925;4951.529604687549;4970.204767237225;4972.5276098770555;4985.675931064469 17:55:28 INFO - PROCESS | 21746 | |5;yui.html;620.8292719502138;670.4569298867917;689.2487188964028;712.7006657203974;750.962451877406;12088.879111208886;13173.473061077546;13248.668783280424;13283.800742988838;13323.467061317548;12438.689032774162;12559.372031398416;12572.24566526009;12586.496540138407;12593;611.0376157551851;630.6972653126502;739.6006156675389;746.9878314883337;773.5706682791049;764.1632412508294;764.9732259370924;766.2146300042446;767.5663250263583;767.6545554500469;811.8863359129726;813.8372325534887;813.9470934389245;814.1451475950258;814.4380377539509;655.554223128275;660.346257205368;666.2804171494774;674.7435974329773;810.1250649298772;492.9580985616191;576.3487259396896;577.4341145677259;589.8731772668854;597.7041364524588;12989.090763646549;13004.609861704164;13034.869651303461;13036.217826930415;13038;11450.828237576443;11680.0655947524;11867.516560429945;12012.69968250792;12255.264684118982;10218.591256349737;10418.062374386265;11485.425728713531;11616.94191529037;11618.94190529042;4024.7786371749544;4029.1538776856896;4114.629683328485;4198.160367926396;4321.092570560186;50157.74921125408;51844.740776296254;51863.222051668876;59270.703646481925;59371.687963684686;9873.901260987299;10146.492675366202;10476.47617619116;10631.30896491741;10647.84028239577;16991.915040424967;17058.317667293417;17076.402325918534;17145.14274286281;17285.56786080358;6878.965605172042;6943.34038266374;6994.370506654425;7135.5361901476235;7240.8913866290995;3656.8902932912056;3766.0961369271176;3784.6404591563755;3790.962090379061;3859.150986782903;2908.2002449326183;3006.864691088906;3020.652624948159;3025.6974302569565;3028.8939887103847;515.9277701121846;518.8676887393691;524.2686452398882;525.5217751845802;526.8524813052352;431.5037706637392;468.39343050749363;546.2025442853399;584.7777844419094;594.4976494861835;7257.709691612276;7267.963660181666;7419.258074192646;7598.164201937782;7696.191899850547;560.2828379674024;564.1227890630109;567.4864247855697;570.4694633990429;575.3785911215961;3331.1505566080978;3642.3261696586214;3683.3001729671814;3704.481372607837;3754.511913451234;60676.08985865216;61611;77176;109546.45226773815;109741;64139;67500.6624966872;89404.55297723469;89829.55085224532;90146.54926725324;54972;59757;61272.693636531534;70587.64706176436;71703.64148179226;7571.810704732426;7767.417443691633;7966.322862556747;8098.3926205536;8133.43065985399;30171.021781405823;32446.675533244364;41882.042411941635;42239.366409503265;42785;38249.808750956065;38909.41635875521;38995.6100438992;51710.22434663558;55916.72041639766;10533;10600.310979786289;10768.19238557127;10786.73033174177;11004.39475828837;11350.148738844784;11671.941640291745;12200.816987745013;12325.075619328765;12542.122051456676;10199.490025498548;10709;11011.229213954946;11327.263727857662;11669.066474682175;10284.485775711035;11074.5570177192;11084.445777711244;11482.885171148182;11495.54017839277;9978.900210997797;11096.334219946506;11155.553777848796;11526.827097593376;11850.881491184979;8585.527795971031;9000.36997410175;9109.817803643757;9151.542422878963;9241.630334786802;9058.36591438593;9490.478023708762;9495.572699228413;9525.380850244712;9591.42451452915 17:55:28 INFO - PROCESS | 21746 | __end_tp_report 17:55:28 INFO - PROCESS | 21746 | __start_cc_report 17:55:28 INFO - PROCESS | 21746 | _x_x_mozilla_cycle_collect,1107 17:55:28 INFO - PROCESS | 21746 | __end_cc_report 17:55:28 INFO - PROCESS | 21746 | __startTimestamp1475110528470__endTimestamp 17:55:28 INFO - PROCESS | 21746 | 17:55:28 INFO - PROCESS | 21746 | ------- Summary: start ------- 17:55:28 INFO - PROCESS | 21746 | Number of tests: 6 17:55:28 INFO - PROCESS | 21746 | 17:55:28 INFO - PROCESS | 21746 | [#0] dojo.html Cycles:165 Average:4670.07 Median:4769.86 stddev:489.25 (10.3%) stddev-sans-first:462.29 17:55:28 INFO - PROCESS | 21746 | Values: 2573.8 2603.3 2632.0 2643.4 2656.6 4637.3 4721.6 4749.8 4755.0 4765.0 4728.6 4752.0 4754.3 4788.5 4793.9 4355.0 4387.6 4389.1 4403.1 4480.3 4446.8 4465.7 4471.2 4475.5 4491.7 4262.8 4324.0 4435.2 4470.9 4493.1 4348.6 4351.9 4360.9 4366.4 4380.5 4358.5 4428.0 4436.4 4442.3 4448.8 4743.7 4761.9 4766.2 4766.4 4779.0 4920.5 5096.2 5101.7 5108.6 5158.2 4999.9 5057.7 5068.0 5068.8 5075.5 4729.3 4733.2 4736.6 4736.9 4740.2 5168.6 5205.0 5224.1 5249.4 5293.1 4948.7 4952.6 5005.2 5011.4 5078.3 5055.7 5076.7 5076.9 5081.1 5136.0 4834.9 4891.9 4996.2 5034.3 5061.4 5009.2 5010.4 5013.3 5013.6 5058.4 4275.5 4275.7 4281.7 4294.0 4330.3 3658.3 3668.3 3701.1 3708.1 3716.8 4269.8 4290.1 4306.1 4345.0 4349.7 4991.6 5011.2 5014.5 5015.4 5070.4 4288.8 4292.2 4302.5 4347.1 4356.7 4519.2 4557.5 4591.4 4651.3 4651.9 4675.2 4675.7 4731.2 4733.3 4791.7 5030.8 5085.2 5094.6 5098.1 5157.3 4594.2 4643.9 4688.5 4716.2 4762.1 5000.3 5019.4 5020.5 5026.9 5072.8 5086.8 5087.3 5090.0 5103.6 5140.3 4769.9 4778.6 4785.3 4791.2 4887.3 4833.6 4836.7 4837.2 4875.4 4907.9 4769.9 4796.5 4800.9 4801.5 4817.7 4760.7 4823.2 4860.8 4890.5 4936.3 4790.0 4818.6 4886.7 4890.5 4892.2 17:55:28 INFO - PROCESS | 21746 | 17:55:28 INFO - PROCESS | 21746 | [#1] ext.html Cycles:180 Average:38741.43 Median:34988.50 stddev:65370.66 (186.8%) stddev-sans-first:65491.15 17:55:28 INFO - PROCESS | 21746 | Values: 550.5 574.0 577.1 580.3 581.0 27076.3 27846.6 30313.8 30359.4 30362.7 30397.0 38491.6 39634.8 39719.8 43557.3 7661.7 7786.1 7789.8 7790.9 7791.0 7683.3 7782.3 7782.6 7783.0 7785.8 7804.5 7836.2 7844.9 7845.6 7848.2 7743.8 7764.2 7771.6 7772.3 7775.4 7704.8 7784.4 7786.4 7789.5 7790.8 38172.0 38576.6 38616.2 38630.4 38631.6 2871.5 2959.9 2973.7 2988.3 3079.8 27744.9 28492.6 29145.1 29194.0 29490.6 3471.3 3542.1 3546.6 3548.2 3630.6 237622.0 237874.0 238139.0 238254.0 238839.8 44984.8 45130.0 45140.0 45220.0 45275.8 32202.4 32930.0 33080.7 35019.0 35038.6 13074.3 13165.3 13166.7 13167.5 13187.3 10481.5 10582.8 10598.6 10602.8 10607.3 17663.6 17736.0 17741.6 17750.7 17830.5 6750.1 6786.3 6834.0 6973.3 7062.7 758.3 905.8 929.3 947.6 954.1 26956.5 27565.2 27621.4 28209.4 28643.3 916.4 920.6 952.3 979.6 983.1 13959.5 14652.6 14843.8 15044.2 15235.3 113608.4 113837.0 113914.0 114157.0 114538.4 49152.0 49882.3 49899.0 49904.5 49936.3 1065.9 1071.0 1081.3 1177.6 1179.0 27619.9 30690.8 31423.8 31558.4 31714.3 46129.8 46825.0 46860.8 46871.8 46899.8 337071.0 337840.0 338137.0 338713.0 340521.0 22031.3 22767.1 23941.5 24823.4 24971.9 38971.4 40681.2 40802.2 41149.4 41222.2 34958.0 35388.3 35550.8 35622.3 35747.0 34499.3 34835.7 35020.5 35230.3 35481.8 28380.4 29395.9 29895.6 35210.6 35389.0 29974.4 32202.4 32210.5 32730.5 32898.3 24536.3 24648.9 24969.4 25540.7 25581.2 17:55:28 INFO - PROCESS | 21746 | 17:55:28 INFO - PROCESS | 21746 | [#2] jquery.html Cycles:180 Average:23544.68 Median:23808.30 stddev:63023.69 (264.7%) stddev-sans-first:63176.42 17:55:28 INFO - PROCESS | 21746 | Values: 344.8 362.7 364.7 366.7 383.3 12255.0 16418.3 16488.8 16803.5 17751.0 14674.2 14932.9 15267.5 15832.5 16105.5 4995.6 5002.6 5151.7 5187.5 5210.7 3690.0 3853.5 5069.6 5148.9 5157.8 3836.0 3897.3 3902.8 3907.4 5476.7 3888.3 6115.4 6138.6 6138.8 6142.5 5183.4 5268.6 5314.3 5391.3 5398.2 20281.0 20536.3 20686.5 20903.6 21053.7 1835.2 1850.3 1863.6 2162.5 2231.1 13163.0 13213.3 13327.9 13461.9 13980.7 1722.5 1737.8 1751.9 1803.1 1807.6 46094.8 62931.0 70480.6 72357.0 72860.0 9300.1 9559.4 9568.0 9680.0 9894.5 13355.7 13364.2 13364.6 13372.7 13379.2 6897.4 6963.5 7042.9 7080.7 7205.0 6676.5 6691.8 6800.3 6832.6 6856.8 5939.9 5961.8 6040.9 6083.3 6148.9 1676.6 1704.8 1713.2 1737.4 1749.0 694.4 790.8 854.6 901.4 1009.7 17119.6 18310.5 18498.4 18771.6 18779.6 908.7 916.1 920.9 926.4 930.7 9831.5 10175.8 10383.7 10401.9 10402.7 374444.0 378361.0 384938.0 387533.0 388601.0 43709.2 76429.0 77428.6 77858.6 78823.6 872.2 884.4 892.0 896.7 900.1 15793.6 15802.8 16387.6 16402.3 16696.1 24440.8 27096.9 29675.0 35365.8 35888.1 45611.5 45741.8 45747.8 46738.0 48061.8 6931.7 7019.7 7200.8 7388.7 7445.7 11023.7 11247.2 11271.9 11334.3 11630.8 9661.7 9947.5 10115.0 10148.5 10354.0 9653.1 9742.2 9755.7 9814.7 9841.5 9835.0 10109.1 10295.0 10321.9 10556.7 7163.9 7256.7 7359.4 7441.3 7572.9 9666.8 9826.0 9830.4 10007.7 10163.8 17:55:28 INFO - PROCESS | 21746 | 17:55:28 INFO - PROCESS | 21746 | [#3] mootools.html Cycles:180 Average:5074.73 Median:4995.51 stddev:2897.69 (58.0%) stddev-sans-first:2892.31 17:55:28 INFO - PROCESS | 21746 | Values: 1351.7 1395.1 1412.0 1633.3 1670.9 7000.9 7249.3 7499.8 8074.7 8104.0 7426.0 7743.3 7745.1 7940.4 7948.5 2123.7 2135.4 2143.5 2153.6 2159.7 1832.4 1897.3 2092.8 2142.3 2160.0 1864.2 1892.3 1896.0 2063.2 2151.4 2053.9 2056.0 2061.5 2064.0 2066.6 1999.1 2007.1 2015.8 2049.8 2061.9 7525.7 7566.4 7570.7 7594.1 7594.3 4417.6 4437.5 4480.1 4492.3 4586.8 2871.7 2878.1 2963.1 2975.5 2978.5 954.5 984.2 985.1 991.5 996.6 10695.1 10740.5 10741.7 10757.8 10786.3 3907.3 3977.0 4128.7 4156.4 4165.0 9164.8 9170.0 9175.4 9183.8 9199.4 4546.4 4568.7 4569.7 4574.6 4577.5 4083.2 4138.1 4161.9 4169.3 4176.9 3534.8 3591.6 3668.5 3680.4 3707.3 1134.4 1159.8 1165.6 1211.3 1214.4 698.6 816.3 820.8 822.5 831.5 5018.9 5036.3 5138.3 5164.1 5190.1 387.8 390.2 401.2 407.2 411.0 3535.2 3577.2 3585.3 3599.2 3705.4 9028.0 9279.0 9418.3 9447.8 9507.7 9333.9 9341.4 9345.3 9350.0 9350.2 6911.4 7166.6 7266.2 7375.2 7387.9 4972.1 5130.5 5237.7 5323.2 5393.6 8922.2 9043.6 9054.9 9074.0 9165.5 8832.7 9114.4 9130.8 9236.4 9239.8 6702.7 6810.0 6829.5 6871.7 6878.4 7421.9 7515.1 7518.6 7523.4 7528.6 6578.0 6585.5 6626.5 6689.2 6716.3 6574.8 6643.3 6762.8 6791.7 6805.9 6197.8 6276.9 6285.1 6286.6 6298.4 4320.1 4373.4 4463.2 4463.4 4563.0 4427.2 4463.8 4580.0 4678.0 4715.9 17:55:28 INFO - PROCESS | 21746 | 17:55:28 INFO - PROCESS | 21746 | [#4] prototype.html Cycles:180 Average:4142.18 Median:4691.71 stddev:1220.72 (26.0%) stddev-sans-first:1189.44 17:55:28 INFO - PROCESS | 21746 | Values: 291.6 295.1 298.2 298.5 300.6 4908.4 4959.2 4973.2 4984.0 4995.2 4867.3 4869.1 4886.7 4896.6 4905.8 3834.4 3841.7 3870.3 3884.5 3884.9 3742.8 3776.0 3879.6 3886.9 3896.3 3782.9 3793.6 3804.9 3823.4 3839.9 3775.8 3781.6 3787.1 3793.6 3794.1 3172.7 3225.0 3245.9 3374.4 3389.3 4653.3 4655.7 4660.0 4669.8 4694.9 4269.2 4284.4 4295.5 4317.4 4322.4 4804.3 4914.5 4941.3 5018.9 5075.8 3644.3 3659.2 3662.2 3678.0 3687.9 5267.9 5293.8 5296.6 5336.9 5338.4 3465.7 3603.7 3638.7 3712.9 3716.8 3672.7 3709.7 3716.9 3722.4 3724.3 4202.7 4229.3 4260.2 4278.4 4285.9 4962.5 5100.0 5104.7 5114.3 5122.9 1262.6 1268.9 1276.9 1277.3 1278.2 788.6 801.3 819.5 828.9 832.7 3895.8 3931.7 3950.5 3964.2 3968.0 4557.3 4572.3 4592.9 4614.2 4628.4 3962.8 3966.2 3969.6 3998.7 4009.8 2326.2 2454.4 2467.7 2481.3 2485.7 4643.6 4706.3 4739.5 4861.7 4862.8 5328.1 5340.9 5342.9 5345.2 5366.3 4715.2 4793.0 4861.4 4862.4 4872.7 5184.3 5201.5 5212.7 5238.0 5243.0 5153.2 5156.7 5161.7 5169.4 5173.2 4688.5 4834.6 4835.8 4852.0 4878.6 3598.4 3626.9 3631.4 3637.4 3638.1 5218.7 5227.3 5230.5 5233.7 5262.2 4793.0 5023.6 5035.1 5044.0 5045.8 4940.8 4946.9 4959.2 4960.0 4963.1 4904.5 4905.3 4946.6 4947.1 4950.3 4785.4 5012.9 5015.4 5016.2 5029.5 4926.9 4951.5 4970.2 4972.5 4985.7 17:55:28 INFO - PROCESS | 21746 | 17:55:28 INFO - PROCESS | 21746 | [#5] yui.html Cycles:180 Average:15859.04 Median:25325.35 stddev:22300.29 (88.1%) stddev-sans-first:22333.50 17:55:28 INFO - PROCESS | 21746 | Values: 620.8 670.5 689.2 712.7 751.0 12088.9 13173.5 13248.7 13283.8 13323.5 12438.7 12559.4 12572.2 12586.5 12593.0 611.0 630.7 739.6 747.0 773.6 764.2 765.0 766.2 767.6 767.7 811.9 813.8 813.9 814.1 814.4 655.6 660.3 666.3 674.7 810.1 493.0 576.3 577.4 589.9 597.7 12989.1 13004.6 13034.9 13036.2 13038.0 11450.8 11680.1 11867.5 12012.7 12255.3 10218.6 10418.1 11485.4 11616.9 11618.9 4024.8 4029.2 4114.6 4198.2 4321.1 50157.7 51844.7 51863.2 59270.7 59371.7 9873.9 10146.5 10476.5 10631.3 10647.8 16991.9 17058.3 17076.4 17145.1 17285.6 6879.0 6943.3 6994.4 7135.5 7240.9 3656.9 3766.1 3784.6 3791.0 3859.2 2908.2 3006.9 3020.7 3025.7 3028.9 515.9 518.9 524.3 525.5 526.9 431.5 468.4 546.2 584.8 594.5 7257.7 7268.0 7419.3 7598.2 7696.2 560.3 564.1 567.5 570.5 575.4 3331.2 3642.3 3683.3 3704.5 3754.5 60676.1 61611.0 77176.0 109546.5 109741.0 64139.0 67500.7 89404.6 89829.6 90146.5 54972.0 59757.0 61272.7 70587.6 71703.6 7571.8 7767.4 7966.3 8098.4 8133.4 30171.0 32446.7 41882.0 42239.4 42785.0 38249.8 38909.4 38995.6 51710.2 55916.7 10533.0 10600.3 10768.2 10786.7 11004.4 11350.1 11671.9 12200.8 12325.1 12542.1 10199.5 10709.0 11011.2 11327.3 11669.1 10284.5 11074.6 11084.4 11482.9 11495.5 9978.9 11096.3 11155.6 11526.8 11850.9 8585.5 9000.4 9109.8 9151.5 9241.6 9058.4 9490.5 9495.6 9525.4 9591.4 17:55:28 INFO - PROCESS | 21746 | -------- Summary: end -------- 17:55:28 INFO - PROCESS | 21746 | 17:55:29 INFO - TEST-INFO | 21746: exit 0 17:55:29 INFO - TEST-OK | dromaeo_css | took 1120990ms 17:55:29 INFO - TEST-START | kraken 17:55:29 INFO - operating with platform_type : linux_ 17:55:29 INFO - Initialising browser for kraken test... 17:55:29 INFO - TEST-INFO | started process 22049 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp68kzQK/profile http://localhost:33531/getInfo.html) 17:55:33 INFO - PROCESS | 22049 | __metrics Screen width/height:1600/1200 17:55:33 INFO - PROCESS | 22049 | colorDepth:24 17:55:33 INFO - PROCESS | 22049 | Browser inner width/height: 1024/697 17:55:33 INFO - PROCESS | 22049 | __metrics 17:55:34 INFO - PROCESS | 22049 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:55:34 INFO - PROCESS | 22049 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:55:35 INFO - PROCESS | 22049 | console.error: PushService: 17:55:35 INFO - PROCESS | 22049 | stateChangeProcessEnqueue: Error transitioning state 17:55:35 INFO - PROCESS | 22049 | UnknownError 17:55:35 INFO - TEST-INFO | 22049: exit 0 17:55:35 INFO - Browser initialized. 17:55:35 INFO - Running cycle 1/1 for kraken test... 17:55:35 INFO - TEST-INFO | started process 22129 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp68kzQK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:55:47 INFO - PROCESS | 22129 | RSS: Main: 175235072 17:55:47 INFO - PROCESS | 22129 | 17:55:50 INFO - PROCESS | 22129 | Cycle 1(1): loaded http://localhost:33531/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33531/tests/kraken/driver.html?testName=audio-beat-detection) 17:55:51 INFO - PROCESS | 22129 | RSS: Main: 242712576 17:55:51 INFO - PROCESS | 22129 | 17:55:54 INFO - PROCESS | 22129 | Cycle 1(1): loaded http://localhost:33531/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33531/tests/kraken/driver.html?testName=audio-dft) 17:55:55 INFO - PROCESS | 22129 | RSS: Main: 218599424 17:55:55 INFO - PROCESS | 22129 | 17:55:58 INFO - PROCESS | 22129 | Cycle 1(1): loaded http://localhost:33531/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33531/tests/kraken/driver.html?testName=audio-fft) 17:55:58 INFO - PROCESS | 22129 | RSS: Main: 300429312 17:55:58 INFO - PROCESS | 22129 | 17:56:01 INFO - PROCESS | 22129 | Cycle 1(1): loaded http://localhost:33531/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33531/tests/kraken/driver.html?testName=audio-oscillator) 17:56:01 INFO - PROCESS | 22129 | RSS: Main: 210071552 17:56:01 INFO - PROCESS | 22129 | 17:56:03 INFO - PROCESS | 22129 | Cycle 1(1): loaded http://localhost:33531/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33531/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:56:04 INFO - PROCESS | 22129 | RSS: Main: 213499904 17:56:04 INFO - PROCESS | 22129 | 17:56:07 INFO - PROCESS | 22129 | Cycle 1(1): loaded http://localhost:33531/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33531/tests/kraken/driver.html?testName=imaging-darkroom) 17:56:08 INFO - PROCESS | 22129 | RSS: Main: 250449920 17:56:08 INFO - PROCESS | 22129 | 17:56:11 INFO - PROCESS | 22129 | Cycle 1(1): loaded http://localhost:33531/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33531/tests/kraken/driver.html?testName=imaging-desaturate) 17:56:12 INFO - PROCESS | 22129 | RSS: Main: 249880576 17:56:12 INFO - PROCESS | 22129 | 17:56:15 INFO - PROCESS | 22129 | Cycle 1(1): loaded http://localhost:33531/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33531/tests/kraken/driver.html?testName=json-parse-financial) 17:56:15 INFO - PROCESS | 22129 | RSS: Main: 249163776 17:56:15 INFO - PROCESS | 22129 | 17:56:17 INFO - PROCESS | 22129 | Cycle 1(1): loaded http://localhost:33531/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33531/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:56:18 INFO - PROCESS | 22129 | RSS: Main: 211640320 17:56:18 INFO - PROCESS | 22129 | 17:56:19 INFO - PROCESS | 22129 | Cycle 1(1): loaded http://localhost:33531/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33531/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:56:20 INFO - PROCESS | 22129 | RSS: Main: 219254784 17:56:20 INFO - PROCESS | 22129 | 17:56:22 INFO - PROCESS | 22129 | Cycle 1(1): loaded http://localhost:33531/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33531/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:56:23 INFO - PROCESS | 22129 | RSS: Main: 223473664 17:56:23 INFO - PROCESS | 22129 | 17:56:26 INFO - PROCESS | 22129 | Cycle 1(1): loaded http://localhost:33531/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33531/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:56:26 INFO - PROCESS | 22129 | RSS: Main: 224403456 17:56:26 INFO - PROCESS | 22129 | 17:56:29 INFO - PROCESS | 22129 | Cycle 1(1): loaded http://localhost:33531/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33531/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:56:30 INFO - PROCESS | 22129 | RSS: Main: 222466048 17:56:30 INFO - PROCESS | 22129 | 17:56:32 INFO - PROCESS | 22129 | Cycle 1(1): loaded http://localhost:33531/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33531/tests/kraken/driver.html?testName=ai-astar) 17:56:32 INFO - PROCESS | 22129 | RSS: Main: 273641472 17:56:32 INFO - PROCESS | 22129 | 17:56:32 INFO - PROCESS | 22129 | __start_tp_report 17:56:32 INFO - PROCESS | 22129 | _x_x_mozilla_page_load 17:56:32 INFO - PROCESS | 22129 | _x_x_mozilla_page_load_details 17:56:32 INFO - PROCESS | 22129 | |i|pagename|runs| 17:56:32 INFO - PROCESS | 22129 | |0;ai-astar;109;114;113;114;113;114;114;113;113;114 17:56:32 INFO - PROCESS | 22129 | |1;audio-beat-detection;152;130;122;162;126;136;122;128;155;121 17:56:32 INFO - PROCESS | 22129 | |2;audio-dft;163;162;163;167;163;163;163;161;163;162 17:56:32 INFO - PROCESS | 22129 | |3;audio-fft;75;78;76;107;76;77;77;76;97;79 17:56:32 INFO - PROCESS | 22129 | |4;audio-oscillator;83;86;130;84;84;85;105;84;84;113 17:56:32 INFO - PROCESS | 22129 | |5;imaging-gaussian-blur;117;117;117;117;116;116;117;117;116;117 17:56:32 INFO - PROCESS | 22129 | |6;imaging-darkroom;146;146;146;146;146;145;146;146;146;146 17:56:32 INFO - PROCESS | 22129 | |7;imaging-desaturate;95;95;95;95;95;94;94;95;95;94 17:56:32 INFO - PROCESS | 22129 | |8;json-parse-financial;65;63;63;63;63;64;64;63;64;63 17:56:32 INFO - PROCESS | 22129 | |9;json-stringify-tinderbox;67;67;66;67;67;66;66;66;68;66 17:56:32 INFO - PROCESS | 22129 | |10;stanford-crypto-aes;89;85;83;81;85;95;81;87;82;82 17:56:32 INFO - PROCESS | 22129 | |11;stanford-crypto-ccm;137;143;132;133;133;132;132;134;167;131 17:56:32 INFO - PROCESS | 22129 | |12;stanford-crypto-pbkdf2;172;172;181;175;175;172;176;175;173;174 17:56:32 INFO - PROCESS | 22129 | |13;stanford-crypto-sha256-iterative;70;70;70;73;68;69;70;70;69;67 17:56:32 INFO - PROCESS | 22129 | __end_tp_report 17:56:32 INFO - PROCESS | 22129 | __start_cc_report 17:56:32 INFO - PROCESS | 22129 | _x_x_mozilla_cycle_collect,1914 17:56:32 INFO - PROCESS | 22129 | __end_cc_report 17:56:32 INFO - PROCESS | 22129 | __startTimestamp1475110592508__endTimestamp 17:56:32 INFO - PROCESS | 22129 | 17:56:32 INFO - PROCESS | 22129 | ------- Summary: start ------- 17:56:32 INFO - PROCESS | 22129 | Number of tests: 14 17:56:32 INFO - PROCESS | 22129 | 17:56:32 INFO - PROCESS | 22129 | [#0] ai-astar Cycles:10 Average:113.10 Median:114.00 stddev:1.52 (1.3%) stddev-sans-first:0.53 17:56:32 INFO - PROCESS | 22129 | Values: 109.0 114.0 113.0 114.0 113.0 114.0 114.0 113.0 113.0 114.0 17:56:32 INFO - PROCESS | 22129 | 17:56:32 INFO - PROCESS | 22129 | [#1] audio-beat-detection Cycles:10 Average:135.40 Median:133.00 stddev:15.30 (11.5%) stddev-sans-first:15.00 17:56:32 INFO - PROCESS | 22129 | Values: 152.0 130.0 122.0 162.0 126.0 136.0 122.0 128.0 155.0 121.0 17:56:32 INFO - PROCESS | 22129 | 17:56:32 INFO - PROCESS | 22129 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:1.56 (1.0%) stddev-sans-first:1.66 17:56:32 INFO - PROCESS | 22129 | Values: 163.0 162.0 163.0 167.0 163.0 163.0 163.0 161.0 163.0 162.0 17:56:32 INFO - PROCESS | 22129 | 17:56:32 INFO - PROCESS | 22129 | [#3] audio-fft Cycles:10 Average:81.80 Median:77.00 stddev:10.96 (14.2%) stddev-sans-first:11.35 17:56:32 INFO - PROCESS | 22129 | Values: 75.0 78.0 76.0 107.0 76.0 77.0 77.0 76.0 97.0 79.0 17:56:32 INFO - PROCESS | 22129 | 17:56:32 INFO - PROCESS | 22129 | [#4] audio-oscillator Cycles:10 Average:93.80 Median:84.00 stddev:16.48 (19.6%) stddev-sans-first:17.01 17:56:32 INFO - PROCESS | 22129 | Values: 83.0 86.0 130.0 84.0 84.0 85.0 105.0 84.0 84.0 113.0 17:56:32 INFO - PROCESS | 22129 | 17:56:32 INFO - PROCESS | 22129 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 17:56:32 INFO - PROCESS | 22129 | Values: 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 116.0 117.0 17:56:32 INFO - PROCESS | 22129 | 17:56:32 INFO - PROCESS | 22129 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 17:56:32 INFO - PROCESS | 22129 | Values: 146.0 146.0 146.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 17:56:32 INFO - PROCESS | 22129 | 17:56:32 INFO - PROCESS | 22129 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 17:56:32 INFO - PROCESS | 22129 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 94.0 95.0 95.0 94.0 17:56:32 INFO - PROCESS | 22129 | 17:56:32 INFO - PROCESS | 22129 | [#8] json-parse-financial Cycles:10 Average:63.50 Median:63.50 stddev:0.71 (1.1%) stddev-sans-first:0.50 17:56:32 INFO - PROCESS | 22129 | Values: 65.0 63.0 63.0 63.0 63.0 64.0 64.0 63.0 64.0 63.0 17:56:32 INFO - PROCESS | 22129 | 17:56:32 INFO - PROCESS | 22129 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 17:56:32 INFO - PROCESS | 22129 | Values: 67.0 67.0 66.0 67.0 67.0 66.0 66.0 66.0 68.0 66.0 17:56:32 INFO - PROCESS | 22129 | 17:56:32 INFO - PROCESS | 22129 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:85.00 stddev:4.40 (5.2%) stddev-sans-first:4.42 17:56:32 INFO - PROCESS | 22129 | Values: 89.0 85.0 83.0 81.0 85.0 95.0 81.0 87.0 82.0 82.0 17:56:32 INFO - PROCESS | 22129 | 17:56:32 INFO - PROCESS | 22129 | [#11] stanford-crypto-ccm Cycles:10 Average:137.40 Median:133.50 stddev:10.99 (8.2%) stddev-sans-first:11.65 17:56:32 INFO - PROCESS | 22129 | Values: 137.0 143.0 132.0 133.0 133.0 132.0 132.0 134.0 167.0 131.0 17:56:32 INFO - PROCESS | 22129 | 17:56:32 INFO - PROCESS | 22129 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.50 Median:175.00 stddev:2.72 (1.6%) stddev-sans-first:2.73 17:56:32 INFO - PROCESS | 22129 | Values: 172.0 172.0 181.0 175.0 175.0 172.0 176.0 175.0 173.0 174.0 17:56:32 INFO - PROCESS | 22129 | 17:56:32 INFO - PROCESS | 22129 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:70.00 stddev:1.58 (2.3%) stddev-sans-first:1.67 17:56:32 INFO - PROCESS | 22129 | Values: 70.0 70.0 70.0 73.0 68.0 69.0 70.0 70.0 69.0 67.0 17:56:32 INFO - PROCESS | 22129 | -------- Summary: end -------- 17:56:32 INFO - PROCESS | 22129 | 17:56:33 INFO - TEST-INFO | 22129: exit 0 17:56:33 INFO - TEST-OK | kraken | took 64389ms 17:56:33 INFO - SUITE-END | took 1185s 17:56:34 INFO - Completed test suite (00:19:45) 17:56:34 INFO - javascript benchmark 17:56:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2573.7940964722825, 2603.3231359846436, 2632.0, 2643.3788059805943, 2656.5616673248915, 4637.304404339351, 4721.551452611996, 4749.833755818543, 4754.976225118874, 4765.046990601881, 4728.574428301452, 4751.999999999991, 4754.310624959378, 4788.473267940523, 4793.880152996177, 4355.0, 4387.605115539601, 4389.078293558357, 4403.141387429452, 4480.260756975095, 4446.844360447385, 4465.665075119363, 4471.172833025885, 4475.462944446671, 4491.6855820092605, 4262.808173632194, 4323.956760432387, 4435.223835828717, 4470.8882277942985, 4493.146302202571, 4348.608625223714, 4351.8694439166875, 4360.912781744379, 4366.4105345778235, 4380.474343078851, 4358.542353052915, 4427.9557204427865, 4436.356728274414, 4442.2892337225885, 4448.777561121931, 4743.667943243974, 4761.880952976203, 4766.189747742857, 4766.404199475066, 4778.976105119487, 4920.532549407801, 5096.159133742928, 5101.7194054327, 5108.565771909392, 5158.200478925773, 4999.875003124915, 5057.671251368686, 5068.037072956126, 5068.797248110071, 5075.492450754932, 4729.266963620645, 4733.195356789354, 4736.597389221886, 4736.8578942631775, 4740.241561350167, 5168.560672342893, 5204.9739751301, 5224.111900976843, 5249.370075590953, 5293.073712100444, 4948.703077815343, 4952.554270115635, 5005.249212618136, 5011.398632164163, 5078.314427552307, 5055.721935293521, 5076.74616269185, 5076.898462030738, 5081.110805609003, 5135.97432012845, 4834.879128021757, 4891.853244402602, 4996.225585034325, 5034.320366750515, 5061.417936937226, 5009.223570346602, 5010.423801262901, 5013.348264725562, 5013.623978201649, 5058.418281897629, 4275.46556680415, 4275.657947364203, 4281.678874084456, 4293.97853010733, 4330.328799036154, 3658.32321020612, 3668.2846844864994, 3701.148735790783, 3708.072981754561, 3716.832742526539, 4269.829206831754, 4290.120525292307, 4306.1172459645695, 4344.978275108604, 4349.673774466928, 4991.625628077836, 5011.173156429221, 5014.52362025607, 5015.398152221756, 5070.416902056237, 4288.764117973541, 4292.248856450171, 4302.548232435549, 4347.108842687241, 4356.6732495063, 4519.18654642161, 4557.521460246693, 4591.44902611682, 4651.325557794101, 4651.906961860744, 4675.158471475167, 4675.696079754805, 4731.243001119942, 4733.313669517969, 4791.712497250176, 5030.773615187252, 5085.211792172219, 5094.592432605308, 5098.082345177903, 5157.303763991813, 4594.196015697306, 4643.883902902319, 4688.484266730725, 4716.174669432767, 4762.095201911626, 5000.324956131021, 5019.372578427697, 5020.47285035066, 5026.899462010812, 5072.771725272298, 5086.847394578169, 5087.3386459759995, 5090.032893750175, 5103.591712663052, 5140.30605868203, 4769.856904292877, 4778.617710583076, 4785.282207668738, 4791.233402655558, 4887.291342755351, 4833.613310935047, 4836.709797412166, 4837.177679794373, 4875.439324477588, 4907.877303067452, 4769.928451073168, 4796.544328288807, 4800.879978000578, 4801.471838097877, 4817.662763606514, 4760.714357138444, 4823.155947709067, 4860.781264843161, 4890.462049174659, 4936.284238785428, 4789.976050119727, 4818.590419814215, 4886.657933944732, 4890.510948905223, 4892.241702536113], "value": 4638.566698813651, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.5100460590074, 573.9697243448011, 577.091081546564, 580.2833500626725, 580.9651420914743, 27076.323091922688, 27846.582301265473, 30313.84843075787, 30359.39281214377, 30362.696373036262, 30397.0, 38491.61508384915, 39634.8018259909, 39719.80140099303, 43557.34663980043, 7661.655225514837, 7786.065672119354, 7789.844203115963, 7790.922090779105, 7791.0, 7683.308502234798, 7782.299593036626, 7782.571958542278, 7782.961085194566, 7785.805354866117, 7804.492707973964, 7836.177201393857, 7844.9215507844765, 7845.568493732842, 7848.2151784821635, 7743.845123097534, 7764.22357764219, 7771.572563509005, 7772.300492955605, 7775.4168437367425, 7704.807379815494, 7784.377249820058, 7786.377089832857, 7789.532628042279, 7790.844183116306, 38172.0, 38576.61423385758, 38616.227675446615, 38630.420543691864, 38631.61368386336, 2871.454423659498, 2959.881604735808, 2973.7026297370307, 2988.2977500287416, 3079.7536197104178, 27744.861275693493, 28492.572611410844, 29145.12564623065, 29194.0, 29490.557641635394, 3471.3230919970615, 3542.079059444537, 3546.6453354664586, 3548.2193917338145, 3630.6187850275605, 237621.99999999828, 237874.0, 238139.0, 238254.0, 238839.80580097163, 44984.77507612441, 45130.0, 45140.0, 45220.0, 45275.77362113168, 32202.35595288081, 32930.0, 33080.66919330824, 35019.0, 35038.64961350354, 13074.280914549601, 13165.275909825052, 13166.736665266833, 13167.53913613019, 13187.274699891406, 10481.528331225114, 10582.788344233073, 10598.629047983284, 10602.787944241072, 10607.310524815863, 17663.55841103957, 17735.960364557985, 17741.580673546086, 17750.733738993924, 17830.46508604718, 6750.063722280824, 6786.287439818748, 6834.0, 6973.3375329343635, 7062.717491300393, 758.3364556013488, 905.7826121730737, 929.2658799548416, 947.5641205045756, 954.1269738189618, 26956.460870782474, 27565.17304480869, 27621.447571048466, 28209.43581128407, 28643.28391790222, 916.4180745226829, 920.5765347939889, 952.319091849331, 979.637534112383, 983.0611765763679, 13959.511417100353, 14652.633684157769, 14843.777343339858, 15044.172570508508, 15235.314410851539, 113608.43195783968, 113837.0, 113914.0, 114157.0, 114538.42730786293, 49152.0, 49882.25176622353, 49899.0, 49904.500954989984, 49936.250956235686, 1065.9040686337958, 1071.0253669161182, 1081.3403823667556, 1177.6349331707197, 1178.9705257368635, 27619.86190069037, 30690.84654576713, 31423.84288078545, 31558.368832623677, 31714.270078259087, 46129.76935115303, 46825.0, 46860.76569617267, 46871.76564117157, 46899.765501172275, 337071.0, 337840.0, 338137.0, 338713.0, 340521.0, 22031.33905982823, 22767.08931642782, 23941.52116957616, 24823.379415514755, 24971.87514062418, 38971.41542876802, 40681.1863762729, 40802.1839563213, 41149.382759259235, 41222.1755564881, 34958.0, 35388.292234155684, 35550.82224588861, 35622.28755424929, 35747.0, 34499.31001380009, 34835.65164348324, 35020.47469287912, 35230.295394092485, 35481.82259088688, 28380.432391351645, 29395.85302073476, 29895.55156672608, 35210.647893520734, 35389.0, 29974.400511990076, 32202.35595288128, 32210.516842246918, 32730.50904236486, 32898.342033158726, 24536.263912082664, 24648.876755616107, 24969.37576560528, 25540.74459255458, 25581.23256302314], "value": 16293.824480899964, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.7621141412427, 362.6989598633134, 364.7319220373027, 366.69930656861374, 383.2870860200029, 12255.0, 16418.34326626935, 16488.83511164888, 16803.495895123135, 17751.0, 14674.192919389456, 14932.925335373335, 15267.465638702648, 15832.525024249262, 16105.516834494983, 4995.5753760930365, 5002.574781143607, 5151.6908985460805, 5187.533122019017, 5210.739463026834, 3689.966809293389, 3853.5183102112237, 5069.619778516608, 5148.948510514903, 5157.7936882524655, 3836.040989752562, 3897.337452633059, 3902.804859757015, 3907.433422153786, 5476.685595457101, 3888.2612303662354, 6115.388461153893, 6138.570300078952, 6138.785142520012, 6142.508599312045, 5183.429822719498, 5268.578513718893, 5314.309139811839, 5391.29913111293, 5398.217258497535, 20281.0, 20536.281230156874, 20686.482837929023, 20903.58192836135, 21053.684194737092, 1835.2292037344214, 1850.3061351993003, 1863.5620629152138, 2162.48100455891, 2231.141010710872, 13163.0, 13213.33933303331, 13327.933360333232, 13461.932690336584, 13980.650483737887, 1722.5435259656201, 1737.8175291594453, 1751.9386821461187, 1803.1074618064142, 1807.6475087357971, 46094.76952615249, 62931.0, 70480.6475967622, 72357.0, 72860.0, 9300.11648893354, 9559.426434413957, 9568.0, 9679.951600241953, 9894.455804930798, 13355.666108347368, 13364.19814811095, 13364.599062028155, 13372.73254534904, 13379.197248165141, 6897.448204143657, 6963.4777391695825, 7042.894356584656, 7080.716771329192, 7204.9639751800905, 6676.499262555328, 6691.765788197487, 6800.285969973181, 6832.624205668736, 6856.760013399507, 5939.940600593939, 5961.821145365646, 6040.879182416327, 6083.270007599028, 6148.877022459616, 1676.5640933357415, 1704.8039475460232, 1713.2119225156318, 1737.3658614605579, 1748.9912550437166, 694.4132208283992, 790.7864876483317, 854.6154230596256, 901.3735453859636, 1009.6920439265947, 17119.572010699583, 18310.54223644393, 18498.445046648623, 18771.624567508574, 18779.624407511772, 908.7001289574424, 916.093067862811, 920.9447433153898, 926.4256161179977, 930.6835675870101, 9831.508424578742, 10175.796484070424, 10383.740406489747, 10401.947990260152, 10402.739931501621, 374444.0, 378361.0, 384938.0, 387533.0, 388601.0, 43709.169432240815, 76429.0, 77428.61285693536, 77858.61070694723, 78823.60588197137, 872.2019352292708, 884.4030279561271, 891.9598618062203, 896.7175339768082, 900.1403659505288, 15793.605159871095, 15802.76295855586, 16387.59031024234, 16402.26189821437, 16696.081715505763, 24440.75559244385, 27096.864515677295, 29675.0, 35365.82317088398, 35888.10279743027, 45611.54388456206, 45741.771291143334, 45747.77126114348, 46738.0, 48061.75969120132, 6931.68807403658, 7019.6841142147705, 7200.819979500555, 7388.704451822082, 7445.702171913063, 11023.724406889893, 11247.212695111264, 11271.943640282074, 11334.263272887236, 11630.825537617111, 9661.71014869555, 9947.452890091114, 10115.0, 10148.492575371349, 10354.0, 9653.131218190396, 9742.220622350053, 9755.707328780149, 9814.65648702292, 9841.507924603884, 9834.950825246115, 10109.140723038625, 10295.0, 10321.948390258001, 10556.683299501028, 7163.8567228656175, 7256.673449694671, 7359.411247100326, 7441.293077157661, 7572.924270757222, 9666.806663866824, 9825.950870245602, 9830.4101753895, 10007.749806254611, 10163.796724065329], "value": 8103.690360312659, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1351.7093824827664, 1395.0931894268726, 1411.9929400352996, 1633.2813562032711, 1670.9081000544966, 7000.859982800341, 7249.311315425026, 7499.775006749793, 8074.677012919484, 8104.027516697997, 7426.0, 7743.2643898829665, 7745.070591529025, 7940.40446966477, 7948.523088614687, 2123.734533183352, 2135.4341099608614, 2143.5498545305504, 2153.633882240023, 2159.7192364992607, 1832.4411054628333, 1897.2505860185288, 2092.79072092791, 2142.2609199826034, 2160.0, 1864.1797609052041, 1892.3187652445179, 1896.0, 2063.2056658186557, 2151.408362700254, 2053.9486512837148, 2056.0439395680933, 2061.4846288427966, 2063.9690404643943, 2066.60734460452, 1999.0604415924493, 2007.076744697441, 2015.7681866585383, 2049.846261530391, 2061.8865962372065, 7525.661345239422, 7566.43251756115, 7570.735024274124, 7594.126675432341, 7594.31651151399, 4417.602415782595, 4437.5340589237985, 4480.126375356806, 4492.281235002417, 4586.816527338902, 2871.7415432610956, 2878.064628995585, 2963.125877866035, 2975.4792911240447, 2978.5085460898927, 954.5395544816442, 984.2175470500969, 985.1084768284713, 991.4992928571097, 996.6113215845826, 10695.090917271964, 10740.462976851204, 10741.731456713567, 10757.83863242052, 10786.298890572089, 3907.257621052048, 3977.0, 4128.710990230655, 4156.397322388237, 4165.0, 9164.816703665889, 9170.037146099698, 9175.357724959322, 9183.77040573991, 9199.35604507678, 4546.40896683429, 4568.680192386501, 4569.725816451024, 4574.611158051603, 4577.496475387705, 4083.1629515949157, 4138.13099249155, 4161.875143745692, 4169.3120635094865, 4176.853810116692, 3534.770239934396, 3591.586967498719, 3668.486411902336, 3680.392735198716, 3707.295613833363, 1134.4214450630238, 1159.8086315757973, 1165.6036947437913, 1211.3216598704753, 1214.392803598201, 698.584342316321, 816.346922462028, 820.782492639451, 822.4859462835727, 831.476170012888, 5018.949810501921, 5036.294918711384, 5138.306328645585, 5164.122099243138, 5190.142320005594, 387.79059307973944, 390.2292971381499, 401.19159892816, 407.1937563623982, 411.0299692725166, 3535.1869070114017, 3577.2487777567003, 3585.31878943, 3599.2441587266444, 3705.3515634763808, 9028.0, 9279.0, 9418.293627977791, 9447.811043779224, 9507.66723164686, 9333.90666093344, 9341.439513629068, 9345.345825792128, 9349.953250233706, 9350.158485736316, 6911.410375613637, 7166.605836679033, 7266.237045110293, 7375.225601311892, 7387.926120738832, 4972.0801651694555, 5130.51260130287, 5237.659552129099, 5323.228131920772, 5393.595480339069, 8922.241609463268, 9043.593038313424, 9054.909450905407, 9073.95463022707, 9165.54172291396, 8832.735017949472, 9114.36199466031, 9130.817383652156, 9236.399634023766, 9239.815203695754, 6702.664866756741, 6809.965950170217, 6829.453643708392, 6871.725130994704, 6878.415334696607, 7421.925780742124, 7515.13575938774, 7518.624068796647, 7523.360514356341, 7528.585927773806, 6578.0, 6585.473162147113, 6626.5030122741955, 6689.230738464944, 6716.32836716344, 6574.8356291093105, 6643.269240383457, 6762.830929226809, 6791.72833086671, 6805.945078512838, 6197.783077592263, 6276.905846412216, 6285.120083188449, 6286.622802631857, 6298.401651843067, 4320.092780516126, 4373.365861950063, 4463.241248987615, 4463.4420697412825, 4562.954370456253, 4427.180971520279, 4463.821447142078, 4580.0, 4677.953220467888, 4715.882102947454], "value": 3997.5974515449, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.5844920987592, 295.13819646631833, 298.17257111515556, 298.467235983769, 300.5611806762127, 4908.435529914061, 4959.1569433196355, 4973.229149481836, 4983.950160498394, 4995.200767877141, 4867.2942423348595, 4869.050535145648, 4886.682365646239, 4896.55930966213, 4905.779239934202, 3834.386498160295, 3841.654251117399, 3870.3033453978273, 3884.475595794574, 3884.864029758959, 3742.812859357035, 3775.9811200943955, 3879.642125256166, 3886.8639597614088, 3896.318144324746, 3782.9432558511644, 3793.60167182446, 3804.9239015219678, 3823.4073718573527, 3839.9232015359676, 3775.8112094395447, 3781.5651200112065, 3787.110029143163, 3793.639604237593, 3794.1083845296334, 3172.682731726832, 3224.9677503224902, 3245.9188520286943, 3374.4432168692138, 3389.3390788796196, 4653.278741795028, 4655.674102812804, 4659.976700116512, 4669.7898594562985, 4694.906101877978, 4269.210196113729, 4284.400183974246, 4295.463067116611, 4317.417148684919, 4322.416473776031, 4804.279358096279, 4914.4839791821705, 4941.283513890466, 5018.874528136789, 5075.847724568232, 3644.2529281497227, 3659.1583935694675, 3662.1577037281572, 3678.0, 3687.8524859005606, 5267.86740850719, 5293.788248470018, 5296.602754793406, 5336.893262134774, 5338.386085600128, 3465.653434656514, 3603.675669189733, 3638.7089032877307, 3712.8514859405323, 3716.832742526593, 3672.7245456590863, 3709.7403181777017, 3716.8699095532065, 3722.4044152935944, 3724.2923844469465, 4202.663786897041, 4229.281022226229, 4260.169266992969, 4278.443802305743, 4285.871423857289, 4962.528559786814, 5100.0, 5104.693718376835, 5114.28400023997, 5122.8975420492125, 1262.62374012327, 1268.898488120948, 1276.8850803427736, 1277.3421687830776, 1278.2041232068957, 788.5584072919183, 801.2628381888676, 819.5001049359886, 828.8798124271947, 832.7168762620738, 3895.824687889052, 3931.724779265424, 3950.486436763202, 3964.2467931093, 3968.0, 4557.316402539579, 4572.268437050056, 4592.862214133581, 4614.215583350839, 4628.375169352162, 3962.841486340514, 3966.2067586482817, 3969.5511138434263, 3998.7200895937585, 4009.7594144351433, 2326.1509549014486, 2454.3678453828006, 2467.728549859514, 2481.255623312999, 2485.6768620079274, 4643.628509719214, 4706.294055891575, 4739.549742774431, 4861.714993952836, 4862.78117484714, 5328.147496400557, 5340.946590534123, 5342.866428339323, 5345.224942383333, 5366.302380690485, 4715.198416269311, 4792.976035119802, 4861.416630004422, 4862.440819305825, 4872.707637541688, 5184.274201611702, 5201.477283517415, 5212.687238765686, 5237.973810130925, 5243.0, 5153.222138362259, 5156.690598564098, 5161.690298582097, 5169.379674438941, 5173.215240741938, 4688.507706690748, 4834.5890599299455, 4835.806567737392, 4852.0, 4878.63410244226, 3598.370285200132, 3626.9274614507035, 3631.3826649469124, 3637.363461394298, 3638.1268495561403, 5218.739063046908, 5227.3465816772905, 5230.476952304739, 5233.712145832016, 5262.158054711228, 4793.0, 5023.572996295356, 5035.144025515744, 5043.9747801260755, 5045.823396181116, 4940.777665005012, 4946.901061978669, 4959.156943319716, 4959.950400495949, 4963.131451995814, 4904.4605093440405, 4905.313256144072, 4946.579540739078, 4947.1342515059005, 4950.257461380822, 4785.353977213032, 5012.872103776621, 5015.398152221756, 5016.212759366655, 5029.516292693737, 4926.8568172844925, 4951.529604687549, 4970.204767237225, 4972.5276098770555, 4985.675931064469], "value": 3752.008972858348, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [620.8292719502138, 670.4569298867917, 689.2487188964028, 712.7006657203974, 750.962451877406, 12088.879111208886, 13173.473061077546, 13248.668783280424, 13283.800742988838, 13323.467061317548, 12438.689032774162, 12559.372031398416, 12572.24566526009, 12586.496540138407, 12593.0, 611.0376157551851, 630.6972653126502, 739.6006156675389, 746.9878314883337, 773.5706682791049, 764.1632412508294, 764.9732259370924, 766.2146300042446, 767.5663250263583, 767.6545554500469, 811.8863359129726, 813.8372325534887, 813.9470934389245, 814.1451475950258, 814.4380377539509, 655.554223128275, 660.346257205368, 666.2804171494774, 674.7435974329773, 810.1250649298772, 492.9580985616191, 576.3487259396896, 577.4341145677259, 589.8731772668854, 597.7041364524588, 12989.090763646549, 13004.609861704164, 13034.869651303461, 13036.217826930415, 13038.0, 11450.828237576443, 11680.0655947524, 11867.516560429945, 12012.69968250792, 12255.264684118982, 10218.591256349737, 10418.062374386265, 11485.425728713531, 11616.94191529037, 11618.94190529042, 4024.7786371749544, 4029.1538776856896, 4114.629683328485, 4198.160367926396, 4321.092570560186, 50157.74921125408, 51844.740776296254, 51863.222051668876, 59270.703646481925, 59371.687963684686, 9873.901260987299, 10146.492675366202, 10476.47617619116, 10631.30896491741, 10647.84028239577, 16991.915040424967, 17058.317667293417, 17076.402325918534, 17145.14274286281, 17285.56786080358, 6878.965605172042, 6943.34038266374, 6994.370506654425, 7135.5361901476235, 7240.8913866290995, 3656.8902932912056, 3766.0961369271176, 3784.6404591563755, 3790.962090379061, 3859.150986782903, 2908.2002449326183, 3006.864691088906, 3020.652624948159, 3025.6974302569565, 3028.8939887103847, 515.9277701121846, 518.8676887393691, 524.2686452398882, 525.5217751845802, 526.8524813052352, 431.5037706637392, 468.39343050749363, 546.2025442853399, 584.7777844419094, 594.4976494861835, 7257.709691612276, 7267.963660181666, 7419.258074192646, 7598.164201937782, 7696.191899850547, 560.2828379674024, 564.1227890630109, 567.4864247855697, 570.4694633990429, 575.3785911215961, 3331.1505566080978, 3642.3261696586214, 3683.3001729671814, 3704.481372607837, 3754.511913451234, 60676.08985865216, 61611.0, 77176.0, 109546.45226773815, 109741.0, 64139.0, 67500.6624966872, 89404.55297723469, 89829.55085224532, 90146.54926725324, 54972.0, 59757.0, 61272.693636531534, 70587.64706176436, 71703.64148179226, 7571.810704732426, 7767.417443691633, 7966.322862556747, 8098.3926205536, 8133.43065985399, 30171.021781405823, 32446.675533244364, 41882.042411941635, 42239.366409503265, 42785.0, 38249.808750956065, 38909.41635875521, 38995.6100438992, 51710.22434663558, 55916.72041639766, 10533.0, 10600.310979786289, 10768.19238557127, 10786.73033174177, 11004.39475828837, 11350.148738844784, 11671.941640291745, 12200.816987745013, 12325.075619328765, 12542.122051456676, 10199.490025498548, 10709.0, 11011.229213954946, 11327.263727857662, 11669.066474682175, 10284.485775711035, 11074.5570177192, 11084.445777711244, 11482.885171148182, 11495.54017839277, 9978.900210997797, 11096.334219946506, 11155.553777848796, 11526.827097593376, 11850.881491184979, 8585.527795971031, 9000.36997410175, 9109.817803643757, 9151.542422878963, 9241.630334786802, 9058.36591438593, 9490.478023708762, 9495.572699228413, 9525.380850244712, 9591.42451452915], "value": 6221.420252678417, "unit": "score"}], "name": "dromaeo_css", "value": 6206.523332108847, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 114.0, 113.0, 114.0, 113.0, 114.0, 114.0, 113.0, 113.0, 114.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 130.0, 122.0, 162.0, 126.0, 136.0, 122.0, 128.0, 155.0, 121.0], "value": 135.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 167.0, 163.0, 163.0, 163.0, 161.0, 163.0, 162.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 76.0, 107.0, 76.0, 77.0, 77.0, 76.0, 97.0, 79.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 130.0, 84.0, 84.0, 85.0, 105.0, 84.0, 84.0, 113.0], "value": 93.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 63.0, 63.0, 63.0, 64.0, 64.0, 63.0, 64.0, 63.0], "value": 63.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 67.0, 67.0, 66.0, 66.0, 66.0, 68.0, 66.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 83.0, 81.0, 85.0, 95.0, 81.0, 87.0, 82.0, 82.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 143.0, 132.0, 133.0, 133.0, 132.0, 132.0, 134.0, 167.0, 131.0], "value": 137.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 181.0, 175.0, 175.0, 172.0, 176.0, 175.0, 173.0, 174.0], "value": 174.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 70.0, 73.0, 68.0, 69.0, 70.0, 70.0, 69.0, 67.0], "value": 69.6, "unit": "score"}], "name": "kraken", "value": 1541.0, "alertThreshold": 2.0}]} 17:56:34 INFO - Return code: 0 17:56:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:56:34 INFO - # TBPL SUCCESS # 17:56:34 INFO - Running post-action listener: _resource_record_post_action 17:56:34 INFO - [mozharness: 2016-09-29 00:56:34.306271Z] Finished run-tests step (success) 17:56:34 INFO - Running post-run listener: _resource_record_post_run 17:56:34 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392081408; Read time: 12; Write time: 302712 17:56:34 INFO - TinderboxPrint: CPU usage
13.0% 17:56:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 17:56:34 INFO - TinderboxPrint: I/O write bytes / time
392,081,408 / 302,712 17:56:34 INFO - TinderboxPrint: CPU idle
8,340.3 (86.9%) 17:56:34 INFO - TinderboxPrint: CPU user
1,202.8 (12.5%) 17:56:34 INFO - TinderboxPrint: Swap in / out
0 / 0 17:56:34 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 99069952; Read time: 0; Write time: 88708 17:56:34 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292106240; Read time: 12; Write time: 213976 17:56:34 INFO - Running post-run listener: _upload_blobber_files 17:56:34 INFO - Blob upload gear active. 17:56:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:56:34 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 17:56:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:56:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:56:35 INFO - (blobuploader) - INFO - Open directory for files ... 17:56:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:56:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:56:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:56:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:56:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:56:39 INFO - (blobuploader) - INFO - Done attempting. 17:56:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:56:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:56:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:56:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:56:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:56:40 INFO - (blobuploader) - INFO - Done attempting. 17:56:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:56:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:56:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:56:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:56:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:56:41 INFO - (blobuploader) - INFO - Done attempting. 17:56:41 INFO - (blobuploader) - INFO - Iteration through files over. 17:56:41 INFO - Return code: 0 17:56:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:56:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:56:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/339e1f3c2c3aa733a4b56c16f25c985f2ae28b04ddaa6036da26e762ddd53a4f1716de5c19987966dfff8cde7f956fcb944f6ededd5fe40efd156fc3c9a16c2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8c4352192221047cc87887d35e9fd95ddfe88f07aabc804ed97064a4a0864197a1a248d36534d6d17e4a2e9e59dad14ec499d104c9856f64c4c9d9a791d24bab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3abb212034d7ac111b1c71589537f3de9d8f36c2e4d09ed4a12835627c58077a73500653cadc1355a5bc99042209c181b9e495e8daea6364a7a2e85bbbb84125"} 17:56:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:56:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:56:41 INFO - Contents: 17:56:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/339e1f3c2c3aa733a4b56c16f25c985f2ae28b04ddaa6036da26e762ddd53a4f1716de5c19987966dfff8cde7f956fcb944f6ededd5fe40efd156fc3c9a16c2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8c4352192221047cc87887d35e9fd95ddfe88f07aabc804ed97064a4a0864197a1a248d36534d6d17e4a2e9e59dad14ec499d104c9856f64c4c9d9a791d24bab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3abb212034d7ac111b1c71589537f3de9d8f36c2e4d09ed4a12835627c58077a73500653cadc1355a5bc99042209c181b9e495e8daea6364a7a2e85bbbb84125"} 17:56:41 INFO - Running post-run listener: copy_logs_to_upload_dir 17:56:41 INFO - Copying logs to upload dir... 17:56:41 INFO - mkdir: /builds/slave/test/build/upload/logs 17:56:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.144627 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-09-28 17:56:40.950944) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 17:56:40.954052) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1475109103.809288-1054666275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/339e1f3c2c3aa733a4b56c16f25c985f2ae28b04ddaa6036da26e762ddd53a4f1716de5c19987966dfff8cde7f956fcb944f6ededd5fe40efd156fc3c9a16c2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8c4352192221047cc87887d35e9fd95ddfe88f07aabc804ed97064a4a0864197a1a248d36534d6d17e4a2e9e59dad14ec499d104c9856f64c4c9d9a791d24bab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3abb212034d7ac111b1c71589537f3de9d8f36c2e4d09ed4a12835627c58077a73500653cadc1355a5bc99042209c181b9e495e8daea6364a7a2e85bbbb84125"} build_url:https://queue.taskcluster.net/v1/task/KvnrEVyiRI2zvV4li8TF9g/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011324 build_url: 'https://queue.taskcluster.net/v1/task/KvnrEVyiRI2zvV4li8TF9g/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-Non-PGO/sha512/339e1f3c2c3aa733a4b56c16f25c985f2ae28b04ddaa6036da26e762ddd53a4f1716de5c19987966dfff8cde7f956fcb944f6ededd5fe40efd156fc3c9a16c2e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8c4352192221047cc87887d35e9fd95ddfe88f07aabc804ed97064a4a0864197a1a248d36534d6d17e4a2e9e59dad14ec499d104c9856f64c4c9d9a791d24bab", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3abb212034d7ac111b1c71589537f3de9d8f36c2e4d09ed4a12835627c58077a73500653cadc1355a5bc99042209c181b9e495e8daea6364a7a2e85bbbb84125"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 17:56:40.979558) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 17:56:40.979897) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1475109103.809288-1054666275 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004543 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 17:56:41.064532) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 17:56:41.064855) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 17:56:41.065151) ========= ========= Total master_lag: 0.17 =========