builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-062 starttime: 1482336847.0 results: success (0) buildid: 20161221063559 builduid: 71e38918ea854aa28b24696d226279a6 revision: 38c65075d65e662c265bb5d215f1507798497a98 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 08:14:07.000430) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-21 08:14:07.001044) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 08:14:07.001350) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-21 08:14:07.017762) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 08:14:07.018156) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1482335246.123441-1478155344 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-21 08:14:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 111M=0s 2016-12-21 08:14:08 (111 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.114164 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 08:14:07.146442) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 08:14:07.146828) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1482335246.123441-1478155344 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016683 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 08:14:07.206028) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 08:14:07.206481) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 38c65075d65e662c265bb5d215f1507798497a98 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 38c65075d65e662c265bb5d215f1507798497a98 --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=a4ce256d2ec601f24a60a71e000001bc-1482335246.123441-1478155344 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-21 08:14:08,144 truncating revision to first 12 chars 2016-12-21 08:14:08,144 Setting DEBUG logging. 2016-12-21 08:14:08,145 attempt 1/10 2016-12-21 08:14:08,145 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/38c65075d65e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-21 08:14:08,468 unpacking tar archive at: mozilla-aurora-38c65075d65e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.667539 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 08:14:07.887591) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 08:14:07.887914) ========= script_repo_revision: 38c65075d65e662c265bb5d215f1507798497a98 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-21 08:14:07.888308) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 08:14:07.888602) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-21 08:14:07.898362) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-12-21 08:14:07.898691) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=a4ce256d2ec601f24a60a71e000001bc-1482335246.123441-1478155344 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:14:08 INFO - MultiFileLogger online at 20161221 08:14:08 in /builds/slave/test 08:14:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:14:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:14:08 INFO - {'append_to_log': False, 08:14:08 INFO - 'base_work_dir': '/builds/slave/test', 08:14:08 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:14:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:14:08 INFO - 'branch': 'Mozilla-Aurora', 08:14:08 INFO - 'buildbot_json_path': 'buildprops.json', 08:14:08 INFO - 'config_files': ('talos/linux_config.py',), 08:14:08 INFO - 'default_actions': ('clobber', 08:14:08 INFO - 'read-buildbot-config', 08:14:08 INFO - 'download-and-extract', 08:14:08 INFO - 'populate-webroot', 08:14:08 INFO - 'create-virtualenv', 08:14:08 INFO - 'install', 08:14:08 INFO - 'run-tests'), 08:14:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:14:08 INFO - 'download_minidump_stackwalk': True, 08:14:08 INFO - 'download_symbols': 'ondemand', 08:14:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:14:08 INFO - 'tooltool.py': '/tools/tooltool.py', 08:14:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:14:08 INFO - '/tools/misc-python/virtualenv.py')}, 08:14:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:14:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:14:08 INFO - 'installer_path': 'installer.exe', 08:14:08 INFO - 'log_level': 'info', 08:14:08 INFO - 'log_name': 'talos', 08:14:08 INFO - 'log_to_console': True, 08:14:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:14:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:14:08 INFO - 'opt_config_files': (), 08:14:08 INFO - 'pip_index': False, 08:14:08 INFO - 'sps_profile': False, 08:14:08 INFO - 'sps_profile_interval': 0, 08:14:08 INFO - 'suite': 'dromaeojs', 08:14:08 INFO - 'system_bits': '32', 08:14:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:14:08 INFO - 'title': 'talos-linux64-ix-062', 08:14:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:14:08 INFO - 'use_talos_json': True, 08:14:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:14:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:14:08 INFO - 'work_dir': 'build'} 08:14:08 INFO - [mozharness: 2016-12-21 16:14:08.940727Z] Running clobber step. 08:14:08 INFO - Running pre-action listener: _resource_record_pre_action 08:14:08 INFO - Running main action method: clobber 08:14:08 INFO - rmtree: /builds/slave/test/build 08:14:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:14:09 INFO - Running post-action listener: _resource_record_post_action 08:14:09 INFO - [mozharness: 2016-12-21 16:14:09.925349Z] Finished clobber step (success) 08:14:09 INFO - [mozharness: 2016-12-21 16:14:09.925447Z] Running read-buildbot-config step. 08:14:09 INFO - Running pre-action listener: _resource_record_pre_action 08:14:09 INFO - Running main action method: read_buildbot_config 08:14:09 INFO - Using buildbot properties: 08:14:09 INFO - { 08:14:09 INFO - "project": "", 08:14:09 INFO - "product": "firefox", 08:14:09 INFO - "script_repo_revision": "production", 08:14:09 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:14:09 INFO - "repository": "", 08:14:09 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 08:14:09 INFO - "buildid": "20161221063559", 08:14:09 INFO - "pgo_build": "True", 08:14:09 INFO - "basedir": "/builds/slave/test", 08:14:09 INFO - "buildnumber": 972, 08:14:09 INFO - "slavename": "talos-linux64-ix-062", 08:14:09 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:14:09 INFO - "platform": "ubuntu64_hw", 08:14:09 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:14:09 INFO - "branch": "mozilla-aurora", 08:14:09 INFO - "repo_path": "releases/mozilla-aurora", 08:14:09 INFO - "revision": "38c65075d65e662c265bb5d215f1507798497a98", 08:14:09 INFO - "stage_platform": "linux64-pgo", 08:14:09 INFO - "builduid": "71e38918ea854aa28b24696d226279a6", 08:14:09 INFO - "slavebuilddir": "test" 08:14:09 INFO - } 08:14:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/HiaI2NBdTKaiN_XeJwN5xA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 08:14:09 INFO - Running post-action listener: _resource_record_post_action 08:14:09 INFO - [mozharness: 2016-12-21 16:14:09.927856Z] Finished read-buildbot-config step (success) 08:14:09 INFO - [mozharness: 2016-12-21 16:14:09.927944Z] Running download-and-extract step. 08:14:09 INFO - Running pre-action listener: _resource_record_pre_action 08:14:09 INFO - Running main action method: download_and_extract 08:14:09 INFO - mkdir: /builds/slave/test/build/tests 08:14: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')]} 08:14:09 INFO - trying https://queue.taskcluster.net/v1/task/HiaI2NBdTKaiN_XeJwN5xA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:14:09 INFO - Downloading https://queue.taskcluster.net/v1/task/HiaI2NBdTKaiN_XeJwN5xA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:14:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HiaI2NBdTKaiN_XeJwN5xA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:14:10 INFO - Downloaded 1361 bytes. 08:14:10 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:14:10 INFO - Using the following test package requirements: 08:14:10 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:14:10 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:14:10 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:14:10 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:14:10 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:14:10 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:14:10 INFO - u'jsshell-linux-x86_64.zip'], 08:14:10 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:14:10 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:14:10 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:14:10 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:14:10 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:14:10 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:14:10 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:14:10 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:14:10 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:14:10 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:14:10 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:14:10 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:14:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HiaI2NBdTKaiN_XeJwN5xA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:14:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HiaI2NBdTKaiN_XeJwN5xA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:14:10 INFO - Fetch https://queue.taskcluster.net/v1/task/HiaI2NBdTKaiN_XeJwN5xA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:14:11 INFO - Http code: 200 08:14:11 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 08:14:11 INFO - x-amz-cf-id: -ObfJxIsZl3nuPX-4LKXdKGGcIHrbzqc-6Xy2uhqwY4TT0QWrrohmQ== 08:14:11 INFO - x-amz-version-id: U_jla_FH0iczOyvg_UprzGyhB_Q8Yr0f 08:14:11 INFO - Expected file size: 21940466 08:14:11 INFO - Obtained file size: 21940466 08:14:15 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:14:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HiaI2NBdTKaiN_XeJwN5xA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:14:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HiaI2NBdTKaiN_XeJwN5xA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:14:15 INFO - Fetch https://queue.taskcluster.net/v1/task/HiaI2NBdTKaiN_XeJwN5xA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:14:15 INFO - Http code: 200 08:14:15 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 08:14:15 INFO - x-amz-cf-id: SVwHIT2DaC4z7vAP2dIVDCldsSgYOHa6-xruZsROgn_Ua_wuQ3POrQ== 08:14:15 INFO - x-amz-version-id: U_jla_FH0iczOyvg_UprzGyhB_Q8Yr0f 08:14:16 INFO - Expected file size: 21940466 08:14:16 INFO - Obtained file size: 21940466 08:14:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HiaI2NBdTKaiN_XeJwN5xA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 08:14:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HiaI2NBdTKaiN_XeJwN5xA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:14:20 INFO - Fetch https://queue.taskcluster.net/v1/task/HiaI2NBdTKaiN_XeJwN5xA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 08:14:21 INFO - Http code: 200 08:14:21 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 08:14:21 INFO - x-amz-cf-id: LB3LybXmeH56TYcfZpx2Q4kZGG_SrnCUxlLAxT-zgBwzavrve4pfeQ== 08:14:21 INFO - x-amz-version-id: mkH4UtJ9WGGP3tzdaIaNphYx68JDQeOC 08:14:21 INFO - Expected file size: 14409038 08:14:21 INFO - Obtained file size: 14409038 08:14: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')]} 08:14:21 INFO - trying https://queue.taskcluster.net/v1/task/HiaI2NBdTKaiN_XeJwN5xA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:14:21 INFO - Downloading https://queue.taskcluster.net/v1/task/HiaI2NBdTKaiN_XeJwN5xA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:14:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HiaI2NBdTKaiN_XeJwN5xA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:14:23 INFO - Downloaded 63967977 bytes. 08:14:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HiaI2NBdTKaiN_XeJwN5xA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:14:23 INFO - mkdir: /builds/slave/test/properties 08:14:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:14:23 INFO - Writing to file /builds/slave/test/properties/build_url 08:14:23 INFO - Contents: 08:14:23 INFO - build_url:https://queue.taskcluster.net/v1/task/HiaI2NBdTKaiN_XeJwN5xA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:14:23 INFO - Running post-action listener: _resource_record_post_action 08:14:23 INFO - Running post-action listener: set_extra_try_arguments 08:14:23 INFO - [mozharness: 2016-12-21 16:14:23.761485Z] Finished download-and-extract step (success) 08:14:23 INFO - [mozharness: 2016-12-21 16:14:23.761709Z] Running populate-webroot step. 08:14:23 INFO - Running pre-action listener: _resource_record_pre_action 08:14:23 INFO - Running main action method: populate_webroot 08:14:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:14:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:14:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:14:23 INFO - '--tppagecycles', 08:14:23 INFO - '7'], 08:14:23 INFO - 'tests': ['tsvgm']}}, 08:14:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:14:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:14:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:14:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:14:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:14:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:14:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:23 INFO - 'talos_options': ['--disable-e10s'], 08:14:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:23 INFO - 'talos_options': ['--disable-e10s'], 08:14:23 INFO - 'tests': ['damp', 'tps']}, 08:14:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:23 INFO - 'tests': ['damp', 'tps']}, 08:14:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:14:23 INFO - 'tests': ['dromaeo_dom']}, 08:14:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:14:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:14:23 INFO - 'tests': ['basic_compositor_video']}, 08:14:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:14:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:14:23 INFO - 'tests': ['a11yr', 08:14:23 INFO - 'ts_paint', 08:14:23 INFO - 'tpaint', 08:14:23 INFO - 'sessionrestore', 08:14:23 INFO - 'sessionrestore_no_auto_restore', 08:14:23 INFO - 'tabpaint']}, 08:14:23 INFO - 'other-e10s': {'tests': ['a11yr', 08:14:23 INFO - 'ts_paint', 08:14:23 INFO - 'tpaint', 08:14:23 INFO - 'sessionrestore', 08:14:23 INFO - 'sessionrestore_no_auto_restore', 08:14:23 INFO - 'tabpaint']}, 08:14:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:14:23 INFO - 'ts_paint', 08:14:23 INFO - 'tpaint', 08:14:23 INFO - 'sessionrestore', 08:14:23 INFO - 'sessionrestore_no_auto_restore', 08:14:23 INFO - 'tabpaint']}, 08:14:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:14:23 INFO - 'ts_paint', 08:14:23 INFO - 'tpaint', 08:14:23 INFO - 'sessionrestore', 08:14:23 INFO - 'sessionrestore_no_auto_restore', 08:14:23 INFO - 'tabpaint']}, 08:14:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:14:23 INFO - 'tests': ['a11yr', 08:14:23 INFO - 'ts_paint', 08:14:23 INFO - 'tpaint', 08:14:23 INFO - 'sessionrestore', 08:14:23 INFO - 'sessionrestore_no_auto_restore', 08:14:23 INFO - 'tabpaint']}, 08:14:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:14:23 INFO - 'tests': ['a11yr', 08:14:23 INFO - 'ts_paint', 08:14:23 INFO - 'tpaint', 08:14:23 INFO - 'sessionrestore', 08:14:23 INFO - 'sessionrestore_no_auto_restore', 08:14:23 INFO - 'tabpaint']}, 08:14:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:14:23 INFO - 'tests': ['tsvgx', 08:14:23 INFO - 'tsvgr_opacity', 08:14:23 INFO - 'tart', 08:14:23 INFO - 'tscrollx', 08:14:23 INFO - 'cart']}, 08:14:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:14:23 INFO - 'tsvgr_opacity', 08:14:23 INFO - 'tart', 08:14:23 INFO - 'tscrollx', 08:14:23 INFO - 'cart']}, 08:14:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:23 INFO - 'talos_options': ['--disable-e10s'], 08:14:23 INFO - 'tests': ['tp5o']}, 08:14:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:23 INFO - 'tests': ['tp5o']}, 08:14:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:23 INFO - 'talos_options': ['--disable-e10s', 08:14:23 INFO - '--xperf_path', 08:14:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:23 INFO - 'tests': ['tp5n']}, 08:14:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:14:23 INFO - 'talos_options': ['--xperf_path', 08:14:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:23 INFO - 'tests': ['tp5n']}}, 08:14:23 INFO - 'talos.zip': {'path': '', 08:14:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:14:23 INFO - Running post-action listener: _resource_record_post_action 08:14:23 INFO - [mozharness: 2016-12-21 16:14:23.779296Z] Finished populate-webroot step (success) 08:14:23 INFO - [mozharness: 2016-12-21 16:14:23.779384Z] Running create-virtualenv step. 08:14:23 INFO - Running pre-action listener: _resource_record_pre_action 08:14:23 INFO - Running main action method: create_virtualenv 08:14:23 INFO - Creating virtualenv /builds/slave/test/build/venv 08:14:23 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 08:14:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:14:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:14:23 INFO - Using real prefix '/usr' 08:14:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:14:24 INFO - Installing distribute.............................................................................................................................................................................................done. 08:14:26 INFO - Installing pip.................done. 08:14:26 INFO - Return code: 0 08:14:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:14:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:14:26 INFO - Reading from file tmpfile_stdout 08:14:26 INFO - Output received: 08:14:26 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) 08:14:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f62fe7eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efaf60>, '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 0x1efbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efc1d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1482335246.123441-1478155344', '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 08:14:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:14:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:14:26 INFO - Using env: {'DISPLAY': ':0', 08:14:26 INFO - 'HOME': '/home/cltbld', 08:14:26 INFO - 'LANG': 'en_US.UTF-8', 08:14:26 INFO - 'LANGUAGE': 'en_US:en', 08:14:26 INFO - 'LOGNAME': 'cltbld', 08:14:26 INFO - 'MAIL': '/var/mail/cltbld', 08:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:26 INFO - 'MOZ_NO_REMOTE': '1', 08:14:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:26 INFO - 'NO_EM_RESTART': '1', 08:14:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:26 INFO - 'PWD': '/builds/slave/test', 08:14:26 INFO - 'SHELL': '/bin/bash', 08:14:26 INFO - 'SHLVL': '1', 08:14:26 INFO - 'TERM': 'linux', 08:14:26 INFO - 'TMOUT': '86400', 08:14:26 INFO - 'USER': 'cltbld', 08:14:26 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1482335246.123441-1478155344', 08:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:26 INFO - '_': '/tools/buildbot/bin/python'} 08:14:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:26 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 08:14:26 INFO - Cleaning up... 08:14:26 INFO - Return code: 0 08:14:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f62fe7eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efaf60>, '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 0x1efbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efc1d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1482335246.123441-1478155344', '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 08:14:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:14:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:14:26 INFO - Using env: {'DISPLAY': ':0', 08:14:26 INFO - 'HOME': '/home/cltbld', 08:14:26 INFO - 'LANG': 'en_US.UTF-8', 08:14:26 INFO - 'LANGUAGE': 'en_US:en', 08:14:26 INFO - 'LOGNAME': 'cltbld', 08:14:26 INFO - 'MAIL': '/var/mail/cltbld', 08:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:26 INFO - 'MOZ_NO_REMOTE': '1', 08:14:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:26 INFO - 'NO_EM_RESTART': '1', 08:14:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:26 INFO - 'PWD': '/builds/slave/test', 08:14:26 INFO - 'SHELL': '/bin/bash', 08:14:26 INFO - 'SHLVL': '1', 08:14:26 INFO - 'TERM': 'linux', 08:14:26 INFO - 'TMOUT': '86400', 08:14:26 INFO - 'USER': 'cltbld', 08:14:26 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1482335246.123441-1478155344', 08:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:26 INFO - '_': '/tools/buildbot/bin/python'} 08:14:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:26 INFO - Downloading/unpacking psutil>=3.1.1 08:14: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 08:14:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:14:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:29 INFO - Installing collected packages: psutil 08:14:29 INFO - Running setup.py install for psutil 08:14:29 INFO - building 'psutil._psutil_linux' extension 08:14:29 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 08:14:29 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 08:14:29 INFO - building 'psutil._psutil_posix' extension 08:14:29 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 08:14:29 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 08:14:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:29 INFO - Successfully installed psutil 08:14:29 INFO - Cleaning up... 08:14:29 INFO - Return code: 0 08:14:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f62fe7eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efaf60>, '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 0x1efbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efc1d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1482335246.123441-1478155344', '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 08:14:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:14:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:14:29 INFO - Using env: {'DISPLAY': ':0', 08:14:29 INFO - 'HOME': '/home/cltbld', 08:14:29 INFO - 'LANG': 'en_US.UTF-8', 08:14:29 INFO - 'LANGUAGE': 'en_US:en', 08:14:29 INFO - 'LOGNAME': 'cltbld', 08:14:29 INFO - 'MAIL': '/var/mail/cltbld', 08:14:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:29 INFO - 'MOZ_NO_REMOTE': '1', 08:14:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:29 INFO - 'NO_EM_RESTART': '1', 08:14:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:29 INFO - 'PWD': '/builds/slave/test', 08:14:29 INFO - 'SHELL': '/bin/bash', 08:14:29 INFO - 'SHLVL': '1', 08:14:29 INFO - 'TERM': 'linux', 08:14:29 INFO - 'TMOUT': '86400', 08:14:29 INFO - 'USER': 'cltbld', 08:14:29 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1482335246.123441-1478155344', 08:14:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:29 INFO - '_': '/tools/buildbot/bin/python'} 08:14:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:14:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:14:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:14:31 INFO - Installing collected packages: mozsystemmonitor 08:14:31 INFO - Running setup.py install for mozsystemmonitor 08:14:32 INFO - Successfully installed mozsystemmonitor 08:14:32 INFO - Cleaning up... 08:14:32 INFO - Return code: 0 08:14:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:14:32 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')]} 08:14:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:32 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')]} 08:14:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:32 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 0x7f62fe7eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efaf60>, '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 0x1efbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efc1d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1482335246.123441-1478155344', '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 08:14:32 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 08:14:32 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 08:14:32 INFO - Using env: {'DISPLAY': ':0', 08:14:32 INFO - 'HOME': '/home/cltbld', 08:14:32 INFO - 'LANG': 'en_US.UTF-8', 08:14:32 INFO - 'LANGUAGE': 'en_US:en', 08:14:32 INFO - 'LOGNAME': 'cltbld', 08:14:32 INFO - 'MAIL': '/var/mail/cltbld', 08:14:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:32 INFO - 'MOZ_NO_REMOTE': '1', 08:14:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:32 INFO - 'NO_EM_RESTART': '1', 08:14:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:32 INFO - 'PWD': '/builds/slave/test', 08:14:32 INFO - 'SHELL': '/bin/bash', 08:14:32 INFO - 'SHLVL': '1', 08:14:32 INFO - 'TERM': 'linux', 08:14:32 INFO - 'TMOUT': '86400', 08:14:32 INFO - 'USER': 'cltbld', 08:14:32 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1482335246.123441-1478155344', 08:14:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:32 INFO - '_': '/tools/buildbot/bin/python'} 08:14:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:32 INFO - Downloading/unpacking jsonschema==2.5.1 08:14:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:14:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:14:34 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 08:14:34 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 08:14:34 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 08:14:34 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 08:14:34 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 08:14:34 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 08:14:34 INFO - Downloading functools32-3.2.3-2.tar.gz 08:14:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:14:34 INFO - warning: no files found matching '*.txt' 08:14:34 INFO - no previously-included directories found matching 'build' 08:14:34 INFO - no previously-included directories found matching 'dist' 08:14:34 INFO - no previously-included directories found matching '.git*' 08:14:34 INFO - Installing collected packages: jsonschema, functools32 08:14:34 INFO - Running setup.py install for functools32 08:14:34 INFO - warning: no files found matching '*.txt' 08:14:34 INFO - no previously-included directories found matching 'build' 08:14:34 INFO - no previously-included directories found matching 'dist' 08:14:34 INFO - no previously-included directories found matching '.git*' 08:14:34 INFO - Successfully installed jsonschema functools32 08:14:34 INFO - Cleaning up... 08:14:34 INFO - Return code: 0 08:14:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:14:34 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')]} 08:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:34 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')]} 08:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:34 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 0x7f62fe7eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efaf60>, '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 0x1efbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efc1d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1482335246.123441-1478155344', '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 08:14:34 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 08:14:34 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 08:14:34 INFO - Using env: {'DISPLAY': ':0', 08:14:34 INFO - 'HOME': '/home/cltbld', 08:14:34 INFO - 'LANG': 'en_US.UTF-8', 08:14:34 INFO - 'LANGUAGE': 'en_US:en', 08:14:34 INFO - 'LOGNAME': 'cltbld', 08:14:34 INFO - 'MAIL': '/var/mail/cltbld', 08:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:34 INFO - 'MOZ_NO_REMOTE': '1', 08:14:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:34 INFO - 'NO_EM_RESTART': '1', 08:14:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:34 INFO - 'PWD': '/builds/slave/test', 08:14:34 INFO - 'SHELL': '/bin/bash', 08:14:34 INFO - 'SHLVL': '1', 08:14:34 INFO - 'TERM': 'linux', 08:14:34 INFO - 'TMOUT': '86400', 08:14:34 INFO - 'USER': 'cltbld', 08:14:34 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1482335246.123441-1478155344', 08:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:34 INFO - '_': '/tools/buildbot/bin/python'} 08:14:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:14:35 INFO - Cleaning up... 08:14:35 INFO - Return code: 0 08:14:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:14:35 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')]} 08:14:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:35 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')]} 08:14:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:35 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 0x7f62fe7eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efaf60>, '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 0x1efbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efc1d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1482335246.123441-1478155344', '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 08:14:35 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 08:14:35 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 08:14:35 INFO - Using env: {'DISPLAY': ':0', 08:14:35 INFO - 'HOME': '/home/cltbld', 08:14:35 INFO - 'LANG': 'en_US.UTF-8', 08:14:35 INFO - 'LANGUAGE': 'en_US:en', 08:14:35 INFO - 'LOGNAME': 'cltbld', 08:14:35 INFO - 'MAIL': '/var/mail/cltbld', 08:14:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:35 INFO - 'MOZ_NO_REMOTE': '1', 08:14:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:35 INFO - 'NO_EM_RESTART': '1', 08:14:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:35 INFO - 'PWD': '/builds/slave/test', 08:14:35 INFO - 'SHELL': '/bin/bash', 08:14:35 INFO - 'SHLVL': '1', 08:14:35 INFO - 'TERM': 'linux', 08:14:35 INFO - 'TMOUT': '86400', 08:14:35 INFO - 'USER': 'cltbld', 08:14:35 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1482335246.123441-1478155344', 08:14:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:35 INFO - '_': '/tools/buildbot/bin/python'} 08:14:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:35 INFO - Downloading/unpacking blobuploader==1.2.4 08:14:35 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 08:14:35 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 08:14:35 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 08:14:35 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 08:14:35 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 08:14:35 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 08:14:37 INFO - Downloading blobuploader-1.2.4.tar.gz 08:14:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:14:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:14:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:38 INFO - Downloading docopt-0.6.1.tar.gz 08:14:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:14:38 INFO - Installing collected packages: blobuploader, requests, docopt 08:14:38 INFO - Running setup.py install for blobuploader 08:14:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:14:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:14:38 INFO - Running setup.py install for requests 08:14:38 INFO - Running setup.py install for docopt 08:14:38 INFO - Successfully installed blobuploader requests docopt 08:14:38 INFO - Cleaning up... 08:14:38 INFO - Return code: 0 08:14:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:38 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')]} 08:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:38 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')]} 08:14:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:38 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 0x7f62fe7eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efaf60>, '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 0x1efbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efc1d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1482335246.123441-1478155344', '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 08:14:38 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 08:14:38 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 08:14:38 INFO - Using env: {'DISPLAY': ':0', 08:14:38 INFO - 'HOME': '/home/cltbld', 08:14:38 INFO - 'LANG': 'en_US.UTF-8', 08:14:38 INFO - 'LANGUAGE': 'en_US:en', 08:14:38 INFO - 'LOGNAME': 'cltbld', 08:14:38 INFO - 'MAIL': '/var/mail/cltbld', 08:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:38 INFO - 'MOZ_NO_REMOTE': '1', 08:14:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:38 INFO - 'NO_EM_RESTART': '1', 08:14:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:38 INFO - 'PWD': '/builds/slave/test', 08:14:38 INFO - 'SHELL': '/bin/bash', 08:14:38 INFO - 'SHLVL': '1', 08:14:38 INFO - 'TERM': 'linux', 08:14:38 INFO - 'TMOUT': '86400', 08:14:38 INFO - 'USER': 'cltbld', 08:14:38 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1482335246.123441-1478155344', 08:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:38 INFO - '_': '/tools/buildbot/bin/python'} 08:14:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:38 INFO - Running setup.py (path:/tmp/pip-9rBLDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:38 INFO - Running setup.py (path:/tmp/pip-EgD_Mn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:39 INFO - Running setup.py (path:/tmp/pip-0iM71h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:39 INFO - Running setup.py (path:/tmp/pip-riQaFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:39 INFO - Running setup.py (path:/tmp/pip-3ptl0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:39 INFO - Running setup.py (path:/tmp/pip-pQls0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:39 INFO - Running setup.py (path:/tmp/pip-dw76ow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:39 INFO - Running setup.py (path:/tmp/pip-pJkn4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:39 INFO - Running setup.py (path:/tmp/pip-QKqRlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:39 INFO - Running setup.py (path:/tmp/pip-gJ0XeK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:39 INFO - Running setup.py (path:/tmp/pip-CDC6LJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:39 INFO - Running setup.py (path:/tmp/pip-zNi85k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:39 INFO - Running setup.py (path:/tmp/pip-J6ny2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:39 INFO - Running setup.py (path:/tmp/pip-Ze0jix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:39 INFO - Running setup.py (path:/tmp/pip-ITF_Ic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:40 INFO - Running setup.py (path:/tmp/pip-4y1o8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:40 INFO - Running setup.py (path:/tmp/pip-RZ1po5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:14:40 INFO - Running setup.py install for manifestparser 08:14:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:14:40 INFO - Running setup.py install for mozcrash 08:14:40 INFO - Running setup.py install for mozdebug 08:14:40 INFO - Running setup.py install for mozdevice 08:14:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:14:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:14:40 INFO - Running setup.py install for mozfile 08:14:40 INFO - Running setup.py install for mozhttpd 08:14:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:14:40 INFO - Running setup.py install for mozinfo 08:14:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:14:40 INFO - Running setup.py install for mozInstall 08:14:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:14:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:14:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:14:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:14:40 INFO - Running setup.py install for mozleak 08:14:41 INFO - Running setup.py install for mozlog 08:14:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:14:41 INFO - Running setup.py install for moznetwork 08:14:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:14:41 INFO - Running setup.py install for mozprocess 08:14:41 INFO - Running setup.py install for mozprofile 08:14:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:14:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:14:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:14:41 INFO - Running setup.py install for mozrunner 08:14:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:14:41 INFO - Running setup.py install for mozscreenshot 08:14:41 INFO - Running setup.py install for moztest 08:14:41 INFO - Running setup.py install for mozversion 08:14:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:14:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:14:41 INFO - Cleaning up... 08:14:41 INFO - Return code: 0 08:14:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:41 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')]} 08:14:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:41 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')]} 08:14:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:41 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 0x7f62fe7eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efaf60>, '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 0x1efbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efc1d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1482335246.123441-1478155344', '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 08:14:41 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 08:14:41 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 08:14:41 INFO - Using env: {'DISPLAY': ':0', 08:14:41 INFO - 'HOME': '/home/cltbld', 08:14:41 INFO - 'LANG': 'en_US.UTF-8', 08:14:41 INFO - 'LANGUAGE': 'en_US:en', 08:14:41 INFO - 'LOGNAME': 'cltbld', 08:14:41 INFO - 'MAIL': '/var/mail/cltbld', 08:14:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:41 INFO - 'MOZ_NO_REMOTE': '1', 08:14:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:41 INFO - 'NO_EM_RESTART': '1', 08:14:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:41 INFO - 'PWD': '/builds/slave/test', 08:14:41 INFO - 'SHELL': '/bin/bash', 08:14:41 INFO - 'SHLVL': '1', 08:14:41 INFO - 'TERM': 'linux', 08:14:41 INFO - 'TMOUT': '86400', 08:14:41 INFO - 'USER': 'cltbld', 08:14:41 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1482335246.123441-1478155344', 08:14:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:41 INFO - '_': '/tools/buildbot/bin/python'} 08:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:42 INFO - Running setup.py (path:/tmp/pip-DZ6slu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:42 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)) 08:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:42 INFO - Running setup.py (path:/tmp/pip-Lx_AEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 08:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:42 INFO - Running setup.py (path:/tmp/pip-cUls3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:42 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)) 08:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:42 INFO - Running setup.py (path:/tmp/pip-iTP7gD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:42 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)) 08:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:42 INFO - Running setup.py (path:/tmp/pip-UozbIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:42 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)) 08:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:42 INFO - Running setup.py (path:/tmp/pip-Rym8Nj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:42 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)) 08:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:42 INFO - Running setup.py (path:/tmp/pip-QVuLXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:42 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)) 08:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:42 INFO - Running setup.py (path:/tmp/pip-dsH70k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:42 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)) 08:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:42 INFO - Running setup.py (path:/tmp/pip-_A5Af9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:42 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)) 08:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:42 INFO - Running setup.py (path:/tmp/pip-eYGZBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:42 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)) 08:14:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:42 INFO - Running setup.py (path:/tmp/pip-pHWcNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:43 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)) 08:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:43 INFO - Running setup.py (path:/tmp/pip-zFH4fr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:43 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)) 08:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:43 INFO - Running setup.py (path:/tmp/pip-a4oPfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:43 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)) 08:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:43 INFO - Running setup.py (path:/tmp/pip-D37x5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 08:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:43 INFO - Running setup.py (path:/tmp/pip-inPz3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:43 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)) 08:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:43 INFO - Running setup.py (path:/tmp/pip-O5Qz7r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:43 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)) 08:14:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:43 INFO - Running setup.py (path:/tmp/pip-ThyhfW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:43 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)) 08:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:14:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:14:43 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)) 08:14:43 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)) 08:14:43 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)) 08:14:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:14:43 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 08:14:43 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 08:14:43 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 08:14:43 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 08:14:43 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 08:14:43 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 08:14:46 INFO - Downloading blessings-1.6.tar.gz 08:14:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:14:46 INFO - Installing collected packages: blessings 08:14:46 INFO - Running setup.py install for blessings 08:14:46 INFO - Successfully installed blessings 08:14:46 INFO - Cleaning up... 08:14:46 INFO - Return code: 0 08:14:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:14:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:14:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:14:46 INFO - Reading from file tmpfile_stdout 08:14:46 INFO - Current package versions: 08:14:46 INFO - argparse == 1.2.1 08:14:46 INFO - blessings == 1.6 08:14:46 INFO - blobuploader == 1.2.4 08:14:46 INFO - docopt == 0.6.1 08:14:46 INFO - functools32 == 3.2.3-2 08:14:46 INFO - jsonschema == 2.5.1 08:14:46 INFO - manifestparser == 1.1 08:14:46 INFO - mozInstall == 1.12 08:14:46 INFO - mozcrash == 1.0 08:14:46 INFO - mozdebug == 0.1 08:14:46 INFO - mozdevice == 0.48 08:14:46 INFO - mozfile == 1.2 08:14:46 INFO - mozhttpd == 0.7 08:14:46 INFO - mozinfo == 0.9 08:14:46 INFO - mozleak == 0.1 08:14:46 INFO - mozlog == 3.4 08:14:46 INFO - moznetwork == 0.27 08:14:46 INFO - mozprocess == 0.23 08:14:46 INFO - mozprofile == 0.28 08:14:46 INFO - mozrunner == 6.13 08:14:46 INFO - mozscreenshot == 0.1 08:14:46 INFO - mozsystemmonitor == 0.3 08:14:46 INFO - moztest == 0.7 08:14:46 INFO - mozversion == 1.4 08:14:46 INFO - psutil == 3.1.1 08:14:46 INFO - requests == 1.2.3 08:14:46 INFO - wsgiref == 0.1.2 08:14:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:46 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')]} 08:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:46 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')]} 08:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:46 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 0x7f62fe7eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efaf60>, '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 0x1efbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efc1d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1482335246.123441-1478155344', '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 08:14:46 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 08:14:46 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 08:14:46 INFO - Using env: {'DISPLAY': ':0', 08:14:46 INFO - 'HOME': '/home/cltbld', 08:14:46 INFO - 'LANG': 'en_US.UTF-8', 08:14:46 INFO - 'LANGUAGE': 'en_US:en', 08:14:46 INFO - 'LOGNAME': 'cltbld', 08:14:46 INFO - 'MAIL': '/var/mail/cltbld', 08:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:46 INFO - 'MOZ_NO_REMOTE': '1', 08:14:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:46 INFO - 'NO_EM_RESTART': '1', 08:14:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:46 INFO - 'PWD': '/builds/slave/test', 08:14:46 INFO - 'SHELL': '/bin/bash', 08:14:46 INFO - 'SHLVL': '1', 08:14:46 INFO - 'TERM': 'linux', 08:14:46 INFO - 'TMOUT': '86400', 08:14:46 INFO - 'USER': 'cltbld', 08:14:46 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1482335246.123441-1478155344', 08:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:46 INFO - '_': '/tools/buildbot/bin/python'} 08:14:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:47 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)) 08:14:47 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)) 08:14:47 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)) 08:14:47 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)) 08:14:47 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)) 08:14:47 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)) 08:14:47 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)) 08:14:47 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)) 08:14:47 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)) 08:14:47 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)) 08:14:47 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)) 08:14:47 INFO - Cleaning up... 08:14:47 INFO - Return code: 0 08:14:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:14:47 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')]} 08:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:47 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')]} 08:14:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:47 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 0x7f62fe7eaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e308a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1efdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1efaf60>, '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 0x1efbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efc1d0>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1482335246.123441-1478155344', '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 08:14:47 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 08:14:47 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 08:14:47 INFO - Using env: {'DISPLAY': ':0', 08:14:47 INFO - 'HOME': '/home/cltbld', 08:14:47 INFO - 'LANG': 'en_US.UTF-8', 08:14:47 INFO - 'LANGUAGE': 'en_US:en', 08:14:47 INFO - 'LOGNAME': 'cltbld', 08:14:47 INFO - 'MAIL': '/var/mail/cltbld', 08:14:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:47 INFO - 'MOZ_NO_REMOTE': '1', 08:14:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:47 INFO - 'NO_EM_RESTART': '1', 08:14:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:47 INFO - 'PWD': '/builds/slave/test', 08:14:47 INFO - 'SHELL': '/bin/bash', 08:14:47 INFO - 'SHLVL': '1', 08:14:47 INFO - 'TERM': 'linux', 08:14:47 INFO - 'TMOUT': '86400', 08:14:47 INFO - 'USER': 'cltbld', 08:14:47 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1482335246.123441-1478155344', 08:14:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:47 INFO - '_': '/tools/buildbot/bin/python'} 08:14:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:14:47 INFO - Cleaning up... 08:14:47 INFO - Return code: 0 08:14:47 INFO - Running post-action listener: _resource_record_post_action 08:14:47 INFO - Running post-action listener: _start_resource_monitoring 08:14:47 INFO - Starting resource monitoring. 08:14:47 INFO - [mozharness: 2016-12-21 16:14:47.438571Z] Finished create-virtualenv step (success) 08:14:47 INFO - [mozharness: 2016-12-21 16:14:47.439155Z] Running install step. 08:14:47 INFO - Running pre-action listener: _resource_record_pre_action 08:14:47 INFO - Running main action method: install 08:14:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:14:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:14:47 INFO - Reading from file tmpfile_stdout 08:14:47 INFO - Detecting whether we're running mozinstall >=1.0... 08:14:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:14:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:14:47 INFO - Reading from file tmpfile_stdout 08:14:47 INFO - Output received: 08:14:47 INFO - Usage: mozinstall [options] installer 08:14:47 INFO - Options: 08:14:47 INFO - -h, --help show this help message and exit 08:14:47 INFO - -d DEST, --destination=DEST 08:14:47 INFO - Directory to install application into. [default: 08:14:47 INFO - "/builds/slave/test"] 08:14:47 INFO - --app=APP Application being installed. [default: firefox] 08:14:47 INFO - mkdir: /builds/slave/test/build/application 08:14:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:14:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:15:03 INFO - Reading from file tmpfile_stdout 08:15:03 INFO - Output received: 08:15:03 INFO - /builds/slave/test/build/application/firefox/firefox 08:15:03 INFO - Running post-action listener: _resource_record_post_action 08:15:03 INFO - [mozharness: 2016-12-21 16:15:03.666669Z] Finished install step (success) 08:15:03 INFO - [mozharness: 2016-12-21 16:15:03.666910Z] Running run-tests step. 08:15:03 INFO - Running pre-action listener: _resource_record_pre_action 08:15:03 INFO - Running main action method: run_tests 08:15:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:15:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:15:03 INFO - Python 2.7.3 08:15:03 INFO - Return code: 0 08:15:03 INFO - grabbing minidump binary from tooltool 08:15:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:03 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 0x1efaf60>, '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 0x1efbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1efc1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:15:03 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 08:15:03 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 08:15:03 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 08:15:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:15:03 INFO - Return code: 0 08:15:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:15:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:15:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:15:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:15:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:15:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HiaI2NBdTKaiN_XeJwN5xA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 08:15:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HiaI2NBdTKaiN_XeJwN5xA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 08:15:03 INFO - Using env: {'DISPLAY': ':0', 08:15:03 INFO - 'HOME': '/home/cltbld', 08:15:03 INFO - 'LANG': 'en_US.UTF-8', 08:15:03 INFO - 'LANGUAGE': 'en_US:en', 08:15:03 INFO - 'LOGNAME': 'cltbld', 08:15:03 INFO - 'MAIL': '/var/mail/cltbld', 08:15:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:15:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:15:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:03 INFO - 'MOZ_NO_REMOTE': '1', 08:15:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:15:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:03 INFO - 'NO_EM_RESTART': '1', 08:15:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:03 INFO - 'PWD': '/builds/slave/test', 08:15:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:15:03 INFO - 'SHELL': '/bin/bash', 08:15:03 INFO - 'SHLVL': '1', 08:15:03 INFO - 'TERM': 'linux', 08:15:03 INFO - 'TMOUT': '86400', 08:15:03 INFO - 'USER': 'cltbld', 08:15:03 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1482335246.123441-1478155344', 08:15:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:03 INFO - '_': '/tools/buildbot/bin/python'} 08:15:03 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HiaI2NBdTKaiN_XeJwN5xA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 08:15:03 INFO - mozversion application_buildid: 20161221063559 08:15:03 INFO - mozversion application_changeset: 38c65075d65e662c265bb5d215f1507798497a98 08:15:03 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:15:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:15:03 INFO - mozversion application_name: Firefox 08:15:03 INFO - mozversion application_remotingname: firefox-dev 08:15:03 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:15:03 INFO - mozversion application_vendor: Mozilla 08:15:03 INFO - mozversion application_version: 52.0a2 08:15:03 INFO - mozversion platform_buildid: 20161221063559 08:15:03 INFO - mozversion platform_changeset: 38c65075d65e662c265bb5d215f1507798497a98 08:15:03 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:15:03 INFO - mozversion platform_version: 52.0a2 08:15:03 INFO - using testdate: 1482336903 08:15:03 INFO - actual date: 1482336903 08:15:03 INFO - starting webserver on 'localhost:55090' 08:15:03 INFO - SUITE-START | Running 2 tests 08:15:03 INFO - TEST-START | dromaeo_css 08:15:03 INFO - operating with platform_type : linux_ 08:15:03 INFO - Initialising browser for dromaeo_css test... 08:15:03 INFO - TEST-INFO | started process 14494 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3ADgOD/profile http://localhost:55090/getInfo.html) 08:15:07 INFO - PROCESS | 14494 | __metrics Screen width/height:1600/1200 08:15:07 INFO - PROCESS | 14494 | colorDepth:24 08:15:07 INFO - PROCESS | 14494 | Browser inner width/height: 1024/697 08:15:07 INFO - PROCESS | 14494 | __metrics 08:15:07 INFO - PROCESS | 14494 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:15:07 INFO - PROCESS | 14494 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:15:08 INFO - PROCESS | 14494 | console.error: PushService: 08:15:08 INFO - PROCESS | 14494 | stateChangeProcessEnqueue: Error transitioning state 08:15:08 INFO - PROCESS | 14494 | UnknownError 08:15:08 INFO - TEST-INFO | 14494: exit 0 08:15:08 INFO - Browser initialized. 08:15:08 INFO - Running cycle 1/1 for dromaeo_css test... 08:15:08 INFO - TEST-INFO | started process 14589 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3ADgOD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:15:20 INFO - PROCESS | 14589 | RSS: Main: 144572416 08:15:20 INFO - PROCESS | 14589 | 08:16:12 INFO - PROCESS | 14589 | 1482336972328 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] 08:18:22 INFO - PROCESS | 14589 | Cycle 1(1): loaded http://localhost:55090/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55090/tests/dromaeo/cssquery-ext.html) 08:18:23 INFO - PROCESS | 14589 | RSS: Main: 243683328 08:18:23 INFO - PROCESS | 14589 | 08:21:26 INFO - PROCESS | 14589 | Cycle 1(1): loaded http://localhost:55090/tests/dromaeo/cssquery-ext.html (next: http://localhost:55090/tests/dromaeo/cssquery-jquery.html) 08:21:26 INFO - PROCESS | 14589 | RSS: Main: 226652160 08:21:26 INFO - PROCESS | 14589 | 08:24:28 INFO - PROCESS | 14589 | Cycle 1(1): loaded http://localhost:55090/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55090/tests/dromaeo/cssquery-mootools.html) 08:24:29 INFO - PROCESS | 14589 | RSS: Main: 175063040 08:24:29 INFO - PROCESS | 14589 | 08:27:31 INFO - PROCESS | 14589 | Cycle 1(1): loaded http://localhost:55090/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55090/tests/dromaeo/cssquery-prototype.html) 08:27:32 INFO - PROCESS | 14589 | RSS: Main: 215236608 08:27:32 INFO - PROCESS | 14589 | 08:30:34 INFO - PROCESS | 14589 | Cycle 1(1): loaded http://localhost:55090/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55090/tests/dromaeo/cssquery-yui.html) 08:30:35 INFO - PROCESS | 14589 | RSS: Main: 176254976 08:30:35 INFO - PROCESS | 14589 | 08:33:37 INFO - PROCESS | 14589 | Cycle 1(1): loaded http://localhost:55090/tests/dromaeo/cssquery-yui.html (next: http://localhost:55090/tests/dromaeo/cssquery-dojo.html) 08:33:38 INFO - PROCESS | 14589 | RSS: Main: 264245248 08:33:38 INFO - PROCESS | 14589 | 08:33:38 INFO - PROCESS | 14589 | __start_tp_report 08:33:38 INFO - PROCESS | 14589 | _x_x_mozilla_page_load 08:33:38 INFO - PROCESS | 14589 | _x_x_mozilla_page_load_details 08:33:38 INFO - PROCESS | 14589 | |i|pagename|runs| 08:33:38 INFO - PROCESS | 14589 | |0;dojo.html;3208.695173958474;3255.3326568053567;3273.5908011498564;3283.981965590667;3284.981655686737;5580.91628625571;5619.353774315955;5621;5623.634463759863;5640.520555752761;5682.147677848325;5731.283589551306;5744.626599271044;5750.683712395817;5785.595008349417;5153.871153221171;5179.533841954223;5181.9740901295445;5210.9218361724415;5265.183896496049;5017.724025178613;5050.924236136461;5274.525292723654;5275.446078161795;5298.258243845865;5062.139436295838;5083.16127838908;5084.44071152173;5145.897082058375;5147.0735267652;5141.588672906178;5196.714180720059;5199.428062913076;5204.739763011834;5240.895182096375;5006.649534532584;5046.62150338726;5122.9754049190315;5147.150720131174;5176.50823171798;5492.5605951524185;5510.972445137789;5529.751161197756;5537.36320323164;5606.747696353633;5947.10793380992;6000.429959153874;6054.152418661391;6066.969665151646;6074.271087469488;5946.197263369433;6028.668423236721;6029.366916473795;6073.1497590337385;6109.14471973924;5574.86062848432;5600;5638.943610563924;5646.71766411686;5652.63257888236;6111.633302001894;6124.142620033199;6133.570650054453;6140.232470941132;6146.323904370515;5840.970795145997;5899.882002359929;5913.586048976616;5922.615030023035;5925;5953.672548009901;6011.669358185254;6061.3029501607;6062.939370606326;6111.014442317695;6068.75724971005;6075.635461872302;6077.696115194222;6082.391760823883;6103.542234332443;6028.336882942873;6084.574079814459;6086.482648974798;6090.878182436327;6109.877802443926;4545.113702827983;4578.244589642672;4578.633709303248;4595.586397224199;4634.83778067766;4119.670426365884;4149.647279981175;4152.667786577066;4172.99848036469;4204.285271503852;5706.400827913092;5710.543156547466;5762.423757624288;5764.625299355528;5795.33353664334;5915.319738230072;5971.970140149271;5974.074018527135;5987.670678112659;6011.458968692751;5718.142278658152;5725.055365864669;5746.02317606008;5763.538916886639;5780.335261444988;5163.044836705221;5230.110881150214;5234.26720259164;5236.842894713165;5254.553362964114;6092.482139018144;6190.969045154746;6202.22298682064;6209.316975132822;6251.593646412968;6042.456178943916;6130;6165.815025549241;6171.9691401542705;6178.320384757763;6341.55609107358;6344.143540621957;6354.364563543609;6362.395572420613;6373.2989371168205;5820.796272130625;5881.441263080001;5916.112583112567;6034.879302414015;6043.063325184604;6044.969775151096;6115.848865095124;6119.350229749554;6132.600268413531;6140.078988151813;5906.557008224315;5914.645121292736;5979.252593425822;5980.730867110903;5994;5883.411658834082;5977.462028417463;5978.910316345171;5979.103134529855;5980.192673988956;5821.592488525763;5868.149118377726;5875.50058245054;5904.084866845646;5919;6008.459238668541;6045.848853778515;6050.062240352577;6050.394960503914;6052.364501727256;5689.2319536862;5734.569907256889;5744.281964754406;5890.440408161217;5895.20414744004 08:33:38 INFO - PROCESS | 14589 | |1;ext.html;585.5140233606107;626.8182227154125;646.2148489585153;659.3966520633624;675.9087523184369;35530.111747206334;47038.23694104472;47984.52015479844;47992.52007479924;48139.27791083136;46843.82890427741;47404.288935665994;47436.525634743644;47498.76250618751;47912.2813157802;8245.464044837096;8780.42927209731;8920.598573064228;8922.687705930293;8931.64273429062;8231.670733170666;10566.20753443491;10794.946025269903;10819;11076.836932122133;10901.945490272537;10973.725656858562;10975.121990240761;10978.615748448807;10986.780264394707;10751.301165424222;10783.975522325367;10803.13574914005;10821.729456763565;10828.837567436494;10655.147588193004;10697.46512674371;10737.83893241602;10750.731231719192;10755.569777208902;45382.773086134686;45647;45726.771366143286;45792;45796.54203457989;3792.3742582474133;3833.4249862520564;3940.4483372327895;3941.7043721720984;4244.427002354704;32203.677963220536;34043.82978085094;34314.6568534314;34358.312833743184;36054.459183112274;4505.977470112662;4508.61676757476;4562.726236425825;4600.5629465200755;4674.649401294916;399775;404579;406579;407385;413197;38592.42111368332;62912.68543657344;63773;63822.361776381644;63865;40313.79843100766;42853.35719964203;42853.571464284956;42865.57134428678;42869.35695964563;17195.570110747332;17308.65382692339;17320;17523.82476175222;17603.471895843144;13587.252701101534;13703.794443083361;14049.438022479191;14440.133591984304;14546.199959002144;9630.181434577999;9656.71029869105;9836.754081147885;9839.458829764431;9859.802803943881;3597.2805438912324;3619.149499867529;3665.560132784083;3669.247804200186;3683.797391143459;1033.5452400943561;1063.6330465989377;1069.2942657845786;1110.8056090184186;1154.9538018479334;34816;34873;35137;35416.822915885255;35430.468542971874;1006.6879267427121;1127.4813585750646;1142.1890457774907;1144.1761931409371;1158.9942050289694;16446.67106657884;18062.36781712634;18472.261109555737;18864.81135188658;18904;552204;557929;558681;560604;560864;63315;63810.36189638137;63819.680901595195;63828;64059.67970160119;1321.9471221151045;1360.7890776929394;1364.433759989613;1415.773476243796;1439.7264519741216;30816.229594260323;35584.288314233054;35705;35875.28249434944;35942.8202858984;54244.45755542394;55069;55102.72448637731;55114.448855510935;55252.447475526336;426456;427445;428827;428981;429310;27213.183604491896;27536.311592210353;28935.421291574472;28947.56578651364;31714.84142579272;48071.5192848067;50227.24659130043;50383.73863964421;50538.24192637187;51488.742556286976;41520.58479415288;42428.787856060524;43102;43259;43917.560824391345;42717;43078.138437231704;43174.78412608043;44333.556664432945;44628.77685611551;43156.56843431525;43209.35185972276;43859.12281754411;44326;44403.55596443994;35821.10447238736;38089.809550952064;38831;39075.21849562936;39767.40348894711;29346.706532934397;29506.55740163942;29793.25516862096;29987.250318742204;30051 08:33:38 INFO - PROCESS | 14589 | |2;jquery.html;398.22239876858896;415.53460124660364;424.27025516112286;432.50694208602187;440.77520464563065;15038.47365342212;19207.519812004706;20449.38651840445;21115.683264751042;21288.148474061018;19243.326483573077;20653.173873045096;20719.378418647426;20756.8962155189;20934.89532552335;5625.128105143699;5826.854328641775;5835.737391817357;5846.3861294563885;5850.385709500505;5736.713164341787;5964.403559644023;6006.099085137221;6019.367966363535;6036.607620504653;5874.73563689635;6021.668808215546;6026.578139530235;6027.427394397547;6033.155358249848;6006.639601623895;6110.450059494622;6113.296970848321;6125.203723515937;6125.601835880676;5873.2952045754355;5900.704964751745;5937.050071988461;6019.849503762441;6030.909536356959;23281.883590582107;23495;23644.172453964202;23924.7607523926;23985.76014239853;2378.6669866218745;2400.6519054736964;2445.461998360358;2534.6071358939394;2540.415704388001;10783.070579190673;11890.692023877367;12868.29224392658;14984.475543356039;15779.842201577952;1906.4566598519493;1934.555052337956;1959.588486417854;2009.166196028661;2088.446561661161;81999.5900020496;84985.57507212486;85922.57038714828;87215.56392217998;87803;10653.147748180127;11327.093832493381;11604;11807.23252988553;11987.340696261615;15298.388064477296;15580.143092129814;16346.264418101215;16413.1793410329;17021.148942552823;8497.61760720769;8641.611127499278;8667.219950204511;8707.912920870836;8853.29173666105;8326.625301861432;8456.788580285542;8530.445521041236;8614.6984855531;8759.16787905148;4981.476944920803;5027.346444962204;5122.3096378195105;5124.30821839047;5215.47845215483;2084.7289852319404;2117.5764847030655;2138.3478039198194;2146.0664610894;2173.8586991845477;901.7745563609097;1010.4745532323151;1019.7756493571402;1054.7890421915647;1057.613970900631;20316.49208769763;20436.284730034677;20712.792872071088;20723.378298651063;20819.271325503534;1038.6364772329623;1051.2851261142343;1069.2835800014009;1074.3607553505651;1106.5794997900907;9890.240874099825;11278.887211127783;11319.547218111184;11392.658220253406;11454.828177577343;479150;483759;489831;490092;503276;91558.54220728854;92219.53890230505;92486;93272;93581;1046.1473898772476;1089.6022951622758;1116.268843907242;1119.6864877834219;1121.5233525751523;17453.912730436776;17903.37338193157;17914.91042544831;17940;18238.361657341928;42447.3632895513;43214.13571728485;43271.35092973545;43497.34753978629;43580.56419435765;57738;59230.40769592249;60174;61263.69368153131;61657;8545.658173672984;8667.783305417415;8722.302215822592;9002.50486223264;9097.40866843653;11558.537658493566;12392.938035309766;12749.490020399451;12981.935090324489;13467.528636497676;8485.490870547786;9340.739000234882;10828.656976859522;11438.771224575295;12249.632511024683;11145.83281250798;11471.451354067094;11609.30344179352;11736.295822250693;11748.412579371168;6902.758403455855;10934.234603577674;11544;11741.354225517678;12639.1784534005;7639.961800190964;7831.804204894923;8690.478571285743;8764.079771623889;8892.73321800347;10995.560177592806;11390.886091139315;11390.943045285052;11435.942820285845;11654.18420710576 08:33:38 INFO - PROCESS | 14589 | |3;mootools.html;1375.147408606664;1509.6075020494668;1527.4501179575354;1666.1003058348492;1842.8341449269562;7961.4825036372595;8712.390132690707;8874.645014199441;8917.509536975464;9255.722328330145;9076.727698169048;9137.360384773068;9138.360314777969;9139.131782480654;9145.908540914588;2517.25740906433;2550.1584477122506;2550.1966880432697;2551.2091251712027;2555.080171138389;2478.330850670318;2547.1339744486872;2550.5154020736095;2552.387427017521;2556.335352808274;2480.516299321633;2492.19003823758;2515.1825656661567;2522.735112813156;2524.192258477288;2415.6014257647466;2433.841800282985;2467.988124868813;2468.518638865422;2481.8262721609403;2467.962980555293;2488.8755562222;2495.7379475155212;2510.184190138194;2511.6232565115197;9018.188363047291;9064.637414503411;9080.818383632357;9083.772905677344;9084.682036128705;5419.810306639288;5568.972155139199;5571.832845014656;5633.464820842013;5637.210790489335;3465.9102259333977;3510.6840384365273;3572.3034008368118;3586.5696116466193;3663.139162296858;1153.6366044695894;1192.0463629096687;1195.844540209776;1236.7217376090398;1244.6390546741434;12052.939735301268;12079.879201207963;12137.757244855053;12148.817767733492;12161.391930403444;4771.093492236464;4812.25410061441;4830.154722923475;4900.313956046157;4924.507549245119;10015;10030.297879148535;10045.397276163454;10050.09549140581;10059.245556583139;5506.944930550723;5510.641808282448;5517.806876759294;5518.034343989786;5536.307961504812;4339.132173565299;4675;4733.502982186889;4740.644451666139;5092.0579692756955;4029.5164580250557;4072.9592704073175;4175.394567787654;4177.310743727251;4184.28867092595;1272.2684456437585;1279.2004996876951;1282.6472720002075;1283.2492991599831;1294.9287789171497;865.2385900407601;906.6237511432813;962.5620342744035;989.0104423185048;990.5889056041661;5749.942500574941;5988.4909782668965;6032.185654936615;6062.666553339521;6101.755929762849;486.04249628232327;486.87584665909964;500.15473849194746;503.85121922017856;511.9641625086208;4003.939940900889;4016.5180178378196;4023.1350259693722;4031.4557534732435;4079.938800917989;10894.67315980522;11298.943505282585;11352.545898164146;11362.147838912115;11418.657440276806;11213.383263920563;11218.102551795837;11220.831687524693;11224.214304998572;11247.268927519848;8028.197180282042;8211.096779354266;8293.502389856629;8306.210909963544;8570.700025498953;5918.496927761188;5918.674472904032;6005.129256257906;6058.787942421994;6102.206713127265;10412;10432.374057556572;10434.634787782392;10441.738956525844;10473.423961682181;9318.207952324128;9441.763955901157;9998.600055997678;10194.643187488402;10330.948345258226;7444;7585.127710313164;7593.8860917087395;7749.418793590616;7947.165547617648;8707.390482666153;8923.41997770143;8974.967878693773;8988.056254093226;9004.144606262395;7876.8818467721885;8006.079300880473;8029.638666259915;8096.433249672466;8114.83770324602;7690.461667683208;7722;7823.647935843014;7923.366130709414;8016.438849280495;6956.2695916928;7042.718291268497;7104.11198600175;7113;7119.572825630479;4904.166291730343;5091.643584949018;5336.359636843604;5345.919811202757;5540.085885828793;5244.711540865289;5275.498827611371;5299.417064122867;5334.119870221525;5433.320834895638 08:33:38 INFO - PROCESS | 14589 | |4;prototype.html;354.9591796943351;358.3352880406845;366.19071851208827;369.54545908532486;370.5775416025729;5326.786928522864;5355.946440535594;5379.488948549892;5386.730663466826;5395.487428694268;4973.900521989558;5104.846854594359;5107.821226257081;5179.352580927384;5269.604779641523;4159.313713237312;4182.16356728654;4187.476565429321;4190.350495673176;4197.181549597822;4196.139791342783;4201.978990105061;4206.726562773425;4209.179210054025;4212.726172798773;3941.901452463697;3971.649639122698;4051;4176.874693759177;4190.120074784299;4153.6677065834665;4164.708470407073;4172.457580514544;4188.612490880184;4189.9790501047455;3748.5689145748315;3755.399136138205;3758.248350329945;3759.812009399519;3761.4357846322996;4984;5108.208227724708;5125.666831655968;5146.382434107931;5157.922631160535;4757.714537127784;4766.142094423002;4780.8525953771195;4782.258749893737;4783.904321913577;5465.371482279549;5475.561955043587;5485.369182544018;5505.3393592768725;5523.28197334344;4024.315866302706;4088.713790034699;4095.8941085906936;4121.196366708493;4146.253674338618;5660.3490598581275;5662.348829884533;5674.602777805555;5693.28833895763;5711.543076553866;4199.727017743837;4205.747655140702;4205.990562265096;4219.915601687949;4242.215190189825;4119.691023173274;4248.447701798808;4265.55211702773;4274.935875961863;4276.700630955803;4771.355866957916;4774.474807771142;4779.545943135397;4785.473597904297;4788.904221915543;5482.479164479368;5517.2551705520045;5522.3649280333275;5522.779088836482;5532.778688852401;1344.731053789246;1407.676234466058;1436.906601070927;1443.985560144406;1455.7525220712505;956.808773077509;980.5342462330478;984.2765567308023;994.8209322321907;997.581015973293;5190.455002224788;5209;5221.511869117283;5232.92150617741;5242.213667949838;5471.261379713767;5481.616286859961;5492.780288788484;5504.889902201933;5525.64621667694;4980.526849949249;5207.29701490294;5209.629618523562;5215.973920130375;5234.607404444682;2851.8574071296352;2871.7271859173347;2881.3084859633536;2922.371690086599;2935.6477222732983;5579.860503487364;5583.972080139654;5600.631507424216;5601.467860553241;5606.775728970877;5232.790688372423;5439.4288599696465;5501.174823776386;5509.862253443615;5534.806281780118;5597.69735855847;5613.438656134354;5614.494695477427;5618.578606604603;5621.971890140523;5307.416184219655;5470;5478.904219156105;5501.807436739695;5507.155103040526;5349;5364.524755692216;5379.757910893941;5405.216243644728;5412.8646783829145;5589.329280486368;5589.546717853306;5618.52242559387;5620.606557541097;5634.647384806198;3891.5330160380936;4009;4031.274370613318;4050.076213798422;4082.2447847148374;5356.74116582595;5432.511074003359;5441.727913604224;5443.210734443563;5464.617476776746;5275.683458992473;5320.52115309624;5342.9465705344;5356.1697936819855;5362.463753624763;5081.8729531762;5280.864614107985;5317.361916570037;5331.853651464954;5342.439043900335;5292.9470705294;5300.840974770763;5304;5304.681719096867;5310;5341.62608617393;5355.839324820262;5380.192971054373;5402.837914862561;5411.6482428643585;5198.116320225495;5249.47505249472;5461.34463864323;5504.926539324793;5511.311086114236 08:33:38 INFO - PROCESS | 14589 | |5;yui.html;763.5991104670047;791.6754130806366;801.6112185589991;803.5700900018489;887.299033763327;14878.47925322614;16084.115373654458;16448.34206631735;17088.231029603667;17312.394066207686;15621.375144994216;15627.843721562782;15899.364025438997;15907;16055.83944160558;858.5964596639569;881.9647214111428;882.07382248639;882.5895958379352;882.7175303902753;716.1907045039098;744.5235049568281;839.064443145891;873.7160422862563;879.9164079412445;922.6540047482194;923.3075193604797;923.5197697197453;924.6624981881632;925.0333401595349;917.1653795046476;917.5733284022962;917.8164367126568;918.453520155513;918.7427520294295;554.5618961020789;580.0892598620168;649.6232185332495;662.8044726805604;664.6112024465693;15428.768568471482;15443.768343474856;15453;15458;15462.690746185013;13754.587362379045;13883.791743123862;13899.930500347535;13918.93040534801;14135.15189088658;11367.545298188063;11404.530032828428;11492.712682182928;11563.190576659637;11757.706057348634;4309.332053531708;4348.565143485658;4377.890552736175;4425.15921974827;4514.0971805639;64937.3506264936;64950.67524662346;65305.3469465304;65353.67323163354;65371.346286537475;10674.199435042403;10997.230193886511;11005.834912476319;11232.775344493228;11243.100551955824;19715.50711232202;19897.403077907686;19953.900230498755;20362.79637203609;20381.898090509454;8817.515036672916;8832.072632373636;8879.778005549913;9037.819243615222;9141;4888;5038.168702164176;5061.367329083864;5063.974680126576;5168.198929165986;3592.2276710507367;3728.6271372862498;3730.7201959852578;3738.4579236010627;3739.7382183247455;672.4519516593961;680.6630717794625;685.3694600967123;694.2918223412192;697.822055375876;742.6769355330448;771.571777663391;775.4828126165111;791.1416113516899;792.9881051784228;9714.417134971924;9923.156531694887;10091.7477063074;10198.43908585035;10341.276110672332;665.70043480434;681.2608319972786;732.3152852083319;745.6532712288812;776.1733753552448;4915;4934.851954441372;4992;5062.443131255559;5116.488351164854;70945.6452717733;72273.2772672277;93760;97525.5123724391;98126;45325.77337113359;59325;65773.01340479897;72950;74898;44249.11501769946;56496.43503564994;64108.35891641117;67193.32806671968;67676.6616166916;10019.899801001897;10248.743781405525;10344.689659310232;10357.9482102589;10508.94745526298;32641.510377344835;33365.666343336256;43945.78027109844;45013.32480012868;45503.54496454993;55602.721986389806;56293.71853140872;56553;63169.68415157895;63536.046959296575;12680.175788573713;12727.745445091232;12735.745285094432;12843.165194262343;13015.47938082504;14182.432702691776;14287.785683214968;14397.784033239719;14906.180160090866;14937.402503899722;11180.88819111831;12742.42659080325;13293.66765830862;13464.394102265618;14360.928195358956;13538.59384218475;13750.587482375544;14068.507602233873;14451.92774036123;14831.11013339203;12451.315177665316;12945.158564693265;13116.409761560562;13236.933815330862;13667.248301343521;10054.34646747959;10299.485025748832;10670.35977841332;11045.447727613426;11393.259438136494;10903.236773425784;11367.804177962205;11624.302541847177;11683.766324673628;11927.582534611247 08:33:38 INFO - PROCESS | 14589 | __end_tp_report 08:33:38 INFO - PROCESS | 14589 | __start_cc_report 08:33:38 INFO - PROCESS | 14589 | _x_x_mozilla_cycle_collect,1041 08:33:38 INFO - PROCESS | 14589 | __end_cc_report 08:33:38 INFO - PROCESS | 14589 | __startTimestamp1482338018223__endTimestamp 08:33:38 INFO - PROCESS | 14589 | 08:33:38 INFO - PROCESS | 14589 | ------- Summary: start ------- 08:33:38 INFO - PROCESS | 14589 | Number of tests: 6 08:33:38 INFO - PROCESS | 14589 | 08:33:38 INFO - PROCESS | 14589 | [#0] dojo.html Cycles:165 Average:5625.78 Median:5875.50 stddev:641.74 (10.9%) stddev-sans-first:615.05 08:33:38 INFO - PROCESS | 14589 | Values: 3208.7 3255.3 3273.6 3284.0 3285.0 5580.9 5619.4 5621.0 5623.6 5640.5 5682.1 5731.3 5744.6 5750.7 5785.6 5153.9 5179.5 5182.0 5210.9 5265.2 5017.7 5050.9 5274.5 5275.4 5298.3 5062.1 5083.2 5084.4 5145.9 5147.1 5141.6 5196.7 5199.4 5204.7 5240.9 5006.6 5046.6 5123.0 5147.2 5176.5 5492.6 5511.0 5529.8 5537.4 5606.7 5947.1 6000.4 6054.2 6067.0 6074.3 5946.2 6028.7 6029.4 6073.1 6109.1 5574.9 5600.0 5638.9 5646.7 5652.6 6111.6 6124.1 6133.6 6140.2 6146.3 5841.0 5899.9 5913.6 5922.6 5925.0 5953.7 6011.7 6061.3 6062.9 6111.0 6068.8 6075.6 6077.7 6082.4 6103.5 6028.3 6084.6 6086.5 6090.9 6109.9 4545.1 4578.2 4578.6 4595.6 4634.8 4119.7 4149.6 4152.7 4173.0 4204.3 5706.4 5710.5 5762.4 5764.6 5795.3 5915.3 5972.0 5974.1 5987.7 6011.5 5718.1 5725.1 5746.0 5763.5 5780.3 5163.0 5230.1 5234.3 5236.8 5254.6 6092.5 6191.0 6202.2 6209.3 6251.6 6042.5 6130.0 6165.8 6172.0 6178.3 6341.6 6344.1 6354.4 6362.4 6373.3 5820.8 5881.4 5916.1 6034.9 6043.1 6045.0 6115.8 6119.4 6132.6 6140.1 5906.6 5914.6 5979.3 5980.7 5994.0 5883.4 5977.5 5978.9 5979.1 5980.2 5821.6 5868.1 5875.5 5904.1 5919.0 6008.5 6045.8 6050.1 6050.4 6052.4 5689.2 5734.6 5744.3 5890.4 5895.2 08:33:38 INFO - PROCESS | 14589 | 08:33:38 INFO - PROCESS | 14589 | [#1] ext.html Cycles:180 Average:62759.90 Median:220044.40 stddev:124333.41 (56.5%) stddev-sans-first:124594.57 08:33:38 INFO - PROCESS | 14589 | Values: 585.5 626.8 646.2 659.4 675.9 35530.1 47038.2 47984.5 47992.5 48139.3 46843.8 47404.3 47436.5 47498.8 47912.3 8245.5 8780.4 8920.6 8922.7 8931.6 8231.7 10566.2 10794.9 10819.0 11076.8 10901.9 10973.7 10975.1 10978.6 10986.8 10751.3 10784.0 10803.1 10821.7 10828.8 10655.1 10697.5 10737.8 10750.7 10755.6 45382.8 45647.0 45726.8 45792.0 45796.5 3792.4 3833.4 3940.4 3941.7 4244.4 32203.7 34043.8 34314.7 34358.3 36054.5 4506.0 4508.6 4562.7 4600.6 4674.6 399775.0 404579.0 406579.0 407385.0 413197.0 38592.4 62912.7 63773.0 63822.4 63865.0 40313.8 42853.4 42853.6 42865.6 42869.4 17195.6 17308.7 17320.0 17523.8 17603.5 13587.3 13703.8 14049.4 14440.1 14546.2 9630.2 9656.7 9836.8 9839.5 9859.8 3597.3 3619.1 3665.6 3669.2 3683.8 1033.5 1063.6 1069.3 1110.8 1155.0 34816.0 34873.0 35137.0 35416.8 35430.5 1006.7 1127.5 1142.2 1144.2 1159.0 16446.7 18062.4 18472.3 18864.8 18904.0 552204.0 557929.0 558681.0 560604.0 560864.0 63315.0 63810.4 63819.7 63828.0 64059.7 1321.9 1360.8 1364.4 1415.8 1439.7 30816.2 35584.3 35705.0 35875.3 35942.8 54244.5 55069.0 55102.7 55114.4 55252.4 426456.0 427445.0 428827.0 428981.0 429310.0 27213.2 27536.3 28935.4 28947.6 31714.8 48071.5 50227.2 50383.7 50538.2 51488.7 41520.6 42428.8 43102.0 43259.0 43917.6 42717.0 43078.1 43174.8 44333.6 44628.8 43156.6 43209.4 43859.1 44326.0 44403.6 35821.1 38089.8 38831.0 39075.2 39767.4 29346.7 29506.6 29793.3 29987.3 30051.0 08:33:38 INFO - PROCESS | 14589 | 08:33:38 INFO - PROCESS | 14589 | [#2] jquery.html Cycles:180 Average:29467.44 Median:13193.21 stddev:80760.17 (612.1%) stddev-sans-first:80957.23 08:33:38 INFO - PROCESS | 14589 | Values: 398.2 415.5 424.3 432.5 440.8 15038.5 19207.5 20449.4 21115.7 21288.1 19243.3 20653.2 20719.4 20756.9 20934.9 5625.1 5826.9 5835.7 5846.4 5850.4 5736.7 5964.4 6006.1 6019.4 6036.6 5874.7 6021.7 6026.6 6027.4 6033.2 6006.6 6110.5 6113.3 6125.2 6125.6 5873.3 5900.7 5937.1 6019.8 6030.9 23281.9 23495.0 23644.2 23924.8 23985.8 2378.7 2400.7 2445.5 2534.6 2540.4 10783.1 11890.7 12868.3 14984.5 15779.8 1906.5 1934.6 1959.6 2009.2 2088.4 81999.6 84985.6 85922.6 87215.6 87803.0 10653.1 11327.1 11604.0 11807.2 11987.3 15298.4 15580.1 16346.3 16413.2 17021.1 8497.6 8641.6 8667.2 8707.9 8853.3 8326.6 8456.8 8530.4 8614.7 8759.2 4981.5 5027.3 5122.3 5124.3 5215.5 2084.7 2117.6 2138.3 2146.1 2173.9 901.8 1010.5 1019.8 1054.8 1057.6 20316.5 20436.3 20712.8 20723.4 20819.3 1038.6 1051.3 1069.3 1074.4 1106.6 9890.2 11278.9 11319.5 11392.7 11454.8 479150.0 483759.0 489831.0 490092.0 503276.0 91558.5 92219.5 92486.0 93272.0 93581.0 1046.1 1089.6 1116.3 1119.7 1121.5 17453.9 17903.4 17914.9 17940.0 18238.4 42447.4 43214.1 43271.4 43497.3 43580.6 57738.0 59230.4 60174.0 61263.7 61657.0 8545.7 8667.8 8722.3 9002.5 9097.4 11558.5 12392.9 12749.5 12981.9 13467.5 8485.5 9340.7 10828.7 11438.8 12249.6 11145.8 11471.5 11609.3 11736.3 11748.4 6902.8 10934.2 11544.0 11741.4 12639.2 7640.0 7831.8 8690.5 8764.1 8892.7 10995.6 11390.9 11390.9 11435.9 11654.2 08:33:38 INFO - PROCESS | 14589 | 08:33:38 INFO - PROCESS | 14589 | [#3] mootools.html Cycles:180 Average:5906.58 Median:2693.59 stddev:3321.14 (123.3%) stddev-sans-first:3312.99 08:33:38 INFO - PROCESS | 14589 | Values: 1375.1 1509.6 1527.5 1666.1 1842.8 7961.5 8712.4 8874.6 8917.5 9255.7 9076.7 9137.4 9138.4 9139.1 9145.9 2517.3 2550.2 2550.2 2551.2 2555.1 2478.3 2547.1 2550.5 2552.4 2556.3 2480.5 2492.2 2515.2 2522.7 2524.2 2415.6 2433.8 2468.0 2468.5 2481.8 2468.0 2488.9 2495.7 2510.2 2511.6 9018.2 9064.6 9080.8 9083.8 9084.7 5419.8 5569.0 5571.8 5633.5 5637.2 3465.9 3510.7 3572.3 3586.6 3663.1 1153.6 1192.0 1195.8 1236.7 1244.6 12052.9 12079.9 12137.8 12148.8 12161.4 4771.1 4812.3 4830.2 4900.3 4924.5 10015.0 10030.3 10045.4 10050.1 10059.2 5506.9 5510.6 5517.8 5518.0 5536.3 4339.1 4675.0 4733.5 4740.6 5092.1 4029.5 4073.0 4175.4 4177.3 4184.3 1272.3 1279.2 1282.6 1283.2 1294.9 865.2 906.6 962.6 989.0 990.6 5749.9 5988.5 6032.2 6062.7 6101.8 486.0 486.9 500.2 503.9 512.0 4003.9 4016.5 4023.1 4031.5 4079.9 10894.7 11298.9 11352.5 11362.1 11418.7 11213.4 11218.1 11220.8 11224.2 11247.3 8028.2 8211.1 8293.5 8306.2 8570.7 5918.5 5918.7 6005.1 6058.8 6102.2 10412.0 10432.4 10434.6 10441.7 10473.4 9318.2 9441.8 9998.6 10194.6 10330.9 7444.0 7585.1 7593.9 7749.4 7947.2 8707.4 8923.4 8975.0 8988.1 9004.1 7876.9 8006.1 8029.6 8096.4 8114.8 7690.5 7722.0 7823.6 7923.4 8016.4 6956.3 7042.7 7104.1 7113.0 7119.6 4904.2 5091.6 5336.4 5345.9 5540.1 5244.7 5275.5 5299.4 5334.1 5433.3 08:33:38 INFO - PROCESS | 14589 | 08:33:38 INFO - PROCESS | 14589 | [#4] prototype.html Cycles:180 Average:4597.82 Median:5238.41 stddev:1300.23 (24.8%) stddev-sans-first:1264.28 08:33:38 INFO - PROCESS | 14589 | Values: 355.0 358.3 366.2 369.5 370.6 5326.8 5355.9 5379.5 5386.7 5395.5 4973.9 5104.8 5107.8 5179.4 5269.6 4159.3 4182.2 4187.5 4190.4 4197.2 4196.1 4202.0 4206.7 4209.2 4212.7 3941.9 3971.6 4051.0 4176.9 4190.1 4153.7 4164.7 4172.5 4188.6 4190.0 3748.6 3755.4 3758.2 3759.8 3761.4 4984.0 5108.2 5125.7 5146.4 5157.9 4757.7 4766.1 4780.9 4782.3 4783.9 5465.4 5475.6 5485.4 5505.3 5523.3 4024.3 4088.7 4095.9 4121.2 4146.3 5660.3 5662.3 5674.6 5693.3 5711.5 4199.7 4205.7 4206.0 4219.9 4242.2 4119.7 4248.4 4265.6 4274.9 4276.7 4771.4 4774.5 4779.5 4785.5 4788.9 5482.5 5517.3 5522.4 5522.8 5532.8 1344.7 1407.7 1436.9 1444.0 1455.8 956.8 980.5 984.3 994.8 997.6 5190.5 5209.0 5221.5 5232.9 5242.2 5471.3 5481.6 5492.8 5504.9 5525.6 4980.5 5207.3 5209.6 5216.0 5234.6 2851.9 2871.7 2881.3 2922.4 2935.6 5579.9 5584.0 5600.6 5601.5 5606.8 5232.8 5439.4 5501.2 5509.9 5534.8 5597.7 5613.4 5614.5 5618.6 5622.0 5307.4 5470.0 5478.9 5501.8 5507.2 5349.0 5364.5 5379.8 5405.2 5412.9 5589.3 5589.5 5618.5 5620.6 5634.6 3891.5 4009.0 4031.3 4050.1 4082.2 5356.7 5432.5 5441.7 5443.2 5464.6 5275.7 5320.5 5342.9 5356.2 5362.5 5081.9 5280.9 5317.4 5331.9 5342.4 5292.9 5300.8 5304.0 5304.7 5310.0 5341.6 5355.8 5380.2 5402.8 5411.6 5198.1 5249.5 5461.3 5504.9 5511.3 08:33:38 INFO - PROCESS | 14589 | 08:33:38 INFO - PROCESS | 14589 | [#5] yui.html Cycles:180 Average:17303.79 Median:24719.24 stddev:21939.27 (88.8%) stddev-sans-first:21965.65 08:33:38 INFO - PROCESS | 14589 | Values: 763.6 791.7 801.6 803.6 887.3 14878.5 16084.1 16448.3 17088.2 17312.4 15621.4 15627.8 15899.4 15907.0 16055.8 858.6 882.0 882.1 882.6 882.7 716.2 744.5 839.1 873.7 879.9 922.7 923.3 923.5 924.7 925.0 917.2 917.6 917.8 918.5 918.7 554.6 580.1 649.6 662.8 664.6 15428.8 15443.8 15453.0 15458.0 15462.7 13754.6 13883.8 13899.9 13918.9 14135.2 11367.5 11404.5 11492.7 11563.2 11757.7 4309.3 4348.6 4377.9 4425.2 4514.1 64937.4 64950.7 65305.3 65353.7 65371.3 10674.2 10997.2 11005.8 11232.8 11243.1 19715.5 19897.4 19953.9 20362.8 20381.9 8817.5 8832.1 8879.8 9037.8 9141.0 4888.0 5038.2 5061.4 5064.0 5168.2 3592.2 3728.6 3730.7 3738.5 3739.7 672.5 680.7 685.4 694.3 697.8 742.7 771.6 775.5 791.1 793.0 9714.4 9923.2 10091.7 10198.4 10341.3 665.7 681.3 732.3 745.7 776.2 4915.0 4934.9 4992.0 5062.4 5116.5 70945.6 72273.3 93760.0 97525.5 98126.0 45325.8 59325.0 65773.0 72950.0 74898.0 44249.1 56496.4 64108.4 67193.3 67676.7 10019.9 10248.7 10344.7 10357.9 10508.9 32641.5 33365.7 43945.8 45013.3 45503.5 55602.7 56293.7 56553.0 63169.7 63536.0 12680.2 12727.7 12735.7 12843.2 13015.5 14182.4 14287.8 14397.8 14906.2 14937.4 11180.9 12742.4 13293.7 13464.4 14360.9 13538.6 13750.6 14068.5 14451.9 14831.1 12451.3 12945.2 13116.4 13236.9 13667.2 10054.3 10299.5 10670.4 11045.4 11393.3 10903.2 11367.8 11624.3 11683.8 11927.6 08:33:38 INFO - PROCESS | 14589 | -------- Summary: end -------- 08:33:38 INFO - PROCESS | 14589 | 08:33:38 INFO - TEST-INFO | 14589: exit 0 08:33:38 INFO - TEST-OK | dromaeo_css | took 1115053ms 08:33:38 INFO - TEST-START | kraken 08:33:38 INFO - operating with platform_type : linux_ 08:33:38 INFO - Initialising browser for kraken test... 08:33:39 INFO - TEST-INFO | started process 14907 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnfMEX6/profile http://localhost:55090/getInfo.html) 08:33:42 INFO - PROCESS | 14907 | __metrics Screen width/height:1600/1200 08:33:42 INFO - PROCESS | 14907 | colorDepth:24 08:33:42 INFO - PROCESS | 14907 | Browser inner width/height: 1024/697 08:33:42 INFO - PROCESS | 14907 | __metrics 08:33:42 INFO - PROCESS | 14907 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:33:42 INFO - PROCESS | 14907 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:33:43 INFO - PROCESS | 14907 | console.error: PushService: 08:33:43 INFO - PROCESS | 14907 | stateChangeProcessEnqueue: Error transitioning state 08:33:43 INFO - PROCESS | 14907 | UnknownError 08:33:43 INFO - TEST-INFO | 14907: exit 0 08:33:43 INFO - Browser initialized. 08:33:43 INFO - Running cycle 1/1 for kraken test... 08:33:43 INFO - TEST-INFO | started process 14996 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnfMEX6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:33:55 INFO - PROCESS | 14996 | RSS: Main: 144547840 08:33:55 INFO - PROCESS | 14996 | 08:33:58 INFO - PROCESS | 14996 | Cycle 1(1): loaded http://localhost:55090/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55090/tests/kraken/driver.html?testName=audio-beat-detection) 08:33:58 INFO - PROCESS | 14996 | RSS: Main: 186212352 08:33:58 INFO - PROCESS | 14996 | 08:34:01 INFO - PROCESS | 14996 | Cycle 1(1): loaded http://localhost:55090/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55090/tests/kraken/driver.html?testName=audio-dft) 08:34:02 INFO - PROCESS | 14996 | RSS: Main: 174886912 08:34:02 INFO - PROCESS | 14996 | 08:34:04 INFO - PROCESS | 14996 | Cycle 1(1): loaded http://localhost:55090/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55090/tests/kraken/driver.html?testName=audio-fft) 08:34:05 INFO - PROCESS | 14996 | RSS: Main: 266608640 08:34:05 INFO - PROCESS | 14996 | 08:34:07 INFO - PROCESS | 14996 | Cycle 1(1): loaded http://localhost:55090/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55090/tests/kraken/driver.html?testName=audio-oscillator) 08:34:08 INFO - PROCESS | 14996 | RSS: Main: 172793856 08:34:08 INFO - PROCESS | 14996 | 08:34:10 INFO - PROCESS | 14996 | Cycle 1(1): loaded http://localhost:55090/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55090/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:34:10 INFO - PROCESS | 14996 | RSS: Main: 175570944 08:34:10 INFO - PROCESS | 14996 | 08:34:13 INFO - PROCESS | 14996 | Cycle 1(1): loaded http://localhost:55090/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55090/tests/kraken/driver.html?testName=imaging-darkroom) 08:34:14 INFO - PROCESS | 14996 | RSS: Main: 214560768 08:34:14 INFO - PROCESS | 14996 | 08:34:17 INFO - PROCESS | 14996 | Cycle 1(1): loaded http://localhost:55090/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55090/tests/kraken/driver.html?testName=imaging-desaturate) 08:34:18 INFO - PROCESS | 14996 | RSS: Main: 212918272 08:34:18 INFO - PROCESS | 14996 | 08:34:21 INFO - PROCESS | 14996 | Cycle 1(1): loaded http://localhost:55090/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55090/tests/kraken/driver.html?testName=json-parse-financial) 08:34:21 INFO - PROCESS | 14996 | RSS: Main: 211558400 08:34:21 INFO - PROCESS | 14996 | 08:34:23 INFO - PROCESS | 14996 | Cycle 1(1): loaded http://localhost:55090/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55090/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:34:23 INFO - PROCESS | 14996 | RSS: Main: 173654016 08:34:23 INFO - PROCESS | 14996 | 08:34:25 INFO - PROCESS | 14996 | Cycle 1(1): loaded http://localhost:55090/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55090/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:34:26 INFO - PROCESS | 14996 | RSS: Main: 181694464 08:34:26 INFO - PROCESS | 14996 | 08:34:28 INFO - PROCESS | 14996 | Cycle 1(1): loaded http://localhost:55090/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55090/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:34:28 INFO - PROCESS | 14996 | RSS: Main: 190271488 08:34:28 INFO - PROCESS | 14996 | 08:34:31 INFO - PROCESS | 14996 | Cycle 1(1): loaded http://localhost:55090/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55090/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:34:32 INFO - PROCESS | 14996 | RSS: Main: 198606848 08:34:32 INFO - PROCESS | 14996 | 08:34:34 INFO - PROCESS | 14996 | Cycle 1(1): loaded http://localhost:55090/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55090/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:34:35 INFO - PROCESS | 14996 | RSS: Main: 195469312 08:34:35 INFO - PROCESS | 14996 | 08:34:37 INFO - PROCESS | 14996 | Cycle 1(1): loaded http://localhost:55090/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55090/tests/kraken/driver.html?testName=ai-astar) 08:34:37 INFO - PROCESS | 14996 | RSS: Main: 246763520 08:34:37 INFO - PROCESS | 14996 | 08:34:37 INFO - PROCESS | 14996 | __start_tp_report 08:34:37 INFO - PROCESS | 14996 | _x_x_mozilla_page_load 08:34:37 INFO - PROCESS | 14996 | _x_x_mozilla_page_load_details 08:34:37 INFO - PROCESS | 14996 | |i|pagename|runs| 08:34:37 INFO - PROCESS | 14996 | |0;ai-astar;102;112;111;109;112;112;110;110;111;110 08:34:37 INFO - PROCESS | 14996 | |1;audio-beat-detection;146;122;120;153;125;118;118;118;150;120 08:34:37 INFO - PROCESS | 14996 | |2;audio-dft;163;160;162;162;162;161;161;162;161;161 08:34:37 INFO - PROCESS | 14996 | |3;audio-fft;76;75;76;116;78;76;76;75;103;77 08:34:37 INFO - PROCESS | 14996 | |4;audio-oscillator;82;81;120;83;82;82;97;83;82;114 08:34:37 INFO - PROCESS | 14996 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;119;117;117 08:34:37 INFO - PROCESS | 14996 | |6;imaging-darkroom;147;147;146;147;146;146;146;157;147;145 08:34:37 INFO - PROCESS | 14996 | |7;imaging-desaturate;86;85;87;86;85;85;89;85;85;85 08:34:37 INFO - PROCESS | 14996 | |8;json-parse-financial;52;50;51;51;53;51;51;50;51;50 08:34:37 INFO - PROCESS | 14996 | |9;json-stringify-tinderbox;61;60;61;60;59;61;60;60;61;62 08:34:37 INFO - PROCESS | 14996 | |10;stanford-crypto-aes;75;75;81;83;76;75;78;81;78;75 08:34:37 INFO - PROCESS | 14996 | |11;stanford-crypto-ccm;139;124;121;124;123;123;127;124;163;134 08:34:37 INFO - PROCESS | 14996 | |12;stanford-crypto-pbkdf2;159;156;159;159;159;155;155;156;155;161 08:34:37 INFO - PROCESS | 14996 | |13;stanford-crypto-sha256-iterative;68;63;64;63;64;69;64;63;64;62 08:34:37 INFO - PROCESS | 14996 | __end_tp_report 08:34:37 INFO - PROCESS | 14996 | __start_cc_report 08:34:37 INFO - PROCESS | 14996 | _x_x_mozilla_cycle_collect,1622 08:34:37 INFO - PROCESS | 14996 | __end_cc_report 08:34:37 INFO - PROCESS | 14996 | __startTimestamp1482338077280__endTimestamp 08:34:37 INFO - PROCESS | 14996 | 08:34:37 INFO - PROCESS | 14996 | ------- Summary: start ------- 08:34:37 INFO - PROCESS | 14996 | Number of tests: 14 08:34:37 INFO - PROCESS | 14996 | 08:34:37 INFO - PROCESS | 14996 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:2.96 (2.7%) stddev-sans-first:1.09 08:34:37 INFO - PROCESS | 14996 | Values: 102.0 112.0 111.0 109.0 112.0 112.0 110.0 110.0 111.0 110.0 08:34:37 INFO - PROCESS | 14996 | 08:34:37 INFO - PROCESS | 14996 | [#1] audio-beat-detection Cycles:10 Average:129.00 Median:123.50 stddev:14.51 (11.8%) stddev-sans-first:14.03 08:34:37 INFO - PROCESS | 14996 | Values: 146.0 122.0 120.0 153.0 125.0 118.0 118.0 118.0 150.0 120.0 08:34:37 INFO - PROCESS | 14996 | 08:34:37 INFO - PROCESS | 14996 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.85 (0.5%) stddev-sans-first:0.71 08:34:37 INFO - PROCESS | 14996 | Values: 163.0 160.0 162.0 162.0 162.0 161.0 161.0 162.0 161.0 161.0 08:34:37 INFO - PROCESS | 14996 | 08:34:37 INFO - PROCESS | 14996 | [#3] audio-fft Cycles:10 Average:82.80 Median:76.00 stddev:14.43 (19.0%) stddev-sans-first:15.09 08:34:37 INFO - PROCESS | 14996 | Values: 76.0 75.0 76.0 116.0 78.0 76.0 76.0 75.0 103.0 77.0 08:34:37 INFO - PROCESS | 14996 | 08:34:37 INFO - PROCESS | 14996 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:82.00 stddev:14.74 (18.0%) stddev-sans-first:15.31 08:34:37 INFO - PROCESS | 14996 | Values: 82.0 81.0 120.0 83.0 82.0 82.0 97.0 83.0 82.0 114.0 08:34:37 INFO - PROCESS | 14996 | 08:34:37 INFO - PROCESS | 14996 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 08:34:37 INFO - PROCESS | 14996 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 119.0 117.0 117.0 08:34:37 INFO - PROCESS | 14996 | 08:34:37 INFO - PROCESS | 14996 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.00 stddev:3.44 (2.3%) stddev-sans-first:3.64 08:34:37 INFO - PROCESS | 14996 | Values: 147.0 147.0 146.0 147.0 146.0 146.0 146.0 157.0 147.0 145.0 08:34:37 INFO - PROCESS | 14996 | 08:34:37 INFO - PROCESS | 14996 | [#7] imaging-desaturate Cycles:10 Average:85.80 Median:85.50 stddev:1.32 (1.5%) stddev-sans-first:1.39 08:34:37 INFO - PROCESS | 14996 | Values: 86.0 85.0 87.0 86.0 85.0 85.0 89.0 85.0 85.0 85.0 08:34:37 INFO - PROCESS | 14996 | 08:34:37 INFO - PROCESS | 14996 | [#8] json-parse-financial Cycles:10 Average:51.00 Median:51.00 stddev:0.94 (1.8%) stddev-sans-first:0.93 08:34:37 INFO - PROCESS | 14996 | Values: 52.0 50.0 51.0 51.0 53.0 51.0 51.0 50.0 51.0 50.0 08:34:37 INFO - PROCESS | 14996 | 08:34:37 INFO - PROCESS | 14996 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:61.00 stddev:0.85 (1.4%) stddev-sans-first:0.88 08:34:37 INFO - PROCESS | 14996 | Values: 61.0 60.0 61.0 60.0 59.0 61.0 60.0 60.0 61.0 62.0 08:34:37 INFO - PROCESS | 14996 | 08:34:37 INFO - PROCESS | 14996 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:78.00 stddev:3.02 (3.9%) stddev-sans-first:3.04 08:34:37 INFO - PROCESS | 14996 | Values: 75.0 75.0 81.0 83.0 76.0 75.0 78.0 81.0 78.0 75.0 08:34:37 INFO - PROCESS | 14996 | 08:34:37 INFO - PROCESS | 14996 | [#11] stanford-crypto-ccm Cycles:10 Average:130.20 Median:125.50 stddev:12.83 (10.2%) stddev-sans-first:13.21 08:34:37 INFO - PROCESS | 14996 | Values: 139.0 124.0 121.0 124.0 123.0 123.0 127.0 124.0 163.0 134.0 08:34:37 INFO - PROCESS | 14996 | 08:34:37 INFO - PROCESS | 14996 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.40 Median:159.00 stddev:2.22 (1.4%) stddev-sans-first:2.28 08:34:37 INFO - PROCESS | 14996 | Values: 159.0 156.0 159.0 159.0 159.0 155.0 155.0 156.0 155.0 161.0 08:34:37 INFO - PROCESS | 14996 | 08:34:37 INFO - PROCESS | 14996 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:64.00 stddev:2.27 (3.5%) stddev-sans-first:2.00 08:34:37 INFO - PROCESS | 14996 | Values: 68.0 63.0 64.0 63.0 64.0 69.0 64.0 63.0 64.0 62.0 08:34:37 INFO - PROCESS | 14996 | -------- Summary: end -------- 08:34:37 INFO - PROCESS | 14996 | 08:34:38 INFO - TEST-INFO | 14996: exit 0 08:34:38 INFO - TEST-OK | kraken | took 59332ms 08:34:38 INFO - SUITE-END | took 1174s 08:34:38 INFO - Completed test suite (00:19:34) 08:34:38 INFO - javascript benchmark 08:34:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3208.695173958474, 3255.3326568053567, 3273.5908011498564, 3283.981965590667, 3284.981655686737, 5580.91628625571, 5619.353774315955, 5621.0, 5623.634463759863, 5640.520555752761, 5682.147677848325, 5731.283589551306, 5744.626599271044, 5750.683712395817, 5785.595008349417, 5153.871153221171, 5179.533841954223, 5181.9740901295445, 5210.9218361724415, 5265.183896496049, 5017.724025178613, 5050.924236136461, 5274.525292723654, 5275.446078161795, 5298.258243845865, 5062.139436295838, 5083.16127838908, 5084.44071152173, 5145.897082058375, 5147.0735267652, 5141.588672906178, 5196.714180720059, 5199.428062913076, 5204.739763011834, 5240.895182096375, 5006.649534532584, 5046.62150338726, 5122.9754049190315, 5147.150720131174, 5176.50823171798, 5492.5605951524185, 5510.972445137789, 5529.751161197756, 5537.36320323164, 5606.747696353633, 5947.10793380992, 6000.429959153874, 6054.152418661391, 6066.969665151646, 6074.271087469488, 5946.197263369433, 6028.668423236721, 6029.366916473795, 6073.1497590337385, 6109.14471973924, 5574.86062848432, 5600.0, 5638.943610563924, 5646.71766411686, 5652.63257888236, 6111.633302001894, 6124.142620033199, 6133.570650054453, 6140.232470941132, 6146.323904370515, 5840.970795145997, 5899.882002359929, 5913.586048976616, 5922.615030023035, 5925.0, 5953.672548009901, 6011.669358185254, 6061.3029501607, 6062.939370606326, 6111.014442317695, 6068.75724971005, 6075.635461872302, 6077.696115194222, 6082.391760823883, 6103.542234332443, 6028.336882942873, 6084.574079814459, 6086.482648974798, 6090.878182436327, 6109.877802443926, 4545.113702827983, 4578.244589642672, 4578.633709303248, 4595.586397224199, 4634.83778067766, 4119.670426365884, 4149.647279981175, 4152.667786577066, 4172.99848036469, 4204.285271503852, 5706.400827913092, 5710.543156547466, 5762.423757624288, 5764.625299355528, 5795.33353664334, 5915.319738230072, 5971.970140149271, 5974.074018527135, 5987.670678112659, 6011.458968692751, 5718.142278658152, 5725.055365864669, 5746.02317606008, 5763.538916886639, 5780.335261444988, 5163.044836705221, 5230.110881150214, 5234.26720259164, 5236.842894713165, 5254.553362964114, 6092.482139018144, 6190.969045154746, 6202.22298682064, 6209.316975132822, 6251.593646412968, 6042.456178943916, 6130.0, 6165.815025549241, 6171.9691401542705, 6178.320384757763, 6341.55609107358, 6344.143540621957, 6354.364563543609, 6362.395572420613, 6373.2989371168205, 5820.796272130625, 5881.441263080001, 5916.112583112567, 6034.879302414015, 6043.063325184604, 6044.969775151096, 6115.848865095124, 6119.350229749554, 6132.600268413531, 6140.078988151813, 5906.557008224315, 5914.645121292736, 5979.252593425822, 5980.730867110903, 5994.0, 5883.411658834082, 5977.462028417463, 5978.910316345171, 5979.103134529855, 5980.192673988956, 5821.592488525763, 5868.149118377726, 5875.50058245054, 5904.084866845646, 5919.0, 6008.459238668541, 6045.848853778515, 6050.062240352577, 6050.394960503914, 6052.364501727256, 5689.2319536862, 5734.569907256889, 5744.281964754406, 5890.440408161217, 5895.20414744004], "value": 5582.131198120605, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.5140233606107, 626.8182227154125, 646.2148489585153, 659.3966520633624, 675.9087523184369, 35530.111747206334, 47038.23694104472, 47984.52015479844, 47992.52007479924, 48139.27791083136, 46843.82890427741, 47404.288935665994, 47436.525634743644, 47498.76250618751, 47912.2813157802, 8245.464044837096, 8780.42927209731, 8920.598573064228, 8922.687705930293, 8931.64273429062, 8231.670733170666, 10566.20753443491, 10794.946025269903, 10819.0, 11076.836932122133, 10901.945490272537, 10973.725656858562, 10975.121990240761, 10978.615748448807, 10986.780264394707, 10751.301165424222, 10783.975522325367, 10803.13574914005, 10821.729456763565, 10828.837567436494, 10655.147588193004, 10697.46512674371, 10737.83893241602, 10750.731231719192, 10755.569777208902, 45382.773086134686, 45647.0, 45726.771366143286, 45792.0, 45796.54203457989, 3792.3742582474133, 3833.4249862520564, 3940.4483372327895, 3941.7043721720984, 4244.427002354704, 32203.677963220536, 34043.82978085094, 34314.6568534314, 34358.312833743184, 36054.459183112274, 4505.977470112662, 4508.61676757476, 4562.726236425825, 4600.5629465200755, 4674.649401294916, 399775.0, 404579.0, 406579.0, 407385.0, 413197.0, 38592.42111368332, 62912.68543657344, 63773.0, 63822.361776381644, 63865.0, 40313.79843100766, 42853.35719964203, 42853.571464284956, 42865.57134428678, 42869.35695964563, 17195.570110747332, 17308.65382692339, 17320.0, 17523.82476175222, 17603.471895843144, 13587.252701101534, 13703.794443083361, 14049.438022479191, 14440.133591984304, 14546.199959002144, 9630.181434577999, 9656.71029869105, 9836.754081147885, 9839.458829764431, 9859.802803943881, 3597.2805438912324, 3619.149499867529, 3665.560132784083, 3669.247804200186, 3683.797391143459, 1033.5452400943561, 1063.6330465989377, 1069.2942657845786, 1110.8056090184186, 1154.9538018479334, 34816.0, 34873.0, 35137.0, 35416.822915885255, 35430.468542971874, 1006.6879267427121, 1127.4813585750646, 1142.1890457774907, 1144.1761931409371, 1158.9942050289694, 16446.67106657884, 18062.36781712634, 18472.261109555737, 18864.81135188658, 18904.0, 552204.0, 557929.0, 558681.0, 560604.0, 560864.0, 63315.0, 63810.36189638137, 63819.680901595195, 63828.0, 64059.67970160119, 1321.9471221151045, 1360.7890776929394, 1364.433759989613, 1415.773476243796, 1439.7264519741216, 30816.229594260323, 35584.288314233054, 35705.0, 35875.28249434944, 35942.8202858984, 54244.45755542394, 55069.0, 55102.72448637731, 55114.448855510935, 55252.447475526336, 426456.0, 427445.0, 428827.0, 428981.0, 429310.0, 27213.183604491896, 27536.311592210353, 28935.421291574472, 28947.56578651364, 31714.84142579272, 48071.5192848067, 50227.24659130043, 50383.73863964421, 50538.24192637187, 51488.742556286976, 41520.58479415288, 42428.787856060524, 43102.0, 43259.0, 43917.560824391345, 42717.0, 43078.138437231704, 43174.78412608043, 44333.556664432945, 44628.77685611551, 43156.56843431525, 43209.35185972276, 43859.12281754411, 44326.0, 44403.55596443994, 35821.10447238736, 38089.809550952064, 38831.0, 39075.21849562936, 39767.40348894711, 29346.706532934397, 29506.55740163942, 29793.25516862096, 29987.250318742204, 30051.0], "value": 20488.949547524164, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.22239876858896, 415.53460124660364, 424.27025516112286, 432.50694208602187, 440.77520464563065, 15038.47365342212, 19207.519812004706, 20449.38651840445, 21115.683264751042, 21288.148474061018, 19243.326483573077, 20653.173873045096, 20719.378418647426, 20756.8962155189, 20934.89532552335, 5625.128105143699, 5826.854328641775, 5835.737391817357, 5846.3861294563885, 5850.385709500505, 5736.713164341787, 5964.403559644023, 6006.099085137221, 6019.367966363535, 6036.607620504653, 5874.73563689635, 6021.668808215546, 6026.578139530235, 6027.427394397547, 6033.155358249848, 6006.639601623895, 6110.450059494622, 6113.296970848321, 6125.203723515937, 6125.601835880676, 5873.2952045754355, 5900.704964751745, 5937.050071988461, 6019.849503762441, 6030.909536356959, 23281.883590582107, 23495.0, 23644.172453964202, 23924.7607523926, 23985.76014239853, 2378.6669866218745, 2400.6519054736964, 2445.461998360358, 2534.6071358939394, 2540.415704388001, 10783.070579190673, 11890.692023877367, 12868.29224392658, 14984.475543356039, 15779.842201577952, 1906.4566598519493, 1934.555052337956, 1959.588486417854, 2009.166196028661, 2088.446561661161, 81999.5900020496, 84985.57507212486, 85922.57038714828, 87215.56392217998, 87803.0, 10653.147748180127, 11327.093832493381, 11604.0, 11807.23252988553, 11987.340696261615, 15298.388064477296, 15580.143092129814, 16346.264418101215, 16413.1793410329, 17021.148942552823, 8497.61760720769, 8641.611127499278, 8667.219950204511, 8707.912920870836, 8853.29173666105, 8326.625301861432, 8456.788580285542, 8530.445521041236, 8614.6984855531, 8759.16787905148, 4981.476944920803, 5027.346444962204, 5122.3096378195105, 5124.30821839047, 5215.47845215483, 2084.7289852319404, 2117.5764847030655, 2138.3478039198194, 2146.0664610894, 2173.8586991845477, 901.7745563609097, 1010.4745532323151, 1019.7756493571402, 1054.7890421915647, 1057.613970900631, 20316.49208769763, 20436.284730034677, 20712.792872071088, 20723.378298651063, 20819.271325503534, 1038.6364772329623, 1051.2851261142343, 1069.2835800014009, 1074.3607553505651, 1106.5794997900907, 9890.240874099825, 11278.887211127783, 11319.547218111184, 11392.658220253406, 11454.828177577343, 479150.0, 483759.0, 489831.0, 490092.0, 503276.0, 91558.54220728854, 92219.53890230505, 92486.0, 93272.0, 93581.0, 1046.1473898772476, 1089.6022951622758, 1116.268843907242, 1119.6864877834219, 1121.5233525751523, 17453.912730436776, 17903.37338193157, 17914.91042544831, 17940.0, 18238.361657341928, 42447.3632895513, 43214.13571728485, 43271.35092973545, 43497.34753978629, 43580.56419435765, 57738.0, 59230.40769592249, 60174.0, 61263.69368153131, 61657.0, 8545.658173672984, 8667.783305417415, 8722.302215822592, 9002.50486223264, 9097.40866843653, 11558.537658493566, 12392.938035309766, 12749.490020399451, 12981.935090324489, 13467.528636497676, 8485.490870547786, 9340.739000234882, 10828.656976859522, 11438.771224575295, 12249.632511024683, 11145.83281250798, 11471.451354067094, 11609.30344179352, 11736.295822250693, 11748.412579371168, 6902.758403455855, 10934.234603577674, 11544.0, 11741.354225517678, 12639.1784534005, 7639.961800190964, 7831.804204894923, 8690.478571285743, 8764.079771623889, 8892.73321800347, 10995.560177592806, 11390.886091139315, 11390.943045285052, 11435.942820285845, 11654.18420710576], "value": 9552.501598227409, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1375.147408606664, 1509.6075020494668, 1527.4501179575354, 1666.1003058348492, 1842.8341449269562, 7961.4825036372595, 8712.390132690707, 8874.645014199441, 8917.509536975464, 9255.722328330145, 9076.727698169048, 9137.360384773068, 9138.360314777969, 9139.131782480654, 9145.908540914588, 2517.25740906433, 2550.1584477122506, 2550.1966880432697, 2551.2091251712027, 2555.080171138389, 2478.330850670318, 2547.1339744486872, 2550.5154020736095, 2552.387427017521, 2556.335352808274, 2480.516299321633, 2492.19003823758, 2515.1825656661567, 2522.735112813156, 2524.192258477288, 2415.6014257647466, 2433.841800282985, 2467.988124868813, 2468.518638865422, 2481.8262721609403, 2467.962980555293, 2488.8755562222, 2495.7379475155212, 2510.184190138194, 2511.6232565115197, 9018.188363047291, 9064.637414503411, 9080.818383632357, 9083.772905677344, 9084.682036128705, 5419.810306639288, 5568.972155139199, 5571.832845014656, 5633.464820842013, 5637.210790489335, 3465.9102259333977, 3510.6840384365273, 3572.3034008368118, 3586.5696116466193, 3663.139162296858, 1153.6366044695894, 1192.0463629096687, 1195.844540209776, 1236.7217376090398, 1244.6390546741434, 12052.939735301268, 12079.879201207963, 12137.757244855053, 12148.817767733492, 12161.391930403444, 4771.093492236464, 4812.25410061441, 4830.154722923475, 4900.313956046157, 4924.507549245119, 10015.0, 10030.297879148535, 10045.397276163454, 10050.09549140581, 10059.245556583139, 5506.944930550723, 5510.641808282448, 5517.806876759294, 5518.034343989786, 5536.307961504812, 4339.132173565299, 4675.0, 4733.502982186889, 4740.644451666139, 5092.0579692756955, 4029.5164580250557, 4072.9592704073175, 4175.394567787654, 4177.310743727251, 4184.28867092595, 1272.2684456437585, 1279.2004996876951, 1282.6472720002075, 1283.2492991599831, 1294.9287789171497, 865.2385900407601, 906.6237511432813, 962.5620342744035, 989.0104423185048, 990.5889056041661, 5749.942500574941, 5988.4909782668965, 6032.185654936615, 6062.666553339521, 6101.755929762849, 486.04249628232327, 486.87584665909964, 500.15473849194746, 503.85121922017856, 511.9641625086208, 4003.939940900889, 4016.5180178378196, 4023.1350259693722, 4031.4557534732435, 4079.938800917989, 10894.67315980522, 11298.943505282585, 11352.545898164146, 11362.147838912115, 11418.657440276806, 11213.383263920563, 11218.102551795837, 11220.831687524693, 11224.214304998572, 11247.268927519848, 8028.197180282042, 8211.096779354266, 8293.502389856629, 8306.210909963544, 8570.700025498953, 5918.496927761188, 5918.674472904032, 6005.129256257906, 6058.787942421994, 6102.206713127265, 10412.0, 10432.374057556572, 10434.634787782392, 10441.738956525844, 10473.423961682181, 9318.207952324128, 9441.763955901157, 9998.600055997678, 10194.643187488402, 10330.948345258226, 7444.0, 7585.127710313164, 7593.8860917087395, 7749.418793590616, 7947.165547617648, 8707.390482666153, 8923.41997770143, 8974.967878693773, 8988.056254093226, 9004.144606262395, 7876.8818467721885, 8006.079300880473, 8029.638666259915, 8096.433249672466, 8114.83770324602, 7690.461667683208, 7722.0, 7823.647935843014, 7923.366130709414, 8016.438849280495, 6956.2695916928, 7042.718291268497, 7104.11198600175, 7113.0, 7119.572825630479, 4904.166291730343, 5091.643584949018, 5336.359636843604, 5345.919811202757, 5540.085885828793, 5244.711540865289, 5275.498827611371, 5299.417064122867, 5334.119870221525, 5433.320834895638], "value": 4682.431075162121, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.9591796943351, 358.3352880406845, 366.19071851208827, 369.54545908532486, 370.5775416025729, 5326.786928522864, 5355.946440535594, 5379.488948549892, 5386.730663466826, 5395.487428694268, 4973.900521989558, 5104.846854594359, 5107.821226257081, 5179.352580927384, 5269.604779641523, 4159.313713237312, 4182.16356728654, 4187.476565429321, 4190.350495673176, 4197.181549597822, 4196.139791342783, 4201.978990105061, 4206.726562773425, 4209.179210054025, 4212.726172798773, 3941.901452463697, 3971.649639122698, 4051.0, 4176.874693759177, 4190.120074784299, 4153.6677065834665, 4164.708470407073, 4172.457580514544, 4188.612490880184, 4189.9790501047455, 3748.5689145748315, 3755.399136138205, 3758.248350329945, 3759.812009399519, 3761.4357846322996, 4984.0, 5108.208227724708, 5125.666831655968, 5146.382434107931, 5157.922631160535, 4757.714537127784, 4766.142094423002, 4780.8525953771195, 4782.258749893737, 4783.904321913577, 5465.371482279549, 5475.561955043587, 5485.369182544018, 5505.3393592768725, 5523.28197334344, 4024.315866302706, 4088.713790034699, 4095.8941085906936, 4121.196366708493, 4146.253674338618, 5660.3490598581275, 5662.348829884533, 5674.602777805555, 5693.28833895763, 5711.543076553866, 4199.727017743837, 4205.747655140702, 4205.990562265096, 4219.915601687949, 4242.215190189825, 4119.691023173274, 4248.447701798808, 4265.55211702773, 4274.935875961863, 4276.700630955803, 4771.355866957916, 4774.474807771142, 4779.545943135397, 4785.473597904297, 4788.904221915543, 5482.479164479368, 5517.2551705520045, 5522.3649280333275, 5522.779088836482, 5532.778688852401, 1344.731053789246, 1407.676234466058, 1436.906601070927, 1443.985560144406, 1455.7525220712505, 956.808773077509, 980.5342462330478, 984.2765567308023, 994.8209322321907, 997.581015973293, 5190.455002224788, 5209.0, 5221.511869117283, 5232.92150617741, 5242.213667949838, 5471.261379713767, 5481.616286859961, 5492.780288788484, 5504.889902201933, 5525.64621667694, 4980.526849949249, 5207.29701490294, 5209.629618523562, 5215.973920130375, 5234.607404444682, 2851.8574071296352, 2871.7271859173347, 2881.3084859633536, 2922.371690086599, 2935.6477222732983, 5579.860503487364, 5583.972080139654, 5600.631507424216, 5601.467860553241, 5606.775728970877, 5232.790688372423, 5439.4288599696465, 5501.174823776386, 5509.862253443615, 5534.806281780118, 5597.69735855847, 5613.438656134354, 5614.494695477427, 5618.578606604603, 5621.971890140523, 5307.416184219655, 5470.0, 5478.904219156105, 5501.807436739695, 5507.155103040526, 5349.0, 5364.524755692216, 5379.757910893941, 5405.216243644728, 5412.8646783829145, 5589.329280486368, 5589.546717853306, 5618.52242559387, 5620.606557541097, 5634.647384806198, 3891.5330160380936, 4009.0, 4031.274370613318, 4050.076213798422, 4082.2447847148374, 5356.74116582595, 5432.511074003359, 5441.727913604224, 5443.210734443563, 5464.617476776746, 5275.683458992473, 5320.52115309624, 5342.9465705344, 5356.1697936819855, 5362.463753624763, 5081.8729531762, 5280.864614107985, 5317.361916570037, 5331.853651464954, 5342.439043900335, 5292.9470705294, 5300.840974770763, 5304.0, 5304.681719096867, 5310.0, 5341.62608617393, 5355.839324820262, 5380.192971054373, 5402.837914862561, 5411.6482428643585, 5198.116320225495, 5249.47505249472, 5461.34463864323, 5504.926539324793, 5511.311086114236], "value": 4194.598161610645, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [763.5991104670047, 791.6754130806366, 801.6112185589991, 803.5700900018489, 887.299033763327, 14878.47925322614, 16084.115373654458, 16448.34206631735, 17088.231029603667, 17312.394066207686, 15621.375144994216, 15627.843721562782, 15899.364025438997, 15907.0, 16055.83944160558, 858.5964596639569, 881.9647214111428, 882.07382248639, 882.5895958379352, 882.7175303902753, 716.1907045039098, 744.5235049568281, 839.064443145891, 873.7160422862563, 879.9164079412445, 922.6540047482194, 923.3075193604797, 923.5197697197453, 924.6624981881632, 925.0333401595349, 917.1653795046476, 917.5733284022962, 917.8164367126568, 918.453520155513, 918.7427520294295, 554.5618961020789, 580.0892598620168, 649.6232185332495, 662.8044726805604, 664.6112024465693, 15428.768568471482, 15443.768343474856, 15453.0, 15458.0, 15462.690746185013, 13754.587362379045, 13883.791743123862, 13899.930500347535, 13918.93040534801, 14135.15189088658, 11367.545298188063, 11404.530032828428, 11492.712682182928, 11563.190576659637, 11757.706057348634, 4309.332053531708, 4348.565143485658, 4377.890552736175, 4425.15921974827, 4514.0971805639, 64937.3506264936, 64950.67524662346, 65305.3469465304, 65353.67323163354, 65371.346286537475, 10674.199435042403, 10997.230193886511, 11005.834912476319, 11232.775344493228, 11243.100551955824, 19715.50711232202, 19897.403077907686, 19953.900230498755, 20362.79637203609, 20381.898090509454, 8817.515036672916, 8832.072632373636, 8879.778005549913, 9037.819243615222, 9141.0, 4888.0, 5038.168702164176, 5061.367329083864, 5063.974680126576, 5168.198929165986, 3592.2276710507367, 3728.6271372862498, 3730.7201959852578, 3738.4579236010627, 3739.7382183247455, 672.4519516593961, 680.6630717794625, 685.3694600967123, 694.2918223412192, 697.822055375876, 742.6769355330448, 771.571777663391, 775.4828126165111, 791.1416113516899, 792.9881051784228, 9714.417134971924, 9923.156531694887, 10091.7477063074, 10198.43908585035, 10341.276110672332, 665.70043480434, 681.2608319972786, 732.3152852083319, 745.6532712288812, 776.1733753552448, 4915.0, 4934.851954441372, 4992.0, 5062.443131255559, 5116.488351164854, 70945.6452717733, 72273.2772672277, 93760.0, 97525.5123724391, 98126.0, 45325.77337113359, 59325.0, 65773.01340479897, 72950.0, 74898.0, 44249.11501769946, 56496.43503564994, 64108.35891641117, 67193.32806671968, 67676.6616166916, 10019.899801001897, 10248.743781405525, 10344.689659310232, 10357.9482102589, 10508.94745526298, 32641.510377344835, 33365.666343336256, 43945.78027109844, 45013.32480012868, 45503.54496454993, 55602.721986389806, 56293.71853140872, 56553.0, 63169.68415157895, 63536.046959296575, 12680.175788573713, 12727.745445091232, 12735.745285094432, 12843.165194262343, 13015.47938082504, 14182.432702691776, 14287.785683214968, 14397.784033239719, 14906.180160090866, 14937.402503899722, 11180.88819111831, 12742.42659080325, 13293.66765830862, 13464.394102265618, 14360.928195358956, 13538.59384218475, 13750.587482375544, 14068.507602233873, 14451.92774036123, 14831.11013339203, 12451.315177665316, 12945.158564693265, 13116.409761560562, 13236.933815330862, 13667.248301343521, 10054.34646747959, 10299.485025748832, 10670.35977841332, 11045.447727613426, 11393.259438136494, 10903.236773425784, 11367.804177962205, 11624.302541847177, 11683.766324673628, 11927.582534611247], "value": 7379.906475350795, "unit": "score"}], "name": "dromaeo_css", "value": 7355.560950213846, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 111.0, 109.0, 112.0, 112.0, 110.0, 110.0, 111.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 122.0, 120.0, 153.0, 125.0, 118.0, 118.0, 118.0, 150.0, 120.0], "value": 129.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 162.0, 162.0, 162.0, 161.0, 161.0, 162.0, 161.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 116.0, 78.0, 76.0, 76.0, 75.0, 103.0, 77.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 120.0, 83.0, 82.0, 82.0, 97.0, 83.0, 82.0, 114.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 119.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 157.0, 147.0, 145.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 87.0, 86.0, 85.0, 85.0, 89.0, 85.0, 85.0, 85.0], "value": 85.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 51.0, 51.0, 53.0, 51.0, 51.0, 50.0, 51.0, 50.0], "value": 51.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 61.0, 60.0, 59.0, 61.0, 60.0, 60.0, 61.0, 62.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 81.0, 83.0, 76.0, 75.0, 78.0, 81.0, 78.0, 75.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 124.0, 121.0, 124.0, 123.0, 123.0, 127.0, 124.0, 163.0, 134.0], "value": 130.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 156.0, 159.0, 159.0, 159.0, 155.0, 155.0, 156.0, 155.0, 161.0], "value": 157.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 63.0, 64.0, 63.0, 64.0, 69.0, 64.0, 63.0, 64.0, 62.0], "value": 64.4, "unit": "score"}], "name": "kraken", "value": 1465.4, "alertThreshold": 2.0}]} 08:34:38 INFO - Return code: 0 08:34:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:34:38 INFO - # TBPL SUCCESS # 08:34:38 INFO - Running post-action listener: _resource_record_post_action 08:34:38 INFO - [mozharness: 2016-12-21 16:34:38.619843Z] Finished run-tests step (success) 08:34:38 INFO - Running post-run listener: _resource_record_post_run 08:34:38 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 374374400; Read time: 8; Write time: 209548 08:34:38 INFO - TinderboxPrint: CPU usage
13.0% 08:34:38 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 08:34:38 INFO - TinderboxPrint: I/O write bytes / time
374,374,400 / 209,548 08:34:38 INFO - TinderboxPrint: CPU idle
8,264.0 (87.0%) 08:34:38 INFO - TinderboxPrint: CPU user
1,195.8 (12.6%) 08:34:38 INFO - TinderboxPrint: Swap in / out
0 / 0 08:34:38 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108195840; Read time: 0; Write time: 76932 08:34:38 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 249241600; Read time: 0; Write time: 127632 08:34:39 INFO - Running post-run listener: _upload_blobber_files 08:34:39 INFO - Blob upload gear active. 08:34:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:34:39 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 08:34:39 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:34:39 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:34:39 INFO - (blobuploader) - INFO - Open directory for files ... 08:34:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:34:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:34:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:42 INFO - (blobuploader) - INFO - Done attempting. 08:34:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:34:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:34:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:43 INFO - (blobuploader) - INFO - Done attempting. 08:34:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:34:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:34:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:34:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:34:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:34:44 INFO - (blobuploader) - INFO - Done attempting. 08:34:44 INFO - (blobuploader) - INFO - Iteration through files over. 08:34:44 INFO - Return code: 0 08:34:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:34:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:34:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/797ba7541759af8887c8cc18c813489a0ba67c75cfafdc0c2d101138c64923c895711bb1dc35a1f7a1faffae8ba143af558bf12f83afbe02117707d624d689cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0dd91442f833df82521cc7a7c90ae7a9203e0396464455765ae702bb09eba36b50c78351522e1e61dc505610461b2bab63e343489b64f93fd1edc7b0182a7b0f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e87b66729918879f6ecdeb16258bb0e4953003e10c0909969a1c1c46ec3d9b5f1e4cdfb343104d0980632916e06f7171f23b08aca865c14ed6b33667946be03d"} 08:34:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:34:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:34:44 INFO - Contents: 08:34:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/797ba7541759af8887c8cc18c813489a0ba67c75cfafdc0c2d101138c64923c895711bb1dc35a1f7a1faffae8ba143af558bf12f83afbe02117707d624d689cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0dd91442f833df82521cc7a7c90ae7a9203e0396464455765ae702bb09eba36b50c78351522e1e61dc505610461b2bab63e343489b64f93fd1edc7b0182a7b0f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e87b66729918879f6ecdeb16258bb0e4953003e10c0909969a1c1c46ec3d9b5f1e4cdfb343104d0980632916e06f7171f23b08aca865c14ed6b33667946be03d"} 08:34:44 INFO - Running post-run listener: copy_logs_to_upload_dir 08:34:44 INFO - Copying logs to upload dir... 08:34:44 INFO - mkdir: /builds/slave/test/build/upload/logs 08:34:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.118981 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-12-21 08:34:44.036285) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-12-21 08:34:44.040466) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1482335246.123441-1478155344 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/797ba7541759af8887c8cc18c813489a0ba67c75cfafdc0c2d101138c64923c895711bb1dc35a1f7a1faffae8ba143af558bf12f83afbe02117707d624d689cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0dd91442f833df82521cc7a7c90ae7a9203e0396464455765ae702bb09eba36b50c78351522e1e61dc505610461b2bab63e343489b64f93fd1edc7b0182a7b0f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e87b66729918879f6ecdeb16258bb0e4953003e10c0909969a1c1c46ec3d9b5f1e4cdfb343104d0980632916e06f7171f23b08aca865c14ed6b33667946be03d"} build_url:https://queue.taskcluster.net/v1/task/HiaI2NBdTKaiN_XeJwN5xA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011296 build_url: 'https://queue.taskcluster.net/v1/task/HiaI2NBdTKaiN_XeJwN5xA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/797ba7541759af8887c8cc18c813489a0ba67c75cfafdc0c2d101138c64923c895711bb1dc35a1f7a1faffae8ba143af558bf12f83afbe02117707d624d689cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0dd91442f833df82521cc7a7c90ae7a9203e0396464455765ae702bb09eba36b50c78351522e1e61dc505610461b2bab63e343489b64f93fd1edc7b0182a7b0f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e87b66729918879f6ecdeb16258bb0e4953003e10c0909969a1c1c46ec3d9b5f1e4cdfb343104d0980632916e06f7171f23b08aca865c14ed6b33667946be03d"}' ========= master_lag: 1.12 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-12-21 08:34:45.168593) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 08:34:45.168970) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1482335246.123441-1478155344 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004539 ========= master_lag: 0.23 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-21 08:34:45.406469) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 08:34:45.406835) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-21 08:34:45.674999) ========= ========= Total master_lag: 1.44 =========