builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-012 starttime: 1475564579.89 results: success (0) buildid: 20161003223900 builduid: cdb9923c768b4648b7751734b2219d6d revision: bf226dd7668c37d77a38bbac5c3fab2c16e23a89 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 00:02:59.890280) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 00:02:59.890758) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 00:02:59.891076) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 00:02:59.913414) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 00:02:59.913768) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1475564579.253171-1129471075 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-04 00:03:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 53.5M=0s 2016-10-04 00:03:00 (53.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089722 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 00:03:00.021214) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 00:03:00.021579) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1475564579.253171-1129471075 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023782 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 00:03:00.071945) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 00:03:00.072364) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev bf226dd7668c37d77a38bbac5c3fab2c16e23a89 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev bf226dd7668c37d77a38bbac5c3fab2c16e23a89 --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=2c5dd2b0a310ecf02fd87158000001b4-1475564579.253171-1129471075 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-04 00:03:00,414 truncating revision to first 12 chars 2016-10-04 00:03:00,414 Setting DEBUG logging. 2016-10-04 00:03:00,414 attempt 1/10 2016-10-04 00:03:00,414 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/bf226dd7668c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 00:03:01,965 unpacking tar archive at: autoland-bf226dd7668c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.865171 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 00:03:01.954582) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 00:03:01.954964) ========= script_repo_revision: bf226dd7668c37d77a38bbac5c3fab2c16e23a89 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 00:03:01.955471) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 00:03:01.955886) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 00:03:01.966657) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-04 00:03:01.966987) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-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', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-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=2c5dd2b0a310ecf02fd87158000001b4-1475564579.253171-1129471075 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:03:02 INFO - MultiFileLogger online at 20161004 00:03:02 in /builds/slave/test 00:03:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 00:03:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:03:02 INFO - {'append_to_log': False, 00:03:02 INFO - 'base_work_dir': '/builds/slave/test', 00:03:02 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 00:03:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:03:02 INFO - 'branch': 'Autoland-Non-PGO', 00:03:02 INFO - 'buildbot_json_path': 'buildprops.json', 00:03:02 INFO - 'config_files': ('talos/linux_config.py',), 00:03:02 INFO - 'default_actions': ('clobber', 00:03:02 INFO - 'read-buildbot-config', 00:03:02 INFO - 'download-and-extract', 00:03:02 INFO - 'populate-webroot', 00:03:02 INFO - 'create-virtualenv', 00:03:02 INFO - 'install', 00:03:02 INFO - 'run-tests'), 00:03:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:03:02 INFO - 'download_minidump_stackwalk': True, 00:03:02 INFO - 'download_symbols': 'ondemand', 00:03:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:03:02 INFO - 'tooltool.py': '/tools/tooltool.py', 00:03:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:03:02 INFO - '/tools/misc-python/virtualenv.py')}, 00:03:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:03:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:03:02 INFO - 'installer_path': 'installer.exe', 00:03:02 INFO - 'log_level': 'info', 00:03:02 INFO - 'log_name': 'talos', 00:03:02 INFO - 'log_to_console': True, 00:03:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:03:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:03:02 INFO - 'opt_config_files': (), 00:03:02 INFO - 'pip_index': False, 00:03:02 INFO - 'sps_profile': False, 00:03:02 INFO - 'sps_profile_interval': 0, 00:03:02 INFO - 'suite': 'dromaeojs', 00:03:02 INFO - 'system_bits': '32', 00:03:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:03:02 INFO - 'title': 'talos-linux64-ix-012', 00:03:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:03:02 INFO - 'use_talos_json': True, 00:03:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:03:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:03:02 INFO - 'work_dir': 'build'} 00:03:02 INFO - [mozharness: 2016-10-04 07:03:02.400773Z] Running clobber step. 00:03:02 INFO - Running pre-action listener: _resource_record_pre_action 00:03:02 INFO - Running main action method: clobber 00:03:02 INFO - rmtree: /builds/slave/test/build 00:03:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:03:02 INFO - Running post-action listener: _resource_record_post_action 00:03:02 INFO - [mozharness: 2016-10-04 07:03:02.879513Z] Finished clobber step (success) 00:03:02 INFO - [mozharness: 2016-10-04 07:03:02.879613Z] Running read-buildbot-config step. 00:03:02 INFO - Running pre-action listener: _resource_record_pre_action 00:03:02 INFO - Running main action method: read_buildbot_config 00:03:02 INFO - Using buildbot properties: 00:03:02 INFO - { 00:03:02 INFO - "project": "", 00:03:02 INFO - "product": "firefox", 00:03:02 INFO - "script_repo_revision": "production", 00:03:02 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 00:03:02 INFO - "repository": "", 00:03:02 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 00:03:02 INFO - "buildid": "20161003223900", 00:03:02 INFO - "pgo_build": "False", 00:03:02 INFO - "basedir": "/builds/slave/test", 00:03:02 INFO - "buildnumber": 758, 00:03:02 INFO - "slavename": "talos-linux64-ix-012", 00:03:02 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 00:03:02 INFO - "platform": "ubuntu64_hw", 00:03:02 INFO - "scheduler": "tests-autoland-linux64-talos", 00:03:02 INFO - "branch": "autoland", 00:03:02 INFO - "repo_path": "integration/autoland", 00:03:02 INFO - "revision": "bf226dd7668c37d77a38bbac5c3fab2c16e23a89", 00:03:02 INFO - "stage_platform": "linux64", 00:03:02 INFO - "builduid": "cdb9923c768b4648b7751734b2219d6d", 00:03:02 INFO - "slavebuilddir": "test" 00:03:02 INFO - } 00:03:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/YVHYTHQ4T8aCh3JJo_CxFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 00:03:02 INFO - Running post-action listener: _resource_record_post_action 00:03:02 INFO - [mozharness: 2016-10-04 07:03:02.882044Z] Finished read-buildbot-config step (success) 00:03:02 INFO - [mozharness: 2016-10-04 07:03:02.882154Z] Running download-and-extract step. 00:03:02 INFO - Running pre-action listener: _resource_record_pre_action 00:03:02 INFO - Running main action method: download_and_extract 00:03:02 INFO - mkdir: /builds/slave/test/build/tests 00:03:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:03:02 INFO - trying https://queue.taskcluster.net/v1/task/YVHYTHQ4T8aCh3JJo_CxFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 00:03:02 INFO - Downloading https://queue.taskcluster.net/v1/task/YVHYTHQ4T8aCh3JJo_CxFQ/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 00:03:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YVHYTHQ4T8aCh3JJo_CxFQ/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 00:03:03 INFO - Downloaded 1361 bytes. 00:03:03 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 00:03:03 INFO - Using the following test package requirements: 00:03:03 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 00:03:03 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:03:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:03:03 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:03:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:03:03 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:03:03 INFO - u'jsshell-linux-x86_64.zip'], 00:03:03 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:03:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:03:03 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 00:03:03 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:03:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:03:03 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:03:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:03:03 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:03:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:03:03 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:03:03 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:03:03 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:03:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YVHYTHQ4T8aCh3JJo_CxFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 00:03:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YVHYTHQ4T8aCh3JJo_CxFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:03:03 INFO - Fetch https://queue.taskcluster.net/v1/task/YVHYTHQ4T8aCh3JJo_CxFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:03:04 INFO - Http code: 200 00:03:04 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 00:03:04 INFO - x-amz-cf-id: P4hU8_BmHbR3lsXpPDVMZrW0ba-r9nZHwZeOF89NCR-seN87svd7zQ== 00:03:04 INFO - x-amz-version-id: .EPcffLxj3vLl3lYxq1irYPUng4_JiS. 00:03:04 INFO - Expected file size: 20420925 00:03:04 INFO - Obtained file size: 20420925 00:03:08 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 00:03:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YVHYTHQ4T8aCh3JJo_CxFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 00:03:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YVHYTHQ4T8aCh3JJo_CxFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:03:08 INFO - Fetch https://queue.taskcluster.net/v1/task/YVHYTHQ4T8aCh3JJo_CxFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:03:09 INFO - Http code: 200 00:03:09 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 00:03:09 INFO - x-amz-cf-id: CbIghF_ikSX_4MB2yVU4WzDp5Yc1swz7aRoEyoyCa3lEs-tuZ8kfKw== 00:03:09 INFO - x-amz-version-id: .EPcffLxj3vLl3lYxq1irYPUng4_JiS. 00:03:09 INFO - Expected file size: 20420925 00:03:09 INFO - Obtained file size: 20420925 00:03:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YVHYTHQ4T8aCh3JJo_CxFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 00:03:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YVHYTHQ4T8aCh3JJo_CxFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:03:13 INFO - Fetch https://queue.taskcluster.net/v1/task/YVHYTHQ4T8aCh3JJo_CxFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 00:03:14 INFO - Http code: 200 00:03:14 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 00:03:14 INFO - x-amz-cf-id: a4_Hb-YRhIopmKME9qGYJbEMU9xL-JZs5d4PQiFZYeo9XN2kY5HxGQ== 00:03:14 INFO - x-amz-version-id: Wr9QBDC7HiBx.wHJb153NSQWHENL9ihN 00:03:15 INFO - Expected file size: 14408522 00:03:15 INFO - Obtained file size: 14408522 00:03: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')]} 00:03:15 INFO - trying https://queue.taskcluster.net/v1/task/YVHYTHQ4T8aCh3JJo_CxFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:03:15 INFO - Downloading https://queue.taskcluster.net/v1/task/YVHYTHQ4T8aCh3JJo_CxFQ/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 00:03:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YVHYTHQ4T8aCh3JJo_CxFQ/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 00:03:16 INFO - Downloaded 55787718 bytes. 00:03:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YVHYTHQ4T8aCh3JJo_CxFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:03:16 INFO - mkdir: /builds/slave/test/properties 00:03:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:03:16 INFO - Writing to file /builds/slave/test/properties/build_url 00:03:16 INFO - Contents: 00:03:16 INFO - build_url:https://queue.taskcluster.net/v1/task/YVHYTHQ4T8aCh3JJo_CxFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:03:17 INFO - Running post-action listener: _resource_record_post_action 00:03:17 INFO - Running post-action listener: set_extra_try_arguments 00:03:17 INFO - [mozharness: 2016-10-04 07:03:17.562783Z] Finished download-and-extract step (success) 00:03:17 INFO - [mozharness: 2016-10-04 07:03:17.563008Z] Running populate-webroot step. 00:03:17 INFO - Running pre-action listener: _resource_record_pre_action 00:03:17 INFO - Running main action method: populate_webroot 00:03:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:03:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:03:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:03:17 INFO - '--tppagecycles', 00:03:17 INFO - '7'], 00:03:17 INFO - 'tests': ['tsvgm']}}, 00:03:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:03:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:03:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:03:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:03:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:03:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:03:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:03:17 INFO - 'talos_options': ['--disable-e10s'], 00:03:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:03:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:03:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:03:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:03:17 INFO - 'talos_options': ['--disable-e10s'], 00:03:17 INFO - 'tests': ['damp', 'tps']}, 00:03:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:03:17 INFO - 'tests': ['damp', 'tps']}, 00:03:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:03:17 INFO - 'tests': ['dromaeo_dom']}, 00:03:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:03:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:03:17 INFO - 'tests': ['basic_compositor_video']}, 00:03:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:03:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:03:17 INFO - 'tests': ['a11yr', 00:03:17 INFO - 'ts_paint', 00:03:17 INFO - 'tpaint', 00:03:17 INFO - 'sessionrestore', 00:03:17 INFO - 'sessionrestore_no_auto_restore', 00:03:17 INFO - 'tabpaint']}, 00:03:17 INFO - 'other-e10s': {'tests': ['a11yr', 00:03:17 INFO - 'ts_paint', 00:03:17 INFO - 'tpaint', 00:03:17 INFO - 'sessionrestore', 00:03:17 INFO - 'sessionrestore_no_auto_restore', 00:03:17 INFO - 'tabpaint']}, 00:03:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:03:17 INFO - 'ts_paint', 00:03:17 INFO - 'tpaint', 00:03:17 INFO - 'sessionrestore', 00:03:17 INFO - 'sessionrestore_no_auto_restore', 00:03:17 INFO - 'tabpaint']}, 00:03:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:03:17 INFO - 'ts_paint', 00:03:17 INFO - 'tpaint', 00:03:17 INFO - 'sessionrestore', 00:03:17 INFO - 'sessionrestore_no_auto_restore', 00:03:17 INFO - 'tabpaint']}, 00:03:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:03:17 INFO - 'tests': ['a11yr', 00:03:17 INFO - 'ts_paint', 00:03:17 INFO - 'tpaint', 00:03:17 INFO - 'sessionrestore', 00:03:17 INFO - 'sessionrestore_no_auto_restore', 00:03:17 INFO - 'tabpaint']}, 00:03:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:03:17 INFO - 'tests': ['a11yr', 00:03:17 INFO - 'ts_paint', 00:03:17 INFO - 'tpaint', 00:03:17 INFO - 'sessionrestore', 00:03:17 INFO - 'sessionrestore_no_auto_restore', 00:03:17 INFO - 'tabpaint']}, 00:03:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:03:17 INFO - 'tests': ['tsvgx', 00:03:17 INFO - 'tsvgr_opacity', 00:03:17 INFO - 'tart', 00:03:17 INFO - 'tscrollx', 00:03:17 INFO - 'cart']}, 00:03:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:03:17 INFO - 'tsvgr_opacity', 00:03:17 INFO - 'tart', 00:03:17 INFO - 'tscrollx', 00:03:17 INFO - 'cart']}, 00:03:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:03:17 INFO - 'talos_options': ['--disable-e10s'], 00:03:17 INFO - 'tests': ['tp5o']}, 00:03:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:03:17 INFO - 'tests': ['tp5o']}, 00:03:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:03:17 INFO - 'talos_options': ['--disable-e10s', 00:03:17 INFO - '--xperf_path', 00:03:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:03:17 INFO - 'tests': ['tp5n']}, 00:03:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:03:17 INFO - 'talos_options': ['--xperf_path', 00:03:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:03:17 INFO - 'tests': ['tp5n']}}, 00:03:17 INFO - 'talos.zip': {'path': '', 00:03:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:03:17 INFO - Running post-action listener: _resource_record_post_action 00:03:17 INFO - [mozharness: 2016-10-04 07:03:17.585094Z] Finished populate-webroot step (success) 00:03:17 INFO - [mozharness: 2016-10-04 07:03:17.585183Z] Running create-virtualenv step. 00:03:17 INFO - Running pre-action listener: _resource_record_pre_action 00:03:17 INFO - Running main action method: create_virtualenv 00:03:17 INFO - Creating virtualenv /builds/slave/test/build/venv 00:03:17 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 00:03:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:03:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:03:17 INFO - Using real prefix '/usr' 00:03:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:03:18 INFO - Installing distribute.............................................................................................................................................................................................done. 00:03:20 INFO - Installing pip.................done. 00:03:20 INFO - Return code: 0 00:03:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:03:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:03:20 INFO - Reading from file tmpfile_stdout 00:03:20 INFO - Output received: 00:03:20 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) 00:03:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:03:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:03:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:03:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:03:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:03:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f36ce2f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1208ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1205f60>, '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 0x1206d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12071d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1475564579.253171-1129471075', '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 00:03:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:03:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:03:20 INFO - Using env: {'DISPLAY': ':0', 00:03:20 INFO - 'HOME': '/home/cltbld', 00:03:20 INFO - 'LANG': 'en_US.UTF-8', 00:03:20 INFO - 'LANGUAGE': 'en_US:en', 00:03:20 INFO - 'LOGNAME': 'cltbld', 00:03:20 INFO - 'MAIL': '/var/mail/cltbld', 00:03:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:20 INFO - 'MOZ_NO_REMOTE': '1', 00:03:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:03:20 INFO - 'NO_EM_RESTART': '1', 00:03:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:03:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:03:20 INFO - 'PWD': '/builds/slave/test', 00:03:20 INFO - 'SHELL': '/bin/bash', 00:03:20 INFO - 'SHLVL': '1', 00:03:20 INFO - 'TERM': 'linux', 00:03:20 INFO - 'TMOUT': '86400', 00:03:20 INFO - 'USER': 'cltbld', 00:03:20 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1475564579.253171-1129471075', 00:03:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:03:20 INFO - '_': '/tools/buildbot/bin/python'} 00:03:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:03:20 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 00:03:20 INFO - Cleaning up... 00:03:20 INFO - Return code: 0 00:03:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:03:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:03:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:03:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:03:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:03:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f36ce2f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1208ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1205f60>, '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 0x1206d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12071d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1475564579.253171-1129471075', '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 00:03:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 00:03:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 00:03:20 INFO - Using env: {'DISPLAY': ':0', 00:03:20 INFO - 'HOME': '/home/cltbld', 00:03:20 INFO - 'LANG': 'en_US.UTF-8', 00:03:20 INFO - 'LANGUAGE': 'en_US:en', 00:03:20 INFO - 'LOGNAME': 'cltbld', 00:03:20 INFO - 'MAIL': '/var/mail/cltbld', 00:03:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:20 INFO - 'MOZ_NO_REMOTE': '1', 00:03:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:03:20 INFO - 'NO_EM_RESTART': '1', 00:03:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:03:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:03:20 INFO - 'PWD': '/builds/slave/test', 00:03:20 INFO - 'SHELL': '/bin/bash', 00:03:20 INFO - 'SHLVL': '1', 00:03:20 INFO - 'TERM': 'linux', 00:03:20 INFO - 'TMOUT': '86400', 00:03:20 INFO - 'USER': 'cltbld', 00:03:20 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1475564579.253171-1129471075', 00:03:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:03:20 INFO - '_': '/tools/buildbot/bin/python'} 00:03:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:03:20 INFO - Downloading/unpacking psutil>=3.1.1 00:03: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 00:03: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 00:03: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 00:03: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 00:03: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 00:03: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 00:03:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:03:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:03:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:03:23 INFO - Installing collected packages: psutil 00:03:23 INFO - Running setup.py install for psutil 00:03:23 INFO - building 'psutil._psutil_linux' extension 00:03:23 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 00:03:23 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 00:03:23 INFO - building 'psutil._psutil_posix' extension 00:03:23 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 00:03:23 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 00:03:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:03:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:03:23 INFO - Successfully installed psutil 00:03:23 INFO - Cleaning up... 00:03:23 INFO - Return code: 0 00:03:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:03:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:03:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:03:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:03:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:03:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f36ce2f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1208ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1205f60>, '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 0x1206d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12071d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1475564579.253171-1129471075', '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 00:03:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:03:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 00:03:23 INFO - Using env: {'DISPLAY': ':0', 00:03:23 INFO - 'HOME': '/home/cltbld', 00:03:23 INFO - 'LANG': 'en_US.UTF-8', 00:03:23 INFO - 'LANGUAGE': 'en_US:en', 00:03:23 INFO - 'LOGNAME': 'cltbld', 00:03:23 INFO - 'MAIL': '/var/mail/cltbld', 00:03:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:23 INFO - 'MOZ_NO_REMOTE': '1', 00:03:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:03:23 INFO - 'NO_EM_RESTART': '1', 00:03:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:03:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:03:23 INFO - 'PWD': '/builds/slave/test', 00:03:23 INFO - 'SHELL': '/bin/bash', 00:03:23 INFO - 'SHLVL': '1', 00:03:23 INFO - 'TERM': 'linux', 00:03:23 INFO - 'TMOUT': '86400', 00:03:23 INFO - 'USER': 'cltbld', 00:03:23 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1475564579.253171-1129471075', 00:03:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:03:23 INFO - '_': '/tools/buildbot/bin/python'} 00:03:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:03:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:03:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:03:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:03:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:03:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:03:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:03:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:03:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:03:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:03:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:03:26 INFO - Installing collected packages: mozsystemmonitor 00:03:26 INFO - Running setup.py install for mozsystemmonitor 00:03:26 INFO - Successfully installed mozsystemmonitor 00:03:26 INFO - Cleaning up... 00:03:26 INFO - Return code: 0 00:03:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:03:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:03:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:03:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:03:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:03:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:26 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 0x7f36ce2f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1208ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1205f60>, '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 0x1206d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12071d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1475564579.253171-1129471075', '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 00:03:26 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 00:03:26 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 00:03:26 INFO - Using env: {'DISPLAY': ':0', 00:03:26 INFO - 'HOME': '/home/cltbld', 00:03:26 INFO - 'LANG': 'en_US.UTF-8', 00:03:26 INFO - 'LANGUAGE': 'en_US:en', 00:03:26 INFO - 'LOGNAME': 'cltbld', 00:03:26 INFO - 'MAIL': '/var/mail/cltbld', 00:03:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:26 INFO - 'MOZ_NO_REMOTE': '1', 00:03:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:03:26 INFO - 'NO_EM_RESTART': '1', 00:03:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:03:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:03:26 INFO - 'PWD': '/builds/slave/test', 00:03:26 INFO - 'SHELL': '/bin/bash', 00:03:26 INFO - 'SHLVL': '1', 00:03:26 INFO - 'TERM': 'linux', 00:03:26 INFO - 'TMOUT': '86400', 00:03:26 INFO - 'USER': 'cltbld', 00:03:26 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1475564579.253171-1129471075', 00:03:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:03:26 INFO - '_': '/tools/buildbot/bin/python'} 00:03:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:03:27 INFO - Downloading/unpacking jsonschema==2.5.1 00:03:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:03:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:03:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:03:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:03:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:03:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:03:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:03:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:03:29 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 00:03:29 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 00:03:29 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 00:03:29 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 00:03:29 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 00:03:29 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 00:03:29 INFO - Downloading functools32-3.2.3-2.tar.gz 00:03:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:03:29 INFO - warning: no files found matching '*.txt' 00:03:29 INFO - no previously-included directories found matching 'build' 00:03:29 INFO - no previously-included directories found matching 'dist' 00:03:29 INFO - no previously-included directories found matching '.git*' 00:03:29 INFO - Installing collected packages: jsonschema, functools32 00:03:29 INFO - Running setup.py install for functools32 00:03:29 INFO - warning: no files found matching '*.txt' 00:03:29 INFO - no previously-included directories found matching 'build' 00:03:29 INFO - no previously-included directories found matching 'dist' 00:03:29 INFO - no previously-included directories found matching '.git*' 00:03:29 INFO - Successfully installed jsonschema functools32 00:03:29 INFO - Cleaning up... 00:03:29 INFO - Return code: 0 00:03:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:03: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')]} 00:03:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:03:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03: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')]} 00:03:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:03:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03: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', '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 0x7f36ce2f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1208ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1205f60>, '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 0x1206d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12071d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1475564579.253171-1129471075', '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 00:03: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 00:03: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 functools32==3.2.3-2 00:03:29 INFO - Using env: {'DISPLAY': ':0', 00:03:29 INFO - 'HOME': '/home/cltbld', 00:03:29 INFO - 'LANG': 'en_US.UTF-8', 00:03:29 INFO - 'LANGUAGE': 'en_US:en', 00:03:29 INFO - 'LOGNAME': 'cltbld', 00:03:29 INFO - 'MAIL': '/var/mail/cltbld', 00:03:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:29 INFO - 'MOZ_NO_REMOTE': '1', 00:03:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:03:29 INFO - 'NO_EM_RESTART': '1', 00:03:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:03:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:03:29 INFO - 'PWD': '/builds/slave/test', 00:03:29 INFO - 'SHELL': '/bin/bash', 00:03:29 INFO - 'SHLVL': '1', 00:03:29 INFO - 'TERM': 'linux', 00:03:29 INFO - 'TMOUT': '86400', 00:03:29 INFO - 'USER': 'cltbld', 00:03:29 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1475564579.253171-1129471075', 00:03:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:03:29 INFO - '_': '/tools/buildbot/bin/python'} 00:03:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:03:29 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:03:29 INFO - Cleaning up... 00:03:29 INFO - Return code: 0 00:03:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:03: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')]} 00:03:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:03:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03: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')]} 00:03:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:03:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03: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', '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 0x7f36ce2f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1208ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1205f60>, '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 0x1206d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12071d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1475564579.253171-1129471075', '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 00:03: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:03: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 blobuploader==1.2.4 00:03:29 INFO - Using env: {'DISPLAY': ':0', 00:03:29 INFO - 'HOME': '/home/cltbld', 00:03:29 INFO - 'LANG': 'en_US.UTF-8', 00:03:29 INFO - 'LANGUAGE': 'en_US:en', 00:03:29 INFO - 'LOGNAME': 'cltbld', 00:03:29 INFO - 'MAIL': '/var/mail/cltbld', 00:03:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:29 INFO - 'MOZ_NO_REMOTE': '1', 00:03:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:03:29 INFO - 'NO_EM_RESTART': '1', 00:03:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:03:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:03:29 INFO - 'PWD': '/builds/slave/test', 00:03:29 INFO - 'SHELL': '/bin/bash', 00:03:29 INFO - 'SHLVL': '1', 00:03:29 INFO - 'TERM': 'linux', 00:03:29 INFO - 'TMOUT': '86400', 00:03:29 INFO - 'USER': 'cltbld', 00:03:29 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1475564579.253171-1129471075', 00:03:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:03:29 INFO - '_': '/tools/buildbot/bin/python'} 00:03:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:03:29 INFO - Downloading/unpacking blobuploader==1.2.4 00:03:29 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 00:03:29 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 00:03:29 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 00:03:29 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 00:03:29 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 00:03:29 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 00:03:31 INFO - Downloading blobuploader-1.2.4.tar.gz 00:03:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:03:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:03:31 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 00:03:31 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 00:03:31 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 00:03:31 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 00:03:31 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 00:03:31 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 00:03:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:03:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:03:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:03:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:03:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:03:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:03:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:03:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:03:32 INFO - Downloading docopt-0.6.1.tar.gz 00:03:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:03:32 INFO - Installing collected packages: blobuploader, requests, docopt 00:03:32 INFO - Running setup.py install for blobuploader 00:03:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:03:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:03:32 INFO - Running setup.py install for requests 00:03:33 INFO - Running setup.py install for docopt 00:03:33 INFO - Successfully installed blobuploader requests docopt 00:03:33 INFO - Cleaning up... 00:03:33 INFO - Return code: 0 00:03:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:03:33 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')]} 00:03:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:03:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:33 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')]} 00:03:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:03:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:33 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 0x7f36ce2f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1208ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1205f60>, '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 0x1206d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12071d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1475564579.253171-1129471075', '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 00:03:33 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 00:03:33 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 00:03:33 INFO - Using env: {'DISPLAY': ':0', 00:03:33 INFO - 'HOME': '/home/cltbld', 00:03:33 INFO - 'LANG': 'en_US.UTF-8', 00:03:33 INFO - 'LANGUAGE': 'en_US:en', 00:03:33 INFO - 'LOGNAME': 'cltbld', 00:03:33 INFO - 'MAIL': '/var/mail/cltbld', 00:03:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:33 INFO - 'MOZ_NO_REMOTE': '1', 00:03:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:03:33 INFO - 'NO_EM_RESTART': '1', 00:03:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:03:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:03:33 INFO - 'PWD': '/builds/slave/test', 00:03:33 INFO - 'SHELL': '/bin/bash', 00:03:33 INFO - 'SHLVL': '1', 00:03:33 INFO - 'TERM': 'linux', 00:03:33 INFO - 'TMOUT': '86400', 00:03:33 INFO - 'USER': 'cltbld', 00:03:33 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1475564579.253171-1129471075', 00:03:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:03:33 INFO - '_': '/tools/buildbot/bin/python'} 00:03:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:03:33 INFO - Running setup.py (path:/tmp/pip-j1w7ZI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:03:33 INFO - Running setup.py (path:/tmp/pip-HBapLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:03:33 INFO - Running setup.py (path:/tmp/pip-AwUZ4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:03:33 INFO - Running setup.py (path:/tmp/pip-0V7akq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:03:33 INFO - Running setup.py (path:/tmp/pip-_jCofw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:03:33 INFO - Running setup.py (path:/tmp/pip-Rykt_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:03:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:03:33 INFO - Running setup.py (path:/tmp/pip-IDZbDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:03:34 INFO - Running setup.py (path:/tmp/pip-c_lCJe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:03:34 INFO - Running setup.py (path:/tmp/pip-SNWHkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:03:34 INFO - Running setup.py (path:/tmp/pip-kAXFSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:03:34 INFO - Running setup.py (path:/tmp/pip-9PUyrO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:03:34 INFO - Running setup.py (path:/tmp/pip-m_XDA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:03:34 INFO - Running setup.py (path:/tmp/pip-mCq17f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:03:34 INFO - Running setup.py (path:/tmp/pip-aAlPOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:03:34 INFO - Running setup.py (path:/tmp/pip-DUZTdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:03:34 INFO - Running setup.py (path:/tmp/pip-MvvlvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:03:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:03:34 INFO - Running setup.py (path:/tmp/pip-zKT9Vk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:03:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:03:34 INFO - Running setup.py install for manifestparser 00:03:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:03:34 INFO - Running setup.py install for mozcrash 00:03:34 INFO - Running setup.py install for mozdebug 00:03:34 INFO - Running setup.py install for mozdevice 00:03:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:03:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:03:35 INFO - Running setup.py install for mozfile 00:03:35 INFO - Running setup.py install for mozhttpd 00:03:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:03:35 INFO - Running setup.py install for mozinfo 00:03:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:03:35 INFO - Running setup.py install for mozInstall 00:03:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:03:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:03:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:03:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:03:35 INFO - Running setup.py install for mozleak 00:03:35 INFO - Running setup.py install for mozlog 00:03:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:03:35 INFO - Running setup.py install for moznetwork 00:03:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:03:35 INFO - Running setup.py install for mozprocess 00:03:35 INFO - Running setup.py install for mozprofile 00:03:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:03:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:03:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:03:36 INFO - Running setup.py install for mozrunner 00:03:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:03:36 INFO - Running setup.py install for mozscreenshot 00:03:36 INFO - Running setup.py install for moztest 00:03:36 INFO - Running setup.py install for mozversion 00:03:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:03:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:03:36 INFO - Cleaning up... 00:03:36 INFO - Return code: 0 00:03:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:03:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:03:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:03:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:03:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:03:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:36 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 0x7f36ce2f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1208ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1205f60>, '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 0x1206d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12071d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1475564579.253171-1129471075', '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 00:03:36 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 00:03:36 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 00:03:36 INFO - Using env: {'DISPLAY': ':0', 00:03:36 INFO - 'HOME': '/home/cltbld', 00:03:36 INFO - 'LANG': 'en_US.UTF-8', 00:03:36 INFO - 'LANGUAGE': 'en_US:en', 00:03:36 INFO - 'LOGNAME': 'cltbld', 00:03:36 INFO - 'MAIL': '/var/mail/cltbld', 00:03:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:36 INFO - 'MOZ_NO_REMOTE': '1', 00:03:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:03:36 INFO - 'NO_EM_RESTART': '1', 00:03:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:03:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:03:36 INFO - 'PWD': '/builds/slave/test', 00:03:36 INFO - 'SHELL': '/bin/bash', 00:03:36 INFO - 'SHLVL': '1', 00:03:36 INFO - 'TERM': 'linux', 00:03:36 INFO - 'TMOUT': '86400', 00:03:36 INFO - 'USER': 'cltbld', 00:03:36 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1475564579.253171-1129471075', 00:03:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:03:36 INFO - '_': '/tools/buildbot/bin/python'} 00:03:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:03:36 INFO - Running setup.py (path:/tmp/pip-vhSwTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:03:36 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)) 00:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:03:36 INFO - Running setup.py (path:/tmp/pip-UzXArl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:03:36 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)) 00:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:03:36 INFO - Running setup.py (path:/tmp/pip-a7x0Tf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:03:36 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)) 00:03:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:03:36 INFO - Running setup.py (path:/tmp/pip-RTZLIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:03:37 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)) 00:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:03:37 INFO - Running setup.py (path:/tmp/pip-QmYPAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:03:37 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)) 00:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:03:37 INFO - Running setup.py (path:/tmp/pip-ETwri1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:03:37 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)) 00:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:03:37 INFO - Running setup.py (path:/tmp/pip-DKlHQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:03:37 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)) 00:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:03:37 INFO - Running setup.py (path:/tmp/pip-L_mE1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:03:37 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)) 00:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:03:37 INFO - Running setup.py (path:/tmp/pip-pH0tky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:03:37 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)) 00:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:03:37 INFO - Running setup.py (path:/tmp/pip-ENCLv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:03:37 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)) 00:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:03:37 INFO - Running setup.py (path:/tmp/pip-8NMdAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:03:37 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)) 00:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:03:37 INFO - Running setup.py (path:/tmp/pip-xllw5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:03:37 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)) 00:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:03:37 INFO - Running setup.py (path:/tmp/pip-QUr5dP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:03:37 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)) 00:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:03:37 INFO - Running setup.py (path:/tmp/pip-SErKYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:03:37 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)) 00:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:03:37 INFO - Running setup.py (path:/tmp/pip-ZLrd3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:03:37 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)) 00:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:03:37 INFO - Running setup.py (path:/tmp/pip-BwnZqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:03:37 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)) 00:03:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:03:37 INFO - Running setup.py (path:/tmp/pip-nqzZqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:03:37 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)) 00:03:37 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)) 00:03:37 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)) 00:03:37 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)) 00:03:37 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)) 00:03:37 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)) 00:03:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:03:37 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 00:03:37 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 00:03:37 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 00:03:37 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 00:03:37 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 00:03:37 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 00:03:39 INFO - Downloading blessings-1.6.tar.gz 00:03:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:03:39 INFO - Installing collected packages: blessings 00:03:39 INFO - Running setup.py install for blessings 00:03:40 INFO - Successfully installed blessings 00:03:40 INFO - Cleaning up... 00:03:40 INFO - Return code: 0 00:03:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:03:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:03:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:03:40 INFO - Reading from file tmpfile_stdout 00:03:40 INFO - Current package versions: 00:03:40 INFO - argparse == 1.2.1 00:03:40 INFO - blessings == 1.6 00:03:40 INFO - blobuploader == 1.2.4 00:03:40 INFO - docopt == 0.6.1 00:03:40 INFO - functools32 == 3.2.3-2 00:03:40 INFO - jsonschema == 2.5.1 00:03:40 INFO - manifestparser == 1.1 00:03:40 INFO - mozInstall == 1.12 00:03:40 INFO - mozcrash == 0.17 00:03:40 INFO - mozdebug == 0.1 00:03:40 INFO - mozdevice == 0.48 00:03:40 INFO - mozfile == 1.2 00:03:40 INFO - mozhttpd == 0.7 00:03:40 INFO - mozinfo == 0.9 00:03:40 INFO - mozleak == 0.1 00:03:40 INFO - mozlog == 3.4 00:03:40 INFO - moznetwork == 0.27 00:03:40 INFO - mozprocess == 0.23 00:03:40 INFO - mozprofile == 0.28 00:03:40 INFO - mozrunner == 6.12 00:03:40 INFO - mozscreenshot == 0.1 00:03:40 INFO - mozsystemmonitor == 0.3 00:03:40 INFO - moztest == 0.7 00:03:40 INFO - mozversion == 1.4 00:03:40 INFO - psutil == 3.1.1 00:03:40 INFO - requests == 1.2.3 00:03:40 INFO - wsgiref == 0.1.2 00:03:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:03:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:03:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:03:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:40 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 0x7f36ce2f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1208ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1205f60>, '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 0x1206d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12071d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1475564579.253171-1129471075', '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 00:03:40 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 00:03:40 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 00:03:40 INFO - Using env: {'DISPLAY': ':0', 00:03:40 INFO - 'HOME': '/home/cltbld', 00:03:40 INFO - 'LANG': 'en_US.UTF-8', 00:03:40 INFO - 'LANGUAGE': 'en_US:en', 00:03:40 INFO - 'LOGNAME': 'cltbld', 00:03:40 INFO - 'MAIL': '/var/mail/cltbld', 00:03:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:40 INFO - 'MOZ_NO_REMOTE': '1', 00:03:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:03:40 INFO - 'NO_EM_RESTART': '1', 00:03:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:03:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:03:40 INFO - 'PWD': '/builds/slave/test', 00:03:40 INFO - 'SHELL': '/bin/bash', 00:03:40 INFO - 'SHLVL': '1', 00:03:40 INFO - 'TERM': 'linux', 00:03:40 INFO - 'TMOUT': '86400', 00:03:40 INFO - 'USER': 'cltbld', 00:03:40 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1475564579.253171-1129471075', 00:03:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:03:40 INFO - '_': '/tools/buildbot/bin/python'} 00:03:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:03:40 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)) 00:03:40 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)) 00:03:40 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)) 00:03:40 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)) 00:03:40 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)) 00:03:40 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)) 00:03:40 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)) 00:03:40 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)) 00:03:40 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)) 00:03:40 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)) 00:03:40 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)) 00:03:40 INFO - Cleaning up... 00:03:40 INFO - Return code: 0 00:03:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:03:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:03:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:03:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:03:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:40 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 0x7f36ce2f7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x113b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1208ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1205f60>, '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 0x1206d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12071d0>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1475564579.253171-1129471075', '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 00:03:40 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 00:03:40 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 00:03:40 INFO - Using env: {'DISPLAY': ':0', 00:03:40 INFO - 'HOME': '/home/cltbld', 00:03:40 INFO - 'LANG': 'en_US.UTF-8', 00:03:40 INFO - 'LANGUAGE': 'en_US:en', 00:03:40 INFO - 'LOGNAME': 'cltbld', 00:03:40 INFO - 'MAIL': '/var/mail/cltbld', 00:03:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:40 INFO - 'MOZ_NO_REMOTE': '1', 00:03:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:03:40 INFO - 'NO_EM_RESTART': '1', 00:03:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:03:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:03:40 INFO - 'PWD': '/builds/slave/test', 00:03:40 INFO - 'SHELL': '/bin/bash', 00:03:40 INFO - 'SHLVL': '1', 00:03:40 INFO - 'TERM': 'linux', 00:03:40 INFO - 'TMOUT': '86400', 00:03:40 INFO - 'USER': 'cltbld', 00:03:40 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1475564579.253171-1129471075', 00:03:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:03:40 INFO - '_': '/tools/buildbot/bin/python'} 00:03:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:03:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:03:40 INFO - Cleaning up... 00:03:40 INFO - Return code: 0 00:03:40 INFO - Running post-action listener: _resource_record_post_action 00:03:40 INFO - Running post-action listener: _start_resource_monitoring 00:03:40 INFO - Starting resource monitoring. 00:03:40 INFO - [mozharness: 2016-10-04 07:03:40.803107Z] Finished create-virtualenv step (success) 00:03:40 INFO - [mozharness: 2016-10-04 07:03:40.803575Z] Running install step. 00:03:40 INFO - Running pre-action listener: _resource_record_pre_action 00:03:40 INFO - Running main action method: install 00:03:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:03:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:03:41 INFO - Reading from file tmpfile_stdout 00:03:41 INFO - Detecting whether we're running mozinstall >=1.0... 00:03:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:03:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:03:41 INFO - Reading from file tmpfile_stdout 00:03:41 INFO - Output received: 00:03:41 INFO - Usage: mozinstall [options] installer 00:03:41 INFO - Options: 00:03:41 INFO - -h, --help show this help message and exit 00:03:41 INFO - -d DEST, --destination=DEST 00:03:41 INFO - Directory to install application into. [default: 00:03:41 INFO - "/builds/slave/test"] 00:03:41 INFO - --app=APP Application being installed. [default: firefox] 00:03:41 INFO - mkdir: /builds/slave/test/build/application 00:03:41 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'] 00:03:41 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 00:03:57 INFO - Reading from file tmpfile_stdout 00:03:57 INFO - Output received: 00:03:57 INFO - /builds/slave/test/build/application/firefox/firefox 00:03:57 INFO - Running post-action listener: _resource_record_post_action 00:03:57 INFO - [mozharness: 2016-10-04 07:03:57.224325Z] Finished install step (success) 00:03:57 INFO - [mozharness: 2016-10-04 07:03:57.224570Z] Running run-tests step. 00:03:57 INFO - Running pre-action listener: _resource_record_pre_action 00:03:57 INFO - Running main action method: run_tests 00:03:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:03:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:03:57 INFO - Python 2.7.3 00:03:57 INFO - Return code: 0 00:03:57 INFO - grabbing minidump binary from tooltool 00:03:57 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')]} 00:03:57 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 0x1205f60>, '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 0x1206d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12071d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:03:57 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 00:03:57 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 00:03:57 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 00:03:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:03:57 INFO - Return code: 0 00:03:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:03:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:03:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:03:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:03:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:03:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YVHYTHQ4T8aCh3JJo_CxFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 00:03:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YVHYTHQ4T8aCh3JJo_CxFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 00:03:57 INFO - Using env: {'DISPLAY': ':0', 00:03:57 INFO - 'HOME': '/home/cltbld', 00:03:57 INFO - 'LANG': 'en_US.UTF-8', 00:03:57 INFO - 'LANGUAGE': 'en_US:en', 00:03:57 INFO - 'LOGNAME': 'cltbld', 00:03:57 INFO - 'MAIL': '/var/mail/cltbld', 00:03:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:03:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:03:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:57 INFO - 'MOZ_NO_REMOTE': '1', 00:03:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:03:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:03:57 INFO - 'NO_EM_RESTART': '1', 00:03:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:03:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:03:57 INFO - 'PWD': '/builds/slave/test', 00:03:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:03:57 INFO - 'SHELL': '/bin/bash', 00:03:57 INFO - 'SHLVL': '1', 00:03:57 INFO - 'TERM': 'linux', 00:03:57 INFO - 'TMOUT': '86400', 00:03:57 INFO - 'USER': 'cltbld', 00:03:57 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1475564579.253171-1129471075', 00:03:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:03:57 INFO - '_': '/tools/buildbot/bin/python'} 00:03:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YVHYTHQ4T8aCh3JJo_CxFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 00:03:57 INFO - mozversion application_buildid: 20161003223900 00:03:57 INFO - mozversion application_changeset: bf226dd7668c37d77a38bbac5c3fab2c16e23a89 00:03:57 INFO - mozversion application_display_name: Nightly 00:03:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:03:57 INFO - mozversion application_name: Firefox 00:03:57 INFO - mozversion application_remotingname: firefox 00:03:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 00:03:57 INFO - mozversion application_vendor: Mozilla 00:03:57 INFO - mozversion application_version: 52.0a1 00:03:57 INFO - mozversion platform_buildid: 20161003223900 00:03:57 INFO - mozversion platform_changeset: bf226dd7668c37d77a38bbac5c3fab2c16e23a89 00:03:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 00:03:57 INFO - mozversion platform_version: 52.0a1 00:03:57 INFO - using testdate: 1475564637 00:03:57 INFO - actual date: 1475564637 00:03:57 INFO - starting webserver on 'localhost:59196' 00:03:57 INFO - SUITE-START | Running 2 tests 00:03:57 INFO - TEST-START | dromaeo_css 00:03:57 INFO - operating with platform_type : linux_ 00:03:57 INFO - Initialising browser for dromaeo_css test... 00:03:57 INFO - TEST-INFO | started process 5843 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpifj0Xn/profile http://localhost:59196/getInfo.html) 00:04:02 INFO - PROCESS | 5843 | __metrics Screen width/height:1600/1200 00:04:02 INFO - PROCESS | 5843 | colorDepth:24 00:04:02 INFO - PROCESS | 5843 | Browser inner width/height: 1024/697 00:04:02 INFO - PROCESS | 5843 | __metrics 00:04:02 INFO - PROCESS | 5843 | 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" 00:04:02 INFO - PROCESS | 5843 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:04:03 INFO - TEST-INFO | 5843: exit 0 00:04:03 INFO - Browser initialized. 00:04:03 INFO - Running cycle 1/1 for dromaeo_css test... 00:04:03 INFO - TEST-INFO | started process 5921 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpifj0Xn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:04:15 INFO - PROCESS | 5921 | RSS: Main: 175370240 00:04:15 INFO - PROCESS | 5921 | 00:05:06 INFO - PROCESS | 5921 | 1475564706616 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] 00:07:20 INFO - PROCESS | 5921 | Cycle 1(1): loaded http://localhost:59196/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59196/tests/dromaeo/cssquery-ext.html) 00:07:21 INFO - PROCESS | 5921 | RSS: Main: 335003648 00:07:21 INFO - PROCESS | 5921 | 00:10:24 INFO - PROCESS | 5921 | Cycle 1(1): loaded http://localhost:59196/tests/dromaeo/cssquery-ext.html (next: http://localhost:59196/tests/dromaeo/cssquery-jquery.html) 00:10:25 INFO - PROCESS | 5921 | RSS: Main: 277180416 00:10:25 INFO - PROCESS | 5921 | 00:13:27 INFO - PROCESS | 5921 | Cycle 1(1): loaded http://localhost:59196/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59196/tests/dromaeo/cssquery-mootools.html) 00:13:27 INFO - PROCESS | 5921 | RSS: Main: 260182016 00:13:27 INFO - PROCESS | 5921 | 00:16:30 INFO - PROCESS | 5921 | Cycle 1(1): loaded http://localhost:59196/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59196/tests/dromaeo/cssquery-prototype.html) 00:16:30 INFO - PROCESS | 5921 | RSS: Main: 219860992 00:16:30 INFO - PROCESS | 5921 | 00:19:33 INFO - PROCESS | 5921 | Cycle 1(1): loaded http://localhost:59196/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59196/tests/dromaeo/cssquery-yui.html) 00:19:34 INFO - PROCESS | 5921 | RSS: Main: 219357184 00:19:34 INFO - PROCESS | 5921 | 00:22:37 INFO - PROCESS | 5921 | Cycle 1(1): loaded http://localhost:59196/tests/dromaeo/cssquery-yui.html (next: http://localhost:59196/tests/dromaeo/cssquery-dojo.html) 00:22:38 INFO - PROCESS | 5921 | RSS: Main: 312041472 00:22:38 INFO - PROCESS | 5921 | 00:22:38 INFO - PROCESS | 5921 | __start_tp_report 00:22:38 INFO - PROCESS | 5921 | _x_x_mozilla_page_load 00:22:38 INFO - PROCESS | 5921 | _x_x_mozilla_page_load_details 00:22:38 INFO - PROCESS | 5921 | |i|pagename|runs| 00:22:38 INFO - PROCESS | 5921 | |0;dojo.html;2561.218828257381;2597.8960841566336;2623.213036089173;2624.6456728341673;2640.3663120851;4623.838165664202;4720.079584481027;4740.90518189636;4759.738214398207;4772.976135119324;4693.5775780179865;4728.314394412808;4738.976305118478;4754.7860346284415;4846.466888642255;4249.46881639795;4306.310990241562;4309.784510774464;4357.150355680636;4370.3007518797;4313.396124542566;4316;4343.087951530182;4365.170617582665;4373.387725718386;4354.0203454222865;4361.4112094867105;4391.989842336248;4404.977975110136;4409.030013397063;4208.389783481378;4236.131593023423;4247.723897946624;4287.785610719483;4319.956800431987;4320.179165958458;4322.956770432318;4330.545292744279;4404.845830395952;4415.558444155591;4707.7175369477945;4710.5289471052965;4721.551452611996;4772.451168115676;4800.591949684281;4821.831235906727;4877.268409738532;5100.28595996557;5104.948950510485;5105.846824595231;4953.6037117030555;5031.119554078022;5104.208847628586;5114.130597798383;5190.091733946544;4762.476127625959;4763.452202996665;4766.380370551806;4769.046190761862;4832.1543729847135;5227.032998895216;5236.699830768275;5237.109691352479;5238.554722848525;5243.973780131075;4737.739424331695;4759.095771803346;4773.880652983703;4908.484609115992;4964.478729733398;5059.443461219263;5060.544550990355;5064.442911279756;5111.923321150186;5129.589632829365;5001.599872010303;5008.84973450797;5016.347874776256;5037.974810125926;5074.695518268915;4832;4890.804367825247;4895.510448955076;4955.628327875424;4988.201887697951;3960.0099975006246;3970.1067259866877;3991.022199561126;3991.3015222336558;4004.1591265833918;3518.4194607889413;3543.36219480496;3549.94675079874;3584.211473475831;3612.566492020922;4305.160493703697;4311.33174357975;4318.179545886272;4319.092990472036;4372.038151606642;4895.167821470359;4939.283803848493;5042.470540593258;5053.1157047516535;5119.257707632447;4322.15717935006;4369.47566292047;4371.213181627274;4384.12317536494;4430.379746835446;4618.65360097994;4626.537346265347;4660.557247061523;4662.6269898408045;4707.03505781314;4623.398958135421;4784;4792.95207047925;4795.688280261772;4852.078105160079;4942.283368911416;5041.4454410015605;5060.2156665716875;5073.492650734897;5159.303494028258;4732;4740.099381117577;4740.241561350167;4742.027884283644;4798.7840547174765;4990.750462476789;4994.150994331045;4994.425641051325;4999.0501804657;5052.494750524918;4914.606831453547;4941.283513890394;4954.925676114934;5048.924266136084;5053.84838454847;4854.514548545118;4894.975525122351;4903.117438861039;4905.852824415273;4909.361782968192;4887.315775791463;4898.975505122452;4900.387451568554;4901.558859702502;4909.803607855789;4786.521347865325;4790.4251489821445;4822.107910036654;4834.371531700856;4847.442544107473;4911.238757992517;4936;4936.975315123402;4941.925871112008;4995.62532810048;4649.674522783373;4815.446223684181;4816.133096042606;4864.902701946012;4869.780859861244 00:22:38 INFO - PROCESS | 5921 | |1;ext.html;551.189751065933;566.6316894018887;570.1419363857395;571.7884382778373;578.6267857232089;28451.430971380585;30996.225094372625;42143.99999999996;43591;43723;40332.59667403325;40558;40831.59168408315;40871;40889;7652.196519365484;7744.651490682904;7804.60976951153;7806.648700808477;7809;7592.088949326088;7678.961605191994;7681.193474685161;7681.539107653559;7683.8079048023965;7698.076230852277;7726.150123486412;7744.225577442267;7744.341730952876;7746.147923728414;7652.04349456318;7685.5004424712215;7686.269804368576;7690.538567685957;7693.923060769376;7673.808154796175;7725.690972361099;7738.226177382273;7742.264484873928;7745.3416459601;38117.428238576445;38465.807670961745;38474.80762596197;38511.614883851085;38513;3025.2890570715863;3272.280098378353;3311.1556553078813;3317.2038710709257;3530.38218311797;28890;29445.705542944725;29524;29617;30736.2315942101;3178.316661917676;3203.679632036801;3298.472244440902;3426.0235832787785;3449.0515108345153;247511;249340;250722;250784;251031;31603.52594711081;32738.345233095206;54545.45454545483;55072.17391739127;55126.17310740342;34311.82844085814;34416;34461.31077378438;34479.13802154966;34500.654993449745;13843.16940983524;13965.718056256772;13974.301284935713;13980.86019139816;13983.580492585239;11701.063914886789;11783.52865885355;11784.351860647575;11785.292882427082;11788;7966.760997170094;7989.0413150421155;8000.5599692017495;8059.274665280153;8073.152319006537;3161.1780936956097;3164.7784655074383;3172.270377813116;3222.371637530706;3241.918952026171;868.5309932636432;868.9522076285865;922.7139586728135;937.4609599480326;958.5638534466801;27109.1867243983;27646;28041;28371.57442638362;28554.85722571374;967.6519243417713;970.5147426286857;980.9411435313904;989.1443901025561;1026.0867827633413;13895.513657022158;14817.25913704332;14906.776398354034;14973.176475293963;15139.848601513844;379464;384263;384331;384890;385177;50013;50568.49431505711;50762.492375076516;50811.23783143256;50827;1164.6564263542446;1188.744419949715;1196.9940150299192;1198.4487135917575;1204.163106640876;25514.23457296284;26468.867655661597;26473.470530589664;27599.586006210324;27661.723382765915;42794.14411711811;43080.35379469248;43093.569064310206;43111.13777724365;43130.56869431391;304248;305559;306016;307933;308778;25539.872300638377;25951.74048259493;25954.09160679367;25960.442373457652;25991;41338;42113;42426.575734242266;42927.356089659304;42996.57003430051;34815;35387;35736.463953041246;35934;36092.458613120296;32834.67165328316;35587.64412355947;35628.287434250655;35855.64144358523;35905.46141807927;26701.732982669924;30732.385352293277;35513.46729799107;35832.28335433225;35848.64151358557;29768.70231297659;32370.676293236767;32687.18282042968;32719.509207362385;32818.50772238371;24403.511929761662;25035.49929001446;25038.874805625856;25500.617490738026;25516.61725074088 00:22:38 INFO - PROCESS | 5921 | |2;jquery.html;339.2299480179993;353.35159981434066;354.1783063293158;366.7359501159165;382.87939299120774;12348.567800126997;15834.604134896634;16344.34622615097;16752.16239188039;17798.11009449529;16383.672326553462;16722.498325050266;16895.15524223787;17324.04717740524;17478.475645730618;4034.5561988181425;4857.688424125484;4905.583025442833;5100.311457953185;5146.511081447256;5000.19996800512;5080.618953578478;5082.593392528607;5088.567471764904;5089.491050894918;5051.6716413433005;5056.898862022757;5140.820071297505;5445.727713614323;5487.341519017724;5391.32608423947;5426.75579598919;5435.347758268994;5436.2661040759585;5442.102053161224;4677.391939047936;4954.3063971044085;4979.900401991976;5047.924281135786;5266.578673706133;12148.514059437612;12194.75610487794;12371.566995155126;14658.926705366512;20096.899515502475;1704.4460550321196;1704.81247062823;1822.6081392500676;1887.3299978507707;2070.8343332533514;9312.72061838146;9506.47714375709;9758.072983066597;9778.266630002778;11220.607278745287;1701.6681747059329;1745.293156271712;1770.6281680847037;1830.789459212181;1847.8152184781413;63924;67854;68386.31613683849;68947.65526172337;71138.64430677865;9503.334766566273;9546.474943878153;9808.409206752225;9892;10009.249306302056;13485.190888546718;13501.66245843842;13504.729905401837;13512.324383780771;13544.119632223874;7241.312075352833;7350.5957172354965;7418.33235008841;7600.923990760021;7646.4265180111715;6770.119884414995;6841.760538381132;7025.2272250053475;7298.416126709851;7516.624168791539;4041.939370909439;4077.1641813428178;4123.154753275571;4201.894952626209;4396.07682386696;1666.9081751452575;1690.8816382853083;1695.313398073782;1709.3077303692025;1710.1363811275226;780.30163004111;823.5635113389912;823.6622984576295;835.7200337886876;898.7618281155499;16380.672386552202;16767.496975090766;17257.223424945907;17711.645767084585;17740.11299435023;852.7399143261241;855.683397143061;866.913308669128;871.9710741325297;893.6916763716507;9157.221636160868;9492.098250666175;9603.087706667855;9638.614455421844;9764.365316254421;345422;366742;367519.6496070117;367827;367994;72125;73808;74030;74735;76566;882.2765332427348;882.4749274181852;886.0696268917611;891.0332289465872;895.2971917045219;13969.511067112602;14860.479883204036;15364.231788410758;15486.225688715744;15488.845111549192;35316.64683353133;35541;36014.45978310275;36177.819110904275;36624.08439789026;48974.755126225566;49102;49719;50601.49398505968;50876.491235087175;7500.9249907500225;7580.317771400601;7711.537307761552;7974.16271291506;8094.352451803959;11040;11983;12046.638600841989;12098.516059357527;12225.510979560719;10271.383716977005;10294.845577316497;10597.89402105969;10831.566737330419;10879.673609791718;10065.496725163566;10098.444585547571;10158.13655839262;10398.584056637952;10539.736506587089;10223.437710925673;10334.431606261427;10395.076910771531;10455.477226138815;11202.327860328407;7629.351505122127;7801.29788319054;7926.682932682628;7991.640376183202;8311.83376332458;9636.325457217927;10006.499675016075;10024;10575.101116405192;11082.778344433227 00:22:38 INFO - PROCESS | 5921 | |3;mootools.html;1217.7807994560976;1321.6894029902974;1362.1894972491368;1418.8864890808736;1701.5150682055616;6688.498362622804;7448.888266675997;7652.732154374591;7698.191689872567;7936.642851071701;7676.232376762321;7729.961350193241;7745;7745.225477452252;7747.806304842382;2116.566103948691;2129.4037669452578;2133.7119488868957;2136.7970042845905;2137.0596937347595;2147.9248226312084;2162.513434477246;2163.1996161420298;2165.66432203008;2195.2316689158747;2153.5692861427697;2172.5872084303933;2182.8581142225703;2184.3446965910243;2221.1559607349263;2122.2466024561213;2136.9252076177413;2139.9786002140013;2142.582196471689;2147.6885851551515;2023.433438637184;2046.8771873687626;2050.241410678044;2052.035543294649;2070.958580828375;7665.846683066363;7729.381649468085;7758.224177582253;7758.922410775876;7769.1842356552315;4412.426384569985;4584.977075114636;4585.358049873021;4635.7218566886095;4636.235021221494;2694.380292532709;2819.1965289892487;2864.613277207571;2876.8993085241914;2881.3228891210547;896.2202883491339;906.9138431848963;917.0874979395544;934.4813628436283;949.7008442340641;10283.640072597424;10359.171266298677;10372.222083343704;10374.792504149875;10374.948125259401;3726.7763934164036;3870.3033453978555;3874.3413619684156;4057.14799892026;4078.408630748525;8097.311728503143;8102.432829701865;8103.189681031968;8109.43233973628;8110.3511719062335;4438.312061630452;4443.466783985942;4443.933340999887;4446.444194475691;4448.866534003985;3667.94498082529;3737.9439308410397;3786.848526058927;4132.855350062733;4146.896327591774;3262.8042317461027;3265.346930613887;3407.6421975692197;3449.6377880322707;3478.0261526772542;980.6812785844629;982.0228872271992;1000.4997501249376;1000.9199264058858;1003.4481035430484;604.727872457396;776.3672606825533;799.3325573146487;806.9152738962442;815.2988429950238;4710.905781884343;4761.642876784185;4838.564529192389;5013.799448022111;5140.820071297487;808.874624433202;831.4678605692362;834.2450082675189;857.4041041476114;881.828043531518;3135.764817638686;3237.174520497258;3273.1817045738567;3296.2748195396975;3386.255023894739;9164.450132992042;9487.620495180116;9495.762605934908;9501.809963800686;9502.857457138149;9369.625214991323;9453.858192127123;9458.385204961656;9464.337496375188;9485.05149485046;6798.2182049064;6901.378875901193;7133.500654954103;7137.2149063602965;7234.782956511208;4971.130052240771;5042.546170844642;5046.949530504795;5062.215356619729;5251.868703282448;8132.430729848854;8431.831363372821;8515.48907065578;8591.097934716765;8598.398112132341;8644.351673624378;8657.523836188819;8724.302055835646;8820.823583528165;8842.911570884466;5955.851103722268;6160.691965401622;6518.185226846645;6640.501962352746;6642.900356494753;6953.826154346182;7044.894326585208;7154.642267886481;7233.1681856587165;7276.672549735169;6295.464885484602;6416.711247993758;6423.743050277936;6558.376954189344;6579.572327798678;6511.609303441809;6547.214334279917;6690.665466726741;6725.29384414649;6729.697163627747;6132.5400594956445;6233.844153896189;6233.968830156002;6235.345288744798;6240.438360547572;4251.744895306291;4272.46594175728;4273.273543497551;4366.2577361847925;4447.599716025444;4249.235137675249;4306.461692288464;4358.193734159191;4382.693211475166;4466.2407390743 00:22:38 INFO - PROCESS | 5921 | |4;prototype.html;283.10679805214545;287.8114834783215;289.47171412172776;290.1947096806362;295.20589613938506;4827.8310259140935;4858.5141485851445;4891.730954797489;4895.583875370593;4898.142825005619;4845.806167753286;4849.199882019462;4854.441739199993;4856.247281671346;4862.781174847131;3565.197830488139;3693.7045036397158;3696.1129328961124;3780.3573392523335;3782.300274449222;3805.809709514527;3808.1431677872397;3822.8279727412196;3826.1582451860686;3830.387138057911;3779.0930176757656;3779.4519794629764;3779.489768881207;3782.3759079751944;3787.0721673190105;3596.17288023756;3696.815159242027;3700.9814950925343;3754.3429899767702;3791.393377059671;3281.6554261802407;3298.802071875695;3319.5559931429666;3324.8503817328037;3335.5997280326274;4740;4741.728207536823;4757.500462451428;4765.189917713962;4774.686961085695;4227.704060715751;4344.652427805768;4351.8694439166875;4363.694541382105;4367.475902891641;5067.670601410897;5073.416557095944;5076.471852062818;5086.440491545927;5092.770825312869;3641.2171383152486;3647.9785660015236;3658.8536458541626;3664.2671465706967;3678.4850120983083;5115.488451154929;5305.628605997582;5339.946600534023;5362.731863406814;5363.678179309254;3751.40565259769;3783.5838057813617;3786.992893766308;3790.2608991246993;3793.7154713396053;3840.7695538267794;3842.7310088293552;3844.826982785781;3854.9206222257812;3894.201688653819;4381.759003254851;4385.583369579885;4387.319965405367;4388.626966707801;4390.143921935256;4858.902821943541;5052.873678158076;5096.031753966735;5197.324347834758;5202.297689811902;1321.5308565459125;1322.4989636762152;1325.1651459580403;1328.3225554967037;1328.6479083043002;830.9820469924294;860.9526476043877;867.1935100356603;870.8606622940299;875.7985663297477;4339.370791235253;4374.300111982067;4457.710248833815;4542.31865220213;4543.159515489645;5319;5320.201969704575;5321.627486075938;5327.3074500314715;5327.520523152934;4323.221820072417;4530.116627257653;4530.954690453119;4542.227821270392;4543.568361005699;2534.4931013797313;2766.7509924106926;2794.3293609533566;2799.566067259578;2806.3825958289144;4886.511348865085;4891.3396691446915;4900.681455705368;4902;4940.802367905316;5152.969406118791;5362.766563690295;5401.756920938567;5402.460843403594;5429.864253393696;4951;4958.611588755154;4965.3048573199785;4966.751662416865;4977.183328085295;5259;5270.578353731769;5271.84184474451;5292.788288468418;5324.307839980777;4926.901461970669;5181.248718935809;5185.42960274377;5207.661502002357;5209.4530074343165;4946.851594452172;4954.355933728592;4976.726280054631;4983.202687569971;4996.625253105959;3640.981795091114;3644.21649345392;3644.362236608636;3664.3953747631344;3673.540807399075;5227.764750586157;5327.840164795062;5359.7672535316315;5382.4886635769535;5384.730763461889;5134.871628209325;5163.8192663256605;5175.308839403414;5182.2898443514305;5183.611229157904;5136;5145.176771716508;5172.836111874798;5188.457655748581;5225.372955245243;4953.653244272867;5078.136716758087;5092.770825312944;5102.4897510248675;5107.795688172431;4905.23968784839;5152.407473140487;5157.948420515897;5162.174052151638;5181.740912954413;4842.7820748065715;4888.755562221946;5013.849584512471;5023.246513022929;5111.642185047011 00:22:38 INFO - PROCESS | 5921 | |5;yui.html;557.2838902010916;563.3465180390742;585.9882802343953;638.9201349831272;654.4927681047188;12786.296753678544;13918.930405347985;13943.372548235317;13969.371378287977;14328.641783955407;13982.790258146137;14551.781723274133;14557.78163327551;14558.781618275709;14575.708485830277;629.8771739510797;780.9297163255305;804.3565147881701;806.5362416610473;806.899137607799;648.1638686094932;746.8058304840727;764.8699721047435;778.0624347661055;779.0184367696686;836.8326334733077;836.9163083691612;839.412411312081;844.8943882014748;845.4377838737232;646.896496560548;839.0099682374795;839.3033781960958;839.6767244610808;839.7942504086508;489.33939182103876;584.042170839823;600.5015836855399;600.5075837812996;603.1465476350958;13219.73560528784;13245.47018119274;13249.403776830066;13257.270850103241;13269.203847769164;11852;12130.757384852343;12209.328486933215;12460.563880264148;13153.73692526144;11388.54445822166;11665.941670291595;11815.409229538489;11855.04391775356;12287.754244915051;4043.9191216175805;4052.3516237401873;4115.938260926088;4209.494860616745;4268.743875367488;64676;67720.66139669319;67770;67783.66108169477;67889.5321514628;10086;10308.793824123475;10683.732906677395;10733.195010374253;10953.123750099972;18300.542486437946;18615.25538978453;18696.53258668517;18710.81289187118;18732.719009214874;6541.411272985454;6687;6709.463242940553;6758.127795686813;6779.796606101825;2924.941501169965;2968.168912704446;2992.1023692892045;2992.4314380268115;3041.604591403148;2837.4325134973087;2922.693117222661;2936.559516072606;2937.3097322129283;2939.4415061138316;490.75952783136006;493.83950216179886;501.55361728062053;504.271327931136;505.7016360347413;523.8009556368631;545.4245770711858;547.1464515356057;553.1426289251724;563.2874413866463;7432;7747.806304842311;7778.64996075178;8130.105688374274;8136.34909207262;506.6478797235886;517.8757098296458;553.3636318234063;582.8047604052605;583.7081459270365;3669.7520759546373;3785.5268091488565;3905.9609403906165;3909.7684428679627;3912.921741565153;59108.40891591029;59299.70350148222;59321;59824;94315;87965;88748.5562572183;88762.55618721995;89596;91319.54340228256;43169.489067882474;62760.68619656964;63703.6814815923;64442.99999999906;65550;8405.117462666332;8861.468311901306;8873;9109.316801239802;9285.535723213947;30289.697103028688;38664.6133538661;42231.577684223994;42403.363949540166;42986;40945.79527102345;41027;44980.77509612431;48227.276590850466;60909.69545152246;10824.567017319534;10830.566777329133;11085;11295.322280663186;11480.712982175512;12804.61586152417;13525.661858453617;13625.523106691218;14121.576352709435;14520.636984075483;12304.630861074182;12346.259224446561;12445;12812;13177.670558235737;11381.943090284496;11627.941860290644;11748.88251117478;11820.645380638594;12488.313142776871;11182.776344473228;11766.529338826693;11906.821397678868;12064.45709943037;12336.444859981502;10076.748081298027;10592.205584581034;10600.840987385349;10983.780324393307;11587.5944341951;10374.858765535935;10861;10880;10910.94544527304;10929.508172132115 00:22:38 INFO - PROCESS | 5921 | __end_tp_report 00:22:38 INFO - PROCESS | 5921 | __start_cc_report 00:22:38 INFO - PROCESS | 5921 | _x_x_mozilla_cycle_collect,1628 00:22:38 INFO - PROCESS | 5921 | __end_cc_report 00:22:38 INFO - PROCESS | 5921 | __startTimestamp1475565758069__endTimestamp 00:22:38 INFO - PROCESS | 5921 | 00:22:38 INFO - PROCESS | 5921 | ------- Summary: start ------- 00:22:38 INFO - PROCESS | 5921 | Number of tests: 6 00:22:38 INFO - PROCESS | 5921 | 00:22:38 INFO - PROCESS | 5921 | [#0] dojo.html Cycles:165 Average:4644.67 Median:4786.52 stddev:509.35 (10.6%) stddev-sans-first:483.98 00:22:38 INFO - PROCESS | 5921 | Values: 2561.2 2597.9 2623.2 2624.6 2640.4 4623.8 4720.1 4740.9 4759.7 4773.0 4693.6 4728.3 4739.0 4754.8 4846.5 4249.5 4306.3 4309.8 4357.2 4370.3 4313.4 4316.0 4343.1 4365.2 4373.4 4354.0 4361.4 4392.0 4405.0 4409.0 4208.4 4236.1 4247.7 4287.8 4320.0 4320.2 4323.0 4330.5 4404.8 4415.6 4707.7 4710.5 4721.6 4772.5 4800.6 4821.8 4877.3 5100.3 5104.9 5105.8 4953.6 5031.1 5104.2 5114.1 5190.1 4762.5 4763.5 4766.4 4769.0 4832.2 5227.0 5236.7 5237.1 5238.6 5244.0 4737.7 4759.1 4773.9 4908.5 4964.5 5059.4 5060.5 5064.4 5111.9 5129.6 5001.6 5008.8 5016.3 5038.0 5074.7 4832.0 4890.8 4895.5 4955.6 4988.2 3960.0 3970.1 3991.0 3991.3 4004.2 3518.4 3543.4 3549.9 3584.2 3612.6 4305.2 4311.3 4318.2 4319.1 4372.0 4895.2 4939.3 5042.5 5053.1 5119.3 4322.2 4369.5 4371.2 4384.1 4430.4 4618.7 4626.5 4660.6 4662.6 4707.0 4623.4 4784.0 4793.0 4795.7 4852.1 4942.3 5041.4 5060.2 5073.5 5159.3 4732.0 4740.1 4740.2 4742.0 4798.8 4990.8 4994.2 4994.4 4999.1 5052.5 4914.6 4941.3 4954.9 5048.9 5053.8 4854.5 4895.0 4903.1 4905.9 4909.4 4887.3 4899.0 4900.4 4901.6 4909.8 4786.5 4790.4 4822.1 4834.4 4847.4 4911.2 4936.0 4937.0 4941.9 4995.6 4649.7 4815.4 4816.1 4864.9 4869.8 00:22:38 INFO - PROCESS | 5921 | 00:22:38 INFO - PROCESS | 5921 | [#1] ext.html Cycles:180 Average:45686.53 Median:35550.56 stddev:83882.37 (236.0%) stddev-sans-first:84049.23 00:22:38 INFO - PROCESS | 5921 | Values: 551.2 566.6 570.1 571.8 578.6 28451.4 30996.2 42144.0 43591.0 43723.0 40332.6 40558.0 40831.6 40871.0 40889.0 7652.2 7744.7 7804.6 7806.6 7809.0 7592.1 7679.0 7681.2 7681.5 7683.8 7698.1 7726.2 7744.2 7744.3 7746.1 7652.0 7685.5 7686.3 7690.5 7693.9 7673.8 7725.7 7738.2 7742.3 7745.3 38117.4 38465.8 38474.8 38511.6 38513.0 3025.3 3272.3 3311.2 3317.2 3530.4 28890.0 29445.7 29524.0 29617.0 30736.2 3178.3 3203.7 3298.5 3426.0 3449.1 247511.0 249340.0 250722.0 250784.0 251031.0 31603.5 32738.3 54545.5 55072.2 55126.2 34311.8 34416.0 34461.3 34479.1 34500.7 13843.2 13965.7 13974.3 13980.9 13983.6 11701.1 11783.5 11784.4 11785.3 11788.0 7966.8 7989.0 8000.6 8059.3 8073.2 3161.2 3164.8 3172.3 3222.4 3241.9 868.5 869.0 922.7 937.5 958.6 27109.2 27646.0 28041.0 28371.6 28554.9 967.7 970.5 980.9 989.1 1026.1 13895.5 14817.3 14906.8 14973.2 15139.8 379464.0 384263.0 384331.0 384890.0 385177.0 50013.0 50568.5 50762.5 50811.2 50827.0 1164.7 1188.7 1197.0 1198.4 1204.2 25514.2 26468.9 26473.5 27599.6 27661.7 42794.1 43080.4 43093.6 43111.1 43130.6 304248.0 305559.0 306016.0 307933.0 308778.0 25539.9 25951.7 25954.1 25960.4 25991.0 41338.0 42113.0 42426.6 42927.4 42996.6 34815.0 35387.0 35736.5 35934.0 36092.5 32834.7 35587.6 35628.3 35855.6 35905.5 26701.7 30732.4 35513.5 35832.3 35848.6 29768.7 32370.7 32687.2 32719.5 32818.5 24403.5 25035.5 25038.9 25500.6 25516.6 00:22:38 INFO - PROCESS | 5921 | 00:22:38 INFO - PROCESS | 5921 | [#2] jquery.html Cycles:180 Average:23190.80 Median:4298.99 stddev:60073.67 (1397.4%) stddev-sans-first:60217.69 00:22:38 INFO - PROCESS | 5921 | Values: 339.2 353.4 354.2 366.7 382.9 12348.6 15834.6 16344.3 16752.2 17798.1 16383.7 16722.5 16895.2 17324.0 17478.5 4034.6 4857.7 4905.6 5100.3 5146.5 5000.2 5080.6 5082.6 5088.6 5089.5 5051.7 5056.9 5140.8 5445.7 5487.3 5391.3 5426.8 5435.3 5436.3 5442.1 4677.4 4954.3 4979.9 5047.9 5266.6 12148.5 12194.8 12371.6 14658.9 20096.9 1704.4 1704.8 1822.6 1887.3 2070.8 9312.7 9506.5 9758.1 9778.3 11220.6 1701.7 1745.3 1770.6 1830.8 1847.8 63924.0 67854.0 68386.3 68947.7 71138.6 9503.3 9546.5 9808.4 9892.0 10009.2 13485.2 13501.7 13504.7 13512.3 13544.1 7241.3 7350.6 7418.3 7600.9 7646.4 6770.1 6841.8 7025.2 7298.4 7516.6 4041.9 4077.2 4123.2 4201.9 4396.1 1666.9 1690.9 1695.3 1709.3 1710.1 780.3 823.6 823.7 835.7 898.8 16380.7 16767.5 17257.2 17711.6 17740.1 852.7 855.7 866.9 872.0 893.7 9157.2 9492.1 9603.1 9638.6 9764.4 345422.0 366742.0 367519.6 367827.0 367994.0 72125.0 73808.0 74030.0 74735.0 76566.0 882.3 882.5 886.1 891.0 895.3 13969.5 14860.5 15364.2 15486.2 15488.8 35316.6 35541.0 36014.5 36177.8 36624.1 48974.8 49102.0 49719.0 50601.5 50876.5 7500.9 7580.3 7711.5 7974.2 8094.4 11040.0 11983.0 12046.6 12098.5 12225.5 10271.4 10294.8 10597.9 10831.6 10879.7 10065.5 10098.4 10158.1 10398.6 10539.7 10223.4 10334.4 10395.1 10455.5 11202.3 7629.4 7801.3 7926.7 7991.6 8311.8 9636.3 10006.5 10024.0 10575.1 11082.8 00:22:38 INFO - PROCESS | 5921 | 00:22:38 INFO - PROCESS | 5921 | [#3] mootools.html Cycles:180 Average:4940.92 Median:5101.52 stddev:2787.44 (54.6%) stddev-sans-first:2781.21 00:22:38 INFO - PROCESS | 5921 | Values: 1217.8 1321.7 1362.2 1418.9 1701.5 6688.5 7448.9 7652.7 7698.2 7936.6 7676.2 7730.0 7745.0 7745.2 7747.8 2116.6 2129.4 2133.7 2136.8 2137.1 2147.9 2162.5 2163.2 2165.7 2195.2 2153.6 2172.6 2182.9 2184.3 2221.2 2122.2 2136.9 2140.0 2142.6 2147.7 2023.4 2046.9 2050.2 2052.0 2071.0 7665.8 7729.4 7758.2 7758.9 7769.2 4412.4 4585.0 4585.4 4635.7 4636.2 2694.4 2819.2 2864.6 2876.9 2881.3 896.2 906.9 917.1 934.5 949.7 10283.6 10359.2 10372.2 10374.8 10374.9 3726.8 3870.3 3874.3 4057.1 4078.4 8097.3 8102.4 8103.2 8109.4 8110.4 4438.3 4443.5 4443.9 4446.4 4448.9 3667.9 3737.9 3786.8 4132.9 4146.9 3262.8 3265.3 3407.6 3449.6 3478.0 980.7 982.0 1000.5 1000.9 1003.4 604.7 776.4 799.3 806.9 815.3 4710.9 4761.6 4838.6 5013.8 5140.8 808.9 831.5 834.2 857.4 881.8 3135.8 3237.2 3273.2 3296.3 3386.3 9164.5 9487.6 9495.8 9501.8 9502.9 9369.6 9453.9 9458.4 9464.3 9485.1 6798.2 6901.4 7133.5 7137.2 7234.8 4971.1 5042.5 5046.9 5062.2 5251.9 8132.4 8431.8 8515.5 8591.1 8598.4 8644.4 8657.5 8724.3 8820.8 8842.9 5955.9 6160.7 6518.2 6640.5 6642.9 6953.8 7044.9 7154.6 7233.2 7276.7 6295.5 6416.7 6423.7 6558.4 6579.6 6511.6 6547.2 6690.7 6725.3 6729.7 6132.5 6233.8 6234.0 6235.3 6240.4 4251.7 4272.5 4273.3 4366.3 4447.6 4249.2 4306.5 4358.2 4382.7 4466.2 00:22:38 INFO - PROCESS | 5921 | 00:22:38 INFO - PROCESS | 5921 | [#4] prototype.html Cycles:180 Average:4246.24 Median:4857.38 stddev:1241.64 (25.6%) stddev-sans-first:1208.96 00:22:38 INFO - PROCESS | 5921 | Values: 283.1 287.8 289.5 290.2 295.2 4827.8 4858.5 4891.7 4895.6 4898.1 4845.8 4849.2 4854.4 4856.2 4862.8 3565.2 3693.7 3696.1 3780.4 3782.3 3805.8 3808.1 3822.8 3826.2 3830.4 3779.1 3779.5 3779.5 3782.4 3787.1 3596.2 3696.8 3701.0 3754.3 3791.4 3281.7 3298.8 3319.6 3324.9 3335.6 4740.0 4741.7 4757.5 4765.2 4774.7 4227.7 4344.7 4351.9 4363.7 4367.5 5067.7 5073.4 5076.5 5086.4 5092.8 3641.2 3648.0 3658.9 3664.3 3678.5 5115.5 5305.6 5339.9 5362.7 5363.7 3751.4 3783.6 3787.0 3790.3 3793.7 3840.8 3842.7 3844.8 3854.9 3894.2 4381.8 4385.6 4387.3 4388.6 4390.1 4858.9 5052.9 5096.0 5197.3 5202.3 1321.5 1322.5 1325.2 1328.3 1328.6 831.0 861.0 867.2 870.9 875.8 4339.4 4374.3 4457.7 4542.3 4543.2 5319.0 5320.2 5321.6 5327.3 5327.5 4323.2 4530.1 4531.0 4542.2 4543.6 2534.5 2766.8 2794.3 2799.6 2806.4 4886.5 4891.3 4900.7 4902.0 4940.8 5153.0 5362.8 5401.8 5402.5 5429.9 4951.0 4958.6 4965.3 4966.8 4977.2 5259.0 5270.6 5271.8 5292.8 5324.3 4926.9 5181.2 5185.4 5207.7 5209.5 4946.9 4954.4 4976.7 4983.2 4996.6 3641.0 3644.2 3644.4 3664.4 3673.5 5227.8 5327.8 5359.8 5382.5 5384.7 5134.9 5163.8 5175.3 5182.3 5183.6 5136.0 5145.2 5172.8 5188.5 5225.4 4953.7 5078.1 5092.8 5102.5 5107.8 4905.2 5152.4 5157.9 5162.2 5181.7 4842.8 4888.8 5013.8 5023.2 5111.6 00:22:38 INFO - PROCESS | 5921 | 00:22:38 INFO - PROCESS | 5921 | [#5] yui.html Cycles:180 Average:16388.75 Median:22571.47 stddev:22096.12 (97.9%) stddev-sans-first:22126.12 00:22:38 INFO - PROCESS | 5921 | Values: 557.3 563.3 586.0 638.9 654.5 12786.3 13918.9 13943.4 13969.4 14328.6 13982.8 14551.8 14557.8 14558.8 14575.7 629.9 780.9 804.4 806.5 806.9 648.2 746.8 764.9 778.1 779.0 836.8 836.9 839.4 844.9 845.4 646.9 839.0 839.3 839.7 839.8 489.3 584.0 600.5 600.5 603.1 13219.7 13245.5 13249.4 13257.3 13269.2 11852.0 12130.8 12209.3 12460.6 13153.7 11388.5 11665.9 11815.4 11855.0 12287.8 4043.9 4052.4 4115.9 4209.5 4268.7 64676.0 67720.7 67770.0 67783.7 67889.5 10086.0 10308.8 10683.7 10733.2 10953.1 18300.5 18615.3 18696.5 18710.8 18732.7 6541.4 6687.0 6709.5 6758.1 6779.8 2924.9 2968.2 2992.1 2992.4 3041.6 2837.4 2922.7 2936.6 2937.3 2939.4 490.8 493.8 501.6 504.3 505.7 523.8 545.4 547.1 553.1 563.3 7432.0 7747.8 7778.6 8130.1 8136.3 506.6 517.9 553.4 582.8 583.7 3669.8 3785.5 3906.0 3909.8 3912.9 59108.4 59299.7 59321.0 59824.0 94315.0 87965.0 88748.6 88762.6 89596.0 91319.5 43169.5 62760.7 63703.7 64443.0 65550.0 8405.1 8861.5 8873.0 9109.3 9285.5 30289.7 38664.6 42231.6 42403.4 42986.0 40945.8 41027.0 44980.8 48227.3 60909.7 10824.6 10830.6 11085.0 11295.3 11480.7 12804.6 13525.7 13625.5 14121.6 14520.6 12304.6 12346.3 12445.0 12812.0 13177.7 11381.9 11627.9 11748.9 11820.6 12488.3 11182.8 11766.5 11906.8 12064.5 12336.4 10076.7 10592.2 10600.8 10983.8 11587.6 10374.9 10861.0 10880.0 10910.9 10929.5 00:22:38 INFO - PROCESS | 5921 | -------- Summary: end -------- 00:22:38 INFO - PROCESS | 5921 | 00:22:39 INFO - TEST-INFO | 5921: exit 0 00:22:39 INFO - TEST-OK | dromaeo_css | took 1121638ms 00:22:39 INFO - TEST-START | kraken 00:22:39 INFO - operating with platform_type : linux_ 00:22:39 INFO - Initialising browser for kraken test... 00:22:39 INFO - TEST-INFO | started process 6234 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4kFrpd/profile http://localhost:59196/getInfo.html) 00:22:43 INFO - PROCESS | 6234 | __metrics Screen width/height:1600/1200 00:22:43 INFO - PROCESS | 6234 | colorDepth:24 00:22:43 INFO - PROCESS | 6234 | Browser inner width/height: 1024/697 00:22:43 INFO - PROCESS | 6234 | __metrics 00:22:43 INFO - PROCESS | 6234 | 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" 00:22:43 INFO - PROCESS | 6234 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:22:44 INFO - TEST-INFO | 6234: exit 0 00:22:44 INFO - Browser initialized. 00:22:44 INFO - Running cycle 1/1 for kraken test... 00:22:44 INFO - TEST-INFO | started process 6316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4kFrpd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:22:57 INFO - PROCESS | 6316 | RSS: Main: 175685632 00:22:57 INFO - PROCESS | 6316 | 00:22:59 INFO - PROCESS | 6316 | Cycle 1(1): loaded http://localhost:59196/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59196/tests/kraken/driver.html?testName=audio-beat-detection) 00:23:00 INFO - PROCESS | 6316 | RSS: Main: 237613056 00:23:00 INFO - PROCESS | 6316 | 00:23:03 INFO - PROCESS | 6316 | Cycle 1(1): loaded http://localhost:59196/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59196/tests/kraken/driver.html?testName=audio-dft) 00:23:04 INFO - PROCESS | 6316 | RSS: Main: 218329088 00:23:04 INFO - PROCESS | 6316 | 00:23:07 INFO - PROCESS | 6316 | Cycle 1(1): loaded http://localhost:59196/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59196/tests/kraken/driver.html?testName=audio-fft) 00:23:08 INFO - PROCESS | 6316 | RSS: Main: 301060096 00:23:08 INFO - PROCESS | 6316 | 00:23:10 INFO - PROCESS | 6316 | Cycle 1(1): loaded http://localhost:59196/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59196/tests/kraken/driver.html?testName=audio-oscillator) 00:23:11 INFO - PROCESS | 6316 | RSS: Main: 212226048 00:23:11 INFO - PROCESS | 6316 | 00:23:13 INFO - PROCESS | 6316 | Cycle 1(1): loaded http://localhost:59196/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59196/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:23:13 INFO - PROCESS | 6316 | RSS: Main: 214974464 00:23:13 INFO - PROCESS | 6316 | 00:23:17 INFO - PROCESS | 6316 | Cycle 1(1): loaded http://localhost:59196/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59196/tests/kraken/driver.html?testName=imaging-darkroom) 00:23:17 INFO - PROCESS | 6316 | RSS: Main: 250941440 00:23:17 INFO - PROCESS | 6316 | 00:23:21 INFO - PROCESS | 6316 | Cycle 1(1): loaded http://localhost:59196/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59196/tests/kraken/driver.html?testName=imaging-desaturate) 00:23:21 INFO - PROCESS | 6316 | RSS: Main: 244883456 00:23:21 INFO - PROCESS | 6316 | 00:23:24 INFO - PROCESS | 6316 | Cycle 1(1): loaded http://localhost:59196/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59196/tests/kraken/driver.html?testName=json-parse-financial) 00:23:25 INFO - PROCESS | 6316 | RSS: Main: 248045568 00:23:25 INFO - PROCESS | 6316 | 00:23:27 INFO - PROCESS | 6316 | Cycle 1(1): loaded http://localhost:59196/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59196/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:23:27 INFO - PROCESS | 6316 | RSS: Main: 211615744 00:23:27 INFO - PROCESS | 6316 | 00:23:29 INFO - PROCESS | 6316 | Cycle 1(1): loaded http://localhost:59196/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59196/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:23:30 INFO - PROCESS | 6316 | RSS: Main: 218357760 00:23:30 INFO - PROCESS | 6316 | 00:23:32 INFO - PROCESS | 6316 | Cycle 1(1): loaded http://localhost:59196/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59196/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:23:32 INFO - PROCESS | 6316 | RSS: Main: 227713024 00:23:32 INFO - PROCESS | 6316 | 00:23:35 INFO - PROCESS | 6316 | Cycle 1(1): loaded http://localhost:59196/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59196/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:23:36 INFO - PROCESS | 6316 | RSS: Main: 236621824 00:23:36 INFO - PROCESS | 6316 | 00:23:39 INFO - PROCESS | 6316 | Cycle 1(1): loaded http://localhost:59196/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59196/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:23:40 INFO - PROCESS | 6316 | RSS: Main: 232415232 00:23:40 INFO - PROCESS | 6316 | 00:23:41 INFO - PROCESS | 6316 | Cycle 1(1): loaded http://localhost:59196/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59196/tests/kraken/driver.html?testName=ai-astar) 00:23:42 INFO - PROCESS | 6316 | RSS: Main: 283664384 00:23:42 INFO - PROCESS | 6316 | 00:23:42 INFO - PROCESS | 6316 | __start_tp_report 00:23:42 INFO - PROCESS | 6316 | _x_x_mozilla_page_load 00:23:42 INFO - PROCESS | 6316 | _x_x_mozilla_page_load_details 00:23:42 INFO - PROCESS | 6316 | |i|pagename|runs| 00:23:42 INFO - PROCESS | 6316 | |0;ai-astar;111;114;112;115;114;113;113;115;114;113 00:23:42 INFO - PROCESS | 6316 | |1;audio-beat-detection;150;127;129;176;134;129;131;130;165;130 00:23:42 INFO - PROCESS | 6316 | |2;audio-dft;162;164;164;164;162;161;161;163;163;161 00:23:42 INFO - PROCESS | 6316 | |3;audio-fft;76;76;77;107;78;78;77;77;100;77 00:23:42 INFO - PROCESS | 6316 | |4;audio-oscillator;86;82;115;83;84;83;117;84;83;116 00:23:42 INFO - PROCESS | 6316 | |5;imaging-gaussian-blur;117;117;117;116;118;116;118;117;117;117 00:23:42 INFO - PROCESS | 6316 | |6;imaging-darkroom;147;147;147;148;146;146;146;146;146;147 00:23:42 INFO - PROCESS | 6316 | |7;imaging-desaturate;96;96;96;95;96;96;96;96;95;95 00:23:42 INFO - PROCESS | 6316 | |8;json-parse-financial;66;64;64;65;65;65;66;67;66;65 00:23:42 INFO - PROCESS | 6316 | |9;json-stringify-tinderbox;65;67;66;67;66;65;66;67;65;67 00:23:42 INFO - PROCESS | 6316 | |10;stanford-crypto-aes;85;84;87;83;83;83;92;84;83;83 00:23:42 INFO - PROCESS | 6316 | |11;stanford-crypto-ccm;149;143;153;143;148;151;140;138;179;152 00:23:42 INFO - PROCESS | 6316 | |12;stanford-crypto-pbkdf2;175;179;176;175;176;177;179;179;177;173 00:23:42 INFO - PROCESS | 6316 | |13;stanford-crypto-sha256-iterative;71;70;70;75;71;74;75;70;70;72 00:23:42 INFO - PROCESS | 6316 | __end_tp_report 00:23:42 INFO - PROCESS | 6316 | __start_cc_report 00:23:42 INFO - PROCESS | 6316 | _x_x_mozilla_cycle_collect,1949 00:23:42 INFO - PROCESS | 6316 | __end_cc_report 00:23:42 INFO - PROCESS | 6316 | __startTimestamp1475565822243__endTimestamp 00:23:42 INFO - PROCESS | 6316 | 00:23:42 INFO - PROCESS | 6316 | ------- Summary: start ------- 00:23:42 INFO - PROCESS | 6316 | Number of tests: 14 00:23:42 INFO - PROCESS | 6316 | 00:23:42 INFO - PROCESS | 6316 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.00 stddev:1.26 (1.1%) stddev-sans-first:1.00 00:23:42 INFO - PROCESS | 6316 | Values: 111.0 114.0 112.0 115.0 114.0 113.0 113.0 115.0 114.0 113.0 00:23:42 INFO - PROCESS | 6316 | 00:23:42 INFO - PROCESS | 6316 | [#1] audio-beat-detection Cycles:10 Average:140.10 Median:132.50 stddev:17.48 (13.2%) stddev-sans-first:18.17 00:23:42 INFO - PROCESS | 6316 | Values: 150.0 127.0 129.0 176.0 134.0 129.0 131.0 130.0 165.0 130.0 00:23:42 INFO - PROCESS | 6316 | 00:23:42 INFO - PROCESS | 6316 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:1.27 (0.8%) stddev-sans-first:1.33 00:23:42 INFO - PROCESS | 6316 | Values: 162.0 164.0 164.0 164.0 162.0 161.0 161.0 163.0 163.0 161.0 00:23:42 INFO - PROCESS | 6316 | 00:23:42 INFO - PROCESS | 6316 | [#3] audio-fft Cycles:10 Average:82.30 Median:77.00 stddev:11.31 (14.7%) stddev-sans-first:11.77 00:23:42 INFO - PROCESS | 6316 | Values: 76.0 76.0 77.0 107.0 78.0 78.0 77.0 77.0 100.0 77.0 00:23:42 INFO - PROCESS | 6316 | 00:23:42 INFO - PROCESS | 6316 | [#4] audio-oscillator Cycles:10 Average:93.30 Median:83.00 stddev:15.71 (18.9%) stddev-sans-first:16.44 00:23:42 INFO - PROCESS | 6316 | Values: 86.0 82.0 115.0 83.0 84.0 83.0 117.0 84.0 83.0 116.0 00:23:42 INFO - PROCESS | 6316 | 00:23:42 INFO - PROCESS | 6316 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 00:23:42 INFO - PROCESS | 6316 | Values: 117.0 117.0 117.0 116.0 118.0 116.0 118.0 117.0 117.0 117.0 00:23:42 INFO - PROCESS | 6316 | 00:23:42 INFO - PROCESS | 6316 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 00:23:42 INFO - PROCESS | 6316 | Values: 147.0 147.0 147.0 148.0 146.0 146.0 146.0 146.0 146.0 147.0 00:23:42 INFO - PROCESS | 6316 | 00:23:42 INFO - PROCESS | 6316 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 00:23:42 INFO - PROCESS | 6316 | Values: 96.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 95.0 00:23:42 INFO - PROCESS | 6316 | 00:23:42 INFO - PROCESS | 6316 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:65.50 stddev:0.95 (1.4%) stddev-sans-first:0.97 00:23:42 INFO - PROCESS | 6316 | Values: 66.0 64.0 64.0 65.0 65.0 65.0 66.0 67.0 66.0 65.0 00:23:42 INFO - PROCESS | 6316 | 00:23:42 INFO - PROCESS | 6316 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.50 stddev:0.88 (1.3%) stddev-sans-first:0.83 00:23:42 INFO - PROCESS | 6316 | Values: 65.0 67.0 66.0 67.0 66.0 65.0 66.0 67.0 65.0 67.0 00:23:42 INFO - PROCESS | 6316 | 00:23:42 INFO - PROCESS | 6316 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:84.00 stddev:2.87 (3.4%) stddev-sans-first:3.04 00:23:42 INFO - PROCESS | 6316 | Values: 85.0 84.0 87.0 83.0 83.0 83.0 92.0 84.0 83.0 83.0 00:23:42 INFO - PROCESS | 6316 | 00:23:42 INFO - PROCESS | 6316 | [#11] stanford-crypto-ccm Cycles:10 Average:149.60 Median:150.00 stddev:11.55 (7.7%) stddev-sans-first:12.25 00:23:42 INFO - PROCESS | 6316 | Values: 149.0 143.0 153.0 143.0 148.0 151.0 140.0 138.0 179.0 152.0 00:23:42 INFO - PROCESS | 6316 | 00:23:42 INFO - PROCESS | 6316 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.60 Median:177.00 stddev:2.01 (1.1%) stddev-sans-first:2.05 00:23:42 INFO - PROCESS | 6316 | Values: 175.0 179.0 176.0 175.0 176.0 177.0 179.0 179.0 177.0 173.0 00:23:42 INFO - PROCESS | 6316 | 00:23:42 INFO - PROCESS | 6316 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:71.50 stddev:2.10 (2.9%) stddev-sans-first:2.20 00:23:42 INFO - PROCESS | 6316 | Values: 71.0 70.0 70.0 75.0 71.0 74.0 75.0 70.0 70.0 72.0 00:23:42 INFO - PROCESS | 6316 | -------- Summary: end -------- 00:23:42 INFO - PROCESS | 6316 | 00:23:43 INFO - TEST-INFO | 6316: exit 0 00:23:43 INFO - TEST-OK | kraken | took 64379ms 00:23:43 INFO - SUITE-END | took 1186s 00:23:43 INFO - Completed test suite (00:19:46) 00:23:43 INFO - javascript benchmark 00:23:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2561.218828257381, 2597.8960841566336, 2623.213036089173, 2624.6456728341673, 2640.3663120851, 4623.838165664202, 4720.079584481027, 4740.90518189636, 4759.738214398207, 4772.976135119324, 4693.5775780179865, 4728.314394412808, 4738.976305118478, 4754.7860346284415, 4846.466888642255, 4249.46881639795, 4306.310990241562, 4309.784510774464, 4357.150355680636, 4370.3007518797, 4313.396124542566, 4316.0, 4343.087951530182, 4365.170617582665, 4373.387725718386, 4354.0203454222865, 4361.4112094867105, 4391.989842336248, 4404.977975110136, 4409.030013397063, 4208.389783481378, 4236.131593023423, 4247.723897946624, 4287.785610719483, 4319.956800431987, 4320.179165958458, 4322.956770432318, 4330.545292744279, 4404.845830395952, 4415.558444155591, 4707.7175369477945, 4710.5289471052965, 4721.551452611996, 4772.451168115676, 4800.591949684281, 4821.831235906727, 4877.268409738532, 5100.28595996557, 5104.948950510485, 5105.846824595231, 4953.6037117030555, 5031.119554078022, 5104.208847628586, 5114.130597798383, 5190.091733946544, 4762.476127625959, 4763.452202996665, 4766.380370551806, 4769.046190761862, 4832.1543729847135, 5227.032998895216, 5236.699830768275, 5237.109691352479, 5238.554722848525, 5243.973780131075, 4737.739424331695, 4759.095771803346, 4773.880652983703, 4908.484609115992, 4964.478729733398, 5059.443461219263, 5060.544550990355, 5064.442911279756, 5111.923321150186, 5129.589632829365, 5001.599872010303, 5008.84973450797, 5016.347874776256, 5037.974810125926, 5074.695518268915, 4832.0, 4890.804367825247, 4895.510448955076, 4955.628327875424, 4988.201887697951, 3960.0099975006246, 3970.1067259866877, 3991.022199561126, 3991.3015222336558, 4004.1591265833918, 3518.4194607889413, 3543.36219480496, 3549.94675079874, 3584.211473475831, 3612.566492020922, 4305.160493703697, 4311.33174357975, 4318.179545886272, 4319.092990472036, 4372.038151606642, 4895.167821470359, 4939.283803848493, 5042.470540593258, 5053.1157047516535, 5119.257707632447, 4322.15717935006, 4369.47566292047, 4371.213181627274, 4384.12317536494, 4430.379746835446, 4618.65360097994, 4626.537346265347, 4660.557247061523, 4662.6269898408045, 4707.03505781314, 4623.398958135421, 4784.0, 4792.95207047925, 4795.688280261772, 4852.078105160079, 4942.283368911416, 5041.4454410015605, 5060.2156665716875, 5073.492650734897, 5159.303494028258, 4732.0, 4740.099381117577, 4740.241561350167, 4742.027884283644, 4798.7840547174765, 4990.750462476789, 4994.150994331045, 4994.425641051325, 4999.0501804657, 5052.494750524918, 4914.606831453547, 4941.283513890394, 4954.925676114934, 5048.924266136084, 5053.84838454847, 4854.514548545118, 4894.975525122351, 4903.117438861039, 4905.852824415273, 4909.361782968192, 4887.315775791463, 4898.975505122452, 4900.387451568554, 4901.558859702502, 4909.803607855789, 4786.521347865325, 4790.4251489821445, 4822.107910036654, 4834.371531700856, 4847.442544107473, 4911.238757992517, 4936.0, 4936.975315123402, 4941.925871112008, 4995.62532810048, 4649.674522783373, 4815.446223684181, 4816.133096042606, 4864.902701946012, 4869.780859861244], "value": 4610.7159737285965, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.189751065933, 566.6316894018887, 570.1419363857395, 571.7884382778373, 578.6267857232089, 28451.430971380585, 30996.225094372625, 42143.99999999996, 43591.0, 43723.0, 40332.59667403325, 40558.0, 40831.59168408315, 40871.0, 40889.0, 7652.196519365484, 7744.651490682904, 7804.60976951153, 7806.648700808477, 7809.0, 7592.088949326088, 7678.961605191994, 7681.193474685161, 7681.539107653559, 7683.8079048023965, 7698.076230852277, 7726.150123486412, 7744.225577442267, 7744.341730952876, 7746.147923728414, 7652.04349456318, 7685.5004424712215, 7686.269804368576, 7690.538567685957, 7693.923060769376, 7673.808154796175, 7725.690972361099, 7738.226177382273, 7742.264484873928, 7745.3416459601, 38117.428238576445, 38465.807670961745, 38474.80762596197, 38511.614883851085, 38513.0, 3025.2890570715863, 3272.280098378353, 3311.1556553078813, 3317.2038710709257, 3530.38218311797, 28890.0, 29445.705542944725, 29524.0, 29617.0, 30736.2315942101, 3178.316661917676, 3203.679632036801, 3298.472244440902, 3426.0235832787785, 3449.0515108345153, 247511.0, 249340.0, 250722.0, 250784.0, 251031.0, 31603.52594711081, 32738.345233095206, 54545.45454545483, 55072.17391739127, 55126.17310740342, 34311.82844085814, 34416.0, 34461.31077378438, 34479.13802154966, 34500.654993449745, 13843.16940983524, 13965.718056256772, 13974.301284935713, 13980.86019139816, 13983.580492585239, 11701.063914886789, 11783.52865885355, 11784.351860647575, 11785.292882427082, 11788.0, 7966.760997170094, 7989.0413150421155, 8000.5599692017495, 8059.274665280153, 8073.152319006537, 3161.1780936956097, 3164.7784655074383, 3172.270377813116, 3222.371637530706, 3241.918952026171, 868.5309932636432, 868.9522076285865, 922.7139586728135, 937.4609599480326, 958.5638534466801, 27109.1867243983, 27646.0, 28041.0, 28371.57442638362, 28554.85722571374, 967.6519243417713, 970.5147426286857, 980.9411435313904, 989.1443901025561, 1026.0867827633413, 13895.513657022158, 14817.25913704332, 14906.776398354034, 14973.176475293963, 15139.848601513844, 379464.0, 384263.0, 384331.0, 384890.0, 385177.0, 50013.0, 50568.49431505711, 50762.492375076516, 50811.23783143256, 50827.0, 1164.6564263542446, 1188.744419949715, 1196.9940150299192, 1198.4487135917575, 1204.163106640876, 25514.23457296284, 26468.867655661597, 26473.470530589664, 27599.586006210324, 27661.723382765915, 42794.14411711811, 43080.35379469248, 43093.569064310206, 43111.13777724365, 43130.56869431391, 304248.0, 305559.0, 306016.0, 307933.0, 308778.0, 25539.872300638377, 25951.74048259493, 25954.09160679367, 25960.442373457652, 25991.0, 41338.0, 42113.0, 42426.575734242266, 42927.356089659304, 42996.57003430051, 34815.0, 35387.0, 35736.463953041246, 35934.0, 36092.458613120296, 32834.67165328316, 35587.64412355947, 35628.287434250655, 35855.64144358523, 35905.46141807927, 26701.732982669924, 30732.385352293277, 35513.46729799107, 35832.28335433225, 35848.64151358557, 29768.70231297659, 32370.676293236767, 32687.18282042968, 32719.509207362385, 32818.50772238371, 24403.511929761662, 25035.49929001446, 25038.874805625856, 25500.617490738026, 25516.61725074088], "value": 16398.636707591646, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.2299480179993, 353.35159981434066, 354.1783063293158, 366.7359501159165, 382.87939299120774, 12348.567800126997, 15834.604134896634, 16344.34622615097, 16752.16239188039, 17798.11009449529, 16383.672326553462, 16722.498325050266, 16895.15524223787, 17324.04717740524, 17478.475645730618, 4034.5561988181425, 4857.688424125484, 4905.583025442833, 5100.311457953185, 5146.511081447256, 5000.19996800512, 5080.618953578478, 5082.593392528607, 5088.567471764904, 5089.491050894918, 5051.6716413433005, 5056.898862022757, 5140.820071297505, 5445.727713614323, 5487.341519017724, 5391.32608423947, 5426.75579598919, 5435.347758268994, 5436.2661040759585, 5442.102053161224, 4677.391939047936, 4954.3063971044085, 4979.900401991976, 5047.924281135786, 5266.578673706133, 12148.514059437612, 12194.75610487794, 12371.566995155126, 14658.926705366512, 20096.899515502475, 1704.4460550321196, 1704.81247062823, 1822.6081392500676, 1887.3299978507707, 2070.8343332533514, 9312.72061838146, 9506.47714375709, 9758.072983066597, 9778.266630002778, 11220.607278745287, 1701.6681747059329, 1745.293156271712, 1770.6281680847037, 1830.789459212181, 1847.8152184781413, 63924.0, 67854.0, 68386.31613683849, 68947.65526172337, 71138.64430677865, 9503.334766566273, 9546.474943878153, 9808.409206752225, 9892.0, 10009.249306302056, 13485.190888546718, 13501.66245843842, 13504.729905401837, 13512.324383780771, 13544.119632223874, 7241.312075352833, 7350.5957172354965, 7418.33235008841, 7600.923990760021, 7646.4265180111715, 6770.119884414995, 6841.760538381132, 7025.2272250053475, 7298.416126709851, 7516.624168791539, 4041.939370909439, 4077.1641813428178, 4123.154753275571, 4201.894952626209, 4396.07682386696, 1666.9081751452575, 1690.8816382853083, 1695.313398073782, 1709.3077303692025, 1710.1363811275226, 780.30163004111, 823.5635113389912, 823.6622984576295, 835.7200337886876, 898.7618281155499, 16380.672386552202, 16767.496975090766, 17257.223424945907, 17711.645767084585, 17740.11299435023, 852.7399143261241, 855.683397143061, 866.913308669128, 871.9710741325297, 893.6916763716507, 9157.221636160868, 9492.098250666175, 9603.087706667855, 9638.614455421844, 9764.365316254421, 345422.0, 366742.0, 367519.6496070117, 367827.0, 367994.0, 72125.0, 73808.0, 74030.0, 74735.0, 76566.0, 882.2765332427348, 882.4749274181852, 886.0696268917611, 891.0332289465872, 895.2971917045219, 13969.511067112602, 14860.479883204036, 15364.231788410758, 15486.225688715744, 15488.845111549192, 35316.64683353133, 35541.0, 36014.45978310275, 36177.819110904275, 36624.08439789026, 48974.755126225566, 49102.0, 49719.0, 50601.49398505968, 50876.491235087175, 7500.9249907500225, 7580.317771400601, 7711.537307761552, 7974.16271291506, 8094.352451803959, 11040.0, 11983.0, 12046.638600841989, 12098.516059357527, 12225.510979560719, 10271.383716977005, 10294.845577316497, 10597.89402105969, 10831.566737330419, 10879.673609791718, 10065.496725163566, 10098.444585547571, 10158.13655839262, 10398.584056637952, 10539.736506587089, 10223.437710925673, 10334.431606261427, 10395.076910771531, 10455.477226138815, 11202.327860328407, 7629.351505122127, 7801.29788319054, 7926.682932682628, 7991.640376183202, 8311.83376332458, 9636.325457217927, 10006.499675016075, 10024.0, 10575.101116405192, 11082.778344433227], "value": 8009.981340599725, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1217.7807994560976, 1321.6894029902974, 1362.1894972491368, 1418.8864890808736, 1701.5150682055616, 6688.498362622804, 7448.888266675997, 7652.732154374591, 7698.191689872567, 7936.642851071701, 7676.232376762321, 7729.961350193241, 7745.0, 7745.225477452252, 7747.806304842382, 2116.566103948691, 2129.4037669452578, 2133.7119488868957, 2136.7970042845905, 2137.0596937347595, 2147.9248226312084, 2162.513434477246, 2163.1996161420298, 2165.66432203008, 2195.2316689158747, 2153.5692861427697, 2172.5872084303933, 2182.8581142225703, 2184.3446965910243, 2221.1559607349263, 2122.2466024561213, 2136.9252076177413, 2139.9786002140013, 2142.582196471689, 2147.6885851551515, 2023.433438637184, 2046.8771873687626, 2050.241410678044, 2052.035543294649, 2070.958580828375, 7665.846683066363, 7729.381649468085, 7758.224177582253, 7758.922410775876, 7769.1842356552315, 4412.426384569985, 4584.977075114636, 4585.358049873021, 4635.7218566886095, 4636.235021221494, 2694.380292532709, 2819.1965289892487, 2864.613277207571, 2876.8993085241914, 2881.3228891210547, 896.2202883491339, 906.9138431848963, 917.0874979395544, 934.4813628436283, 949.7008442340641, 10283.640072597424, 10359.171266298677, 10372.222083343704, 10374.792504149875, 10374.948125259401, 3726.7763934164036, 3870.3033453978555, 3874.3413619684156, 4057.14799892026, 4078.408630748525, 8097.311728503143, 8102.432829701865, 8103.189681031968, 8109.43233973628, 8110.3511719062335, 4438.312061630452, 4443.466783985942, 4443.933340999887, 4446.444194475691, 4448.866534003985, 3667.94498082529, 3737.9439308410397, 3786.848526058927, 4132.855350062733, 4146.896327591774, 3262.8042317461027, 3265.346930613887, 3407.6421975692197, 3449.6377880322707, 3478.0261526772542, 980.6812785844629, 982.0228872271992, 1000.4997501249376, 1000.9199264058858, 1003.4481035430484, 604.727872457396, 776.3672606825533, 799.3325573146487, 806.9152738962442, 815.2988429950238, 4710.905781884343, 4761.642876784185, 4838.564529192389, 5013.799448022111, 5140.820071297487, 808.874624433202, 831.4678605692362, 834.2450082675189, 857.4041041476114, 881.828043531518, 3135.764817638686, 3237.174520497258, 3273.1817045738567, 3296.2748195396975, 3386.255023894739, 9164.450132992042, 9487.620495180116, 9495.762605934908, 9501.809963800686, 9502.857457138149, 9369.625214991323, 9453.858192127123, 9458.385204961656, 9464.337496375188, 9485.05149485046, 6798.2182049064, 6901.378875901193, 7133.500654954103, 7137.2149063602965, 7234.782956511208, 4971.130052240771, 5042.546170844642, 5046.949530504795, 5062.215356619729, 5251.868703282448, 8132.430729848854, 8431.831363372821, 8515.48907065578, 8591.097934716765, 8598.398112132341, 8644.351673624378, 8657.523836188819, 8724.302055835646, 8820.823583528165, 8842.911570884466, 5955.851103722268, 6160.691965401622, 6518.185226846645, 6640.501962352746, 6642.900356494753, 6953.826154346182, 7044.894326585208, 7154.642267886481, 7233.1681856587165, 7276.672549735169, 6295.464885484602, 6416.711247993758, 6423.743050277936, 6558.376954189344, 6579.572327798678, 6511.609303441809, 6547.214334279917, 6690.665466726741, 6725.29384414649, 6729.697163627747, 6132.5400594956445, 6233.844153896189, 6233.968830156002, 6235.345288744798, 6240.438360547572, 4251.744895306291, 4272.46594175728, 4273.273543497551, 4366.2577361847925, 4447.599716025444, 4249.235137675249, 4306.461692288464, 4358.193734159191, 4382.693211475166, 4466.2407390743], "value": 3966.0508726228577, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.10679805214545, 287.8114834783215, 289.47171412172776, 290.1947096806362, 295.20589613938506, 4827.8310259140935, 4858.5141485851445, 4891.730954797489, 4895.583875370593, 4898.142825005619, 4845.806167753286, 4849.199882019462, 4854.441739199993, 4856.247281671346, 4862.781174847131, 3565.197830488139, 3693.7045036397158, 3696.1129328961124, 3780.3573392523335, 3782.300274449222, 3805.809709514527, 3808.1431677872397, 3822.8279727412196, 3826.1582451860686, 3830.387138057911, 3779.0930176757656, 3779.4519794629764, 3779.489768881207, 3782.3759079751944, 3787.0721673190105, 3596.17288023756, 3696.815159242027, 3700.9814950925343, 3754.3429899767702, 3791.393377059671, 3281.6554261802407, 3298.802071875695, 3319.5559931429666, 3324.8503817328037, 3335.5997280326274, 4740.0, 4741.728207536823, 4757.500462451428, 4765.189917713962, 4774.686961085695, 4227.704060715751, 4344.652427805768, 4351.8694439166875, 4363.694541382105, 4367.475902891641, 5067.670601410897, 5073.416557095944, 5076.471852062818, 5086.440491545927, 5092.770825312869, 3641.2171383152486, 3647.9785660015236, 3658.8536458541626, 3664.2671465706967, 3678.4850120983083, 5115.488451154929, 5305.628605997582, 5339.946600534023, 5362.731863406814, 5363.678179309254, 3751.40565259769, 3783.5838057813617, 3786.992893766308, 3790.2608991246993, 3793.7154713396053, 3840.7695538267794, 3842.7310088293552, 3844.826982785781, 3854.9206222257812, 3894.201688653819, 4381.759003254851, 4385.583369579885, 4387.319965405367, 4388.626966707801, 4390.143921935256, 4858.902821943541, 5052.873678158076, 5096.031753966735, 5197.324347834758, 5202.297689811902, 1321.5308565459125, 1322.4989636762152, 1325.1651459580403, 1328.3225554967037, 1328.6479083043002, 830.9820469924294, 860.9526476043877, 867.1935100356603, 870.8606622940299, 875.7985663297477, 4339.370791235253, 4374.300111982067, 4457.710248833815, 4542.31865220213, 4543.159515489645, 5319.0, 5320.201969704575, 5321.627486075938, 5327.3074500314715, 5327.520523152934, 4323.221820072417, 4530.116627257653, 4530.954690453119, 4542.227821270392, 4543.568361005699, 2534.4931013797313, 2766.7509924106926, 2794.3293609533566, 2799.566067259578, 2806.3825958289144, 4886.511348865085, 4891.3396691446915, 4900.681455705368, 4902.0, 4940.802367905316, 5152.969406118791, 5362.766563690295, 5401.756920938567, 5402.460843403594, 5429.864253393696, 4951.0, 4958.611588755154, 4965.3048573199785, 4966.751662416865, 4977.183328085295, 5259.0, 5270.578353731769, 5271.84184474451, 5292.788288468418, 5324.307839980777, 4926.901461970669, 5181.248718935809, 5185.42960274377, 5207.661502002357, 5209.4530074343165, 4946.851594452172, 4954.355933728592, 4976.726280054631, 4983.202687569971, 4996.625253105959, 3640.981795091114, 3644.21649345392, 3644.362236608636, 3664.3953747631344, 3673.540807399075, 5227.764750586157, 5327.840164795062, 5359.7672535316315, 5382.4886635769535, 5384.730763461889, 5134.871628209325, 5163.8192663256605, 5175.308839403414, 5182.2898443514305, 5183.611229157904, 5136.0, 5145.176771716508, 5172.836111874798, 5188.457655748581, 5225.372955245243, 4953.653244272867, 5078.136716758087, 5092.770825312944, 5102.4897510248675, 5107.795688172431, 4905.23968784839, 5152.407473140487, 5157.948420515897, 5162.174052151638, 5181.740912954413, 4842.7820748065715, 4888.755562221946, 5013.849584512471, 5023.246513022929, 5111.642185047011], "value": 3847.8685238665867, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.2838902010916, 563.3465180390742, 585.9882802343953, 638.9201349831272, 654.4927681047188, 12786.296753678544, 13918.930405347985, 13943.372548235317, 13969.371378287977, 14328.641783955407, 13982.790258146137, 14551.781723274133, 14557.78163327551, 14558.781618275709, 14575.708485830277, 629.8771739510797, 780.9297163255305, 804.3565147881701, 806.5362416610473, 806.899137607799, 648.1638686094932, 746.8058304840727, 764.8699721047435, 778.0624347661055, 779.0184367696686, 836.8326334733077, 836.9163083691612, 839.412411312081, 844.8943882014748, 845.4377838737232, 646.896496560548, 839.0099682374795, 839.3033781960958, 839.6767244610808, 839.7942504086508, 489.33939182103876, 584.042170839823, 600.5015836855399, 600.5075837812996, 603.1465476350958, 13219.73560528784, 13245.47018119274, 13249.403776830066, 13257.270850103241, 13269.203847769164, 11852.0, 12130.757384852343, 12209.328486933215, 12460.563880264148, 13153.73692526144, 11388.54445822166, 11665.941670291595, 11815.409229538489, 11855.04391775356, 12287.754244915051, 4043.9191216175805, 4052.3516237401873, 4115.938260926088, 4209.494860616745, 4268.743875367488, 64676.0, 67720.66139669319, 67770.0, 67783.66108169477, 67889.5321514628, 10086.0, 10308.793824123475, 10683.732906677395, 10733.195010374253, 10953.123750099972, 18300.542486437946, 18615.25538978453, 18696.53258668517, 18710.81289187118, 18732.719009214874, 6541.411272985454, 6687.0, 6709.463242940553, 6758.127795686813, 6779.796606101825, 2924.941501169965, 2968.168912704446, 2992.1023692892045, 2992.4314380268115, 3041.604591403148, 2837.4325134973087, 2922.693117222661, 2936.559516072606, 2937.3097322129283, 2939.4415061138316, 490.75952783136006, 493.83950216179886, 501.55361728062053, 504.271327931136, 505.7016360347413, 523.8009556368631, 545.4245770711858, 547.1464515356057, 553.1426289251724, 563.2874413866463, 7432.0, 7747.806304842311, 7778.64996075178, 8130.105688374274, 8136.34909207262, 506.6478797235886, 517.8757098296458, 553.3636318234063, 582.8047604052605, 583.7081459270365, 3669.7520759546373, 3785.5268091488565, 3905.9609403906165, 3909.7684428679627, 3912.921741565153, 59108.40891591029, 59299.70350148222, 59321.0, 59824.0, 94315.0, 87965.0, 88748.5562572183, 88762.55618721995, 89596.0, 91319.54340228256, 43169.489067882474, 62760.68619656964, 63703.6814815923, 64442.99999999906, 65550.0, 8405.117462666332, 8861.468311901306, 8873.0, 9109.316801239802, 9285.535723213947, 30289.697103028688, 38664.6133538661, 42231.577684223994, 42403.363949540166, 42986.0, 40945.79527102345, 41027.0, 44980.77509612431, 48227.276590850466, 60909.69545152246, 10824.567017319534, 10830.566777329133, 11085.0, 11295.322280663186, 11480.712982175512, 12804.61586152417, 13525.661858453617, 13625.523106691218, 14121.576352709435, 14520.636984075483, 12304.630861074182, 12346.259224446561, 12445.0, 12812.0, 13177.670558235737, 11381.943090284496, 11627.941860290644, 11748.88251117478, 11820.645380638594, 12488.313142776871, 11182.776344473228, 11766.529338826693, 11906.821397678868, 12064.45709943037, 12336.444859981502, 10076.748081298027, 10592.205584581034, 10600.840987385349, 10983.780324393307, 11587.5944341951, 10374.858765535935, 10861.0, 10880.0, 10910.94544527304, 10929.508172132115], "value": 6445.072946664349, "unit": "score"}], "name": "dromaeo_css", "value": 6249.476023295337, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 114.0, 112.0, 115.0, 114.0, 113.0, 113.0, 115.0, 114.0, 113.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 127.0, 129.0, 176.0, 134.0, 129.0, 131.0, 130.0, 165.0, 130.0], "value": 140.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 164.0, 164.0, 162.0, 161.0, 161.0, 163.0, 163.0, 161.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 107.0, 78.0, 78.0, 77.0, 77.0, 100.0, 77.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 82.0, 115.0, 83.0, 84.0, 83.0, 117.0, 84.0, 83.0, 116.0], "value": 93.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 118.0, 116.0, 118.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 64.0, 65.0, 65.0, 65.0, 66.0, 67.0, 66.0, 65.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 66.0, 67.0, 66.0, 65.0, 66.0, 67.0, 65.0, 67.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 87.0, 83.0, 83.0, 83.0, 92.0, 84.0, 83.0, 83.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 143.0, 153.0, 143.0, 148.0, 151.0, 140.0, 138.0, 179.0, 152.0], "value": 149.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 179.0, 176.0, 175.0, 176.0, 177.0, 179.0, 179.0, 177.0, 173.0], "value": 176.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 70.0, 75.0, 71.0, 74.0, 75.0, 70.0, 70.0, 72.0], "value": 71.8, "unit": "score"}], "name": "kraken", "value": 1564.9999999999998, "alertThreshold": 2.0}]} 00:23:44 INFO - Return code: 0 00:23:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:23:44 INFO - # TBPL SUCCESS # 00:23:44 INFO - Running post-action listener: _resource_record_post_action 00:23:44 INFO - [mozharness: 2016-10-04 07:23:44.067668Z] Finished run-tests step (success) 00:23:44 INFO - Running post-run listener: _resource_record_post_run 00:23:44 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 0; Write bytes: 393928704; Read time: 0; Write time: 245904 00:23:44 INFO - TinderboxPrint: CPU usage
13.0% 00:23:44 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 00:23:44 INFO - TinderboxPrint: I/O write bytes / time
393,928,704 / 245,904 00:23:44 INFO - TinderboxPrint: CPU idle
8,349.7 (87.0%) 00:23:44 INFO - TinderboxPrint: CPU user
1,202.0 (12.5%) 00:23:44 INFO - TinderboxPrint: Swap in / out
0 / 0 00:23:44 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99803136; Read time: 0; Write time: 67992 00:23:44 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 294125568; Read time: 0; Write time: 177912 00:23:44 INFO - Running post-run listener: _upload_blobber_files 00:23:44 INFO - Blob upload gear active. 00:23:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:23:44 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 00:23:44 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:23:44 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:23:45 INFO - (blobuploader) - INFO - Open directory for files ... 00:23:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:23:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:23:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:23:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:23:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:23:45 INFO - (blobuploader) - INFO - Done attempting. 00:23:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:23:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:23:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:23:49 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:23:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:23:49 INFO - (blobuploader) - INFO - Done attempting. 00:23:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:23:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:23:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:23:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:23:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:23:50 INFO - (blobuploader) - INFO - Done attempting. 00:23:50 INFO - (blobuploader) - INFO - Iteration through files over. 00:23:50 INFO - Return code: 0 00:23:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:23:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:23:50 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/22420a992f49b1078295b8c0862aeb731f05a3775639d5c95573871b74f20466479f12bc83d6f869a7fc0b81beb4bdd8084ec8c66063a5b147b64ff57a874b7f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4c9815472842a0f7a2b754bc5f322d840305727124525f3fd0f696b22f3ae45b06ce807550fb807176896b5571525d2736a65a13f2c4dfd7c89127d26e87c2a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/23392c8475b84f3b9d941d17754acfba465b891e7cd2546be42e0c5135be728015d92d5648c6d8084f08f0fef9beaba073b3588bc11318f7575d40eaaa6fd650"} 00:23:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:23:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:23:50 INFO - Contents: 00:23:50 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/22420a992f49b1078295b8c0862aeb731f05a3775639d5c95573871b74f20466479f12bc83d6f869a7fc0b81beb4bdd8084ec8c66063a5b147b64ff57a874b7f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4c9815472842a0f7a2b754bc5f322d840305727124525f3fd0f696b22f3ae45b06ce807550fb807176896b5571525d2736a65a13f2c4dfd7c89127d26e87c2a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/23392c8475b84f3b9d941d17754acfba465b891e7cd2546be42e0c5135be728015d92d5648c6d8084f08f0fef9beaba073b3588bc11318f7575d40eaaa6fd650"} 00:23:50 INFO - Running post-run listener: copy_logs_to_upload_dir 00:23:50 INFO - Copying logs to upload dir... 00:23:50 INFO - mkdir: /builds/slave/test/build/upload/logs 00:23:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.689739 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-04 00:23:50.673761) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 00:23:50.677148) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1475564579.253171-1129471075 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/22420a992f49b1078295b8c0862aeb731f05a3775639d5c95573871b74f20466479f12bc83d6f869a7fc0b81beb4bdd8084ec8c66063a5b147b64ff57a874b7f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4c9815472842a0f7a2b754bc5f322d840305727124525f3fd0f696b22f3ae45b06ce807550fb807176896b5571525d2736a65a13f2c4dfd7c89127d26e87c2a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/23392c8475b84f3b9d941d17754acfba465b891e7cd2546be42e0c5135be728015d92d5648c6d8084f08f0fef9beaba073b3588bc11318f7575d40eaaa6fd650"} build_url:https://queue.taskcluster.net/v1/task/YVHYTHQ4T8aCh3JJo_CxFQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011229 build_url: 'https://queue.taskcluster.net/v1/task/YVHYTHQ4T8aCh3JJo_CxFQ/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/Autoland-Non-PGO/sha512/22420a992f49b1078295b8c0862aeb731f05a3775639d5c95573871b74f20466479f12bc83d6f869a7fc0b81beb4bdd8084ec8c66063a5b147b64ff57a874b7f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4c9815472842a0f7a2b754bc5f322d840305727124525f3fd0f696b22f3ae45b06ce807550fb807176896b5571525d2736a65a13f2c4dfd7c89127d26e87c2a8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/23392c8475b84f3b9d941d17754acfba465b891e7cd2546be42e0c5135be728015d92d5648c6d8084f08f0fef9beaba073b3588bc11318f7575d40eaaa6fd650"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 00:23:50.703471) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 00:23:50.703863) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1475564579.253171-1129471075 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004416 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 00:23:50.787127) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 00:23:50.787493) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 00:23:50.787863) ========= ========= Total master_lag: 0.17 =========