builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-025 starttime: 1476446751.57 results: success (0) buildid: 20161014032941 builduid: 214b62323e2946a38c774ebd84800b2b revision: 1391a2889aeb2bdd61ad6ef838e65826e35aabc2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 05:05:51.570040) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-14 05:05:51.570549) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 05:05:51.570885) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-14 05:05:51.585868) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 05:05:51.586194) ========= 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=232498196343f89f466a4a9a000001c8-1476446751.666417-1620542792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-14 05:05: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 8.91M=0.001s 2016-10-14 05:05:52 (8.91 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.125545 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 05:05:51.728310) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 05:05:51.728933) ========= 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=232498196343f89f466a4a9a000001c8-1476446751.666417-1620542792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017886 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 05:05:51.780291) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 05:05:51.780728) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1391a2889aeb2bdd61ad6ef838e65826e35aabc2 --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 1391a2889aeb2bdd61ad6ef838e65826e35aabc2 --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=232498196343f89f466a4a9a000001c8-1476446751.666417-1620542792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-14 05:05:52,744 truncating revision to first 12 chars 2016-10-14 05:05:52,744 Setting DEBUG logging. 2016-10-14 05:05:52,744 attempt 1/10 2016-10-14 05:05:52,744 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1391a2889aeb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-14 05:05:53,058 unpacking tar archive at: fx-team-1391a2889aeb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.619116 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 05:05:52.414190) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 05:05:52.414556) ========= script_repo_revision: 1391a2889aeb2bdd61ad6ef838e65826e35aabc2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-14 05:05:52.415005) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 05:05:52.415308) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-14 05:05:52.425967) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-14 05:05:52.426281) ========= /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=232498196343f89f466a4a9a000001c8-1476446751.666417-1620542792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:05:53 INFO - MultiFileLogger online at 20161014 05:05:53 in /builds/slave/test 05:05:53 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 05:05:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:05:53 INFO - {'append_to_log': False, 05:05:53 INFO - 'base_work_dir': '/builds/slave/test', 05:05:53 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:05:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:05:53 INFO - 'branch': 'Fx-Team-Non-PGO', 05:05:53 INFO - 'buildbot_json_path': 'buildprops.json', 05:05:53 INFO - 'config_files': ('talos/linux_config.py',), 05:05:53 INFO - 'default_actions': ('clobber', 05:05:53 INFO - 'read-buildbot-config', 05:05:53 INFO - 'download-and-extract', 05:05:53 INFO - 'populate-webroot', 05:05:53 INFO - 'create-virtualenv', 05:05:53 INFO - 'install', 05:05:53 INFO - 'run-tests'), 05:05:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:05:53 INFO - 'download_minidump_stackwalk': True, 05:05:53 INFO - 'download_symbols': 'ondemand', 05:05:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:05:53 INFO - 'tooltool.py': '/tools/tooltool.py', 05:05:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:05:53 INFO - '/tools/misc-python/virtualenv.py')}, 05:05:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:05:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:05:53 INFO - 'installer_path': 'installer.exe', 05:05:53 INFO - 'log_level': 'info', 05:05:53 INFO - 'log_name': 'talos', 05:05:53 INFO - 'log_to_console': True, 05:05:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:05:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:05:53 INFO - 'opt_config_files': (), 05:05:53 INFO - 'pip_index': False, 05:05:53 INFO - 'sps_profile': False, 05:05:53 INFO - 'sps_profile_interval': 0, 05:05:53 INFO - 'suite': 'dromaeojs', 05:05:53 INFO - 'system_bits': '32', 05:05:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:05:53 INFO - 'title': 'talos-linux64-ix-025', 05:05:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:05:53 INFO - 'use_talos_json': True, 05:05:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:05:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:05:53 INFO - 'work_dir': 'build'} 05:05:53 INFO - [mozharness: 2016-10-14 12:05:53.482226Z] Running clobber step. 05:05:53 INFO - Running pre-action listener: _resource_record_pre_action 05:05:53 INFO - Running main action method: clobber 05:05:53 INFO - rmtree: /builds/slave/test/build 05:05:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:05:53 INFO - Running post-action listener: _resource_record_post_action 05:05:53 INFO - [mozharness: 2016-10-14 12:05:53.955227Z] Finished clobber step (success) 05:05:53 INFO - [mozharness: 2016-10-14 12:05:53.955328Z] Running read-buildbot-config step. 05:05:53 INFO - Running pre-action listener: _resource_record_pre_action 05:05:53 INFO - Running main action method: read_buildbot_config 05:05:53 INFO - Using buildbot properties: 05:05:53 INFO - { 05:05:53 INFO - "project": "", 05:05:53 INFO - "product": "firefox", 05:05:53 INFO - "script_repo_revision": "production", 05:05:53 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:05:53 INFO - "repository": "", 05:05:53 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:05:53 INFO - "buildid": "20161014032941", 05:05:53 INFO - "pgo_build": "False", 05:05:53 INFO - "basedir": "/builds/slave/test", 05:05:53 INFO - "buildnumber": 3391, 05:05:53 INFO - "slavename": "talos-linux64-ix-025", 05:05:53 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:05:53 INFO - "platform": "ubuntu64_hw", 05:05:53 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:05:53 INFO - "branch": "fx-team", 05:05:53 INFO - "repo_path": "integration/fx-team", 05:05:53 INFO - "revision": "1391a2889aeb2bdd61ad6ef838e65826e35aabc2", 05:05:53 INFO - "stage_platform": "linux64", 05:05:53 INFO - "builduid": "214b62323e2946a38c774ebd84800b2b", 05:05:53 INFO - "slavebuilddir": "test" 05:05:53 INFO - } 05:05:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/P0Vca6-TQmm_RTkJdIAjSg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 05:05:53 INFO - Running post-action listener: _resource_record_post_action 05:05:53 INFO - [mozharness: 2016-10-14 12:05:53.958068Z] Finished read-buildbot-config step (success) 05:05:53 INFO - [mozharness: 2016-10-14 12:05:53.958156Z] Running download-and-extract step. 05:05:53 INFO - Running pre-action listener: _resource_record_pre_action 05:05:53 INFO - Running main action method: download_and_extract 05:05:53 INFO - mkdir: /builds/slave/test/build/tests 05:05:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:53 INFO - trying https://queue.taskcluster.net/v1/task/P0Vca6-TQmm_RTkJdIAjSg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:05:53 INFO - Downloading https://queue.taskcluster.net/v1/task/P0Vca6-TQmm_RTkJdIAjSg/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 05:05:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P0Vca6-TQmm_RTkJdIAjSg/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 05:05:54 INFO - Downloaded 1361 bytes. 05:05:54 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:05:54 INFO - Using the following test package requirements: 05:05:54 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:05:54 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:05:54 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:05:54 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:54 INFO - u'jsshell-linux-x86_64.zip'], 05:05:54 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:05:54 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:05:54 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:05:54 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:05:54 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:05:54 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:05:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:05:54 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:05:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P0Vca6-TQmm_RTkJdIAjSg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:05:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P0Vca6-TQmm_RTkJdIAjSg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:05:54 INFO - Fetch https://queue.taskcluster.net/v1/task/P0Vca6-TQmm_RTkJdIAjSg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:05:55 INFO - Http code: 200 05:05:55 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 05:05:55 INFO - x-amz-cf-id: h1KxQfRigcnkQbXLi_ePnwQYvEeDy_FaOwdm46Xa7-R1BU1bUa_9xg== 05:05:55 INFO - x-amz-version-id: ZItoPXE5u5Mk7vi1csxUNXT8O6Wa5JCn 05:05:55 INFO - Expected file size: 20554361 05:05:55 INFO - Obtained file size: 20554361 05:05:59 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 05:05:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P0Vca6-TQmm_RTkJdIAjSg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:05:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P0Vca6-TQmm_RTkJdIAjSg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:05:59 INFO - Fetch https://queue.taskcluster.net/v1/task/P0Vca6-TQmm_RTkJdIAjSg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:05:59 INFO - Http code: 200 05:05:59 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 05:05:59 INFO - x-amz-cf-id: 9sNZrQUosJgcMQSSSyzv3vdFRk7fIZbkq1F6kilcfpCqoIB2FJbbnA== 05:05:59 INFO - x-amz-version-id: ZItoPXE5u5Mk7vi1csxUNXT8O6Wa5JCn 05:06:00 INFO - Expected file size: 20554361 05:06:00 INFO - Obtained file size: 20554361 05:06:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P0Vca6-TQmm_RTkJdIAjSg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 05:06:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P0Vca6-TQmm_RTkJdIAjSg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:06:04 INFO - Fetch https://queue.taskcluster.net/v1/task/P0Vca6-TQmm_RTkJdIAjSg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 05:06:05 INFO - Http code: 200 05:06:05 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 05:06:05 INFO - x-amz-cf-id: M16QinxCKgRC-pr8WhyyP4EjVCsJM4itXKq5yD-V1Y5DC-3sVFmong== 05:06:05 INFO - x-amz-version-id: yHTZtZ1RMsS3Pf4RdrnF5H._VawD6Q_C 05:06:05 INFO - Expected file size: 14409006 05:06:05 INFO - Obtained file size: 14409006 05:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:05 INFO - trying https://queue.taskcluster.net/v1/task/P0Vca6-TQmm_RTkJdIAjSg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:06:05 INFO - Downloading https://queue.taskcluster.net/v1/task/P0Vca6-TQmm_RTkJdIAjSg/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 05:06:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P0Vca6-TQmm_RTkJdIAjSg/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 05:06:06 INFO - Downloaded 55638788 bytes. 05:06:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P0Vca6-TQmm_RTkJdIAjSg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:06:06 INFO - mkdir: /builds/slave/test/properties 05:06:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:06:06 INFO - Writing to file /builds/slave/test/properties/build_url 05:06:06 INFO - Contents: 05:06:06 INFO - build_url:https://queue.taskcluster.net/v1/task/P0Vca6-TQmm_RTkJdIAjSg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:06:07 INFO - Running post-action listener: _resource_record_post_action 05:06:07 INFO - Running post-action listener: set_extra_try_arguments 05:06:07 INFO - [mozharness: 2016-10-14 12:06:07.313531Z] Finished download-and-extract step (success) 05:06:07 INFO - [mozharness: 2016-10-14 12:06:07.313756Z] Running populate-webroot step. 05:06:07 INFO - Running pre-action listener: _resource_record_pre_action 05:06:07 INFO - Running main action method: populate_webroot 05:06:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:06:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:06:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:06:07 INFO - '--tppagecycles', 05:06:07 INFO - '7'], 05:06:07 INFO - 'tests': ['tsvgm']}}, 05:06:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:06:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:06:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:06:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:06:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:06:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:06:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:07 INFO - 'talos_options': ['--disable-e10s'], 05:06:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:06:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:06:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:07 INFO - 'talos_options': ['--disable-e10s'], 05:06:07 INFO - 'tests': ['damp', 'tps']}, 05:06:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:07 INFO - 'tests': ['damp', 'tps']}, 05:06:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:06:07 INFO - 'tests': ['dromaeo_dom']}, 05:06:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:06:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:06:07 INFO - 'tests': ['basic_compositor_video']}, 05:06:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:06:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:06:07 INFO - 'tests': ['a11yr', 05:06:07 INFO - 'ts_paint', 05:06:07 INFO - 'tpaint', 05:06:07 INFO - 'sessionrestore', 05:06:07 INFO - 'sessionrestore_no_auto_restore', 05:06:07 INFO - 'tabpaint']}, 05:06:07 INFO - 'other-e10s': {'tests': ['a11yr', 05:06:07 INFO - 'ts_paint', 05:06:07 INFO - 'tpaint', 05:06:07 INFO - 'sessionrestore', 05:06:07 INFO - 'sessionrestore_no_auto_restore', 05:06:07 INFO - 'tabpaint']}, 05:06:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:06:07 INFO - 'ts_paint', 05:06:07 INFO - 'tpaint', 05:06:07 INFO - 'sessionrestore', 05:06:07 INFO - 'sessionrestore_no_auto_restore', 05:06:07 INFO - 'tabpaint']}, 05:06:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:06:07 INFO - 'ts_paint', 05:06:07 INFO - 'tpaint', 05:06:07 INFO - 'sessionrestore', 05:06:07 INFO - 'sessionrestore_no_auto_restore', 05:06:07 INFO - 'tabpaint']}, 05:06:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:06:07 INFO - 'tests': ['a11yr', 05:06:07 INFO - 'ts_paint', 05:06:07 INFO - 'tpaint', 05:06:07 INFO - 'sessionrestore', 05:06:07 INFO - 'sessionrestore_no_auto_restore', 05:06:07 INFO - 'tabpaint']}, 05:06:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:06:07 INFO - 'tests': ['a11yr', 05:06:07 INFO - 'ts_paint', 05:06:07 INFO - 'tpaint', 05:06:07 INFO - 'sessionrestore', 05:06:07 INFO - 'sessionrestore_no_auto_restore', 05:06:07 INFO - 'tabpaint']}, 05:06:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:06:07 INFO - 'tests': ['tsvgx', 05:06:07 INFO - 'tsvgr_opacity', 05:06:07 INFO - 'tart', 05:06:07 INFO - 'tscrollx', 05:06:07 INFO - 'cart']}, 05:06:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:06:07 INFO - 'tsvgr_opacity', 05:06:07 INFO - 'tart', 05:06:07 INFO - 'tscrollx', 05:06:07 INFO - 'cart']}, 05:06:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:07 INFO - 'talos_options': ['--disable-e10s'], 05:06:07 INFO - 'tests': ['tp5o']}, 05:06:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:07 INFO - 'tests': ['tp5o']}, 05:06:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:07 INFO - 'talos_options': ['--disable-e10s', 05:06:07 INFO - '--xperf_path', 05:06:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:06:07 INFO - 'tests': ['tp5n']}, 05:06:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:06:07 INFO - 'talos_options': ['--xperf_path', 05:06:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:06:07 INFO - 'tests': ['tp5n']}}, 05:06:07 INFO - 'talos.zip': {'path': '', 05:06:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:06:07 INFO - Running post-action listener: _resource_record_post_action 05:06:07 INFO - [mozharness: 2016-10-14 12:06:07.329206Z] Finished populate-webroot step (success) 05:06:07 INFO - [mozharness: 2016-10-14 12:06:07.329313Z] Running create-virtualenv step. 05:06:07 INFO - Running pre-action listener: _resource_record_pre_action 05:06:07 INFO - Running main action method: create_virtualenv 05:06:07 INFO - Creating virtualenv /builds/slave/test/build/venv 05:06:07 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 05:06:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:06:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:06:07 INFO - Using real prefix '/usr' 05:06:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:06:07 INFO - Installing distribute.............................................................................................................................................................................................done. 05:06:09 INFO - Installing pip.................done. 05:06:09 INFO - Return code: 0 05:06:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:06:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:06:10 INFO - Reading from file tmpfile_stdout 05:06:10 INFO - Output received: 05:06:10 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) 05:06:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0e40d57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27afca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27acf60>, '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 0x27add40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ae1d0>, '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': '232498196343f89f466a4a9a000001c8-1476446751.666417-1620542792', '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 05:06:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:06:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:06:10 INFO - Using env: {'DISPLAY': ':0', 05:06:10 INFO - 'HOME': '/home/cltbld', 05:06:10 INFO - 'LANG': 'en_US.UTF-8', 05:06:10 INFO - 'LANGUAGE': 'en_US:en', 05:06:10 INFO - 'LOGNAME': 'cltbld', 05:06:10 INFO - 'MAIL': '/var/mail/cltbld', 05:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:10 INFO - 'MOZ_NO_REMOTE': '1', 05:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:10 INFO - 'NO_EM_RESTART': '1', 05:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:10 INFO - 'PWD': '/builds/slave/test', 05:06:10 INFO - 'SHELL': '/bin/bash', 05:06:10 INFO - 'SHLVL': '1', 05:06:10 INFO - 'TERM': 'linux', 05:06:10 INFO - 'TMOUT': '86400', 05:06:10 INFO - 'USER': 'cltbld', 05:06:10 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1476446751.666417-1620542792', 05:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:10 INFO - '_': '/tools/buildbot/bin/python'} 05:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:10 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 05:06:10 INFO - Cleaning up... 05:06:10 INFO - Return code: 0 05:06:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f0e40d57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27afca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27acf60>, '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 0x27add40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ae1d0>, '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': '232498196343f89f466a4a9a000001c8-1476446751.666417-1620542792', '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 05:06:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:06:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:06:10 INFO - Using env: {'DISPLAY': ':0', 05:06:10 INFO - 'HOME': '/home/cltbld', 05:06:10 INFO - 'LANG': 'en_US.UTF-8', 05:06:10 INFO - 'LANGUAGE': 'en_US:en', 05:06:10 INFO - 'LOGNAME': 'cltbld', 05:06:10 INFO - 'MAIL': '/var/mail/cltbld', 05:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:10 INFO - 'MOZ_NO_REMOTE': '1', 05:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:10 INFO - 'NO_EM_RESTART': '1', 05:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:10 INFO - 'PWD': '/builds/slave/test', 05:06:10 INFO - 'SHELL': '/bin/bash', 05:06:10 INFO - 'SHLVL': '1', 05:06:10 INFO - 'TERM': 'linux', 05:06:10 INFO - 'TMOUT': '86400', 05:06:10 INFO - 'USER': 'cltbld', 05:06:10 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1476446751.666417-1620542792', 05:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:10 INFO - '_': '/tools/buildbot/bin/python'} 05:06:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:10 INFO - Downloading/unpacking psutil>=3.1.1 05:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:06:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:06:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:06:12 INFO - Installing collected packages: psutil 05:06:12 INFO - Running setup.py install for psutil 05:06:12 INFO - building 'psutil._psutil_linux' extension 05:06:12 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 05:06:12 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 05:06:12 INFO - building 'psutil._psutil_posix' extension 05:06:12 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 05:06:13 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 05:06:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:06:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:06:13 INFO - Successfully installed psutil 05:06:13 INFO - Cleaning up... 05:06:13 INFO - Return code: 0 05:06:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:06:13 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')]} 05:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:13 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')]} 05:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:13 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 0x7f0e40d57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27afca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27acf60>, '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 0x27add40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ae1d0>, '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': '232498196343f89f466a4a9a000001c8-1476446751.666417-1620542792', '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 05:06:13 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 05:06:13 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 05:06:13 INFO - Using env: {'DISPLAY': ':0', 05:06:13 INFO - 'HOME': '/home/cltbld', 05:06:13 INFO - 'LANG': 'en_US.UTF-8', 05:06:13 INFO - 'LANGUAGE': 'en_US:en', 05:06:13 INFO - 'LOGNAME': 'cltbld', 05:06:13 INFO - 'MAIL': '/var/mail/cltbld', 05:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:13 INFO - 'MOZ_NO_REMOTE': '1', 05:06:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:13 INFO - 'NO_EM_RESTART': '1', 05:06:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:13 INFO - 'PWD': '/builds/slave/test', 05:06:13 INFO - 'SHELL': '/bin/bash', 05:06:13 INFO - 'SHLVL': '1', 05:06:13 INFO - 'TERM': 'linux', 05:06:13 INFO - 'TMOUT': '86400', 05:06:13 INFO - 'USER': 'cltbld', 05:06:13 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1476446751.666417-1620542792', 05:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:13 INFO - '_': '/tools/buildbot/bin/python'} 05:06:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:06:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:06:15 INFO - Installing collected packages: mozsystemmonitor 05:06:15 INFO - Running setup.py install for mozsystemmonitor 05:06:15 INFO - Successfully installed mozsystemmonitor 05:06:15 INFO - Cleaning up... 05:06:15 INFO - Return code: 0 05:06:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:06: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')]} 05:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06: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')]} 05:06:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06: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', '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 0x7f0e40d57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27afca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27acf60>, '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 0x27add40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ae1d0>, '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': '232498196343f89f466a4a9a000001c8-1476446751.666417-1620542792', '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 05:06: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:06: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 jsonschema==2.5.1 05:06:15 INFO - Using env: {'DISPLAY': ':0', 05:06:15 INFO - 'HOME': '/home/cltbld', 05:06:15 INFO - 'LANG': 'en_US.UTF-8', 05:06:15 INFO - 'LANGUAGE': 'en_US:en', 05:06:15 INFO - 'LOGNAME': 'cltbld', 05:06:15 INFO - 'MAIL': '/var/mail/cltbld', 05:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:15 INFO - 'MOZ_NO_REMOTE': '1', 05:06:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:15 INFO - 'NO_EM_RESTART': '1', 05:06:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:15 INFO - 'PWD': '/builds/slave/test', 05:06:15 INFO - 'SHELL': '/bin/bash', 05:06:15 INFO - 'SHLVL': '1', 05:06:15 INFO - 'TERM': 'linux', 05:06:15 INFO - 'TMOUT': '86400', 05:06:15 INFO - 'USER': 'cltbld', 05:06:15 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1476446751.666417-1620542792', 05:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:15 INFO - '_': '/tools/buildbot/bin/python'} 05:06:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:15 INFO - Downloading/unpacking jsonschema==2.5.1 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:06:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06:17 INFO - Downloading functools32-3.2.3-2.tar.gz 05:06:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:06:17 INFO - warning: no files found matching '*.txt' 05:06:17 INFO - no previously-included directories found matching 'build' 05:06:17 INFO - no previously-included directories found matching 'dist' 05:06:17 INFO - no previously-included directories found matching '.git*' 05:06:17 INFO - Installing collected packages: jsonschema, functools32 05:06:17 INFO - Running setup.py install for functools32 05:06:18 INFO - warning: no files found matching '*.txt' 05:06:18 INFO - no previously-included directories found matching 'build' 05:06:18 INFO - no previously-included directories found matching 'dist' 05:06:18 INFO - no previously-included directories found matching '.git*' 05:06:18 INFO - Successfully installed jsonschema functools32 05:06:18 INFO - Cleaning up... 05:06:18 INFO - Return code: 0 05:06:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:18 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 0x7f0e40d57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27afca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27acf60>, '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 0x27add40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ae1d0>, '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': '232498196343f89f466a4a9a000001c8-1476446751.666417-1620542792', '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 05:06:18 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 05:06:18 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 05:06:18 INFO - Using env: {'DISPLAY': ':0', 05:06:18 INFO - 'HOME': '/home/cltbld', 05:06:18 INFO - 'LANG': 'en_US.UTF-8', 05:06:18 INFO - 'LANGUAGE': 'en_US:en', 05:06:18 INFO - 'LOGNAME': 'cltbld', 05:06:18 INFO - 'MAIL': '/var/mail/cltbld', 05:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:18 INFO - 'MOZ_NO_REMOTE': '1', 05:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:18 INFO - 'NO_EM_RESTART': '1', 05:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:18 INFO - 'PWD': '/builds/slave/test', 05:06:18 INFO - 'SHELL': '/bin/bash', 05:06:18 INFO - 'SHLVL': '1', 05:06:18 INFO - 'TERM': 'linux', 05:06:18 INFO - 'TMOUT': '86400', 05:06:18 INFO - 'USER': 'cltbld', 05:06:18 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1476446751.666417-1620542792', 05:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:18 INFO - '_': '/tools/buildbot/bin/python'} 05:06:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:06:18 INFO - Cleaning up... 05:06:18 INFO - Return code: 0 05:06:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:18 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 0x7f0e40d57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27afca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27acf60>, '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 0x27add40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ae1d0>, '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': '232498196343f89f466a4a9a000001c8-1476446751.666417-1620542792', '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 05:06:18 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 05:06:18 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 05:06:18 INFO - Using env: {'DISPLAY': ':0', 05:06:18 INFO - 'HOME': '/home/cltbld', 05:06:18 INFO - 'LANG': 'en_US.UTF-8', 05:06:18 INFO - 'LANGUAGE': 'en_US:en', 05:06:18 INFO - 'LOGNAME': 'cltbld', 05:06:18 INFO - 'MAIL': '/var/mail/cltbld', 05:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:18 INFO - 'MOZ_NO_REMOTE': '1', 05:06:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:18 INFO - 'NO_EM_RESTART': '1', 05:06:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:18 INFO - 'PWD': '/builds/slave/test', 05:06:18 INFO - 'SHELL': '/bin/bash', 05:06:18 INFO - 'SHLVL': '1', 05:06:18 INFO - 'TERM': 'linux', 05:06:18 INFO - 'TMOUT': '86400', 05:06:18 INFO - 'USER': 'cltbld', 05:06:18 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1476446751.666417-1620542792', 05:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:18 INFO - '_': '/tools/buildbot/bin/python'} 05:06:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:18 INFO - Downloading/unpacking blobuploader==1.2.4 05:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:20 INFO - Downloading blobuploader-1.2.4.tar.gz 05:06:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:06:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06: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 05:06:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:06:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:06:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:06:21 INFO - Downloading docopt-0.6.1.tar.gz 05:06:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:06:21 INFO - Installing collected packages: blobuploader, requests, docopt 05:06:21 INFO - Running setup.py install for blobuploader 05:06:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:06:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:06:21 INFO - Running setup.py install for requests 05:06:21 INFO - Running setup.py install for docopt 05:06:21 INFO - Successfully installed blobuploader requests docopt 05:06:21 INFO - Cleaning up... 05:06:21 INFO - Return code: 0 05:06:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06:21 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')]} 05:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:21 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')]} 05:06:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:21 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 0x7f0e40d57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27afca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27acf60>, '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 0x27add40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ae1d0>, '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': '232498196343f89f466a4a9a000001c8-1476446751.666417-1620542792', '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 05:06:21 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 05:06:21 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 05:06:21 INFO - Using env: {'DISPLAY': ':0', 05:06:21 INFO - 'HOME': '/home/cltbld', 05:06:21 INFO - 'LANG': 'en_US.UTF-8', 05:06:21 INFO - 'LANGUAGE': 'en_US:en', 05:06:21 INFO - 'LOGNAME': 'cltbld', 05:06:21 INFO - 'MAIL': '/var/mail/cltbld', 05:06:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:21 INFO - 'MOZ_NO_REMOTE': '1', 05:06:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:21 INFO - 'NO_EM_RESTART': '1', 05:06:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:21 INFO - 'PWD': '/builds/slave/test', 05:06:21 INFO - 'SHELL': '/bin/bash', 05:06:21 INFO - 'SHLVL': '1', 05:06:21 INFO - 'TERM': 'linux', 05:06:21 INFO - 'TMOUT': '86400', 05:06:21 INFO - 'USER': 'cltbld', 05:06:21 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1476446751.666417-1620542792', 05:06:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:21 INFO - '_': '/tools/buildbot/bin/python'} 05:06:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:06:22 INFO - Running setup.py (path:/tmp/pip-k4KHi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:06:22 INFO - Running setup.py (path:/tmp/pip-xcKEUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:06:22 INFO - Running setup.py (path:/tmp/pip-qLoMW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:06:22 INFO - Running setup.py (path:/tmp/pip-MdyESe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:06:22 INFO - Running setup.py (path:/tmp/pip-C1HPBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:06:22 INFO - Running setup.py (path:/tmp/pip-Cvw3bd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:06:22 INFO - Running setup.py (path:/tmp/pip-oTF8Xk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:06:22 INFO - Running setup.py (path:/tmp/pip-JXn2lp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:06:22 INFO - Running setup.py (path:/tmp/pip-W_yPsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:06:22 INFO - Running setup.py (path:/tmp/pip-NyPAo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:06:22 INFO - Running setup.py (path:/tmp/pip-QgLBuu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:06:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:06:22 INFO - Running setup.py (path:/tmp/pip-UFdsxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:06:23 INFO - Running setup.py (path:/tmp/pip-VNrCmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:06:23 INFO - Running setup.py (path:/tmp/pip-gz2XsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:23 INFO - Running setup.py (path:/tmp/pip-h7UlHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:06:23 INFO - Running setup.py (path:/tmp/pip-Aik6zR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:06:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:06:23 INFO - Running setup.py (path:/tmp/pip-BNdOtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:06:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:06:23 INFO - Running setup.py install for manifestparser 05:06:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:06:23 INFO - Running setup.py install for mozcrash 05:06:23 INFO - Running setup.py install for mozdebug 05:06:23 INFO - Running setup.py install for mozdevice 05:06:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:06:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:06:23 INFO - Running setup.py install for mozfile 05:06:23 INFO - Running setup.py install for mozhttpd 05:06:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:06:23 INFO - Running setup.py install for mozinfo 05:06:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:06:24 INFO - Running setup.py install for mozInstall 05:06:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:06:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:06:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:06:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:06:24 INFO - Running setup.py install for mozleak 05:06:24 INFO - Running setup.py install for mozlog 05:06:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:06:24 INFO - Running setup.py install for moznetwork 05:06:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:06:24 INFO - Running setup.py install for mozprocess 05:06:24 INFO - Running setup.py install for mozprofile 05:06:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:06:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:06:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:06:24 INFO - Running setup.py install for mozrunner 05:06:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:06:24 INFO - Running setup.py install for mozscreenshot 05:06:24 INFO - Running setup.py install for moztest 05:06:25 INFO - Running setup.py install for mozversion 05:06:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:06:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:06:25 INFO - Cleaning up... 05:06:25 INFO - Return code: 0 05:06:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:06:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:25 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 0x7f0e40d57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27afca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27acf60>, '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 0x27add40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ae1d0>, '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': '232498196343f89f466a4a9a000001c8-1476446751.666417-1620542792', '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 05:06:25 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 05:06:25 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 05:06:25 INFO - Using env: {'DISPLAY': ':0', 05:06:25 INFO - 'HOME': '/home/cltbld', 05:06:25 INFO - 'LANG': 'en_US.UTF-8', 05:06:25 INFO - 'LANGUAGE': 'en_US:en', 05:06:25 INFO - 'LOGNAME': 'cltbld', 05:06:25 INFO - 'MAIL': '/var/mail/cltbld', 05:06:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:25 INFO - 'MOZ_NO_REMOTE': '1', 05:06:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:25 INFO - 'NO_EM_RESTART': '1', 05:06:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:25 INFO - 'PWD': '/builds/slave/test', 05:06:25 INFO - 'SHELL': '/bin/bash', 05:06:25 INFO - 'SHLVL': '1', 05:06:25 INFO - 'TERM': 'linux', 05:06:25 INFO - 'TMOUT': '86400', 05:06:25 INFO - 'USER': 'cltbld', 05:06:25 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1476446751.666417-1620542792', 05:06:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:25 INFO - '_': '/tools/buildbot/bin/python'} 05:06:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:06:25 INFO - Running setup.py (path:/tmp/pip-WKqpTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:06:25 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)) 05:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:06:25 INFO - Running setup.py (path:/tmp/pip-xQBE95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:06:25 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)) 05:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:06:25 INFO - Running setup.py (path:/tmp/pip-1mSuhv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:06:25 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)) 05:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:06:25 INFO - Running setup.py (path:/tmp/pip-xP6Wyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:06:25 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)) 05:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:06:25 INFO - Running setup.py (path:/tmp/pip-FVZzHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:06:25 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)) 05:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:06:25 INFO - Running setup.py (path:/tmp/pip-Td3J5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:06:25 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)) 05:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:06:25 INFO - Running setup.py (path:/tmp/pip-gAk_N9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:06:25 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)) 05:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:06:25 INFO - Running setup.py (path:/tmp/pip-C4FWxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:06:25 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)) 05:06:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:06:25 INFO - Running setup.py (path:/tmp/pip-zlhxc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:06:26 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)) 05:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:06:26 INFO - Running setup.py (path:/tmp/pip-RbuAwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:06:26 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)) 05:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:06:26 INFO - Running setup.py (path:/tmp/pip-qhfMzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:06:26 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)) 05:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:06:26 INFO - Running setup.py (path:/tmp/pip-uojsv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:06:26 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)) 05:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:06:26 INFO - Running setup.py (path:/tmp/pip-d4jV3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:06:26 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)) 05:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:06:26 INFO - Running setup.py (path:/tmp/pip-STNakE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:06:26 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)) 05:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:26 INFO - Running setup.py (path:/tmp/pip-tm95GL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:06:26 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)) 05:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:06:26 INFO - Running setup.py (path:/tmp/pip-GtwUmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:06:26 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)) 05:06:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:06:26 INFO - Running setup.py (path:/tmp/pip-S6qWYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:06:26 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)) 05:06:26 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)) 05:06:26 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)) 05:06:26 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)) 05:06:26 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)) 05:06:26 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)) 05:06:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:06:26 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 05:06:26 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 05:06:26 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 05:06:26 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 05:06:26 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 05:06:26 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 05:06:28 INFO - Downloading blessings-1.6.tar.gz 05:06:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:06:28 INFO - Installing collected packages: blessings 05:06:28 INFO - Running setup.py install for blessings 05:06:28 INFO - Successfully installed blessings 05:06:28 INFO - Cleaning up... 05:06:28 INFO - Return code: 0 05:06:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:06:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:06:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:06:29 INFO - Reading from file tmpfile_stdout 05:06:29 INFO - Current package versions: 05:06:29 INFO - argparse == 1.2.1 05:06:29 INFO - blessings == 1.6 05:06:29 INFO - blobuploader == 1.2.4 05:06:29 INFO - docopt == 0.6.1 05:06:29 INFO - functools32 == 3.2.3-2 05:06:29 INFO - jsonschema == 2.5.1 05:06:29 INFO - manifestparser == 1.1 05:06:29 INFO - mozInstall == 1.12 05:06:29 INFO - mozcrash == 0.17 05:06:29 INFO - mozdebug == 0.1 05:06:29 INFO - mozdevice == 0.48 05:06:29 INFO - mozfile == 1.2 05:06:29 INFO - mozhttpd == 0.7 05:06:29 INFO - mozinfo == 0.9 05:06:29 INFO - mozleak == 0.1 05:06:29 INFO - mozlog == 3.4 05:06:29 INFO - moznetwork == 0.27 05:06:29 INFO - mozprocess == 0.23 05:06:29 INFO - mozprofile == 0.28 05:06:29 INFO - mozrunner == 6.12 05:06:29 INFO - mozscreenshot == 0.1 05:06:29 INFO - mozsystemmonitor == 0.3 05:06:29 INFO - moztest == 0.7 05:06:29 INFO - mozversion == 1.4 05:06:29 INFO - psutil == 3.1.1 05:06:29 INFO - requests == 1.2.3 05:06:29 INFO - wsgiref == 0.1.2 05:06:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:06:29 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')]} 05:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:29 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')]} 05:06:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:29 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 0x7f0e40d57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27afca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27acf60>, '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 0x27add40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ae1d0>, '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': '232498196343f89f466a4a9a000001c8-1476446751.666417-1620542792', '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 05:06:29 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 05:06:29 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 05:06:29 INFO - Using env: {'DISPLAY': ':0', 05:06:29 INFO - 'HOME': '/home/cltbld', 05:06:29 INFO - 'LANG': 'en_US.UTF-8', 05:06:29 INFO - 'LANGUAGE': 'en_US:en', 05:06:29 INFO - 'LOGNAME': 'cltbld', 05:06:29 INFO - 'MAIL': '/var/mail/cltbld', 05:06:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:29 INFO - 'MOZ_NO_REMOTE': '1', 05:06:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:29 INFO - 'NO_EM_RESTART': '1', 05:06:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:29 INFO - 'PWD': '/builds/slave/test', 05:06:29 INFO - 'SHELL': '/bin/bash', 05:06:29 INFO - 'SHLVL': '1', 05:06:29 INFO - 'TERM': 'linux', 05:06:29 INFO - 'TMOUT': '86400', 05:06:29 INFO - 'USER': 'cltbld', 05:06:29 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1476446751.666417-1620542792', 05:06:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:29 INFO - '_': '/tools/buildbot/bin/python'} 05:06:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:29 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)) 05:06:29 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)) 05:06:29 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)) 05:06:29 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)) 05:06:29 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)) 05:06:29 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)) 05:06:29 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)) 05:06:29 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)) 05:06:29 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)) 05:06:29 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)) 05:06:29 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)) 05:06:29 INFO - Cleaning up... 05:06:29 INFO - Return code: 0 05:06:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:06:29 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')]} 05:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:06:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:29 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')]} 05:06:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:06:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:06:29 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 0x7f0e40d57f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27afca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27acf60>, '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 0x27add40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ae1d0>, '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': '232498196343f89f466a4a9a000001c8-1476446751.666417-1620542792', '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 05:06:29 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 05:06:29 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 05:06:29 INFO - Using env: {'DISPLAY': ':0', 05:06:29 INFO - 'HOME': '/home/cltbld', 05:06:29 INFO - 'LANG': 'en_US.UTF-8', 05:06:29 INFO - 'LANGUAGE': 'en_US:en', 05:06:29 INFO - 'LOGNAME': 'cltbld', 05:06:29 INFO - 'MAIL': '/var/mail/cltbld', 05:06:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:29 INFO - 'MOZ_NO_REMOTE': '1', 05:06:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:29 INFO - 'NO_EM_RESTART': '1', 05:06:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:29 INFO - 'PWD': '/builds/slave/test', 05:06:29 INFO - 'SHELL': '/bin/bash', 05:06:29 INFO - 'SHLVL': '1', 05:06:29 INFO - 'TERM': 'linux', 05:06:29 INFO - 'TMOUT': '86400', 05:06:29 INFO - 'USER': 'cltbld', 05:06:29 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1476446751.666417-1620542792', 05:06:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:29 INFO - '_': '/tools/buildbot/bin/python'} 05:06:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:06:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:06:29 INFO - Cleaning up... 05:06:29 INFO - Return code: 0 05:06:29 INFO - Running post-action listener: _resource_record_post_action 05:06:29 INFO - Running post-action listener: _start_resource_monitoring 05:06:29 INFO - Starting resource monitoring. 05:06:29 INFO - [mozharness: 2016-10-14 12:06:29.501113Z] Finished create-virtualenv step (success) 05:06:29 INFO - [mozharness: 2016-10-14 12:06:29.501688Z] Running install step. 05:06:29 INFO - Running pre-action listener: _resource_record_pre_action 05:06:29 INFO - Running main action method: install 05:06:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:06:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:06:29 INFO - Reading from file tmpfile_stdout 05:06:29 INFO - Detecting whether we're running mozinstall >=1.0... 05:06:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:06:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:06:29 INFO - Reading from file tmpfile_stdout 05:06:29 INFO - Output received: 05:06:29 INFO - Usage: mozinstall [options] installer 05:06:29 INFO - Options: 05:06:29 INFO - -h, --help show this help message and exit 05:06:29 INFO - -d DEST, --destination=DEST 05:06:29 INFO - Directory to install application into. [default: 05:06:29 INFO - "/builds/slave/test"] 05:06:29 INFO - --app=APP Application being installed. [default: firefox] 05:06:29 INFO - mkdir: /builds/slave/test/build/application 05:06:29 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'] 05:06:29 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 05:06:45 INFO - Reading from file tmpfile_stdout 05:06:45 INFO - Output received: 05:06:45 INFO - /builds/slave/test/build/application/firefox/firefox 05:06:45 INFO - Running post-action listener: _resource_record_post_action 05:06:45 INFO - [mozharness: 2016-10-14 12:06:45.869605Z] Finished install step (success) 05:06:45 INFO - [mozharness: 2016-10-14 12:06:45.869850Z] Running run-tests step. 05:06:45 INFO - Running pre-action listener: _resource_record_pre_action 05:06:45 INFO - Running main action method: run_tests 05:06:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:06:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:06:45 INFO - Python 2.7.3 05:06:45 INFO - Return code: 0 05:06:45 INFO - grabbing minidump binary from tooltool 05:06:45 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')]} 05:06:45 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 0x27acf60>, '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 0x27add40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27ae1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:06:45 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 05:06:45 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 05:06:45 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 05:06:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:06:45 INFO - Return code: 0 05:06:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:06:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:06:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:06:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:06:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:06:45 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/P0Vca6-TQmm_RTkJdIAjSg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 05:06:45 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/P0Vca6-TQmm_RTkJdIAjSg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 05:06:45 INFO - Using env: {'DISPLAY': ':0', 05:06:45 INFO - 'HOME': '/home/cltbld', 05:06:45 INFO - 'LANG': 'en_US.UTF-8', 05:06:45 INFO - 'LANGUAGE': 'en_US:en', 05:06:45 INFO - 'LOGNAME': 'cltbld', 05:06:45 INFO - 'MAIL': '/var/mail/cltbld', 05:06:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:06:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:06:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:06:45 INFO - 'MOZ_NO_REMOTE': '1', 05:06:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:06:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:06:45 INFO - 'NO_EM_RESTART': '1', 05:06:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:06:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:06:45 INFO - 'PWD': '/builds/slave/test', 05:06:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:06:45 INFO - 'SHELL': '/bin/bash', 05:06:45 INFO - 'SHLVL': '1', 05:06:45 INFO - 'TERM': 'linux', 05:06:45 INFO - 'TMOUT': '86400', 05:06:45 INFO - 'USER': 'cltbld', 05:06:45 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1476446751.666417-1620542792', 05:06:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:06:45 INFO - '_': '/tools/buildbot/bin/python'} 05:06:45 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/P0Vca6-TQmm_RTkJdIAjSg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 05:06:46 INFO - mozversion application_buildid: 20161014032941 05:06:46 INFO - mozversion application_changeset: 1391a2889aeb2bdd61ad6ef838e65826e35aabc2 05:06:46 INFO - mozversion application_display_name: Nightly 05:06:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:06:46 INFO - mozversion application_name: Firefox 05:06:46 INFO - mozversion application_remotingname: firefox 05:06:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:06:46 INFO - mozversion application_vendor: Mozilla 05:06:46 INFO - mozversion application_version: 52.0a1 05:06:46 INFO - mozversion platform_buildid: 20161014032941 05:06:46 INFO - mozversion platform_changeset: 1391a2889aeb2bdd61ad6ef838e65826e35aabc2 05:06:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:06:46 INFO - mozversion platform_version: 52.0a1 05:06:46 INFO - using testdate: 1476446806 05:06:46 INFO - actual date: 1476446806 05:06:46 INFO - starting webserver on 'localhost:40491' 05:06:46 INFO - SUITE-START | Running 2 tests 05:06:46 INFO - TEST-START | dromaeo_css 05:06:46 INFO - operating with platform_type : linux_ 05:06:46 INFO - Initialising browser for dromaeo_css test... 05:06:46 INFO - TEST-INFO | started process 3583 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAZlOQi/profile http://localhost:40491/getInfo.html) 05:06:50 INFO - PROCESS | 3583 | __metrics Screen width/height:1600/1200 05:06:50 INFO - PROCESS | 3583 | colorDepth:24 05:06:50 INFO - PROCESS | 3583 | Browser inner width/height: 1024/697 05:06:50 INFO - PROCESS | 3583 | __metrics 05:06:51 INFO - PROCESS | 3583 | 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" 05:06:51 INFO - PROCESS | 3583 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:06:51 INFO - PROCESS | 3583 | console.error: PushService: 05:06:51 INFO - PROCESS | 3583 | stateChangeProcessEnqueue: Error transitioning state 05:06:51 INFO - PROCESS | 3583 | UnknownError 05:06:52 INFO - TEST-INFO | 3583: exit 0 05:06:52 INFO - Browser initialized. 05:06:52 INFO - Running cycle 1/1 for dromaeo_css test... 05:06:52 INFO - TEST-INFO | started process 3664 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAZlOQi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:07:04 INFO - PROCESS | 3664 | RSS: Main: 173522944 05:07:04 INFO - PROCESS | 3664 | 05:07:56 INFO - PROCESS | 3664 | 1476446876413 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] 05:10:10 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:40491/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40491/tests/dromaeo/cssquery-ext.html) 05:10:11 INFO - PROCESS | 3664 | RSS: Main: 310513664 05:10:11 INFO - PROCESS | 3664 | 05:13:14 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:40491/tests/dromaeo/cssquery-ext.html (next: http://localhost:40491/tests/dromaeo/cssquery-jquery.html) 05:13:15 INFO - PROCESS | 3664 | RSS: Main: 283049984 05:13:15 INFO - PROCESS | 3664 | 05:16:17 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:40491/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40491/tests/dromaeo/cssquery-mootools.html) 05:16:17 INFO - PROCESS | 3664 | RSS: Main: 220622848 05:16:17 INFO - PROCESS | 3664 | 05:19:20 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:40491/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40491/tests/dromaeo/cssquery-prototype.html) 05:19:20 INFO - PROCESS | 3664 | RSS: Main: 218996736 05:19:20 INFO - PROCESS | 3664 | 05:22:24 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:40491/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40491/tests/dromaeo/cssquery-yui.html) 05:22:24 INFO - PROCESS | 3664 | RSS: Main: 220467200 05:22:24 INFO - PROCESS | 3664 | 05:25:27 INFO - PROCESS | 3664 | Cycle 1(1): loaded http://localhost:40491/tests/dromaeo/cssquery-yui.html (next: http://localhost:40491/tests/dromaeo/cssquery-dojo.html) 05:25:28 INFO - PROCESS | 3664 | RSS: Main: 308772864 05:25:28 INFO - PROCESS | 3664 | 05:25:28 INFO - PROCESS | 3664 | __start_tp_report 05:25:28 INFO - PROCESS | 3664 | _x_x_mozilla_page_load 05:25:28 INFO - PROCESS | 3664 | _x_x_mozilla_page_load_details 05:25:28 INFO - PROCESS | 3664 | |i|pagename|runs| 05:25:28 INFO - PROCESS | 3664 | |0;dojo.html;2531.265932879465;2555.9233223003293;2573.639690443338;2597.0131350086963;2606.3353844769595;4474.060447306069;4521.186186486431;4524.208263553882;4571.657125715568;4584;4487.820487180517;4552.430946131733;4573.153966516197;4575.656825738066;4603.40155779749;4195.517515485728;4222.366645003243;4233.407322974786;4261.3607958806115;4272.124214536013;4210.221109094812;4255.17024180285;4268;4269.765162916038;4270.338097594878;4180.456540649727;4184.958150418503;4186.979065104671;4202.894927626803;4255.957440425587;4259.190753756808;4260.1053778706355;4261.573842615745;4271.63691086258;4321.157374312011;4073.8574149904907;4104.548499665035;4120.979395103005;4200.348945913388;4244.278472659656;4492.056668099703;4495.887602809923;4517.367568540407;4536.2741961286365;4551.8634440966825;4801.447833499157;4817.879553011167;4847.587955023827;4888.975555122237;4902.730349830758;4753.429588449409;4826.0347930414055;4871.244957031666;4890.339804126433;4936.6297527685565;4490.236659767847;4490.910181796346;4498.145352383037;4506.594406503365;4510.458744950627;4910.754462276872;4953.578945789648;4957.157283261854;5023.372078490189;5033.874153146201;4759.6668233223345;4761.666683332202;4763.809447622126;4808.807647694053;4825.613950883921;4838.056578967138;4851.80592776285;4856.465788763233;4857.489963553847;4903.239997800275;4626.282926146453;4721.409823772028;4724.692894961817;4798.5441383068555;4856.927146092811;4758.11974784659;4785.617150627942;4802.73584952831;4842.104210720958;4850.248211527219;4086.3257562501853;4124.237016152021;4126.071633882352;4168.937465938014;4176.164767046603;3630.8910732678064;3633.927321453609;3634.909127271839;3656.7074634029213;3685.8157092145284;4034.8789536313957;4117.526484454266;4125.339945608748;4144.461220041436;4188.329867221291;4837.105135549864;4846.975765121152;4853.805847766121;4855.198892182821;4855.6115510759055;4151.937720934188;4154.729942553724;4158.521769996429;4158.771267580251;4163.063310755117;4360.563943605677;4388.341748737651;4396.956030439655;4400.669949753781;4448.799804008828;4490.932636010528;4519.163954668397;4530.456345238461;4532.90934181308;4589.655775816827;4716.716996980193;4884.609231261419;4891.5353041461;4894.486078961658;4943.184374578154;4437.844675436344;4492.73043617384;4506.459224893034;4527.977360113178;4543.65922555803;4812.374391329105;4818.229083346648;4819.614430845594;4875.43932447773;4879.170541008109;4838.298446725275;4872.293517439881;4880.536349046835;4881.463039065629;4948.257761335684;4598.425196850394;4649.232876575327;4735.715857048588;4750.643701722315;4758.7858546364805;4738.97630511859;4740.454847692559;4780.426348838023;4784.665073444826;4801.7118972861745;4672.672912896064;4675.041616468684;4682.2040253156365;4729.148753224453;4733.786979585858;4624.514425985223;4685.718856868599;4750.382450281441;4802.135615589227;4811.422629284508;4681.906361872811;4709.058188362273;4712.269598212282;4762.3570817939135;4771.5467030632035 05:25:28 INFO - PROCESS | 3664 | |1;ext.html;545.2339463054408;565.9349174844891;567.7955935863089;577.9624324418916;582.2750675409117;27556.724432755665;28135.718642813565;37106.814465927666;38362.23275534488;38587.807060964726;38994.22011559767;39562.60437395625;39613.603863961354;39621.80189099057;39638.20723585527;7594.848103037936;7743.419243556727;7743.5353878767455;7744.186860379636;7748.612569371537;7637.961810190969;7725.111612164589;7726.266004729542;7731.188225236354;7735.1491335953;7721.729739459092;7745.109312429058;7752.186020467854;7762.146163921964;7762.8447431051345;7697.923020769805;7745.373471570977;7747.2640099190485;7748.2251774822635;7751.728689495841;7694.345980591656;7766.805829854242;7766.9902912621;7771.261730135628;7772.961135194344;35815.82092089549;36131.4580281296;36233.27533449316;36255.63744362549;36260.27479450423;2835.2628316637615;2952.6161598991994;3101.6122984626923;3496.5454490916018;3543.202779374646;26997.595036074476;27361;27574.5863812043;27683.446331073468;27744.861275693693;3197.216681912946;3214.3089235814414;3380.797152170878;3386.1196089016785;3399.2351720862607;232166;232942;233736;234450;235289;26700.866495667397;49223.75388123036;49657.50342496601;49676.50323496719;49701;32581.837090814395;32712.672873270963;32771.672283276865;32776.50835237473;32778.67221327804;12312;12450;12462.376881155906;12464.626061218178;12465.314407707481;10031.899681003242;10153.746156346151;10155.847662285072;10156.339837910513;10161.339512931636;7618.923810761932;7739.883901741366;7781.5331080135375;7782.92217077822;7795.259450352208;3025.3344264261827;3057.801242919203;3062.6937306269197;3089.1813669377634;3126.2340726522148;871.3856731004627;902.3052249767642;907.1336873285996;938.0947385772762;990.9355891867006;26833.597496037575;27052;27076.323091922466;27645.86177069142;27662.44675106527;927.5455027036838;946.394307643109;955.9187469065207;965.0928127560071;992.1814503035025;13908.582742517741;14459.638509037148;14543;14872.925635371754;14943.850561494246;361727;363766;364086;366902;368190;48008.27987580189;48647.270290945664;48655.75672121687;48801.2679809796;48846;1010.0959641121156;1068.038765111406;1121.1647322744607;1148.8391625172483;1157.1321508868348;26374.472510550066;27210.591841122794;27556.311092222855;28597;28813.855930720212;40467.190656186125;41258.38112428256;41261.1747765049;41280;41290;254136.83452661688;254972;255617;256694;257873;21677.566448671252;22440.77559224387;23681.64477532873;24878.75121248837;24943.62584561197;39769;39967.20065598613;40095.799521002205;40165.79917100396;40465;34158.65841341555;34238.315233695685;34402;34757.826210869796;34793.826030869684;34045.829770850985;34311.65688343085;34607.653923461454;34871.82564087163;34971.82514087515;34103.48844767281;34265.98202567851;34838;35070.82464587661;35300.117497062776;29477.410451790416;31974.200644984063;32082.518762219053;32084.67915320817;32099;24109.276721698378;24228.51542969166;24333;24588.139415120386;24712 05:25:28 INFO - PROCESS | 3664 | |2;jquery.html;336.71883976879303;347.5950517646941;349.2874535946669;351.6518646539926;383.7198844843264;12175.695607609814;13234.139780914245;15609.297581608826;16178.75731864023;16398.18009099546;13421.261830599338;13919.373628186731;14104.64738381541;14334;14547.127172369665;4539.2056390131675;4696.483386827446;4704.623630109583;4705.694129881564;4706.152892479352;4682.648801339896;4886.584640305578;5102.2091575805625;5119.641625086246;5124.5644120249635;5089.669171503859;5092.643514953955;5094.133997220481;5096.082705113078;5098.490150984909;4602.447706275235;4642.210824159901;4647.117047760915;4659.2312268475835;5084.084864724348;4512.548745125494;4512.9774351128035;4515.5710207530565;4516.07420478801;4520.073384956077;11360.488778004927;11781.882181178164;11915.702107447296;11977.101717371232;12024.579139730067;1797.8651601129968;1862.1992543206416;2070.3167954575106;2086.54096098858;2357.7288611809518;8838.204561589424;9042.457452552868;9117.179453849185;9156.450612963243;9557.808843823084;1651.3889860751478;1719.346648273648;1728.0927513055622;1732.748751431048;1752.6144248265362;58804;61032.38967610356;68492;69414.30585694179;70269.29730702679;9312.48781317034;9645.71062868115;9719.951400242953;9744.12302892743;9890.307678462439;13021.674458138623;13038.869611303955;13062.804057939138;13068;13088.08383413152;6320.5891617044745;6581.703823327962;6584.078229047937;6715.46276297895;6808.727650894008;6177.135201071854;6187.041008643668;6346.11154438379;6375.649339286291;6375.872482550323;3996.9400458993136;4008.719389642697;4097.918041639151;4115.464989551339;4242;1656.2629629814858;1697.9575510612333;1731.2296028267301;1757.745126956584;1768.4871387297796;733.2960358056325;774.2721841469001;786.6066966516742;862.2110768646744;870.9346798990101;16033.118178500294;16436.424725134562;16856.66286674284;16889.15554222284;17334.133293335282;796.3430170109683;799.2646764976236;818.2226884459787;848.5799529233069;853.5177624642057;8856.291496680378;9508.239340852715;9526.285528585384;9579.089986451276;9621.326507144433;357667;362575;363255;367371;369037;70435.64782176056;74551.25448745552;74555;76341.61829190819;76738;879.5778026547293;889.4618755652866;911.7355966769562;913.36064754672;917.4220241247971;14373.856261437251;14760.48338308154;15190.46833360827;15856.365745370056;15953.361865525249;37656.24687506289;37693;37997.81001094977;38723;38731;47719.522804772896;48014;48141.518584813704;48280;50694.493055068975;6904.654767261717;7076.973838793449;7132.714691412285;7194.820129496805;7216.386607138452;9829;10488.842667359842;10571.471426428801;10697.572097116028;10699.14406847466;8428.410011299151;8790.340724445565;9079.68221112258;9195.954020229856;9408.1532662058;8696.260817830555;8790.38467307308;8858.73423797287;9251.259899207913;9265.119813617695;8444.704435344733;8705.521196334263;8805.251553617758;8814.559272036244;8816.250618697226;6758.459323254227;7083.893741593984;7098.6450677466955;7124.643767811693;7362.9631851840395;7030.929690703232;7772.922270777446;8873.201411872962;8992.640294388151;9418.293627978066 05:25:28 INFO - PROCESS | 3664 | |3;mootools.html;1221.7739718152147;1331.7669407853623;1379.1518216296977;1417.6314158318835;1673.5733983613336;6380.553361264713;6802.55783374081;6938.653067346631;7181.17416497103;7192.388646965014;7393.741219057334;7465.701371945116;7478.140013898404;7487.138979017414;7501.849963000736;2100.8004239597253;2129.680547917817;2130.2650585547963;2134.338355109921;2134.8719076855436;2037.3174986379581;2073.5334549726267;2119.586680597284;2121.236354912238;2122.692209629603;2076.9303808538616;2102.579484103178;2113.725215721954;2116.9894150529226;2139.12295958657;2036.378904434147;2041.836653067751;2045.3659365596714;2046.7850875657991;2048.0988365119374;2058.207590077816;2059.052835695582;2081.687746837971;2089.477630592352;2089.9791002090087;7114.928850711479;7188.496805223636;7201.89197162043;7386.372158366492;7401.259874012556;4416.80124394403;4545.36364908913;4549.840755573539;4550.704204226748;4556.589906908361;2838.8296702197936;2968.0502239283437;2995.4907665696883;3008.6540047894555;3023.246517020123;926.9629214831399;938.6949241496472;949.9572519236651;950.0974074629061;951.286535098676;9667;9742.07450292221;9749.756256093584;9754.268429867718;9760.609575616896;3821.9808900955873;3920.6079392061138;3935.547412047651;3956.3669812830385;4125.876223713233;7714.498557593738;7820.648070836826;7821.882671759929;7844;7858;4420.248557745191;4426.18115648606;4432.2908334666945;4435.866923992286;4436.334549817553;3447.1899103710607;3570.696490798311;3943.743656662308;4127.4015267786;4129.318662420667;3247.8726434185646;3285.671432856743;3404.3701915145775;3412.8293585320635;3416.350893330259;1025.7640742629087;1039.3140527251978;1039.7036844499432;1045.905868471826;1061.1828891753307;610.584802334408;788.5505262000604;809.9959500202461;811.3144392987916;812.4921923797626;4655.674102812771;4691.249400095969;4711.81152753886;5099.617528685363;5178.922316165261;801.2068052627973;804.5816175588661;846.331398195431;877.7498412952278;877.8419884420738;3171.2864605463587;3269.73842092632;3306.272620023591;3323.418401779679;3439.3851912317796;8664.306855451548;8981.685641002665;9077.727668169966;9082.046385129599;9082.273418126533;9009.954950225207;9011.234045106108;9022.548872556346;9026.142516460926;9030.232430243372;6776.288489708608;6971.511994160462;7020.157581090302;7026.9648651756415;7030.613316267654;4877.829275975324;4906.95093049065;4930.260460930889;4947.802087916443;4950.331705219749;7933.722319718782;8200.630971606412;8211.260986511243;8236.752897413087;8241.052278987992;8322.875156872531;8408.2432581068;8459.661613535389;8466.280366168945;8547;5387.299651045339;5575.414581469049;5800;5908.940910590839;5913.083472061838;6763.729450821912;7039.084918960502;7079.469039822137;7235.457340699574;7238.710451582088;6150.507959363151;6276.592021518769;6321.0834429008455;6429.58207716497;6548.967255163884;6290.24517057956;6352.618842869442;6369.936300636934;6372.681365931778;6377.17096777416;5605.49550540437;5701.942980570141;5704.600677952503;5708.257926469532;5708.828735137952;3912.8043597820565;3960.5841386653988;4054.7567145971334;4065.654419374386;4088.427620133124;3978.622030907059;4013.7190396671954;4040.5353384361174;4041.191761647741;4179.832806687698 05:25:28 INFO - PROCESS | 3664 | |4;prototype.html;280.60995216648854;285.82993119094147;287.35632183908046;299.45050831723773;303.2797106871181;4583.312503124533;4728.858134255969;4783.234682450809;4831.3719216501895;4842.418909730833;4517.4579050513985;4671.626269898408;4671.649626278026;4689.484156742756;4694.6244300455965;3511.666391692785;3658.3414985302634;3751.4056525976353;3760.548734151892;3766.491523644307;3638.945415818765;3756.1736417988136;3758.857451252787;3783.1487915218995;3787.640174183462;3728.4780130781714;3732.3095227382887;3734.4045888107776;3737.4020156774923;3757.4739536464917;3746.932124344549;3752.3620984432578;3757.830897609614;3762.7366084374103;3762.9247415051545;3263.282077942849;3298;3298.1424829544253;3330.833458327074;3333.21669407689;4568.634509239253;4588.862334129982;4589.380433641449;4590.268790069903;4599.379083823708;4224.155168966188;4234.184267462134;4249.447571815645;4251.4685664291965;4272.508661503935;4720.834770783041;4916;4920.335754673145;4922.827701030483;4930.235813448921;3479;3486.267883744417;3491.423915054013;3491.493733408667;3497.4404095344876;5178.4562620924635;5196.740162991835;5246.134387826004;5262.868428289246;5263.947060646351;3465.9826700866333;3583.623719509466;3609.7473176877365;3617.4031284837706;3632.418812989909;3626.6917312028772;3664;3664.3770559005034;3676.2279921216846;3678.31951089044;4141.399497072968;4155.501339839238;4183.518895327076;4210.5578914214175;4214.3889136075095;4543.795529201194;4729.17239483096;4995.375578052744;5003.449620541737;5009;1227.4783217132683;1253.8370011898394;1254.9395760582292;1255.2970336611527;1256.5162412471263;778.9026371703537;799.400449662753;815.48216882279;815.8211384549388;816.3713940266081;3890.513685789276;3901.804909754501;3914.8042597869994;3925.2149570085526;3939.6060393960947;4484.663650226246;4488.506264310923;4505.752183629932;4525.52481989393;4528.320751887243;3934.803259836997;3942.7383237364343;3947.013246688328;3956.2592459317807;3963.504561929759;2332.440214348544;2347.8356515043783;2402.687650605445;2418.806495480357;2439.7438268981855;4225.408442818008;4238.597333253336;4240.731208803276;4253.191893540279;4263.31599018386;4593.793279302439;4600.677952543289;4627.67606267558;4662.254039353755;4666.719996800135;4208.726432781859;4230.259704551691;4238.554951730024;4418.889527761768;4814;5108.361454818148;5122.410922743783;5183.5593974512585;5188.377394712658;5190.169572868323;5062.645614806928;5073.365829271341;5076.162433198481;5086.694798312114;5090.389153301628;4572.657050721143;4724.4094488188975;4795.6163506918665;4823.756953016864;4827.662063655651;3685.70514358856;3703.6481534254203;3711.1649878777057;3712.3503386907723;3714.9071273218387;4944.851654450372;5100.693958362362;5147.507222905316;5154.742262886765;5167.6641018333685;4850.151223535797;4933.360652051136;4959.231319145538;4968.453470118212;4969.453360130455;4939.678920870132;4968.8757781055765;4991.625628077982;4998.450790097004;5011.574016208663;4756.286557016475;4895.583875370491;4896.608271338356;4913;4931.3589233399425;4988.553319537294;5001.349824522788;5017.37282839645;5020.171671674133;5027.296178534935;4898.681585696918;4919.458859525521;4940.777665005012;4956.207006878882;4964.900701986012 05:25:28 INFO - PROCESS | 3664 | |5;yui.html;590.0883135555566;607.0590584593884;680.6018479189676;693.9965300173495;700.8142842146832;11758.353290569015;12087.335196564185;12225.388730563469;12237.816432753516;13347.933260333684;12275.815862762065;12539.373031348441;12541.372931353419;12551.874481255185;12552.497900083985;617.2931992868163;765.4374035084222;785.8349746553203;787.7557957033309;788.9289963903248;638.2373064188297;764.2815753191982;791.2443616346404;797.7447216890597;798.1021350980147;827.6606591297569;830.3647709502236;830.5182993863544;830.7466222802043;831.0442990560873;641.4804008752878;814.763718521628;817.5993763056059;817.750586071248;818.5743413424985;490.09821927652933;576.2911618709012;595.3391735173954;599.5084031094505;599.5143933413905;12717.109802313842;12781.16922400041;12791.552295669608;12796.104272700915;12797.104202705814;11663.941680291544;12145;12151.756964860742;12172.756544869142;12846.550370737074;11413;11523;11785.351805650685;11790.941045294805;12099.57651482194;3694.07648087978;3710.684591809699;3763.096856754359;3850.1337199130253;3883.59222281662;61264.999999999556;62037.37962620406;62507.687461562855;63615.363846361404;63799.6810015947;9431.292653051049;9516.476593787269;9613.086756758097;9660.806783864284;9721.125098741006;19201.039948002544;19257.711134332996;19318.227270909287;19356.90321548383;19715.211391544177;6255.624662520263;6452.193475815523;6477.093206951031;6553.737850486023;6562.868742625121;3347.2636020075543;3361.61341445732;3405.5402520659395;3424.33225521021;3459.6713312235297;2733.2620192548297;2814.3949050954143;2832;2832.56095305228;2840.162152165075;468.5853020077188;468.9109069276827;471.58029353875077;475.75974133062584;481.99277010844867;529.6080900133874;530.5543343591324;547.7015026810398;548.3036543589699;570.6148349863826;7314.817129571697;7467.720369594336;7490.737824176128;7757.224277572198;7911.446198766032;480.23162939296844;557.3479029535372;559.5244042563869;561.6517758989371;581.1863391252281;3425.794452332868;3512.964870351315;3643.398839191557;3678.4666223397458;3691.3909204981414;54330.72834635802;55478.7808487656;58571;98936;101644;84802.57598711966;86085.56957215299;86729.56635216784;89851;90297;73916.63041684758;75026.62486687422;76271;76840.61579692065;76994.23005769982;6881.13985751781;6969.128858892638;6969.756058537927;7005.369516743313;7466.178720340867;44440.777796110815;44662;45303.32045019393;45443.318350224115;47574.76212618915;60146;60788.69605651943;64510;65747;69076.309236907;9361.344705870524;9384.390014649027;9406.1064198901;9421.104995025462;9648.951755241178;10448.68653940383;10452.372857628567;10545.52545135486;10607;10742.24804263694;8786.472811631322;8831.64673413082;8971.50656713887;9363.063693630582;9373.390729602554;9361.953190234006;9393.953030234805;9408.059194080537;9423.528823558932;9494.525273736424;9410.858837117587;9448.48033358172;9742.415455072718;9847.162991145546;10064.597416103274;8089.2315230053055;8187.71343002992;8281.92435571542;8326.583670816555;8517.190866867637;8082.797930051795;8293.709720160006;8389.580520974048;8393.748187554384;8412.49112423108 05:25:28 INFO - PROCESS | 3664 | __end_tp_report 05:25:28 INFO - PROCESS | 3664 | __start_cc_report 05:25:28 INFO - PROCESS | 3664 | _x_x_mozilla_cycle_collect,1489 05:25:28 INFO - PROCESS | 3664 | __end_cc_report 05:25:28 INFO - PROCESS | 3664 | __startTimestamp1476447928056__endTimestamp 05:25:28 INFO - PROCESS | 3664 | 05:25:28 INFO - PROCESS | 3664 | ------- Summary: start ------- 05:25:28 INFO - PROCESS | 3664 | Number of tests: 6 05:25:28 INFO - PROCESS | 3664 | 05:25:28 INFO - PROCESS | 3664 | [#0] dojo.html Cycles:165 Average:4492.45 Median:4584.00 stddev:459.10 (10.0%) stddev-sans-first:433.96 05:25:28 INFO - PROCESS | 3664 | Values: 2531.3 2555.9 2573.6 2597.0 2606.3 4474.1 4521.2 4524.2 4571.7 4584.0 4487.8 4552.4 4573.2 4575.7 4603.4 4195.5 4222.4 4233.4 4261.4 4272.1 4210.2 4255.2 4268.0 4269.8 4270.3 4180.5 4185.0 4187.0 4202.9 4256.0 4259.2 4260.1 4261.6 4271.6 4321.2 4073.9 4104.5 4121.0 4200.3 4244.3 4492.1 4495.9 4517.4 4536.3 4551.9 4801.4 4817.9 4847.6 4889.0 4902.7 4753.4 4826.0 4871.2 4890.3 4936.6 4490.2 4490.9 4498.1 4506.6 4510.5 4910.8 4953.6 4957.2 5023.4 5033.9 4759.7 4761.7 4763.8 4808.8 4825.6 4838.1 4851.8 4856.5 4857.5 4903.2 4626.3 4721.4 4724.7 4798.5 4856.9 4758.1 4785.6 4802.7 4842.1 4850.2 4086.3 4124.2 4126.1 4168.9 4176.2 3630.9 3633.9 3634.9 3656.7 3685.8 4034.9 4117.5 4125.3 4144.5 4188.3 4837.1 4847.0 4853.8 4855.2 4855.6 4151.9 4154.7 4158.5 4158.8 4163.1 4360.6 4388.3 4397.0 4400.7 4448.8 4490.9 4519.2 4530.5 4532.9 4589.7 4716.7 4884.6 4891.5 4894.5 4943.2 4437.8 4492.7 4506.5 4528.0 4543.7 4812.4 4818.2 4819.6 4875.4 4879.2 4838.3 4872.3 4880.5 4881.5 4948.3 4598.4 4649.2 4735.7 4750.6 4758.8 4739.0 4740.5 4780.4 4784.7 4801.7 4672.7 4675.0 4682.2 4729.1 4733.8 4624.5 4685.7 4750.4 4802.1 4811.4 4681.9 4709.1 4712.3 4762.4 4771.5 05:25:28 INFO - PROCESS | 3664 | 05:25:28 INFO - PROCESS | 3664 | [#1] ext.html Cycles:180 Average:42607.90 Median:34815.91 stddev:76527.34 (219.8%) stddev-sans-first:76676.86 05:25:28 INFO - PROCESS | 3664 | Values: 545.2 565.9 567.8 578.0 582.3 27556.7 28135.7 37106.8 38362.2 38587.8 38994.2 39562.6 39613.6 39621.8 39638.2 7594.8 7743.4 7743.5 7744.2 7748.6 7638.0 7725.1 7726.3 7731.2 7735.1 7721.7 7745.1 7752.2 7762.1 7762.8 7697.9 7745.4 7747.3 7748.2 7751.7 7694.3 7766.8 7767.0 7771.3 7773.0 35815.8 36131.5 36233.3 36255.6 36260.3 2835.3 2952.6 3101.6 3496.5 3543.2 26997.6 27361.0 27574.6 27683.4 27744.9 3197.2 3214.3 3380.8 3386.1 3399.2 232166.0 232942.0 233736.0 234450.0 235289.0 26700.9 49223.8 49657.5 49676.5 49701.0 32581.8 32712.7 32771.7 32776.5 32778.7 12312.0 12450.0 12462.4 12464.6 12465.3 10031.9 10153.7 10155.8 10156.3 10161.3 7618.9 7739.9 7781.5 7782.9 7795.3 3025.3 3057.8 3062.7 3089.2 3126.2 871.4 902.3 907.1 938.1 990.9 26833.6 27052.0 27076.3 27645.9 27662.4 927.5 946.4 955.9 965.1 992.2 13908.6 14459.6 14543.0 14872.9 14943.9 361727.0 363766.0 364086.0 366902.0 368190.0 48008.3 48647.3 48655.8 48801.3 48846.0 1010.1 1068.0 1121.2 1148.8 1157.1 26374.5 27210.6 27556.3 28597.0 28813.9 40467.2 41258.4 41261.2 41280.0 41290.0 254136.8 254972.0 255617.0 256694.0 257873.0 21677.6 22440.8 23681.6 24878.8 24943.6 39769.0 39967.2 40095.8 40165.8 40465.0 34158.7 34238.3 34402.0 34757.8 34793.8 34045.8 34311.7 34607.7 34871.8 34971.8 34103.5 34266.0 34838.0 35070.8 35300.1 29477.4 31974.2 32082.5 32084.7 32099.0 24109.3 24228.5 24333.0 24588.1 24712.0 05:25:28 INFO - PROCESS | 3664 | 05:25:28 INFO - PROCESS | 3664 | [#2] jquery.html Cycles:180 Average:22603.38 Median:5086.88 stddev:60273.73 (1184.9%) stddev-sans-first:60419.63 05:25:28 INFO - PROCESS | 3664 | Values: 336.7 347.6 349.3 351.7 383.7 12175.7 13234.1 15609.3 16178.8 16398.2 13421.3 13919.4 14104.6 14334.0 14547.1 4539.2 4696.5 4704.6 4705.7 4706.2 4682.6 4886.6 5102.2 5119.6 5124.6 5089.7 5092.6 5094.1 5096.1 5098.5 4602.4 4642.2 4647.1 4659.2 5084.1 4512.5 4513.0 4515.6 4516.1 4520.1 11360.5 11781.9 11915.7 11977.1 12024.6 1797.9 1862.2 2070.3 2086.5 2357.7 8838.2 9042.5 9117.2 9156.5 9557.8 1651.4 1719.3 1728.1 1732.7 1752.6 58804.0 61032.4 68492.0 69414.3 70269.3 9312.5 9645.7 9720.0 9744.1 9890.3 13021.7 13038.9 13062.8 13068.0 13088.1 6320.6 6581.7 6584.1 6715.5 6808.7 6177.1 6187.0 6346.1 6375.6 6375.9 3996.9 4008.7 4097.9 4115.5 4242.0 1656.3 1698.0 1731.2 1757.7 1768.5 733.3 774.3 786.6 862.2 870.9 16033.1 16436.4 16856.7 16889.2 17334.1 796.3 799.3 818.2 848.6 853.5 8856.3 9508.2 9526.3 9579.1 9621.3 357667.0 362575.0 363255.0 367371.0 369037.0 70435.6 74551.3 74555.0 76341.6 76738.0 879.6 889.5 911.7 913.4 917.4 14373.9 14760.5 15190.5 15856.4 15953.4 37656.2 37693.0 37997.8 38723.0 38731.0 47719.5 48014.0 48141.5 48280.0 50694.5 6904.7 7077.0 7132.7 7194.8 7216.4 9829.0 10488.8 10571.5 10697.6 10699.1 8428.4 8790.3 9079.7 9196.0 9408.2 8696.3 8790.4 8858.7 9251.3 9265.1 8444.7 8705.5 8805.3 8814.6 8816.3 6758.5 7083.9 7098.6 7124.6 7363.0 7030.9 7772.9 8873.2 8992.6 9418.3 05:25:28 INFO - PROCESS | 3664 | 05:25:28 INFO - PROCESS | 3664 | [#3] mootools.html Cycles:180 Average:4766.33 Median:5481.36 stddev:2628.93 (48.0%) stddev-sans-first:2622.80 05:25:28 INFO - PROCESS | 3664 | Values: 1221.8 1331.8 1379.2 1417.6 1673.6 6380.6 6802.6 6938.7 7181.2 7192.4 7393.7 7465.7 7478.1 7487.1 7501.8 2100.8 2129.7 2130.3 2134.3 2134.9 2037.3 2073.5 2119.6 2121.2 2122.7 2076.9 2102.6 2113.7 2117.0 2139.1 2036.4 2041.8 2045.4 2046.8 2048.1 2058.2 2059.1 2081.7 2089.5 2090.0 7114.9 7188.5 7201.9 7386.4 7401.3 4416.8 4545.4 4549.8 4550.7 4556.6 2838.8 2968.1 2995.5 3008.7 3023.2 927.0 938.7 950.0 950.1 951.3 9667.0 9742.1 9749.8 9754.3 9760.6 3822.0 3920.6 3935.5 3956.4 4125.9 7714.5 7820.6 7821.9 7844.0 7858.0 4420.2 4426.2 4432.3 4435.9 4436.3 3447.2 3570.7 3943.7 4127.4 4129.3 3247.9 3285.7 3404.4 3412.8 3416.4 1025.8 1039.3 1039.7 1045.9 1061.2 610.6 788.6 810.0 811.3 812.5 4655.7 4691.2 4711.8 5099.6 5178.9 801.2 804.6 846.3 877.7 877.8 3171.3 3269.7 3306.3 3323.4 3439.4 8664.3 8981.7 9077.7 9082.0 9082.3 9010.0 9011.2 9022.5 9026.1 9030.2 6776.3 6971.5 7020.2 7027.0 7030.6 4877.8 4907.0 4930.3 4947.8 4950.3 7933.7 8200.6 8211.3 8236.8 8241.1 8322.9 8408.2 8459.7 8466.3 8547.0 5387.3 5575.4 5800.0 5908.9 5913.1 6763.7 7039.1 7079.5 7235.5 7238.7 6150.5 6276.6 6321.1 6429.6 6549.0 6290.2 6352.6 6369.9 6372.7 6377.2 5605.5 5701.9 5704.6 5708.3 5708.8 3912.8 3960.6 4054.8 4065.7 4088.4 3978.6 4013.7 4040.5 4041.2 4179.8 05:25:28 INFO - PROCESS | 3664 | 05:25:28 INFO - PROCESS | 3664 | [#4] prototype.html Cycles:180 Average:4034.74 Median:4497.13 stddev:1178.94 (26.2%) stddev-sans-first:1148.08 05:25:28 INFO - PROCESS | 3664 | Values: 280.6 285.8 287.4 299.5 303.3 4583.3 4728.9 4783.2 4831.4 4842.4 4517.5 4671.6 4671.6 4689.5 4694.6 3511.7 3658.3 3751.4 3760.5 3766.5 3638.9 3756.2 3758.9 3783.1 3787.6 3728.5 3732.3 3734.4 3737.4 3757.5 3746.9 3752.4 3757.8 3762.7 3762.9 3263.3 3298.0 3298.1 3330.8 3333.2 4568.6 4588.9 4589.4 4590.3 4599.4 4224.2 4234.2 4249.4 4251.5 4272.5 4720.8 4916.0 4920.3 4922.8 4930.2 3479.0 3486.3 3491.4 3491.5 3497.4 5178.5 5196.7 5246.1 5262.9 5263.9 3466.0 3583.6 3609.7 3617.4 3632.4 3626.7 3664.0 3664.4 3676.2 3678.3 4141.4 4155.5 4183.5 4210.6 4214.4 4543.8 4729.2 4995.4 5003.4 5009.0 1227.5 1253.8 1254.9 1255.3 1256.5 778.9 799.4 815.5 815.8 816.4 3890.5 3901.8 3914.8 3925.2 3939.6 4484.7 4488.5 4505.8 4525.5 4528.3 3934.8 3942.7 3947.0 3956.3 3963.5 2332.4 2347.8 2402.7 2418.8 2439.7 4225.4 4238.6 4240.7 4253.2 4263.3 4593.8 4600.7 4627.7 4662.3 4666.7 4208.7 4230.3 4238.6 4418.9 4814.0 5108.4 5122.4 5183.6 5188.4 5190.2 5062.6 5073.4 5076.2 5086.7 5090.4 4572.7 4724.4 4795.6 4823.8 4827.7 3685.7 3703.6 3711.2 3712.4 3714.9 4944.9 5100.7 5147.5 5154.7 5167.7 4850.2 4933.4 4959.2 4968.5 4969.5 4939.7 4968.9 4991.6 4998.5 5011.6 4756.3 4895.6 4896.6 4913.0 4931.4 4988.6 5001.3 5017.4 5020.2 5027.3 4898.7 4919.5 4940.8 4956.2 4964.9 05:25:28 INFO - PROCESS | 3664 | 05:25:28 INFO - PROCESS | 3664 | [#5] yui.html Cycles:180 Average:16811.07 Median:31327.34 stddev:24391.19 (77.9%) stddev-sans-first:24429.20 05:25:28 INFO - PROCESS | 3664 | Values: 590.1 607.1 680.6 694.0 700.8 11758.4 12087.3 12225.4 12237.8 13347.9 12275.8 12539.4 12541.4 12551.9 12552.5 617.3 765.4 785.8 787.8 788.9 638.2 764.3 791.2 797.7 798.1 827.7 830.4 830.5 830.7 831.0 641.5 814.8 817.6 817.8 818.6 490.1 576.3 595.3 599.5 599.5 12717.1 12781.2 12791.6 12796.1 12797.1 11663.9 12145.0 12151.8 12172.8 12846.6 11413.0 11523.0 11785.4 11790.9 12099.6 3694.1 3710.7 3763.1 3850.1 3883.6 61265.0 62037.4 62507.7 63615.4 63799.7 9431.3 9516.5 9613.1 9660.8 9721.1 19201.0 19257.7 19318.2 19356.9 19715.2 6255.6 6452.2 6477.1 6553.7 6562.9 3347.3 3361.6 3405.5 3424.3 3459.7 2733.3 2814.4 2832.0 2832.6 2840.2 468.6 468.9 471.6 475.8 482.0 529.6 530.6 547.7 548.3 570.6 7314.8 7467.7 7490.7 7757.2 7911.4 480.2 557.3 559.5 561.7 581.2 3425.8 3513.0 3643.4 3678.5 3691.4 54330.7 55478.8 58571.0 98936.0 101644.0 84802.6 86085.6 86729.6 89851.0 90297.0 73916.6 75026.6 76271.0 76840.6 76994.2 6881.1 6969.1 6969.8 7005.4 7466.2 44440.8 44662.0 45303.3 45443.3 47574.8 60146.0 60788.7 64510.0 65747.0 69076.3 9361.3 9384.4 9406.1 9421.1 9649.0 10448.7 10452.4 10545.5 10607.0 10742.2 8786.5 8831.6 8971.5 9363.1 9373.4 9362.0 9394.0 9408.1 9423.5 9494.5 9410.9 9448.5 9742.4 9847.2 10064.6 8089.2 8187.7 8281.9 8326.6 8517.2 8082.8 8293.7 8389.6 8393.7 8412.5 05:25:28 INFO - PROCESS | 3664 | -------- Summary: end -------- 05:25:28 INFO - PROCESS | 3664 | 05:25:29 INFO - TEST-INFO | 3664: exit 0 05:25:29 INFO - TEST-OK | dromaeo_css | took 1122939ms 05:25:29 INFO - TEST-START | kraken 05:25:29 INFO - operating with platform_type : linux_ 05:25:29 INFO - Initialising browser for kraken test... 05:25:29 INFO - TEST-INFO | started process 3973 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfzitTc/profile http://localhost:40491/getInfo.html) 05:25:33 INFO - PROCESS | 3973 | __metrics Screen width/height:1600/1200 05:25:33 INFO - PROCESS | 3973 | colorDepth:24 05:25:33 INFO - PROCESS | 3973 | Browser inner width/height: 1024/697 05:25:33 INFO - PROCESS | 3973 | __metrics 05:25:34 INFO - PROCESS | 3973 | 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" 05:25:34 INFO - PROCESS | 3973 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:25:34 INFO - PROCESS | 3973 | console.error: PushService: 05:25:34 INFO - PROCESS | 3973 | stateChangeProcessEnqueue: Error transitioning state 05:25:34 INFO - PROCESS | 3973 | UnknownError 05:25:35 INFO - TEST-INFO | 3973: exit 0 05:25:35 INFO - Browser initialized. 05:25:35 INFO - Running cycle 1/1 for kraken test... 05:25:35 INFO - TEST-INFO | started process 4055 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfzitTc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:25:47 INFO - PROCESS | 4055 | RSS: Main: 173441024 05:25:47 INFO - PROCESS | 4055 | 05:25:50 INFO - PROCESS | 4055 | Cycle 1(1): loaded http://localhost:40491/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40491/tests/kraken/driver.html?testName=audio-beat-detection) 05:25:51 INFO - PROCESS | 4055 | RSS: Main: 230182912 05:25:51 INFO - PROCESS | 4055 | 05:25:54 INFO - PROCESS | 4055 | Cycle 1(1): loaded http://localhost:40491/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40491/tests/kraken/driver.html?testName=audio-dft) 05:25:54 INFO - PROCESS | 4055 | RSS: Main: 217403392 05:25:54 INFO - PROCESS | 4055 | 05:25:58 INFO - PROCESS | 4055 | Cycle 1(1): loaded http://localhost:40491/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40491/tests/kraken/driver.html?testName=audio-fft) 05:25:58 INFO - PROCESS | 4055 | RSS: Main: 300101632 05:25:58 INFO - PROCESS | 4055 | 05:26:01 INFO - PROCESS | 4055 | Cycle 1(1): loaded http://localhost:40491/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40491/tests/kraken/driver.html?testName=audio-oscillator) 05:26:01 INFO - PROCESS | 4055 | RSS: Main: 210960384 05:26:01 INFO - PROCESS | 4055 | 05:26:03 INFO - PROCESS | 4055 | Cycle 1(1): loaded http://localhost:40491/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40491/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:26:04 INFO - PROCESS | 4055 | RSS: Main: 213803008 05:26:04 INFO - PROCESS | 4055 | 05:26:07 INFO - PROCESS | 4055 | Cycle 1(1): loaded http://localhost:40491/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40491/tests/kraken/driver.html?testName=imaging-darkroom) 05:26:08 INFO - PROCESS | 4055 | RSS: Main: 249643008 05:26:08 INFO - PROCESS | 4055 | 05:26:11 INFO - PROCESS | 4055 | Cycle 1(1): loaded http://localhost:40491/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40491/tests/kraken/driver.html?testName=imaging-desaturate) 05:26:12 INFO - PROCESS | 4055 | RSS: Main: 248311808 05:26:12 INFO - PROCESS | 4055 | 05:26:15 INFO - PROCESS | 4055 | Cycle 1(1): loaded http://localhost:40491/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40491/tests/kraken/driver.html?testName=json-parse-financial) 05:26:15 INFO - PROCESS | 4055 | RSS: Main: 248401920 05:26:15 INFO - PROCESS | 4055 | 05:26:17 INFO - PROCESS | 4055 | Cycle 1(1): loaded http://localhost:40491/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40491/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:26:18 INFO - PROCESS | 4055 | RSS: Main: 210534400 05:26:18 INFO - PROCESS | 4055 | 05:26:19 INFO - PROCESS | 4055 | Cycle 1(1): loaded http://localhost:40491/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40491/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:26:20 INFO - PROCESS | 4055 | RSS: Main: 217481216 05:26:20 INFO - PROCESS | 4055 | 05:26:22 INFO - PROCESS | 4055 | Cycle 1(1): loaded http://localhost:40491/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40491/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:26:23 INFO - PROCESS | 4055 | RSS: Main: 226381824 05:26:23 INFO - PROCESS | 4055 | 05:26:26 INFO - PROCESS | 4055 | Cycle 1(1): loaded http://localhost:40491/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40491/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:26:27 INFO - PROCESS | 4055 | RSS: Main: 235802624 05:26:27 INFO - PROCESS | 4055 | 05:26:30 INFO - PROCESS | 4055 | Cycle 1(1): loaded http://localhost:40491/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40491/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:26:30 INFO - PROCESS | 4055 | RSS: Main: 232259584 05:26:30 INFO - PROCESS | 4055 | 05:26:32 INFO - PROCESS | 4055 | Cycle 1(1): loaded http://localhost:40491/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40491/tests/kraken/driver.html?testName=ai-astar) 05:26:32 INFO - PROCESS | 4055 | RSS: Main: 282591232 05:26:32 INFO - PROCESS | 4055 | 05:26:32 INFO - PROCESS | 4055 | __start_tp_report 05:26:32 INFO - PROCESS | 4055 | _x_x_mozilla_page_load 05:26:32 INFO - PROCESS | 4055 | _x_x_mozilla_page_load_details 05:26:32 INFO - PROCESS | 4055 | |i|pagename|runs| 05:26:32 INFO - PROCESS | 4055 | |0;ai-astar;108;114;115;116;114;115;114;115;114;116 05:26:32 INFO - PROCESS | 4055 | |1;audio-beat-detection;155;128;128;162;130;126;129;126;157;133 05:26:32 INFO - PROCESS | 4055 | |2;audio-dft;163;163;163;164;163;163;163;162;162;160 05:26:32 INFO - PROCESS | 4055 | |3;audio-fft;76;75;76;102;77;76;76;76;103;76 05:26:32 INFO - PROCESS | 4055 | |4;audio-oscillator;84;84;129;85;85;84;107;85;83;113 05:26:32 INFO - PROCESS | 4055 | |5;imaging-gaussian-blur;118;117;117;117;117;117;117;117;117;117 05:26:32 INFO - PROCESS | 4055 | |6;imaging-darkroom;147;147;146;147;147;147;146;147;147;147 05:26:32 INFO - PROCESS | 4055 | |7;imaging-desaturate;85;85;85;85;85;84;85;85;84;85 05:26:32 INFO - PROCESS | 4055 | |8;json-parse-financial;65;66;65;64;65;73;64;65;68;65 05:26:32 INFO - PROCESS | 4055 | |9;json-stringify-tinderbox;67;67;68;67;68;67;67;67;67;68 05:26:32 INFO - PROCESS | 4055 | |10;stanford-crypto-aes;83;83;86;91;82;84;92;82;83;83 05:26:32 INFO - PROCESS | 4055 | |11;stanford-crypto-ccm;140;150;148;140;139;151;139;140;179;139 05:26:32 INFO - PROCESS | 4055 | |12;stanford-crypto-pbkdf2;177;180;179;184;183;183;176;174;173;177 05:26:32 INFO - PROCESS | 4055 | |13;stanford-crypto-sha256-iterative;71;70;70;70;70;69;69;75;69;71 05:26:32 INFO - PROCESS | 4055 | __end_tp_report 05:26:32 INFO - PROCESS | 4055 | __start_cc_report 05:26:32 INFO - PROCESS | 4055 | _x_x_mozilla_cycle_collect,1986 05:26:32 INFO - PROCESS | 4055 | __end_cc_report 05:26:32 INFO - PROCESS | 4055 | __startTimestamp1476447992712__endTimestamp 05:26:32 INFO - PROCESS | 4055 | 05:26:32 INFO - PROCESS | 4055 | ------- Summary: start ------- 05:26:32 INFO - PROCESS | 4055 | Number of tests: 14 05:26:32 INFO - PROCESS | 4055 | 05:26:32 INFO - PROCESS | 4055 | [#0] ai-astar Cycles:10 Average:114.10 Median:115.00 stddev:2.28 (2.0%) stddev-sans-first:0.83 05:26:32 INFO - PROCESS | 4055 | Values: 108.0 114.0 115.0 116.0 114.0 115.0 114.0 115.0 114.0 116.0 05:26:32 INFO - PROCESS | 4055 | 05:26:32 INFO - PROCESS | 4055 | [#1] audio-beat-detection Cycles:10 Average:137.40 Median:131.50 stddev:14.45 (11.0%) stddev-sans-first:13.86 05:26:32 INFO - PROCESS | 4055 | Values: 155.0 128.0 128.0 162.0 130.0 126.0 129.0 126.0 157.0 133.0 05:26:32 INFO - PROCESS | 4055 | 05:26:32 INFO - PROCESS | 4055 | [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:1.07 (0.7%) stddev-sans-first:1.13 05:26:32 INFO - PROCESS | 4055 | Values: 163.0 163.0 163.0 164.0 163.0 163.0 163.0 162.0 162.0 160.0 05:26:32 INFO - PROCESS | 4055 | 05:26:32 INFO - PROCESS | 4055 | [#3] audio-fft Cycles:10 Average:81.30 Median:76.00 stddev:11.19 (14.7%) stddev-sans-first:11.70 05:26:32 INFO - PROCESS | 4055 | Values: 76.0 75.0 76.0 102.0 77.0 76.0 76.0 76.0 103.0 76.0 05:26:32 INFO - PROCESS | 4055 | 05:26:32 INFO - PROCESS | 4055 | [#4] audio-oscillator Cycles:10 Average:93.90 Median:84.00 stddev:16.39 (19.5%) stddev-sans-first:16.99 05:26:32 INFO - PROCESS | 4055 | Values: 84.0 84.0 129.0 85.0 85.0 84.0 107.0 85.0 83.0 113.0 05:26:32 INFO - PROCESS | 4055 | 05:26:32 INFO - PROCESS | 4055 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 05:26:32 INFO - PROCESS | 4055 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 05:26:32 INFO - PROCESS | 4055 | 05:26:32 INFO - PROCESS | 4055 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 05:26:32 INFO - PROCESS | 4055 | Values: 147.0 147.0 146.0 147.0 147.0 147.0 146.0 147.0 147.0 147.0 05:26:32 INFO - PROCESS | 4055 | 05:26:32 INFO - PROCESS | 4055 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 05:26:32 INFO - PROCESS | 4055 | Values: 85.0 85.0 85.0 85.0 85.0 84.0 85.0 85.0 84.0 85.0 05:26:32 INFO - PROCESS | 4055 | 05:26:32 INFO - PROCESS | 4055 | [#8] json-parse-financial Cycles:10 Average:66.00 Median:65.00 stddev:2.71 (4.2%) stddev-sans-first:2.85 05:26:32 INFO - PROCESS | 4055 | Values: 65.0 66.0 65.0 64.0 65.0 73.0 64.0 65.0 68.0 65.0 05:26:32 INFO - PROCESS | 4055 | 05:26:32 INFO - PROCESS | 4055 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 05:26:32 INFO - PROCESS | 4055 | Values: 67.0 67.0 68.0 67.0 68.0 67.0 67.0 67.0 67.0 68.0 05:26:32 INFO - PROCESS | 4055 | 05:26:32 INFO - PROCESS | 4055 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:83.50 stddev:3.67 (4.4%) stddev-sans-first:3.82 05:26:32 INFO - PROCESS | 4055 | Values: 83.0 83.0 86.0 91.0 82.0 84.0 92.0 82.0 83.0 83.0 05:26:32 INFO - PROCESS | 4055 | 05:26:32 INFO - PROCESS | 4055 | [#11] stanford-crypto-ccm Cycles:10 Average:146.50 Median:144.00 stddev:12.41 (8.6%) stddev-sans-first:12.94 05:26:32 INFO - PROCESS | 4055 | Values: 140.0 150.0 148.0 140.0 139.0 151.0 139.0 140.0 179.0 139.0 05:26:32 INFO - PROCESS | 4055 | 05:26:32 INFO - PROCESS | 4055 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.60 Median:179.50 stddev:3.86 (2.2%) stddev-sans-first:4.06 05:26:32 INFO - PROCESS | 4055 | Values: 177.0 180.0 179.0 184.0 183.0 183.0 176.0 174.0 173.0 177.0 05:26:32 INFO - PROCESS | 4055 | 05:26:32 INFO - PROCESS | 4055 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:70.00 stddev:1.78 (2.5%) stddev-sans-first:1.87 05:26:32 INFO - PROCESS | 4055 | Values: 71.0 70.0 70.0 70.0 70.0 69.0 69.0 75.0 69.0 71.0 05:26:32 INFO - PROCESS | 4055 | -------- Summary: end -------- 05:26:32 INFO - PROCESS | 4055 | 05:26:34 INFO - TEST-INFO | 4055: exit 0 05:26:34 INFO - TEST-OK | kraken | took 64990ms 05:26:34 INFO - SUITE-END | took 1187s 05:26:34 INFO - Completed test suite (00:19:48) 05:26:34 INFO - javascript benchmark 05:26:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2531.265932879465, 2555.9233223003293, 2573.639690443338, 2597.0131350086963, 2606.3353844769595, 4474.060447306069, 4521.186186486431, 4524.208263553882, 4571.657125715568, 4584.0, 4487.820487180517, 4552.430946131733, 4573.153966516197, 4575.656825738066, 4603.40155779749, 4195.517515485728, 4222.366645003243, 4233.407322974786, 4261.3607958806115, 4272.124214536013, 4210.221109094812, 4255.17024180285, 4268.0, 4269.765162916038, 4270.338097594878, 4180.456540649727, 4184.958150418503, 4186.979065104671, 4202.894927626803, 4255.957440425587, 4259.190753756808, 4260.1053778706355, 4261.573842615745, 4271.63691086258, 4321.157374312011, 4073.8574149904907, 4104.548499665035, 4120.979395103005, 4200.348945913388, 4244.278472659656, 4492.056668099703, 4495.887602809923, 4517.367568540407, 4536.2741961286365, 4551.8634440966825, 4801.447833499157, 4817.879553011167, 4847.587955023827, 4888.975555122237, 4902.730349830758, 4753.429588449409, 4826.0347930414055, 4871.244957031666, 4890.339804126433, 4936.6297527685565, 4490.236659767847, 4490.910181796346, 4498.145352383037, 4506.594406503365, 4510.458744950627, 4910.754462276872, 4953.578945789648, 4957.157283261854, 5023.372078490189, 5033.874153146201, 4759.6668233223345, 4761.666683332202, 4763.809447622126, 4808.807647694053, 4825.613950883921, 4838.056578967138, 4851.80592776285, 4856.465788763233, 4857.489963553847, 4903.239997800275, 4626.282926146453, 4721.409823772028, 4724.692894961817, 4798.5441383068555, 4856.927146092811, 4758.11974784659, 4785.617150627942, 4802.73584952831, 4842.104210720958, 4850.248211527219, 4086.3257562501853, 4124.237016152021, 4126.071633882352, 4168.937465938014, 4176.164767046603, 3630.8910732678064, 3633.927321453609, 3634.909127271839, 3656.7074634029213, 3685.8157092145284, 4034.8789536313957, 4117.526484454266, 4125.339945608748, 4144.461220041436, 4188.329867221291, 4837.105135549864, 4846.975765121152, 4853.805847766121, 4855.198892182821, 4855.6115510759055, 4151.937720934188, 4154.729942553724, 4158.521769996429, 4158.771267580251, 4163.063310755117, 4360.563943605677, 4388.341748737651, 4396.956030439655, 4400.669949753781, 4448.799804008828, 4490.932636010528, 4519.163954668397, 4530.456345238461, 4532.90934181308, 4589.655775816827, 4716.716996980193, 4884.609231261419, 4891.5353041461, 4894.486078961658, 4943.184374578154, 4437.844675436344, 4492.73043617384, 4506.459224893034, 4527.977360113178, 4543.65922555803, 4812.374391329105, 4818.229083346648, 4819.614430845594, 4875.43932447773, 4879.170541008109, 4838.298446725275, 4872.293517439881, 4880.536349046835, 4881.463039065629, 4948.257761335684, 4598.425196850394, 4649.232876575327, 4735.715857048588, 4750.643701722315, 4758.7858546364805, 4738.97630511859, 4740.454847692559, 4780.426348838023, 4784.665073444826, 4801.7118972861745, 4672.672912896064, 4675.041616468684, 4682.2040253156365, 4729.148753224453, 4733.786979585858, 4624.514425985223, 4685.718856868599, 4750.382450281441, 4802.135615589227, 4811.422629284508, 4681.906361872811, 4709.058188362273, 4712.269598212282, 4762.3570817939135, 4771.5467030632035], "value": 4463.93471433203, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.2339463054408, 565.9349174844891, 567.7955935863089, 577.9624324418916, 582.2750675409117, 27556.724432755665, 28135.718642813565, 37106.814465927666, 38362.23275534488, 38587.807060964726, 38994.22011559767, 39562.60437395625, 39613.603863961354, 39621.80189099057, 39638.20723585527, 7594.848103037936, 7743.419243556727, 7743.5353878767455, 7744.186860379636, 7748.612569371537, 7637.961810190969, 7725.111612164589, 7726.266004729542, 7731.188225236354, 7735.1491335953, 7721.729739459092, 7745.109312429058, 7752.186020467854, 7762.146163921964, 7762.8447431051345, 7697.923020769805, 7745.373471570977, 7747.2640099190485, 7748.2251774822635, 7751.728689495841, 7694.345980591656, 7766.805829854242, 7766.9902912621, 7771.261730135628, 7772.961135194344, 35815.82092089549, 36131.4580281296, 36233.27533449316, 36255.63744362549, 36260.27479450423, 2835.2628316637615, 2952.6161598991994, 3101.6122984626923, 3496.5454490916018, 3543.202779374646, 26997.595036074476, 27361.0, 27574.5863812043, 27683.446331073468, 27744.861275693693, 3197.216681912946, 3214.3089235814414, 3380.797152170878, 3386.1196089016785, 3399.2351720862607, 232166.0, 232942.0, 233736.0, 234450.0, 235289.0, 26700.866495667397, 49223.75388123036, 49657.50342496601, 49676.50323496719, 49701.0, 32581.837090814395, 32712.672873270963, 32771.672283276865, 32776.50835237473, 32778.67221327804, 12312.0, 12450.0, 12462.376881155906, 12464.626061218178, 12465.314407707481, 10031.899681003242, 10153.746156346151, 10155.847662285072, 10156.339837910513, 10161.339512931636, 7618.923810761932, 7739.883901741366, 7781.5331080135375, 7782.92217077822, 7795.259450352208, 3025.3344264261827, 3057.801242919203, 3062.6937306269197, 3089.1813669377634, 3126.2340726522148, 871.3856731004627, 902.3052249767642, 907.1336873285996, 938.0947385772762, 990.9355891867006, 26833.597496037575, 27052.0, 27076.323091922466, 27645.86177069142, 27662.44675106527, 927.5455027036838, 946.394307643109, 955.9187469065207, 965.0928127560071, 992.1814503035025, 13908.582742517741, 14459.638509037148, 14543.0, 14872.925635371754, 14943.850561494246, 361727.0, 363766.0, 364086.0, 366902.0, 368190.0, 48008.27987580189, 48647.270290945664, 48655.75672121687, 48801.2679809796, 48846.0, 1010.0959641121156, 1068.038765111406, 1121.1647322744607, 1148.8391625172483, 1157.1321508868348, 26374.472510550066, 27210.591841122794, 27556.311092222855, 28597.0, 28813.855930720212, 40467.190656186125, 41258.38112428256, 41261.1747765049, 41280.0, 41290.0, 254136.83452661688, 254972.0, 255617.0, 256694.0, 257873.0, 21677.566448671252, 22440.77559224387, 23681.64477532873, 24878.75121248837, 24943.62584561197, 39769.0, 39967.20065598613, 40095.799521002205, 40165.79917100396, 40465.0, 34158.65841341555, 34238.315233695685, 34402.0, 34757.826210869796, 34793.826030869684, 34045.829770850985, 34311.65688343085, 34607.653923461454, 34871.82564087163, 34971.82514087515, 34103.48844767281, 34265.98202567851, 34838.0, 35070.82464587661, 35300.117497062776, 29477.410451790416, 31974.200644984063, 32082.518762219053, 32084.67915320817, 32099.0, 24109.276721698378, 24228.51542969166, 24333.0, 24588.139415120386, 24712.0], "value": 15784.204248466249, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.71883976879303, 347.5950517646941, 349.2874535946669, 351.6518646539926, 383.7198844843264, 12175.695607609814, 13234.139780914245, 15609.297581608826, 16178.75731864023, 16398.18009099546, 13421.261830599338, 13919.373628186731, 14104.64738381541, 14334.0, 14547.127172369665, 4539.2056390131675, 4696.483386827446, 4704.623630109583, 4705.694129881564, 4706.152892479352, 4682.648801339896, 4886.584640305578, 5102.2091575805625, 5119.641625086246, 5124.5644120249635, 5089.669171503859, 5092.643514953955, 5094.133997220481, 5096.082705113078, 5098.490150984909, 4602.447706275235, 4642.210824159901, 4647.117047760915, 4659.2312268475835, 5084.084864724348, 4512.548745125494, 4512.9774351128035, 4515.5710207530565, 4516.07420478801, 4520.073384956077, 11360.488778004927, 11781.882181178164, 11915.702107447296, 11977.101717371232, 12024.579139730067, 1797.8651601129968, 1862.1992543206416, 2070.3167954575106, 2086.54096098858, 2357.7288611809518, 8838.204561589424, 9042.457452552868, 9117.179453849185, 9156.450612963243, 9557.808843823084, 1651.3889860751478, 1719.346648273648, 1728.0927513055622, 1732.748751431048, 1752.6144248265362, 58804.0, 61032.38967610356, 68492.0, 69414.30585694179, 70269.29730702679, 9312.48781317034, 9645.71062868115, 9719.951400242953, 9744.12302892743, 9890.307678462439, 13021.674458138623, 13038.869611303955, 13062.804057939138, 13068.0, 13088.08383413152, 6320.5891617044745, 6581.703823327962, 6584.078229047937, 6715.46276297895, 6808.727650894008, 6177.135201071854, 6187.041008643668, 6346.11154438379, 6375.649339286291, 6375.872482550323, 3996.9400458993136, 4008.719389642697, 4097.918041639151, 4115.464989551339, 4242.0, 1656.2629629814858, 1697.9575510612333, 1731.2296028267301, 1757.745126956584, 1768.4871387297796, 733.2960358056325, 774.2721841469001, 786.6066966516742, 862.2110768646744, 870.9346798990101, 16033.118178500294, 16436.424725134562, 16856.66286674284, 16889.15554222284, 17334.133293335282, 796.3430170109683, 799.2646764976236, 818.2226884459787, 848.5799529233069, 853.5177624642057, 8856.291496680378, 9508.239340852715, 9526.285528585384, 9579.089986451276, 9621.326507144433, 357667.0, 362575.0, 363255.0, 367371.0, 369037.0, 70435.64782176056, 74551.25448745552, 74555.0, 76341.61829190819, 76738.0, 879.5778026547293, 889.4618755652866, 911.7355966769562, 913.36064754672, 917.4220241247971, 14373.856261437251, 14760.48338308154, 15190.46833360827, 15856.365745370056, 15953.361865525249, 37656.24687506289, 37693.0, 37997.81001094977, 38723.0, 38731.0, 47719.522804772896, 48014.0, 48141.518584813704, 48280.0, 50694.493055068975, 6904.654767261717, 7076.973838793449, 7132.714691412285, 7194.820129496805, 7216.386607138452, 9829.0, 10488.842667359842, 10571.471426428801, 10697.572097116028, 10699.14406847466, 8428.410011299151, 8790.340724445565, 9079.68221112258, 9195.954020229856, 9408.1532662058, 8696.260817830555, 8790.38467307308, 8858.73423797287, 9251.259899207913, 9265.119813617695, 8444.704435344733, 8705.521196334263, 8805.251553617758, 8814.559272036244, 8816.250618697226, 6758.459323254227, 7083.893741593984, 7098.6450677466955, 7124.643767811693, 7362.9631851840395, 7030.929690703232, 7772.922270777446, 8873.201411872962, 8992.640294388151, 9418.293627978066], "value": 7538.783795090461, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1221.7739718152147, 1331.7669407853623, 1379.1518216296977, 1417.6314158318835, 1673.5733983613336, 6380.553361264713, 6802.55783374081, 6938.653067346631, 7181.17416497103, 7192.388646965014, 7393.741219057334, 7465.701371945116, 7478.140013898404, 7487.138979017414, 7501.849963000736, 2100.8004239597253, 2129.680547917817, 2130.2650585547963, 2134.338355109921, 2134.8719076855436, 2037.3174986379581, 2073.5334549726267, 2119.586680597284, 2121.236354912238, 2122.692209629603, 2076.9303808538616, 2102.579484103178, 2113.725215721954, 2116.9894150529226, 2139.12295958657, 2036.378904434147, 2041.836653067751, 2045.3659365596714, 2046.7850875657991, 2048.0988365119374, 2058.207590077816, 2059.052835695582, 2081.687746837971, 2089.477630592352, 2089.9791002090087, 7114.928850711479, 7188.496805223636, 7201.89197162043, 7386.372158366492, 7401.259874012556, 4416.80124394403, 4545.36364908913, 4549.840755573539, 4550.704204226748, 4556.589906908361, 2838.8296702197936, 2968.0502239283437, 2995.4907665696883, 3008.6540047894555, 3023.246517020123, 926.9629214831399, 938.6949241496472, 949.9572519236651, 950.0974074629061, 951.286535098676, 9667.0, 9742.07450292221, 9749.756256093584, 9754.268429867718, 9760.609575616896, 3821.9808900955873, 3920.6079392061138, 3935.547412047651, 3956.3669812830385, 4125.876223713233, 7714.498557593738, 7820.648070836826, 7821.882671759929, 7844.0, 7858.0, 4420.248557745191, 4426.18115648606, 4432.2908334666945, 4435.866923992286, 4436.334549817553, 3447.1899103710607, 3570.696490798311, 3943.743656662308, 4127.4015267786, 4129.318662420667, 3247.8726434185646, 3285.671432856743, 3404.3701915145775, 3412.8293585320635, 3416.350893330259, 1025.7640742629087, 1039.3140527251978, 1039.7036844499432, 1045.905868471826, 1061.1828891753307, 610.584802334408, 788.5505262000604, 809.9959500202461, 811.3144392987916, 812.4921923797626, 4655.674102812771, 4691.249400095969, 4711.81152753886, 5099.617528685363, 5178.922316165261, 801.2068052627973, 804.5816175588661, 846.331398195431, 877.7498412952278, 877.8419884420738, 3171.2864605463587, 3269.73842092632, 3306.272620023591, 3323.418401779679, 3439.3851912317796, 8664.306855451548, 8981.685641002665, 9077.727668169966, 9082.046385129599, 9082.273418126533, 9009.954950225207, 9011.234045106108, 9022.548872556346, 9026.142516460926, 9030.232430243372, 6776.288489708608, 6971.511994160462, 7020.157581090302, 7026.9648651756415, 7030.613316267654, 4877.829275975324, 4906.95093049065, 4930.260460930889, 4947.802087916443, 4950.331705219749, 7933.722319718782, 8200.630971606412, 8211.260986511243, 8236.752897413087, 8241.052278987992, 8322.875156872531, 8408.2432581068, 8459.661613535389, 8466.280366168945, 8547.0, 5387.299651045339, 5575.414581469049, 5800.0, 5908.940910590839, 5913.083472061838, 6763.729450821912, 7039.084918960502, 7079.469039822137, 7235.457340699574, 7238.710451582088, 6150.507959363151, 6276.592021518769, 6321.0834429008455, 6429.58207716497, 6548.967255163884, 6290.24517057956, 6352.618842869442, 6369.936300636934, 6372.681365931778, 6377.17096777416, 5605.49550540437, 5701.942980570141, 5704.600677952503, 5708.257926469532, 5708.828735137952, 3912.8043597820565, 3960.5841386653988, 4054.7567145971334, 4065.654419374386, 4088.427620133124, 3978.622030907059, 4013.7190396671954, 4040.5353384361174, 4041.191761647741, 4179.832806687698], "value": 3868.883939277183, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [280.60995216648854, 285.82993119094147, 287.35632183908046, 299.45050831723773, 303.2797106871181, 4583.312503124533, 4728.858134255969, 4783.234682450809, 4831.3719216501895, 4842.418909730833, 4517.4579050513985, 4671.626269898408, 4671.649626278026, 4689.484156742756, 4694.6244300455965, 3511.666391692785, 3658.3414985302634, 3751.4056525976353, 3760.548734151892, 3766.491523644307, 3638.945415818765, 3756.1736417988136, 3758.857451252787, 3783.1487915218995, 3787.640174183462, 3728.4780130781714, 3732.3095227382887, 3734.4045888107776, 3737.4020156774923, 3757.4739536464917, 3746.932124344549, 3752.3620984432578, 3757.830897609614, 3762.7366084374103, 3762.9247415051545, 3263.282077942849, 3298.0, 3298.1424829544253, 3330.833458327074, 3333.21669407689, 4568.634509239253, 4588.862334129982, 4589.380433641449, 4590.268790069903, 4599.379083823708, 4224.155168966188, 4234.184267462134, 4249.447571815645, 4251.4685664291965, 4272.508661503935, 4720.834770783041, 4916.0, 4920.335754673145, 4922.827701030483, 4930.235813448921, 3479.0, 3486.267883744417, 3491.423915054013, 3491.493733408667, 3497.4404095344876, 5178.4562620924635, 5196.740162991835, 5246.134387826004, 5262.868428289246, 5263.947060646351, 3465.9826700866333, 3583.623719509466, 3609.7473176877365, 3617.4031284837706, 3632.418812989909, 3626.6917312028772, 3664.0, 3664.3770559005034, 3676.2279921216846, 3678.31951089044, 4141.399497072968, 4155.501339839238, 4183.518895327076, 4210.5578914214175, 4214.3889136075095, 4543.795529201194, 4729.17239483096, 4995.375578052744, 5003.449620541737, 5009.0, 1227.4783217132683, 1253.8370011898394, 1254.9395760582292, 1255.2970336611527, 1256.5162412471263, 778.9026371703537, 799.400449662753, 815.48216882279, 815.8211384549388, 816.3713940266081, 3890.513685789276, 3901.804909754501, 3914.8042597869994, 3925.2149570085526, 3939.6060393960947, 4484.663650226246, 4488.506264310923, 4505.752183629932, 4525.52481989393, 4528.320751887243, 3934.803259836997, 3942.7383237364343, 3947.013246688328, 3956.2592459317807, 3963.504561929759, 2332.440214348544, 2347.8356515043783, 2402.687650605445, 2418.806495480357, 2439.7438268981855, 4225.408442818008, 4238.597333253336, 4240.731208803276, 4253.191893540279, 4263.31599018386, 4593.793279302439, 4600.677952543289, 4627.67606267558, 4662.254039353755, 4666.719996800135, 4208.726432781859, 4230.259704551691, 4238.554951730024, 4418.889527761768, 4814.0, 5108.361454818148, 5122.410922743783, 5183.5593974512585, 5188.377394712658, 5190.169572868323, 5062.645614806928, 5073.365829271341, 5076.162433198481, 5086.694798312114, 5090.389153301628, 4572.657050721143, 4724.4094488188975, 4795.6163506918665, 4823.756953016864, 4827.662063655651, 3685.70514358856, 3703.6481534254203, 3711.1649878777057, 3712.3503386907723, 3714.9071273218387, 4944.851654450372, 5100.693958362362, 5147.507222905316, 5154.742262886765, 5167.6641018333685, 4850.151223535797, 4933.360652051136, 4959.231319145538, 4968.453470118212, 4969.453360130455, 4939.678920870132, 4968.8757781055765, 4991.625628077982, 4998.450790097004, 5011.574016208663, 4756.286557016475, 4895.583875370491, 4896.608271338356, 4913.0, 4931.3589233399425, 4988.553319537294, 5001.349824522788, 5017.37282839645, 5020.171671674133, 5027.296178534935, 4898.681585696918, 4919.458859525521, 4940.777665005012, 4956.207006878882, 4964.900701986012], "value": 3659.8572957199385, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.0883135555566, 607.0590584593884, 680.6018479189676, 693.9965300173495, 700.8142842146832, 11758.353290569015, 12087.335196564185, 12225.388730563469, 12237.816432753516, 13347.933260333684, 12275.815862762065, 12539.373031348441, 12541.372931353419, 12551.874481255185, 12552.497900083985, 617.2931992868163, 765.4374035084222, 785.8349746553203, 787.7557957033309, 788.9289963903248, 638.2373064188297, 764.2815753191982, 791.2443616346404, 797.7447216890597, 798.1021350980147, 827.6606591297569, 830.3647709502236, 830.5182993863544, 830.7466222802043, 831.0442990560873, 641.4804008752878, 814.763718521628, 817.5993763056059, 817.750586071248, 818.5743413424985, 490.09821927652933, 576.2911618709012, 595.3391735173954, 599.5084031094505, 599.5143933413905, 12717.109802313842, 12781.16922400041, 12791.552295669608, 12796.104272700915, 12797.104202705814, 11663.941680291544, 12145.0, 12151.756964860742, 12172.756544869142, 12846.550370737074, 11413.0, 11523.0, 11785.351805650685, 11790.941045294805, 12099.57651482194, 3694.07648087978, 3710.684591809699, 3763.096856754359, 3850.1337199130253, 3883.59222281662, 61264.999999999556, 62037.37962620406, 62507.687461562855, 63615.363846361404, 63799.6810015947, 9431.292653051049, 9516.476593787269, 9613.086756758097, 9660.806783864284, 9721.125098741006, 19201.039948002544, 19257.711134332996, 19318.227270909287, 19356.90321548383, 19715.211391544177, 6255.624662520263, 6452.193475815523, 6477.093206951031, 6553.737850486023, 6562.868742625121, 3347.2636020075543, 3361.61341445732, 3405.5402520659395, 3424.33225521021, 3459.6713312235297, 2733.2620192548297, 2814.3949050954143, 2832.0, 2832.56095305228, 2840.162152165075, 468.5853020077188, 468.9109069276827, 471.58029353875077, 475.75974133062584, 481.99277010844867, 529.6080900133874, 530.5543343591324, 547.7015026810398, 548.3036543589699, 570.6148349863826, 7314.817129571697, 7467.720369594336, 7490.737824176128, 7757.224277572198, 7911.446198766032, 480.23162939296844, 557.3479029535372, 559.5244042563869, 561.6517758989371, 581.1863391252281, 3425.794452332868, 3512.964870351315, 3643.398839191557, 3678.4666223397458, 3691.3909204981414, 54330.72834635802, 55478.7808487656, 58571.0, 98936.0, 101644.0, 84802.57598711966, 86085.56957215299, 86729.56635216784, 89851.0, 90297.0, 73916.63041684758, 75026.62486687422, 76271.0, 76840.61579692065, 76994.23005769982, 6881.13985751781, 6969.128858892638, 6969.756058537927, 7005.369516743313, 7466.178720340867, 44440.777796110815, 44662.0, 45303.32045019393, 45443.318350224115, 47574.76212618915, 60146.0, 60788.69605651943, 64510.0, 65747.0, 69076.309236907, 9361.344705870524, 9384.390014649027, 9406.1064198901, 9421.104995025462, 9648.951755241178, 10448.68653940383, 10452.372857628567, 10545.52545135486, 10607.0, 10742.24804263694, 8786.472811631322, 8831.64673413082, 8971.50656713887, 9363.063693630582, 9373.390729602554, 9361.953190234006, 9393.953030234805, 9408.059194080537, 9423.528823558932, 9494.525273736424, 9410.858837117587, 9448.48033358172, 9742.415455072718, 9847.162991145546, 10064.597416103274, 8089.2315230053055, 8187.71343002992, 8281.92435571542, 8326.583670816555, 8517.190866867637, 8082.797930051795, 8293.709720160006, 8389.580520974048, 8393.748187554384, 8412.49112423108], "value": 6139.113420018116, "unit": "score"}], "name": "dromaeo_css", "value": 5989.736588850111, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 114.0, 115.0, 116.0, 114.0, 115.0, 114.0, 115.0, 114.0, 116.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 128.0, 128.0, 162.0, 130.0, 126.0, 129.0, 126.0, 157.0, 133.0], "value": 137.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 164.0, 163.0, 163.0, 163.0, 162.0, 162.0, 160.0], "value": 162.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 102.0, 77.0, 76.0, 76.0, 76.0, 103.0, 76.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 129.0, 85.0, 85.0, 84.0, 107.0, 85.0, 83.0, 113.0], "value": 93.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 85.0, 84.0, 85.0, 85.0, 84.0, 85.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 64.0, 65.0, 73.0, 64.0, 65.0, 68.0, 65.0], "value": 66.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 67.0, 68.0, 67.0, 67.0, 67.0, 67.0, 68.0], "value": 67.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 86.0, 91.0, 82.0, 84.0, 92.0, 82.0, 83.0, 83.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 150.0, 148.0, 140.0, 139.0, 151.0, 139.0, 140.0, 179.0, 139.0], "value": 146.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 180.0, 179.0, 184.0, 183.0, 183.0, 176.0, 174.0, 173.0, 177.0], "value": 178.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 70.0, 70.0, 70.0, 69.0, 69.0, 75.0, 69.0, 71.0], "value": 70.4, "unit": "score"}], "name": "kraken", "value": 1551.7, "alertThreshold": 2.0}]} 05:26:34 INFO - Return code: 0 05:26:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:26:34 INFO - # TBPL SUCCESS # 05:26:34 INFO - Running post-action listener: _resource_record_post_action 05:26:34 INFO - [mozharness: 2016-10-14 12:26:34.514684Z] Finished run-tests step (success) 05:26:34 INFO - Running post-run listener: _resource_record_post_run 05:26:34 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 397500416; Read time: 12; Write time: 265548 05:26:34 INFO - TinderboxPrint: CPU usage
13.0% 05:26:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:26:34 INFO - TinderboxPrint: I/O write bytes / time
397,500,416 / 265,548 05:26:34 INFO - TinderboxPrint: CPU idle
8,351.6 (86.9%) 05:26:34 INFO - TinderboxPrint: CPU user
1,205.6 (12.5%) 05:26:34 INFO - TinderboxPrint: Swap in / out
0 / 0 05:26:34 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107200512; Read time: 0; Write time: 70800 05:26:34 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 289685504; Read time: 0; Write time: 194748 05:26:35 INFO - Running post-run listener: _upload_blobber_files 05:26:35 INFO - Blob upload gear active. 05:26:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:26:35 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 05:26:35 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'] 05:26:35 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 05:26:35 INFO - (blobuploader) - INFO - Open directory for files ... 05:26:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:26:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:26:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:26:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:26:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:26:36 INFO - (blobuploader) - INFO - Done attempting. 05:26:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:26:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:26:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:26:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:26:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:26:39 INFO - (blobuploader) - INFO - Done attempting. 05:26:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:26:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:26:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:26:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:26:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:26:40 INFO - (blobuploader) - INFO - Done attempting. 05:26:40 INFO - (blobuploader) - INFO - Iteration through files over. 05:26:40 INFO - Return code: 0 05:26:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:26:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:26:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/065f6f70e5d16c8ddcf7739e501bbd68e76336a9a06a4570fb91f86bb150d7500d121f492f2307a267052f548056cef4e8a7c6d8f6ddba7948a0e175ad9b9068", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b1101475c0c3c218dc863654f1ff0b1b6be04d58bdf3b5d112f5365f37c338d8b512b2bfcf924696d9898ec7c450252d41c641ad04fc1a887a22680481303510", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2372dcfe2b7c9a6829cc35bdc1790164285a7d030110186c0ab0cd9b181a5bf068f004188f203782ac64140fa4077a6c247d91478564e120efc147323c1b6c56"} 05:26:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:26:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:26:40 INFO - Contents: 05:26:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/065f6f70e5d16c8ddcf7739e501bbd68e76336a9a06a4570fb91f86bb150d7500d121f492f2307a267052f548056cef4e8a7c6d8f6ddba7948a0e175ad9b9068", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b1101475c0c3c218dc863654f1ff0b1b6be04d58bdf3b5d112f5365f37c338d8b512b2bfcf924696d9898ec7c450252d41c641ad04fc1a887a22680481303510", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2372dcfe2b7c9a6829cc35bdc1790164285a7d030110186c0ab0cd9b181a5bf068f004188f203782ac64140fa4077a6c247d91478564e120efc147323c1b6c56"} 05:26:40 INFO - Running post-run listener: copy_logs_to_upload_dir 05:26:40 INFO - Copying logs to upload dir... 05:26:40 INFO - mkdir: /builds/slave/test/build/upload/logs 05:26:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.938518 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-14 05:26:39.370088) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 05:26:39.374037) ========= 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=232498196343f89f466a4a9a000001c8-1476446751.666417-1620542792 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/065f6f70e5d16c8ddcf7739e501bbd68e76336a9a06a4570fb91f86bb150d7500d121f492f2307a267052f548056cef4e8a7c6d8f6ddba7948a0e175ad9b9068", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b1101475c0c3c218dc863654f1ff0b1b6be04d58bdf3b5d112f5365f37c338d8b512b2bfcf924696d9898ec7c450252d41c641ad04fc1a887a22680481303510", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2372dcfe2b7c9a6829cc35bdc1790164285a7d030110186c0ab0cd9b181a5bf068f004188f203782ac64140fa4077a6c247d91478564e120efc147323c1b6c56"} build_url:https://queue.taskcluster.net/v1/task/P0Vca6-TQmm_RTkJdIAjSg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011233 build_url: 'https://queue.taskcluster.net/v1/task/P0Vca6-TQmm_RTkJdIAjSg/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/065f6f70e5d16c8ddcf7739e501bbd68e76336a9a06a4570fb91f86bb150d7500d121f492f2307a267052f548056cef4e8a7c6d8f6ddba7948a0e175ad9b9068", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b1101475c0c3c218dc863654f1ff0b1b6be04d58bdf3b5d112f5365f37c338d8b512b2bfcf924696d9898ec7c450252d41c641ad04fc1a887a22680481303510", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2372dcfe2b7c9a6829cc35bdc1790164285a7d030110186c0ab0cd9b181a5bf068f004188f203782ac64140fa4077a6c247d91478564e120efc147323c1b6c56"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-14 05:26:39.400476) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 05:26:39.400820) ========= 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=232498196343f89f466a4a9a000001c8-1476446751.666417-1620542792 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004521 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-14 05:26:39.484725) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 05:26:39.485239) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-14 05:26:39.485911) ========= ========= Total master_lag: 0.16 =========