builder: cedar_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-012 starttime: 1478527490.94 results: success (0) buildid: 20161107041537 builduid: a04dca672c164725a9b45b381a1f895c revision: 36b139f0c1300e703ab80a1ef58f56bbc55d87e4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-07 06:04:50.936791) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-07 06:04:50.937234) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-07 06:04:50.937509) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-07 06:04:50.951994) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 06:04:50.952271) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1478527490.604500-1100081964 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-07 06:04:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 215M=0s 2016-11-07 06:04:51 (215 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129906 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 06:04:51.095795) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 06:04:51.096152) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1478527490.604500-1100081964 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019727 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 06:04:51.148444) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-07 06:04:51.149093) ========= bash -c 'python archiver_client.py mozharness --repo projects/cedar --rev 36b139f0c1300e703ab80a1ef58f56bbc55d87e4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/cedar --rev 36b139f0c1300e703ab80a1ef58f56bbc55d87e4 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1478527490.604500-1100081964 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-07 06:04:51,505 truncating revision to first 12 chars 2016-11-07 06:04:51,505 Setting DEBUG logging. 2016-11-07 06:04:51,505 attempt 1/10 2016-11-07 06:04:51,506 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/36b139f0c130?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-07 06:04:52,286 unpacking tar archive at: cedar-36b139f0c130/testing/mozharness/ program finished with exit code 0 elapsedTime=1.110342 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-07 06:04:52.272763) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-07 06:04:52.273092) ========= script_repo_revision: 36b139f0c1300e703ab80a1ef58f56bbc55d87e4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-07 06:04:52.273469) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-07 06:04:52.273736) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-07 06:04:52.283084) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-11-07 06:04:52.283351) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 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', 'Cedar', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Cedar'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1478527490.604500-1100081964 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:04:52 INFO - MultiFileLogger online at 20161107 06:04:52 in /builds/slave/test 06:04:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 06:04:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:04:52 INFO - {'append_to_log': False, 06:04:52 INFO - 'base_work_dir': '/builds/slave/test', 06:04:52 INFO - 'blob_upload_branch': 'Cedar', 06:04:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:04:52 INFO - 'branch': 'Cedar', 06:04:52 INFO - 'buildbot_json_path': 'buildprops.json', 06:04:52 INFO - 'config_files': ('talos/linux_config.py',), 06:04:52 INFO - 'default_actions': ('clobber', 06:04:52 INFO - 'read-buildbot-config', 06:04:52 INFO - 'download-and-extract', 06:04:52 INFO - 'populate-webroot', 06:04:52 INFO - 'create-virtualenv', 06:04:52 INFO - 'install', 06:04:52 INFO - 'run-tests'), 06:04:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:04:52 INFO - 'download_minidump_stackwalk': True, 06:04:52 INFO - 'download_symbols': 'ondemand', 06:04:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:04:52 INFO - 'tooltool.py': '/tools/tooltool.py', 06:04:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:04:52 INFO - '/tools/misc-python/virtualenv.py')}, 06:04:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:04:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:04:52 INFO - 'installer_path': 'installer.exe', 06:04:52 INFO - 'log_level': 'info', 06:04:52 INFO - 'log_name': 'talos', 06:04:52 INFO - 'log_to_console': True, 06:04:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:04:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:04:52 INFO - 'opt_config_files': (), 06:04:52 INFO - 'pip_index': False, 06:04:52 INFO - 'sps_profile': False, 06:04:52 INFO - 'sps_profile_interval': 0, 06:04:52 INFO - 'suite': 'dromaeojs', 06:04:52 INFO - 'system_bits': '32', 06:04:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:04:52 INFO - 'title': 'talos-linux64-ix-012', 06:04:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:04:52 INFO - 'use_talos_json': True, 06:04:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:04:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:04:52 INFO - 'work_dir': 'build'} 06:04:52 INFO - [mozharness: 2016-11-07 14:04:52.741578Z] Running clobber step. 06:04:52 INFO - Running pre-action listener: _resource_record_pre_action 06:04:52 INFO - Running main action method: clobber 06:04:52 INFO - rmtree: /builds/slave/test/build 06:04:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:04:53 INFO - Running post-action listener: _resource_record_post_action 06:04:53 INFO - [mozharness: 2016-11-07 14:04:53.196317Z] Finished clobber step (success) 06:04:53 INFO - [mozharness: 2016-11-07 14:04:53.196416Z] Running read-buildbot-config step. 06:04:53 INFO - Running pre-action listener: _resource_record_pre_action 06:04:53 INFO - Running main action method: read_buildbot_config 06:04:53 INFO - Using buildbot properties: 06:04:53 INFO - { 06:04:53 INFO - "project": "", 06:04:53 INFO - "product": "firefox", 06:04:53 INFO - "script_repo_revision": "default", 06:04:53 INFO - "builddir": "cedar_ubuntu64_hw_test-dromaeojs", 06:04:53 INFO - "repository": "", 06:04:53 INFO - "buildername": "Ubuntu HW 12.04 x64 cedar talos dromaeojs", 06:04:53 INFO - "buildid": "20161107041537", 06:04:53 INFO - "pgo_build": "False", 06:04:53 INFO - "basedir": "/builds/slave/test", 06:04:53 INFO - "buildnumber": 2, 06:04:53 INFO - "slavename": "talos-linux64-ix-012", 06:04:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:04:53 INFO - "platform": "ubuntu64_hw", 06:04:53 INFO - "scheduler": "tests-cedar-linux64-talos", 06:04:53 INFO - "branch": "cedar", 06:04:53 INFO - "repo_path": "projects/cedar", 06:04:53 INFO - "revision": "36b139f0c1300e703ab80a1ef58f56bbc55d87e4", 06:04:53 INFO - "stage_platform": "linux64", 06:04:53 INFO - "builduid": "a04dca672c164725a9b45b381a1f895c", 06:04:53 INFO - "slavebuilddir": "test" 06:04:53 INFO - } 06:04:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/DRqMyzKkQeWA72Fj33Bcrw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 06:04:53 INFO - Running post-action listener: _resource_record_post_action 06:04:53 INFO - [mozharness: 2016-11-07 14:04:53.198838Z] Finished read-buildbot-config step (success) 06:04:53 INFO - [mozharness: 2016-11-07 14:04:53.198926Z] Running download-and-extract step. 06:04:53 INFO - Running pre-action listener: _resource_record_pre_action 06:04:53 INFO - Running main action method: download_and_extract 06:04:53 INFO - mkdir: /builds/slave/test/build/tests 06:04:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:04:53 INFO - trying https://queue.taskcluster.net/v1/task/DRqMyzKkQeWA72Fj33Bcrw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:04:53 INFO - Downloading https://queue.taskcluster.net/v1/task/DRqMyzKkQeWA72Fj33Bcrw/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:04:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DRqMyzKkQeWA72Fj33Bcrw/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:04:53 INFO - Downloaded 1361 bytes. 06:04:53 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:04:53 INFO - Using the following test package requirements: 06:04:53 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:04:53 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:04:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:04:53 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:04:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:04:53 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:04:53 INFO - u'jsshell-linux-x86_64.zip'], 06:04:53 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:04:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:04:53 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:04:53 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:04:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:04:53 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:04:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:04:53 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:04:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:04:53 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:04:53 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:04:53 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:04:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DRqMyzKkQeWA72Fj33Bcrw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:04:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DRqMyzKkQeWA72Fj33Bcrw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:04:53 INFO - Fetch https://queue.taskcluster.net/v1/task/DRqMyzKkQeWA72Fj33Bcrw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:04:54 INFO - Http code: 200 06:04:54 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 06:04:54 INFO - x-amz-cf-id: 5lPzvPcmA19be_sp2arInwn0ErQLhxaPrAI339m8DWmxMBmBf6914g== 06:04:54 INFO - x-amz-version-id: RyeAIU_suchFDQyg4CXKMdikpyPjYNjl 06:04:54 INFO - Expected file size: 20353381 06:04:54 INFO - Obtained file size: 20353381 06:04:58 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:04:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DRqMyzKkQeWA72Fj33Bcrw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:04:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DRqMyzKkQeWA72Fj33Bcrw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:04:58 INFO - Fetch https://queue.taskcluster.net/v1/task/DRqMyzKkQeWA72Fj33Bcrw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:04:59 INFO - Http code: 200 06:04:59 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 06:04:59 INFO - x-amz-cf-id: uqTc6MeSwExdpMV9w4EuSktgh9D6uvEDvU0Gm7DH49gPgckJkYyH2A== 06:04:59 INFO - x-amz-version-id: RyeAIU_suchFDQyg4CXKMdikpyPjYNjl 06:04:59 INFO - Expected file size: 20353381 06:04:59 INFO - Obtained file size: 20353381 06:05:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DRqMyzKkQeWA72Fj33Bcrw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 06:05:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DRqMyzKkQeWA72Fj33Bcrw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:05:03 INFO - Fetch https://queue.taskcluster.net/v1/task/DRqMyzKkQeWA72Fj33Bcrw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:05:04 INFO - Http code: 200 06:05:04 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 06:05:04 INFO - x-amz-cf-id: FKr26LGAwq9-BqVMHF7WZmMogtO3LmkZaC0rUved8XuyEAFbMyD_kA== 06:05:04 INFO - x-amz-version-id: k6uOJnjCHS37MkemCraDe.rej8GhNwt1 06:05:04 INFO - Expected file size: 14409038 06:05:04 INFO - Obtained file size: 14409038 06:05:04 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:05:04 INFO - trying https://queue.taskcluster.net/v1/task/DRqMyzKkQeWA72Fj33Bcrw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:05:04 INFO - Downloading https://queue.taskcluster.net/v1/task/DRqMyzKkQeWA72Fj33Bcrw/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:05:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DRqMyzKkQeWA72Fj33Bcrw/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:05:06 INFO - Downloaded 55869481 bytes. 06:05:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DRqMyzKkQeWA72Fj33Bcrw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:05:06 INFO - mkdir: /builds/slave/test/properties 06:05:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:05:06 INFO - Writing to file /builds/slave/test/properties/build_url 06:05:06 INFO - Contents: 06:05:06 INFO - build_url:https://queue.taskcluster.net/v1/task/DRqMyzKkQeWA72Fj33Bcrw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:05:06 INFO - Running post-action listener: _resource_record_post_action 06:05:06 INFO - Running post-action listener: set_extra_try_arguments 06:05:06 INFO - [mozharness: 2016-11-07 14:05:06.699193Z] Finished download-and-extract step (success) 06:05:06 INFO - [mozharness: 2016-11-07 14:05:06.699421Z] Running populate-webroot step. 06:05:06 INFO - Running pre-action listener: _resource_record_pre_action 06:05:06 INFO - Running main action method: populate_webroot 06:05:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:05:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:05:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:05:06 INFO - '--tppagecycles', 06:05:06 INFO - '7'], 06:05:06 INFO - 'tests': ['tsvgm']}}, 06:05:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:05:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:05:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:05:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:05:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:05:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:05:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:06 INFO - 'talos_options': ['--disable-e10s'], 06:05:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:05:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:05:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:06 INFO - 'talos_options': ['--disable-e10s'], 06:05:06 INFO - 'tests': ['damp', 'tps']}, 06:05:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:06 INFO - 'tests': ['damp', 'tps']}, 06:05:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:05:06 INFO - 'tests': ['dromaeo_dom']}, 06:05:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:05:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:05:06 INFO - 'tests': ['basic_compositor_video']}, 06:05:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:05:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:05:06 INFO - 'tests': ['a11yr', 06:05:06 INFO - 'ts_paint', 06:05:06 INFO - 'tpaint', 06:05:06 INFO - 'sessionrestore', 06:05:06 INFO - 'sessionrestore_no_auto_restore', 06:05:06 INFO - 'tabpaint']}, 06:05:06 INFO - 'other-e10s': {'tests': ['a11yr', 06:05:06 INFO - 'ts_paint', 06:05:06 INFO - 'tpaint', 06:05:06 INFO - 'sessionrestore', 06:05:06 INFO - 'sessionrestore_no_auto_restore', 06:05:06 INFO - 'tabpaint']}, 06:05:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:05:06 INFO - 'ts_paint', 06:05:06 INFO - 'tpaint', 06:05:06 INFO - 'sessionrestore', 06:05:06 INFO - 'sessionrestore_no_auto_restore', 06:05:06 INFO - 'tabpaint']}, 06:05:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:05:06 INFO - 'ts_paint', 06:05:06 INFO - 'tpaint', 06:05:06 INFO - 'sessionrestore', 06:05:06 INFO - 'sessionrestore_no_auto_restore', 06:05:06 INFO - 'tabpaint']}, 06:05:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:05:06 INFO - 'tests': ['a11yr', 06:05:06 INFO - 'ts_paint', 06:05:06 INFO - 'tpaint', 06:05:06 INFO - 'sessionrestore', 06:05:06 INFO - 'sessionrestore_no_auto_restore', 06:05:06 INFO - 'tabpaint']}, 06:05:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:05:06 INFO - 'tests': ['a11yr', 06:05:06 INFO - 'ts_paint', 06:05:06 INFO - 'tpaint', 06:05:06 INFO - 'sessionrestore', 06:05:06 INFO - 'sessionrestore_no_auto_restore', 06:05:06 INFO - 'tabpaint']}, 06:05:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:05:06 INFO - 'tests': ['tsvgx', 06:05:06 INFO - 'tsvgr_opacity', 06:05:06 INFO - 'tart', 06:05:06 INFO - 'tscrollx', 06:05:06 INFO - 'cart']}, 06:05:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:05:06 INFO - 'tsvgr_opacity', 06:05:06 INFO - 'tart', 06:05:06 INFO - 'tscrollx', 06:05:06 INFO - 'cart']}, 06:05:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:06 INFO - 'talos_options': ['--disable-e10s'], 06:05:06 INFO - 'tests': ['tp5o']}, 06:05:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:06 INFO - 'tests': ['tp5o']}, 06:05:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:06 INFO - 'talos_options': ['--disable-e10s', 06:05:06 INFO - '--xperf_path', 06:05:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:05:06 INFO - 'tests': ['tp5n']}, 06:05:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:05:06 INFO - 'talos_options': ['--xperf_path', 06:05:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:05:06 INFO - 'tests': ['tp5n']}}, 06:05:06 INFO - 'talos.zip': {'path': '', 06:05:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:05:06 INFO - Running post-action listener: _resource_record_post_action 06:05:06 INFO - [mozharness: 2016-11-07 14:05:06.718825Z] Finished populate-webroot step (success) 06:05:06 INFO - [mozharness: 2016-11-07 14:05:06.718912Z] Running create-virtualenv step. 06:05:06 INFO - Running pre-action listener: _resource_record_pre_action 06:05:06 INFO - Running main action method: create_virtualenv 06:05:06 INFO - Creating virtualenv /builds/slave/test/build/venv 06:05:06 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:05:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:05:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:05:06 INFO - Using real prefix '/usr' 06:05:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:05:07 INFO - Installing distribute.............................................................................................................................................................................................done. 06:05:09 INFO - Installing pip.................done. 06:05:09 INFO - Return code: 0 06:05:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:05:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:05:09 INFO - Reading from file tmpfile_stdout 06:05:09 INFO - Output received: 06:05:09 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:05:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:05:09 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:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:09 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:05:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:09 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 0x7faa6a60bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c37790>, '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 0x1c38690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c38b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1478527490.604500-1100081964', '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:05:09 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:05:09 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:05:09 INFO - Using env: {'DISPLAY': ':0', 06:05:09 INFO - 'HOME': '/home/cltbld', 06:05:09 INFO - 'LANG': 'en_US.UTF-8', 06:05:09 INFO - 'LANGUAGE': 'en_US:en', 06:05:09 INFO - 'LOGNAME': 'cltbld', 06:05:09 INFO - 'MAIL': '/var/mail/cltbld', 06:05:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:09 INFO - 'MOZ_NO_REMOTE': '1', 06:05:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:09 INFO - 'NO_EM_RESTART': '1', 06:05:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:09 INFO - 'PWD': '/builds/slave/test', 06:05:09 INFO - 'SHELL': '/bin/bash', 06:05:09 INFO - 'SHLVL': '1', 06:05:09 INFO - 'TERM': 'linux', 06:05:09 INFO - 'TMOUT': '86400', 06:05:09 INFO - 'USER': 'cltbld', 06:05:09 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1478527490.604500-1100081964', 06:05:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:09 INFO - '_': '/tools/buildbot/bin/python'} 06:05:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:09 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:05:09 INFO - Cleaning up... 06:05:09 INFO - Return code: 0 06:05:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:05:09 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:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:09 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:05:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:09 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 0x7faa6a60bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c37790>, '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 0x1c38690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c38b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1478527490.604500-1100081964', '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:05:09 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:05:09 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:05:09 INFO - Using env: {'DISPLAY': ':0', 06:05:09 INFO - 'HOME': '/home/cltbld', 06:05:09 INFO - 'LANG': 'en_US.UTF-8', 06:05:09 INFO - 'LANGUAGE': 'en_US:en', 06:05:09 INFO - 'LOGNAME': 'cltbld', 06:05:09 INFO - 'MAIL': '/var/mail/cltbld', 06:05:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:09 INFO - 'MOZ_NO_REMOTE': '1', 06:05:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:09 INFO - 'NO_EM_RESTART': '1', 06:05:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:09 INFO - 'PWD': '/builds/slave/test', 06:05:09 INFO - 'SHELL': '/bin/bash', 06:05:09 INFO - 'SHLVL': '1', 06:05:09 INFO - 'TERM': 'linux', 06:05:09 INFO - 'TMOUT': '86400', 06:05:09 INFO - 'USER': 'cltbld', 06:05:09 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1478527490.604500-1100081964', 06:05:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:09 INFO - '_': '/tools/buildbot/bin/python'} 06:05:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:09 INFO - Downloading/unpacking psutil>=3.1.1 06:05:09 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:05:09 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:05:09 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:05:09 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:05:09 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:05:09 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:05:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:05:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:05:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:05:12 INFO - Installing collected packages: psutil 06:05:12 INFO - Running setup.py install for psutil 06:05:12 INFO - building 'psutil._psutil_linux' extension 06:05:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:05:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:05:12 INFO - building 'psutil._psutil_posix' extension 06:05:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:05:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:05:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:05:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:05:12 INFO - Successfully installed psutil 06:05:12 INFO - Cleaning up... 06:05:12 INFO - Return code: 0 06:05:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa6a60bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c37790>, '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 0x1c38690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c38b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1478527490.604500-1100081964', '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:05:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:05:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:05:12 INFO - Using env: {'DISPLAY': ':0', 06:05:12 INFO - 'HOME': '/home/cltbld', 06:05:12 INFO - 'LANG': 'en_US.UTF-8', 06:05:12 INFO - 'LANGUAGE': 'en_US:en', 06:05:12 INFO - 'LOGNAME': 'cltbld', 06:05:12 INFO - 'MAIL': '/var/mail/cltbld', 06:05:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:12 INFO - 'MOZ_NO_REMOTE': '1', 06:05:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:12 INFO - 'NO_EM_RESTART': '1', 06:05:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:12 INFO - 'PWD': '/builds/slave/test', 06:05:12 INFO - 'SHELL': '/bin/bash', 06:05:12 INFO - 'SHLVL': '1', 06:05:12 INFO - 'TERM': 'linux', 06:05:12 INFO - 'TMOUT': '86400', 06:05:12 INFO - 'USER': 'cltbld', 06:05:12 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1478527490.604500-1100081964', 06:05:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:12 INFO - '_': '/tools/buildbot/bin/python'} 06:05:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:05:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:05:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:05:14 INFO - Installing collected packages: mozsystemmonitor 06:05:14 INFO - Running setup.py install for mozsystemmonitor 06:05:14 INFO - Successfully installed mozsystemmonitor 06:05:14 INFO - Cleaning up... 06:05:14 INFO - Return code: 0 06:05:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:05: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:05:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05: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:05:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa6a60bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c37790>, '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 0x1c38690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c38b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1478527490.604500-1100081964', '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:05: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==2.5.1'] in /builds/slave/test/build 06:05: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==2.5.1 06:05:14 INFO - Using env: {'DISPLAY': ':0', 06:05:14 INFO - 'HOME': '/home/cltbld', 06:05:14 INFO - 'LANG': 'en_US.UTF-8', 06:05:14 INFO - 'LANGUAGE': 'en_US:en', 06:05:14 INFO - 'LOGNAME': 'cltbld', 06:05:14 INFO - 'MAIL': '/var/mail/cltbld', 06:05:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:14 INFO - 'MOZ_NO_REMOTE': '1', 06:05:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:14 INFO - 'NO_EM_RESTART': '1', 06:05:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:14 INFO - 'PWD': '/builds/slave/test', 06:05:14 INFO - 'SHELL': '/bin/bash', 06:05:14 INFO - 'SHLVL': '1', 06:05:14 INFO - 'TERM': 'linux', 06:05:14 INFO - 'TMOUT': '86400', 06:05:14 INFO - 'USER': 'cltbld', 06:05:14 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1478527490.604500-1100081964', 06:05:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:14 INFO - '_': '/tools/buildbot/bin/python'} 06:05:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:15 INFO - Downloading/unpacking jsonschema==2.5.1 06:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:05:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:17 INFO - Downloading functools32-3.2.3-2.tar.gz 06:05:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:05:17 INFO - warning: no files found matching '*.txt' 06:05:17 INFO - no previously-included directories found matching 'build' 06:05:17 INFO - no previously-included directories found matching 'dist' 06:05:17 INFO - no previously-included directories found matching '.git*' 06:05:17 INFO - Installing collected packages: jsonschema, functools32 06:05:17 INFO - Running setup.py install for functools32 06:05:17 INFO - warning: no files found matching '*.txt' 06:05:17 INFO - no previously-included directories found matching 'build' 06:05:17 INFO - no previously-included directories found matching 'dist' 06:05:17 INFO - no previously-included directories found matching '.git*' 06:05:17 INFO - Successfully installed jsonschema functools32 06:05:17 INFO - Cleaning up... 06:05:17 INFO - Return code: 0 06:05:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:05:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7faa6a60bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c37790>, '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 0x1c38690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c38b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1478527490.604500-1100081964', '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:05:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:05:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:05:17 INFO - Using env: {'DISPLAY': ':0', 06:05:17 INFO - 'HOME': '/home/cltbld', 06:05:17 INFO - 'LANG': 'en_US.UTF-8', 06:05:17 INFO - 'LANGUAGE': 'en_US:en', 06:05:17 INFO - 'LOGNAME': 'cltbld', 06:05:17 INFO - 'MAIL': '/var/mail/cltbld', 06:05:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:17 INFO - 'MOZ_NO_REMOTE': '1', 06:05:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:17 INFO - 'NO_EM_RESTART': '1', 06:05:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:17 INFO - 'PWD': '/builds/slave/test', 06:05:17 INFO - 'SHELL': '/bin/bash', 06:05:17 INFO - 'SHLVL': '1', 06:05:17 INFO - 'TERM': 'linux', 06:05:17 INFO - 'TMOUT': '86400', 06:05:17 INFO - 'USER': 'cltbld', 06:05:17 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1478527490.604500-1100081964', 06:05:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:17 INFO - '_': '/tools/buildbot/bin/python'} 06:05:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:05:17 INFO - Cleaning up... 06:05:17 INFO - Return code: 0 06:05:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:05:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa6a60bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c37790>, '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 0x1c38690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c38b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1478527490.604500-1100081964', '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:05:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:05:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:05:18 INFO - Using env: {'DISPLAY': ':0', 06:05:18 INFO - 'HOME': '/home/cltbld', 06:05:18 INFO - 'LANG': 'en_US.UTF-8', 06:05:18 INFO - 'LANGUAGE': 'en_US:en', 06:05:18 INFO - 'LOGNAME': 'cltbld', 06:05:18 INFO - 'MAIL': '/var/mail/cltbld', 06:05:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:18 INFO - 'MOZ_NO_REMOTE': '1', 06:05:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:18 INFO - 'NO_EM_RESTART': '1', 06:05:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:18 INFO - 'PWD': '/builds/slave/test', 06:05:18 INFO - 'SHELL': '/bin/bash', 06:05:18 INFO - 'SHLVL': '1', 06:05:18 INFO - 'TERM': 'linux', 06:05:18 INFO - 'TMOUT': '86400', 06:05:18 INFO - 'USER': 'cltbld', 06:05:18 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1478527490.604500-1100081964', 06:05:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:18 INFO - '_': '/tools/buildbot/bin/python'} 06:05:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:18 INFO - Downloading/unpacking blobuploader==1.2.4 06:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:20 INFO - Downloading blobuploader-1.2.4.tar.gz 06:05:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:05:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:05:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:20 INFO - Downloading docopt-0.6.1.tar.gz 06:05:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:05:20 INFO - Installing collected packages: blobuploader, requests, docopt 06:05:20 INFO - Running setup.py install for blobuploader 06:05:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:05:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:05:21 INFO - Running setup.py install for requests 06:05:21 INFO - Running setup.py install for docopt 06:05:21 INFO - Successfully installed blobuploader requests docopt 06:05:21 INFO - Cleaning up... 06:05:21 INFO - Return code: 0 06:05:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa6a60bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c37790>, '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 0x1c38690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c38b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1478527490.604500-1100081964', '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:05:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:05:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:05:21 INFO - Using env: {'DISPLAY': ':0', 06:05:21 INFO - 'HOME': '/home/cltbld', 06:05:21 INFO - 'LANG': 'en_US.UTF-8', 06:05:21 INFO - 'LANGUAGE': 'en_US:en', 06:05:21 INFO - 'LOGNAME': 'cltbld', 06:05:21 INFO - 'MAIL': '/var/mail/cltbld', 06:05:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:21 INFO - 'MOZ_NO_REMOTE': '1', 06:05:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:21 INFO - 'NO_EM_RESTART': '1', 06:05:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:21 INFO - 'PWD': '/builds/slave/test', 06:05:21 INFO - 'SHELL': '/bin/bash', 06:05:21 INFO - 'SHLVL': '1', 06:05:21 INFO - 'TERM': 'linux', 06:05:21 INFO - 'TMOUT': '86400', 06:05:21 INFO - 'USER': 'cltbld', 06:05:21 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1478527490.604500-1100081964', 06:05:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:21 INFO - '_': '/tools/buildbot/bin/python'} 06:05:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:05:21 INFO - Running setup.py (path:/tmp/pip-5ZHi4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:05:21 INFO - Running setup.py (path:/tmp/pip-9TqI3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:05:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:05:21 INFO - Running setup.py (path:/tmp/pip-s7Ez_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:05:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:05:22 INFO - Running setup.py (path:/tmp/pip-Ch1BNc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:05:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:05:22 INFO - Running setup.py (path:/tmp/pip-W8QVGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:05:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:05:22 INFO - Running setup.py (path:/tmp/pip-njLOmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:05:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:05:22 INFO - Running setup.py (path:/tmp/pip-iCFWkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:05:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:05:22 INFO - Running setup.py (path:/tmp/pip-stELF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:05:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:05:22 INFO - Running setup.py (path:/tmp/pip-LyIzxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:05:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:05:22 INFO - Running setup.py (path:/tmp/pip-WotwoO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:05:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:05:22 INFO - Running setup.py (path:/tmp/pip-T81acj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:05:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:05:22 INFO - Running setup.py (path:/tmp/pip-bHQtdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:05:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:05:22 INFO - Running setup.py (path:/tmp/pip-o3SNN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:05:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:05:22 INFO - Running setup.py (path:/tmp/pip-ac_Nde-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:05:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:05:22 INFO - Running setup.py (path:/tmp/pip-u_yMZG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:05:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:05:22 INFO - Running setup.py (path:/tmp/pip-nspNlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:05:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:05:22 INFO - Running setup.py (path:/tmp/pip-hSnWW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:05:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:05:23 INFO - Running setup.py install for manifestparser 06:05:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:05:23 INFO - Running setup.py install for mozcrash 06:05:23 INFO - Running setup.py install for mozdebug 06:05:23 INFO - Running setup.py install for mozdevice 06:05:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:05:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:05:23 INFO - Running setup.py install for mozfile 06:05:23 INFO - Running setup.py install for mozhttpd 06:05:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:05:23 INFO - Running setup.py install for mozinfo 06:05:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:05:23 INFO - Running setup.py install for mozInstall 06:05:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:05:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:05:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:05:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:05:23 INFO - Running setup.py install for mozleak 06:05:23 INFO - Running setup.py install for mozlog 06:05:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:05:24 INFO - Running setup.py install for moznetwork 06:05:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:05:24 INFO - Running setup.py install for mozprocess 06:05:24 INFO - Running setup.py install for mozprofile 06:05:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:05:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:05:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:05:24 INFO - Running setup.py install for mozrunner 06:05:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:05:24 INFO - Running setup.py install for mozscreenshot 06:05:24 INFO - Running setup.py install for moztest 06:05:24 INFO - Running setup.py install for mozversion 06:05:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:05:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:05:24 INFO - Cleaning up... 06:05:24 INFO - Return code: 0 06:05:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:05:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:24 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 0x7faa6a60bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c37790>, '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 0x1c38690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c38b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1478527490.604500-1100081964', '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:05:24 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:05:24 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:05:24 INFO - Using env: {'DISPLAY': ':0', 06:05:24 INFO - 'HOME': '/home/cltbld', 06:05:24 INFO - 'LANG': 'en_US.UTF-8', 06:05:24 INFO - 'LANGUAGE': 'en_US:en', 06:05:24 INFO - 'LOGNAME': 'cltbld', 06:05:24 INFO - 'MAIL': '/var/mail/cltbld', 06:05:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:24 INFO - 'MOZ_NO_REMOTE': '1', 06:05:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:24 INFO - 'NO_EM_RESTART': '1', 06:05:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:24 INFO - 'PWD': '/builds/slave/test', 06:05:24 INFO - 'SHELL': '/bin/bash', 06:05:24 INFO - 'SHLVL': '1', 06:05:24 INFO - 'TERM': 'linux', 06:05:24 INFO - 'TMOUT': '86400', 06:05:24 INFO - 'USER': 'cltbld', 06:05:24 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1478527490.604500-1100081964', 06:05:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:24 INFO - '_': '/tools/buildbot/bin/python'} 06:05:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:05:25 INFO - Running setup.py (path:/tmp/pip-LO5F_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:05:25 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:05:25 INFO - Running setup.py (path:/tmp/pip-dkQZIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:05:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:05:25 INFO - Running setup.py (path:/tmp/pip-FscfLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:05:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:05:25 INFO - Running setup.py (path:/tmp/pip-1JUwmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:05:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:05:25 INFO - Running setup.py (path:/tmp/pip-pG3pBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:05:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:05:25 INFO - Running setup.py (path:/tmp/pip-YMZ9_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:05:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:05:25 INFO - Running setup.py (path:/tmp/pip-ZAsyGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:05:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:05:25 INFO - Running setup.py (path:/tmp/pip-DLGjae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:05:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:05:25 INFO - Running setup.py (path:/tmp/pip-hWGVci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:05:25 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:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:05:25 INFO - Running setup.py (path:/tmp/pip-ZzEAZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:05:25 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:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:05:25 INFO - Running setup.py (path:/tmp/pip-ePa6Ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:05:25 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:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:05:25 INFO - Running setup.py (path:/tmp/pip-e2c7U6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:05:25 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:05:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:05:25 INFO - Running setup.py (path:/tmp/pip-kvz2La-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:05:26 INFO - Running setup.py (path:/tmp/pip-YAsxL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:05:26 INFO - Running setup.py (path:/tmp/pip-4IbdLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:05:26 INFO - Running setup.py (path:/tmp/pip-c4fNn6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:05:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:05:26 INFO - Running setup.py (path:/tmp/pip-7jbJ4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:05:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:05:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:05:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:05:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:05:28 INFO - Downloading blessings-1.6.tar.gz 06:05:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:05:28 INFO - Installing collected packages: blessings 06:05:28 INFO - Running setup.py install for blessings 06:05:28 INFO - Successfully installed blessings 06:05:28 INFO - Cleaning up... 06:05:28 INFO - Return code: 0 06:05:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:05:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:05:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:05:28 INFO - Reading from file tmpfile_stdout 06:05:28 INFO - Current package versions: 06:05:28 INFO - argparse == 1.2.1 06:05:28 INFO - blessings == 1.6 06:05:28 INFO - blobuploader == 1.2.4 06:05:28 INFO - docopt == 0.6.1 06:05:28 INFO - functools32 == 3.2.3-2 06:05:28 INFO - jsonschema == 2.5.1 06:05:28 INFO - manifestparser == 1.1 06:05:28 INFO - mozInstall == 1.12 06:05:28 INFO - mozcrash == 0.17 06:05:28 INFO - mozdebug == 0.1 06:05:28 INFO - mozdevice == 0.48 06:05:28 INFO - mozfile == 1.2 06:05:28 INFO - mozhttpd == 0.7 06:05:28 INFO - mozinfo == 0.9 06:05:28 INFO - mozleak == 0.1 06:05:28 INFO - mozlog == 3.4 06:05:28 INFO - moznetwork == 0.27 06:05:28 INFO - mozprocess == 0.23 06:05:28 INFO - mozprofile == 0.28 06:05:28 INFO - mozrunner == 6.12 06:05:28 INFO - mozscreenshot == 0.1 06:05:28 INFO - mozsystemmonitor == 0.3 06:05:28 INFO - moztest == 0.7 06:05:28 INFO - mozversion == 1.4 06:05:28 INFO - psutil == 3.1.1 06:05:28 INFO - requests == 1.2.3 06:05:28 INFO - wsgiref == 0.1.2 06:05:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:05:28 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:05:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:28 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:05:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:28 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 0x7faa6a60bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c37790>, '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 0x1c38690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c38b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1478527490.604500-1100081964', '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:05:28 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:05:28 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:05:28 INFO - Using env: {'DISPLAY': ':0', 06:05:28 INFO - 'HOME': '/home/cltbld', 06:05:28 INFO - 'LANG': 'en_US.UTF-8', 06:05:28 INFO - 'LANGUAGE': 'en_US:en', 06:05:28 INFO - 'LOGNAME': 'cltbld', 06:05:28 INFO - 'MAIL': '/var/mail/cltbld', 06:05:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:28 INFO - 'MOZ_NO_REMOTE': '1', 06:05:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:28 INFO - 'NO_EM_RESTART': '1', 06:05:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:28 INFO - 'PWD': '/builds/slave/test', 06:05:28 INFO - 'SHELL': '/bin/bash', 06:05:28 INFO - 'SHLVL': '1', 06:05:28 INFO - 'TERM': 'linux', 06:05:28 INFO - 'TMOUT': '86400', 06:05:28 INFO - 'USER': 'cltbld', 06:05:28 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1478527490.604500-1100081964', 06:05:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:28 INFO - '_': '/tools/buildbot/bin/python'} 06:05:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:28 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:05:28 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:05:28 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:05:28 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:05:28 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:05:28 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:05:28 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:05:28 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:05:28 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:05:28 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:05:28 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:05:28 INFO - Cleaning up... 06:05:28 INFO - Return code: 0 06:05:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:05:28 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:05:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:05:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:28 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:05:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:05:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:05:28 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 0x7faa6a60bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ba87b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c37790>, '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 0x1c38690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c38b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1478527490.604500-1100081964', '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:05:28 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:05:28 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:05:28 INFO - Using env: {'DISPLAY': ':0', 06:05:28 INFO - 'HOME': '/home/cltbld', 06:05:28 INFO - 'LANG': 'en_US.UTF-8', 06:05:28 INFO - 'LANGUAGE': 'en_US:en', 06:05:28 INFO - 'LOGNAME': 'cltbld', 06:05:28 INFO - 'MAIL': '/var/mail/cltbld', 06:05:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:28 INFO - 'MOZ_NO_REMOTE': '1', 06:05:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:28 INFO - 'NO_EM_RESTART': '1', 06:05:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:28 INFO - 'PWD': '/builds/slave/test', 06:05:28 INFO - 'SHELL': '/bin/bash', 06:05:28 INFO - 'SHLVL': '1', 06:05:28 INFO - 'TERM': 'linux', 06:05:28 INFO - 'TMOUT': '86400', 06:05:28 INFO - 'USER': 'cltbld', 06:05:28 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1478527490.604500-1100081964', 06:05:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:28 INFO - '_': '/tools/buildbot/bin/python'} 06:05:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:05:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:05:29 INFO - Cleaning up... 06:05:29 INFO - Return code: 0 06:05:29 INFO - Running post-action listener: _resource_record_post_action 06:05:29 INFO - Running post-action listener: _start_resource_monitoring 06:05:29 INFO - Starting resource monitoring. 06:05:29 INFO - [mozharness: 2016-11-07 14:05:29.238152Z] Finished create-virtualenv step (success) 06:05:29 INFO - [mozharness: 2016-11-07 14:05:29.238676Z] Running install step. 06:05:29 INFO - Running pre-action listener: _resource_record_pre_action 06:05:29 INFO - Running main action method: install 06:05:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:05:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:05:29 INFO - Reading from file tmpfile_stdout 06:05:29 INFO - Detecting whether we're running mozinstall >=1.0... 06:05:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:05:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:05:29 INFO - Reading from file tmpfile_stdout 06:05:29 INFO - Output received: 06:05:29 INFO - Usage: mozinstall [options] installer 06:05:29 INFO - Options: 06:05:29 INFO - -h, --help show this help message and exit 06:05:29 INFO - -d DEST, --destination=DEST 06:05:29 INFO - Directory to install application into. [default: 06:05:29 INFO - "/builds/slave/test"] 06:05:29 INFO - --app=APP Application being installed. [default: firefox] 06:05:29 INFO - mkdir: /builds/slave/test/build/application 06:05:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:05:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:05:45 INFO - Reading from file tmpfile_stdout 06:05:45 INFO - Output received: 06:05:45 INFO - /builds/slave/test/build/application/firefox/firefox 06:05:45 INFO - Running post-action listener: _resource_record_post_action 06:05:45 INFO - [mozharness: 2016-11-07 14:05:45.640386Z] Finished install step (success) 06:05:45 INFO - [mozharness: 2016-11-07 14:05:45.640626Z] Running run-tests step. 06:05:45 INFO - Running pre-action listener: _resource_record_pre_action 06:05:45 INFO - Running main action method: run_tests 06:05:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:05:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:05:45 INFO - Python 2.7.3 06:05:45 INFO - Return code: 0 06:05:45 INFO - grabbing minidump binary from tooltool 06:05:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:05:45 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c37790>, '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 0x1c38690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c38b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:05:45 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:05:45 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:05:45 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:05:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:05:45 INFO - Return code: 0 06:05:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:05:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:05:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:05:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:05:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:05:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DRqMyzKkQeWA72Fj33Bcrw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:05:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Cedar --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DRqMyzKkQeWA72Fj33Bcrw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:05:45 INFO - Using env: {'DISPLAY': ':0', 06:05:45 INFO - 'HOME': '/home/cltbld', 06:05:45 INFO - 'LANG': 'en_US.UTF-8', 06:05:45 INFO - 'LANGUAGE': 'en_US:en', 06:05:45 INFO - 'LOGNAME': 'cltbld', 06:05:45 INFO - 'MAIL': '/var/mail/cltbld', 06:05:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:05:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:05:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:05:45 INFO - 'MOZ_NO_REMOTE': '1', 06:05:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:05:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:05:45 INFO - 'NO_EM_RESTART': '1', 06:05:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:05:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:05:45 INFO - 'PWD': '/builds/slave/test', 06:05:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:05:45 INFO - 'SHELL': '/bin/bash', 06:05:45 INFO - 'SHLVL': '1', 06:05:45 INFO - 'TERM': 'linux', 06:05:45 INFO - 'TMOUT': '86400', 06:05:45 INFO - 'USER': 'cltbld', 06:05:45 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1478527490.604500-1100081964', 06:05:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:05:45 INFO - '_': '/tools/buildbot/bin/python'} 06:05:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DRqMyzKkQeWA72Fj33Bcrw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:05:45 INFO - mozversion application_buildid: 20161107041537 06:05:45 INFO - mozversion application_changeset: 36b139f0c1300e703ab80a1ef58f56bbc55d87e4 06:05:45 INFO - mozversion application_display_name: Nightly 06:05:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:05:45 INFO - mozversion application_name: Firefox 06:05:45 INFO - mozversion application_remotingname: firefox 06:05:45 INFO - mozversion application_repository: https://hg.mozilla.org/projects/cedar 06:05:45 INFO - mozversion application_vendor: Mozilla 06:05:45 INFO - mozversion application_version: 52.0a1 06:05:45 INFO - mozversion platform_buildid: 20161107041537 06:05:45 INFO - mozversion platform_changeset: 36b139f0c1300e703ab80a1ef58f56bbc55d87e4 06:05:45 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/cedar 06:05:45 INFO - mozversion platform_version: 52.0a1 06:05:45 INFO - using testdate: 1478527545 06:05:45 INFO - actual date: 1478527545 06:05:45 INFO - starting webserver on 'localhost:58606' 06:05:45 INFO - SUITE-START | Running 2 tests 06:05:45 INFO - TEST-START | dromaeo_css 06:05:45 INFO - operating with platform_type : linux_ 06:05:45 INFO - Initialising browser for dromaeo_css test... 06:05:45 INFO - TEST-INFO | started process 26287 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwu8NZd/profile http://localhost:58606/getInfo.html) 06:05:50 INFO - PROCESS | 26287 | __metrics Screen width/height:1600/1200 06:05:50 INFO - PROCESS | 26287 | colorDepth:24 06:05:50 INFO - PROCESS | 26287 | Browser inner width/height: 1024/697 06:05:50 INFO - PROCESS | 26287 | __metrics 06:05:50 INFO - PROCESS | 26287 | 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:05:50 INFO - PROCESS | 26287 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:05:50 INFO - PROCESS | 26287 | console.error: PushService: 06:05:50 INFO - PROCESS | 26287 | stateChangeProcessEnqueue: Error transitioning state 06:05:50 INFO - PROCESS | 26287 | UnknownError 06:05:51 INFO - TEST-INFO | 26287: exit 0 06:05:51 INFO - Browser initialized. 06:05:51 INFO - Running cycle 1/1 for dromaeo_css test... 06:05:51 INFO - TEST-INFO | started process 26370 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwu8NZd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:06:03 INFO - PROCESS | 26370 | RSS: Main: 174624768 06:06:03 INFO - PROCESS | 26370 | 06:06:55 INFO - PROCESS | 26370 | 1478527615695 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:09:09 INFO - PROCESS | 26370 | Cycle 1(1): loaded http://localhost:58606/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58606/tests/dromaeo/cssquery-ext.html) 06:09:10 INFO - PROCESS | 26370 | RSS: Main: 298762240 06:09:10 INFO - PROCESS | 26370 | 06:12:13 INFO - PROCESS | 26370 | Cycle 1(1): loaded http://localhost:58606/tests/dromaeo/cssquery-ext.html (next: http://localhost:58606/tests/dromaeo/cssquery-jquery.html) 06:12:13 INFO - PROCESS | 26370 | RSS: Main: 282095616 06:12:13 INFO - PROCESS | 26370 | 06:15:15 INFO - PROCESS | 26370 | Cycle 1(1): loaded http://localhost:58606/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58606/tests/dromaeo/cssquery-mootools.html) 06:15:16 INFO - PROCESS | 26370 | RSS: Main: 223354880 06:15:16 INFO - PROCESS | 26370 | 06:18:19 INFO - PROCESS | 26370 | Cycle 1(1): loaded http://localhost:58606/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58606/tests/dromaeo/cssquery-prototype.html) 06:18:19 INFO - PROCESS | 26370 | RSS: Main: 220270592 06:18:19 INFO - PROCESS | 26370 | 06:21:22 INFO - PROCESS | 26370 | Cycle 1(1): loaded http://localhost:58606/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58606/tests/dromaeo/cssquery-yui.html) 06:21:23 INFO - PROCESS | 26370 | RSS: Main: 220835840 06:21:23 INFO - PROCESS | 26370 | 06:24:26 INFO - PROCESS | 26370 | Cycle 1(1): loaded http://localhost:58606/tests/dromaeo/cssquery-yui.html (next: http://localhost:58606/tests/dromaeo/cssquery-dojo.html) 06:24:26 INFO - PROCESS | 26370 | RSS: Main: 312905728 06:24:26 INFO - PROCESS | 26370 | 06:24:26 INFO - PROCESS | 26370 | __start_tp_report 06:24:26 INFO - PROCESS | 26370 | _x_x_mozilla_page_load 06:24:26 INFO - PROCESS | 26370 | _x_x_mozilla_page_load_details 06:24:26 INFO - PROCESS | 26370 | |i|pagename|runs| 06:24:26 INFO - PROCESS | 26370 | |0;dojo.html;2596.130296350723;2597;2649.2714503511534;2650.403659176685;2663.560512515436;4553.248713962193;4643.7910294036765;4661.254199328108;4698.201305778013;4714.198586240339;4640.837570685027;4667.416572928384;4699.2951057341415;4730.574248317651;4786.545278198574;4296.0548679290505;4299.419578356913;4335.176316499855;4392.494863090737;4395.099004704044;4389.539098394671;4408.074304396081;4417.73493590384;4421.447319085114;4463.754493502856;4233.745975241464;4356.869293921188;4368.060866913629;4389.034412429261;4459.866204013885;4265.616094551505;4300.78496075195;4324.286492728696;4327.285997810389;4337.956620433787;4298.054428025829;4302.311630139194;4303.698741088125;4304.9139017219795;4313.331433627762;4668.766561671903;4680.953190468086;4684.203685373494;4688.367070445481;4692.085043416535;4988.052270068675;5031.4465408805;5040.823571174991;5062.417821950449;5119;5069.0115427491655;5073.036123136592;5081.5426611605135;5082.847514574569;5133.845984620468;4634.652401069933;4677.555632214934;4736.147493451212;4739.905201895943;4783.354247176587;5135.204043373283;5168.173092305288;5185.533302002837;5191.740412979411;5211.140161873249;4948.3943248629985;4985.426675932242;4991.450940396553;4998.350214472095;5016.172331565251;5090.847274581768;5093.261477085876;5096.490350964948;5097.745112744422;5135.12702840518;4798.520147985243;4839.588634965997;4842.878928026827;4909.558139767367;5006;4893.0458560581055;4915.21356582945;4941.678790878582;5003.399592048904;5017.473165317662;4327.6321512671775;4329.134173165379;4332.480102387671;4367;4374.58441448062;3761.2101458693433;3785.886423407302;3786.772793632391;3799.411091280856;3824.158685089276;4225.809838557272;4267.039916018871;4274.487061552633;4292.205941900758;4332.523422423531;5048.5203905628905;5101.081805275012;5123.590112790967;5165.715885626251;5167.0957582422925;4342.370356298319;4367.126574685076;4384.05742765307;4385.232584297735;4427.092446048552;4465.754383508874;4471.19518486669;4505.504394516601;4625.953740462553;4657.883552911137;4707.62339012885;4730.574248317668;4745.4542727585385;4768;4815.638827087912;5019.347484826949;5036.294918711456;5038.118329292286;5069.8732531687;5085.796568137233;4613.677042606985;4745.976270118627;4759.6668233223345;4761.262004389325;4813.614910807197;4851.29656199842;4940.530649588283;4965.751712414437;4969.00619876019;5057.089723849743;5072.188449848007;5086.415062267739;5087.92368114486;5090.49095090488;5124.077666020003;4931.580815630568;4936.358273424432;4938.43208031081;4939.407271127488;4987.12725273083;4771.570558649738;4829.517048295143;4834.927476087932;4883.169861123689;4899.069176856386;4870.464248932685;4887.780049897692;4892.755362231946;4908.582770464408;4915;4946.3817022872145;4979.726115063706;4988.476209997898;4989.80040798364;4994.375703037121;4669.719816811003;4699.624030077517;4812.783424745825;4826.1795494766675;4925.38432695913 06:24:26 INFO - PROCESS | 26370 | |1;ext.html;543.6466296907012;556.9053260945639;569.7009070238122;571.8884817460597;580.2775544447164;27612.44775104499;38220.23559528811;39631.60368396315;39637;43031.78484107583;39370;39662.80168599153;39738;39849;39855;7585.431092668045;7740.7677769667;7742.690292388298;7743.535387876717;7748.147703752583;7587.279208475186;7676.731314403997;7678;7680;7682.1549629540705;7653.579053152074;7712.074551053882;7712.267334603232;7713.190115037924;7713.961430192841;7611.6574754135645;7614.6192690365815;7620.276073772982;7648.311651951323;7699.923000769976;7288.854222915565;7420.332170104716;7423.331900129015;7424.33181013706;7434;36613;36974.445383319275;37046.62953370459;37059.44410833839;37082;2872.5978363029194;2883.1062370665163;2907.4766542022426;2910.1851481584977;2938.147937098239;27269.181924542296;27672;27786.444271114466;28061.859690701414;28720.138395848157;3202.743780497555;3311.718503927169;3317.9170520736934;3350.3801796667694;3351.983240083808;233376;234401.13997150207;234525;234543.99999999828;235133;47568;47852.28221576609;47866.5213347869;47951.28073078907;47992;31795.205119871727;55800.16299755507;55847;55881;56027.15959260614;11642.476088575864;12276.877231227752;12280.385980700928;12291.508339666492;12341.074419418579;9026.368154229142;9056.411333263317;9057.04900985387;9063.456192628331;9072.047435019227;17402.39091631812;17428.128593570524;17469.91265043692;17475.912620436815;17508.47474575765;6589;6757.459403247728;6762.661866906635;6765.6320287899825;6805.149356330458;757.5833291689548;798.9360851131895;868.748063061705;896.4038914122166;934.9672761453317;24468.755312446647;27576.310592235353;27946.720532794818;27970.160895173176;28019.579706304015;916.097643820836;917.564157025421;941.3363578677016;980.9411435313904;994.3139233928711;13984;14467.27663616815;14560.126392416489;14664.193469359074;14836.554903352917;363445;366096;366361;366467;367952;48072.27891581629;48168.27747583789;48179;48275;48369.758151209724;1051.8527406163143;1081.1999120650662;1127.0983213429388;1137.9361839812866;1175.2419689300352;25263.621045684697;28528.42943141167;28992.855035724686;29018.7098129016;29298.12105636834;41503.58496414997;42118.789406052776;42120.578794211666;42170.78914605407;42173;283347;283460;285983;286642;287046;30341.241468963453;30425.543616846207;31056;31426.84286578644;36009.639903600626;39800.80099599483;39858;40097.59902400939;40478.392824108254;41318.793406032775;33836.830815845766;34562.13594660053;34598.13504662403;34671.82664086764;34903.30193396169;33783.83108084542;34421.65578344184;34461.82769086239;34550.82724586361;34595.65404346025;33394.83302583471;33853.49219761755;34027.14932126716;34031.82984085064;34286.82856585701;28555.42889142247;30700.84649576738;31129;31161.688383116787;31537.21156971094;24247.878760606083;24547.263582092564;24603.876980614983;24629.753702463462;24728.763561821477 06:24:26 INFO - PROCESS | 26370 | |2;jquery.html;348.5764795773138;362.55586906040105;365.0982074276537;365.5960164018761;376.9269020387867;12832.67918302043;13202.669933251662;13955.999999999987;16536.58658533537;16569.751453728204;15152.242387880617;16465.34138634456;17162;17242.224099915504;17288.394906178288;5604.075327570956;5792.131180322943;5794.797182098628;5852.239208902836;5858.53131749459;4086.836526538935;4273.850415235467;6632.6020438773585;6917.688704008332;6972.51192416531;6793.728250869984;7006.894896576556;7067.293270672943;7084.539504932189;7091.645417729119;6836.521443498932;6849.726010959555;6863.794086177422;6863.828404289883;6865.210500792423;6432.967835160841;6668.399844014062;6689.966550167267;6703;6711.161104861892;19126.330578429828;20412.387628371172;22280.554388912293;22904.541909161722;23016.65475017876;1924.3361040441025;2017.2939471185114;2060.9793902060937;2073.3261689950677;2161.0923412166926;13749.862501374959;13998.93000535001;14350.497732579413;14638.121712697166;14873;1823.6990896502061;1824.3705921457076;1905.4188472515877;1937.4962509747568;1947.9643772258025;74302.25697743008;75689.24310756876;79359;85290.14709852885;85396.57301713513;15181.924090379478;15739.921300393426;15833.683326333408;16058.43795467153;16332;28580.285492862844;28592.571111433346;28645.71354286472;28685.426291474472;28921.85539072291;7999.84000320002;8050.758477245692;8101.473404228706;8161.79595510117;8250.46371985819;6328.557001009885;6334.208223972004;6338.112664227012;6524.836879078061;6528.183977002875;8157.918420815835;8219.465734727224;8360.205780450848;8593.398462107718;8652.8702069469;2974.2970002347215;3156.3845050215446;3281.786683865541;3291.637919828817;3364.4953257011643;751.4514404484756;794.1899262751961;797.2904115337354;830.33158307563;892.9955350223337;16114;16410.753838692428;16481.917590411973;16651.50045498637;17506.562335941704;835.3442547600105;837.6146972392646;847.588919374103;883.0595415882065;894.2041582991143;8019.83960320802;9095.408798428081;9534.18959388446;9569.569369378394;9658.806823863484;377760;379189;379454;380388;380880;76320;76360;77716;78385.21614783893;80273.59863200647;854.8674955381802;881.6737807011575;881.8060026794095;883.6112110671284;883.765802062454;14943.775843362575;14949.850501494846;15069.321880515623;15162;15421;36568.63431365652;36672.31579105243;36747.44878826873;37166.814165929;37523.2495350086;49879;50107.49892501028;50146;50208.74895625498;51306.23040654318;5560.944390556043;6903.5167538271835;7018.543794653331;7436.665350059368;7562.810929726801;11194.66416007521;11611.6516504505;11732.296062236293;11805.645830625095;11936.76126477483;9640.951795240979;9957.302988791005;10285.382877027403;10369.377837329785;10484.580616775243;9681.225501959967;9953.203743700342;9994.800103998024;10216.948915255376;10486.895131048592;10094;10230.23273254494;10362.766802764556;10498.947505262426;10645.201609879445;7459.925400745923;7468.850622987401;7613;7699.384049275933;7728.381729461742;10311.123554497952;10384.221183411124;10384.273100883167;10433;10479.580816767244 06:24:26 INFO - PROCESS | 26370 | |3;mootools.html;1204.1029433072363;1301.6745813546613;1333.4932725564288;1370.9761848973264;1598.2887615011325;6070.787522436715;6421.4541763950065;6557.540972131953;6599.703013364392;6777.3561511656435;6812.4890633202585;6868.553544019648;6884;6886.62123583204;6893.3795958363735;2095.8113769760716;2124.1928067334393;2126.075157306569;2127.0322003488454;2127.2767259131892;2073.906674199665;2104.757952835428;2105.2526353144644;2106.0838535237144;2118.7245658064508;2047.7440319960006;2074.7199128117663;2076.4497408186767;2091.205341970049;2107.8419118566167;2030.4619275891826;2064.9070791814406;2064.9896750516227;2067.1008111471406;2068.813806757399;2019.3437132931856;2038.500567361006;2071.5809670375843;2073.50235943374;2075.201047596671;6609.570377925419;6813.080234168373;6968.756093536753;6970.30296970304;6973.79078627642;4088.3049881520215;4239.745615263063;4240.915181696349;4246.723962942398;4253.255680255974;2654.694710108343;2851.458222937635;2886.047604290579;2892.3492214251623;2894.233028247516;871.6469829718974;881.2201201936333;924.8705181274627;975.1954637424153;998.4807899892088;9156.908430915739;9220.677276295297;9235.353525253235;9235.584398702074;9242.676506322246;3776.1692427666417;3843;3914.745541539791;3920.862769803043;3937.42907278443;7356.301151390609;7356.889646655304;7359.521631093961;7360.668769905367;7360.705571777069;4082.775447350424;4130.648894843972;4134.297169481196;4148;4157.584241575818;3345.7657963942293;3469;3706.925861482809;3825.139343647657;3826.1582451860545;3071.78497505177;3126.2340726522148;3248.9765723796927;3256.5603643507825;3265.9346813063607;994.418265314799;1002.5939494504737;1007.0684616729496;1008.9646862359782;1013.6685623066917;675.9797206083825;685.5098604497808;701.0850839654198;705.2806137739477;713.333033613573;4387.100644367897;4472.105578884171;4493.88765280864;4521.751303678329;4674.976625116853;373.2125215794671;388.5861557441316;390.3870922651467;403.85663089603355;407.0272049800978;3161.146490447566;3201.167696398953;3252.2032102135126;3296.9835150824574;3335.09952312879;8214.876776848352;8243.8351232975;8429.114942930904;8430.536320502308;8443.704470343508;8296.917030829734;8336.66653333872;8435.283000944988;8445.535495547803;8453.154684531497;6394.744210231539;6584.374484424068;6588.835279117964;6589.24223714279;6595.0766892635065;4611.538846115496;4652.069586082729;4655.580997710087;4759.738214398241;4805.087033463631;7401.555906645618;7645;7706.190849960898;7711.730089447067;7727.9953606033105;7323;7484.663190156565;7520.210377910459;7579.848403032019;7695.6536955836;5273.551748101301;5686.9715651421475;5786.739596718074;5835.4748072673665;5842.649441033552;5969.8806023878415;6154.846128846814;6359.04614307839;6361.173047503795;6514.120593719787;5654.773809047592;5823.970880145572;5854.414558544111;5921.259842519685;6025.548083893813;5843.795467158629;5896.439838215363;5901.616394934315;5912.674802885883;5988.970055149696;5145.228215767665;5318.57451403879;5360.65155764874;5392.433794451526;5464.508194262536;3865.9806700966315;3988.9401658974557;4001.9599804001587;4055.939160912648;4060.918781624292;3987.581303963042;4044.3529035354204;4062.2484840304637;4178.958210417978;4180.26845302077 06:24:26 INFO - PROCESS | 26370 | |4;prototype.html;297.69188889499367;301.08320165097274;303.96656367799545;306.98772049118037;308.74065784740816;4777.498362671917;4792.329073929653;4799.592034677053;4822.9035419291595;4840.709557426557;4768.523147685239;4773.832915847946;4776.665633405663;4802.879928001802;4805.351277577526;3510.947335789965;3611.494390785292;3652.5251717276715;3711.962880371202;3729.5151630288024;3733.906652333686;3734.663880250777;3740.906477338061;3742.906427339311;3761.322961866863;3695.316366472198;3715.238376132886;3715.6284371562897;3718.442233664958;3733.3466643337442;3569.6965757910607;3616.6383361663884;3686.1337585667347;3699.426588878728;3747.8500859965843;3304.6364899860996;3305.1406634275263;3309.834508274577;3323.0861513083855;3326.76712630116;4628.44458664959;4635.1656701794;4646.1404640141345;4664.813407463697;4680.180968330528;4201.579842015804;4257.233697934371;4300.8709738707885;4305.246581848195;4310.245707001262;4948.158813001798;4962.15643340633;4992.878026838579;5014.52362025607;5020.7740651670765;3631.8547258109643;3636.4545318202217;3643.143861192618;3645.1616128290643;3648.890533284006;4868.367112275417;5173.275741396207;5192.1173400522;5201.349831271091;5201.973990130025;3559.857605695743;3602.9099272518397;3612.259486805199;3618.3667858124722;3626.111602657313;3634.8546058157376;3654.689351405107;3663.120850995742;3697.685696715809;3705.1107734144152;4215.852445164404;4221;4222.472190976128;4223.880671622022;4224.704270701083;4733.881652958635;4988.5260900214425;5027.723475208899;5037.11850426174;5046.571041461443;1241.85097788266;1248.7252804383022;1249.8187762774346;1254.5985284708806;1257.6289994451658;784.3999340504519;787.4369825574742;831.5177197225595;834.4534330013729;839.9832003359899;4096.754194748325;4316.179925814085;4433.46798384196;4436.447243464826;4444.400005999149;5151.896962060813;5166.457521960216;5174.197999310113;5193.766280517386;5199.948000520022;4428.202923473741;4435.602785122676;4458.554144585515;4467.548046884775;4481.686281960231;2510.309664842183;2614.3333449970137;2627.750363715444;2647.510210611043;2653.907113251027;4677.4854765975715;4724.551167639069;4733.408323959505;4742.648345221595;4758.381410416693;4954.8653914980405;5126.743662816844;5135.35808023997;5150.330457040561;5150.48495150482;4642.634090284517;4692.7653617319;4700.459447163552;4715.24556071027;4723.45680246776;4980.526849949249;5032.496750324938;5052.747362631927;5067.898642027212;5071;4779.187538118459;4965.666136915644;4968.180250258812;4973.676711013773;4980.975095124646;4724.811007559659;4739.4075740532435;4742;4755.358026666356;4782.210935195793;3530.188056747014;3541.8406171721817;3544.6278140795876;3559.7330200235606;3576.177479179751;4990.650654454299;5003.499650034967;5006.249062640633;5008.449070602303;5039.168537191323;4647.282298314088;4737.928931065968;4796.424429068534;4841.927371089507;4885.094813022853;4843.200871856246;4857.465678775261;4858.222684370484;4876.463589005136;4876.732319471463;4787.3776409068;4798.47216806158;4799.208130658402;4814.229723244264;4828.324034635224;4741.122892264942;4894.388201474816;5062.797488100435;5078.822241221539;5086.61850361217;4932.235503496964;4947.208446648519;4957.603391728725;4959.553640172402;4959.991203562563 06:24:26 INFO - PROCESS | 26370 | |5;yui.html;563.8590352411894;593.6935007495879;595.627732667083;659.2884436437071;689.8103021669041;11828.704282392933;11931.880681193186;12159.878401215985;12278.938605306983;12695.873041269597;11455.255408398449;11522.423878806068;11544.826827597572;11547.422628868566;11562;725.365305357812;738.1732459645204;739.2681245566904;740.9925900740977;741.9501405511222;592.1946153231602;610.4871907597617;719.5071376107358;734.6363550042736;742.2095468326243;780.7657702689199;784.525362155896;784.764570628812;787.4841978504061;787.763670898731;782.3350152370497;782.4913806026043;782.788647065292;783.2441693765516;783.8393129408514;461.24586301397125;468.950760170184;551.657972057327;563.219940382569;568.4770011589347;12268.32524211168;12315.93842030793;12319.568815091428;12326;12326.137170398075;11359.772804543945;11468.254563453349;11565.190436669436;11723.531058757639;12058;8679;8758.386912916098;10558.155347572176;10679.83980240297;10761.354318740823;3896.5713771485116;3939.310620641405;3964.187341594995;3975.383815508601;4129.690273229489;47551.52448475506;48232.51767482315;48324;48634.51365486371;49331;8905.510196939102;9016.323775716848;9262.212711919428;9309.162175404246;9700.223982081558;16048.197590120448;16060.437884674215;16071.11608861524;16147.012802631316;16203.189840508163;5977.790777322773;6050.727717252734;6064.818055458343;6076.179715738407;6171.290301615371;3647.76289541179;3676.9816150919073;3679.8344074516713;3692.8522859085338;3825.387937929918;2434.4522482441307;2497.9750202497744;2500.2749202731006;2503.4242124311145;2505.9874700626747;445.57670213297496;450.17168410124873;458.1524180266547;458.83940620783125;459.9287110497878;390.48066072124004;465.8346287068042;479.72176137839966;488.3066046214384;499.9475055119233;6382.808515744535;6478.093066970628;6509.609423434609;6554.213494380705;6630.9336906630315;391.0165932679314;420.7875023113308;440.28893337260735;441.68860953028036;482.4018217410456;3158.652548219694;3191.5372271021038;3525.9294814103573;3557.1107223194203;3679.411294192916;62350;65887;67236.39088639825;68177;71015.64492177506;46992.5300746995;47909.9999999993;59999.40000600025;61733.074003889975;61877;44337.556624433986;48413.5158648409;50535.49464505308;52814.73592632089;52970.73514632402;7385.9261407387385;7489.475736698379;7583.7724868254045;7639.083310002613;7751.992241008633;26676.466470670865;30043.94846180373;32947.50578741273;35087.29825403529;35590.8220458896;42249.155016900106;47742.283865742735;48247.5175248243;48629;49316;8931.821363572823;9505.952470237604;9529.475878826453;9731.854022189815;9851.753706157404;10880.564777408816;10986.176036797113;11169.609063682732;11294;11294.209405341548;9487.430754154773;9619.27855410861;9803.705888823346;9829.066238707312;10179;10283.7429064271;10310.381377117397;10474.21443391764;10516.26386152962;10695.89304106949;9345.53272336394;9515.952420237854;9578.408096963638;9604.327697061139;9805.656802011896;8270.875936861072;8548.615312311085;8714.520701361485;8887.377883548348;9003.639854406012;7358.216625338726;7771.106322772954;7825.608719564113;7968.7609371718945;8195.238023824906 06:24:26 INFO - PROCESS | 26370 | __end_tp_report 06:24:26 INFO - PROCESS | 26370 | __start_cc_report 06:24:26 INFO - PROCESS | 26370 | _x_x_mozilla_cycle_collect,1240 06:24:26 INFO - PROCESS | 26370 | __end_cc_report 06:24:26 INFO - PROCESS | 26370 | __startTimestamp1478528666423__endTimestamp 06:24:26 INFO - PROCESS | 26370 | 06:24:26 INFO - PROCESS | 26370 | ------- Summary: start ------- 06:24:26 INFO - PROCESS | 26370 | Number of tests: 6 06:24:26 INFO - PROCESS | 26370 | 06:24:26 INFO - PROCESS | 26370 | [#0] dojo.html Cycles:165 Average:4662.84 Median:4768.00 stddev:486.18 (10.2%) stddev-sans-first:459.85 06:24:26 INFO - PROCESS | 26370 | Values: 2596.1 2597.0 2649.3 2650.4 2663.6 4553.2 4643.8 4661.3 4698.2 4714.2 4640.8 4667.4 4699.3 4730.6 4786.5 4296.1 4299.4 4335.2 4392.5 4395.1 4389.5 4408.1 4417.7 4421.4 4463.8 4233.7 4356.9 4368.1 4389.0 4459.9 4265.6 4300.8 4324.3 4327.3 4338.0 4298.1 4302.3 4303.7 4304.9 4313.3 4668.8 4681.0 4684.2 4688.4 4692.1 4988.1 5031.4 5040.8 5062.4 5119.0 5069.0 5073.0 5081.5 5082.8 5133.8 4634.7 4677.6 4736.1 4739.9 4783.4 5135.2 5168.2 5185.5 5191.7 5211.1 4948.4 4985.4 4991.5 4998.4 5016.2 5090.8 5093.3 5096.5 5097.7 5135.1 4798.5 4839.6 4842.9 4909.6 5006.0 4893.0 4915.2 4941.7 5003.4 5017.5 4327.6 4329.1 4332.5 4367.0 4374.6 3761.2 3785.9 3786.8 3799.4 3824.2 4225.8 4267.0 4274.5 4292.2 4332.5 5048.5 5101.1 5123.6 5165.7 5167.1 4342.4 4367.1 4384.1 4385.2 4427.1 4465.8 4471.2 4505.5 4626.0 4657.9 4707.6 4730.6 4745.5 4768.0 4815.6 5019.3 5036.3 5038.1 5069.9 5085.8 4613.7 4746.0 4759.7 4761.3 4813.6 4851.3 4940.5 4965.8 4969.0 5057.1 5072.2 5086.4 5087.9 5090.5 5124.1 4931.6 4936.4 4938.4 4939.4 4987.1 4771.6 4829.5 4834.9 4883.2 4899.1 4870.5 4887.8 4892.8 4908.6 4915.0 4946.4 4979.7 4988.5 4989.8 4994.4 4669.7 4699.6 4812.8 4826.2 4925.4 06:24:26 INFO - PROCESS | 26370 | 06:24:26 INFO - PROCESS | 26370 | [#1] ext.html Cycles:180 Average:44731.72 Median:366414.00 stddev:78907.66 (21.5%) stddev-sans-first:79059.26 06:24:26 INFO - PROCESS | 26370 | Values: 543.6 556.9 569.7 571.9 580.3 27612.4 38220.2 39631.6 39637.0 43031.8 39370.0 39662.8 39738.0 39849.0 39855.0 7585.4 7740.8 7742.7 7743.5 7748.1 7587.3 7676.7 7678.0 7680.0 7682.2 7653.6 7712.1 7712.3 7713.2 7714.0 7611.7 7614.6 7620.3 7648.3 7699.9 7288.9 7420.3 7423.3 7424.3 7434.0 36613.0 36974.4 37046.6 37059.4 37082.0 2872.6 2883.1 2907.5 2910.2 2938.1 27269.2 27672.0 27786.4 28061.9 28720.1 3202.7 3311.7 3317.9 3350.4 3352.0 233376.0 234401.1 234525.0 234544.0 235133.0 47568.0 47852.3 47866.5 47951.3 47992.0 31795.2 55800.2 55847.0 55881.0 56027.2 11642.5 12276.9 12280.4 12291.5 12341.1 9026.4 9056.4 9057.0 9063.5 9072.0 17402.4 17428.1 17469.9 17475.9 17508.5 6589.0 6757.5 6762.7 6765.6 6805.1 757.6 798.9 868.7 896.4 935.0 24468.8 27576.3 27946.7 27970.2 28019.6 916.1 917.6 941.3 980.9 994.3 13984.0 14467.3 14560.1 14664.2 14836.6 363445.0 366096.0 366361.0 366467.0 367952.0 48072.3 48168.3 48179.0 48275.0 48369.8 1051.9 1081.2 1127.1 1137.9 1175.2 25263.6 28528.4 28992.9 29018.7 29298.1 41503.6 42118.8 42120.6 42170.8 42173.0 283347.0 283460.0 285983.0 286642.0 287046.0 30341.2 30425.5 31056.0 31426.8 36009.6 39800.8 39858.0 40097.6 40478.4 41318.8 33836.8 34562.1 34598.1 34671.8 34903.3 33783.8 34421.7 34461.8 34550.8 34595.7 33394.8 33853.5 34027.1 34031.8 34286.8 28555.4 30700.8 31129.0 31161.7 31537.2 24247.9 24547.3 24603.9 24629.8 24728.8 06:24:26 INFO - PROCESS | 26370 | 06:24:26 INFO - PROCESS | 26370 | [#2] jquery.html Cycles:180 Average:25260.36 Median:4180.34 stddev:62836.12 (1503.1%) stddev-sans-first:62984.55 06:24:26 INFO - PROCESS | 26370 | Values: 348.6 362.6 365.1 365.6 376.9 12832.7 13202.7 13956.0 16536.6 16569.8 15152.2 16465.3 17162.0 17242.2 17288.4 5604.1 5792.1 5794.8 5852.2 5858.5 4086.8 4273.9 6632.6 6917.7 6972.5 6793.7 7006.9 7067.3 7084.5 7091.6 6836.5 6849.7 6863.8 6863.8 6865.2 6433.0 6668.4 6690.0 6703.0 6711.2 19126.3 20412.4 22280.6 22904.5 23016.7 1924.3 2017.3 2061.0 2073.3 2161.1 13749.9 13998.9 14350.5 14638.1 14873.0 1823.7 1824.4 1905.4 1937.5 1948.0 74302.3 75689.2 79359.0 85290.1 85396.6 15181.9 15739.9 15833.7 16058.4 16332.0 28580.3 28592.6 28645.7 28685.4 28921.9 7999.8 8050.8 8101.5 8161.8 8250.5 6328.6 6334.2 6338.1 6524.8 6528.2 8157.9 8219.5 8360.2 8593.4 8652.9 2974.3 3156.4 3281.8 3291.6 3364.5 751.5 794.2 797.3 830.3 893.0 16114.0 16410.8 16481.9 16651.5 17506.6 835.3 837.6 847.6 883.1 894.2 8019.8 9095.4 9534.2 9569.6 9658.8 377760.0 379189.0 379454.0 380388.0 380880.0 76320.0 76360.0 77716.0 78385.2 80273.6 854.9 881.7 881.8 883.6 883.8 14943.8 14949.9 15069.3 15162.0 15421.0 36568.6 36672.3 36747.4 37166.8 37523.2 49879.0 50107.5 50146.0 50208.7 51306.2 5560.9 6903.5 7018.5 7436.7 7562.8 11194.7 11611.7 11732.3 11805.6 11936.8 9641.0 9957.3 10285.4 10369.4 10484.6 9681.2 9953.2 9994.8 10216.9 10486.9 10094.0 10230.2 10362.8 10498.9 10645.2 7459.9 7468.9 7613.0 7699.4 7728.4 10311.1 10384.2 10384.3 10433.0 10479.6 06:24:26 INFO - PROCESS | 26370 | 06:24:26 INFO - PROCESS | 26370 | [#3] mootools.html Cycles:180 Average:4487.31 Median:4665.28 stddev:2429.94 (52.1%) stddev-sans-first:2424.23 06:24:26 INFO - PROCESS | 26370 | Values: 1204.1 1301.7 1333.5 1371.0 1598.3 6070.8 6421.5 6557.5 6599.7 6777.4 6812.5 6868.6 6884.0 6886.6 6893.4 2095.8 2124.2 2126.1 2127.0 2127.3 2073.9 2104.8 2105.3 2106.1 2118.7 2047.7 2074.7 2076.4 2091.2 2107.8 2030.5 2064.9 2065.0 2067.1 2068.8 2019.3 2038.5 2071.6 2073.5 2075.2 6609.6 6813.1 6968.8 6970.3 6973.8 4088.3 4239.7 4240.9 4246.7 4253.3 2654.7 2851.5 2886.0 2892.3 2894.2 871.6 881.2 924.9 975.2 998.5 9156.9 9220.7 9235.4 9235.6 9242.7 3776.2 3843.0 3914.7 3920.9 3937.4 7356.3 7356.9 7359.5 7360.7 7360.7 4082.8 4130.6 4134.3 4148.0 4157.6 3345.8 3469.0 3706.9 3825.1 3826.2 3071.8 3126.2 3249.0 3256.6 3265.9 994.4 1002.6 1007.1 1009.0 1013.7 676.0 685.5 701.1 705.3 713.3 4387.1 4472.1 4493.9 4521.8 4675.0 373.2 388.6 390.4 403.9 407.0 3161.1 3201.2 3252.2 3297.0 3335.1 8214.9 8243.8 8429.1 8430.5 8443.7 8296.9 8336.7 8435.3 8445.5 8453.2 6394.7 6584.4 6588.8 6589.2 6595.1 4611.5 4652.1 4655.6 4759.7 4805.1 7401.6 7645.0 7706.2 7711.7 7728.0 7323.0 7484.7 7520.2 7579.8 7695.7 5273.6 5687.0 5786.7 5835.5 5842.6 5969.9 6154.8 6359.0 6361.2 6514.1 5654.8 5824.0 5854.4 5921.3 6025.5 5843.8 5896.4 5901.6 5912.7 5989.0 5145.2 5318.6 5360.7 5392.4 5464.5 3866.0 3988.9 4002.0 4055.9 4060.9 3987.6 4044.4 4062.2 4179.0 4180.3 06:24:26 INFO - PROCESS | 26370 | 06:24:26 INFO - PROCESS | 26370 | [#4] prototype.html Cycles:180 Average:4109.93 Median:4719.35 stddev:1190.62 (25.2%) stddev-sans-first:1159.07 06:24:26 INFO - PROCESS | 26370 | Values: 297.7 301.1 304.0 307.0 308.7 4777.5 4792.3 4799.6 4822.9 4840.7 4768.5 4773.8 4776.7 4802.9 4805.4 3510.9 3611.5 3652.5 3712.0 3729.5 3733.9 3734.7 3740.9 3742.9 3761.3 3695.3 3715.2 3715.6 3718.4 3733.3 3569.7 3616.6 3686.1 3699.4 3747.9 3304.6 3305.1 3309.8 3323.1 3326.8 4628.4 4635.2 4646.1 4664.8 4680.2 4201.6 4257.2 4300.9 4305.2 4310.2 4948.2 4962.2 4992.9 5014.5 5020.8 3631.9 3636.5 3643.1 3645.2 3648.9 4868.4 5173.3 5192.1 5201.3 5202.0 3559.9 3602.9 3612.3 3618.4 3626.1 3634.9 3654.7 3663.1 3697.7 3705.1 4215.9 4221.0 4222.5 4223.9 4224.7 4733.9 4988.5 5027.7 5037.1 5046.6 1241.9 1248.7 1249.8 1254.6 1257.6 784.4 787.4 831.5 834.5 840.0 4096.8 4316.2 4433.5 4436.4 4444.4 5151.9 5166.5 5174.2 5193.8 5199.9 4428.2 4435.6 4458.6 4467.5 4481.7 2510.3 2614.3 2627.8 2647.5 2653.9 4677.5 4724.6 4733.4 4742.6 4758.4 4954.9 5126.7 5135.4 5150.3 5150.5 4642.6 4692.8 4700.5 4715.2 4723.5 4980.5 5032.5 5052.7 5067.9 5071.0 4779.2 4965.7 4968.2 4973.7 4981.0 4724.8 4739.4 4742.0 4755.4 4782.2 3530.2 3541.8 3544.6 3559.7 3576.2 4990.7 5003.5 5006.2 5008.4 5039.2 4647.3 4737.9 4796.4 4841.9 4885.1 4843.2 4857.5 4858.2 4876.5 4876.7 4787.4 4798.5 4799.2 4814.2 4828.3 4741.1 4894.4 5062.8 5078.8 5086.6 4932.2 4947.2 4957.6 4959.6 4960.0 06:24:26 INFO - PROCESS | 26370 | 06:24:26 INFO - PROCESS | 26370 | [#5] yui.html Cycles:180 Average:13589.91 Median:24561.41 stddev:17488.04 (71.2%) stddev-sans-first:17509.74 06:24:26 INFO - PROCESS | 26370 | Values: 563.9 593.7 595.6 659.3 689.8 11828.7 11931.9 12159.9 12278.9 12695.9 11455.3 11522.4 11544.8 11547.4 11562.0 725.4 738.2 739.3 741.0 742.0 592.2 610.5 719.5 734.6 742.2 780.8 784.5 784.8 787.5 787.8 782.3 782.5 782.8 783.2 783.8 461.2 469.0 551.7 563.2 568.5 12268.3 12315.9 12319.6 12326.0 12326.1 11359.8 11468.3 11565.2 11723.5 12058.0 8679.0 8758.4 10558.2 10679.8 10761.4 3896.6 3939.3 3964.2 3975.4 4129.7 47551.5 48232.5 48324.0 48634.5 49331.0 8905.5 9016.3 9262.2 9309.2 9700.2 16048.2 16060.4 16071.1 16147.0 16203.2 5977.8 6050.7 6064.8 6076.2 6171.3 3647.8 3677.0 3679.8 3692.9 3825.4 2434.5 2498.0 2500.3 2503.4 2506.0 445.6 450.2 458.2 458.8 459.9 390.5 465.8 479.7 488.3 499.9 6382.8 6478.1 6509.6 6554.2 6630.9 391.0 420.8 440.3 441.7 482.4 3158.7 3191.5 3525.9 3557.1 3679.4 62350.0 65887.0 67236.4 68177.0 71015.6 46992.5 47910.0 59999.4 61733.1 61877.0 44337.6 48413.5 50535.5 52814.7 52970.7 7385.9 7489.5 7583.8 7639.1 7752.0 26676.5 30043.9 32947.5 35087.3 35590.8 42249.2 47742.3 48247.5 48629.0 49316.0 8931.8 9506.0 9529.5 9731.9 9851.8 10880.6 10986.2 11169.6 11294.0 11294.2 9487.4 9619.3 9803.7 9829.1 10179.0 10283.7 10310.4 10474.2 10516.3 10695.9 9345.5 9516.0 9578.4 9604.3 9805.7 8270.9 8548.6 8714.5 8887.4 9003.6 7358.2 7771.1 7825.6 7968.8 8195.2 06:24:26 INFO - PROCESS | 26370 | -------- Summary: end -------- 06:24:26 INFO - PROCESS | 26370 | 06:24:27 INFO - TEST-INFO | 26370: exit 0 06:24:27 INFO - TEST-OK | dromaeo_css | took 1121462ms 06:24:27 INFO - TEST-START | kraken 06:24:27 INFO - operating with platform_type : linux_ 06:24:27 INFO - Initialising browser for kraken test... 06:24:27 INFO - TEST-INFO | started process 26677 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9H8IJX/profile http://localhost:58606/getInfo.html) 06:24:31 INFO - PROCESS | 26677 | __metrics Screen width/height:1600/1200 06:24:31 INFO - PROCESS | 26677 | colorDepth:24 06:24:31 INFO - PROCESS | 26677 | Browser inner width/height: 1024/697 06:24:31 INFO - PROCESS | 26677 | __metrics 06:24:32 INFO - PROCESS | 26677 | 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:24:32 INFO - PROCESS | 26677 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:24:32 INFO - PROCESS | 26677 | console.error: PushService: 06:24:32 INFO - PROCESS | 26677 | stateChangeProcessEnqueue: Error transitioning state 06:24:32 INFO - PROCESS | 26677 | UnknownError 06:24:33 INFO - TEST-INFO | 26677: exit 0 06:24:33 INFO - Browser initialized. 06:24:33 INFO - Running cycle 1/1 for kraken test... 06:24:33 INFO - TEST-INFO | started process 26759 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9H8IJX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:24:45 INFO - PROCESS | 26759 | RSS: Main: 174899200 06:24:45 INFO - PROCESS | 26759 | 06:24:48 INFO - PROCESS | 26759 | Cycle 1(1): loaded http://localhost:58606/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58606/tests/kraken/driver.html?testName=audio-beat-detection) 06:24:49 INFO - PROCESS | 26759 | RSS: Main: 230739968 06:24:49 INFO - PROCESS | 26759 | 06:24:52 INFO - PROCESS | 26759 | Cycle 1(1): loaded http://localhost:58606/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58606/tests/kraken/driver.html?testName=audio-dft) 06:24:52 INFO - PROCESS | 26759 | RSS: Main: 217858048 06:24:52 INFO - PROCESS | 26759 | 06:24:55 INFO - PROCESS | 26759 | Cycle 1(1): loaded http://localhost:58606/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58606/tests/kraken/driver.html?testName=audio-fft) 06:24:56 INFO - PROCESS | 26759 | RSS: Main: 299876352 06:24:56 INFO - PROCESS | 26759 | 06:24:58 INFO - PROCESS | 26759 | Cycle 1(1): loaded http://localhost:58606/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58606/tests/kraken/driver.html?testName=audio-oscillator) 06:24:59 INFO - PROCESS | 26759 | RSS: Main: 210776064 06:24:59 INFO - PROCESS | 26759 | 06:25:01 INFO - PROCESS | 26759 | Cycle 1(1): loaded http://localhost:58606/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58606/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:25:02 INFO - PROCESS | 26759 | RSS: Main: 213823488 06:25:02 INFO - PROCESS | 26759 | 06:25:05 INFO - PROCESS | 26759 | Cycle 1(1): loaded http://localhost:58606/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58606/tests/kraken/driver.html?testName=imaging-darkroom) 06:25:05 INFO - PROCESS | 26759 | RSS: Main: 249741312 06:25:05 INFO - PROCESS | 26759 | 06:25:09 INFO - PROCESS | 26759 | Cycle 1(1): loaded http://localhost:58606/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58606/tests/kraken/driver.html?testName=imaging-desaturate) 06:25:09 INFO - PROCESS | 26759 | RSS: Main: 251207680 06:25:09 INFO - PROCESS | 26759 | 06:25:12 INFO - PROCESS | 26759 | Cycle 1(1): loaded http://localhost:58606/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58606/tests/kraken/driver.html?testName=json-parse-financial) 06:25:13 INFO - PROCESS | 26759 | RSS: Main: 252956672 06:25:13 INFO - PROCESS | 26759 | 06:25:14 INFO - PROCESS | 26759 | Cycle 1(1): loaded http://localhost:58606/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58606/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:25:15 INFO - PROCESS | 26759 | RSS: Main: 211251200 06:25:15 INFO - PROCESS | 26759 | 06:25:17 INFO - PROCESS | 26759 | Cycle 1(1): loaded http://localhost:58606/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58606/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:25:18 INFO - PROCESS | 26759 | RSS: Main: 217743360 06:25:18 INFO - PROCESS | 26759 | 06:25:20 INFO - PROCESS | 26759 | Cycle 1(1): loaded http://localhost:58606/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58606/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:25:20 INFO - PROCESS | 26759 | RSS: Main: 227000320 06:25:20 INFO - PROCESS | 26759 | 06:25:23 INFO - PROCESS | 26759 | Cycle 1(1): loaded http://localhost:58606/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58606/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:25:24 INFO - PROCESS | 26759 | RSS: Main: 235593728 06:25:24 INFO - PROCESS | 26759 | 06:25:27 INFO - PROCESS | 26759 | Cycle 1(1): loaded http://localhost:58606/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58606/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:25:28 INFO - PROCESS | 26759 | RSS: Main: 232353792 06:25:28 INFO - PROCESS | 26759 | 06:25:29 INFO - PROCESS | 26759 | Cycle 1(1): loaded http://localhost:58606/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58606/tests/kraken/driver.html?testName=ai-astar) 06:25:30 INFO - PROCESS | 26759 | RSS: Main: 283017216 06:25:30 INFO - PROCESS | 26759 | 06:25:30 INFO - PROCESS | 26759 | __start_tp_report 06:25:30 INFO - PROCESS | 26759 | _x_x_mozilla_page_load 06:25:30 INFO - PROCESS | 26759 | _x_x_mozilla_page_load_details 06:25:30 INFO - PROCESS | 26759 | |i|pagename|runs| 06:25:30 INFO - PROCESS | 26759 | |0;ai-astar;108;114;115;117;116;114;115;115;114;116 06:25:30 INFO - PROCESS | 26759 | |1;audio-beat-detection;152;127;128;175;127;131;127;129;161;134 06:25:30 INFO - PROCESS | 26759 | |2;audio-dft;162;160;162;162;162;160;159;162;161;161 06:25:30 INFO - PROCESS | 26759 | |3;audio-fft;74;76;78;111;76;77;77;77;101;77 06:25:30 INFO - PROCESS | 26759 | |4;audio-oscillator;84;84;113;84;83;84;116;83;84;112 06:25:30 INFO - PROCESS | 26759 | |5;imaging-gaussian-blur;117;116;117;117;117;118;117;117;116;117 06:25:30 INFO - PROCESS | 26759 | |6;imaging-darkroom;147;148;147;146;147;149;147;146;147;147 06:25:30 INFO - PROCESS | 26759 | |7;imaging-desaturate;84;85;84;85;84;85;85;84;84;84 06:25:30 INFO - PROCESS | 26759 | |8;json-parse-financial;65;63;64;63;64;64;65;64;65;67 06:25:30 INFO - PROCESS | 26759 | |9;json-stringify-tinderbox;66;66;66;67;67;67;66;67;67;66 06:25:30 INFO - PROCESS | 26759 | |10;stanford-crypto-aes;84;92;84;87;90;84;85;86;84;92 06:25:30 INFO - PROCESS | 26759 | |11;stanford-crypto-ccm;144;144;145;144;146;141;137;140;192;141 06:25:30 INFO - PROCESS | 26759 | |12;stanford-crypto-pbkdf2;179;175;177;176;174;183;176;172;172;174 06:25:30 INFO - PROCESS | 26759 | |13;stanford-crypto-sha256-iterative;71;69;69;73;71;71;71;68;68;68 06:25:30 INFO - PROCESS | 26759 | __end_tp_report 06:25:30 INFO - PROCESS | 26759 | __start_cc_report 06:25:30 INFO - PROCESS | 26759 | _x_x_mozilla_cycle_collect,1934 06:25:30 INFO - PROCESS | 26759 | __end_cc_report 06:25:30 INFO - PROCESS | 26759 | __startTimestamp1478528730077__endTimestamp 06:25:30 INFO - PROCESS | 26759 | 06:25:30 INFO - PROCESS | 26759 | ------- Summary: start ------- 06:25:30 INFO - PROCESS | 26759 | Number of tests: 14 06:25:30 INFO - PROCESS | 26759 | 06:25:30 INFO - PROCESS | 26759 | [#0] ai-astar Cycles:10 Average:114.40 Median:115.00 stddev:2.46 (2.1%) stddev-sans-first:1.05 06:25:30 INFO - PROCESS | 26759 | Values: 108.0 114.0 115.0 117.0 116.0 114.0 115.0 115.0 114.0 116.0 06:25:30 INFO - PROCESS | 26759 | 06:25:30 INFO - PROCESS | 26759 | [#1] audio-beat-detection Cycles:10 Average:139.10 Median:132.50 stddev:17.29 (13.1%) stddev-sans-first:17.70 06:25:30 INFO - PROCESS | 26759 | Values: 152.0 127.0 128.0 175.0 127.0 131.0 127.0 129.0 161.0 134.0 06:25:30 INFO - PROCESS | 26759 | 06:25:30 INFO - PROCESS | 26759 | [#2] audio-dft Cycles:10 Average:161.10 Median:162.00 stddev:1.10 (0.7%) stddev-sans-first:1.12 06:25:30 INFO - PROCESS | 26759 | Values: 162.0 160.0 162.0 162.0 162.0 160.0 159.0 162.0 161.0 161.0 06:25:30 INFO - PROCESS | 26759 | 06:25:30 INFO - PROCESS | 26759 | [#3] audio-fft Cycles:10 Average:82.40 Median:77.00 stddev:12.70 (16.5%) stddev-sans-first:13.11 06:25:30 INFO - PROCESS | 26759 | Values: 74.0 76.0 78.0 111.0 76.0 77.0 77.0 77.0 101.0 77.0 06:25:30 INFO - PROCESS | 26759 | 06:25:30 INFO - PROCESS | 26759 | [#4] audio-oscillator Cycles:10 Average:92.70 Median:84.00 stddev:14.51 (17.3%) stddev-sans-first:15.04 06:25:30 INFO - PROCESS | 26759 | Values: 84.0 84.0 113.0 84.0 83.0 84.0 116.0 83.0 84.0 112.0 06:25:30 INFO - PROCESS | 26759 | 06:25:30 INFO - PROCESS | 26759 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 06:25:30 INFO - PROCESS | 26759 | Values: 117.0 116.0 117.0 117.0 117.0 118.0 117.0 117.0 116.0 117.0 06:25:30 INFO - PROCESS | 26759 | 06:25:30 INFO - PROCESS | 26759 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:0.88 (0.6%) stddev-sans-first:0.93 06:25:30 INFO - PROCESS | 26759 | Values: 147.0 148.0 147.0 146.0 147.0 149.0 147.0 146.0 147.0 147.0 06:25:30 INFO - PROCESS | 26759 | 06:25:30 INFO - PROCESS | 26759 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 06:25:30 INFO - PROCESS | 26759 | Values: 84.0 85.0 84.0 85.0 84.0 85.0 85.0 84.0 84.0 84.0 06:25:30 INFO - PROCESS | 26759 | 06:25:30 INFO - PROCESS | 26759 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:64.50 stddev:1.17 (1.8%) stddev-sans-first:1.22 06:25:30 INFO - PROCESS | 26759 | Values: 65.0 63.0 64.0 63.0 64.0 64.0 65.0 64.0 65.0 67.0 06:25:30 INFO - PROCESS | 26759 | 06:25:30 INFO - PROCESS | 26759 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:67.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 06:25:30 INFO - PROCESS | 26759 | Values: 66.0 66.0 66.0 67.0 67.0 67.0 66.0 67.0 67.0 66.0 06:25:30 INFO - PROCESS | 26759 | 06:25:30 INFO - PROCESS | 26759 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:86.50 stddev:3.33 (3.8%) stddev-sans-first:3.37 06:25:30 INFO - PROCESS | 26759 | Values: 84.0 92.0 84.0 87.0 90.0 84.0 85.0 86.0 84.0 92.0 06:25:30 INFO - PROCESS | 26759 | 06:25:30 INFO - PROCESS | 26759 | [#11] stanford-crypto-ccm Cycles:10 Average:147.40 Median:144.00 stddev:15.90 (11.0%) stddev-sans-first:16.82 06:25:30 INFO - PROCESS | 26759 | Values: 144.0 144.0 145.0 144.0 146.0 141.0 137.0 140.0 192.0 141.0 06:25:30 INFO - PROCESS | 26759 | 06:25:30 INFO - PROCESS | 26759 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.80 Median:176.00 stddev:3.33 (1.9%) stddev-sans-first:3.32 06:25:30 INFO - PROCESS | 26759 | Values: 179.0 175.0 177.0 176.0 174.0 183.0 176.0 172.0 172.0 174.0 06:25:30 INFO - PROCESS | 26759 | 06:25:30 INFO - PROCESS | 26759 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:71.00 stddev:1.73 (2.4%) stddev-sans-first:1.79 06:25:30 INFO - PROCESS | 26759 | Values: 71.0 69.0 69.0 73.0 71.0 71.0 71.0 68.0 68.0 68.0 06:25:30 INFO - PROCESS | 26759 | -------- Summary: end -------- 06:25:30 INFO - PROCESS | 26759 | 06:25:31 INFO - TEST-INFO | 26759: exit 0 06:25:31 INFO - TEST-OK | kraken | took 63965ms 06:25:31 INFO - SUITE-END | took 1185s 06:25:31 INFO - Completed test suite (00:19:45) 06:25:31 INFO - javascript benchmark 06:25:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2596.130296350723, 2597.0, 2649.2714503511534, 2650.403659176685, 2663.560512515436, 4553.248713962193, 4643.7910294036765, 4661.254199328108, 4698.201305778013, 4714.198586240339, 4640.837570685027, 4667.416572928384, 4699.2951057341415, 4730.574248317651, 4786.545278198574, 4296.0548679290505, 4299.419578356913, 4335.176316499855, 4392.494863090737, 4395.099004704044, 4389.539098394671, 4408.074304396081, 4417.73493590384, 4421.447319085114, 4463.754493502856, 4233.745975241464, 4356.869293921188, 4368.060866913629, 4389.034412429261, 4459.866204013885, 4265.616094551505, 4300.78496075195, 4324.286492728696, 4327.285997810389, 4337.956620433787, 4298.054428025829, 4302.311630139194, 4303.698741088125, 4304.9139017219795, 4313.331433627762, 4668.766561671903, 4680.953190468086, 4684.203685373494, 4688.367070445481, 4692.085043416535, 4988.052270068675, 5031.4465408805, 5040.823571174991, 5062.417821950449, 5119.0, 5069.0115427491655, 5073.036123136592, 5081.5426611605135, 5082.847514574569, 5133.845984620468, 4634.652401069933, 4677.555632214934, 4736.147493451212, 4739.905201895943, 4783.354247176587, 5135.204043373283, 5168.173092305288, 5185.533302002837, 5191.740412979411, 5211.140161873249, 4948.3943248629985, 4985.426675932242, 4991.450940396553, 4998.350214472095, 5016.172331565251, 5090.847274581768, 5093.261477085876, 5096.490350964948, 5097.745112744422, 5135.12702840518, 4798.520147985243, 4839.588634965997, 4842.878928026827, 4909.558139767367, 5006.0, 4893.0458560581055, 4915.21356582945, 4941.678790878582, 5003.399592048904, 5017.473165317662, 4327.6321512671775, 4329.134173165379, 4332.480102387671, 4367.0, 4374.58441448062, 3761.2101458693433, 3785.886423407302, 3786.772793632391, 3799.411091280856, 3824.158685089276, 4225.809838557272, 4267.039916018871, 4274.487061552633, 4292.205941900758, 4332.523422423531, 5048.5203905628905, 5101.081805275012, 5123.590112790967, 5165.715885626251, 5167.0957582422925, 4342.370356298319, 4367.126574685076, 4384.05742765307, 4385.232584297735, 4427.092446048552, 4465.754383508874, 4471.19518486669, 4505.504394516601, 4625.953740462553, 4657.883552911137, 4707.62339012885, 4730.574248317668, 4745.4542727585385, 4768.0, 4815.638827087912, 5019.347484826949, 5036.294918711456, 5038.118329292286, 5069.8732531687, 5085.796568137233, 4613.677042606985, 4745.976270118627, 4759.6668233223345, 4761.262004389325, 4813.614910807197, 4851.29656199842, 4940.530649588283, 4965.751712414437, 4969.00619876019, 5057.089723849743, 5072.188449848007, 5086.415062267739, 5087.92368114486, 5090.49095090488, 5124.077666020003, 4931.580815630568, 4936.358273424432, 4938.43208031081, 4939.407271127488, 4987.12725273083, 4771.570558649738, 4829.517048295143, 4834.927476087932, 4883.169861123689, 4899.069176856386, 4870.464248932685, 4887.780049897692, 4892.755362231946, 4908.582770464408, 4915.0, 4946.3817022872145, 4979.726115063706, 4988.476209997898, 4989.80040798364, 4994.375703037121, 4669.719816811003, 4699.624030077517, 4812.783424745825, 4826.1795494766675, 4925.38432695913], "value": 4631.934250599445, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [543.6466296907012, 556.9053260945639, 569.7009070238122, 571.8884817460597, 580.2775544447164, 27612.44775104499, 38220.23559528811, 39631.60368396315, 39637.0, 43031.78484107583, 39370.0, 39662.80168599153, 39738.0, 39849.0, 39855.0, 7585.431092668045, 7740.7677769667, 7742.690292388298, 7743.535387876717, 7748.147703752583, 7587.279208475186, 7676.731314403997, 7678.0, 7680.0, 7682.1549629540705, 7653.579053152074, 7712.074551053882, 7712.267334603232, 7713.190115037924, 7713.961430192841, 7611.6574754135645, 7614.6192690365815, 7620.276073772982, 7648.311651951323, 7699.923000769976, 7288.854222915565, 7420.332170104716, 7423.331900129015, 7424.33181013706, 7434.0, 36613.0, 36974.445383319275, 37046.62953370459, 37059.44410833839, 37082.0, 2872.5978363029194, 2883.1062370665163, 2907.4766542022426, 2910.1851481584977, 2938.147937098239, 27269.181924542296, 27672.0, 27786.444271114466, 28061.859690701414, 28720.138395848157, 3202.743780497555, 3311.718503927169, 3317.9170520736934, 3350.3801796667694, 3351.983240083808, 233376.0, 234401.13997150207, 234525.0, 234543.99999999828, 235133.0, 47568.0, 47852.28221576609, 47866.5213347869, 47951.28073078907, 47992.0, 31795.205119871727, 55800.16299755507, 55847.0, 55881.0, 56027.15959260614, 11642.476088575864, 12276.877231227752, 12280.385980700928, 12291.508339666492, 12341.074419418579, 9026.368154229142, 9056.411333263317, 9057.04900985387, 9063.456192628331, 9072.047435019227, 17402.39091631812, 17428.128593570524, 17469.91265043692, 17475.912620436815, 17508.47474575765, 6589.0, 6757.459403247728, 6762.661866906635, 6765.6320287899825, 6805.149356330458, 757.5833291689548, 798.9360851131895, 868.748063061705, 896.4038914122166, 934.9672761453317, 24468.755312446647, 27576.310592235353, 27946.720532794818, 27970.160895173176, 28019.579706304015, 916.097643820836, 917.564157025421, 941.3363578677016, 980.9411435313904, 994.3139233928711, 13984.0, 14467.27663616815, 14560.126392416489, 14664.193469359074, 14836.554903352917, 363445.0, 366096.0, 366361.0, 366467.0, 367952.0, 48072.27891581629, 48168.27747583789, 48179.0, 48275.0, 48369.758151209724, 1051.8527406163143, 1081.1999120650662, 1127.0983213429388, 1137.9361839812866, 1175.2419689300352, 25263.621045684697, 28528.42943141167, 28992.855035724686, 29018.7098129016, 29298.12105636834, 41503.58496414997, 42118.789406052776, 42120.578794211666, 42170.78914605407, 42173.0, 283347.0, 283460.0, 285983.0, 286642.0, 287046.0, 30341.241468963453, 30425.543616846207, 31056.0, 31426.84286578644, 36009.639903600626, 39800.80099599483, 39858.0, 40097.59902400939, 40478.392824108254, 41318.793406032775, 33836.830815845766, 34562.13594660053, 34598.13504662403, 34671.82664086764, 34903.30193396169, 33783.83108084542, 34421.65578344184, 34461.82769086239, 34550.82724586361, 34595.65404346025, 33394.83302583471, 33853.49219761755, 34027.14932126716, 34031.82984085064, 34286.82856585701, 28555.42889142247, 30700.84649576738, 31129.0, 31161.688383116787, 31537.21156971094, 24247.878760606083, 24547.263582092564, 24603.876980614983, 24629.753702463462, 24728.763561821477], "value": 16809.69464472207, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.5764795773138, 362.55586906040105, 365.0982074276537, 365.5960164018761, 376.9269020387867, 12832.67918302043, 13202.669933251662, 13955.999999999987, 16536.58658533537, 16569.751453728204, 15152.242387880617, 16465.34138634456, 17162.0, 17242.224099915504, 17288.394906178288, 5604.075327570956, 5792.131180322943, 5794.797182098628, 5852.239208902836, 5858.53131749459, 4086.836526538935, 4273.850415235467, 6632.6020438773585, 6917.688704008332, 6972.51192416531, 6793.728250869984, 7006.894896576556, 7067.293270672943, 7084.539504932189, 7091.645417729119, 6836.521443498932, 6849.726010959555, 6863.794086177422, 6863.828404289883, 6865.210500792423, 6432.967835160841, 6668.399844014062, 6689.966550167267, 6703.0, 6711.161104861892, 19126.330578429828, 20412.387628371172, 22280.554388912293, 22904.541909161722, 23016.65475017876, 1924.3361040441025, 2017.2939471185114, 2060.9793902060937, 2073.3261689950677, 2161.0923412166926, 13749.862501374959, 13998.93000535001, 14350.497732579413, 14638.121712697166, 14873.0, 1823.6990896502061, 1824.3705921457076, 1905.4188472515877, 1937.4962509747568, 1947.9643772258025, 74302.25697743008, 75689.24310756876, 79359.0, 85290.14709852885, 85396.57301713513, 15181.924090379478, 15739.921300393426, 15833.683326333408, 16058.43795467153, 16332.0, 28580.285492862844, 28592.571111433346, 28645.71354286472, 28685.426291474472, 28921.85539072291, 7999.84000320002, 8050.758477245692, 8101.473404228706, 8161.79595510117, 8250.46371985819, 6328.557001009885, 6334.208223972004, 6338.112664227012, 6524.836879078061, 6528.183977002875, 8157.918420815835, 8219.465734727224, 8360.205780450848, 8593.398462107718, 8652.8702069469, 2974.2970002347215, 3156.3845050215446, 3281.786683865541, 3291.637919828817, 3364.4953257011643, 751.4514404484756, 794.1899262751961, 797.2904115337354, 830.33158307563, 892.9955350223337, 16114.0, 16410.753838692428, 16481.917590411973, 16651.50045498637, 17506.562335941704, 835.3442547600105, 837.6146972392646, 847.588919374103, 883.0595415882065, 894.2041582991143, 8019.83960320802, 9095.408798428081, 9534.18959388446, 9569.569369378394, 9658.806823863484, 377760.0, 379189.0, 379454.0, 380388.0, 380880.0, 76320.0, 76360.0, 77716.0, 78385.21614783893, 80273.59863200647, 854.8674955381802, 881.6737807011575, 881.8060026794095, 883.6112110671284, 883.765802062454, 14943.775843362575, 14949.850501494846, 15069.321880515623, 15162.0, 15421.0, 36568.63431365652, 36672.31579105243, 36747.44878826873, 37166.814165929, 37523.2495350086, 49879.0, 50107.49892501028, 50146.0, 50208.74895625498, 51306.23040654318, 5560.944390556043, 6903.5167538271835, 7018.543794653331, 7436.665350059368, 7562.810929726801, 11194.66416007521, 11611.6516504505, 11732.296062236293, 11805.645830625095, 11936.76126477483, 9640.951795240979, 9957.302988791005, 10285.382877027403, 10369.377837329785, 10484.580616775243, 9681.225501959967, 9953.203743700342, 9994.800103998024, 10216.948915255376, 10486.895131048592, 10094.0, 10230.23273254494, 10362.766802764556, 10498.947505262426, 10645.201609879445, 7459.925400745923, 7468.850622987401, 7613.0, 7699.384049275933, 7728.381729461742, 10311.123554497952, 10384.221183411124, 10384.273100883167, 10433.0, 10479.580816767244], "value": 9073.11657467553, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1204.1029433072363, 1301.6745813546613, 1333.4932725564288, 1370.9761848973264, 1598.2887615011325, 6070.787522436715, 6421.4541763950065, 6557.540972131953, 6599.703013364392, 6777.3561511656435, 6812.4890633202585, 6868.553544019648, 6884.0, 6886.62123583204, 6893.3795958363735, 2095.8113769760716, 2124.1928067334393, 2126.075157306569, 2127.0322003488454, 2127.2767259131892, 2073.906674199665, 2104.757952835428, 2105.2526353144644, 2106.0838535237144, 2118.7245658064508, 2047.7440319960006, 2074.7199128117663, 2076.4497408186767, 2091.205341970049, 2107.8419118566167, 2030.4619275891826, 2064.9070791814406, 2064.9896750516227, 2067.1008111471406, 2068.813806757399, 2019.3437132931856, 2038.500567361006, 2071.5809670375843, 2073.50235943374, 2075.201047596671, 6609.570377925419, 6813.080234168373, 6968.756093536753, 6970.30296970304, 6973.79078627642, 4088.3049881520215, 4239.745615263063, 4240.915181696349, 4246.723962942398, 4253.255680255974, 2654.694710108343, 2851.458222937635, 2886.047604290579, 2892.3492214251623, 2894.233028247516, 871.6469829718974, 881.2201201936333, 924.8705181274627, 975.1954637424153, 998.4807899892088, 9156.908430915739, 9220.677276295297, 9235.353525253235, 9235.584398702074, 9242.676506322246, 3776.1692427666417, 3843.0, 3914.745541539791, 3920.862769803043, 3937.42907278443, 7356.301151390609, 7356.889646655304, 7359.521631093961, 7360.668769905367, 7360.705571777069, 4082.775447350424, 4130.648894843972, 4134.297169481196, 4148.0, 4157.584241575818, 3345.7657963942293, 3469.0, 3706.925861482809, 3825.139343647657, 3826.1582451860545, 3071.78497505177, 3126.2340726522148, 3248.9765723796927, 3256.5603643507825, 3265.9346813063607, 994.418265314799, 1002.5939494504737, 1007.0684616729496, 1008.9646862359782, 1013.6685623066917, 675.9797206083825, 685.5098604497808, 701.0850839654198, 705.2806137739477, 713.333033613573, 4387.100644367897, 4472.105578884171, 4493.88765280864, 4521.751303678329, 4674.976625116853, 373.2125215794671, 388.5861557441316, 390.3870922651467, 403.85663089603355, 407.0272049800978, 3161.146490447566, 3201.167696398953, 3252.2032102135126, 3296.9835150824574, 3335.09952312879, 8214.876776848352, 8243.8351232975, 8429.114942930904, 8430.536320502308, 8443.704470343508, 8296.917030829734, 8336.66653333872, 8435.283000944988, 8445.535495547803, 8453.154684531497, 6394.744210231539, 6584.374484424068, 6588.835279117964, 6589.24223714279, 6595.0766892635065, 4611.538846115496, 4652.069586082729, 4655.580997710087, 4759.738214398241, 4805.087033463631, 7401.555906645618, 7645.0, 7706.190849960898, 7711.730089447067, 7727.9953606033105, 7323.0, 7484.663190156565, 7520.210377910459, 7579.848403032019, 7695.6536955836, 5273.551748101301, 5686.9715651421475, 5786.739596718074, 5835.4748072673665, 5842.649441033552, 5969.8806023878415, 6154.846128846814, 6359.04614307839, 6361.173047503795, 6514.120593719787, 5654.773809047592, 5823.970880145572, 5854.414558544111, 5921.259842519685, 6025.548083893813, 5843.795467158629, 5896.439838215363, 5901.616394934315, 5912.674802885883, 5988.970055149696, 5145.228215767665, 5318.57451403879, 5360.65155764874, 5392.433794451526, 5464.508194262536, 3865.9806700966315, 3988.9401658974557, 4001.9599804001587, 4055.939160912648, 4060.918781624292, 3987.581303963042, 4044.3529035354204, 4062.2484840304637, 4178.958210417978, 4180.26845302077], "value": 3614.988102753487, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.69188889499367, 301.08320165097274, 303.96656367799545, 306.98772049118037, 308.74065784740816, 4777.498362671917, 4792.329073929653, 4799.592034677053, 4822.9035419291595, 4840.709557426557, 4768.523147685239, 4773.832915847946, 4776.665633405663, 4802.879928001802, 4805.351277577526, 3510.947335789965, 3611.494390785292, 3652.5251717276715, 3711.962880371202, 3729.5151630288024, 3733.906652333686, 3734.663880250777, 3740.906477338061, 3742.906427339311, 3761.322961866863, 3695.316366472198, 3715.238376132886, 3715.6284371562897, 3718.442233664958, 3733.3466643337442, 3569.6965757910607, 3616.6383361663884, 3686.1337585667347, 3699.426588878728, 3747.8500859965843, 3304.6364899860996, 3305.1406634275263, 3309.834508274577, 3323.0861513083855, 3326.76712630116, 4628.44458664959, 4635.1656701794, 4646.1404640141345, 4664.813407463697, 4680.180968330528, 4201.579842015804, 4257.233697934371, 4300.8709738707885, 4305.246581848195, 4310.245707001262, 4948.158813001798, 4962.15643340633, 4992.878026838579, 5014.52362025607, 5020.7740651670765, 3631.8547258109643, 3636.4545318202217, 3643.143861192618, 3645.1616128290643, 3648.890533284006, 4868.367112275417, 5173.275741396207, 5192.1173400522, 5201.349831271091, 5201.973990130025, 3559.857605695743, 3602.9099272518397, 3612.259486805199, 3618.3667858124722, 3626.111602657313, 3634.8546058157376, 3654.689351405107, 3663.120850995742, 3697.685696715809, 3705.1107734144152, 4215.852445164404, 4221.0, 4222.472190976128, 4223.880671622022, 4224.704270701083, 4733.881652958635, 4988.5260900214425, 5027.723475208899, 5037.11850426174, 5046.571041461443, 1241.85097788266, 1248.7252804383022, 1249.8187762774346, 1254.5985284708806, 1257.6289994451658, 784.3999340504519, 787.4369825574742, 831.5177197225595, 834.4534330013729, 839.9832003359899, 4096.754194748325, 4316.179925814085, 4433.46798384196, 4436.447243464826, 4444.400005999149, 5151.896962060813, 5166.457521960216, 5174.197999310113, 5193.766280517386, 5199.948000520022, 4428.202923473741, 4435.602785122676, 4458.554144585515, 4467.548046884775, 4481.686281960231, 2510.309664842183, 2614.3333449970137, 2627.750363715444, 2647.510210611043, 2653.907113251027, 4677.4854765975715, 4724.551167639069, 4733.408323959505, 4742.648345221595, 4758.381410416693, 4954.8653914980405, 5126.743662816844, 5135.35808023997, 5150.330457040561, 5150.48495150482, 4642.634090284517, 4692.7653617319, 4700.459447163552, 4715.24556071027, 4723.45680246776, 4980.526849949249, 5032.496750324938, 5052.747362631927, 5067.898642027212, 5071.0, 4779.187538118459, 4965.666136915644, 4968.180250258812, 4973.676711013773, 4980.975095124646, 4724.811007559659, 4739.4075740532435, 4742.0, 4755.358026666356, 4782.210935195793, 3530.188056747014, 3541.8406171721817, 3544.6278140795876, 3559.7330200235606, 3576.177479179751, 4990.650654454299, 5003.499650034967, 5006.249062640633, 5008.449070602303, 5039.168537191323, 4647.282298314088, 4737.928931065968, 4796.424429068534, 4841.927371089507, 4885.094813022853, 4843.200871856246, 4857.465678775261, 4858.222684370484, 4876.463589005136, 4876.732319471463, 4787.3776409068, 4798.47216806158, 4799.208130658402, 4814.229723244264, 4828.324034635224, 4741.122892264942, 4894.388201474816, 5062.797488100435, 5078.822241221539, 5086.61850361217, 4932.235503496964, 4947.208446648519, 4957.603391728725, 4959.553640172402, 4959.991203562563], "value": 3731.418350036476, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.8590352411894, 593.6935007495879, 595.627732667083, 659.2884436437071, 689.8103021669041, 11828.704282392933, 11931.880681193186, 12159.878401215985, 12278.938605306983, 12695.873041269597, 11455.255408398449, 11522.423878806068, 11544.826827597572, 11547.422628868566, 11562.0, 725.365305357812, 738.1732459645204, 739.2681245566904, 740.9925900740977, 741.9501405511222, 592.1946153231602, 610.4871907597617, 719.5071376107358, 734.6363550042736, 742.2095468326243, 780.7657702689199, 784.525362155896, 784.764570628812, 787.4841978504061, 787.763670898731, 782.3350152370497, 782.4913806026043, 782.788647065292, 783.2441693765516, 783.8393129408514, 461.24586301397125, 468.950760170184, 551.657972057327, 563.219940382569, 568.4770011589347, 12268.32524211168, 12315.93842030793, 12319.568815091428, 12326.0, 12326.137170398075, 11359.772804543945, 11468.254563453349, 11565.190436669436, 11723.531058757639, 12058.0, 8679.0, 8758.386912916098, 10558.155347572176, 10679.83980240297, 10761.354318740823, 3896.5713771485116, 3939.310620641405, 3964.187341594995, 3975.383815508601, 4129.690273229489, 47551.52448475506, 48232.51767482315, 48324.0, 48634.51365486371, 49331.0, 8905.510196939102, 9016.323775716848, 9262.212711919428, 9309.162175404246, 9700.223982081558, 16048.197590120448, 16060.437884674215, 16071.11608861524, 16147.012802631316, 16203.189840508163, 5977.790777322773, 6050.727717252734, 6064.818055458343, 6076.179715738407, 6171.290301615371, 3647.76289541179, 3676.9816150919073, 3679.8344074516713, 3692.8522859085338, 3825.387937929918, 2434.4522482441307, 2497.9750202497744, 2500.2749202731006, 2503.4242124311145, 2505.9874700626747, 445.57670213297496, 450.17168410124873, 458.1524180266547, 458.83940620783125, 459.9287110497878, 390.48066072124004, 465.8346287068042, 479.72176137839966, 488.3066046214384, 499.9475055119233, 6382.808515744535, 6478.093066970628, 6509.609423434609, 6554.213494380705, 6630.9336906630315, 391.0165932679314, 420.7875023113308, 440.28893337260735, 441.68860953028036, 482.4018217410456, 3158.652548219694, 3191.5372271021038, 3525.9294814103573, 3557.1107223194203, 3679.411294192916, 62350.0, 65887.0, 67236.39088639825, 68177.0, 71015.64492177506, 46992.5300746995, 47909.9999999993, 59999.40000600025, 61733.074003889975, 61877.0, 44337.556624433986, 48413.5158648409, 50535.49464505308, 52814.73592632089, 52970.73514632402, 7385.9261407387385, 7489.475736698379, 7583.7724868254045, 7639.083310002613, 7751.992241008633, 26676.466470670865, 30043.94846180373, 32947.50578741273, 35087.29825403529, 35590.8220458896, 42249.155016900106, 47742.283865742735, 48247.5175248243, 48629.0, 49316.0, 8931.821363572823, 9505.952470237604, 9529.475878826453, 9731.854022189815, 9851.753706157404, 10880.564777408816, 10986.176036797113, 11169.609063682732, 11294.0, 11294.209405341548, 9487.430754154773, 9619.27855410861, 9803.705888823346, 9829.066238707312, 10179.0, 10283.7429064271, 10310.381377117397, 10474.21443391764, 10516.26386152962, 10695.89304106949, 9345.53272336394, 9515.952420237854, 9578.408096963638, 9604.327697061139, 9805.656802011896, 8270.875936861072, 8548.615312311085, 8714.520701361485, 8887.377883548348, 9003.639854406012, 7358.216625338726, 7771.106322772954, 7825.608719564113, 7968.7609371718945, 8195.238023824906], "value": 5621.983589872257, "unit": "score"}], "name": "dromaeo_css", "value": 6139.989845764585, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 114.0, 115.0, 117.0, 116.0, 114.0, 115.0, 115.0, 114.0, 116.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 127.0, 128.0, 175.0, 127.0, 131.0, 127.0, 129.0, 161.0, 134.0], "value": 139.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 162.0, 162.0, 162.0, 160.0, 159.0, 162.0, 161.0, 161.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 78.0, 111.0, 76.0, 77.0, 77.0, 77.0, 101.0, 77.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 113.0, 84.0, 83.0, 84.0, 116.0, 83.0, 84.0, 112.0], "value": 92.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 116.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 146.0, 147.0, 149.0, 147.0, 146.0, 147.0, 147.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 85.0, 84.0, 85.0, 85.0, 84.0, 84.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 64.0, 63.0, 64.0, 64.0, 65.0, 64.0, 65.0, 67.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 67.0, 67.0, 67.0, 66.0, 67.0, 67.0, 66.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 92.0, 84.0, 87.0, 90.0, 84.0, 85.0, 86.0, 84.0, 92.0], "value": 86.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 144.0, 145.0, 144.0, 146.0, 141.0, 137.0, 140.0, 192.0, 141.0], "value": 147.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 175.0, 177.0, 176.0, 174.0, 183.0, 176.0, 172.0, 172.0, 174.0], "value": 175.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 69.0, 73.0, 71.0, 71.0, 71.0, 68.0, 68.0, 68.0], "value": 69.9, "unit": "score"}], "name": "kraken", "value": 1548.9, "alertThreshold": 2.0}]} 06:25:31 INFO - Return code: 0 06:25:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:25:31 INFO - # TBPL SUCCESS # 06:25:31 INFO - Running post-action listener: _resource_record_post_action 06:25:31 INFO - [mozharness: 2016-11-07 14:25:31.892006Z] Finished run-tests step (success) 06:25:31 INFO - Running post-run listener: _resource_record_post_run 06:25:31 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 405434368; Read time: 8; Write time: 237648 06:25:31 INFO - TinderboxPrint: CPU usage
13.1% 06:25:31 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 06:25:31 INFO - TinderboxPrint: I/O write bytes / time
405,434,368 / 237,648 06:25:31 INFO - TinderboxPrint: CPU idle
8,335.3 (86.9%) 06:25:31 INFO - TinderboxPrint: CPU user
1,207.1 (12.6%) 06:25:31 INFO - TinderboxPrint: Swap in / out
0 / 0 06:25:31 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110329856; Read time: 0; Write time: 52268 06:25:31 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 293994496; Read time: 0; Write time: 185324 06:25:32 INFO - Running post-run listener: _upload_blobber_files 06:25:32 INFO - Blob upload gear active. 06:25:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:25:32 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:25:32 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', 'Cedar', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:25:32 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 Cedar -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:25:32 INFO - (blobuploader) - INFO - Open directory for files ... 06:25:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:25:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:25:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:25:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:25:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:25:33 INFO - (blobuploader) - INFO - Done attempting. 06:25:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:25:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:25:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:25:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:25:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:25:36 INFO - (blobuploader) - INFO - Done attempting. 06:25:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:25:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:25:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:25:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:25:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:25:37 INFO - (blobuploader) - INFO - Done attempting. 06:25:37 INFO - (blobuploader) - INFO - Iteration through files over. 06:25:37 INFO - Return code: 0 06:25:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:25:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:25:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/44826367a5a985ef05913ce1b6d03fc0ac57d7136712cc00cc742c2f22a4eb43bf18413ae36193fe1c0542c7a02e3abb07d685cb78d736f141a2fda5aad3cf1c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/3a484f5b643a7173b8f83e39c23f05c7e198d0bcfa38bee01a3dfa50bc48166d0d32e8c222bdc8116eb6e176f43f709bceee5d7a3bfec6241a48b2514558a9fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e8a7b649f933b3f95ab3ef2dec34fbbdc0c214d3d0625beb93b126393c714b9df9d421745f4637452e79c4d4f96cb6f69648cba08e2f1e75b484e826a4480d67"} 06:25:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:25:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:25:37 INFO - Contents: 06:25:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/44826367a5a985ef05913ce1b6d03fc0ac57d7136712cc00cc742c2f22a4eb43bf18413ae36193fe1c0542c7a02e3abb07d685cb78d736f141a2fda5aad3cf1c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/3a484f5b643a7173b8f83e39c23f05c7e198d0bcfa38bee01a3dfa50bc48166d0d32e8c222bdc8116eb6e176f43f709bceee5d7a3bfec6241a48b2514558a9fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e8a7b649f933b3f95ab3ef2dec34fbbdc0c214d3d0625beb93b126393c714b9df9d421745f4637452e79c4d4f96cb6f69648cba08e2f1e75b484e826a4480d67"} 06:25:37 INFO - Running post-run listener: copy_logs_to_upload_dir 06:25:37 INFO - Copying logs to upload dir... 06:25:37 INFO - mkdir: /builds/slave/test/build/upload/logs 06:25:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.275165 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-11-07 06:25:37.573314) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-07 06:25:37.576505) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1478527490.604500-1100081964 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/44826367a5a985ef05913ce1b6d03fc0ac57d7136712cc00cc742c2f22a4eb43bf18413ae36193fe1c0542c7a02e3abb07d685cb78d736f141a2fda5aad3cf1c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/3a484f5b643a7173b8f83e39c23f05c7e198d0bcfa38bee01a3dfa50bc48166d0d32e8c222bdc8116eb6e176f43f709bceee5d7a3bfec6241a48b2514558a9fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e8a7b649f933b3f95ab3ef2dec34fbbdc0c214d3d0625beb93b126393c714b9df9d421745f4637452e79c4d4f96cb6f69648cba08e2f1e75b484e826a4480d67"} build_url:https://queue.taskcluster.net/v1/task/DRqMyzKkQeWA72Fj33Bcrw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011582 build_url: 'https://queue.taskcluster.net/v1/task/DRqMyzKkQeWA72Fj33Bcrw/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/Cedar/sha512/44826367a5a985ef05913ce1b6d03fc0ac57d7136712cc00cc742c2f22a4eb43bf18413ae36193fe1c0542c7a02e3abb07d685cb78d736f141a2fda5aad3cf1c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/3a484f5b643a7173b8f83e39c23f05c7e198d0bcfa38bee01a3dfa50bc48166d0d32e8c222bdc8116eb6e176f43f709bceee5d7a3bfec6241a48b2514558a9fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/e8a7b649f933b3f95ab3ef2dec34fbbdc0c214d3d0625beb93b126393c714b9df9d421745f4637452e79c4d4f96cb6f69648cba08e2f1e75b484e826a4480d67"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-07 06:25:37.602742) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 06:25:37.603118) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=2c5dd2b0a310ecf02fd87158000001b4-1478527490.604500-1100081964 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 06:25:37.684953) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-07 06:25:37.685343) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-07 06:25:37.685681) ========= ========= Total master_lag: 0.17 =========