builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-040 starttime: 1475241273.84 results: success (0) buildid: 20160930033007 builduid: 802ac2eeb13e454181fb627f5e8bb170 revision: 3040be42dde9169f98248ede39d3e7b7619e774a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 06:14:33.835570) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-30 06:14:33.836038) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 06:14:33.836341) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-30 06:14:33.892608) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 06:14:33.893006) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1475241128.942430-341232885 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-30 06:14:34-- 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% 42.6M=0s 2016-09-30 06:14:34 (42.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.084398 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 06:14:33.991820) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 06:14:33.992135) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1475241128.942430-341232885 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016084 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 06:14:34.042356) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-30 06:14:34.042800) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 3040be42dde9169f98248ede39d3e7b7619e774a --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 3040be42dde9169f98248ede39d3e7b7619e774a --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=9e0dfe3369c33a1556e63f89000001d8-1475241128.942430-341232885 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-30 06:14:34,324 truncating revision to first 12 chars 2016-09-30 06:14:34,324 Setting DEBUG logging. 2016-09-30 06:14:34,325 attempt 1/10 2016-09-30 06:14:34,325 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/3040be42dde9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-30 06:14:35,451 unpacking tar archive at: autoland-3040be42dde9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.501329 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-30 06:14:35.557827) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 06:14:35.558196) ========= script_repo_revision: 3040be42dde9169f98248ede39d3e7b7619e774a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-30 06:14:35.558602) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 06:14:35.558869) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-30 06:14:35.568789) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-09-30 06:14:35.569181) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=9e0dfe3369c33a1556e63f89000001d8-1475241128.942430-341232885 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:14:35 INFO - MultiFileLogger online at 20160930 06:14:35 in /builds/slave/test 06:14:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 06:14:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:14:35 INFO - {'append_to_log': False, 06:14:35 INFO - 'base_work_dir': '/builds/slave/test', 06:14:35 INFO - 'blob_upload_branch': 'Autoland', 06:14:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:14:35 INFO - 'branch': 'Autoland', 06:14:35 INFO - 'buildbot_json_path': 'buildprops.json', 06:14:35 INFO - 'config_files': ('talos/linux_config.py',), 06:14:35 INFO - 'default_actions': ('clobber', 06:14:35 INFO - 'read-buildbot-config', 06:14:35 INFO - 'download-and-extract', 06:14:35 INFO - 'populate-webroot', 06:14:35 INFO - 'create-virtualenv', 06:14:35 INFO - 'install', 06:14:35 INFO - 'run-tests'), 06:14:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:14:35 INFO - 'download_minidump_stackwalk': True, 06:14:35 INFO - 'download_symbols': 'ondemand', 06:14:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:14:35 INFO - 'tooltool.py': '/tools/tooltool.py', 06:14:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:14:35 INFO - '/tools/misc-python/virtualenv.py')}, 06:14:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:14:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:14:35 INFO - 'installer_path': 'installer.exe', 06:14:35 INFO - 'log_level': 'info', 06:14:35 INFO - 'log_name': 'talos', 06:14:35 INFO - 'log_to_console': True, 06:14:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:14:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:14:35 INFO - 'opt_config_files': (), 06:14:35 INFO - 'pip_index': False, 06:14:35 INFO - 'sps_profile': False, 06:14:35 INFO - 'sps_profile_interval': 0, 06:14:35 INFO - 'suite': 'dromaeojs', 06:14:35 INFO - 'system_bits': '32', 06:14:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:14:35 INFO - 'title': 'talos-linux64-ix-040', 06:14:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:14:35 INFO - 'use_talos_json': True, 06:14:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:14:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:14:35 INFO - 'work_dir': 'build'} 06:14:35 INFO - [mozharness: 2016-09-30 13:14:35.948238Z] Running clobber step. 06:14:35 INFO - Running pre-action listener: _resource_record_pre_action 06:14:35 INFO - Running main action method: clobber 06:14:35 INFO - rmtree: /builds/slave/test/build 06:14:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:14:36 INFO - Running post-action listener: _resource_record_post_action 06:14:36 INFO - [mozharness: 2016-09-30 13:14:36.939037Z] Finished clobber step (success) 06:14:36 INFO - [mozharness: 2016-09-30 13:14:36.939139Z] Running read-buildbot-config step. 06:14:36 INFO - Running pre-action listener: _resource_record_pre_action 06:14:36 INFO - Running main action method: read_buildbot_config 06:14:36 INFO - Using buildbot properties: 06:14:36 INFO - { 06:14:36 INFO - "project": "", 06:14:36 INFO - "product": "firefox", 06:14:36 INFO - "script_repo_revision": "production", 06:14:36 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 06:14:36 INFO - "repository": "", 06:14:36 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 06:14:36 INFO - "buildid": "20160930033007", 06:14:36 INFO - "pgo_build": "True", 06:14:36 INFO - "basedir": "/builds/slave/test", 06:14:36 INFO - "buildnumber": 293, 06:14:36 INFO - "slavename": "talos-linux64-ix-040", 06:14:36 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:14:36 INFO - "platform": "ubuntu64_hw", 06:14:36 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 06:14:36 INFO - "branch": "autoland", 06:14:36 INFO - "repo_path": "integration/autoland", 06:14:36 INFO - "revision": "3040be42dde9169f98248ede39d3e7b7619e774a", 06:14:36 INFO - "stage_platform": "linux64-pgo", 06:14:36 INFO - "builduid": "802ac2eeb13e454181fb627f5e8bb170", 06:14:36 INFO - "slavebuilddir": "test" 06:14:36 INFO - } 06:14:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/X44qMvJtRFGIVR4EX4YObA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 06:14:36 INFO - Running post-action listener: _resource_record_post_action 06:14:36 INFO - [mozharness: 2016-09-30 13:14:36.941580Z] Finished read-buildbot-config step (success) 06:14:36 INFO - [mozharness: 2016-09-30 13:14:36.941668Z] Running download-and-extract step. 06:14:36 INFO - Running pre-action listener: _resource_record_pre_action 06:14:36 INFO - Running main action method: download_and_extract 06:14:36 INFO - mkdir: /builds/slave/test/build/tests 06:14: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')]} 06:14:36 INFO - trying https://queue.taskcluster.net/v1/task/X44qMvJtRFGIVR4EX4YObA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:14:36 INFO - Downloading https://queue.taskcluster.net/v1/task/X44qMvJtRFGIVR4EX4YObA/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 06:14:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X44qMvJtRFGIVR4EX4YObA/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 06:14:37 INFO - Downloaded 1361 bytes. 06:14:37 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:14:37 INFO - Using the following test package requirements: 06:14:37 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:14:37 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:37 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:14:37 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:37 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:14:37 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:37 INFO - u'jsshell-linux-x86_64.zip'], 06:14:37 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:37 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:14:37 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:14:37 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:37 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:14:37 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:37 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:14:37 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:37 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:14:37 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:14:37 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:14:37 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:14:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X44qMvJtRFGIVR4EX4YObA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:14:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X44qMvJtRFGIVR4EX4YObA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:14:37 INFO - Fetch https://queue.taskcluster.net/v1/task/X44qMvJtRFGIVR4EX4YObA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:14:38 INFO - Http code: 200 06:14:38 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 06:14:38 INFO - x-amz-cf-id: 5MeMueVxpVBZk4rPCGHj0blG7rVpvBBMOmHWh0mSvUhWCYMqyOjZ7A== 06:14:38 INFO - x-amz-version-id: 0C23mNamTioS8LW5JlhU79y_bHX.qJ_c 06:14:38 INFO - Expected file size: 21989306 06:14:38 INFO - Obtained file size: 21989306 06:14:42 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 06:14:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X44qMvJtRFGIVR4EX4YObA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:14:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X44qMvJtRFGIVR4EX4YObA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:14:42 INFO - Fetch https://queue.taskcluster.net/v1/task/X44qMvJtRFGIVR4EX4YObA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:14:43 INFO - Http code: 200 06:14:43 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 06:14:43 INFO - x-amz-cf-id: y7WZVMgpAd1-Dcj69DcaE__wq4Gpdj-ZAlxTRG_w_8k1bn7ZkPRTtQ== 06:14:43 INFO - x-amz-version-id: 0C23mNamTioS8LW5JlhU79y_bHX.qJ_c 06:14:43 INFO - Expected file size: 21989306 06:14:43 INFO - Obtained file size: 21989306 06:14:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X44qMvJtRFGIVR4EX4YObA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 06:14:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X44qMvJtRFGIVR4EX4YObA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:14:47 INFO - Fetch https://queue.taskcluster.net/v1/task/X44qMvJtRFGIVR4EX4YObA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:14:48 INFO - Http code: 200 06:14:48 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 06:14:48 INFO - x-amz-cf-id: vzAUxhUn9eExfTY95luxdnyf8a6jfoTONM_gXiWiUJKvrb1ODFRIJg== 06:14:48 INFO - x-amz-version-id: _Ppg680.MvTehbQDo4UoUCX2PwTRR0F_ 06:14:49 INFO - Expected file size: 14408522 06:14:49 INFO - Obtained file size: 14408522 06:14:49 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')]} 06:14:49 INFO - trying https://queue.taskcluster.net/v1/task/X44qMvJtRFGIVR4EX4YObA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:14:49 INFO - Downloading https://queue.taskcluster.net/v1/task/X44qMvJtRFGIVR4EX4YObA/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 06:14:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X44qMvJtRFGIVR4EX4YObA/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 06:14:51 INFO - Downloaded 59708331 bytes. 06:14:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X44qMvJtRFGIVR4EX4YObA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:14:51 INFO - mkdir: /builds/slave/test/properties 06:14:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:14:51 INFO - Writing to file /builds/slave/test/properties/build_url 06:14:51 INFO - Contents: 06:14:51 INFO - build_url:https://queue.taskcluster.net/v1/task/X44qMvJtRFGIVR4EX4YObA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:14:52 INFO - Running post-action listener: _resource_record_post_action 06:14:52 INFO - Running post-action listener: set_extra_try_arguments 06:14:52 INFO - [mozharness: 2016-09-30 13:14:52.376995Z] Finished download-and-extract step (success) 06:14:52 INFO - [mozharness: 2016-09-30 13:14:52.377221Z] Running populate-webroot step. 06:14:52 INFO - Running pre-action listener: _resource_record_pre_action 06:14:52 INFO - Running main action method: populate_webroot 06:14:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:14:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:14:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:14:52 INFO - '--tppagecycles', 06:14:52 INFO - '7'], 06:14:52 INFO - 'tests': ['tsvgm']}}, 06:14:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:14:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:14:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:14:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:14:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:14:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:14:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:52 INFO - 'talos_options': ['--disable-e10s'], 06:14:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:14:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:14:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:52 INFO - 'talos_options': ['--disable-e10s'], 06:14:52 INFO - 'tests': ['damp', 'tps']}, 06:14:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:52 INFO - 'tests': ['damp', 'tps']}, 06:14:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:14:52 INFO - 'tests': ['dromaeo_dom']}, 06:14:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:14:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:14:52 INFO - 'tests': ['basic_compositor_video']}, 06:14:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:14:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:14:52 INFO - 'tests': ['a11yr', 06:14:52 INFO - 'ts_paint', 06:14:52 INFO - 'tpaint', 06:14:52 INFO - 'sessionrestore', 06:14:52 INFO - 'sessionrestore_no_auto_restore', 06:14:52 INFO - 'tabpaint']}, 06:14:52 INFO - 'other-e10s': {'tests': ['a11yr', 06:14:52 INFO - 'ts_paint', 06:14:52 INFO - 'tpaint', 06:14:52 INFO - 'sessionrestore', 06:14:52 INFO - 'sessionrestore_no_auto_restore', 06:14:52 INFO - 'tabpaint']}, 06:14:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:14:52 INFO - 'ts_paint', 06:14:52 INFO - 'tpaint', 06:14:52 INFO - 'sessionrestore', 06:14:52 INFO - 'sessionrestore_no_auto_restore', 06:14:52 INFO - 'tabpaint']}, 06:14:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:14:52 INFO - 'ts_paint', 06:14:52 INFO - 'tpaint', 06:14:52 INFO - 'sessionrestore', 06:14:52 INFO - 'sessionrestore_no_auto_restore', 06:14:52 INFO - 'tabpaint']}, 06:14:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:14:52 INFO - 'tests': ['a11yr', 06:14:52 INFO - 'ts_paint', 06:14:52 INFO - 'tpaint', 06:14:52 INFO - 'sessionrestore', 06:14:52 INFO - 'sessionrestore_no_auto_restore', 06:14:52 INFO - 'tabpaint']}, 06:14:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:14:52 INFO - 'tests': ['a11yr', 06:14:52 INFO - 'ts_paint', 06:14:52 INFO - 'tpaint', 06:14:52 INFO - 'sessionrestore', 06:14:52 INFO - 'sessionrestore_no_auto_restore', 06:14:52 INFO - 'tabpaint']}, 06:14:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:14:52 INFO - 'tests': ['tsvgx', 06:14:52 INFO - 'tsvgr_opacity', 06:14:52 INFO - 'tart', 06:14:52 INFO - 'tscrollx', 06:14:52 INFO - 'cart']}, 06:14:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:14:52 INFO - 'tsvgr_opacity', 06:14:52 INFO - 'tart', 06:14:52 INFO - 'tscrollx', 06:14:52 INFO - 'cart']}, 06:14:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:52 INFO - 'talos_options': ['--disable-e10s'], 06:14:52 INFO - 'tests': ['tp5o']}, 06:14:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:52 INFO - 'tests': ['tp5o']}, 06:14:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:52 INFO - 'talos_options': ['--disable-e10s', 06:14:52 INFO - '--xperf_path', 06:14:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:14:52 INFO - 'tests': ['tp5n']}, 06:14:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:14:52 INFO - 'talos_options': ['--xperf_path', 06:14:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:14:52 INFO - 'tests': ['tp5n']}}, 06:14:52 INFO - 'talos.zip': {'path': '', 06:14:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:14:52 INFO - Running post-action listener: _resource_record_post_action 06:14:52 INFO - [mozharness: 2016-09-30 13:14:52.394768Z] Finished populate-webroot step (success) 06:14:52 INFO - [mozharness: 2016-09-30 13:14:52.394857Z] Running create-virtualenv step. 06:14:52 INFO - Running pre-action listener: _resource_record_pre_action 06:14:52 INFO - Running main action method: create_virtualenv 06:14:52 INFO - Creating virtualenv /builds/slave/test/build/venv 06:14:52 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 06:14:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:14:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:14:52 INFO - Using real prefix '/usr' 06:14:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:14:53 INFO - Installing distribute.............................................................................................................................................................................................done. 06:14:54 INFO - Installing pip.................done. 06:14:54 INFO - Return code: 0 06:14:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:14:55 INFO - Reading from file tmpfile_stdout 06:14:55 INFO - Output received: 06:14:55 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) 06:14:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:55 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 0x7f8fa4223f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290d7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299c790>, '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 0x299d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299db20>, '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': '9e0dfe3369c33a1556e63f89000001d8-1475241128.942430-341232885', '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 06:14:55 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 06:14:55 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 06:14:55 INFO - Using env: {'DISPLAY': ':0', 06:14:55 INFO - 'HOME': '/home/cltbld', 06:14:55 INFO - 'LANG': 'en_US.UTF-8', 06:14:55 INFO - 'LANGUAGE': 'en_US:en', 06:14:55 INFO - 'LOGNAME': 'cltbld', 06:14:55 INFO - 'MAIL': '/var/mail/cltbld', 06:14:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:55 INFO - 'MOZ_NO_REMOTE': '1', 06:14:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:55 INFO - 'NO_EM_RESTART': '1', 06:14:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:55 INFO - 'PWD': '/builds/slave/test', 06:14:55 INFO - 'SHELL': '/bin/bash', 06:14:55 INFO - 'SHLVL': '1', 06:14:55 INFO - 'TERM': 'linux', 06:14:55 INFO - 'TMOUT': '86400', 06:14:55 INFO - 'USER': 'cltbld', 06:14:55 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1475241128.942430-341232885', 06:14:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:55 INFO - '_': '/tools/buildbot/bin/python'} 06:14:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:55 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 06:14:55 INFO - Cleaning up... 06:14:55 INFO - Return code: 0 06:14:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:14:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:55 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 0x7f8fa4223f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290d7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299c790>, '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 0x299d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299db20>, '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': '9e0dfe3369c33a1556e63f89000001d8-1475241128.942430-341232885', '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 06:14:55 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 06:14:55 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 06:14:55 INFO - Using env: {'DISPLAY': ':0', 06:14:55 INFO - 'HOME': '/home/cltbld', 06:14:55 INFO - 'LANG': 'en_US.UTF-8', 06:14:55 INFO - 'LANGUAGE': 'en_US:en', 06:14:55 INFO - 'LOGNAME': 'cltbld', 06:14:55 INFO - 'MAIL': '/var/mail/cltbld', 06:14:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:55 INFO - 'MOZ_NO_REMOTE': '1', 06:14:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:55 INFO - 'NO_EM_RESTART': '1', 06:14:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:55 INFO - 'PWD': '/builds/slave/test', 06:14:55 INFO - 'SHELL': '/bin/bash', 06:14:55 INFO - 'SHLVL': '1', 06:14:55 INFO - 'TERM': 'linux', 06:14:55 INFO - 'TMOUT': '86400', 06:14:55 INFO - 'USER': 'cltbld', 06:14:55 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1475241128.942430-341232885', 06:14:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:55 INFO - '_': '/tools/buildbot/bin/python'} 06:14:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:55 INFO - Downloading/unpacking psutil>=3.1.1 06:14:55 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 06:14:55 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 06:14:55 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 06:14:55 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 06:14:55 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 06:14:55 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 06:14:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:14:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:14:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:14:57 INFO - Installing collected packages: psutil 06:14:57 INFO - Running setup.py install for psutil 06:14:57 INFO - building 'psutil._psutil_linux' extension 06:14:57 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 06:14:57 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 06:14:57 INFO - building 'psutil._psutil_posix' extension 06:14:57 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 06:14:58 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 06:14:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:14:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:14:58 INFO - Successfully installed psutil 06:14:58 INFO - Cleaning up... 06:14:58 INFO - Return code: 0 06:14:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:14:58 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')]} 06:14:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:14:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:58 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')]} 06:14:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:14:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:14:58 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 0x7f8fa4223f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290d7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299c790>, '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 0x299d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299db20>, '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': '9e0dfe3369c33a1556e63f89000001d8-1475241128.942430-341232885', '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 06:14:58 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 06:14:58 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 06:14:58 INFO - Using env: {'DISPLAY': ':0', 06:14:58 INFO - 'HOME': '/home/cltbld', 06:14:58 INFO - 'LANG': 'en_US.UTF-8', 06:14:58 INFO - 'LANGUAGE': 'en_US:en', 06:14:58 INFO - 'LOGNAME': 'cltbld', 06:14:58 INFO - 'MAIL': '/var/mail/cltbld', 06:14:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:14:58 INFO - 'MOZ_NO_REMOTE': '1', 06:14:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:14:58 INFO - 'NO_EM_RESTART': '1', 06:14:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:14:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:14:58 INFO - 'PWD': '/builds/slave/test', 06:14:58 INFO - 'SHELL': '/bin/bash', 06:14:58 INFO - 'SHLVL': '1', 06:14:58 INFO - 'TERM': 'linux', 06:14:58 INFO - 'TMOUT': '86400', 06:14:58 INFO - 'USER': 'cltbld', 06:14:58 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1475241128.942430-341232885', 06:14:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:14:58 INFO - '_': '/tools/buildbot/bin/python'} 06:14:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:14:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:14:58 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 06:14:58 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 06:14:58 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 06:14:58 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 06:14:58 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 06:14:58 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 06:15:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:15:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:15:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:15:00 INFO - Installing collected packages: mozsystemmonitor 06:15:00 INFO - Running setup.py install for mozsystemmonitor 06:15:00 INFO - Successfully installed mozsystemmonitor 06:15:00 INFO - Cleaning up... 06:15:00 INFO - Return code: 0 06:15:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:00 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 0x7f8fa4223f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290d7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299c790>, '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 0x299d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299db20>, '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': '9e0dfe3369c33a1556e63f89000001d8-1475241128.942430-341232885', '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 06:15:00 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 06:15:00 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 06:15:00 INFO - Using env: {'DISPLAY': ':0', 06:15:00 INFO - 'HOME': '/home/cltbld', 06:15:00 INFO - 'LANG': 'en_US.UTF-8', 06:15:00 INFO - 'LANGUAGE': 'en_US:en', 06:15:00 INFO - 'LOGNAME': 'cltbld', 06:15:00 INFO - 'MAIL': '/var/mail/cltbld', 06:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:00 INFO - 'MOZ_NO_REMOTE': '1', 06:15:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:00 INFO - 'NO_EM_RESTART': '1', 06:15:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:00 INFO - 'PWD': '/builds/slave/test', 06:15:00 INFO - 'SHELL': '/bin/bash', 06:15:00 INFO - 'SHLVL': '1', 06:15:00 INFO - 'TERM': 'linux', 06:15:00 INFO - 'TMOUT': '86400', 06:15:00 INFO - 'USER': 'cltbld', 06:15:00 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1475241128.942430-341232885', 06:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:00 INFO - '_': '/tools/buildbot/bin/python'} 06:15:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:00 INFO - Downloading/unpacking jsonschema==2.5.1 06:15:00 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 06:15:00 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 06:15:00 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 06:15:00 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 06:15:00 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 06:15:00 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 06:15:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:15:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:15:02 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 06:15:02 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 06:15:02 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 06:15:02 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 06:15:02 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 06:15:02 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 06:15:02 INFO - Downloading functools32-3.2.3-2.tar.gz 06:15:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:15:02 INFO - warning: no files found matching '*.txt' 06:15:02 INFO - no previously-included directories found matching 'build' 06:15:02 INFO - no previously-included directories found matching 'dist' 06:15:02 INFO - no previously-included directories found matching '.git*' 06:15:02 INFO - Installing collected packages: jsonschema, functools32 06:15:02 INFO - Running setup.py install for functools32 06:15:03 INFO - warning: no files found matching '*.txt' 06:15:03 INFO - no previously-included directories found matching 'build' 06:15:03 INFO - no previously-included directories found matching 'dist' 06:15:03 INFO - no previously-included directories found matching '.git*' 06:15:03 INFO - Successfully installed jsonschema functools32 06:15:03 INFO - Cleaning up... 06:15:03 INFO - Return code: 0 06:15:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:15:03 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')]} 06:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:03 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')]} 06:15:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:03 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 0x7f8fa4223f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290d7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299c790>, '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 0x299d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299db20>, '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': '9e0dfe3369c33a1556e63f89000001d8-1475241128.942430-341232885', '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 06:15:03 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 06:15:03 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 06:15:03 INFO - Using env: {'DISPLAY': ':0', 06:15:03 INFO - 'HOME': '/home/cltbld', 06:15:03 INFO - 'LANG': 'en_US.UTF-8', 06:15:03 INFO - 'LANGUAGE': 'en_US:en', 06:15:03 INFO - 'LOGNAME': 'cltbld', 06:15:03 INFO - 'MAIL': '/var/mail/cltbld', 06:15:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:03 INFO - 'MOZ_NO_REMOTE': '1', 06:15:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:03 INFO - 'NO_EM_RESTART': '1', 06:15:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:03 INFO - 'PWD': '/builds/slave/test', 06:15:03 INFO - 'SHELL': '/bin/bash', 06:15:03 INFO - 'SHLVL': '1', 06:15:03 INFO - 'TERM': 'linux', 06:15:03 INFO - 'TMOUT': '86400', 06:15:03 INFO - 'USER': 'cltbld', 06:15:03 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1475241128.942430-341232885', 06:15:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:03 INFO - '_': '/tools/buildbot/bin/python'} 06:15:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:15:03 INFO - Cleaning up... 06:15:03 INFO - Return code: 0 06:15:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:15:03 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')]} 06:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:03 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')]} 06:15:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:03 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 0x7f8fa4223f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290d7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299c790>, '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 0x299d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299db20>, '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': '9e0dfe3369c33a1556e63f89000001d8-1475241128.942430-341232885', '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 06:15:03 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 06:15:03 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 06:15:03 INFO - Using env: {'DISPLAY': ':0', 06:15:03 INFO - 'HOME': '/home/cltbld', 06:15:03 INFO - 'LANG': 'en_US.UTF-8', 06:15:03 INFO - 'LANGUAGE': 'en_US:en', 06:15:03 INFO - 'LOGNAME': 'cltbld', 06:15:03 INFO - 'MAIL': '/var/mail/cltbld', 06:15:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:03 INFO - 'MOZ_NO_REMOTE': '1', 06:15:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:03 INFO - 'NO_EM_RESTART': '1', 06:15:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:03 INFO - 'PWD': '/builds/slave/test', 06:15:03 INFO - 'SHELL': '/bin/bash', 06:15:03 INFO - 'SHLVL': '1', 06:15:03 INFO - 'TERM': 'linux', 06:15:03 INFO - 'TMOUT': '86400', 06:15:03 INFO - 'USER': 'cltbld', 06:15:03 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1475241128.942430-341232885', 06:15:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:03 INFO - '_': '/tools/buildbot/bin/python'} 06:15:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:03 INFO - Downloading/unpacking blobuploader==1.2.4 06:15:03 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 06:15:03 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 06:15:03 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 06:15:03 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 06:15:03 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 06:15:03 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 06:15:05 INFO - Downloading blobuploader-1.2.4.tar.gz 06:15:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:15:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:15:05 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 06:15:05 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 06:15:05 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 06:15:05 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 06:15:05 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 06:15:05 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 06:15:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:15:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:15:06 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 06:15:06 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 06:15:06 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 06:15:06 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 06:15:06 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 06:15:06 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 06:15:06 INFO - Downloading docopt-0.6.1.tar.gz 06:15:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:15:06 INFO - Installing collected packages: blobuploader, requests, docopt 06:15:06 INFO - Running setup.py install for blobuploader 06:15:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:15:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:15:06 INFO - Running setup.py install for requests 06:15:06 INFO - Running setup.py install for docopt 06:15:06 INFO - Successfully installed blobuploader requests docopt 06:15:06 INFO - Cleaning up... 06:15:06 INFO - Return code: 0 06:15:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:06 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 0x7f8fa4223f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290d7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299c790>, '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 0x299d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299db20>, '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': '9e0dfe3369c33a1556e63f89000001d8-1475241128.942430-341232885', '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 06:15:06 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 06:15:06 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 06:15:06 INFO - Using env: {'DISPLAY': ':0', 06:15:06 INFO - 'HOME': '/home/cltbld', 06:15:06 INFO - 'LANG': 'en_US.UTF-8', 06:15:06 INFO - 'LANGUAGE': 'en_US:en', 06:15:06 INFO - 'LOGNAME': 'cltbld', 06:15:06 INFO - 'MAIL': '/var/mail/cltbld', 06:15:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:06 INFO - 'MOZ_NO_REMOTE': '1', 06:15:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:06 INFO - 'NO_EM_RESTART': '1', 06:15:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:06 INFO - 'PWD': '/builds/slave/test', 06:15:06 INFO - 'SHELL': '/bin/bash', 06:15:06 INFO - 'SHLVL': '1', 06:15:06 INFO - 'TERM': 'linux', 06:15:06 INFO - 'TMOUT': '86400', 06:15:06 INFO - 'USER': 'cltbld', 06:15:06 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1475241128.942430-341232885', 06:15:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:06 INFO - '_': '/tools/buildbot/bin/python'} 06:15:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:15:07 INFO - Running setup.py (path:/tmp/pip-ns6V86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:15:07 INFO - Running setup.py (path:/tmp/pip-YKnnov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:15:07 INFO - Running setup.py (path:/tmp/pip-SCn2Xg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:15:07 INFO - Running setup.py (path:/tmp/pip-RSoCtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:15:07 INFO - Running setup.py (path:/tmp/pip-zF4q3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:15:07 INFO - Running setup.py (path:/tmp/pip-VBZylm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:15:07 INFO - Running setup.py (path:/tmp/pip-eBqACh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:15:07 INFO - Running setup.py (path:/tmp/pip-BdD2bZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:15:07 INFO - Running setup.py (path:/tmp/pip-MP4dZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:15:07 INFO - Running setup.py (path:/tmp/pip-tF_XtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:15:07 INFO - Running setup.py (path:/tmp/pip-JBKprW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:15:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:15:07 INFO - Running setup.py (path:/tmp/pip-4k4Yxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:15:08 INFO - Running setup.py (path:/tmp/pip-ZFlGb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:15:08 INFO - Running setup.py (path:/tmp/pip-LVtY1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:15:08 INFO - Running setup.py (path:/tmp/pip-2kyRHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:15:08 INFO - Running setup.py (path:/tmp/pip-Svg6ys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:15:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:15:08 INFO - Running setup.py (path:/tmp/pip-l9uqhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:15:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:15:08 INFO - Running setup.py install for manifestparser 06:15:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:15:08 INFO - Running setup.py install for mozcrash 06:15:08 INFO - Running setup.py install for mozdebug 06:15:08 INFO - Running setup.py install for mozdevice 06:15:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:15:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:15:08 INFO - Running setup.py install for mozfile 06:15:08 INFO - Running setup.py install for mozhttpd 06:15:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:15:09 INFO - Running setup.py install for mozinfo 06:15:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:15:09 INFO - Running setup.py install for mozInstall 06:15:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:15:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:15:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:15:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:15:09 INFO - Running setup.py install for mozleak 06:15:09 INFO - Running setup.py install for mozlog 06:15:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:15:09 INFO - Running setup.py install for moznetwork 06:15:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:15:09 INFO - Running setup.py install for mozprocess 06:15:09 INFO - Running setup.py install for mozprofile 06:15:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:15:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:15:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:15:09 INFO - Running setup.py install for mozrunner 06:15:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:15:09 INFO - Running setup.py install for mozscreenshot 06:15:09 INFO - Running setup.py install for moztest 06:15:10 INFO - Running setup.py install for mozversion 06:15:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:15:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:15:10 INFO - Cleaning up... 06:15:10 INFO - Return code: 0 06:15:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:10 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 0x7f8fa4223f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290d7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299c790>, '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 0x299d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299db20>, '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': '9e0dfe3369c33a1556e63f89000001d8-1475241128.942430-341232885', '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 06:15:10 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 06:15:10 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 06:15:10 INFO - Using env: {'DISPLAY': ':0', 06:15:10 INFO - 'HOME': '/home/cltbld', 06:15:10 INFO - 'LANG': 'en_US.UTF-8', 06:15:10 INFO - 'LANGUAGE': 'en_US:en', 06:15:10 INFO - 'LOGNAME': 'cltbld', 06:15:10 INFO - 'MAIL': '/var/mail/cltbld', 06:15:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:10 INFO - 'MOZ_NO_REMOTE': '1', 06:15:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:10 INFO - 'NO_EM_RESTART': '1', 06:15:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:10 INFO - 'PWD': '/builds/slave/test', 06:15:10 INFO - 'SHELL': '/bin/bash', 06:15:10 INFO - 'SHLVL': '1', 06:15:10 INFO - 'TERM': 'linux', 06:15:10 INFO - 'TMOUT': '86400', 06:15:10 INFO - 'USER': 'cltbld', 06:15:10 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1475241128.942430-341232885', 06:15:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:10 INFO - '_': '/tools/buildbot/bin/python'} 06:15:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:15:10 INFO - Running setup.py (path:/tmp/pip-Xn0wOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:15:10 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)) 06:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:15:10 INFO - Running setup.py (path:/tmp/pip-jzRPz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:15:10 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)) 06:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:15:10 INFO - Running setup.py (path:/tmp/pip-qjTQ2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:15:10 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)) 06:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:15:10 INFO - Running setup.py (path:/tmp/pip-NfuIyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:15:10 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)) 06:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:15:10 INFO - Running setup.py (path:/tmp/pip-b8LO3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:15:10 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)) 06:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:15:10 INFO - Running setup.py (path:/tmp/pip-U4NFxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:15:10 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)) 06:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:15:10 INFO - Running setup.py (path:/tmp/pip-6pii6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:15:10 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)) 06:15:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:15:10 INFO - Running setup.py (path:/tmp/pip-AO_mG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:15:11 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)) 06:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:15:11 INFO - Running setup.py (path:/tmp/pip-h0jDbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:15:11 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)) 06:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:15:11 INFO - Running setup.py (path:/tmp/pip-VsvKe8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:15:11 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)) 06:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:15:11 INFO - Running setup.py (path:/tmp/pip-FXLy9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:15:11 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)) 06:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:15:11 INFO - Running setup.py (path:/tmp/pip-4YTIo3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:15:11 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)) 06:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:15:11 INFO - Running setup.py (path:/tmp/pip-h2meAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:15:11 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)) 06:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:15:11 INFO - Running setup.py (path:/tmp/pip-UWIjf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:15:11 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)) 06:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:15:11 INFO - Running setup.py (path:/tmp/pip-SPNyKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:15:11 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)) 06:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:15:11 INFO - Running setup.py (path:/tmp/pip-wLEf6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:15:11 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)) 06:15:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:15:11 INFO - Running setup.py (path:/tmp/pip-PgsX4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:15:11 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)) 06:15:11 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)) 06:15:11 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)) 06:15:11 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)) 06:15:11 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)) 06:15:11 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)) 06:15:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:15:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:15:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:15:13 INFO - Downloading blessings-1.6.tar.gz 06:15:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:15:13 INFO - Installing collected packages: blessings 06:15:13 INFO - Running setup.py install for blessings 06:15:13 INFO - Successfully installed blessings 06:15:13 INFO - Cleaning up... 06:15:13 INFO - Return code: 0 06:15:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:15:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:15:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:15:14 INFO - Reading from file tmpfile_stdout 06:15:14 INFO - Current package versions: 06:15:14 INFO - argparse == 1.2.1 06:15:14 INFO - blessings == 1.6 06:15:14 INFO - blobuploader == 1.2.4 06:15:14 INFO - docopt == 0.6.1 06:15:14 INFO - functools32 == 3.2.3-2 06:15:14 INFO - jsonschema == 2.5.1 06:15:14 INFO - manifestparser == 1.1 06:15:14 INFO - mozInstall == 1.12 06:15:14 INFO - mozcrash == 0.17 06:15:14 INFO - mozdebug == 0.1 06:15:14 INFO - mozdevice == 0.48 06:15:14 INFO - mozfile == 1.2 06:15:14 INFO - mozhttpd == 0.7 06:15:14 INFO - mozinfo == 0.9 06:15:14 INFO - mozleak == 0.1 06:15:14 INFO - mozlog == 3.4 06:15:14 INFO - moznetwork == 0.27 06:15:14 INFO - mozprocess == 0.23 06:15:14 INFO - mozprofile == 0.28 06:15:14 INFO - mozrunner == 6.12 06:15:14 INFO - mozscreenshot == 0.1 06:15:14 INFO - mozsystemmonitor == 0.3 06:15:14 INFO - moztest == 0.7 06:15:14 INFO - mozversion == 1.4 06:15:14 INFO - psutil == 3.1.1 06:15:14 INFO - requests == 1.2.3 06:15:14 INFO - wsgiref == 0.1.2 06:15:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:14 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 0x7f8fa4223f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290d7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299c790>, '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 0x299d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299db20>, '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': '9e0dfe3369c33a1556e63f89000001d8-1475241128.942430-341232885', '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 06:15:14 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 06:15:14 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 06:15:14 INFO - Using env: {'DISPLAY': ':0', 06:15:14 INFO - 'HOME': '/home/cltbld', 06:15:14 INFO - 'LANG': 'en_US.UTF-8', 06:15:14 INFO - 'LANGUAGE': 'en_US:en', 06:15:14 INFO - 'LOGNAME': 'cltbld', 06:15:14 INFO - 'MAIL': '/var/mail/cltbld', 06:15:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:14 INFO - 'MOZ_NO_REMOTE': '1', 06:15:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:14 INFO - 'NO_EM_RESTART': '1', 06:15:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:14 INFO - 'PWD': '/builds/slave/test', 06:15:14 INFO - 'SHELL': '/bin/bash', 06:15:14 INFO - 'SHLVL': '1', 06:15:14 INFO - 'TERM': 'linux', 06:15:14 INFO - 'TMOUT': '86400', 06:15:14 INFO - 'USER': 'cltbld', 06:15:14 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1475241128.942430-341232885', 06:15:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:14 INFO - '_': '/tools/buildbot/bin/python'} 06:15:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:14 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)) 06:15:14 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)) 06:15:14 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)) 06:15:14 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)) 06:15:14 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)) 06:15:14 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)) 06:15:14 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)) 06:15:14 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)) 06:15:14 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)) 06:15:14 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)) 06:15:14 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)) 06:15:14 INFO - Cleaning up... 06:15:14 INFO - Return code: 0 06:15:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:15:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:15:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:15:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8fa4223f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x290d7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x299c790>, '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 0x299d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299db20>, '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': '9e0dfe3369c33a1556e63f89000001d8-1475241128.942430-341232885', '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 06:15:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:15:14 INFO - Using env: {'DISPLAY': ':0', 06:15:14 INFO - 'HOME': '/home/cltbld', 06:15:14 INFO - 'LANG': 'en_US.UTF-8', 06:15:14 INFO - 'LANGUAGE': 'en_US:en', 06:15:14 INFO - 'LOGNAME': 'cltbld', 06:15:14 INFO - 'MAIL': '/var/mail/cltbld', 06:15:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:14 INFO - 'MOZ_NO_REMOTE': '1', 06:15:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:14 INFO - 'NO_EM_RESTART': '1', 06:15:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:14 INFO - 'PWD': '/builds/slave/test', 06:15:14 INFO - 'SHELL': '/bin/bash', 06:15:14 INFO - 'SHLVL': '1', 06:15:14 INFO - 'TERM': 'linux', 06:15:14 INFO - 'TMOUT': '86400', 06:15:14 INFO - 'USER': 'cltbld', 06:15:14 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1475241128.942430-341232885', 06:15:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:14 INFO - '_': '/tools/buildbot/bin/python'} 06:15:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:15:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:15:14 INFO - Cleaning up... 06:15:14 INFO - Return code: 0 06:15:14 INFO - Running post-action listener: _resource_record_post_action 06:15:14 INFO - Running post-action listener: _start_resource_monitoring 06:15:14 INFO - Starting resource monitoring. 06:15:14 INFO - [mozharness: 2016-09-30 13:15:14.506043Z] Finished create-virtualenv step (success) 06:15:14 INFO - [mozharness: 2016-09-30 13:15:14.506560Z] Running install step. 06:15:14 INFO - Running pre-action listener: _resource_record_pre_action 06:15:14 INFO - Running main action method: install 06:15:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:15:14 INFO - Reading from file tmpfile_stdout 06:15:14 INFO - Detecting whether we're running mozinstall >=1.0... 06:15:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:15:14 INFO - Reading from file tmpfile_stdout 06:15:14 INFO - Output received: 06:15:14 INFO - Usage: mozinstall [options] installer 06:15:14 INFO - Options: 06:15:14 INFO - -h, --help show this help message and exit 06:15:14 INFO - -d DEST, --destination=DEST 06:15:14 INFO - Directory to install application into. [default: 06:15:14 INFO - "/builds/slave/test"] 06:15:14 INFO - --app=APP Application being installed. [default: firefox] 06:15:14 INFO - mkdir: /builds/slave/test/build/application 06:15:14 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'] 06:15:14 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 06:15:31 INFO - Reading from file tmpfile_stdout 06:15:31 INFO - Output received: 06:15:31 INFO - /builds/slave/test/build/application/firefox/firefox 06:15:31 INFO - Running post-action listener: _resource_record_post_action 06:15:31 INFO - [mozharness: 2016-09-30 13:15:31.782429Z] Finished install step (success) 06:15:31 INFO - [mozharness: 2016-09-30 13:15:31.782676Z] Running run-tests step. 06:15:31 INFO - Running pre-action listener: _resource_record_pre_action 06:15:31 INFO - Running main action method: run_tests 06:15:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:15:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:15:31 INFO - Python 2.7.3 06:15:31 INFO - Return code: 0 06:15:31 INFO - grabbing minidump binary from tooltool 06:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:15:31 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 0x299c790>, '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 0x299d690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x299db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:15:31 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 06:15:31 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 06:15:31 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 06:15:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:15:31 INFO - Return code: 0 06:15:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:15:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:15:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:15:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:15:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:15:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X44qMvJtRFGIVR4EX4YObA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 06:15:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/X44qMvJtRFGIVR4EX4YObA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --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 06:15:31 INFO - Using env: {'DISPLAY': ':0', 06:15:31 INFO - 'HOME': '/home/cltbld', 06:15:31 INFO - 'LANG': 'en_US.UTF-8', 06:15:31 INFO - 'LANGUAGE': 'en_US:en', 06:15:31 INFO - 'LOGNAME': 'cltbld', 06:15:31 INFO - 'MAIL': '/var/mail/cltbld', 06:15:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:15:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:15:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:15:31 INFO - 'MOZ_NO_REMOTE': '1', 06:15:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:15:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:15:31 INFO - 'NO_EM_RESTART': '1', 06:15:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:15:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:15:31 INFO - 'PWD': '/builds/slave/test', 06:15:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:15:31 INFO - 'SHELL': '/bin/bash', 06:15:31 INFO - 'SHLVL': '1', 06:15:31 INFO - 'TERM': 'linux', 06:15:31 INFO - 'TMOUT': '86400', 06:15:31 INFO - 'USER': 'cltbld', 06:15:31 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1475241128.942430-341232885', 06:15:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:15:31 INFO - '_': '/tools/buildbot/bin/python'} 06:15:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X44qMvJtRFGIVR4EX4YObA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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 06:15:32 INFO - mozversion application_buildid: 20160930033007 06:15:32 INFO - mozversion application_changeset: 3040be42dde9169f98248ede39d3e7b7619e774a 06:15:32 INFO - mozversion application_display_name: Nightly 06:15:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:15:32 INFO - mozversion application_name: Firefox 06:15:32 INFO - mozversion application_remotingname: firefox 06:15:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 06:15:32 INFO - mozversion application_vendor: Mozilla 06:15:32 INFO - mozversion application_version: 52.0a1 06:15:32 INFO - mozversion platform_buildid: 20160930033007 06:15:32 INFO - mozversion platform_changeset: 3040be42dde9169f98248ede39d3e7b7619e774a 06:15:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 06:15:32 INFO - mozversion platform_version: 52.0a1 06:15:32 INFO - using testdate: 1475241332 06:15:32 INFO - actual date: 1475241332 06:15:32 INFO - starting webserver on 'localhost:58916' 06:15:32 INFO - SUITE-START | Running 2 tests 06:15:32 INFO - TEST-START | dromaeo_css 06:15:32 INFO - operating with platform_type : linux_ 06:15:32 INFO - Initialising browser for dromaeo_css test... 06:15:32 INFO - TEST-INFO | started process 17584 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaUMnuT/profile http://localhost:58916/getInfo.html) 06:15:36 INFO - PROCESS | 17584 | __metrics Screen width/height:1600/1200 06:15:36 INFO - PROCESS | 17584 | colorDepth:24 06:15:36 INFO - PROCESS | 17584 | Browser inner width/height: 1024/697 06:15:36 INFO - PROCESS | 17584 | __metrics 06:15:37 INFO - PROCESS | 17584 | 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" 06:15:37 INFO - PROCESS | 17584 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:15:37 INFO - PROCESS | 17584 | console.error: PushService: 06:15:37 INFO - PROCESS | 17584 | stateChangeProcessEnqueue: Error transitioning state 06:15:37 INFO - PROCESS | 17584 | UnknownError 06:15:38 INFO - TEST-INFO | 17584: exit 0 06:15:38 INFO - Browser initialized. 06:15:38 INFO - Running cycle 1/1 for dromaeo_css test... 06:15:38 INFO - TEST-INFO | started process 17665 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaUMnuT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:15:50 INFO - PROCESS | 17665 | RSS: Main: 173961216 06:15:50 INFO - PROCESS | 17665 | 06:16:41 INFO - PROCESS | 17665 | 1475241401480 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] 06:18:50 INFO - PROCESS | 17665 | Cycle 1(1): loaded http://localhost:58916/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58916/tests/dromaeo/cssquery-ext.html) 06:18:51 INFO - PROCESS | 17665 | RSS: Main: 310153216 06:18:51 INFO - PROCESS | 17665 | 06:21:54 INFO - PROCESS | 17665 | Cycle 1(1): loaded http://localhost:58916/tests/dromaeo/cssquery-ext.html (next: http://localhost:58916/tests/dromaeo/cssquery-jquery.html) 06:21:55 INFO - PROCESS | 17665 | RSS: Main: 282804224 06:21:55 INFO - PROCESS | 17665 | 06:24:57 INFO - PROCESS | 17665 | Cycle 1(1): loaded http://localhost:58916/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58916/tests/dromaeo/cssquery-mootools.html) 06:24:57 INFO - PROCESS | 17665 | RSS: Main: 259383296 06:24:57 INFO - PROCESS | 17665 | 06:27:59 INFO - PROCESS | 17665 | Cycle 1(1): loaded http://localhost:58916/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58916/tests/dromaeo/cssquery-prototype.html) 06:28:00 INFO - PROCESS | 17665 | RSS: Main: 242348032 06:28:00 INFO - PROCESS | 17665 | 06:31:03 INFO - PROCESS | 17665 | Cycle 1(1): loaded http://localhost:58916/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58916/tests/dromaeo/cssquery-yui.html) 06:31:03 INFO - PROCESS | 17665 | RSS: Main: 216170496 06:31:03 INFO - PROCESS | 17665 | 06:34:06 INFO - PROCESS | 17665 | Cycle 1(1): loaded http://localhost:58916/tests/dromaeo/cssquery-yui.html (next: http://localhost:58916/tests/dromaeo/cssquery-dojo.html) 06:34:06 INFO - PROCESS | 17665 | RSS: Main: 287318016 06:34:06 INFO - PROCESS | 17665 | 06:34:06 INFO - PROCESS | 17665 | __start_tp_report 06:34:06 INFO - PROCESS | 17665 | _x_x_mozilla_page_load 06:34:06 INFO - PROCESS | 17665 | _x_x_mozilla_page_load_details 06:34:06 INFO - PROCESS | 17665 | |i|pagename|runs| 06:34:06 INFO - PROCESS | 17665 | |0;dojo.html;2938.2654336415894;2970.91087267382;2971.554266859972;3004.0537230772293;3020.8640611172495;5102.923456148152;5123.743812809364;5147.5624571911385;5170.586353091758;5205.453427390126;5130.358705161855;5208.635395522315;5228.241904923784;5243.370795504545;5270.288511051007;4736.97631511842;4749.287606858981;4750.596199323062;4810.350602668647;4866.46468888422;4843.297721830332;4889.755512224392;4892.584130348924;4920.926186107211;4934.4572097069295;4656.650751193674;4698.08387364464;4740.881477963044;4813.927791083119;4814.759262036884;4697.906041879143;4746.074515469485;4748.240281554935;4754.833580824655;4819.1325561398935;4660.37084993525;4683.765811709401;4686.625069994392;4715.198416269242;4749.715017098985;5078.568321692661;5185.922211166836;5195.6622819516615;5198.870028249286;5250.238715386286;5434.7826086956475;5508;5539.335279766414;5543.307086614173;5619.915701264485;5573.804916827932;5578.665280083208;5588.804391846266;5593.049181639131;5601.215829783833;5240.842774716764;5243.9213411798855;5245.527902488794;5248.737563121828;5308.044551980681;5534.308211473566;5581.302337207849;5581.609287349927;5622.606417550814;5655.208270842003;5469.343678758574;5471.042567550663;5473.67157970523;5534.778608855681;5536.75084621193;5488.1767734839295;5492.231087647732;5527.115661494142;5548.223248745179;5556.749946252347;5407.810726624549;5455.727213639381;5529.972350138304;5532.059549876531;5592.552595792326;5466.945330546723;5512.834614961557;5528.087865502147;5543.750531226105;5597.776088956478;4297.269464191095;4305.849295274713;4306.547812479707;4326.545712700184;4359.564043595678;3844.942325865114;3857.8456861725776;3877.728559000899;3912;3920.294347017564;5220;5238.580913526908;5242.633015688865;5267;5344.5724342052545;5568.192612071227;5578.888422231533;5579.944200558024;5585.636933599303;5588.86027849307;5230.895382092337;5257.106291930381;5311.28297679816;5312.1766126250495;5376.059189641797;4743;4779.283107533828;4799.0401919616215;4800.447948485899;4801.327814106028;5672.688002159838;5674.631148975303;5677.2903387075785;5683.488486036276;5733.655980641175;5445.40100588927;5473.616846820684;5565.220869078251;5570.108782594765;5575.080111781511;5667.716614169358;5704.401037891128;5711.228984087095;5736.053551164011;5737.635899848899;5436.130219164915;5464.508194262536;5472.151816468454;5496.422875598005;5557.499825015768;5530.115181570929;5585.357683866408;5589.944100558942;5594.16087586849;5595.07681232592;5282.392524859691;5433.809816656398;5443.319585051869;5445.967421533477;5495.53287970511;5308.309919710413;5387.0572649785345;5413.593980451403;5419.647722897999;5505.807296744595;5368.060589396762;5372;5376.381716102698;5376.596755243294;5378.838634840961;5420.593455490933;5456.072467680583;5470.72646367688;5472.50747432733;5534.695591742332;5144.742762861767;5188.584913206859;5259.158534634593;5304.867378315419;5307.336582927134 06:34:06 INFO - PROCESS | 17665 | |1;ext.html;583.4602992232184;609.7469550136693;617.3178637605446;635.6853357587993;636.9331220221874;32304.192395190134;42404.57595424045;43280.78359608205;43416.56583434164;43477;44987.325190122094;45460.54539454613;45463.54536454634;45482.63243145962;45489.7725511372;8153.592320383987;9039.819203615923;9186.26509879208;9192.264618830477;9192.448453092802;8014.879776803353;8311;8315.126911674248;10204.183665306795;10541;11040.613578524753;11091.889081109206;11095.667129986114;11101.666949991513;11103.44482775862;10669.253152279343;10730.409827459487;10730.839037414446;10742.3017503862;10745.731356716067;8024.598770061532;8255.793605159859;10310.226732995055;10670.093042091432;10693.625723099733;42606.57393426088;42847;42847.785761071;42893.78553107214;42898;3342.8997130086136;3448.2758620689683;3511.052015955703;3548.538689970313;3776.999095239764;29985.250368740737;32470.35059298801;32508.674913251038;32571.160056388188;34120.82939585286;4186.246475634384;4187.539370669224;4235.661147108224;4251.9787401062795;4342.174986752507;314221;315512;317277.9999999977;317368;320019;57496.712516437154;57638.7118064407;58009;58025;58026;61628;61667.69166154141;61685.07472387918;61695.6915215421;61698;15997.680046399008;16410.425635102714;16411.261493232832;16427.425040123537;16430.83569164293;11322.886771132347;12272.38638068093;12286.877131228752;12290.631281061404;12299.262044277371;16137.435189768301;17933.551661208574;18226.817731822513;18332.54168645768;18997.335093271668;6969.407600353925;7109.92890071103;7140.5358651687475;7155.212926578072;7195.424366050704;956.4691596164057;990.8110267678815;1005.1908213887745;1074.1728868771002;1075.6504136155781;30972;31927.680723192934;31995.840020799747;32814;34699.82650086733;1020.4438580973388;1064.5050051725984;1069.7967386196597;1086.8697353187683;1139.3050239353988;15735.370585176464;16204.75692864608;16470.505884823473;16685.332586696397;16742.953026797888;539916;546752;546764;546813;547665;48597;49233.50766492361;51025.234621480704;52683;56168.59578510488;1312.193001304191;1319.5843309357713;1342.7851543753147;1377.0498356134235;1380.1149763415951;29470.705292946797;30536.389272214874;30657.540136897518;30872;31066.223344415666;48814.267785983946;49619.50380496149;49712.751436242586;49821.501784983135;49822;435343;437882;444696;681960;688493;41896.790516048444;42049;42113.36829947492;42426.78786606047;42478.362824557036;46999.53000469952;47125.764371177924;47200.391945128395;47769.76115119402;48148.27777583409;39577.051301189;40594.391084133174;41021.38467922924;41745;42213.57786422219;40525.594744053364;40871;41058.794706027475;41976.790116049226;42155.57844421639;40287.597124029555;41229.587704123776;41398.37902431526;41632.3755143667;41701.37447938344;34195.82902085473;36313;36897;37041.62958370382;37195.44206836846;27330.590041149;27547.311317216427;27600.585991210548;27947.580786287814;27986.440271194868 06:34:06 INFO - PROCESS | 17665 | |2;jquery.html;362.5088005752204;373.65250317205;374.75266324226016;379.8727426312185;405.5559162716826;13946.721065578682;18292.176852041674;18742.90628546857;19685.50786230345;20001.899990500064;18218.908905455453;19107;19151.329703460382;19302.613947721038;19307.806921930776;5527.170924361348;5808.535317174616;5812.3025236971625;5814.767409303623;5852.385499522553;4166.604172603597;4521.909561808779;5712.028955077647;6397.232332120152;6398.616083035009;6292.5595208335435;6479.708413121397;6484.578502397353;6486.805395838132;6523.739050437976;6341.302456729756;6388.105665206875;6393.552451328409;6422.068800023971;6442.871142577145;5484.91772623411;5596.356419011825;5623.915641265385;5628.718564071821;5658.915116273218;22597.096116155335;22855;23007.424814379607;23061.538769224688;23217.53564928709;2383.4398916254668;2450.3139121046133;2562.705288891783;2713.4573085383004;2968.643762748484;14045.719085618333;14189.787153192607;14270.928645356707;14296.785548216785;14861.479848205368;1904.7619047619048;1942.9028548572514;1949.4444083436154;2006.0972562346856;2010.939671809848;80144;81209;81720.59139704263;83138.58430707808;84035.15964840335;10625.9468702656;10886.29239099456;10929.234953553334;10980.231383803057;11070.723231919106;15617.60955976087;15646.687066258839;15653.139077350626;15658.530244092695;15669.981451205635;7637;7879.33025692811;7966.721164759206;8117.391195660349;8206.302464290482;7489.363404110712;7515.473916825769;7626.58053807046;7766.922330776733;7816.101148367897;4676.69601475903;4699.95300047002;4710.599599034121;4726.1020406122725;4764.523547645277;1919.5680971781237;1957.628050670368;1996.241428257253;1999.2702663527707;2005.8194762471155;850.9319254459629;876.3952872517942;895.7939673874915;1003.3578509753763;1032.695354870315;17848.375306864196;18584.349547765763;18706.625867482846;18968.241270349306;19416.4175074748;976.077606661712;982.9459379734184;984.9015098490094;1021.1779517488493;1059.9682009539572;9924.553395097239;10078.344907580984;10573.841392379121;10674.412907290018;10762.300450470695;403661;407955;413695;413798;428448;87392.56303718568;88354.11645883459;88802.55598721965;89779.55110224537;90763;920.9493477858782;948.672707915768;964.2719746591279;965.290511474066;969.9224062075017;16192.109433981244;16540.255688494286;16854.915725421295;17069.5481414288;17140.228689708743;39883.40174897437;40544.1891162181;40843.795781020905;40906;42072.789636051624;55010.44989550053;55288.26810647618;56152.71923640356;56690.433095668515;57948.4205157943;8257.710980115668;8450.408471406943;8566.443181193203;8589.484630922165;8656.567171641267;12086.972607328124;12546.749065018466;12698.174618650128;12794.040446966701;12888.871111288767;7244.818879528054;11172.441377931233;11443.542258309908;11590.246633968765;11666.108615149295;10988;11324.150688698546;11484;11632.243904146204;11711.414429278331;11325.603603873826;11623.941880290544;11814.409279536161;11891.28652280866;11982.161248712855;8474.27968622674;8481.830363392573;8535.743927682179;8653.524056176971;8876.556172191495;9584.472853993097;10871.565137394417;11041.889581104086;11200.21598488098;11549.422528873354 06:34:06 INFO - PROCESS | 17665 | |3;mootools.html;1338.8795008449238;1449.7028109237608;1478.48253111411;1581.5018269245186;1716.6309243512642;7627.92372076279;8397.118302578234;8672.783180420492;8764.91235087649;8961.596728147233;8757.693480728176;8806.163414475615;8878.112188781119;8886.822263554724;8905.643774249038;2356.2695564375013;2390.988045059772;2391.85648861068;2395.2574701842395;2395.8203134764876;2315.4442933695877;2367.9052837886466;2403.8677872716994;2405.194259922928;2407.735149133594;2329.7320808107115;2340.0990618611872;2361.9291421257303;2406.1698713943747;2406.927792166238;2306.238941149417;2313.6645186447954;2320.3966968588206;2333.894974726133;2381.404648837791;2285.874276914769;2324.93025209244;2329.650552417134;2338.38032921276;2344.367020904346;8805.25155361795;8887;8895;8898.86651700225;8903;5137.845864624067;5296.496832800916;5303.071962406602;5373.328333958255;5375.247465354853;3287.736981041535;3467.3065386922717;3517.43721004638;3532.5760908690863;3547.787132772042;1007.4360703153251;1053.7312985188728;1055.2665897201448;1074.2265568790458;1075.2849355178796;12326.63020109407;12455.564055258114;12537.43581538833;12553.686157846036;12581.433835477426;4280.208161490134;4529.184746745617;4566.908661826745;4689.6717229793585;4728.668993170445;9762.17021553176;9788.951055244679;9793.069658382443;9805.166560842266;9806.16647584949;5168.870778230499;5178.067947769362;5201.505856943584;5217.373915130132;5238.633295669267;4210.473690788652;4340.178883725604;4357.3899654048455;4465.464144302705;4856.465788763304;3520.6479352065103;3804.9429258561145;3811.733178677521;3845.1925095729653;3856.1902000580194;1101.4107452512867;1133.824257240129;1143.1940481960364;1149.4942225420955;1149.9425028748528;788.7673136424769;865.9220670139717;887.3123329419623;943.235978857128;957.6552441121191;5916.136417028622;5920.319163296276;5944.554158438134;5961.433663801932;6278.905816412757;933.5285680731188;935.0929598289648;943.2689665509148;949.1789601994225;971.7424882406168;3895.870197642652;4136.8138433770555;4223.957760422418;4235.4917409911;4335.284678028153;10932.781344373068;11319.151063670257;11370.431478426046;11443.771124577463;11456.427178641035;11310.491027903765;11314.321140731583;11317.49071291794;11372.886271137348;11385.772284554429;7869.960650196713;8029.397795165386;8184.304334131665;8323.250907418362;8326;5942.257217847769;5955.642661440327;5961.493273071664;6012.6392416455155;6250.4374606285655;10212.897871021492;10260.897391025994;10273.537690803782;10290.12533934624;10419.479026048819;8923.643054277756;9951.601935922483;10282.126019288444;10303;10454.790904181722;7311.3785328247695;7758.107817601048;7874.488158269694;7979.800504987422;8004.039515257973;8474.915250847413;8476.49141051539;8605.096464871098;8618.569071546272;8679.218870301704;7515.436342274242;7545.962270188614;7847.529148251123;7853.371730261451;7870.173631768582;7668.846623067619;7669;7689.6539655714505;7720.150783413932;7812.53124812513;6842.93157068423;6887.827804304932;6902.585844849325;6931.7227310907;6942.062821519232;5126.2054381570915;5245.921311180412;5251.107311756934;5310.468953104659;5356.464353564613;4992.925106123338;5021.874453138555;5089.796408143633;5160.922586161286;5181.093308671043 06:34:06 INFO - PROCESS | 17665 | |4;prototype.html;327.74927180706754;328.79943234626876;334.72218059011016;337.86485405837664;343.9965600343999;5185.585153187745;5272.9209061864;5316.415194328625;5362.1420572708375;5364.088105022151;5061.493850614946;5154.974225128878;5207.489827949899;5253.86865328367;5262.789488420468;4173.853915112972;4176.874693759177;4198.286291330466;4222.97888510557;4260.808263628144;4072.5520192778918;4210.473690788652;4217.683673724468;4229.6404805591565;4268.7225330353585;4153.626173644371;4183.414321994923;4195.62239398454;4200.390943313218;4200.537940826506;4170.9582904171175;4178.307785346924;4188.973701443136;4208.326667733163;4210.842018444952;3776;3781.9054523636855;3789.8484060637543;3802.7147963902817;3823.3118038753014;5083.79664813407;5199.896002079975;5209.515288142861;5215.322008138955;5260.8684782880355;4816.638752093572;4824.565789078964;4839;4840.878978025542;4859.173940430135;5368.12115759485;5507.807226747084;5508.245877061469;5542.168674698787;5543.279373681436;3984.9601503984877;4008.358662613997;4015.4980627421573;4020.5175378954714;4029.703069250528;5677.772889084432;5704.429557044304;5705.286839145107;5721.656700597978;5730.312362516483;4165.812538435777;4174.499060112806;4213.662906967435;4229.915401691949;4230.878817113467;4103.876883693494;4211.663066954637;4214.768187749642;4233.068724880522;4264.997725534497;4734.621230301567;4736.952630473651;4743.075100355467;4772.260299653559;4784.832530861403;5543.722813859291;5543.750531226105;5559.583031272671;5563.972180139073;5584.329880414376;1418.3546486348687;1463.751162302411;1468.7588987305924;1472.124086168728;1477.9113253204841;928.945646690997;953.1278879824882;960.2366118935463;967.970960871175;969.5733877094056;4709.976450117796;4755.358026666356;4772.308015337757;4775.952240477551;4780.259059845729;4976.253561965734;4987.476314986947;5013.649044566918;5022;5030.44056342535;4446.3552784846015;4741.028089241697;4755.881102972453;4785.712857228577;4854.854354369375;2657.86710664466;2669.958716100722;2677.3039009857575;2679.209633158223;2698.7706044986003;5154.737089413118;5173.63784535079;5187.325647665854;5221.973890130601;5228.144008876794;5075.289459475676;5129.410117836422;5130.589552835764;5373.9731301343245;5795.797147099831;5809.82570522885;5822.592418530747;5833.445822646841;5922.585419020627;5945.702714864239;5736.340320863154;5740.789795928681;5763.8559036024435;5782.508486778503;5808.564357673107;5455.563554915518;5578.77267001259;5662.915056274242;5666.46168613981;5737.799177028784;5887.558433117619;5888.882222355614;5890.322612899571;5897.498712609477;5913.763449461973;3785.8074706467373;3798.2593394287846;4107.342825147962;4127.422160897537;4130.401091841726;5652.3217213934595;5653;5657.60396772222;5685.886282274414;5717.828465146053;5471.467988963097;5475.5072043516275;5501.257330260363;5502.862428439321;5505.229267902417;5323.866903327448;5438.700871452108;5460.890782184255;5486.149646804752;5549.916751248816;5398.514133727984;5418.810341638182;5419.187121931742;5436.891262174813;5439.782408703608;5469.234307197075;5534.225208470898;5560.471755183251;5577;5638.407967163389;5432.837014889559;5455.9454405455435;5460.235567020541;5465.890682186255;5490.670559766427 06:34:06 INFO - PROCESS | 17665 | |5;yui.html;715.3097261142998;740.1044735869598;778.8208711996244;779.2986312318912;811.290121143999;15054.84945150548;16591;16593.336266549322;16661.750073748903;16666.749998750027;14672;14859.554213373589;14943.252837358143;14985.475508357209;15001.849981500181;646.983825404364;662.6620423583983;764.9426293028031;788.8698364769806;793.2543409195367;766.1457474915456;779.5751315533048;783.9451238413313;791.635847510146;791.6912404162381;839.2991851803752;840.5755093677715;840.9579521023925;841.5077179849795;841.7516832534386;681.9624920629363;829.2826704900248;833.170994860112;833.3916241143999;833.7207035643066;513.1046324164357;589.6491587505427;599.0953659973471;600.0129786501182;604.5979423683245;14399.280035998263;14421.495247666386;14435.855641443557;14436.278186090758;14451.060681055698;12845.35773211345;13180.604581862559;13374.79937800924;13579.796303055462;13792.93103534486;11745.412729363583;11892.286462812259;11928.40357982106;12111.333876636869;12571.559995400117;4203.117345357478;4322.308430651081;4380.145871555048;4398.274284743045;4501.932471012938;76269.61865190695;76558;78460.60769696173;80688;81321.18678813195;10658.62694805678;11032.338059716443;11098.056665183389;11098.2786118902;11293;20098.296559620343;20420.89789551043;20461.89769051175;20465.59068818645;20477.180912763324;7809.882851757228;7866.370690344758;8080.676772929134;8158;8165.591720413956;4514.367988481616;4735.526447355306;4764.99935013651;4798.2322828348;4806.639502037361;3478.3912815257227;3546.37938360791;3586.9239228231427;3610.6750392464805;3611.2416392557334;609.1502354215933;614.695725615823;627.4447114303782;631.6904716688881;636.2460484326089;598.9910151347733;602.6305616953015;639.536336156283;640.6316368088368;648.8183308673579;8723.781905452415;8922.509261990523;9011.459312441275;9031.729048128434;9402.341836071546;634.8857205703018;638.2341190571241;641.4323323858325;652.0968458684756;692.4564217089661;4560.156371071363;4602.286645569942;4659.394278743742;4691.741954192552;4715.669903106749;89953.55023224842;92414.53792730994;94506;120318;124439.3778031104;94678.5266073679;96324;96592;97347.51326243323;97979;80504.59747701224;80595.59702201451;82233.58883205545;83834;84534.57732711297;9800.509974501389;9843.704688859345;10013.799724005625;10324.741881453023;10395.636152734618;49763;50277.24584131168;50323.49676503335;51293.48706512887;51448.48551514437;69456.65271673811;71874.64062679654;75516.22418879144;75546.62226688831;76034.61982690051;12744.872551274739;12761.234325940473;12824.615261542169;12898.67753306175;13177.209367437985;14260.215688136837;14502.85497145015;14898.32957516936;14900.552983410515;15113.622159445662;13400.128991615515;13594.660133496742;13688.315584220949;14040.227787471787;14114.858851411354;13457.528986485426;13754.793678094637;13877.791833122714;14233.430662773373;14283.500077497238;12871.163374380636;13335.266560339274;13366;13411.530596429078;13553.728925421634;11052.11583073336;11373.545058197911;11408.258463199865;11623;11866.288022718665;11373.374464404536;11377.573914344384;11418.371989540656;11706.1220408468;11763.411829408666 06:34:06 INFO - PROCESS | 17665 | __end_tp_report 06:34:06 INFO - PROCESS | 17665 | __start_cc_report 06:34:06 INFO - PROCESS | 17665 | _x_x_mozilla_cycle_collect,1009 06:34:06 INFO - PROCESS | 17665 | __end_cc_report 06:34:06 INFO - PROCESS | 17665 | __startTimestamp1475242446891__endTimestamp 06:34:06 INFO - PROCESS | 17665 | 06:34:06 INFO - PROCESS | 17665 | ------- Summary: start ------- 06:34:06 INFO - PROCESS | 17665 | Number of tests: 6 06:34:06 INFO - PROCESS | 17665 | 06:34:06 INFO - PROCESS | 17665 | [#0] dojo.html Cycles:165 Average:5165.37 Median:5372.00 stddev:567.15 (10.6%) stddev-sans-first:541.31 06:34:06 INFO - PROCESS | 17665 | Values: 2938.3 2970.9 2971.6 3004.1 3020.9 5102.9 5123.7 5147.6 5170.6 5205.5 5130.4 5208.6 5228.2 5243.4 5270.3 4737.0 4749.3 4750.6 4810.4 4866.5 4843.3 4889.8 4892.6 4920.9 4934.5 4656.7 4698.1 4740.9 4813.9 4814.8 4697.9 4746.1 4748.2 4754.8 4819.1 4660.4 4683.8 4686.6 4715.2 4749.7 5078.6 5185.9 5195.7 5198.9 5250.2 5434.8 5508.0 5539.3 5543.3 5619.9 5573.8 5578.7 5588.8 5593.0 5601.2 5240.8 5243.9 5245.5 5248.7 5308.0 5534.3 5581.3 5581.6 5622.6 5655.2 5469.3 5471.0 5473.7 5534.8 5536.8 5488.2 5492.2 5527.1 5548.2 5556.7 5407.8 5455.7 5530.0 5532.1 5592.6 5466.9 5512.8 5528.1 5543.8 5597.8 4297.3 4305.8 4306.5 4326.5 4359.6 3844.9 3857.8 3877.7 3912.0 3920.3 5220.0 5238.6 5242.6 5267.0 5344.6 5568.2 5578.9 5579.9 5585.6 5588.9 5230.9 5257.1 5311.3 5312.2 5376.1 4743.0 4779.3 4799.0 4800.4 4801.3 5672.7 5674.6 5677.3 5683.5 5733.7 5445.4 5473.6 5565.2 5570.1 5575.1 5667.7 5704.4 5711.2 5736.1 5737.6 5436.1 5464.5 5472.2 5496.4 5557.5 5530.1 5585.4 5589.9 5594.2 5595.1 5282.4 5433.8 5443.3 5446.0 5495.5 5308.3 5387.1 5413.6 5419.6 5505.8 5368.1 5372.0 5376.4 5376.6 5378.8 5420.6 5456.1 5470.7 5472.5 5534.7 5144.7 5188.6 5259.2 5304.9 5307.3 06:34:06 INFO - PROCESS | 17665 | 06:34:06 INFO - PROCESS | 17665 | [#1] ext.html Cycles:180 Average:62600.01 Median:41144.19 stddev:128845.71 (313.2%) stddev-sans-first:129123.03 06:34:06 INFO - PROCESS | 17665 | Values: 583.5 609.7 617.3 635.7 636.9 32304.2 42404.6 43280.8 43416.6 43477.0 44987.3 45460.5 45463.5 45482.6 45489.8 8153.6 9039.8 9186.3 9192.3 9192.4 8014.9 8311.0 8315.1 10204.2 10541.0 11040.6 11091.9 11095.7 11101.7 11103.4 10669.3 10730.4 10730.8 10742.3 10745.7 8024.6 8255.8 10310.2 10670.1 10693.6 42606.6 42847.0 42847.8 42893.8 42898.0 3342.9 3448.3 3511.1 3548.5 3777.0 29985.3 32470.4 32508.7 32571.2 34120.8 4186.2 4187.5 4235.7 4252.0 4342.2 314221.0 315512.0 317278.0 317368.0 320019.0 57496.7 57638.7 58009.0 58025.0 58026.0 61628.0 61667.7 61685.1 61695.7 61698.0 15997.7 16410.4 16411.3 16427.4 16430.8 11322.9 12272.4 12286.9 12290.6 12299.3 16137.4 17933.6 18226.8 18332.5 18997.3 6969.4 7109.9 7140.5 7155.2 7195.4 956.5 990.8 1005.2 1074.2 1075.7 30972.0 31927.7 31995.8 32814.0 34699.8 1020.4 1064.5 1069.8 1086.9 1139.3 15735.4 16204.8 16470.5 16685.3 16743.0 539916.0 546752.0 546764.0 546813.0 547665.0 48597.0 49233.5 51025.2 52683.0 56168.6 1312.2 1319.6 1342.8 1377.0 1380.1 29470.7 30536.4 30657.5 30872.0 31066.2 48814.3 49619.5 49712.8 49821.5 49822.0 435343.0 437882.0 444696.0 681960.0 688493.0 41896.8 42049.0 42113.4 42426.8 42478.4 46999.5 47125.8 47200.4 47769.8 48148.3 39577.1 40594.4 41021.4 41745.0 42213.6 40525.6 40871.0 41058.8 41976.8 42155.6 40287.6 41229.6 41398.4 41632.4 41701.4 34195.8 36313.0 36897.0 37041.6 37195.4 27330.6 27547.3 27600.6 27947.6 27986.4 06:34:06 INFO - PROCESS | 17665 | 06:34:06 INFO - PROCESS | 17665 | [#2] jquery.html Cycles:180 Average:26739.71 Median:221772.20 stddev:68603.27 (30.9%) stddev-sans-first:68767.13 06:34:06 INFO - PROCESS | 17665 | Values: 362.5 373.7 374.8 379.9 405.6 13946.7 18292.2 18742.9 19685.5 20001.9 18218.9 19107.0 19151.3 19302.6 19307.8 5527.2 5808.5 5812.3 5814.8 5852.4 4166.6 4521.9 5712.0 6397.2 6398.6 6292.6 6479.7 6484.6 6486.8 6523.7 6341.3 6388.1 6393.6 6422.1 6442.9 5484.9 5596.4 5623.9 5628.7 5658.9 22597.1 22855.0 23007.4 23061.5 23217.5 2383.4 2450.3 2562.7 2713.5 2968.6 14045.7 14189.8 14270.9 14296.8 14861.5 1904.8 1942.9 1949.4 2006.1 2010.9 80144.0 81209.0 81720.6 83138.6 84035.2 10625.9 10886.3 10929.2 10980.2 11070.7 15617.6 15646.7 15653.1 15658.5 15670.0 7637.0 7879.3 7966.7 8117.4 8206.3 7489.4 7515.5 7626.6 7766.9 7816.1 4676.7 4700.0 4710.6 4726.1 4764.5 1919.6 1957.6 1996.2 1999.3 2005.8 850.9 876.4 895.8 1003.4 1032.7 17848.4 18584.3 18706.6 18968.2 19416.4 976.1 982.9 984.9 1021.2 1060.0 9924.6 10078.3 10573.8 10674.4 10762.3 403661.0 407955.0 413695.0 413798.0 428448.0 87392.6 88354.1 88802.6 89779.6 90763.0 920.9 948.7 964.3 965.3 969.9 16192.1 16540.3 16854.9 17069.5 17140.2 39883.4 40544.2 40843.8 40906.0 42072.8 55010.4 55288.3 56152.7 56690.4 57948.4 8257.7 8450.4 8566.4 8589.5 8656.6 12087.0 12546.7 12698.2 12794.0 12888.9 7244.8 11172.4 11443.5 11590.2 11666.1 10988.0 11324.2 11484.0 11632.2 11711.4 11325.6 11623.9 11814.4 11891.3 11982.2 8474.3 8481.8 8535.7 8653.5 8876.6 9584.5 10871.6 11041.9 11200.2 11549.4 06:34:06 INFO - PROCESS | 17665 | 06:34:06 INFO - PROCESS | 17665 | [#3] mootools.html Cycles:180 Average:5801.79 Median:5108.00 stddev:3336.89 (65.3%) stddev-sans-first:3329.39 06:34:06 INFO - PROCESS | 17665 | Values: 1338.9 1449.7 1478.5 1581.5 1716.6 7627.9 8397.1 8672.8 8764.9 8961.6 8757.7 8806.2 8878.1 8886.8 8905.6 2356.3 2391.0 2391.9 2395.3 2395.8 2315.4 2367.9 2403.9 2405.2 2407.7 2329.7 2340.1 2361.9 2406.2 2406.9 2306.2 2313.7 2320.4 2333.9 2381.4 2285.9 2324.9 2329.7 2338.4 2344.4 8805.3 8887.0 8895.0 8898.9 8903.0 5137.8 5296.5 5303.1 5373.3 5375.2 3287.7 3467.3 3517.4 3532.6 3547.8 1007.4 1053.7 1055.3 1074.2 1075.3 12326.6 12455.6 12537.4 12553.7 12581.4 4280.2 4529.2 4566.9 4689.7 4728.7 9762.2 9789.0 9793.1 9805.2 9806.2 5168.9 5178.1 5201.5 5217.4 5238.6 4210.5 4340.2 4357.4 4465.5 4856.5 3520.6 3804.9 3811.7 3845.2 3856.2 1101.4 1133.8 1143.2 1149.5 1149.9 788.8 865.9 887.3 943.2 957.7 5916.1 5920.3 5944.6 5961.4 6278.9 933.5 935.1 943.3 949.2 971.7 3895.9 4136.8 4224.0 4235.5 4335.3 10932.8 11319.2 11370.4 11443.8 11456.4 11310.5 11314.3 11317.5 11372.9 11385.8 7870.0 8029.4 8184.3 8323.3 8326.0 5942.3 5955.6 5961.5 6012.6 6250.4 10212.9 10260.9 10273.5 10290.1 10419.5 8923.6 9951.6 10282.1 10303.0 10454.8 7311.4 7758.1 7874.5 7979.8 8004.0 8474.9 8476.5 8605.1 8618.6 8679.2 7515.4 7546.0 7847.5 7853.4 7870.2 7668.8 7669.0 7689.7 7720.2 7812.5 6842.9 6887.8 6902.6 6931.7 6942.1 5126.2 5245.9 5251.1 5310.5 5356.5 4992.9 5021.9 5089.8 5160.9 5181.1 06:34:06 INFO - PROCESS | 17665 | 06:34:06 INFO - PROCESS | 17665 | [#4] prototype.html Cycles:180 Average:4600.87 Median:5154.86 stddev:1331.68 (25.8%) stddev-sans-first:1296.21 06:34:06 INFO - PROCESS | 17665 | Values: 327.7 328.8 334.7 337.9 344.0 5185.6 5272.9 5316.4 5362.1 5364.1 5061.5 5155.0 5207.5 5253.9 5262.8 4173.9 4176.9 4198.3 4223.0 4260.8 4072.6 4210.5 4217.7 4229.6 4268.7 4153.6 4183.4 4195.6 4200.4 4200.5 4171.0 4178.3 4189.0 4208.3 4210.8 3776.0 3781.9 3789.8 3802.7 3823.3 5083.8 5199.9 5209.5 5215.3 5260.9 4816.6 4824.6 4839.0 4840.9 4859.2 5368.1 5507.8 5508.2 5542.2 5543.3 3985.0 4008.4 4015.5 4020.5 4029.7 5677.8 5704.4 5705.3 5721.7 5730.3 4165.8 4174.5 4213.7 4229.9 4230.9 4103.9 4211.7 4214.8 4233.1 4265.0 4734.6 4737.0 4743.1 4772.3 4784.8 5543.7 5543.8 5559.6 5564.0 5584.3 1418.4 1463.8 1468.8 1472.1 1477.9 928.9 953.1 960.2 968.0 969.6 4710.0 4755.4 4772.3 4776.0 4780.3 4976.3 4987.5 5013.6 5022.0 5030.4 4446.4 4741.0 4755.9 4785.7 4854.9 2657.9 2670.0 2677.3 2679.2 2698.8 5154.7 5173.6 5187.3 5222.0 5228.1 5075.3 5129.4 5130.6 5374.0 5795.8 5809.8 5822.6 5833.4 5922.6 5945.7 5736.3 5740.8 5763.9 5782.5 5808.6 5455.6 5578.8 5662.9 5666.5 5737.8 5887.6 5888.9 5890.3 5897.5 5913.8 3785.8 3798.3 4107.3 4127.4 4130.4 5652.3 5653.0 5657.6 5685.9 5717.8 5471.5 5475.5 5501.3 5502.9 5505.2 5323.9 5438.7 5460.9 5486.1 5549.9 5398.5 5418.8 5419.2 5436.9 5439.8 5469.2 5534.2 5560.5 5577.0 5638.4 5432.8 5455.9 5460.2 5465.9 5490.7 06:34:06 INFO - PROCESS | 17665 | 06:34:06 INFO - PROCESS | 17665 | [#5] yui.html Cycles:180 Average:20308.22 Median:4725.60 stddev:28780.82 (609.0%) stddev-sans-first:28823.96 06:34:06 INFO - PROCESS | 17665 | Values: 715.3 740.1 778.8 779.3 811.3 15054.8 16591.0 16593.3 16661.8 16666.7 14672.0 14859.6 14943.3 14985.5 15001.8 647.0 662.7 764.9 788.9 793.3 766.1 779.6 783.9 791.6 791.7 839.3 840.6 841.0 841.5 841.8 682.0 829.3 833.2 833.4 833.7 513.1 589.6 599.1 600.0 604.6 14399.3 14421.5 14435.9 14436.3 14451.1 12845.4 13180.6 13374.8 13579.8 13792.9 11745.4 11892.3 11928.4 12111.3 12571.6 4203.1 4322.3 4380.1 4398.3 4501.9 76269.6 76558.0 78460.6 80688.0 81321.2 10658.6 11032.3 11098.1 11098.3 11293.0 20098.3 20420.9 20461.9 20465.6 20477.2 7809.9 7866.4 8080.7 8158.0 8165.6 4514.4 4735.5 4765.0 4798.2 4806.6 3478.4 3546.4 3586.9 3610.7 3611.2 609.2 614.7 627.4 631.7 636.2 599.0 602.6 639.5 640.6 648.8 8723.8 8922.5 9011.5 9031.7 9402.3 634.9 638.2 641.4 652.1 692.5 4560.2 4602.3 4659.4 4691.7 4715.7 89953.6 92414.5 94506.0 120318.0 124439.4 94678.5 96324.0 96592.0 97347.5 97979.0 80504.6 80595.6 82233.6 83834.0 84534.6 9800.5 9843.7 10013.8 10324.7 10395.6 49763.0 50277.2 50323.5 51293.5 51448.5 69456.7 71874.6 75516.2 75546.6 76034.6 12744.9 12761.2 12824.6 12898.7 13177.2 14260.2 14502.9 14898.3 14900.6 15113.6 13400.1 13594.7 13688.3 14040.2 14114.9 13457.5 13754.8 13877.8 14233.4 14283.5 12871.2 13335.3 13366.0 13411.5 13553.7 11052.1 11373.5 11408.3 11623.0 11866.3 11373.4 11377.6 11418.4 11706.1 11763.4 06:34:06 INFO - PROCESS | 17665 | -------- Summary: end -------- 06:34:06 INFO - PROCESS | 17665 | 06:34:07 INFO - TEST-INFO | 17665: exit 0 06:34:07 INFO - TEST-OK | dromaeo_css | took 1115721ms 06:34:07 INFO - TEST-START | kraken 06:34:07 INFO - operating with platform_type : linux_ 06:34:07 INFO - Initialising browser for kraken test... 06:34:07 INFO - TEST-INFO | started process 17981 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJJHqi6/profile http://localhost:58916/getInfo.html) 06:34:12 INFO - PROCESS | 17981 | __metrics Screen width/height:1600/1200 06:34:12 INFO - PROCESS | 17981 | colorDepth:24 06:34:12 INFO - PROCESS | 17981 | Browser inner width/height: 1024/697 06:34:12 INFO - PROCESS | 17981 | __metrics 06:34:12 INFO - PROCESS | 17981 | 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" 06:34:12 INFO - PROCESS | 17981 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:34:13 INFO - PROCESS | 17981 | console.error: PushService: 06:34:13 INFO - PROCESS | 17981 | stateChangeProcessEnqueue: Error transitioning state 06:34:13 INFO - PROCESS | 17981 | UnknownError 06:34:13 INFO - TEST-INFO | 17981: exit 0 06:34:13 INFO - Browser initialized. 06:34:13 INFO - Running cycle 1/1 for kraken test... 06:34:13 INFO - TEST-INFO | started process 18061 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJJHqi6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:34:26 INFO - PROCESS | 18061 | RSS: Main: 173445120 06:34:26 INFO - PROCESS | 18061 | 06:34:28 INFO - PROCESS | 18061 | Cycle 1(1): loaded http://localhost:58916/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58916/tests/kraken/driver.html?testName=audio-beat-detection) 06:34:29 INFO - PROCESS | 18061 | RSS: Main: 232718336 06:34:29 INFO - PROCESS | 18061 | 06:34:32 INFO - PROCESS | 18061 | Cycle 1(1): loaded http://localhost:58916/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58916/tests/kraken/driver.html?testName=audio-dft) 06:34:32 INFO - PROCESS | 18061 | RSS: Main: 217657344 06:34:32 INFO - PROCESS | 18061 | 06:34:35 INFO - PROCESS | 18061 | Cycle 1(1): loaded http://localhost:58916/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58916/tests/kraken/driver.html?testName=audio-fft) 06:34:36 INFO - PROCESS | 18061 | RSS: Main: 299286528 06:34:36 INFO - PROCESS | 18061 | 06:34:38 INFO - PROCESS | 18061 | Cycle 1(1): loaded http://localhost:58916/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58916/tests/kraken/driver.html?testName=audio-oscillator) 06:34:39 INFO - PROCESS | 18061 | RSS: Main: 207675392 06:34:39 INFO - PROCESS | 18061 | 06:34:41 INFO - PROCESS | 18061 | Cycle 1(1): loaded http://localhost:58916/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58916/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:34:42 INFO - PROCESS | 18061 | RSS: Main: 213164032 06:34:42 INFO - PROCESS | 18061 | 06:34:45 INFO - PROCESS | 18061 | Cycle 1(1): loaded http://localhost:58916/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58916/tests/kraken/driver.html?testName=imaging-darkroom) 06:34:45 INFO - PROCESS | 18061 | RSS: Main: 249495552 06:34:45 INFO - PROCESS | 18061 | 06:34:48 INFO - PROCESS | 18061 | Cycle 1(1): loaded http://localhost:58916/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58916/tests/kraken/driver.html?testName=imaging-desaturate) 06:34:49 INFO - PROCESS | 18061 | RSS: Main: 248930304 06:34:49 INFO - PROCESS | 18061 | 06:34:52 INFO - PROCESS | 18061 | Cycle 1(1): loaded http://localhost:58916/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58916/tests/kraken/driver.html?testName=json-parse-financial) 06:34:52 INFO - PROCESS | 18061 | RSS: Main: 248422400 06:34:52 INFO - PROCESS | 18061 | 06:34:54 INFO - PROCESS | 18061 | Cycle 1(1): loaded http://localhost:58916/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58916/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:34:55 INFO - PROCESS | 18061 | RSS: Main: 210296832 06:34:55 INFO - PROCESS | 18061 | 06:34:56 INFO - PROCESS | 18061 | Cycle 1(1): loaded http://localhost:58916/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58916/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:34:57 INFO - PROCESS | 18061 | RSS: Main: 218570752 06:34:57 INFO - PROCESS | 18061 | 06:34:59 INFO - PROCESS | 18061 | Cycle 1(1): loaded http://localhost:58916/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58916/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:35:00 INFO - PROCESS | 18061 | RSS: Main: 222953472 06:35:00 INFO - PROCESS | 18061 | 06:35:02 INFO - PROCESS | 18061 | Cycle 1(1): loaded http://localhost:58916/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58916/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:35:03 INFO - PROCESS | 18061 | RSS: Main: 224501760 06:35:03 INFO - PROCESS | 18061 | 06:35:06 INFO - PROCESS | 18061 | Cycle 1(1): loaded http://localhost:58916/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58916/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:35:06 INFO - PROCESS | 18061 | RSS: Main: 222019584 06:35:06 INFO - PROCESS | 18061 | 06:35:08 INFO - PROCESS | 18061 | Cycle 1(1): loaded http://localhost:58916/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58916/tests/kraken/driver.html?testName=ai-astar) 06:35:08 INFO - PROCESS | 18061 | RSS: Main: 273072128 06:35:08 INFO - PROCESS | 18061 | 06:35:08 INFO - PROCESS | 18061 | __start_tp_report 06:35:08 INFO - PROCESS | 18061 | _x_x_mozilla_page_load 06:35:08 INFO - PROCESS | 18061 | _x_x_mozilla_page_load_details 06:35:08 INFO - PROCESS | 18061 | |i|pagename|runs| 06:35:08 INFO - PROCESS | 18061 | |0;ai-astar;108;110;111;111;111;109;111;111;110;111 06:35:08 INFO - PROCESS | 18061 | |1;audio-beat-detection;151;122;128;161;130;133;125;122;153;121 06:35:08 INFO - PROCESS | 18061 | |2;audio-dft;160;161;161;161;160;161;161;162;160;161 06:35:08 INFO - PROCESS | 18061 | |3;audio-fft;75;84;76;116;78;77;76;87;100;76 06:35:08 INFO - PROCESS | 18061 | |4;audio-oscillator;83;83;114;83;83;84;103;82;82;114 06:35:08 INFO - PROCESS | 18061 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;117;116;116 06:35:08 INFO - PROCESS | 18061 | |6;imaging-darkroom;146;146;146;146;146;146;145;145;146;145 06:35:08 INFO - PROCESS | 18061 | |7;imaging-desaturate;95;96;95;95;96;96;94;94;95;95 06:35:08 INFO - PROCESS | 18061 | |8;json-parse-financial;53;53;61;54;54;62;54;53;53;55 06:35:08 INFO - PROCESS | 18061 | |9;json-stringify-tinderbox;60;61;61;61;61;61;61;62;62;61 06:35:08 INFO - PROCESS | 18061 | |10;stanford-crypto-aes;88;88;82;80;84;79;80;79;79;79 06:35:08 INFO - PROCESS | 18061 | |11;stanford-crypto-ccm;132;128;136;127;132;130;130;141;167;132 06:35:08 INFO - PROCESS | 18061 | |12;stanford-crypto-pbkdf2;168;170;174;165;172;172;164;167;166;167 06:35:08 INFO - PROCESS | 18061 | |13;stanford-crypto-sha256-iterative;67;67;65;68;68;66;66;67;64;65 06:35:08 INFO - PROCESS | 18061 | __end_tp_report 06:35:08 INFO - PROCESS | 18061 | __start_cc_report 06:35:08 INFO - PROCESS | 18061 | _x_x_mozilla_cycle_collect,1668 06:35:08 INFO - PROCESS | 18061 | __end_cc_report 06:35:08 INFO - PROCESS | 18061 | __startTimestamp1475242508758__endTimestamp 06:35:08 INFO - PROCESS | 18061 | 06:35:08 INFO - PROCESS | 18061 | ------- Summary: start ------- 06:35:08 INFO - PROCESS | 18061 | Number of tests: 14 06:35:08 INFO - PROCESS | 18061 | 06:35:08 INFO - PROCESS | 18061 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:1.06 (1.0%) stddev-sans-first:0.73 06:35:08 INFO - PROCESS | 18061 | Values: 108.0 110.0 111.0 111.0 111.0 109.0 111.0 111.0 110.0 111.0 06:35:08 INFO - PROCESS | 18061 | 06:35:08 INFO - PROCESS | 18061 | [#1] audio-beat-detection Cycles:10 Average:134.60 Median:131.50 stddev:14.78 (11.2%) stddev-sans-first:14.44 06:35:08 INFO - PROCESS | 18061 | Values: 151.0 122.0 128.0 161.0 130.0 133.0 125.0 122.0 153.0 121.0 06:35:08 INFO - PROCESS | 18061 | 06:35:08 INFO - PROCESS | 18061 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 06:35:08 INFO - PROCESS | 18061 | Values: 160.0 161.0 161.0 161.0 160.0 161.0 161.0 162.0 160.0 161.0 06:35:08 INFO - PROCESS | 18061 | 06:35:08 INFO - PROCESS | 18061 | [#3] audio-fft Cycles:10 Average:84.50 Median:76.50 stddev:13.52 (17.7%) stddev-sans-first:13.89 06:35:08 INFO - PROCESS | 18061 | Values: 75.0 84.0 76.0 116.0 78.0 77.0 76.0 87.0 100.0 76.0 06:35:08 INFO - PROCESS | 18061 | 06:35:08 INFO - PROCESS | 18061 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:83.00 stddev:13.62 (16.4%) stddev-sans-first:14.12 06:35:08 INFO - PROCESS | 18061 | Values: 83.0 83.0 114.0 83.0 83.0 84.0 103.0 82.0 82.0 114.0 06:35:08 INFO - PROCESS | 18061 | 06:35:08 INFO - PROCESS | 18061 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 06:35:08 INFO - PROCESS | 18061 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 06:35:08 INFO - PROCESS | 18061 | 06:35:08 INFO - PROCESS | 18061 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 06:35:08 INFO - PROCESS | 18061 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 145.0 145.0 146.0 145.0 06:35:08 INFO - PROCESS | 18061 | 06:35:08 INFO - PROCESS | 18061 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 06:35:08 INFO - PROCESS | 18061 | Values: 95.0 96.0 95.0 95.0 96.0 96.0 94.0 94.0 95.0 95.0 06:35:08 INFO - PROCESS | 18061 | 06:35:08 INFO - PROCESS | 18061 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:54.00 stddev:3.39 (6.3%) stddev-sans-first:3.50 06:35:08 INFO - PROCESS | 18061 | Values: 53.0 53.0 61.0 54.0 54.0 62.0 54.0 53.0 53.0 55.0 06:35:08 INFO - PROCESS | 18061 | 06:35:08 INFO - PROCESS | 18061 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.44 06:35:08 INFO - PROCESS | 18061 | Values: 60.0 61.0 61.0 61.0 61.0 61.0 61.0 62.0 62.0 61.0 06:35:08 INFO - PROCESS | 18061 | 06:35:08 INFO - PROCESS | 18061 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:81.00 stddev:3.65 (4.5%) stddev-sans-first:3.10 06:35:08 INFO - PROCESS | 18061 | Values: 88.0 88.0 82.0 80.0 84.0 79.0 80.0 79.0 79.0 79.0 06:35:08 INFO - PROCESS | 18061 | 06:35:08 INFO - PROCESS | 18061 | [#11] stanford-crypto-ccm Cycles:10 Average:135.50 Median:132.00 stddev:11.78 (8.9%) stddev-sans-first:12.42 06:35:08 INFO - PROCESS | 18061 | Values: 132.0 128.0 136.0 127.0 132.0 130.0 130.0 141.0 167.0 132.0 06:35:08 INFO - PROCESS | 18061 | 06:35:08 INFO - PROCESS | 18061 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.50 Median:169.00 stddev:3.34 (2.0%) stddev-sans-first:3.54 06:35:08 INFO - PROCESS | 18061 | Values: 168.0 170.0 174.0 165.0 172.0 172.0 164.0 167.0 166.0 167.0 06:35:08 INFO - PROCESS | 18061 | 06:35:08 INFO - PROCESS | 18061 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:67.00 stddev:1.34 (2.0%) stddev-sans-first:1.39 06:35:08 INFO - PROCESS | 18061 | Values: 67.0 67.0 65.0 68.0 68.0 66.0 66.0 67.0 64.0 65.0 06:35:08 INFO - PROCESS | 18061 | -------- Summary: end -------- 06:35:08 INFO - PROCESS | 18061 | 06:35:09 INFO - TEST-INFO | 18061: exit 0 06:35:10 INFO - TEST-OK | kraken | took 62230ms 06:35:10 INFO - SUITE-END | took 1177s 06:35:10 INFO - Completed test suite (00:19:38) 06:35:10 INFO - javascript benchmark 06:35:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2938.2654336415894, 2970.91087267382, 2971.554266859972, 3004.0537230772293, 3020.8640611172495, 5102.923456148152, 5123.743812809364, 5147.5624571911385, 5170.586353091758, 5205.453427390126, 5130.358705161855, 5208.635395522315, 5228.241904923784, 5243.370795504545, 5270.288511051007, 4736.97631511842, 4749.287606858981, 4750.596199323062, 4810.350602668647, 4866.46468888422, 4843.297721830332, 4889.755512224392, 4892.584130348924, 4920.926186107211, 4934.4572097069295, 4656.650751193674, 4698.08387364464, 4740.881477963044, 4813.927791083119, 4814.759262036884, 4697.906041879143, 4746.074515469485, 4748.240281554935, 4754.833580824655, 4819.1325561398935, 4660.37084993525, 4683.765811709401, 4686.625069994392, 4715.198416269242, 4749.715017098985, 5078.568321692661, 5185.922211166836, 5195.6622819516615, 5198.870028249286, 5250.238715386286, 5434.7826086956475, 5508.0, 5539.335279766414, 5543.307086614173, 5619.915701264485, 5573.804916827932, 5578.665280083208, 5588.804391846266, 5593.049181639131, 5601.215829783833, 5240.842774716764, 5243.9213411798855, 5245.527902488794, 5248.737563121828, 5308.044551980681, 5534.308211473566, 5581.302337207849, 5581.609287349927, 5622.606417550814, 5655.208270842003, 5469.343678758574, 5471.042567550663, 5473.67157970523, 5534.778608855681, 5536.75084621193, 5488.1767734839295, 5492.231087647732, 5527.115661494142, 5548.223248745179, 5556.749946252347, 5407.810726624549, 5455.727213639381, 5529.972350138304, 5532.059549876531, 5592.552595792326, 5466.945330546723, 5512.834614961557, 5528.087865502147, 5543.750531226105, 5597.776088956478, 4297.269464191095, 4305.849295274713, 4306.547812479707, 4326.545712700184, 4359.564043595678, 3844.942325865114, 3857.8456861725776, 3877.728559000899, 3912.0, 3920.294347017564, 5220.0, 5238.580913526908, 5242.633015688865, 5267.0, 5344.5724342052545, 5568.192612071227, 5578.888422231533, 5579.944200558024, 5585.636933599303, 5588.86027849307, 5230.895382092337, 5257.106291930381, 5311.28297679816, 5312.1766126250495, 5376.059189641797, 4743.0, 4779.283107533828, 4799.0401919616215, 4800.447948485899, 4801.327814106028, 5672.688002159838, 5674.631148975303, 5677.2903387075785, 5683.488486036276, 5733.655980641175, 5445.40100588927, 5473.616846820684, 5565.220869078251, 5570.108782594765, 5575.080111781511, 5667.716614169358, 5704.401037891128, 5711.228984087095, 5736.053551164011, 5737.635899848899, 5436.130219164915, 5464.508194262536, 5472.151816468454, 5496.422875598005, 5557.499825015768, 5530.115181570929, 5585.357683866408, 5589.944100558942, 5594.16087586849, 5595.07681232592, 5282.392524859691, 5433.809816656398, 5443.319585051869, 5445.967421533477, 5495.53287970511, 5308.309919710413, 5387.0572649785345, 5413.593980451403, 5419.647722897999, 5505.807296744595, 5368.060589396762, 5372.0, 5376.381716102698, 5376.596755243294, 5378.838634840961, 5420.593455490933, 5456.072467680583, 5470.72646367688, 5472.50747432733, 5534.695591742332, 5144.742762861767, 5188.584913206859, 5259.158534634593, 5304.867378315419, 5307.336582927134], "value": 5127.828883223875, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.4602992232184, 609.7469550136693, 617.3178637605446, 635.6853357587993, 636.9331220221874, 32304.192395190134, 42404.57595424045, 43280.78359608205, 43416.56583434164, 43477.0, 44987.325190122094, 45460.54539454613, 45463.54536454634, 45482.63243145962, 45489.7725511372, 8153.592320383987, 9039.819203615923, 9186.26509879208, 9192.264618830477, 9192.448453092802, 8014.879776803353, 8311.0, 8315.126911674248, 10204.183665306795, 10541.0, 11040.613578524753, 11091.889081109206, 11095.667129986114, 11101.666949991513, 11103.44482775862, 10669.253152279343, 10730.409827459487, 10730.839037414446, 10742.3017503862, 10745.731356716067, 8024.598770061532, 8255.793605159859, 10310.226732995055, 10670.093042091432, 10693.625723099733, 42606.57393426088, 42847.0, 42847.785761071, 42893.78553107214, 42898.0, 3342.8997130086136, 3448.2758620689683, 3511.052015955703, 3548.538689970313, 3776.999095239764, 29985.250368740737, 32470.35059298801, 32508.674913251038, 32571.160056388188, 34120.82939585286, 4186.246475634384, 4187.539370669224, 4235.661147108224, 4251.9787401062795, 4342.174986752507, 314221.0, 315512.0, 317277.9999999977, 317368.0, 320019.0, 57496.712516437154, 57638.7118064407, 58009.0, 58025.0, 58026.0, 61628.0, 61667.69166154141, 61685.07472387918, 61695.6915215421, 61698.0, 15997.680046399008, 16410.425635102714, 16411.261493232832, 16427.425040123537, 16430.83569164293, 11322.886771132347, 12272.38638068093, 12286.877131228752, 12290.631281061404, 12299.262044277371, 16137.435189768301, 17933.551661208574, 18226.817731822513, 18332.54168645768, 18997.335093271668, 6969.407600353925, 7109.92890071103, 7140.5358651687475, 7155.212926578072, 7195.424366050704, 956.4691596164057, 990.8110267678815, 1005.1908213887745, 1074.1728868771002, 1075.6504136155781, 30972.0, 31927.680723192934, 31995.840020799747, 32814.0, 34699.82650086733, 1020.4438580973388, 1064.5050051725984, 1069.7967386196597, 1086.8697353187683, 1139.3050239353988, 15735.370585176464, 16204.75692864608, 16470.505884823473, 16685.332586696397, 16742.953026797888, 539916.0, 546752.0, 546764.0, 546813.0, 547665.0, 48597.0, 49233.50766492361, 51025.234621480704, 52683.0, 56168.59578510488, 1312.193001304191, 1319.5843309357713, 1342.7851543753147, 1377.0498356134235, 1380.1149763415951, 29470.705292946797, 30536.389272214874, 30657.540136897518, 30872.0, 31066.223344415666, 48814.267785983946, 49619.50380496149, 49712.751436242586, 49821.501784983135, 49822.0, 435343.0, 437882.0, 444696.0, 681960.0, 688493.0, 41896.790516048444, 42049.0, 42113.36829947492, 42426.78786606047, 42478.362824557036, 46999.53000469952, 47125.764371177924, 47200.391945128395, 47769.76115119402, 48148.27777583409, 39577.051301189, 40594.391084133174, 41021.38467922924, 41745.0, 42213.57786422219, 40525.594744053364, 40871.0, 41058.794706027475, 41976.790116049226, 42155.57844421639, 40287.597124029555, 41229.587704123776, 41398.37902431526, 41632.3755143667, 41701.37447938344, 34195.82902085473, 36313.0, 36897.0, 37041.62958370382, 37195.44206836846, 27330.590041149, 27547.311317216427, 27600.585991210548, 27947.580786287814, 27986.440271194868], "value": 20472.246616247816, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.5088005752204, 373.65250317205, 374.75266324226016, 379.8727426312185, 405.5559162716826, 13946.721065578682, 18292.176852041674, 18742.90628546857, 19685.50786230345, 20001.899990500064, 18218.908905455453, 19107.0, 19151.329703460382, 19302.613947721038, 19307.806921930776, 5527.170924361348, 5808.535317174616, 5812.3025236971625, 5814.767409303623, 5852.385499522553, 4166.604172603597, 4521.909561808779, 5712.028955077647, 6397.232332120152, 6398.616083035009, 6292.5595208335435, 6479.708413121397, 6484.578502397353, 6486.805395838132, 6523.739050437976, 6341.302456729756, 6388.105665206875, 6393.552451328409, 6422.068800023971, 6442.871142577145, 5484.91772623411, 5596.356419011825, 5623.915641265385, 5628.718564071821, 5658.915116273218, 22597.096116155335, 22855.0, 23007.424814379607, 23061.538769224688, 23217.53564928709, 2383.4398916254668, 2450.3139121046133, 2562.705288891783, 2713.4573085383004, 2968.643762748484, 14045.719085618333, 14189.787153192607, 14270.928645356707, 14296.785548216785, 14861.479848205368, 1904.7619047619048, 1942.9028548572514, 1949.4444083436154, 2006.0972562346856, 2010.939671809848, 80144.0, 81209.0, 81720.59139704263, 83138.58430707808, 84035.15964840335, 10625.9468702656, 10886.29239099456, 10929.234953553334, 10980.231383803057, 11070.723231919106, 15617.60955976087, 15646.687066258839, 15653.139077350626, 15658.530244092695, 15669.981451205635, 7637.0, 7879.33025692811, 7966.721164759206, 8117.391195660349, 8206.302464290482, 7489.363404110712, 7515.473916825769, 7626.58053807046, 7766.922330776733, 7816.101148367897, 4676.69601475903, 4699.95300047002, 4710.599599034121, 4726.1020406122725, 4764.523547645277, 1919.5680971781237, 1957.628050670368, 1996.241428257253, 1999.2702663527707, 2005.8194762471155, 850.9319254459629, 876.3952872517942, 895.7939673874915, 1003.3578509753763, 1032.695354870315, 17848.375306864196, 18584.349547765763, 18706.625867482846, 18968.241270349306, 19416.4175074748, 976.077606661712, 982.9459379734184, 984.9015098490094, 1021.1779517488493, 1059.9682009539572, 9924.553395097239, 10078.344907580984, 10573.841392379121, 10674.412907290018, 10762.300450470695, 403661.0, 407955.0, 413695.0, 413798.0, 428448.0, 87392.56303718568, 88354.11645883459, 88802.55598721965, 89779.55110224537, 90763.0, 920.9493477858782, 948.672707915768, 964.2719746591279, 965.290511474066, 969.9224062075017, 16192.109433981244, 16540.255688494286, 16854.915725421295, 17069.5481414288, 17140.228689708743, 39883.40174897437, 40544.1891162181, 40843.795781020905, 40906.0, 42072.789636051624, 55010.44989550053, 55288.26810647618, 56152.71923640356, 56690.433095668515, 57948.4205157943, 8257.710980115668, 8450.408471406943, 8566.443181193203, 8589.484630922165, 8656.567171641267, 12086.972607328124, 12546.749065018466, 12698.174618650128, 12794.040446966701, 12888.871111288767, 7244.818879528054, 11172.441377931233, 11443.542258309908, 11590.246633968765, 11666.108615149295, 10988.0, 11324.150688698546, 11484.0, 11632.243904146204, 11711.414429278331, 11325.603603873826, 11623.941880290544, 11814.409279536161, 11891.28652280866, 11982.161248712855, 8474.27968622674, 8481.830363392573, 8535.743927682179, 8653.524056176971, 8876.556172191495, 9584.472853993097, 10871.565137394417, 11041.889581104086, 11200.21598488098, 11549.422528873354], "value": 9173.486721789877, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1338.8795008449238, 1449.7028109237608, 1478.48253111411, 1581.5018269245186, 1716.6309243512642, 7627.92372076279, 8397.118302578234, 8672.783180420492, 8764.91235087649, 8961.596728147233, 8757.693480728176, 8806.163414475615, 8878.112188781119, 8886.822263554724, 8905.643774249038, 2356.2695564375013, 2390.988045059772, 2391.85648861068, 2395.2574701842395, 2395.8203134764876, 2315.4442933695877, 2367.9052837886466, 2403.8677872716994, 2405.194259922928, 2407.735149133594, 2329.7320808107115, 2340.0990618611872, 2361.9291421257303, 2406.1698713943747, 2406.927792166238, 2306.238941149417, 2313.6645186447954, 2320.3966968588206, 2333.894974726133, 2381.404648837791, 2285.874276914769, 2324.93025209244, 2329.650552417134, 2338.38032921276, 2344.367020904346, 8805.25155361795, 8887.0, 8895.0, 8898.86651700225, 8903.0, 5137.845864624067, 5296.496832800916, 5303.071962406602, 5373.328333958255, 5375.247465354853, 3287.736981041535, 3467.3065386922717, 3517.43721004638, 3532.5760908690863, 3547.787132772042, 1007.4360703153251, 1053.7312985188728, 1055.2665897201448, 1074.2265568790458, 1075.2849355178796, 12326.63020109407, 12455.564055258114, 12537.43581538833, 12553.686157846036, 12581.433835477426, 4280.208161490134, 4529.184746745617, 4566.908661826745, 4689.6717229793585, 4728.668993170445, 9762.17021553176, 9788.951055244679, 9793.069658382443, 9805.166560842266, 9806.16647584949, 5168.870778230499, 5178.067947769362, 5201.505856943584, 5217.373915130132, 5238.633295669267, 4210.473690788652, 4340.178883725604, 4357.3899654048455, 4465.464144302705, 4856.465788763304, 3520.6479352065103, 3804.9429258561145, 3811.733178677521, 3845.1925095729653, 3856.1902000580194, 1101.4107452512867, 1133.824257240129, 1143.1940481960364, 1149.4942225420955, 1149.9425028748528, 788.7673136424769, 865.9220670139717, 887.3123329419623, 943.235978857128, 957.6552441121191, 5916.136417028622, 5920.319163296276, 5944.554158438134, 5961.433663801932, 6278.905816412757, 933.5285680731188, 935.0929598289648, 943.2689665509148, 949.1789601994225, 971.7424882406168, 3895.870197642652, 4136.8138433770555, 4223.957760422418, 4235.4917409911, 4335.284678028153, 10932.781344373068, 11319.151063670257, 11370.431478426046, 11443.771124577463, 11456.427178641035, 11310.491027903765, 11314.321140731583, 11317.49071291794, 11372.886271137348, 11385.772284554429, 7869.960650196713, 8029.397795165386, 8184.304334131665, 8323.250907418362, 8326.0, 5942.257217847769, 5955.642661440327, 5961.493273071664, 6012.6392416455155, 6250.4374606285655, 10212.897871021492, 10260.897391025994, 10273.537690803782, 10290.12533934624, 10419.479026048819, 8923.643054277756, 9951.601935922483, 10282.126019288444, 10303.0, 10454.790904181722, 7311.3785328247695, 7758.107817601048, 7874.488158269694, 7979.800504987422, 8004.039515257973, 8474.915250847413, 8476.49141051539, 8605.096464871098, 8618.569071546272, 8679.218870301704, 7515.436342274242, 7545.962270188614, 7847.529148251123, 7853.371730261451, 7870.173631768582, 7668.846623067619, 7669.0, 7689.6539655714505, 7720.150783413932, 7812.53124812513, 6842.93157068423, 6887.827804304932, 6902.585844849325, 6931.7227310907, 6942.062821519232, 5126.2054381570915, 5245.921311180412, 5251.107311756934, 5310.468953104659, 5356.464353564613, 4992.925106123338, 5021.874453138555, 5089.796408143633, 5160.922586161286, 5181.093308671043], "value": 4610.692475316032, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.74927180706754, 328.79943234626876, 334.72218059011016, 337.86485405837664, 343.9965600343999, 5185.585153187745, 5272.9209061864, 5316.415194328625, 5362.1420572708375, 5364.088105022151, 5061.493850614946, 5154.974225128878, 5207.489827949899, 5253.86865328367, 5262.789488420468, 4173.853915112972, 4176.874693759177, 4198.286291330466, 4222.97888510557, 4260.808263628144, 4072.5520192778918, 4210.473690788652, 4217.683673724468, 4229.6404805591565, 4268.7225330353585, 4153.626173644371, 4183.414321994923, 4195.62239398454, 4200.390943313218, 4200.537940826506, 4170.9582904171175, 4178.307785346924, 4188.973701443136, 4208.326667733163, 4210.842018444952, 3776.0, 3781.9054523636855, 3789.8484060637543, 3802.7147963902817, 3823.3118038753014, 5083.79664813407, 5199.896002079975, 5209.515288142861, 5215.322008138955, 5260.8684782880355, 4816.638752093572, 4824.565789078964, 4839.0, 4840.878978025542, 4859.173940430135, 5368.12115759485, 5507.807226747084, 5508.245877061469, 5542.168674698787, 5543.279373681436, 3984.9601503984877, 4008.358662613997, 4015.4980627421573, 4020.5175378954714, 4029.703069250528, 5677.772889084432, 5704.429557044304, 5705.286839145107, 5721.656700597978, 5730.312362516483, 4165.812538435777, 4174.499060112806, 4213.662906967435, 4229.915401691949, 4230.878817113467, 4103.876883693494, 4211.663066954637, 4214.768187749642, 4233.068724880522, 4264.997725534497, 4734.621230301567, 4736.952630473651, 4743.075100355467, 4772.260299653559, 4784.832530861403, 5543.722813859291, 5543.750531226105, 5559.583031272671, 5563.972180139073, 5584.329880414376, 1418.3546486348687, 1463.751162302411, 1468.7588987305924, 1472.124086168728, 1477.9113253204841, 928.945646690997, 953.1278879824882, 960.2366118935463, 967.970960871175, 969.5733877094056, 4709.976450117796, 4755.358026666356, 4772.308015337757, 4775.952240477551, 4780.259059845729, 4976.253561965734, 4987.476314986947, 5013.649044566918, 5022.0, 5030.44056342535, 4446.3552784846015, 4741.028089241697, 4755.881102972453, 4785.712857228577, 4854.854354369375, 2657.86710664466, 2669.958716100722, 2677.3039009857575, 2679.209633158223, 2698.7706044986003, 5154.737089413118, 5173.63784535079, 5187.325647665854, 5221.973890130601, 5228.144008876794, 5075.289459475676, 5129.410117836422, 5130.589552835764, 5373.9731301343245, 5795.797147099831, 5809.82570522885, 5822.592418530747, 5833.445822646841, 5922.585419020627, 5945.702714864239, 5736.340320863154, 5740.789795928681, 5763.8559036024435, 5782.508486778503, 5808.564357673107, 5455.563554915518, 5578.77267001259, 5662.915056274242, 5666.46168613981, 5737.799177028784, 5887.558433117619, 5888.882222355614, 5890.322612899571, 5897.498712609477, 5913.763449461973, 3785.8074706467373, 3798.2593394287846, 4107.342825147962, 4127.422160897537, 4130.401091841726, 5652.3217213934595, 5653.0, 5657.60396772222, 5685.886282274414, 5717.828465146053, 5471.467988963097, 5475.5072043516275, 5501.257330260363, 5502.862428439321, 5505.229267902417, 5323.866903327448, 5438.700871452108, 5460.890782184255, 5486.149646804752, 5549.916751248816, 5398.514133727984, 5418.810341638182, 5419.187121931742, 5436.891262174813, 5439.782408703608, 5469.234307197075, 5534.225208470898, 5560.471755183251, 5577.0, 5638.407967163389, 5432.837014889559, 5455.9454405455435, 5460.235567020541, 5465.890682186255, 5490.670559766427], "value": 4180.607685347379, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.3097261142998, 740.1044735869598, 778.8208711996244, 779.2986312318912, 811.290121143999, 15054.84945150548, 16591.0, 16593.336266549322, 16661.750073748903, 16666.749998750027, 14672.0, 14859.554213373589, 14943.252837358143, 14985.475508357209, 15001.849981500181, 646.983825404364, 662.6620423583983, 764.9426293028031, 788.8698364769806, 793.2543409195367, 766.1457474915456, 779.5751315533048, 783.9451238413313, 791.635847510146, 791.6912404162381, 839.2991851803752, 840.5755093677715, 840.9579521023925, 841.5077179849795, 841.7516832534386, 681.9624920629363, 829.2826704900248, 833.170994860112, 833.3916241143999, 833.7207035643066, 513.1046324164357, 589.6491587505427, 599.0953659973471, 600.0129786501182, 604.5979423683245, 14399.280035998263, 14421.495247666386, 14435.855641443557, 14436.278186090758, 14451.060681055698, 12845.35773211345, 13180.604581862559, 13374.79937800924, 13579.796303055462, 13792.93103534486, 11745.412729363583, 11892.286462812259, 11928.40357982106, 12111.333876636869, 12571.559995400117, 4203.117345357478, 4322.308430651081, 4380.145871555048, 4398.274284743045, 4501.932471012938, 76269.61865190695, 76558.0, 78460.60769696173, 80688.0, 81321.18678813195, 10658.62694805678, 11032.338059716443, 11098.056665183389, 11098.2786118902, 11293.0, 20098.296559620343, 20420.89789551043, 20461.89769051175, 20465.59068818645, 20477.180912763324, 7809.882851757228, 7866.370690344758, 8080.676772929134, 8158.0, 8165.591720413956, 4514.367988481616, 4735.526447355306, 4764.99935013651, 4798.2322828348, 4806.639502037361, 3478.3912815257227, 3546.37938360791, 3586.9239228231427, 3610.6750392464805, 3611.2416392557334, 609.1502354215933, 614.695725615823, 627.4447114303782, 631.6904716688881, 636.2460484326089, 598.9910151347733, 602.6305616953015, 639.536336156283, 640.6316368088368, 648.8183308673579, 8723.781905452415, 8922.509261990523, 9011.459312441275, 9031.729048128434, 9402.341836071546, 634.8857205703018, 638.2341190571241, 641.4323323858325, 652.0968458684756, 692.4564217089661, 4560.156371071363, 4602.286645569942, 4659.394278743742, 4691.741954192552, 4715.669903106749, 89953.55023224842, 92414.53792730994, 94506.0, 120318.0, 124439.3778031104, 94678.5266073679, 96324.0, 96592.0, 97347.51326243323, 97979.0, 80504.59747701224, 80595.59702201451, 82233.58883205545, 83834.0, 84534.57732711297, 9800.509974501389, 9843.704688859345, 10013.799724005625, 10324.741881453023, 10395.636152734618, 49763.0, 50277.24584131168, 50323.49676503335, 51293.48706512887, 51448.48551514437, 69456.65271673811, 71874.64062679654, 75516.22418879144, 75546.62226688831, 76034.61982690051, 12744.872551274739, 12761.234325940473, 12824.615261542169, 12898.67753306175, 13177.209367437985, 14260.215688136837, 14502.85497145015, 14898.32957516936, 14900.552983410515, 15113.622159445662, 13400.128991615515, 13594.660133496742, 13688.315584220949, 14040.227787471787, 14114.858851411354, 13457.528986485426, 13754.793678094637, 13877.791833122714, 14233.430662773373, 14283.500077497238, 12871.163374380636, 13335.266560339274, 13366.0, 13411.530596429078, 13553.728925421634, 11052.11583073336, 11373.545058197911, 11408.258463199865, 11623.0, 11866.288022718665, 11373.374464404536, 11377.573914344384, 11418.371989540656, 11706.1220408468, 11763.411829408666], "value": 7420.99090940179, "unit": "score"}], "name": "dromaeo_css", "value": 7186.620264111391, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 111.0, 111.0, 111.0, 109.0, 111.0, 111.0, 110.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 122.0, 128.0, 161.0, 130.0, 133.0, 125.0, 122.0, 153.0, 121.0], "value": 134.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 161.0, 160.0, 161.0, 161.0, 162.0, 160.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 84.0, 76.0, 116.0, 78.0, 77.0, 76.0, 87.0, 100.0, 76.0], "value": 84.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 114.0, 83.0, 83.0, 84.0, 103.0, 82.0, 82.0, 114.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 146.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 94.0, 94.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 61.0, 54.0, 54.0, 62.0, 54.0, 53.0, 53.0, 55.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 61.0, 61.0, 61.0, 62.0, 62.0, 61.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 82.0, 80.0, 84.0, 79.0, 80.0, 79.0, 79.0, 79.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 128.0, 136.0, 127.0, 132.0, 130.0, 130.0, 141.0, 167.0, 132.0], "value": 135.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 170.0, 174.0, 165.0, 172.0, 172.0, 164.0, 167.0, 166.0, 167.0], "value": 168.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 65.0, 68.0, 68.0, 66.0, 66.0, 67.0, 64.0, 65.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1507.2, "alertThreshold": 2.0}]} 06:35:10 INFO - Return code: 0 06:35:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:35:10 INFO - # TBPL SUCCESS # 06:35:10 INFO - Running post-action listener: _resource_record_post_action 06:35:10 INFO - [mozharness: 2016-09-30 13:35:10.574975Z] Finished run-tests step (success) 06:35:10 INFO - Running post-run listener: _resource_record_post_run 06:35:10 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392830976; Read time: 20; Write time: 242460 06:35:10 INFO - TinderboxPrint: CPU usage
13.1% 06:35:10 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 06:35:10 INFO - TinderboxPrint: I/O write bytes / time
392,830,976 / 242,460 06:35:10 INFO - TinderboxPrint: CPU idle
8,294.3 (86.9%) 06:35:10 INFO - TinderboxPrint: CPU user
1,198.3 (12.6%) 06:35:10 INFO - TinderboxPrint: Swap in / out
0 / 0 06:35:10 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103747584; Read time: 0; Write time: 80228 06:35:10 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 289083392; Read time: 0; Write time: 162232 06:35:11 INFO - Running post-run listener: _upload_blobber_files 06:35:11 INFO - Blob upload gear active. 06:35:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:35:11 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 06:35:11 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:35:11 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:35:11 INFO - (blobuploader) - INFO - Open directory for files ... 06:35:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:35:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:35:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:35:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:35:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:35:14 INFO - (blobuploader) - INFO - Done attempting. 06:35:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:35:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:35:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:35:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:35:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:35:16 INFO - (blobuploader) - INFO - Done attempting. 06:35:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:35:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:35:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:35:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:35:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:35:17 INFO - (blobuploader) - INFO - Done attempting. 06:35:17 INFO - (blobuploader) - INFO - Iteration through files over. 06:35:17 INFO - Return code: 0 06:35:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:35:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:35:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bf258864179a9f14a0252c7973f21397dc0b7930c35c2b63b262a4727f4d55c06f92b2c3b682b404d689ca5b8858ac541dcac44cb38757da133d8fa0c740fd61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/07f6eb86e239137fa6aad962d075c8793508cb92e9b9e2f83bc3376c887a4d9f7a004f27b87a58b020ae965e4c78784bd5fc29ab0b28006a585e9d7067af85e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4025281ada40255df290513a9559e2d88f9f88459c346d3162719abb82276769bab58f0cd99e4ee5d63b040929c4739fa02900fbe0638675900b4dc511893858"} 06:35:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:35:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:35:17 INFO - Contents: 06:35:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/bf258864179a9f14a0252c7973f21397dc0b7930c35c2b63b262a4727f4d55c06f92b2c3b682b404d689ca5b8858ac541dcac44cb38757da133d8fa0c740fd61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/07f6eb86e239137fa6aad962d075c8793508cb92e9b9e2f83bc3376c887a4d9f7a004f27b87a58b020ae965e4c78784bd5fc29ab0b28006a585e9d7067af85e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4025281ada40255df290513a9559e2d88f9f88459c346d3162719abb82276769bab58f0cd99e4ee5d63b040929c4739fa02900fbe0638675900b4dc511893858"} 06:35:17 INFO - Running post-run listener: copy_logs_to_upload_dir 06:35:17 INFO - Copying logs to upload dir... 06:35:17 INFO - mkdir: /builds/slave/test/build/upload/logs 06:35:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.845495 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-09-30 06:35:17.432365) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-30 06:35:17.437733) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1475241128.942430-341232885 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/sha512/bf258864179a9f14a0252c7973f21397dc0b7930c35c2b63b262a4727f4d55c06f92b2c3b682b404d689ca5b8858ac541dcac44cb38757da133d8fa0c740fd61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/07f6eb86e239137fa6aad962d075c8793508cb92e9b9e2f83bc3376c887a4d9f7a004f27b87a58b020ae965e4c78784bd5fc29ab0b28006a585e9d7067af85e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4025281ada40255df290513a9559e2d88f9f88459c346d3162719abb82276769bab58f0cd99e4ee5d63b040929c4739fa02900fbe0638675900b4dc511893858"} build_url:https://queue.taskcluster.net/v1/task/X44qMvJtRFGIVR4EX4YObA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011240 build_url: 'https://queue.taskcluster.net/v1/task/X44qMvJtRFGIVR4EX4YObA/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/sha512/bf258864179a9f14a0252c7973f21397dc0b7930c35c2b63b262a4727f4d55c06f92b2c3b682b404d689ca5b8858ac541dcac44cb38757da133d8fa0c740fd61", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/07f6eb86e239137fa6aad962d075c8793508cb92e9b9e2f83bc3376c887a4d9f7a004f27b87a58b020ae965e4c78784bd5fc29ab0b28006a585e9d7067af85e4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4025281ada40255df290513a9559e2d88f9f88459c346d3162719abb82276769bab58f0cd99e4ee5d63b040929c4739fa02900fbe0638675900b4dc511893858"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-30 06:35:17.463166) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 06:35:17.463564) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1475241128.942430-341232885 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004547 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-30 06:35:17.548166) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 06:35:17.548521) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-30 06:35:17.548845) ========= ========= Total master_lag: 0.17 =========