builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-029 starttime: 1479771475.12 results: success (0) buildid: 20161121125101 builduid: 83754cf308bc40e2b02318cc47682aa9 revision: d49013ebf0df7f07ecb12467f193583272bc4a00 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-21 15:37:55.119320) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-21 15:37:55.119785) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-21 15:37:55.120061) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-21 15:37:55.131136) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 15:37:55.131416) ========= 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=c7c495d6f76fb52e1ad9f659000001da-1479771474.681008-204534780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-21 15:37:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-11-21 15:37:55 (220 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.066008 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 15:37:55.208780) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 15:37:55.209133) ========= 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=c7c495d6f76fb52e1ad9f659000001da-1479771474.681008-204534780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016311 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 15:37:55.258249) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-21 15:37:55.258611) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d49013ebf0df7f07ecb12467f193583272bc4a00 --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 d49013ebf0df7f07ecb12467f193583272bc4a00 --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=c7c495d6f76fb52e1ad9f659000001da-1479771474.681008-204534780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-21 15:37:55,557 truncating revision to first 12 chars 2016-11-21 15:37:55,557 Setting DEBUG logging. 2016-11-21 15:37:55,557 attempt 1/10 2016-11-21 15:37:55,557 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d49013ebf0df?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-21 15:37:56,949 unpacking tar archive at: mozilla-aurora-d49013ebf0df/testing/mozharness/ program finished with exit code 0 elapsedTime=1.691653 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-21 15:37:56.963681) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-21 15:37:56.964005) ========= script_repo_revision: d49013ebf0df7f07ecb12467f193583272bc4a00 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-21 15:37:56.964407) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-21 15:37:56.964684) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-21 15:37:56.974036) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-11-21 15:37:56.974333) ========= /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=c7c495d6f76fb52e1ad9f659000001da-1479771474.681008-204534780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:37:57 INFO - MultiFileLogger online at 20161121 15:37:57 in /builds/slave/test 15:37:57 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 15:37:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:37:57 INFO - {'append_to_log': False, 15:37:57 INFO - 'base_work_dir': '/builds/slave/test', 15:37:57 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:37:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:37:57 INFO - 'branch': 'Mozilla-Aurora', 15:37:57 INFO - 'buildbot_json_path': 'buildprops.json', 15:37:57 INFO - 'config_files': ('talos/linux_config.py',), 15:37:57 INFO - 'default_actions': ('clobber', 15:37:57 INFO - 'read-buildbot-config', 15:37:57 INFO - 'download-and-extract', 15:37:57 INFO - 'populate-webroot', 15:37:57 INFO - 'create-virtualenv', 15:37:57 INFO - 'install', 15:37:57 INFO - 'run-tests'), 15:37:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:37:57 INFO - 'download_minidump_stackwalk': True, 15:37:57 INFO - 'download_symbols': 'ondemand', 15:37:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:37:57 INFO - 'tooltool.py': '/tools/tooltool.py', 15:37:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:37:57 INFO - '/tools/misc-python/virtualenv.py')}, 15:37:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:37:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:37:57 INFO - 'installer_path': 'installer.exe', 15:37:57 INFO - 'log_level': 'info', 15:37:57 INFO - 'log_name': 'talos', 15:37:57 INFO - 'log_to_console': True, 15:37:57 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:37:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:37:57 INFO - 'opt_config_files': (), 15:37:57 INFO - 'pip_index': False, 15:37:57 INFO - 'sps_profile': False, 15:37:57 INFO - 'sps_profile_interval': 0, 15:37:57 INFO - 'suite': 'dromaeojs', 15:37:57 INFO - 'system_bits': '32', 15:37:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:37:57 INFO - 'title': 'talos-linux64-ix-029', 15:37:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:37:57 INFO - 'use_talos_json': True, 15:37:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:37:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:37:57 INFO - 'work_dir': 'build'} 15:37:57 INFO - [mozharness: 2016-11-21 23:37:57.371881Z] Running clobber step. 15:37:57 INFO - Running pre-action listener: _resource_record_pre_action 15:37:57 INFO - Running main action method: clobber 15:37:57 INFO - rmtree: /builds/slave/test/build 15:37:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:37:57 INFO - Running post-action listener: _resource_record_post_action 15:37:57 INFO - [mozharness: 2016-11-21 23:37:57.849820Z] Finished clobber step (success) 15:37:57 INFO - [mozharness: 2016-11-21 23:37:57.849919Z] Running read-buildbot-config step. 15:37:57 INFO - Running pre-action listener: _resource_record_pre_action 15:37:57 INFO - Running main action method: read_buildbot_config 15:37:57 INFO - Using buildbot properties: 15:37:57 INFO - { 15:37:57 INFO - "project": "", 15:37:57 INFO - "product": "firefox", 15:37:57 INFO - "script_repo_revision": "production", 15:37:57 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 15:37:57 INFO - "repository": "", 15:37:57 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 15:37:57 INFO - "buildid": "20161121125101", 15:37:57 INFO - "pgo_build": "True", 15:37:57 INFO - "basedir": "/builds/slave/test", 15:37:57 INFO - "buildnumber": 631, 15:37:57 INFO - "slavename": "talos-linux64-ix-029", 15:37:57 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:37:57 INFO - "platform": "ubuntu64_hw", 15:37:57 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 15:37:57 INFO - "branch": "mozilla-aurora", 15:37:57 INFO - "repo_path": "releases/mozilla-aurora", 15:37:57 INFO - "revision": "d49013ebf0df7f07ecb12467f193583272bc4a00", 15:37:57 INFO - "stage_platform": "linux64-pgo", 15:37:57 INFO - "builduid": "83754cf308bc40e2b02318cc47682aa9", 15:37:57 INFO - "slavebuilddir": "test" 15:37:57 INFO - } 15:37:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/YhGiLdw7Q-mAX_AQrT5mzw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 15:37:57 INFO - Running post-action listener: _resource_record_post_action 15:37:57 INFO - [mozharness: 2016-11-21 23:37:57.852339Z] Finished read-buildbot-config step (success) 15:37:57 INFO - [mozharness: 2016-11-21 23:37:57.852426Z] Running download-and-extract step. 15:37:57 INFO - Running pre-action listener: _resource_record_pre_action 15:37:57 INFO - Running main action method: download_and_extract 15:37:57 INFO - mkdir: /builds/slave/test/build/tests 15:37:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:37:57 INFO - trying https://queue.taskcluster.net/v1/task/YhGiLdw7Q-mAX_AQrT5mzw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 15:37:57 INFO - Downloading https://queue.taskcluster.net/v1/task/YhGiLdw7Q-mAX_AQrT5mzw/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 15:37:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YhGiLdw7Q-mAX_AQrT5mzw/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 15:37:58 INFO - Downloaded 1361 bytes. 15:37:58 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 15:37:58 INFO - Using the following test package requirements: 15:37:58 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 15:37:58 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:37:58 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 15:37:58 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:37:58 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 15:37:58 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:37:58 INFO - u'jsshell-linux-x86_64.zip'], 15:37:58 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:37:58 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 15:37:58 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 15:37:58 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:37:58 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 15:37:58 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:37:58 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 15:37:58 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:37:58 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 15:37:58 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 15:37:58 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 15:37:58 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:37:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YhGiLdw7Q-mAX_AQrT5mzw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 15:37:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YhGiLdw7Q-mAX_AQrT5mzw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:37:58 INFO - Fetch https://queue.taskcluster.net/v1/task/YhGiLdw7Q-mAX_AQrT5mzw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 15:37:58 INFO - Http code: 200 15:37:58 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 15:37:58 INFO - x-amz-cf-id: vZgtM4KcyK6CiXOc8cOXbkh_4_zu71nqzO96lhjQnBeE9Jh1CfQ1Ig== 15:37:58 INFO - x-amz-version-id: Pd7xBpT23foP8JV2xyZC32.uEe0fw3Rz 15:37:59 INFO - Expected file size: 21949256 15:37:59 INFO - Obtained file size: 21949256 15:38:03 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 15:38:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YhGiLdw7Q-mAX_AQrT5mzw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 15:38:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YhGiLdw7Q-mAX_AQrT5mzw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:38:03 INFO - Fetch https://queue.taskcluster.net/v1/task/YhGiLdw7Q-mAX_AQrT5mzw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 15:38:03 INFO - Http code: 200 15:38:03 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 15:38:03 INFO - x-amz-cf-id: eA8r4LNkeAyosIOm7IRnIRv3snvOqMVLkR6BqvLRrUJPWHBlWLOxvA== 15:38:03 INFO - x-amz-version-id: Pd7xBpT23foP8JV2xyZC32.uEe0fw3Rz 15:38:04 INFO - Expected file size: 21949256 15:38:04 INFO - Obtained file size: 21949256 15:38:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YhGiLdw7Q-mAX_AQrT5mzw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 15:38:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YhGiLdw7Q-mAX_AQrT5mzw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:38:08 INFO - Fetch https://queue.taskcluster.net/v1/task/YhGiLdw7Q-mAX_AQrT5mzw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 15:38:09 INFO - Http code: 200 15:38:09 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 15:38:09 INFO - x-amz-cf-id: ZYichwaAHVafwwVBn5ujohizaKrC4Cq2cOp9MMGpNhp7agO-EaqZwQ== 15:38:09 INFO - x-amz-version-id: wC_W1Fjuy1tRAXNF9kG20O3KVSgACR_2 15:38:09 INFO - Expected file size: 14409038 15:38:09 INFO - Obtained file size: 14409038 15:38: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')]} 15:38:09 INFO - trying https://queue.taskcluster.net/v1/task/YhGiLdw7Q-mAX_AQrT5mzw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 15:38:09 INFO - Downloading https://queue.taskcluster.net/v1/task/YhGiLdw7Q-mAX_AQrT5mzw/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 15:38:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YhGiLdw7Q-mAX_AQrT5mzw/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 15:38:10 INFO - Downloaded 63961553 bytes. 15:38:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YhGiLdw7Q-mAX_AQrT5mzw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 15:38:10 INFO - mkdir: /builds/slave/test/properties 15:38:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:38:10 INFO - Writing to file /builds/slave/test/properties/build_url 15:38:10 INFO - Contents: 15:38:10 INFO - build_url:https://queue.taskcluster.net/v1/task/YhGiLdw7Q-mAX_AQrT5mzw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 15:38:11 INFO - Running post-action listener: _resource_record_post_action 15:38:11 INFO - Running post-action listener: set_extra_try_arguments 15:38:11 INFO - [mozharness: 2016-11-21 23:38:11.172504Z] Finished download-and-extract step (success) 15:38:11 INFO - [mozharness: 2016-11-21 23:38:11.172727Z] Running populate-webroot step. 15:38:11 INFO - Running pre-action listener: _resource_record_pre_action 15:38:11 INFO - Running main action method: populate_webroot 15:38:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:38:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:38:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:38:11 INFO - '--tppagecycles', 15:38:11 INFO - '7'], 15:38:11 INFO - 'tests': ['tsvgm']}}, 15:38:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:38:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:38:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:38:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:38:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:38:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:38:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:38:11 INFO - 'talos_options': ['--disable-e10s'], 15:38:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:38:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:38:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:38:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:38:11 INFO - 'talos_options': ['--disable-e10s'], 15:38:11 INFO - 'tests': ['damp', 'tps']}, 15:38:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:38:11 INFO - 'tests': ['damp', 'tps']}, 15:38:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:38:11 INFO - 'tests': ['dromaeo_dom']}, 15:38:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:38:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:38:11 INFO - 'tests': ['basic_compositor_video']}, 15:38:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:38:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:38:11 INFO - 'tests': ['a11yr', 15:38:11 INFO - 'ts_paint', 15:38:11 INFO - 'tpaint', 15:38:11 INFO - 'sessionrestore', 15:38:11 INFO - 'sessionrestore_no_auto_restore', 15:38:11 INFO - 'tabpaint']}, 15:38:11 INFO - 'other-e10s': {'tests': ['a11yr', 15:38:11 INFO - 'ts_paint', 15:38:11 INFO - 'tpaint', 15:38:11 INFO - 'sessionrestore', 15:38:11 INFO - 'sessionrestore_no_auto_restore', 15:38:11 INFO - 'tabpaint']}, 15:38:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:38:11 INFO - 'ts_paint', 15:38:11 INFO - 'tpaint', 15:38:11 INFO - 'sessionrestore', 15:38:11 INFO - 'sessionrestore_no_auto_restore', 15:38:11 INFO - 'tabpaint']}, 15:38:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:38:11 INFO - 'ts_paint', 15:38:11 INFO - 'tpaint', 15:38:11 INFO - 'sessionrestore', 15:38:11 INFO - 'sessionrestore_no_auto_restore', 15:38:11 INFO - 'tabpaint']}, 15:38:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:38:11 INFO - 'tests': ['a11yr', 15:38:11 INFO - 'ts_paint', 15:38:11 INFO - 'tpaint', 15:38:11 INFO - 'sessionrestore', 15:38:11 INFO - 'sessionrestore_no_auto_restore', 15:38:11 INFO - 'tabpaint']}, 15:38:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:38:11 INFO - 'tests': ['a11yr', 15:38:11 INFO - 'ts_paint', 15:38:11 INFO - 'tpaint', 15:38:11 INFO - 'sessionrestore', 15:38:11 INFO - 'sessionrestore_no_auto_restore', 15:38:11 INFO - 'tabpaint']}, 15:38:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:38:11 INFO - 'tests': ['tsvgx', 15:38:11 INFO - 'tsvgr_opacity', 15:38:11 INFO - 'tart', 15:38:11 INFO - 'tscrollx', 15:38:11 INFO - 'cart']}, 15:38:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:38:11 INFO - 'tsvgr_opacity', 15:38:11 INFO - 'tart', 15:38:11 INFO - 'tscrollx', 15:38:11 INFO - 'cart']}, 15:38:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:38:11 INFO - 'talos_options': ['--disable-e10s'], 15:38:11 INFO - 'tests': ['tp5o']}, 15:38:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:38:11 INFO - 'tests': ['tp5o']}, 15:38:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:38:11 INFO - 'talos_options': ['--disable-e10s', 15:38:11 INFO - '--xperf_path', 15:38:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:38:11 INFO - 'tests': ['tp5n']}, 15:38:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:38:11 INFO - 'talos_options': ['--xperf_path', 15:38:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:38:11 INFO - 'tests': ['tp5n']}}, 15:38:11 INFO - 'talos.zip': {'path': '', 15:38:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:38:11 INFO - Running post-action listener: _resource_record_post_action 15:38:11 INFO - [mozharness: 2016-11-21 23:38:11.190723Z] Finished populate-webroot step (success) 15:38:11 INFO - [mozharness: 2016-11-21 23:38:11.190810Z] Running create-virtualenv step. 15:38:11 INFO - Running pre-action listener: _resource_record_pre_action 15:38:11 INFO - Running main action method: create_virtualenv 15:38:11 INFO - Creating virtualenv /builds/slave/test/build/venv 15:38:11 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 15:38:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:38:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:38:11 INFO - Using real prefix '/usr' 15:38:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:38:11 INFO - Installing distribute.............................................................................................................................................................................................done. 15:38:13 INFO - Installing pip.................done. 15:38:13 INFO - Return code: 0 15:38:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:38:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:38:13 INFO - Reading from file tmpfile_stdout 15:38:13 INFO - Output received: 15:38:13 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) 15:38:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:38:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81acdd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2727f60>, '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 0x2728d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27291d0>, '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': 'c7c495d6f76fb52e1ad9f659000001da-1479771474.681008-204534780', '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 15:38:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:38:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:38:13 INFO - Using env: {'DISPLAY': ':0', 15:38:13 INFO - 'HOME': '/home/cltbld', 15:38:13 INFO - 'LANG': 'en_US.UTF-8', 15:38:13 INFO - 'LANGUAGE': 'en_US:en', 15:38:13 INFO - 'LOGNAME': 'cltbld', 15:38:13 INFO - 'MAIL': '/var/mail/cltbld', 15:38:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:13 INFO - 'MOZ_NO_REMOTE': '1', 15:38:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:38:13 INFO - 'NO_EM_RESTART': '1', 15:38:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:38:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:13 INFO - 'PWD': '/builds/slave/test', 15:38:13 INFO - 'SHELL': '/bin/bash', 15:38:13 INFO - 'SHLVL': '1', 15:38:13 INFO - 'TERM': 'linux', 15:38:13 INFO - 'TMOUT': '86400', 15:38:13 INFO - 'USER': 'cltbld', 15:38:13 INFO - 'XDG_SESSION_COOKIE': 'c7c495d6f76fb52e1ad9f659000001da-1479771474.681008-204534780', 15:38:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:13 INFO - '_': '/tools/buildbot/bin/python'} 15:38:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:14 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 15:38:14 INFO - Cleaning up... 15:38:14 INFO - Return code: 0 15:38:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:38:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f81acdd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2727f60>, '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 0x2728d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27291d0>, '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': 'c7c495d6f76fb52e1ad9f659000001da-1479771474.681008-204534780', '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 15:38:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:38:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:38:14 INFO - Using env: {'DISPLAY': ':0', 15:38:14 INFO - 'HOME': '/home/cltbld', 15:38:14 INFO - 'LANG': 'en_US.UTF-8', 15:38:14 INFO - 'LANGUAGE': 'en_US:en', 15:38:14 INFO - 'LOGNAME': 'cltbld', 15:38:14 INFO - 'MAIL': '/var/mail/cltbld', 15:38:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:14 INFO - 'MOZ_NO_REMOTE': '1', 15:38:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:38:14 INFO - 'NO_EM_RESTART': '1', 15:38:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:38:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:14 INFO - 'PWD': '/builds/slave/test', 15:38:14 INFO - 'SHELL': '/bin/bash', 15:38:14 INFO - 'SHLVL': '1', 15:38:14 INFO - 'TERM': 'linux', 15:38:14 INFO - 'TMOUT': '86400', 15:38:14 INFO - 'USER': 'cltbld', 15:38:14 INFO - 'XDG_SESSION_COOKIE': 'c7c495d6f76fb52e1ad9f659000001da-1479771474.681008-204534780', 15:38:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:14 INFO - '_': '/tools/buildbot/bin/python'} 15:38:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:14 INFO - Downloading/unpacking psutil>=3.1.1 15:38:14 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 15:38:14 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 15:38:14 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 15:38:14 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 15:38:14 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 15:38:14 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 15:38:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:38:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:38:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:38:16 INFO - Installing collected packages: psutil 15:38:16 INFO - Running setup.py install for psutil 15:38:16 INFO - building 'psutil._psutil_linux' extension 15:38:16 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 15:38:16 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 15:38:16 INFO - building 'psutil._psutil_posix' extension 15:38:16 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 15:38:16 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 15:38:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:38:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:38:16 INFO - Successfully installed psutil 15:38:16 INFO - Cleaning up... 15:38:16 INFO - Return code: 0 15:38:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:38:16 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')]} 15:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:16 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')]} 15:38:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:16 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 0x7f81acdd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2727f60>, '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 0x2728d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27291d0>, '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': 'c7c495d6f76fb52e1ad9f659000001da-1479771474.681008-204534780', '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 15:38:16 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 15:38:16 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 15:38:16 INFO - Using env: {'DISPLAY': ':0', 15:38:16 INFO - 'HOME': '/home/cltbld', 15:38:16 INFO - 'LANG': 'en_US.UTF-8', 15:38:16 INFO - 'LANGUAGE': 'en_US:en', 15:38:16 INFO - 'LOGNAME': 'cltbld', 15:38:16 INFO - 'MAIL': '/var/mail/cltbld', 15:38:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:16 INFO - 'MOZ_NO_REMOTE': '1', 15:38:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:38:16 INFO - 'NO_EM_RESTART': '1', 15:38:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:38:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:16 INFO - 'PWD': '/builds/slave/test', 15:38:16 INFO - 'SHELL': '/bin/bash', 15:38:16 INFO - 'SHLVL': '1', 15:38:16 INFO - 'TERM': 'linux', 15:38:16 INFO - 'TMOUT': '86400', 15:38:16 INFO - 'USER': 'cltbld', 15:38:16 INFO - 'XDG_SESSION_COOKIE': 'c7c495d6f76fb52e1ad9f659000001da-1479771474.681008-204534780', 15:38:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:16 INFO - '_': '/tools/buildbot/bin/python'} 15:38:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:38:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:38:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:38:19 INFO - Installing collected packages: mozsystemmonitor 15:38:19 INFO - Running setup.py install for mozsystemmonitor 15:38:19 INFO - Successfully installed mozsystemmonitor 15:38:19 INFO - Cleaning up... 15:38:19 INFO - Return code: 0 15:38:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:38:19 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')]} 15:38:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:19 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')]} 15:38:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:19 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 0x7f81acdd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2727f60>, '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 0x2728d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27291d0>, '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': 'c7c495d6f76fb52e1ad9f659000001da-1479771474.681008-204534780', '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 15:38:19 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 15:38:19 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 15:38:19 INFO - Using env: {'DISPLAY': ':0', 15:38:19 INFO - 'HOME': '/home/cltbld', 15:38:19 INFO - 'LANG': 'en_US.UTF-8', 15:38:19 INFO - 'LANGUAGE': 'en_US:en', 15:38:19 INFO - 'LOGNAME': 'cltbld', 15:38:19 INFO - 'MAIL': '/var/mail/cltbld', 15:38:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:19 INFO - 'MOZ_NO_REMOTE': '1', 15:38:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:38:19 INFO - 'NO_EM_RESTART': '1', 15:38:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:38:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:19 INFO - 'PWD': '/builds/slave/test', 15:38:19 INFO - 'SHELL': '/bin/bash', 15:38:19 INFO - 'SHLVL': '1', 15:38:19 INFO - 'TERM': 'linux', 15:38:19 INFO - 'TMOUT': '86400', 15:38:19 INFO - 'USER': 'cltbld', 15:38:19 INFO - 'XDG_SESSION_COOKIE': 'c7c495d6f76fb52e1ad9f659000001da-1479771474.681008-204534780', 15:38:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:19 INFO - '_': '/tools/buildbot/bin/python'} 15:38:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:19 INFO - Downloading/unpacking jsonschema==2.5.1 15:38:19 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 15:38:19 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 15:38:19 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 15:38:19 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 15:38:19 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 15:38:19 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 15:38:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:38:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:38:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:38:21 INFO - Downloading functools32-3.2.3-2.tar.gz 15:38:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:38:21 INFO - warning: no files found matching '*.txt' 15:38:21 INFO - no previously-included directories found matching 'build' 15:38:21 INFO - no previously-included directories found matching 'dist' 15:38:21 INFO - no previously-included directories found matching '.git*' 15:38:21 INFO - Installing collected packages: jsonschema, functools32 15:38:21 INFO - Running setup.py install for functools32 15:38:21 INFO - warning: no files found matching '*.txt' 15:38:21 INFO - no previously-included directories found matching 'build' 15:38:21 INFO - no previously-included directories found matching 'dist' 15:38:21 INFO - no previously-included directories found matching '.git*' 15:38:21 INFO - Successfully installed jsonschema functools32 15:38:21 INFO - Cleaning up... 15:38:21 INFO - Return code: 0 15:38:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:38: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')]} 15:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38: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')]} 15:38:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:21 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 0x7f81acdd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2727f60>, '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 0x2728d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27291d0>, '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': 'c7c495d6f76fb52e1ad9f659000001da-1479771474.681008-204534780', '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 15:38:21 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 15:38:21 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 15:38:21 INFO - Using env: {'DISPLAY': ':0', 15:38:21 INFO - 'HOME': '/home/cltbld', 15:38:21 INFO - 'LANG': 'en_US.UTF-8', 15:38:21 INFO - 'LANGUAGE': 'en_US:en', 15:38:21 INFO - 'LOGNAME': 'cltbld', 15:38:21 INFO - 'MAIL': '/var/mail/cltbld', 15:38:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:21 INFO - 'MOZ_NO_REMOTE': '1', 15:38:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:38:21 INFO - 'NO_EM_RESTART': '1', 15:38:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:38:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:21 INFO - 'PWD': '/builds/slave/test', 15:38:21 INFO - 'SHELL': '/bin/bash', 15:38:21 INFO - 'SHLVL': '1', 15:38:21 INFO - 'TERM': 'linux', 15:38:21 INFO - 'TMOUT': '86400', 15:38:21 INFO - 'USER': 'cltbld', 15:38:21 INFO - 'XDG_SESSION_COOKIE': 'c7c495d6f76fb52e1ad9f659000001da-1479771474.681008-204534780', 15:38:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:21 INFO - '_': '/tools/buildbot/bin/python'} 15:38:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:38:22 INFO - Cleaning up... 15:38:22 INFO - Return code: 0 15:38:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:38:22 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')]} 15:38:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:22 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')]} 15:38:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:22 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 0x7f81acdd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2727f60>, '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 0x2728d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27291d0>, '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': 'c7c495d6f76fb52e1ad9f659000001da-1479771474.681008-204534780', '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 15:38:22 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 15:38:22 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 15:38:22 INFO - Using env: {'DISPLAY': ':0', 15:38:22 INFO - 'HOME': '/home/cltbld', 15:38:22 INFO - 'LANG': 'en_US.UTF-8', 15:38:22 INFO - 'LANGUAGE': 'en_US:en', 15:38:22 INFO - 'LOGNAME': 'cltbld', 15:38:22 INFO - 'MAIL': '/var/mail/cltbld', 15:38:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:22 INFO - 'MOZ_NO_REMOTE': '1', 15:38:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:38:22 INFO - 'NO_EM_RESTART': '1', 15:38:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:38:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:22 INFO - 'PWD': '/builds/slave/test', 15:38:22 INFO - 'SHELL': '/bin/bash', 15:38:22 INFO - 'SHLVL': '1', 15:38:22 INFO - 'TERM': 'linux', 15:38:22 INFO - 'TMOUT': '86400', 15:38:22 INFO - 'USER': 'cltbld', 15:38:22 INFO - 'XDG_SESSION_COOKIE': 'c7c495d6f76fb52e1ad9f659000001da-1479771474.681008-204534780', 15:38:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:22 INFO - '_': '/tools/buildbot/bin/python'} 15:38:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:22 INFO - Downloading/unpacking blobuploader==1.2.4 15:38:22 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 15:38:22 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 15:38:22 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 15:38:22 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 15:38:22 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 15:38:22 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 15:38:24 INFO - Downloading blobuploader-1.2.4.tar.gz 15:38:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:38:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:38:24 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 15:38:24 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 15:38:24 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 15:38:24 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 15:38:24 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 15:38:24 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 15:38:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:38:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:38:24 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 15:38:24 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 15:38:24 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 15:38:24 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 15:38:24 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 15:38:24 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 15:38:25 INFO - Downloading docopt-0.6.1.tar.gz 15:38:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:38:25 INFO - Installing collected packages: blobuploader, requests, docopt 15:38:25 INFO - Running setup.py install for blobuploader 15:38:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:38:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:38:25 INFO - Running setup.py install for requests 15:38:25 INFO - Running setup.py install for docopt 15:38:25 INFO - Successfully installed blobuploader requests docopt 15:38:25 INFO - Cleaning up... 15:38:25 INFO - Return code: 0 15:38:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:38:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:25 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 0x7f81acdd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2727f60>, '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 0x2728d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27291d0>, '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': 'c7c495d6f76fb52e1ad9f659000001da-1479771474.681008-204534780', '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 15:38:25 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 15:38:25 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 15:38:25 INFO - Using env: {'DISPLAY': ':0', 15:38:25 INFO - 'HOME': '/home/cltbld', 15:38:25 INFO - 'LANG': 'en_US.UTF-8', 15:38:25 INFO - 'LANGUAGE': 'en_US:en', 15:38:25 INFO - 'LOGNAME': 'cltbld', 15:38:25 INFO - 'MAIL': '/var/mail/cltbld', 15:38:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:25 INFO - 'MOZ_NO_REMOTE': '1', 15:38:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:38:25 INFO - 'NO_EM_RESTART': '1', 15:38:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:38:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:25 INFO - 'PWD': '/builds/slave/test', 15:38:25 INFO - 'SHELL': '/bin/bash', 15:38:25 INFO - 'SHLVL': '1', 15:38:25 INFO - 'TERM': 'linux', 15:38:25 INFO - 'TMOUT': '86400', 15:38:25 INFO - 'USER': 'cltbld', 15:38:25 INFO - 'XDG_SESSION_COOKIE': 'c7c495d6f76fb52e1ad9f659000001da-1479771474.681008-204534780', 15:38:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:25 INFO - '_': '/tools/buildbot/bin/python'} 15:38:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:38:26 INFO - Running setup.py (path:/tmp/pip-QiyFD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:38:26 INFO - Running setup.py (path:/tmp/pip-s1L9Kf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:38:26 INFO - Running setup.py (path:/tmp/pip-Sxq8aX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:38:26 INFO - Running setup.py (path:/tmp/pip-89OXPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:38:26 INFO - Running setup.py (path:/tmp/pip-t4DR4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:38:26 INFO - Running setup.py (path:/tmp/pip-QFlMzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:38:26 INFO - Running setup.py (path:/tmp/pip-yVHqW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:38:26 INFO - Running setup.py (path:/tmp/pip-I3N0ba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:38:26 INFO - Running setup.py (path:/tmp/pip-UR1hc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:38:26 INFO - Running setup.py (path:/tmp/pip-RiGSur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:38:26 INFO - Running setup.py (path:/tmp/pip-oqFKiQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:38:26 INFO - Running setup.py (path:/tmp/pip-2IyfYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:38:26 INFO - Running setup.py (path:/tmp/pip-8aOBpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:38:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:38:26 INFO - Running setup.py (path:/tmp/pip-ie2fOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:38:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:38:27 INFO - Running setup.py (path:/tmp/pip-pUq2Zx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:38:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:38:27 INFO - Running setup.py (path:/tmp/pip-rrq9di-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:38:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:38:27 INFO - Running setup.py (path:/tmp/pip-2Dhlud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:38:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:38:27 INFO - Running setup.py install for manifestparser 15:38:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:38:27 INFO - Running setup.py install for mozcrash 15:38:27 INFO - Running setup.py install for mozdebug 15:38:27 INFO - Running setup.py install for mozdevice 15:38:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:38:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:38:27 INFO - Running setup.py install for mozfile 15:38:27 INFO - Running setup.py install for mozhttpd 15:38:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:38:27 INFO - Running setup.py install for mozinfo 15:38:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:38:27 INFO - Running setup.py install for mozInstall 15:38:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:38:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:38:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:38:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:38:28 INFO - Running setup.py install for mozleak 15:38:28 INFO - Running setup.py install for mozlog 15:38:28 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:38:28 INFO - Running setup.py install for moznetwork 15:38:28 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:38:28 INFO - Running setup.py install for mozprocess 15:38:28 INFO - Running setup.py install for mozprofile 15:38:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:38:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:38:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:38:28 INFO - Running setup.py install for mozrunner 15:38:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:38:28 INFO - Running setup.py install for mozscreenshot 15:38:28 INFO - Running setup.py install for moztest 15:38:28 INFO - Running setup.py install for mozversion 15:38:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:38:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:38:29 INFO - Cleaning up... 15:38:29 INFO - Return code: 0 15:38:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:38: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')]} 15:38:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38: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')]} 15:38:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:29 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 0x7f81acdd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2727f60>, '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 0x2728d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27291d0>, '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': 'c7c495d6f76fb52e1ad9f659000001da-1479771474.681008-204534780', '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 15:38:29 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 15:38:29 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 15:38:29 INFO - Using env: {'DISPLAY': ':0', 15:38:29 INFO - 'HOME': '/home/cltbld', 15:38:29 INFO - 'LANG': 'en_US.UTF-8', 15:38:29 INFO - 'LANGUAGE': 'en_US:en', 15:38:29 INFO - 'LOGNAME': 'cltbld', 15:38:29 INFO - 'MAIL': '/var/mail/cltbld', 15:38:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:29 INFO - 'MOZ_NO_REMOTE': '1', 15:38:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:38:29 INFO - 'NO_EM_RESTART': '1', 15:38:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:38:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:29 INFO - 'PWD': '/builds/slave/test', 15:38:29 INFO - 'SHELL': '/bin/bash', 15:38:29 INFO - 'SHLVL': '1', 15:38:29 INFO - 'TERM': 'linux', 15:38:29 INFO - 'TMOUT': '86400', 15:38:29 INFO - 'USER': 'cltbld', 15:38:29 INFO - 'XDG_SESSION_COOKIE': 'c7c495d6f76fb52e1ad9f659000001da-1479771474.681008-204534780', 15:38:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:29 INFO - '_': '/tools/buildbot/bin/python'} 15:38:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:38:29 INFO - Running setup.py (path:/tmp/pip-1oOES6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:38:29 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)) 15:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:38:29 INFO - Running setup.py (path:/tmp/pip-V5fs8a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:38:29 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)) 15:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:38:29 INFO - Running setup.py (path:/tmp/pip-BIT5gI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:38:29 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)) 15:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:38:29 INFO - Running setup.py (path:/tmp/pip-qVO0le-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:38:29 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)) 15:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:38:29 INFO - Running setup.py (path:/tmp/pip-59bvc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:38:29 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)) 15:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:38:29 INFO - Running setup.py (path:/tmp/pip-foes0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:38:29 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)) 15:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:38:29 INFO - Running setup.py (path:/tmp/pip-FN9Q44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:38:29 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)) 15:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:38:29 INFO - Running setup.py (path:/tmp/pip-84876t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:38:29 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)) 15:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:38:29 INFO - Running setup.py (path:/tmp/pip-_BZsuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:38:29 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)) 15:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:38:29 INFO - Running setup.py (path:/tmp/pip-bG_JLa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:38:29 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)) 15:38:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:38:29 INFO - Running setup.py (path:/tmp/pip-nYSGHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:38:30 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)) 15:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:38:30 INFO - Running setup.py (path:/tmp/pip-Tnlc3h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:38:30 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)) 15:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:38:30 INFO - Running setup.py (path:/tmp/pip-wqLZSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:38:30 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)) 15:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:38:30 INFO - Running setup.py (path:/tmp/pip-U1bdsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:38:30 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)) 15:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:38:30 INFO - Running setup.py (path:/tmp/pip-vDT5zl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:38:30 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)) 15:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:38:30 INFO - Running setup.py (path:/tmp/pip-O9g7ea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:38:30 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)) 15:38:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:38:30 INFO - Running setup.py (path:/tmp/pip-cpW8uJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:38:30 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)) 15:38:30 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)) 15:38:30 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)) 15:38:30 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)) 15:38:30 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)) 15:38:30 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)) 15:38:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:38:30 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 15:38:30 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 15:38:30 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 15:38:30 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 15:38:30 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 15:38:30 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 15:38:32 INFO - Downloading blessings-1.6.tar.gz 15:38:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:38:32 INFO - Installing collected packages: blessings 15:38:32 INFO - Running setup.py install for blessings 15:38:32 INFO - Successfully installed blessings 15:38:32 INFO - Cleaning up... 15:38:32 INFO - Return code: 0 15:38:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:38:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:38:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:38:32 INFO - Reading from file tmpfile_stdout 15:38:32 INFO - Current package versions: 15:38:32 INFO - argparse == 1.2.1 15:38:32 INFO - blessings == 1.6 15:38:32 INFO - blobuploader == 1.2.4 15:38:32 INFO - docopt == 0.6.1 15:38:32 INFO - functools32 == 3.2.3-2 15:38:32 INFO - jsonschema == 2.5.1 15:38:32 INFO - manifestparser == 1.1 15:38:32 INFO - mozInstall == 1.12 15:38:32 INFO - mozcrash == 1.0 15:38:32 INFO - mozdebug == 0.1 15:38:32 INFO - mozdevice == 0.48 15:38:32 INFO - mozfile == 1.2 15:38:32 INFO - mozhttpd == 0.7 15:38:32 INFO - mozinfo == 0.9 15:38:32 INFO - mozleak == 0.1 15:38:32 INFO - mozlog == 3.4 15:38:32 INFO - moznetwork == 0.27 15:38:32 INFO - mozprocess == 0.23 15:38:32 INFO - mozprofile == 0.28 15:38:32 INFO - mozrunner == 6.13 15:38:32 INFO - mozscreenshot == 0.1 15:38:32 INFO - mozsystemmonitor == 0.3 15:38:32 INFO - moztest == 0.7 15:38:32 INFO - mozversion == 1.4 15:38:32 INFO - psutil == 3.1.1 15:38:32 INFO - requests == 1.2.3 15:38:32 INFO - wsgiref == 0.1.2 15:38:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:38: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')]} 15:38:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38: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')]} 15:38:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:32 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 0x7f81acdd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2727f60>, '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 0x2728d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27291d0>, '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': 'c7c495d6f76fb52e1ad9f659000001da-1479771474.681008-204534780', '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 15:38:32 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 15:38:32 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 15:38:32 INFO - Using env: {'DISPLAY': ':0', 15:38:32 INFO - 'HOME': '/home/cltbld', 15:38:32 INFO - 'LANG': 'en_US.UTF-8', 15:38:32 INFO - 'LANGUAGE': 'en_US:en', 15:38:32 INFO - 'LOGNAME': 'cltbld', 15:38:32 INFO - 'MAIL': '/var/mail/cltbld', 15:38:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:32 INFO - 'MOZ_NO_REMOTE': '1', 15:38:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:38:32 INFO - 'NO_EM_RESTART': '1', 15:38:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:38:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:32 INFO - 'PWD': '/builds/slave/test', 15:38:32 INFO - 'SHELL': '/bin/bash', 15:38:32 INFO - 'SHLVL': '1', 15:38:32 INFO - 'TERM': 'linux', 15:38:32 INFO - 'TMOUT': '86400', 15:38:32 INFO - 'USER': 'cltbld', 15:38:32 INFO - 'XDG_SESSION_COOKIE': 'c7c495d6f76fb52e1ad9f659000001da-1479771474.681008-204534780', 15:38:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:32 INFO - '_': '/tools/buildbot/bin/python'} 15:38:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:33 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)) 15:38:33 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)) 15:38:33 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)) 15:38:33 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)) 15:38:33 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)) 15:38:33 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)) 15:38:33 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)) 15:38:33 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)) 15:38:33 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)) 15:38:33 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)) 15:38:33 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)) 15:38:33 INFO - Cleaning up... 15:38:33 INFO - Return code: 0 15:38:33 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:38:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:38:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:38:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:38:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:38:33 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 0x7f81acdd5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x265d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x272aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2727f60>, '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 0x2728d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27291d0>, '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': 'c7c495d6f76fb52e1ad9f659000001da-1479771474.681008-204534780', '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 15:38:33 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 15:38:33 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 15:38:33 INFO - Using env: {'DISPLAY': ':0', 15:38:33 INFO - 'HOME': '/home/cltbld', 15:38:33 INFO - 'LANG': 'en_US.UTF-8', 15:38:33 INFO - 'LANGUAGE': 'en_US:en', 15:38:33 INFO - 'LOGNAME': 'cltbld', 15:38:33 INFO - 'MAIL': '/var/mail/cltbld', 15:38:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:33 INFO - 'MOZ_NO_REMOTE': '1', 15:38:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:38:33 INFO - 'NO_EM_RESTART': '1', 15:38:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:38:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:33 INFO - 'PWD': '/builds/slave/test', 15:38:33 INFO - 'SHELL': '/bin/bash', 15:38:33 INFO - 'SHLVL': '1', 15:38:33 INFO - 'TERM': 'linux', 15:38:33 INFO - 'TMOUT': '86400', 15:38:33 INFO - 'USER': 'cltbld', 15:38:33 INFO - 'XDG_SESSION_COOKIE': 'c7c495d6f76fb52e1ad9f659000001da-1479771474.681008-204534780', 15:38:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:33 INFO - '_': '/tools/buildbot/bin/python'} 15:38:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:38:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:38:33 INFO - Cleaning up... 15:38:33 INFO - Return code: 0 15:38:33 INFO - Running post-action listener: _resource_record_post_action 15:38:33 INFO - Running post-action listener: _start_resource_monitoring 15:38:33 INFO - Starting resource monitoring. 15:38:33 INFO - [mozharness: 2016-11-21 23:38:33.393674Z] Finished create-virtualenv step (success) 15:38:33 INFO - [mozharness: 2016-11-21 23:38:33.394131Z] Running install step. 15:38:33 INFO - Running pre-action listener: _resource_record_pre_action 15:38:33 INFO - Running main action method: install 15:38:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:38:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:38:33 INFO - Reading from file tmpfile_stdout 15:38:33 INFO - Detecting whether we're running mozinstall >=1.0... 15:38:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:38:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:38:33 INFO - Reading from file tmpfile_stdout 15:38:33 INFO - Output received: 15:38:33 INFO - Usage: mozinstall [options] installer 15:38:33 INFO - Options: 15:38:33 INFO - -h, --help show this help message and exit 15:38:33 INFO - -d DEST, --destination=DEST 15:38:33 INFO - Directory to install application into. [default: 15:38:33 INFO - "/builds/slave/test"] 15:38:33 INFO - --app=APP Application being installed. [default: firefox] 15:38:33 INFO - mkdir: /builds/slave/test/build/application 15:38:33 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'] 15:38:33 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 15:38:50 INFO - Reading from file tmpfile_stdout 15:38:50 INFO - Output received: 15:38:50 INFO - /builds/slave/test/build/application/firefox/firefox 15:38:50 INFO - Running post-action listener: _resource_record_post_action 15:38:50 INFO - [mozharness: 2016-11-21 23:38:50.584065Z] Finished install step (success) 15:38:50 INFO - [mozharness: 2016-11-21 23:38:50.584425Z] Running run-tests step. 15:38:50 INFO - Running pre-action listener: _resource_record_pre_action 15:38:50 INFO - Running main action method: run_tests 15:38:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:38:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:38:50 INFO - Python 2.7.3 15:38:50 INFO - Return code: 0 15:38:50 INFO - grabbing minidump binary from tooltool 15:38:50 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')]} 15:38:50 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 0x2727f60>, '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 0x2728d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27291d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:38:50 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 15:38:50 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 15:38:50 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 15:38:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:38:50 INFO - Return code: 0 15:38:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:38:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:38:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:38:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:38:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:38:50 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/YhGiLdw7Q-mAX_AQrT5mzw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 15:38:50 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/YhGiLdw7Q-mAX_AQrT5mzw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --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 15:38:50 INFO - Using env: {'DISPLAY': ':0', 15:38:50 INFO - 'HOME': '/home/cltbld', 15:38:50 INFO - 'LANG': 'en_US.UTF-8', 15:38:50 INFO - 'LANGUAGE': 'en_US:en', 15:38:50 INFO - 'LOGNAME': 'cltbld', 15:38:50 INFO - 'MAIL': '/var/mail/cltbld', 15:38:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:38:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:38:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:38:50 INFO - 'MOZ_NO_REMOTE': '1', 15:38:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:38:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:38:50 INFO - 'NO_EM_RESTART': '1', 15:38:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:38:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:38:50 INFO - 'PWD': '/builds/slave/test', 15:38:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:38:50 INFO - 'SHELL': '/bin/bash', 15:38:50 INFO - 'SHLVL': '1', 15:38:50 INFO - 'TERM': 'linux', 15:38:50 INFO - 'TMOUT': '86400', 15:38:50 INFO - 'USER': 'cltbld', 15:38:50 INFO - 'XDG_SESSION_COOKIE': 'c7c495d6f76fb52e1ad9f659000001da-1479771474.681008-204534780', 15:38:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:38:50 INFO - '_': '/tools/buildbot/bin/python'} 15:38:50 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/YhGiLdw7Q-mAX_AQrT5mzw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--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 15:38:50 INFO - mozversion application_buildid: 20161121125101 15:38:50 INFO - mozversion application_changeset: d49013ebf0df7f07ecb12467f193583272bc4a00 15:38:50 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:38:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:38:50 INFO - mozversion application_name: Firefox 15:38:50 INFO - mozversion application_remotingname: firefox-dev 15:38:50 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:38:50 INFO - mozversion application_vendor: Mozilla 15:38:50 INFO - mozversion application_version: 52.0a2 15:38:50 INFO - mozversion platform_buildid: 20161121125101 15:38:50 INFO - mozversion platform_changeset: d49013ebf0df7f07ecb12467f193583272bc4a00 15:38:50 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:38:50 INFO - mozversion platform_version: 52.0a2 15:38:50 INFO - using testdate: 1479771530 15:38:50 INFO - actual date: 1479771530 15:38:50 INFO - starting webserver on 'localhost:57482' 15:38:50 INFO - SUITE-START | Running 2 tests 15:38:50 INFO - TEST-START | dromaeo_css 15:38:50 INFO - operating with platform_type : linux_ 15:38:50 INFO - Initialising browser for dromaeo_css test... 15:38:50 INFO - TEST-INFO | started process 19610 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpos5N1z/profile http://localhost:57482/getInfo.html) 15:38:53 ERROR - PROCESS | 19610 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5373: TypeError: parent.firstChild is null 15:38:54 INFO - PROCESS | 19610 | __metrics Screen width/height:1600/1200 15:38:54 INFO - PROCESS | 19610 | colorDepth:24 15:38:54 INFO - PROCESS | 19610 | Browser inner width/height: 1024/697 15:38:54 INFO - PROCESS | 19610 | __metrics 15:38:55 INFO - PROCESS | 19610 | 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" 15:38:55 INFO - PROCESS | 19610 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:38:56 INFO - PROCESS | 19610 | console.error: PushService: 15:38:56 INFO - PROCESS | 19610 | stateChangeProcessEnqueue: Error transitioning state 15:38:56 INFO - PROCESS | 19610 | UnknownError 15:38:56 INFO - TEST-INFO | 19610: exit 0 15:38:56 INFO - Browser initialized. 15:38:56 INFO - Running cycle 1/1 for dromaeo_css test... 15:38:56 INFO - TEST-INFO | started process 19703 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpos5N1z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:39:08 INFO - PROCESS | 19703 | RSS: Main: 144310272 15:39:08 INFO - PROCESS | 19703 | 15:40:00 INFO - PROCESS | 19703 | 1479771600325 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] 15:42:10 INFO - PROCESS | 19703 | Cycle 1(1): loaded http://localhost:57482/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57482/tests/dromaeo/cssquery-ext.html) 15:42:11 INFO - PROCESS | 19703 | RSS: Main: 246665216 15:42:11 INFO - PROCESS | 19703 | 15:45:14 INFO - PROCESS | 19703 | Cycle 1(1): loaded http://localhost:57482/tests/dromaeo/cssquery-ext.html (next: http://localhost:57482/tests/dromaeo/cssquery-jquery.html) 15:45:14 INFO - PROCESS | 19703 | RSS: Main: 233234432 15:45:14 INFO - PROCESS | 19703 | 15:48:16 INFO - PROCESS | 19703 | Cycle 1(1): loaded http://localhost:57482/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57482/tests/dromaeo/cssquery-mootools.html) 15:48:17 INFO - PROCESS | 19703 | RSS: Main: 175828992 15:48:17 INFO - PROCESS | 19703 | 15:51:19 INFO - PROCESS | 19703 | Cycle 1(1): loaded http://localhost:57482/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57482/tests/dromaeo/cssquery-prototype.html) 15:51:19 INFO - PROCESS | 19703 | RSS: Main: 175824896 15:51:19 INFO - PROCESS | 19703 | 15:54:22 INFO - PROCESS | 19703 | Cycle 1(1): loaded http://localhost:57482/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57482/tests/dromaeo/cssquery-yui.html) 15:54:23 INFO - PROCESS | 19703 | RSS: Main: 174800896 15:54:23 INFO - PROCESS | 19703 | 15:57:25 INFO - PROCESS | 19703 | Cycle 1(1): loaded http://localhost:57482/tests/dromaeo/cssquery-yui.html (next: http://localhost:57482/tests/dromaeo/cssquery-dojo.html) 15:57:25 INFO - PROCESS | 19703 | RSS: Main: 261992448 15:57:25 INFO - PROCESS | 19703 | 15:57:25 INFO - PROCESS | 19703 | __start_tp_report 15:57:25 INFO - PROCESS | 19703 | _x_x_mozilla_page_load 15:57:25 INFO - PROCESS | 19703 | _x_x_mozilla_page_load_details 15:57:25 INFO - PROCESS | 19703 | |i|pagename|runs| 15:57:25 INFO - PROCESS | 19703 | |0;dojo.html;3183.9681603183967;3227.3867965086633;3230.1924518870283;3235.579374681291;3245.6916592923662;5452.863678408042;5496.31296087989;5543.805966791163;5545.140503222002;5554.694491802949;5492.203630473589;5513.09034009388;5513.173024046385;5516.007118718629;5522.116461366182;4970.875728106799;4997.5252351026775;5047.167217409142;5059.848204553851;5070;4962.206047032476;4963.6277279204205;5042.5713814325645;5089.974550127245;5098.413682426512;4893.804247830082;4902.436219834711;4912.238603016538;5030.496950304977;5033.395992480908;5072.163093089635;5088.974555127238;5127.8205262816;5134.537891589737;5161.66449180802;4788.80844766209;4989.550940415344;5011.949880501221;5063.215201643751;5095.006473737622;5369.704666243355;5415.458454154553;5485.670859748428;5501.642393244466;5506.476884695948;5888.705564721747;5904.084866845646;5998.7600495980105;5999.100134979744;5999.520038396918;5685.147227915804;5985.401459854023;5986.07215881539;6046.062860256668;6054.8183554493;5384.273123128367;5449.3188351456465;5482.396936337;5542.722863856791;5543.445655434505;6042.697865106815;6048.274207095089;6049.697515124314;6049.909251361233;6052.757889684363;5593.972030139905;5842.386549412336;5852.648841069549;5856.472917437451;5858.619189752652;5689.516391106802;5769.336526299446;5803.970980145073;5805.506531944832;5888;5836.970815145897;5843.2695913010875;5844.415558444121;5848.444397782204;5864.648121112747;5791.594588378773;5860.824175274749;5863.560232982543;5864.413558644102;5889.882202355929;4453.087117140978;4490.169318676056;4516.9774151129695;4550;4561.612262957686;4058.736182148151;4093.8302699569276;4118.9702574356415;4120.320147175742;4136.565660605593;5614.578906582023;5621.550275977912;5621.634593751393;5622.128570071645;5630.042892708249;5706.572007099484;5778.88442231153;5868.823935281948;5929;5932.466078052909;5567.8886422272135;5584.664920104807;5609.635373700697;5618.775248990077;5625.043742563774;5185.533302002837;5185.9740701297005;5187.610929180327;5201;5228.816991405282;5978.641281523035;5990.400959903975;6031.577789554689;6184.041473571604;6205.03821907605;5817.069268916953;5866.3547009828035;5895.970520147372;5900.203472531153;5936.1095835625;6107.0228763397645;6116;6116.143739876332;6116.388361164026;6119.785807496716;5672.773089076556;5680.545556355564;5796.1305804129715;5796.710164491843;5798.884022319446;5840.8247752567495;5893.5874488785375;5895.14520394549;5919.526437884872;5955.67243801595;5739.167820666064;5839.620424672553;5840.094785308284;5841.1530328101335;5852.824415267549;5686.061799802987;5799.4780469757925;5802.564807639528;5803.65178089316;5811.622244554091;5688.089905615082;5732.082866741302;5785.132230165509;5803.129530570448;5834.445727655866;5888.3228428731245;5905.43898329658;5905.940940590539;5918.171455996078;5926.111083337361;5483.8080667176455;5531.197976293495;5701.6864072474755;5744.885102297847;5754.424557544212 15:57:25 INFO - PROCESS | 19703 | |1;ext.html;591.2845456997034;620.3269452643881;651.1957732200733;667.136058803849;676.5467137018197;34279.82860085699;36413;36413.81793091031;36437;36469.63530364696;36918.261634767354;46608.30087548681;47441.525584744144;47527.28709069358;49762.751186244015;8807.295416366675;8930.55347232639;8932.508712020835;8934.463932164059;8935.910640893573;8349.749507514754;8620.612072456723;8766.956165219164;8867.37928345013;8867.467951922874;10615.097716694052;10885.510152043176;10886.727831804228;11189.720256993558;11194.328340299608;10670.519826607782;10682.038616524473;10694.786104277871;10746.301490403099;10750.139988800955;8234.670613175465;8512.914870851275;8519.57402129891;10616.57533698651;10701.411422371766;35353.64646353529;43521.782391088156;44574;44635.55364446346;47219;3729.701623870084;3734.9439758403646;3742.251549690073;3864;3960.425738267964;33197;33425.6657433425;33472;33631.32737345264;33682.831585842156;4223.450951376332;4276.2089013532595;4290.678199135077;4317.11499142675;4370.847020354304;270412;270538;270660.64669676725;270802;272697;55179.17231241534;56963.715181423824;62332.68833655893;62638.686806565674;62745.490180393186;53127;54139.729301354026;54358.72820635871;54383.45616543863;54449.72775136099;17474.563135921704;17630.118494075246;17836.01901895408;17865.196066177054;17915;14808.407663693331;14832.406703731946;14901;14905.180215088274;14960.326785294688;15727.764083538756;16047.944897357294;16559.42042028523;17263;17361.3923512679;6744.831379215559;6746.595204287759;6953.374196322356;6954.478414118961;6987.196472405637;963.3160456076264;1046.9214808889365;1085.8588383510094;1124.3029321820525;1153.1005815463952;33329.333413331595;33451.16372090717;33703.47409923863;33916.660833391354;33980.32039359248;1019.4851599942131;1047.177965297238;1048.9475526223812;1084.4957094950885;1149.0348107589664;16470.83529164693;17630.735538966925;17688.380906668204;17731.73402398965;17779;166623;167492;535544;538650;540085;63031.369686303464;63245.68377158085;63464.36535634677;63475.36524634787;63495.36504634987;1296.2546535741985;1367.924764137962;1394.769862972598;1422.5447856685762;1448.7609544425263;32821.17947051343;34568.48147277743;35136.64863351334;35196.296074078884;35196.648033519334;51895.481045189066;52322;52403.73798130985;52435.47564524306;52620.73689631528;390805;392299;392414;571036;577819;30468.695313046584;30727.078187654406;30745.077647670605;30989.69010309868;31105;48845.2673209895;49624;49952.25071623856;51400.22899656583;52089.739551302;41902;42131.789341054326;42181.15637687167;42185.57814421816;44036.11927761491;41748.16503669849;42093.36859947042;42286.1542769149;42803;43980.78009609931;42698.359524607775;43649.78175109104;43875.561244388424;44274.3358849624;44412;35960.28079438449;38160.23679526449;38210.617893821815;38968.220635586564;39005;28731;28866.422671546872;28911.7108828909;28914.855425722737;29170.416591668472 15:57:25 INFO - PROCESS | 19703 | |2;jquery.html;393.7204584744831;432.6765270497429;435.4034972088239;438.7893810970735;448.61643294982787;16624.58438539037;19029.809701902977;20416.979151042462;21145.94270286487;21305.25431609894;18083.30375931584;18291.176897039633;18385.08074596268;18715.81284187158;19549.90225048876;5409.350877894648;5822.184894114827;5857.589968702193;5861.6189947653265;5864.970675146639;5479.260299859528;5674.347450043236;5708.714564271791;5714.828555143353;5716.657000579979;5685.317761868561;5686.317641882959;5689.175069614904;5692.88988647214;5694.316681998145;5509.201165830972;5693.658380497183;5704.828855134353;5725.969325521404;5726.885462290752;5093.28693982839;5167.48325167484;5177.326947496839;5181.1969144782615;5182.611304152204;24042;24169.154079607128;24351.02595896162;24471.26586202399;24528.386790330205;2230.710007699005;2273.59075366434;2394.114177754225;2399.436132508859;2491.2152671908293;14860.405583776635;15486.45797397097;15521.223938803014;15560.37758489659;15782.763258551131;1813.1478205243513;1878.5021969178179;1896.6680830854684;1945.8929758863258;1961.0096901065015;88935;88955.55522222412;90025.54987225022;91439.54280228556;92065.53967230188;10112.191024718006;11020.173486988508;11367.374794386224;11796.587119450778;11868.347240901661;13196.868031319564;14291.213983231022;15149.697006059818;15689.293981770848;15784.21078946071;8043.316318112909;8175.264226219669;8313.958430207811;8948.955255223682;9077.137671921157;8594.527300998505;8604.35467339952;8634.870476942851;8804.691835785718;8954.328425368123;6878.8624227516175;6968.44252459802;7007.649617519103;7100.325469080429;7109.786706398816;2001.7097520859393;2037.9286724964852;2059.783722709124;2085.4056593870673;2112.8309735221146;958.8034452937131;1002.283367392318;1028.321307936758;1084.6821112348534;1099.378850949211;19356.612867742566;20952.790472095083;21119.26082587102;21264.681029784566;21402.464938376354;995.8058178655093;1008.5511947183579;1036.5542816588938;1068.8289873620183;1095.1567293184203;11245.718857028476;11875.346855923008;11999.820002699966;12003.759924801456;12045.879541204651;518950;524128;533838;534837;539539;52383;76180.61909690416;87101;87645.68531472034;88462.55768721116;1041.6562534363793;1071.7159952612565;1099.2195541165702;1100.7853468573712;1107.684309971654;17744.55638609045;18126.64050196267;18475.260989560265;18599.2560297592;18650.253989840254;39570.80214599024;40587.59412405838;40630.79684601676;40770.1845963085;41635.7918210407;52147.217791733914;53911.46088539065;53966.46033539614;54696.45303546914;54761;9295.163435290857;9356.953215234153;9366.906330936876;9469.905300946903;9506.572204250688;12604.810927836274;13542.796858047333;13646.181229126285;13711.382987765774;14613;12229.532456105324;12456.937715311366;12485.93757031209;12653.620391388273;13002.764737349937;11937.462814173557;12254;12366.319852408204;12553.435095420911;12571.994240460559;12567.937160314506;12788.616341509769;12790.296533690736;12893.290869002294;13051.412686429323;9098.272138229058;9138.17756401927;9235.215006724235;9356.672516461891;9391.953040235028;9420.528973551158;11979.940100299791;12684.87315126837;12708;12780.744385112059 15:57:25 INFO - PROCESS | 19703 | |3;mootools.html;1349.7637913365159;1514.7500662390705;1532.7125214819553;1686.2580464595576;1846.326090976794;7363.447741419395;7758.418118641103;8324;8564.057953625112;8572.614232359543;8537.231649151576;8599.957000215007;8605.870911936327;8606.741797746077;8608.39741218115;2454.239185852387;2484.1553871683623;2484.291976786616;2486.502699460106;2488.2908371114236;2413.1071503543712;2510.8870100845506;2514.0697941761573;2516.55960206964;2519.962200566993;2426.5389575980594;2438.780509754122;2463.261021693485;2467.6915385576804;2467.7778999890006;2376.192094687806;2400.195934361991;2401;2402.315340128055;2434.4035711250767;2371.4664200554907;2387.9880600596885;2425.296663967465;2427.0655797517907;2434.3062227265323;8543.530105844176;8553.871691924625;8625.396222264444;8637.65449382024;8679.609417576225;5315.202719592054;5476.534494567966;5476.616636835423;5479.342478902558;5537.698640819404;3546.4325707886615;3569.428891377393;3687.520622319108;3711.294853977736;3712.870049548253;1206.9637910862689;1221.3404761428817;1224.8285240066398;1251.2930194440112;1251.386820457978;11841;12100.757984840342;12111.031117510665;12125.09061820367;12133.575324863587;4589.426321709786;4753.809847606057;4801.927971080437;4804.543568361;4821.4696383397795;10314.587416503256;10324.12244959172;10341.224408169417;10341.327813692085;10344.120749736358;5445.346558412936;5447.591430642718;5448.237246785453;5450.046241907729;5452.018636645442;4196.790160491963;4360.41134446852;4517.796699148546;4929.876753081202;4990.650654454226;4165.58344165581;4174.624283814472;4262.104957958802;4291.485021797404;4327.6321512671775;1341.805438211454;1360.3742278551977;1362.0601784768478;1373.8488766235705;1379.6137081617164;873.2839071960931;883.9955800220957;945.4705364995624;977.4721650308753;1053.8682664666917;5800.8259752207505;5976.342602313742;6010.156745447146;6071.51427885768;6100.3899610039525;471.76176031104075;475.14948242645966;475.5173498898621;482.96860704054126;484.138233943581;4114.300568903293;4200.810963506649;4238.745675259433;4246.150769846043;4281.272183728774;10269.94865025685;10492.108170805566;10608.681739547827;10612.787744245072;10614.203934704929;9921.702348929544;10487.632932847313;10541.20799464093;10561.577536898592;10566.52450639723;7890.684372625031;8245.917540824636;8248.917510824935;8251.95874020626;8252.628631711588;5967.224260846062;5979.103134529855;6068.939310606837;6115.327313995368;6321.52588555851;9617.663381781604;9704.514774261399;9751.658691945748;9768.804623907625;9828.213742900407;9826.4104153751;9848.162906153057;9872.901270987486;9958.701238962843;10006.549705263425;7307.963460182665;7354.103985876704;7420.962895185489;7423.703051877865;7543.924560754542;8059.83880322402;8070.83858322842;8125;8126.228008339198;8134.959325203573;7242.746503872339;7320.633968301457;7392.778216653509;7399.778006659809;7427.554346739213;7134.785956421316;7172.175199852084;7232.891506627299;7309.853802924018;7405.148407932941;6790.7623233186605;6829.795106146824;6877.105976223059;6880.69036893331;6884.173899132136;5124.180131178993;5145.614078944169;5199.960007998491;5348.679079255257;5416.620836541404;5212.765425555935;5217;5287.867803304948;5305.734713264398;5329.413764485826 15:57:25 INFO - PROCESS | 19703 | |4;prototype.html;357.67094273268594;358.34065319811543;360.38194496438604;360.7889384709945;368.28185039173616;5395.838124856251;5424.186372044191;5434.212039254306;5444.564434845212;5486.204500347447;5066.947886106123;5351.919721204185;5367.838964831061;5382.811601593945;5408.4315548490895;4013.73224128368;4255.3616757610325;4256.21260066887;4279.5078565965005;4317.676174286926;4273.337632666926;4279.679024073192;4282.593153650414;4290.806913688876;4295.677824163185;4013.8193781279765;4253.893652658693;4265.44549208604;4267.423897773808;4277.294246449348;4015.8996025099314;4069.308217603015;4219.11398606293;4265.488141423018;4266.189424009428;3790.5261842269715;3797.126660867988;3802.4866643003393;3814.370628846237;3817.7136714746507;5208.250059956825;5222.76497557607;5245.79016839326;5248.876918233645;5268.92096618551;4574.222382195035;4763.54746299101;4817.975910120462;4824.758762061883;4831.420229572439;5541.5843811714285;5579.210394802599;5586;5589.552835773128;5612.803551875665;4116.382542618631;4121.649659778893;4124.670026397881;4129.256733787947;4129.666738292855;5584.274044374246;5785.363610002896;5819.301683797929;5821.380378829502;5842.386549412336;4180.561041090642;4187.748735075906;4187.832486700559;4190.832366705297;4193.22425351311;4213.494380674339;4235.729281215623;4237.809298581571;4241.766702831313;4268.957310426918;4592.770361481913;4788.425388953278;4807.4471435784635;4817.13291607514;4830.178869592178;5611.186377975252;5617.915731264035;5636.408177141423;5639.182318563785;5659.547236221175;1393.658553654341;1396.9790453143007;1411.788231765223;1415.5965549818252;1417.5888992192356;952.1953948913157;985.7387792235063;989.9208063354914;996.4868092932146;1003.3027046202965;5179.766910489037;5388.757505912244;5521.806736764194;5551.611387202857;5585.636933599303;5811.506021988093;5812.854678633068;5824.301083869963;5835.241418615553;5842.357340692605;5328.600354973392;5515.586331025189;5530.778768849201;5553.194786755897;5559.8888022240135;2946.9263268418463;2956.817273090781;2966.7329940305476;2968.228260652246;2982.597349357852;5800.622959507618;5807.186993820868;5815.9709201453725;5835.2414186156375;5837.824865254049;5533.916991245134;5894.705264736746;5899.970500147472;5922;5926.940730592639;6052.365861217447;6056.3338032816355;6060.303065147476;6065.5450841187085;6085.117657939485;5612.747426365905;5791.247137872049;5804.448577385142;5804.76780928775;5861.501772349227;5747.626404283708;5754.9424505754405;5764;5774.624649397776;5796.333421656564;5928.4960778334325;6067.514598831995;6068.848278792889;6077.908831367621;6083.908741368795;4126.7730274833975;4181;4201.626081264076;4206.894827629334;4217.1776503581505;5784.900868834908;5815.41845815415;5834.38738932406;5850.180974663465;5866.5893387462465;5618.241537392563;5731.8853622928145;5760.884782304414;5763.308402991668;5765.509931655689;5629.099344104923;5651.180578815966;5651.378348381592;5657.943420565742;5682.346530149086;5375.462453754593;5560.774750644536;5590.357108932525;5597.069011191133;5598.272224610774;5512.862178445571;5578.135389014709;5626.521745651666;5667.583104223944;5702.800401985911;5555.194496798023;5557.582816381797;5559.555235581225;5560.277163968658;5580.972095139498 15:57:25 INFO - PROCESS | 19703 | |5;yui.html;819.082627457248;828.1428721273484;843.7806170395697;864.913508649135;872.9393786549341;15008.324625391857;16176.595585110379;16369;16423.671526569477;16436.589085272888;13802.171869687802;13951.162930224194;13976.650583735413;13998.370073346698;14310.427582896698;838.6226198210799;853.1042405474258;853.4580541356221;854.5556310718423;855.4696088425185;733.1458850439232;752.3191511681937;838.1953324808192;856.2807241916788;866.9176428239339;903.5888670654837;904.1500989070286;904.6019751309403;905.1988989744058;905.8052518708477;890.3144578674385;896.4531635702216;896.6323807239033;896.753392816974;897.349421669291;553.3774503683356;571.8456016875421;648.2706954675989;654.3848782144769;660.2605082307798;14787;14798.926005370013;14815.777763333559;14860.03409778361;14948.103113813206;13570.864291357157;13868.375923083486;13964.231967241798;14002.509912153026;14024.298785060706;12809.807852882213;12896.484140634364;12899.742005159844;13029.934850325688;13136.737265254736;4347.260965635849;4403.119376124788;4425.468943726742;4466.39703640011;4571.9542804571865;62646;63889.36110638881;64002.67998660023;64726.676366618805;65051;10545.47272636365;11115.110791136689;11204.887951120385;11386.089112871116;11439.59961401347;20537.58924821495;20652.896735516228;20793;20814.27150049741;20982.2656207032;8415.158484151536;8531.786705332292;8532.829343413097;8626.39615226928;8629.568521573896;4606.907861842745;4767.237242041326;4810.470848206694;4914.975425122851;4983.875403114951;3403.1322012886553;3495.7727747696317;3501.124718820295;3504.9299014019575;3505.316463289685;619.4734475695623;625.1217040058725;629.9748010079545;635.2821311917504;641.1280658304702;645.5287640022809;648.4974145037634;719.7624783821326;725.9963700181465;733.4938892164496;7491.10106787189;7680.155182929873;7897.131315555284;9023.864642030374;9265.180470248759;655.0861548140317;670.2024590737008;687.9380855723009;703.9225685174627;729.9781006569812;4159.688023398257;4220.277920741105;4355.259605867011;4384.671149663788;4532.4334458192725;91595.54202228946;93567.53216233876;94141;94270.52864735632;97444.51277743567;50750.49249507531;65648;80580.95642826811;85023.57488212643;86333.56833215794;56970;61389;65007.67496162489;67779.66110169418;75864.62067689736;9573.760655983377;9978.60085596568;10004.547067141508;10065.245106616887;10095.646652367132;37920.810395948945;44312.55687443084;44451;45170.54829451664;46410.07179856452;35640.82179589086;56707;59269.70365148319;59749;59855.401445984986;12107.091968102251;12260.932698141154;12405.75188496243;12555.246685198917;12964.157329773534;12237.388130593257;12728.1726687765;12732.618021459;12786.936065319614;12875.613731588068;12650.746985060432;12719.427625756678;13144.934275328562;13178;13456.86543134556;13077.869221307665;13294.734105318033;13444.058915875794;13459.596212113653;13670.52153174634;12298.262104273414;12335.876641233473;12473.064520161206;12886.09797314179;12916.8062479061;10203.28576999603;10640.395064663433;10847.891521084688;10937.85107625928;11153.163512736739;10646.183274552961;10839.295445795999;11208.775824483302;11235.269707469315;11238.831417528907 15:57:25 INFO - PROCESS | 19703 | __end_tp_report 15:57:25 INFO - PROCESS | 19703 | __start_cc_report 15:57:25 INFO - PROCESS | 19703 | _x_x_mozilla_cycle_collect,1135 15:57:25 INFO - PROCESS | 19703 | __end_cc_report 15:57:25 INFO - PROCESS | 19703 | __startTimestamp1479772645812__endTimestamp 15:57:25 INFO - PROCESS | 19703 | 15:57:25 INFO - PROCESS | 19703 | ------- Summary: start ------- 15:57:25 INFO - PROCESS | 19703 | Number of tests: 6 15:57:25 INFO - PROCESS | 19703 | 15:57:25 INFO - PROCESS | 19703 | [#0] dojo.html Cycles:165 Average:5487.83 Median:5688.09 stddev:611.02 (10.7%) stddev-sans-first:585.55 15:57:25 INFO - PROCESS | 19703 | Values: 3184.0 3227.4 3230.2 3235.6 3245.7 5452.9 5496.3 5543.8 5545.1 5554.7 5492.2 5513.1 5513.2 5516.0 5522.1 4970.9 4997.5 5047.2 5059.8 5070.0 4962.2 4963.6 5042.6 5090.0 5098.4 4893.8 4902.4 4912.2 5030.5 5033.4 5072.2 5089.0 5127.8 5134.5 5161.7 4788.8 4989.6 5011.9 5063.2 5095.0 5369.7 5415.5 5485.7 5501.6 5506.5 5888.7 5904.1 5998.8 5999.1 5999.5 5685.1 5985.4 5986.1 6046.1 6054.8 5384.3 5449.3 5482.4 5542.7 5543.4 6042.7 6048.3 6049.7 6049.9 6052.8 5594.0 5842.4 5852.6 5856.5 5858.6 5689.5 5769.3 5804.0 5805.5 5888.0 5837.0 5843.3 5844.4 5848.4 5864.6 5791.6 5860.8 5863.6 5864.4 5889.9 4453.1 4490.2 4517.0 4550.0 4561.6 4058.7 4093.8 4119.0 4120.3 4136.6 5614.6 5621.6 5621.6 5622.1 5630.0 5706.6 5778.9 5868.8 5929.0 5932.5 5567.9 5584.7 5609.6 5618.8 5625.0 5185.5 5186.0 5187.6 5201.0 5228.8 5978.6 5990.4 6031.6 6184.0 6205.0 5817.1 5866.4 5896.0 5900.2 5936.1 6107.0 6116.0 6116.1 6116.4 6119.8 5672.8 5680.5 5796.1 5796.7 5798.9 5840.8 5893.6 5895.1 5919.5 5955.7 5739.2 5839.6 5840.1 5841.2 5852.8 5686.1 5799.5 5802.6 5803.7 5811.6 5688.1 5732.1 5785.1 5803.1 5834.4 5888.3 5905.4 5905.9 5918.2 5926.1 5483.8 5531.2 5701.7 5744.9 5754.4 15:57:25 INFO - PROCESS | 19703 | 15:57:25 INFO - PROCESS | 19703 | [#1] ext.html Cycles:180 Average:55366.83 Median:21037.31 stddev:106637.64 (506.9%) stddev-sans-first:106857.48 15:57:25 INFO - PROCESS | 19703 | Values: 591.3 620.3 651.2 667.1 676.5 34279.8 36413.0 36413.8 36437.0 36469.6 36918.3 46608.3 47441.5 47527.3 49762.8 8807.3 8930.6 8932.5 8934.5 8935.9 8349.7 8620.6 8767.0 8867.4 8867.5 10615.1 10885.5 10886.7 11189.7 11194.3 10670.5 10682.0 10694.8 10746.3 10750.1 8234.7 8512.9 8519.6 10616.6 10701.4 35353.6 43521.8 44574.0 44635.6 47219.0 3729.7 3734.9 3742.3 3864.0 3960.4 33197.0 33425.7 33472.0 33631.3 33682.8 4223.5 4276.2 4290.7 4317.1 4370.8 270412.0 270538.0 270660.6 270802.0 272697.0 55179.2 56963.7 62332.7 62638.7 62745.5 53127.0 54139.7 54358.7 54383.5 54449.7 17474.6 17630.1 17836.0 17865.2 17915.0 14808.4 14832.4 14901.0 14905.2 14960.3 15727.8 16047.9 16559.4 17263.0 17361.4 6744.8 6746.6 6953.4 6954.5 6987.2 963.3 1046.9 1085.9 1124.3 1153.1 33329.3 33451.2 33703.5 33916.7 33980.3 1019.5 1047.2 1048.9 1084.5 1149.0 16470.8 17630.7 17688.4 17731.7 17779.0 166623.0 167492.0 535544.0 538650.0 540085.0 63031.4 63245.7 63464.4 63475.4 63495.4 1296.3 1367.9 1394.8 1422.5 1448.8 32821.2 34568.5 35136.6 35196.3 35196.6 51895.5 52322.0 52403.7 52435.5 52620.7 390805.0 392299.0 392414.0 571036.0 577819.0 30468.7 30727.1 30745.1 30989.7 31105.0 48845.3 49624.0 49952.3 51400.2 52089.7 41902.0 42131.8 42181.2 42185.6 44036.1 41748.2 42093.4 42286.2 42803.0 43980.8 42698.4 43649.8 43875.6 44274.3 44412.0 35960.3 38160.2 38210.6 38968.2 39005.0 28731.0 28866.4 28911.7 28914.9 29170.4 15:57:25 INFO - PROCESS | 19703 | 15:57:25 INFO - PROCESS | 19703 | [#2] jquery.html Cycles:180 Average:30347.79 Median:13220.72 stddev:87051.00 (658.4%) stddev-sans-first:87266.15 15:57:25 INFO - PROCESS | 19703 | Values: 393.7 432.7 435.4 438.8 448.6 16624.6 19029.8 20417.0 21145.9 21305.3 18083.3 18291.2 18385.1 18715.8 19549.9 5409.4 5822.2 5857.6 5861.6 5865.0 5479.3 5674.3 5708.7 5714.8 5716.7 5685.3 5686.3 5689.2 5692.9 5694.3 5509.2 5693.7 5704.8 5726.0 5726.9 5093.3 5167.5 5177.3 5181.2 5182.6 24042.0 24169.2 24351.0 24471.3 24528.4 2230.7 2273.6 2394.1 2399.4 2491.2 14860.4 15486.5 15521.2 15560.4 15782.8 1813.1 1878.5 1896.7 1945.9 1961.0 88935.0 88955.6 90025.5 91439.5 92065.5 10112.2 11020.2 11367.4 11796.6 11868.3 13196.9 14291.2 15149.7 15689.3 15784.2 8043.3 8175.3 8314.0 8949.0 9077.1 8594.5 8604.4 8634.9 8804.7 8954.3 6878.9 6968.4 7007.6 7100.3 7109.8 2001.7 2037.9 2059.8 2085.4 2112.8 958.8 1002.3 1028.3 1084.7 1099.4 19356.6 20952.8 21119.3 21264.7 21402.5 995.8 1008.6 1036.6 1068.8 1095.2 11245.7 11875.3 11999.8 12003.8 12045.9 518950.0 524128.0 533838.0 534837.0 539539.0 52383.0 76180.6 87101.0 87645.7 88462.6 1041.7 1071.7 1099.2 1100.8 1107.7 17744.6 18126.6 18475.3 18599.3 18650.3 39570.8 40587.6 40630.8 40770.2 41635.8 52147.2 53911.5 53966.5 54696.5 54761.0 9295.2 9357.0 9366.9 9469.9 9506.6 12604.8 13542.8 13646.2 13711.4 14613.0 12229.5 12456.9 12485.9 12653.6 13002.8 11937.5 12254.0 12366.3 12553.4 12572.0 12567.9 12788.6 12790.3 12893.3 13051.4 9098.3 9138.2 9235.2 9356.7 9392.0 9420.5 11979.9 12684.9 12708.0 12780.7 15:57:25 INFO - PROCESS | 19703 | 15:57:25 INFO - PROCESS | 19703 | [#3] mootools.html Cycles:180 Average:5729.02 Median:5057.42 stddev:3152.21 (62.3%) stddev-sans-first:3143.87 15:57:25 INFO - PROCESS | 19703 | Values: 1349.8 1514.8 1532.7 1686.3 1846.3 7363.4 7758.4 8324.0 8564.1 8572.6 8537.2 8600.0 8605.9 8606.7 8608.4 2454.2 2484.2 2484.3 2486.5 2488.3 2413.1 2510.9 2514.1 2516.6 2520.0 2426.5 2438.8 2463.3 2467.7 2467.8 2376.2 2400.2 2401.0 2402.3 2434.4 2371.5 2388.0 2425.3 2427.1 2434.3 8543.5 8553.9 8625.4 8637.7 8679.6 5315.2 5476.5 5476.6 5479.3 5537.7 3546.4 3569.4 3687.5 3711.3 3712.9 1207.0 1221.3 1224.8 1251.3 1251.4 11841.0 12100.8 12111.0 12125.1 12133.6 4589.4 4753.8 4801.9 4804.5 4821.5 10314.6 10324.1 10341.2 10341.3 10344.1 5445.3 5447.6 5448.2 5450.0 5452.0 4196.8 4360.4 4517.8 4929.9 4990.7 4165.6 4174.6 4262.1 4291.5 4327.6 1341.8 1360.4 1362.1 1373.8 1379.6 873.3 884.0 945.5 977.5 1053.9 5800.8 5976.3 6010.2 6071.5 6100.4 471.8 475.1 475.5 483.0 484.1 4114.3 4200.8 4238.7 4246.2 4281.3 10269.9 10492.1 10608.7 10612.8 10614.2 9921.7 10487.6 10541.2 10561.6 10566.5 7890.7 8245.9 8248.9 8252.0 8252.6 5967.2 5979.1 6068.9 6115.3 6321.5 9617.7 9704.5 9751.7 9768.8 9828.2 9826.4 9848.2 9872.9 9958.7 10006.5 7308.0 7354.1 7421.0 7423.7 7543.9 8059.8 8070.8 8125.0 8126.2 8135.0 7242.7 7320.6 7392.8 7399.8 7427.6 7134.8 7172.2 7232.9 7309.9 7405.1 6790.8 6829.8 6877.1 6880.7 6884.2 5124.2 5145.6 5200.0 5348.7 5416.6 5212.8 5217.0 5287.9 5305.7 5329.4 15:57:25 INFO - PROCESS | 19703 | 15:57:25 INFO - PROCESS | 19703 | [#4] prototype.html Cycles:180 Average:4768.65 Median:5514.22 stddev:1396.14 (25.3%) stddev-sans-first:1360.24 15:57:25 INFO - PROCESS | 19703 | Values: 357.7 358.3 360.4 360.8 368.3 5395.8 5424.2 5434.2 5444.6 5486.2 5066.9 5351.9 5367.8 5382.8 5408.4 4013.7 4255.4 4256.2 4279.5 4317.7 4273.3 4279.7 4282.6 4290.8 4295.7 4013.8 4253.9 4265.4 4267.4 4277.3 4015.9 4069.3 4219.1 4265.5 4266.2 3790.5 3797.1 3802.5 3814.4 3817.7 5208.3 5222.8 5245.8 5248.9 5268.9 4574.2 4763.5 4818.0 4824.8 4831.4 5541.6 5579.2 5586.0 5589.6 5612.8 4116.4 4121.6 4124.7 4129.3 4129.7 5584.3 5785.4 5819.3 5821.4 5842.4 4180.6 4187.7 4187.8 4190.8 4193.2 4213.5 4235.7 4237.8 4241.8 4269.0 4592.8 4788.4 4807.4 4817.1 4830.2 5611.2 5617.9 5636.4 5639.2 5659.5 1393.7 1397.0 1411.8 1415.6 1417.6 952.2 985.7 989.9 996.5 1003.3 5179.8 5388.8 5521.8 5551.6 5585.6 5811.5 5812.9 5824.3 5835.2 5842.4 5328.6 5515.6 5530.8 5553.2 5559.9 2946.9 2956.8 2966.7 2968.2 2982.6 5800.6 5807.2 5816.0 5835.2 5837.8 5533.9 5894.7 5900.0 5922.0 5926.9 6052.4 6056.3 6060.3 6065.5 6085.1 5612.7 5791.2 5804.4 5804.8 5861.5 5747.6 5754.9 5764.0 5774.6 5796.3 5928.5 6067.5 6068.8 6077.9 6083.9 4126.8 4181.0 4201.6 4206.9 4217.2 5784.9 5815.4 5834.4 5850.2 5866.6 5618.2 5731.9 5760.9 5763.3 5765.5 5629.1 5651.2 5651.4 5657.9 5682.3 5375.5 5560.8 5590.4 5597.1 5598.3 5512.9 5578.1 5626.5 5667.6 5702.8 5555.2 5557.6 5559.6 5560.3 5581.0 15:57:25 INFO - PROCESS | 19703 | 15:57:25 INFO - PROCESS | 19703 | [#5] yui.html Cycles:180 Average:17655.45 Median:24851.49 stddev:23403.35 (94.2%) stddev-sans-first:23434.85 15:57:25 INFO - PROCESS | 19703 | Values: 819.1 828.1 843.8 864.9 872.9 15008.3 16176.6 16369.0 16423.7 16436.6 13802.2 13951.2 13976.7 13998.4 14310.4 838.6 853.1 853.5 854.6 855.5 733.1 752.3 838.2 856.3 866.9 903.6 904.2 904.6 905.2 905.8 890.3 896.5 896.6 896.8 897.3 553.4 571.8 648.3 654.4 660.3 14787.0 14798.9 14815.8 14860.0 14948.1 13570.9 13868.4 13964.2 14002.5 14024.3 12809.8 12896.5 12899.7 13029.9 13136.7 4347.3 4403.1 4425.5 4466.4 4572.0 62646.0 63889.4 64002.7 64726.7 65051.0 10545.5 11115.1 11204.9 11386.1 11439.6 20537.6 20652.9 20793.0 20814.3 20982.3 8415.2 8531.8 8532.8 8626.4 8629.6 4606.9 4767.2 4810.5 4915.0 4983.9 3403.1 3495.8 3501.1 3504.9 3505.3 619.5 625.1 630.0 635.3 641.1 645.5 648.5 719.8 726.0 733.5 7491.1 7680.2 7897.1 9023.9 9265.2 655.1 670.2 687.9 703.9 730.0 4159.7 4220.3 4355.3 4384.7 4532.4 91595.5 93567.5 94141.0 94270.5 97444.5 50750.5 65648.0 80581.0 85023.6 86333.6 56970.0 61389.0 65007.7 67779.7 75864.6 9573.8 9978.6 10004.5 10065.2 10095.6 37920.8 44312.6 44451.0 45170.5 46410.1 35640.8 56707.0 59269.7 59749.0 59855.4 12107.1 12260.9 12405.8 12555.2 12964.2 12237.4 12728.2 12732.6 12786.9 12875.6 12650.7 12719.4 13144.9 13178.0 13456.9 13077.9 13294.7 13444.1 13459.6 13670.5 12298.3 12335.9 12473.1 12886.1 12916.8 10203.3 10640.4 10847.9 10937.9 11153.2 10646.2 10839.3 11208.8 11235.3 11238.8 15:57:25 INFO - PROCESS | 19703 | -------- Summary: end -------- 15:57:25 INFO - PROCESS | 19703 | 15:57:26 INFO - TEST-INFO | 19703: exit 0 15:57:26 INFO - TEST-OK | dromaeo_css | took 1115648ms 15:57:26 INFO - TEST-START | kraken 15:57:26 INFO - operating with platform_type : linux_ 15:57:26 INFO - Initialising browser for kraken test... 15:57:26 INFO - TEST-INFO | started process 20024 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqQoqgg/profile http://localhost:57482/getInfo.html) 15:57:29 ERROR - PROCESS | 20024 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5373: TypeError: parent.firstChild is null 15:57:30 INFO - PROCESS | 20024 | __metrics Screen width/height:1600/1200 15:57:30 INFO - PROCESS | 20024 | colorDepth:24 15:57:30 INFO - PROCESS | 20024 | Browser inner width/height: 1024/697 15:57:30 INFO - PROCESS | 20024 | __metrics 15:57:31 INFO - PROCESS | 20024 | 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" 15:57:31 INFO - PROCESS | 20024 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:57:31 INFO - PROCESS | 20024 | console.error: PushService: 15:57:31 INFO - PROCESS | 20024 | stateChangeProcessEnqueue: Error transitioning state 15:57:31 INFO - PROCESS | 20024 | UnknownError 15:57:32 INFO - TEST-INFO | 20024: exit 0 15:57:32 INFO - Browser initialized. 15:57:32 INFO - Running cycle 1/1 for kraken test... 15:57:32 INFO - TEST-INFO | started process 20117 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqQoqgg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:57:44 INFO - PROCESS | 20117 | RSS: Main: 144543744 15:57:44 INFO - PROCESS | 20117 | 15:57:46 INFO - PROCESS | 20117 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57482/tests/kraken/driver.html?testName=audio-beat-detection) 15:57:47 INFO - PROCESS | 20117 | RSS: Main: 186392576 15:57:47 INFO - PROCESS | 20117 | 15:57:50 INFO - PROCESS | 20117 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57482/tests/kraken/driver.html?testName=audio-dft) 15:57:50 INFO - PROCESS | 20117 | RSS: Main: 175640576 15:57:50 INFO - PROCESS | 20117 | 15:57:53 INFO - PROCESS | 20117 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57482/tests/kraken/driver.html?testName=audio-fft) 15:57:54 INFO - PROCESS | 20117 | RSS: Main: 266719232 15:57:54 INFO - PROCESS | 20117 | 15:57:56 INFO - PROCESS | 20117 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57482/tests/kraken/driver.html?testName=audio-oscillator) 15:57:56 INFO - PROCESS | 20117 | RSS: Main: 173113344 15:57:56 INFO - PROCESS | 20117 | 15:57:58 INFO - PROCESS | 20117 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57482/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:57:59 INFO - PROCESS | 20117 | RSS: Main: 175763456 15:57:59 INFO - PROCESS | 20117 | 15:58:02 INFO - PROCESS | 20117 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57482/tests/kraken/driver.html?testName=imaging-darkroom) 15:58:02 INFO - PROCESS | 20117 | RSS: Main: 214761472 15:58:02 INFO - PROCESS | 20117 | 15:58:06 INFO - PROCESS | 20117 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57482/tests/kraken/driver.html?testName=imaging-desaturate) 15:58:06 INFO - PROCESS | 20117 | RSS: Main: 212848640 15:58:06 INFO - PROCESS | 20117 | 15:58:09 INFO - PROCESS | 20117 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57482/tests/kraken/driver.html?testName=json-parse-financial) 15:58:10 INFO - PROCESS | 20117 | RSS: Main: 212447232 15:58:10 INFO - PROCESS | 20117 | 15:58:11 INFO - PROCESS | 20117 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57482/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:58:12 INFO - PROCESS | 20117 | RSS: Main: 174149632 15:58:12 INFO - PROCESS | 20117 | 15:58:13 INFO - PROCESS | 20117 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57482/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:58:14 INFO - PROCESS | 20117 | RSS: Main: 180490240 15:58:14 INFO - PROCESS | 20117 | 15:58:16 INFO - PROCESS | 20117 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57482/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:58:17 INFO - PROCESS | 20117 | RSS: Main: 190513152 15:58:17 INFO - PROCESS | 20117 | 15:58:19 INFO - PROCESS | 20117 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57482/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:58:20 INFO - PROCESS | 20117 | RSS: Main: 198574080 15:58:20 INFO - PROCESS | 20117 | 15:58:23 INFO - PROCESS | 20117 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57482/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:58:23 INFO - PROCESS | 20117 | RSS: Main: 195559424 15:58:23 INFO - PROCESS | 20117 | 15:58:25 INFO - PROCESS | 20117 | Cycle 1(1): loaded http://localhost:57482/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57482/tests/kraken/driver.html?testName=ai-astar) 15:58:25 INFO - PROCESS | 20117 | RSS: Main: 246595584 15:58:25 INFO - PROCESS | 20117 | 15:58:25 INFO - PROCESS | 20117 | __start_tp_report 15:58:25 INFO - PROCESS | 20117 | _x_x_mozilla_page_load 15:58:25 INFO - PROCESS | 20117 | _x_x_mozilla_page_load_details 15:58:25 INFO - PROCESS | 20117 | |i|pagename|runs| 15:58:25 INFO - PROCESS | 20117 | |0;ai-astar;100;112;111;111;112;110;110;112;111;110 15:58:25 INFO - PROCESS | 20117 | |1;audio-beat-detection;152;121;123;161;123;126;123;119;163;120 15:58:25 INFO - PROCESS | 20117 | |2;audio-dft;160;161;159;160;158;159;159;160;159;159 15:58:25 INFO - PROCESS | 20117 | |3;audio-fft;75;75;75;109;74;75;75;76;96;74 15:58:25 INFO - PROCESS | 20117 | |4;audio-oscillator;82;81;110;82;82;82;110;83;82;114 15:58:25 INFO - PROCESS | 20117 | |5;imaging-gaussian-blur;116;116;117;116;117;116;117;116;117;117 15:58:25 INFO - PROCESS | 20117 | |6;imaging-darkroom;148;145;147;145;145;145;146;145;146;145 15:58:25 INFO - PROCESS | 20117 | |7;imaging-desaturate;85;84;84;84;84;84;84;83;84;85 15:58:25 INFO - PROCESS | 20117 | |8;json-parse-financial;51;51;49;50;50;49;51;51;50;50 15:58:25 INFO - PROCESS | 20117 | |9;json-stringify-tinderbox;59;59;59;60;59;61;59;59;59;59 15:58:25 INFO - PROCESS | 20117 | |10;stanford-crypto-aes;76;83;76;75;82;80;75;83;76;77 15:58:25 INFO - PROCESS | 20117 | |11;stanford-crypto-ccm;126;126;125;125;134;124;124;124;178;128 15:58:25 INFO - PROCESS | 20117 | |12;stanford-crypto-pbkdf2;160;154;152;153;156;153;151;150;157;153 15:58:25 INFO - PROCESS | 20117 | |13;stanford-crypto-sha256-iterative;61;63;62;64;62;61;59;61;61;61 15:58:25 INFO - PROCESS | 20117 | __end_tp_report 15:58:25 INFO - PROCESS | 20117 | __start_cc_report 15:58:25 INFO - PROCESS | 20117 | _x_x_mozilla_cycle_collect,1620 15:58:25 INFO - PROCESS | 20117 | __end_cc_report 15:58:25 INFO - PROCESS | 20117 | __startTimestamp1479772705472__endTimestamp 15:58:25 INFO - PROCESS | 20117 | 15:58:25 INFO - PROCESS | 20117 | ------- Summary: start ------- 15:58:25 INFO - PROCESS | 20117 | Number of tests: 14 15:58:25 INFO - PROCESS | 20117 | 15:58:25 INFO - PROCESS | 20117 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:3.57 (3.2%) stddev-sans-first:0.87 15:58:25 INFO - PROCESS | 20117 | Values: 100.0 112.0 111.0 111.0 112.0 110.0 110.0 112.0 111.0 110.0 15:58:25 INFO - PROCESS | 20117 | 15:58:25 INFO - PROCESS | 20117 | [#1] audio-beat-detection Cycles:10 Average:133.10 Median:124.50 stddev:17.96 (14.4%) stddev-sans-first:17.70 15:58:25 INFO - PROCESS | 20117 | Values: 152.0 121.0 123.0 161.0 123.0 126.0 123.0 119.0 163.0 120.0 15:58:25 INFO - PROCESS | 20117 | 15:58:25 INFO - PROCESS | 20117 | [#2] audio-dft Cycles:10 Average:159.40 Median:159.50 stddev:0.84 (0.5%) stddev-sans-first:0.87 15:58:25 INFO - PROCESS | 20117 | Values: 160.0 161.0 159.0 160.0 158.0 159.0 159.0 160.0 159.0 159.0 15:58:25 INFO - PROCESS | 20117 | 15:58:25 INFO - PROCESS | 20117 | [#3] audio-fft Cycles:10 Average:80.40 Median:75.00 stddev:12.06 (16.1%) stddev-sans-first:12.63 15:58:25 INFO - PROCESS | 20117 | Values: 75.0 75.0 75.0 109.0 74.0 75.0 75.0 76.0 96.0 74.0 15:58:25 INFO - PROCESS | 20117 | 15:58:25 INFO - PROCESS | 20117 | [#4] audio-oscillator Cycles:10 Average:90.80 Median:82.00 stddev:14.22 (17.3%) stddev-sans-first:14.72 15:58:25 INFO - PROCESS | 20117 | Values: 82.0 81.0 110.0 82.0 82.0 82.0 110.0 83.0 82.0 114.0 15:58:25 INFO - PROCESS | 20117 | 15:58:25 INFO - PROCESS | 20117 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 15:58:25 INFO - PROCESS | 20117 | Values: 116.0 116.0 117.0 116.0 117.0 116.0 117.0 116.0 117.0 117.0 15:58:25 INFO - PROCESS | 20117 | 15:58:25 INFO - PROCESS | 20117 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:145.50 stddev:1.06 (0.7%) stddev-sans-first:0.73 15:58:25 INFO - PROCESS | 20117 | Values: 148.0 145.0 147.0 145.0 145.0 145.0 146.0 145.0 146.0 145.0 15:58:25 INFO - PROCESS | 20117 | 15:58:25 INFO - PROCESS | 20117 | [#7] imaging-desaturate Cycles:10 Average:84.10 Median:84.00 stddev:0.57 (0.7%) stddev-sans-first:0.50 15:58:25 INFO - PROCESS | 20117 | Values: 85.0 84.0 84.0 84.0 84.0 84.0 84.0 83.0 84.0 85.0 15:58:25 INFO - PROCESS | 20117 | 15:58:25 INFO - PROCESS | 20117 | [#8] json-parse-financial Cycles:10 Average:50.20 Median:50.50 stddev:0.79 (1.6%) stddev-sans-first:0.78 15:58:25 INFO - PROCESS | 20117 | Values: 51.0 51.0 49.0 50.0 50.0 49.0 51.0 51.0 50.0 50.0 15:58:25 INFO - PROCESS | 20117 | 15:58:25 INFO - PROCESS | 20117 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.00 stddev:0.67 (1.1%) stddev-sans-first:0.71 15:58:25 INFO - PROCESS | 20117 | Values: 59.0 59.0 59.0 60.0 59.0 61.0 59.0 59.0 59.0 59.0 15:58:25 INFO - PROCESS | 20117 | 15:58:25 INFO - PROCESS | 20117 | [#10] stanford-crypto-aes Cycles:10 Average:78.30 Median:78.50 stddev:3.33 (4.2%) stddev-sans-first:3.43 15:58:25 INFO - PROCESS | 20117 | Values: 76.0 83.0 76.0 75.0 82.0 80.0 75.0 83.0 76.0 77.0 15:58:25 INFO - PROCESS | 20117 | 15:58:25 INFO - PROCESS | 20117 | [#11] stanford-crypto-ccm Cycles:10 Average:131.40 Median:126.00 stddev:16.65 (13.2%) stddev-sans-first:17.54 15:58:25 INFO - PROCESS | 20117 | Values: 126.0 126.0 125.0 125.0 134.0 124.0 124.0 124.0 178.0 128.0 15:58:25 INFO - PROCESS | 20117 | 15:58:25 INFO - PROCESS | 20117 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.90 Median:153.50 stddev:3.00 (2.0%) stddev-sans-first:2.22 15:58:25 INFO - PROCESS | 20117 | Values: 160.0 154.0 152.0 153.0 156.0 153.0 151.0 150.0 157.0 153.0 15:58:25 INFO - PROCESS | 20117 | 15:58:25 INFO - PROCESS | 20117 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.50 Median:61.50 stddev:1.35 (2.2%) stddev-sans-first:1.42 15:58:25 INFO - PROCESS | 20117 | Values: 61.0 63.0 62.0 64.0 62.0 61.0 59.0 61.0 61.0 61.0 15:58:25 INFO - PROCESS | 20117 | -------- Summary: end -------- 15:58:25 INFO - PROCESS | 20117 | 15:58:26 INFO - TEST-INFO | 20117: exit 0 15:58:26 INFO - TEST-OK | kraken | took 60179ms 15:58:26 INFO - SUITE-END | took 1175s 15:58:27 INFO - Completed test suite (00:19:36) 15:58:27 INFO - javascript benchmark 15:58:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3183.9681603183967, 3227.3867965086633, 3230.1924518870283, 3235.579374681291, 3245.6916592923662, 5452.863678408042, 5496.31296087989, 5543.805966791163, 5545.140503222002, 5554.694491802949, 5492.203630473589, 5513.09034009388, 5513.173024046385, 5516.007118718629, 5522.116461366182, 4970.875728106799, 4997.5252351026775, 5047.167217409142, 5059.848204553851, 5070.0, 4962.206047032476, 4963.6277279204205, 5042.5713814325645, 5089.974550127245, 5098.413682426512, 4893.804247830082, 4902.436219834711, 4912.238603016538, 5030.496950304977, 5033.395992480908, 5072.163093089635, 5088.974555127238, 5127.8205262816, 5134.537891589737, 5161.66449180802, 4788.80844766209, 4989.550940415344, 5011.949880501221, 5063.215201643751, 5095.006473737622, 5369.704666243355, 5415.458454154553, 5485.670859748428, 5501.642393244466, 5506.476884695948, 5888.705564721747, 5904.084866845646, 5998.7600495980105, 5999.100134979744, 5999.520038396918, 5685.147227915804, 5985.401459854023, 5986.07215881539, 6046.062860256668, 6054.8183554493, 5384.273123128367, 5449.3188351456465, 5482.396936337, 5542.722863856791, 5543.445655434505, 6042.697865106815, 6048.274207095089, 6049.697515124314, 6049.909251361233, 6052.757889684363, 5593.972030139905, 5842.386549412336, 5852.648841069549, 5856.472917437451, 5858.619189752652, 5689.516391106802, 5769.336526299446, 5803.970980145073, 5805.506531944832, 5888.0, 5836.970815145897, 5843.2695913010875, 5844.415558444121, 5848.444397782204, 5864.648121112747, 5791.594588378773, 5860.824175274749, 5863.560232982543, 5864.413558644102, 5889.882202355929, 4453.087117140978, 4490.169318676056, 4516.9774151129695, 4550.0, 4561.612262957686, 4058.736182148151, 4093.8302699569276, 4118.9702574356415, 4120.320147175742, 4136.565660605593, 5614.578906582023, 5621.550275977912, 5621.634593751393, 5622.128570071645, 5630.042892708249, 5706.572007099484, 5778.88442231153, 5868.823935281948, 5929.0, 5932.466078052909, 5567.8886422272135, 5584.664920104807, 5609.635373700697, 5618.775248990077, 5625.043742563774, 5185.533302002837, 5185.9740701297005, 5187.610929180327, 5201.0, 5228.816991405282, 5978.641281523035, 5990.400959903975, 6031.577789554689, 6184.041473571604, 6205.03821907605, 5817.069268916953, 5866.3547009828035, 5895.970520147372, 5900.203472531153, 5936.1095835625, 6107.0228763397645, 6116.0, 6116.143739876332, 6116.388361164026, 6119.785807496716, 5672.773089076556, 5680.545556355564, 5796.1305804129715, 5796.710164491843, 5798.884022319446, 5840.8247752567495, 5893.5874488785375, 5895.14520394549, 5919.526437884872, 5955.67243801595, 5739.167820666064, 5839.620424672553, 5840.094785308284, 5841.1530328101335, 5852.824415267549, 5686.061799802987, 5799.4780469757925, 5802.564807639528, 5803.65178089316, 5811.622244554091, 5688.089905615082, 5732.082866741302, 5785.132230165509, 5803.129530570448, 5834.445727655866, 5888.3228428731245, 5905.43898329658, 5905.940940590539, 5918.171455996078, 5926.111083337361, 5483.8080667176455, 5531.197976293495, 5701.6864072474755, 5744.885102297847, 5754.424557544212], "value": 5447.566660928191, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.2845456997034, 620.3269452643881, 651.1957732200733, 667.136058803849, 676.5467137018197, 34279.82860085699, 36413.0, 36413.81793091031, 36437.0, 36469.63530364696, 36918.261634767354, 46608.30087548681, 47441.525584744144, 47527.28709069358, 49762.751186244015, 8807.295416366675, 8930.55347232639, 8932.508712020835, 8934.463932164059, 8935.910640893573, 8349.749507514754, 8620.612072456723, 8766.956165219164, 8867.37928345013, 8867.467951922874, 10615.097716694052, 10885.510152043176, 10886.727831804228, 11189.720256993558, 11194.328340299608, 10670.519826607782, 10682.038616524473, 10694.786104277871, 10746.301490403099, 10750.139988800955, 8234.670613175465, 8512.914870851275, 8519.57402129891, 10616.57533698651, 10701.411422371766, 35353.64646353529, 43521.782391088156, 44574.0, 44635.55364446346, 47219.0, 3729.701623870084, 3734.9439758403646, 3742.251549690073, 3864.0, 3960.425738267964, 33197.0, 33425.6657433425, 33472.0, 33631.32737345264, 33682.831585842156, 4223.450951376332, 4276.2089013532595, 4290.678199135077, 4317.11499142675, 4370.847020354304, 270412.0, 270538.0, 270660.64669676725, 270802.0, 272697.0, 55179.17231241534, 56963.715181423824, 62332.68833655893, 62638.686806565674, 62745.490180393186, 53127.0, 54139.729301354026, 54358.72820635871, 54383.45616543863, 54449.72775136099, 17474.563135921704, 17630.118494075246, 17836.01901895408, 17865.196066177054, 17915.0, 14808.407663693331, 14832.406703731946, 14901.0, 14905.180215088274, 14960.326785294688, 15727.764083538756, 16047.944897357294, 16559.42042028523, 17263.0, 17361.3923512679, 6744.831379215559, 6746.595204287759, 6953.374196322356, 6954.478414118961, 6987.196472405637, 963.3160456076264, 1046.9214808889365, 1085.8588383510094, 1124.3029321820525, 1153.1005815463952, 33329.333413331595, 33451.16372090717, 33703.47409923863, 33916.660833391354, 33980.32039359248, 1019.4851599942131, 1047.177965297238, 1048.9475526223812, 1084.4957094950885, 1149.0348107589664, 16470.83529164693, 17630.735538966925, 17688.380906668204, 17731.73402398965, 17779.0, 166623.0, 167492.0, 535544.0, 538650.0, 540085.0, 63031.369686303464, 63245.68377158085, 63464.36535634677, 63475.36524634787, 63495.36504634987, 1296.2546535741985, 1367.924764137962, 1394.769862972598, 1422.5447856685762, 1448.7609544425263, 32821.17947051343, 34568.48147277743, 35136.64863351334, 35196.296074078884, 35196.648033519334, 51895.481045189066, 52322.0, 52403.73798130985, 52435.47564524306, 52620.73689631528, 390805.0, 392299.0, 392414.0, 571036.0, 577819.0, 30468.695313046584, 30727.078187654406, 30745.077647670605, 30989.69010309868, 31105.0, 48845.2673209895, 49624.0, 49952.25071623856, 51400.22899656583, 52089.739551302, 41902.0, 42131.789341054326, 42181.15637687167, 42185.57814421816, 44036.11927761491, 41748.16503669849, 42093.36859947042, 42286.1542769149, 42803.0, 43980.78009609931, 42698.359524607775, 43649.78175109104, 43875.561244388424, 44274.3358849624, 44412.0, 35960.28079438449, 38160.23679526449, 38210.617893821815, 38968.220635586564, 39005.0, 28731.0, 28866.422671546872, 28911.7108828909, 28914.855425722737, 29170.416591668472], "value": 20428.29389094765, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.7204584744831, 432.6765270497429, 435.4034972088239, 438.7893810970735, 448.61643294982787, 16624.58438539037, 19029.809701902977, 20416.979151042462, 21145.94270286487, 21305.25431609894, 18083.30375931584, 18291.176897039633, 18385.08074596268, 18715.81284187158, 19549.90225048876, 5409.350877894648, 5822.184894114827, 5857.589968702193, 5861.6189947653265, 5864.970675146639, 5479.260299859528, 5674.347450043236, 5708.714564271791, 5714.828555143353, 5716.657000579979, 5685.317761868561, 5686.317641882959, 5689.175069614904, 5692.88988647214, 5694.316681998145, 5509.201165830972, 5693.658380497183, 5704.828855134353, 5725.969325521404, 5726.885462290752, 5093.28693982839, 5167.48325167484, 5177.326947496839, 5181.1969144782615, 5182.611304152204, 24042.0, 24169.154079607128, 24351.02595896162, 24471.26586202399, 24528.386790330205, 2230.710007699005, 2273.59075366434, 2394.114177754225, 2399.436132508859, 2491.2152671908293, 14860.405583776635, 15486.45797397097, 15521.223938803014, 15560.37758489659, 15782.763258551131, 1813.1478205243513, 1878.5021969178179, 1896.6680830854684, 1945.8929758863258, 1961.0096901065015, 88935.0, 88955.55522222412, 90025.54987225022, 91439.54280228556, 92065.53967230188, 10112.191024718006, 11020.173486988508, 11367.374794386224, 11796.587119450778, 11868.347240901661, 13196.868031319564, 14291.213983231022, 15149.697006059818, 15689.293981770848, 15784.21078946071, 8043.316318112909, 8175.264226219669, 8313.958430207811, 8948.955255223682, 9077.137671921157, 8594.527300998505, 8604.35467339952, 8634.870476942851, 8804.691835785718, 8954.328425368123, 6878.8624227516175, 6968.44252459802, 7007.649617519103, 7100.325469080429, 7109.786706398816, 2001.7097520859393, 2037.9286724964852, 2059.783722709124, 2085.4056593870673, 2112.8309735221146, 958.8034452937131, 1002.283367392318, 1028.321307936758, 1084.6821112348534, 1099.378850949211, 19356.612867742566, 20952.790472095083, 21119.26082587102, 21264.681029784566, 21402.464938376354, 995.8058178655093, 1008.5511947183579, 1036.5542816588938, 1068.8289873620183, 1095.1567293184203, 11245.718857028476, 11875.346855923008, 11999.820002699966, 12003.759924801456, 12045.879541204651, 518950.0, 524128.0, 533838.0, 534837.0, 539539.0, 52383.0, 76180.61909690416, 87101.0, 87645.68531472034, 88462.55768721116, 1041.6562534363793, 1071.7159952612565, 1099.2195541165702, 1100.7853468573712, 1107.684309971654, 17744.55638609045, 18126.64050196267, 18475.260989560265, 18599.2560297592, 18650.253989840254, 39570.80214599024, 40587.59412405838, 40630.79684601676, 40770.1845963085, 41635.7918210407, 52147.217791733914, 53911.46088539065, 53966.46033539614, 54696.45303546914, 54761.0, 9295.163435290857, 9356.953215234153, 9366.906330936876, 9469.905300946903, 9506.572204250688, 12604.810927836274, 13542.796858047333, 13646.181229126285, 13711.382987765774, 14613.0, 12229.532456105324, 12456.937715311366, 12485.93757031209, 12653.620391388273, 13002.764737349937, 11937.462814173557, 12254.0, 12366.319852408204, 12553.435095420911, 12571.994240460559, 12567.937160314506, 12788.616341509769, 12790.296533690736, 12893.290869002294, 13051.412686429323, 9098.272138229058, 9138.17756401927, 9235.215006724235, 9356.672516461891, 9391.953040235028, 9420.528973551158, 11979.940100299791, 12684.87315126837, 12708.0, 12780.744385112059], "value": 9682.746733893326, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1349.7637913365159, 1514.7500662390705, 1532.7125214819553, 1686.2580464595576, 1846.326090976794, 7363.447741419395, 7758.418118641103, 8324.0, 8564.057953625112, 8572.614232359543, 8537.231649151576, 8599.957000215007, 8605.870911936327, 8606.741797746077, 8608.39741218115, 2454.239185852387, 2484.1553871683623, 2484.291976786616, 2486.502699460106, 2488.2908371114236, 2413.1071503543712, 2510.8870100845506, 2514.0697941761573, 2516.55960206964, 2519.962200566993, 2426.5389575980594, 2438.780509754122, 2463.261021693485, 2467.6915385576804, 2467.7778999890006, 2376.192094687806, 2400.195934361991, 2401.0, 2402.315340128055, 2434.4035711250767, 2371.4664200554907, 2387.9880600596885, 2425.296663967465, 2427.0655797517907, 2434.3062227265323, 8543.530105844176, 8553.871691924625, 8625.396222264444, 8637.65449382024, 8679.609417576225, 5315.202719592054, 5476.534494567966, 5476.616636835423, 5479.342478902558, 5537.698640819404, 3546.4325707886615, 3569.428891377393, 3687.520622319108, 3711.294853977736, 3712.870049548253, 1206.9637910862689, 1221.3404761428817, 1224.8285240066398, 1251.2930194440112, 1251.386820457978, 11841.0, 12100.757984840342, 12111.031117510665, 12125.09061820367, 12133.575324863587, 4589.426321709786, 4753.809847606057, 4801.927971080437, 4804.543568361, 4821.4696383397795, 10314.587416503256, 10324.12244959172, 10341.224408169417, 10341.327813692085, 10344.120749736358, 5445.346558412936, 5447.591430642718, 5448.237246785453, 5450.046241907729, 5452.018636645442, 4196.790160491963, 4360.41134446852, 4517.796699148546, 4929.876753081202, 4990.650654454226, 4165.58344165581, 4174.624283814472, 4262.104957958802, 4291.485021797404, 4327.6321512671775, 1341.805438211454, 1360.3742278551977, 1362.0601784768478, 1373.8488766235705, 1379.6137081617164, 873.2839071960931, 883.9955800220957, 945.4705364995624, 977.4721650308753, 1053.8682664666917, 5800.8259752207505, 5976.342602313742, 6010.156745447146, 6071.51427885768, 6100.3899610039525, 471.76176031104075, 475.14948242645966, 475.5173498898621, 482.96860704054126, 484.138233943581, 4114.300568903293, 4200.810963506649, 4238.745675259433, 4246.150769846043, 4281.272183728774, 10269.94865025685, 10492.108170805566, 10608.681739547827, 10612.787744245072, 10614.203934704929, 9921.702348929544, 10487.632932847313, 10541.20799464093, 10561.577536898592, 10566.52450639723, 7890.684372625031, 8245.917540824636, 8248.917510824935, 8251.95874020626, 8252.628631711588, 5967.224260846062, 5979.103134529855, 6068.939310606837, 6115.327313995368, 6321.52588555851, 9617.663381781604, 9704.514774261399, 9751.658691945748, 9768.804623907625, 9828.213742900407, 9826.4104153751, 9848.162906153057, 9872.901270987486, 9958.701238962843, 10006.549705263425, 7307.963460182665, 7354.103985876704, 7420.962895185489, 7423.703051877865, 7543.924560754542, 8059.83880322402, 8070.83858322842, 8125.0, 8126.228008339198, 8134.959325203573, 7242.746503872339, 7320.633968301457, 7392.778216653509, 7399.778006659809, 7427.554346739213, 7134.785956421316, 7172.175199852084, 7232.891506627299, 7309.853802924018, 7405.148407932941, 6790.7623233186605, 6829.795106146824, 6877.105976223059, 6880.69036893331, 6884.173899132136, 5124.180131178993, 5145.614078944169, 5199.960007998491, 5348.679079255257, 5416.620836541404, 5212.765425555935, 5217.0, 5287.867803304948, 5305.734713264398, 5329.413764485826], "value": 4585.336954672044, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.67094273268594, 358.34065319811543, 360.38194496438604, 360.7889384709945, 368.28185039173616, 5395.838124856251, 5424.186372044191, 5434.212039254306, 5444.564434845212, 5486.204500347447, 5066.947886106123, 5351.919721204185, 5367.838964831061, 5382.811601593945, 5408.4315548490895, 4013.73224128368, 4255.3616757610325, 4256.21260066887, 4279.5078565965005, 4317.676174286926, 4273.337632666926, 4279.679024073192, 4282.593153650414, 4290.806913688876, 4295.677824163185, 4013.8193781279765, 4253.893652658693, 4265.44549208604, 4267.423897773808, 4277.294246449348, 4015.8996025099314, 4069.308217603015, 4219.11398606293, 4265.488141423018, 4266.189424009428, 3790.5261842269715, 3797.126660867988, 3802.4866643003393, 3814.370628846237, 3817.7136714746507, 5208.250059956825, 5222.76497557607, 5245.79016839326, 5248.876918233645, 5268.92096618551, 4574.222382195035, 4763.54746299101, 4817.975910120462, 4824.758762061883, 4831.420229572439, 5541.5843811714285, 5579.210394802599, 5586.0, 5589.552835773128, 5612.803551875665, 4116.382542618631, 4121.649659778893, 4124.670026397881, 4129.256733787947, 4129.666738292855, 5584.274044374246, 5785.363610002896, 5819.301683797929, 5821.380378829502, 5842.386549412336, 4180.561041090642, 4187.748735075906, 4187.832486700559, 4190.832366705297, 4193.22425351311, 4213.494380674339, 4235.729281215623, 4237.809298581571, 4241.766702831313, 4268.957310426918, 4592.770361481913, 4788.425388953278, 4807.4471435784635, 4817.13291607514, 4830.178869592178, 5611.186377975252, 5617.915731264035, 5636.408177141423, 5639.182318563785, 5659.547236221175, 1393.658553654341, 1396.9790453143007, 1411.788231765223, 1415.5965549818252, 1417.5888992192356, 952.1953948913157, 985.7387792235063, 989.9208063354914, 996.4868092932146, 1003.3027046202965, 5179.766910489037, 5388.757505912244, 5521.806736764194, 5551.611387202857, 5585.636933599303, 5811.506021988093, 5812.854678633068, 5824.301083869963, 5835.241418615553, 5842.357340692605, 5328.600354973392, 5515.586331025189, 5530.778768849201, 5553.194786755897, 5559.8888022240135, 2946.9263268418463, 2956.817273090781, 2966.7329940305476, 2968.228260652246, 2982.597349357852, 5800.622959507618, 5807.186993820868, 5815.9709201453725, 5835.2414186156375, 5837.824865254049, 5533.916991245134, 5894.705264736746, 5899.970500147472, 5922.0, 5926.940730592639, 6052.365861217447, 6056.3338032816355, 6060.303065147476, 6065.5450841187085, 6085.117657939485, 5612.747426365905, 5791.247137872049, 5804.448577385142, 5804.76780928775, 5861.501772349227, 5747.626404283708, 5754.9424505754405, 5764.0, 5774.624649397776, 5796.333421656564, 5928.4960778334325, 6067.514598831995, 6068.848278792889, 6077.908831367621, 6083.908741368795, 4126.7730274833975, 4181.0, 4201.626081264076, 4206.894827629334, 4217.1776503581505, 5784.900868834908, 5815.41845815415, 5834.38738932406, 5850.180974663465, 5866.5893387462465, 5618.241537392563, 5731.8853622928145, 5760.884782304414, 5763.308402991668, 5765.509931655689, 5629.099344104923, 5651.180578815966, 5651.378348381592, 5657.943420565742, 5682.346530149086, 5375.462453754593, 5560.774750644536, 5590.357108932525, 5597.069011191133, 5598.272224610774, 5512.862178445571, 5578.135389014709, 5626.521745651666, 5667.583104223944, 5702.800401985911, 5555.194496798023, 5557.582816381797, 5559.555235581225, 5560.277163968658, 5580.972095139498], "value": 4329.259708698514, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [819.082627457248, 828.1428721273484, 843.7806170395697, 864.913508649135, 872.9393786549341, 15008.324625391857, 16176.595585110379, 16369.0, 16423.671526569477, 16436.589085272888, 13802.171869687802, 13951.162930224194, 13976.650583735413, 13998.370073346698, 14310.427582896698, 838.6226198210799, 853.1042405474258, 853.4580541356221, 854.5556310718423, 855.4696088425185, 733.1458850439232, 752.3191511681937, 838.1953324808192, 856.2807241916788, 866.9176428239339, 903.5888670654837, 904.1500989070286, 904.6019751309403, 905.1988989744058, 905.8052518708477, 890.3144578674385, 896.4531635702216, 896.6323807239033, 896.753392816974, 897.349421669291, 553.3774503683356, 571.8456016875421, 648.2706954675989, 654.3848782144769, 660.2605082307798, 14787.0, 14798.926005370013, 14815.777763333559, 14860.03409778361, 14948.103113813206, 13570.864291357157, 13868.375923083486, 13964.231967241798, 14002.509912153026, 14024.298785060706, 12809.807852882213, 12896.484140634364, 12899.742005159844, 13029.934850325688, 13136.737265254736, 4347.260965635849, 4403.119376124788, 4425.468943726742, 4466.39703640011, 4571.9542804571865, 62646.0, 63889.36110638881, 64002.67998660023, 64726.676366618805, 65051.0, 10545.47272636365, 11115.110791136689, 11204.887951120385, 11386.089112871116, 11439.59961401347, 20537.58924821495, 20652.896735516228, 20793.0, 20814.27150049741, 20982.2656207032, 8415.158484151536, 8531.786705332292, 8532.829343413097, 8626.39615226928, 8629.568521573896, 4606.907861842745, 4767.237242041326, 4810.470848206694, 4914.975425122851, 4983.875403114951, 3403.1322012886553, 3495.7727747696317, 3501.124718820295, 3504.9299014019575, 3505.316463289685, 619.4734475695623, 625.1217040058725, 629.9748010079545, 635.2821311917504, 641.1280658304702, 645.5287640022809, 648.4974145037634, 719.7624783821326, 725.9963700181465, 733.4938892164496, 7491.10106787189, 7680.155182929873, 7897.131315555284, 9023.864642030374, 9265.180470248759, 655.0861548140317, 670.2024590737008, 687.9380855723009, 703.9225685174627, 729.9781006569812, 4159.688023398257, 4220.277920741105, 4355.259605867011, 4384.671149663788, 4532.4334458192725, 91595.54202228946, 93567.53216233876, 94141.0, 94270.52864735632, 97444.51277743567, 50750.49249507531, 65648.0, 80580.95642826811, 85023.57488212643, 86333.56833215794, 56970.0, 61389.0, 65007.67496162489, 67779.66110169418, 75864.62067689736, 9573.760655983377, 9978.60085596568, 10004.547067141508, 10065.245106616887, 10095.646652367132, 37920.810395948945, 44312.55687443084, 44451.0, 45170.54829451664, 46410.07179856452, 35640.82179589086, 56707.0, 59269.70365148319, 59749.0, 59855.401445984986, 12107.091968102251, 12260.932698141154, 12405.75188496243, 12555.246685198917, 12964.157329773534, 12237.388130593257, 12728.1726687765, 12732.618021459, 12786.936065319614, 12875.613731588068, 12650.746985060432, 12719.427625756678, 13144.934275328562, 13178.0, 13456.86543134556, 13077.869221307665, 13294.734105318033, 13444.058915875794, 13459.596212113653, 13670.52153174634, 12298.262104273414, 12335.876641233473, 12473.064520161206, 12886.09797314179, 12916.8062479061, 10203.28576999603, 10640.395064663433, 10847.891521084688, 10937.85107625928, 11153.163512736739, 10646.183274552961, 10839.295445795999, 11208.775824483302, 11235.269707469315, 11238.831417528907], "value": 7216.345309251479, "unit": "score"}], "name": "dromaeo_css", "value": 7324.254857447376, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 112.0, 111.0, 111.0, 112.0, 110.0, 110.0, 112.0, 111.0, 110.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 121.0, 123.0, 161.0, 123.0, 126.0, 123.0, 119.0, 163.0, 120.0], "value": 133.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 159.0, 160.0, 158.0, 159.0, 159.0, 160.0, 159.0, 159.0], "value": 159.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 109.0, 74.0, 75.0, 75.0, 76.0, 96.0, 74.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 110.0, 82.0, 82.0, 82.0, 110.0, 83.0, 82.0, 114.0], "value": 90.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 145.0, 147.0, 145.0, 145.0, 145.0, 146.0, 145.0, 146.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0, 83.0, 84.0, 85.0], "value": 84.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 49.0, 50.0, 50.0, 49.0, 51.0, 51.0, 50.0, 50.0], "value": 50.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 60.0, 59.0, 61.0, 59.0, 59.0, 59.0, 59.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 83.0, 76.0, 75.0, 82.0, 80.0, 75.0, 83.0, 76.0, 77.0], "value": 78.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 126.0, 125.0, 125.0, 134.0, 124.0, 124.0, 124.0, 178.0, 128.0], "value": 131.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 154.0, 152.0, 153.0, 156.0, 153.0, 151.0, 150.0, 157.0, 153.0], "value": 153.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 62.0, 64.0, 62.0, 61.0, 59.0, 61.0, 61.0, 61.0], "value": 61.5, "unit": "score"}], "name": "kraken", "value": 1454.5000000000002, "alertThreshold": 2.0}]} 15:58:27 INFO - Return code: 0 15:58:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:58:27 ERROR - # TBPL SUCCESS # 15:58:27 INFO - Running post-action listener: _resource_record_post_action 15:58:27 INFO - [mozharness: 2016-11-21 23:58:27.265699Z] Finished run-tests step (success) 15:58:27 INFO - Running post-run listener: _resource_record_post_run 15:58:27 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 4096; Write bytes: 355913728; Read time: 12; Write time: 327856 15:58:27 INFO - TinderboxPrint: CPU usage
13.0% 15:58:27 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 15:58:27 INFO - TinderboxPrint: I/O write bytes / time
355,913,728 / 327,856 15:58:27 INFO - TinderboxPrint: CPU idle
8,288.0 (87.0%) 15:58:27 INFO - TinderboxPrint: CPU user
1,187.7 (12.5%) 15:58:27 INFO - TinderboxPrint: Swap in / out
0 / 0 15:58:27 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110039040; Read time: 0; Write time: 156372 15:58:27 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 245514240; Read time: 0; Write time: 171484 15:58:27 INFO - Running post-run listener: _upload_blobber_files 15:58:27 INFO - Blob upload gear active. 15:58:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:58:27 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 15:58:27 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'] 15:58:27 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 15:58:28 INFO - (blobuploader) - INFO - Open directory for files ... 15:58:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:58:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:58:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:58:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:58:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:58:29 INFO - (blobuploader) - INFO - Done attempting. 15:58:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:58:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:58:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:58:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:58:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:58:30 INFO - (blobuploader) - INFO - Done attempting. 15:58:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:58:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:58:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:58:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:58:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:58:34 INFO - (blobuploader) - INFO - Done attempting. 15:58:34 INFO - (blobuploader) - INFO - Iteration through files over. 15:58:34 INFO - Return code: 0 15:58:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:58:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:58:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b0218815a2ede3365ccccde4c1f79ff23c5b3f738bfceef429945f175c7ee173ba6aab6034de520303d0a669ef5d3e1de7b75639b6873e7868e168a436ade639", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5656e85c1a568c4f386efcf87565c57b10f4fdea9751f4ee97f20dc61b07bfa192c7e93a191c2dc08d2c9ff1366b303e78a8fc191c839f4559aa39abb9bf0aea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a75ad180fb7968a4cddbe3e1e5249a66f42b6689286a876787cf2953fe9e6e9698950bf245fd3f3a483593f30c5c2875a3614b601cccae4fa9bfe44ac88deac3"} 15:58:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:58:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:58:34 INFO - Contents: 15:58:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b0218815a2ede3365ccccde4c1f79ff23c5b3f738bfceef429945f175c7ee173ba6aab6034de520303d0a669ef5d3e1de7b75639b6873e7868e168a436ade639", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5656e85c1a568c4f386efcf87565c57b10f4fdea9751f4ee97f20dc61b07bfa192c7e93a191c2dc08d2c9ff1366b303e78a8fc191c839f4559aa39abb9bf0aea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a75ad180fb7968a4cddbe3e1e5249a66f42b6689286a876787cf2953fe9e6e9698950bf245fd3f3a483593f30c5c2875a3614b601cccae4fa9bfe44ac88deac3"} 15:58:34 INFO - Running post-run listener: copy_logs_to_upload_dir 15:58:34 INFO - Copying logs to upload dir... 15:58:34 INFO - mkdir: /builds/slave/test/build/upload/logs 15:58:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.855586 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-11-21 15:58:33.841925) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-21 15:58:33.845722) ========= 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=c7c495d6f76fb52e1ad9f659000001da-1479771474.681008-204534780 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/b0218815a2ede3365ccccde4c1f79ff23c5b3f738bfceef429945f175c7ee173ba6aab6034de520303d0a669ef5d3e1de7b75639b6873e7868e168a436ade639", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5656e85c1a568c4f386efcf87565c57b10f4fdea9751f4ee97f20dc61b07bfa192c7e93a191c2dc08d2c9ff1366b303e78a8fc191c839f4559aa39abb9bf0aea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a75ad180fb7968a4cddbe3e1e5249a66f42b6689286a876787cf2953fe9e6e9698950bf245fd3f3a483593f30c5c2875a3614b601cccae4fa9bfe44ac88deac3"} build_url:https://queue.taskcluster.net/v1/task/YhGiLdw7Q-mAX_AQrT5mzw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011905 build_url: 'https://queue.taskcluster.net/v1/task/YhGiLdw7Q-mAX_AQrT5mzw/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/b0218815a2ede3365ccccde4c1f79ff23c5b3f738bfceef429945f175c7ee173ba6aab6034de520303d0a669ef5d3e1de7b75639b6873e7868e168a436ade639", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5656e85c1a568c4f386efcf87565c57b10f4fdea9751f4ee97f20dc61b07bfa192c7e93a191c2dc08d2c9ff1366b303e78a8fc191c839f4559aa39abb9bf0aea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a75ad180fb7968a4cddbe3e1e5249a66f42b6689286a876787cf2953fe9e6e9698950bf245fd3f3a483593f30c5c2875a3614b601cccae4fa9bfe44ac88deac3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-21 15:58:33.872272) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 15:58:33.872645) ========= 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=c7c495d6f76fb52e1ad9f659000001da-1479771474.681008-204534780 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004435 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-21 15:58:33.959087) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-21 15:58:33.959845) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-21 15:58:33.960499) ========= ========= Total master_lag: 0.17 =========