builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-051 starttime: 1483816942.75 results: success (0) buildid: 20170107094256 builduid: d824de7591cc41b99a8f629feb6f525c revision: 4195687bda73679988aaff7b27a8c3b31e38a0fc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-07 11:22:22.751108) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-07 11:22:22.751577) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-07 11:22:22.751865) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-07 11:22:22.766847) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 11:22:22.767254) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1483816942.411184-1103399561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-07 11:22:23-- 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% 46.1M=0s 2017-01-07 11:22:23 (46.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.114395 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 11:22:22.896468) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 11:22:22.896778) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1483816942.411184-1103399561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016156 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 11:22:22.945908) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-07 11:22:22.946267) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4195687bda73679988aaff7b27a8c3b31e38a0fc --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 4195687bda73679988aaff7b27a8c3b31e38a0fc --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=5ac5dba3e01a12f1ff77ab15000001b1-1483816942.411184-1103399561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-07 11:22:23,276 truncating revision to first 12 chars 2017-01-07 11:22:23,276 Setting DEBUG logging. 2017-01-07 11:22:23,276 attempt 1/10 2017-01-07 11:22:23,276 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4195687bda73?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-07 11:22:24,016 unpacking tar archive at: mozilla-aurora-4195687bda73/testing/mozharness/ program finished with exit code 0 elapsedTime=1.084729 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-07 11:22:24.044725) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-07 11:22:24.045061) ========= script_repo_revision: 4195687bda73679988aaff7b27a8c3b31e38a0fc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-07 11:22:24.045445) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-07 11:22:24.045707) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-07 11:22:24.054563) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-07 11:22:24.054931) ========= /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=5ac5dba3e01a12f1ff77ab15000001b1-1483816942.411184-1103399561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:22:24 INFO - MultiFileLogger online at 20170107 11:22:24 in /builds/slave/test 11:22:24 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 11:22:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:22:24 INFO - {'append_to_log': False, 11:22:24 INFO - 'base_work_dir': '/builds/slave/test', 11:22:24 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 11:22:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:22:24 INFO - 'branch': 'Mozilla-Aurora', 11:22:24 INFO - 'buildbot_json_path': 'buildprops.json', 11:22:24 INFO - 'config_files': ('talos/linux_config.py',), 11:22:24 INFO - 'default_actions': ('clobber', 11:22:24 INFO - 'read-buildbot-config', 11:22:24 INFO - 'download-and-extract', 11:22:24 INFO - 'populate-webroot', 11:22:24 INFO - 'create-virtualenv', 11:22:24 INFO - 'install', 11:22:24 INFO - 'run-tests'), 11:22:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:22:24 INFO - 'download_minidump_stackwalk': True, 11:22:24 INFO - 'download_symbols': 'ondemand', 11:22:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:22:24 INFO - 'tooltool.py': '/tools/tooltool.py', 11:22:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:22:24 INFO - '/tools/misc-python/virtualenv.py')}, 11:22:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:22:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:22:24 INFO - 'installer_path': 'installer.exe', 11:22:24 INFO - 'log_level': 'info', 11:22:24 INFO - 'log_name': 'talos', 11:22:24 INFO - 'log_to_console': True, 11:22:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:22:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:22:24 INFO - 'opt_config_files': (), 11:22:24 INFO - 'pip_index': False, 11:22:24 INFO - 'sps_profile': False, 11:22:24 INFO - 'sps_profile_interval': 0, 11:22:24 INFO - 'suite': 'dromaeojs', 11:22:24 INFO - 'system_bits': '32', 11:22:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:22:24 INFO - 'title': 'talos-linux64-ix-051', 11:22:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:22:24 INFO - 'use_talos_json': True, 11:22:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:22:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:22:24 INFO - 'work_dir': 'build'} 11:22:24 INFO - [mozharness: 2017-01-07 19:22:24.483356Z] Running clobber step. 11:22:24 INFO - Running pre-action listener: _resource_record_pre_action 11:22:24 INFO - Running main action method: clobber 11:22:24 INFO - rmtree: /builds/slave/test/build 11:22:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:22:25 INFO - Running post-action listener: _resource_record_post_action 11:22:25 INFO - [mozharness: 2017-01-07 19:22:25.453572Z] Finished clobber step (success) 11:22:25 INFO - [mozharness: 2017-01-07 19:22:25.453670Z] Running read-buildbot-config step. 11:22:25 INFO - Running pre-action listener: _resource_record_pre_action 11:22:25 INFO - Running main action method: read_buildbot_config 11:22:25 INFO - Using buildbot properties: 11:22:25 INFO - { 11:22:25 INFO - "project": "", 11:22:25 INFO - "product": "firefox", 11:22:25 INFO - "script_repo_revision": "production", 11:22:25 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 11:22:25 INFO - "repository": "", 11:22:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 11:22:25 INFO - "buildid": "20170107094256", 11:22:25 INFO - "pgo_build": "True", 11:22:25 INFO - "basedir": "/builds/slave/test", 11:22:25 INFO - "buildnumber": 718, 11:22:25 INFO - "slavename": "talos-linux64-ix-051", 11:22:25 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:22:25 INFO - "platform": "ubuntu64_hw", 11:22:25 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 11:22:25 INFO - "branch": "mozilla-aurora", 11:22:25 INFO - "repo_path": "releases/mozilla-aurora", 11:22:25 INFO - "revision": "4195687bda73679988aaff7b27a8c3b31e38a0fc", 11:22:25 INFO - "stage_platform": "linux64-pgo", 11:22:25 INFO - "builduid": "d824de7591cc41b99a8f629feb6f525c", 11:22:25 INFO - "slavebuilddir": "test" 11:22:25 INFO - } 11:22:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/A0_xom9tRX6DK8uQXHeoMA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 11:22:25 INFO - Running post-action listener: _resource_record_post_action 11:22:25 INFO - [mozharness: 2017-01-07 19:22:25.456109Z] Finished read-buildbot-config step (success) 11:22:25 INFO - [mozharness: 2017-01-07 19:22:25.456197Z] Running download-and-extract step. 11:22:25 INFO - Running pre-action listener: _resource_record_pre_action 11:22:25 INFO - Running main action method: download_and_extract 11:22:25 INFO - mkdir: /builds/slave/test/build/tests 11:22: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')]} 11:22:25 INFO - trying https://queue.taskcluster.net/v1/task/A0_xom9tRX6DK8uQXHeoMA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 11:22:25 INFO - Downloading https://queue.taskcluster.net/v1/task/A0_xom9tRX6DK8uQXHeoMA/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 11:22:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A0_xom9tRX6DK8uQXHeoMA/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 11:22:26 INFO - Downloaded 1361 bytes. 11:22:26 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 11:22:26 INFO - Using the following test package requirements: 11:22:26 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 11:22:26 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:26 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 11:22:26 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:26 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 11:22:26 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:26 INFO - u'jsshell-linux-x86_64.zip'], 11:22:26 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:26 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 11:22:26 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 11:22:26 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:26 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 11:22:26 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:26 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 11:22:26 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:26 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 11:22:26 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 11:22:26 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 11:22:26 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:22:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A0_xom9tRX6DK8uQXHeoMA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 11:22:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A0_xom9tRX6DK8uQXHeoMA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:22:26 INFO - Fetch https://queue.taskcluster.net/v1/task/A0_xom9tRX6DK8uQXHeoMA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 11:22:26 INFO - Http code: 200 11:22:26 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 11:22:26 INFO - x-amz-cf-id: g7_YB7YmAeAsFtc6Mrgioh1ZHYishnkaZgcZo85GmbsgeUDMqAjSlg== 11:22:26 INFO - x-amz-version-id: vTrVWsshe3bstBOqgcKUn.IDyHpLO0nJ 11:22:26 INFO - Expected file size: 21943944 11:22:26 INFO - Obtained file size: 21943944 11:22:30 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 11:22:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A0_xom9tRX6DK8uQXHeoMA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 11:22:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A0_xom9tRX6DK8uQXHeoMA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 11:22:30 INFO - Fetch https://queue.taskcluster.net/v1/task/A0_xom9tRX6DK8uQXHeoMA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 11:22:31 INFO - Http code: 200 11:22:31 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 11:22:31 INFO - x-amz-cf-id: w6_EMzRA2IRGtz2nY4HUlOjwZuiAWzGqibJBcGUQweU8R4EapgE18w== 11:22:31 INFO - x-amz-version-id: vTrVWsshe3bstBOqgcKUn.IDyHpLO0nJ 11:22:31 INFO - Expected file size: 21943944 11:22:31 INFO - Obtained file size: 21943944 11:22:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/A0_xom9tRX6DK8uQXHeoMA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 11:22:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/A0_xom9tRX6DK8uQXHeoMA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 11:22:36 INFO - Fetch https://queue.taskcluster.net/v1/task/A0_xom9tRX6DK8uQXHeoMA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 11:22:36 INFO - Http code: 200 11:22:36 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 11:22:36 INFO - x-amz-cf-id: tKiwJB_ADSnqcG23AlR5L9E3t5w4pNnDQZCk9678_yi86iZuUqsvyQ== 11:22:36 INFO - x-amz-version-id: R9rdGRRcw9vbGQum1tkyAqdSESVu8eUD 11:22:36 INFO - Expected file size: 14409038 11:22:36 INFO - Obtained file size: 14409038 11:22:37 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')]} 11:22:37 INFO - trying https://queue.taskcluster.net/v1/task/A0_xom9tRX6DK8uQXHeoMA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 11:22:37 INFO - Downloading https://queue.taskcluster.net/v1/task/A0_xom9tRX6DK8uQXHeoMA/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 11:22:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A0_xom9tRX6DK8uQXHeoMA/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 11:22:38 INFO - Downloaded 64094373 bytes. 11:22:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/A0_xom9tRX6DK8uQXHeoMA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 11:22:38 INFO - mkdir: /builds/slave/test/properties 11:22:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:22:38 INFO - Writing to file /builds/slave/test/properties/build_url 11:22:38 INFO - Contents: 11:22:38 INFO - build_url:https://queue.taskcluster.net/v1/task/A0_xom9tRX6DK8uQXHeoMA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 11:22:38 INFO - Running post-action listener: _resource_record_post_action 11:22:38 INFO - Running post-action listener: set_extra_try_arguments 11:22:38 INFO - [mozharness: 2017-01-07 19:22:38.986245Z] Finished download-and-extract step (success) 11:22:38 INFO - [mozharness: 2017-01-07 19:22:38.986472Z] Running populate-webroot step. 11:22:38 INFO - Running pre-action listener: _resource_record_pre_action 11:22:38 INFO - Running main action method: populate_webroot 11:22:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:22:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:22:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:22:38 INFO - '--tppagecycles', 11:22:38 INFO - '7'], 11:22:38 INFO - 'tests': ['tsvgm']}}, 11:22:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:22:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:22:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:22:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:22:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:22:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:22:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:38 INFO - 'talos_options': ['--disable-e10s'], 11:22:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:22:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:22:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:39 INFO - 'talos_options': ['--disable-e10s'], 11:22:39 INFO - 'tests': ['damp', 'tps']}, 11:22:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:39 INFO - 'tests': ['damp', 'tps']}, 11:22:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:22:39 INFO - 'tests': ['dromaeo_dom']}, 11:22:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:22:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:22:39 INFO - 'tests': ['basic_compositor_video']}, 11:22:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:22:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:22:39 INFO - 'tests': ['a11yr', 11:22:39 INFO - 'ts_paint', 11:22:39 INFO - 'tpaint', 11:22:39 INFO - 'sessionrestore', 11:22:39 INFO - 'sessionrestore_no_auto_restore', 11:22:39 INFO - 'tabpaint']}, 11:22:39 INFO - 'other-e10s': {'tests': ['a11yr', 11:22:39 INFO - 'ts_paint', 11:22:39 INFO - 'tpaint', 11:22:39 INFO - 'sessionrestore', 11:22:39 INFO - 'sessionrestore_no_auto_restore', 11:22:39 INFO - 'tabpaint']}, 11:22:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:22:39 INFO - 'ts_paint', 11:22:39 INFO - 'tpaint', 11:22:39 INFO - 'sessionrestore', 11:22:39 INFO - 'sessionrestore_no_auto_restore', 11:22:39 INFO - 'tabpaint']}, 11:22:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:22:39 INFO - 'ts_paint', 11:22:39 INFO - 'tpaint', 11:22:39 INFO - 'sessionrestore', 11:22:39 INFO - 'sessionrestore_no_auto_restore', 11:22:39 INFO - 'tabpaint']}, 11:22:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:22:39 INFO - 'tests': ['a11yr', 11:22:39 INFO - 'ts_paint', 11:22:39 INFO - 'tpaint', 11:22:39 INFO - 'sessionrestore', 11:22:39 INFO - 'sessionrestore_no_auto_restore', 11:22:39 INFO - 'tabpaint']}, 11:22:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:22:39 INFO - 'tests': ['a11yr', 11:22:39 INFO - 'ts_paint', 11:22:39 INFO - 'tpaint', 11:22:39 INFO - 'sessionrestore', 11:22:39 INFO - 'sessionrestore_no_auto_restore', 11:22:39 INFO - 'tabpaint']}, 11:22:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:22:39 INFO - 'tests': ['tsvgx', 11:22:39 INFO - 'tsvgr_opacity', 11:22:39 INFO - 'tart', 11:22:39 INFO - 'tscrollx', 11:22:39 INFO - 'cart']}, 11:22:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:22:39 INFO - 'tsvgr_opacity', 11:22:39 INFO - 'tart', 11:22:39 INFO - 'tscrollx', 11:22:39 INFO - 'cart']}, 11:22:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:39 INFO - 'talos_options': ['--disable-e10s'], 11:22:39 INFO - 'tests': ['tp5o']}, 11:22:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:39 INFO - 'tests': ['tp5o']}, 11:22:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:39 INFO - 'talos_options': ['--disable-e10s', 11:22:39 INFO - '--xperf_path', 11:22:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:22:39 INFO - 'tests': ['tp5n']}, 11:22:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:22:39 INFO - 'talos_options': ['--xperf_path', 11:22:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:22:39 INFO - 'tests': ['tp5n']}}, 11:22:39 INFO - 'talos.zip': {'path': '', 11:22:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:22:39 INFO - Running post-action listener: _resource_record_post_action 11:22:39 INFO - [mozharness: 2017-01-07 19:22:39.005995Z] Finished populate-webroot step (success) 11:22:39 INFO - [mozharness: 2017-01-07 19:22:39.006083Z] Running create-virtualenv step. 11:22:39 INFO - Running pre-action listener: _resource_record_pre_action 11:22:39 INFO - Running main action method: create_virtualenv 11:22:39 INFO - Creating virtualenv /builds/slave/test/build/venv 11:22:39 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 11:22:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:22:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:22:39 INFO - Using real prefix '/usr' 11:22:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:22:40 INFO - Installing distribute.............................................................................................................................................................................................done. 11:22:42 INFO - Installing pip.................done. 11:22:42 INFO - Return code: 0 11:22:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:22:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:22:42 INFO - Reading from file tmpfile_stdout 11:22:42 INFO - Output received: 11:22:42 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) 11:22:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:22:42 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')]} 11:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:42 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')]} 11:22:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:42 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 0x7f0b7e658f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2836ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2833f60>, '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 0x2834d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28351d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1483816942.411184-1103399561', '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 11:22:42 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 11:22:42 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 11:22:42 INFO - Using env: {'DISPLAY': ':0', 11:22:42 INFO - 'HOME': '/home/cltbld', 11:22:42 INFO - 'LANG': 'en_US.UTF-8', 11:22:42 INFO - 'LANGUAGE': 'en_US:en', 11:22:42 INFO - 'LOGNAME': 'cltbld', 11:22:42 INFO - 'MAIL': '/var/mail/cltbld', 11:22:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:42 INFO - 'MOZ_NO_REMOTE': '1', 11:22:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:42 INFO - 'NO_EM_RESTART': '1', 11:22:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:42 INFO - 'PWD': '/builds/slave/test', 11:22:42 INFO - 'SHELL': '/bin/bash', 11:22:42 INFO - 'SHLVL': '1', 11:22:42 INFO - 'TERM': 'linux', 11:22:42 INFO - 'TMOUT': '86400', 11:22:42 INFO - 'USER': 'cltbld', 11:22:42 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1483816942.411184-1103399561', 11:22:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:42 INFO - '_': '/tools/buildbot/bin/python'} 11:22:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:42 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 11:22:42 INFO - Cleaning up... 11:22:42 INFO - Return code: 0 11:22:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:22:42 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')]} 11:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:42 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')]} 11:22:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:42 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 0x7f0b7e658f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2836ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2833f60>, '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 0x2834d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28351d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1483816942.411184-1103399561', '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 11:22:42 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 11:22:42 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 11:22:42 INFO - Using env: {'DISPLAY': ':0', 11:22:42 INFO - 'HOME': '/home/cltbld', 11:22:42 INFO - 'LANG': 'en_US.UTF-8', 11:22:42 INFO - 'LANGUAGE': 'en_US:en', 11:22:42 INFO - 'LOGNAME': 'cltbld', 11:22:42 INFO - 'MAIL': '/var/mail/cltbld', 11:22:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:42 INFO - 'MOZ_NO_REMOTE': '1', 11:22:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:42 INFO - 'NO_EM_RESTART': '1', 11:22:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:42 INFO - 'PWD': '/builds/slave/test', 11:22:42 INFO - 'SHELL': '/bin/bash', 11:22:42 INFO - 'SHLVL': '1', 11:22:42 INFO - 'TERM': 'linux', 11:22:42 INFO - 'TMOUT': '86400', 11:22:42 INFO - 'USER': 'cltbld', 11:22:42 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1483816942.411184-1103399561', 11:22:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:42 INFO - '_': '/tools/buildbot/bin/python'} 11:22:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:42 INFO - Downloading/unpacking psutil>=3.1.1 11:22:42 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 11:22:42 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 11:22:42 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 11:22:42 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 11:22:42 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 11:22:42 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 11:22:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:22:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:22:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:22:44 INFO - Installing collected packages: psutil 11:22:44 INFO - Running setup.py install for psutil 11:22:44 INFO - building 'psutil._psutil_linux' extension 11:22:44 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 11:22:45 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 11:22:45 INFO - building 'psutil._psutil_posix' extension 11:22:45 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 11:22:45 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 11:22:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:22:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:22:45 INFO - Successfully installed psutil 11:22:45 INFO - Cleaning up... 11:22:45 INFO - Return code: 0 11:22:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:45 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 0x7f0b7e658f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2836ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2833f60>, '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 0x2834d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28351d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1483816942.411184-1103399561', '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 11:22:45 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 11:22:45 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 11:22:45 INFO - Using env: {'DISPLAY': ':0', 11:22:45 INFO - 'HOME': '/home/cltbld', 11:22:45 INFO - 'LANG': 'en_US.UTF-8', 11:22:45 INFO - 'LANGUAGE': 'en_US:en', 11:22:45 INFO - 'LOGNAME': 'cltbld', 11:22:45 INFO - 'MAIL': '/var/mail/cltbld', 11:22:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:45 INFO - 'MOZ_NO_REMOTE': '1', 11:22:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:45 INFO - 'NO_EM_RESTART': '1', 11:22:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:45 INFO - 'PWD': '/builds/slave/test', 11:22:45 INFO - 'SHELL': '/bin/bash', 11:22:45 INFO - 'SHLVL': '1', 11:22:45 INFO - 'TERM': 'linux', 11:22:45 INFO - 'TMOUT': '86400', 11:22:45 INFO - 'USER': 'cltbld', 11:22:45 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1483816942.411184-1103399561', 11:22:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:45 INFO - '_': '/tools/buildbot/bin/python'} 11:22:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:22:45 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 11:22:45 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 11:22:45 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 11:22:45 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 11:22:45 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 11:22:45 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 11:22:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:22:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:22:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:22:47 INFO - Installing collected packages: mozsystemmonitor 11:22:47 INFO - Running setup.py install for mozsystemmonitor 11:22:47 INFO - Successfully installed mozsystemmonitor 11:22:47 INFO - Cleaning up... 11:22:47 INFO - Return code: 0 11:22:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:22:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:22:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0b7e658f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2836ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2833f60>, '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 0x2834d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28351d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1483816942.411184-1103399561', '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 11:22:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:22:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:22:47 INFO - Using env: {'DISPLAY': ':0', 11:22:47 INFO - 'HOME': '/home/cltbld', 11:22:47 INFO - 'LANG': 'en_US.UTF-8', 11:22:47 INFO - 'LANGUAGE': 'en_US:en', 11:22:47 INFO - 'LOGNAME': 'cltbld', 11:22:47 INFO - 'MAIL': '/var/mail/cltbld', 11:22:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:47 INFO - 'MOZ_NO_REMOTE': '1', 11:22:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:47 INFO - 'NO_EM_RESTART': '1', 11:22:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:47 INFO - 'PWD': '/builds/slave/test', 11:22:47 INFO - 'SHELL': '/bin/bash', 11:22:47 INFO - 'SHLVL': '1', 11:22:47 INFO - 'TERM': 'linux', 11:22:47 INFO - 'TMOUT': '86400', 11:22:47 INFO - 'USER': 'cltbld', 11:22:47 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1483816942.411184-1103399561', 11:22:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:47 INFO - '_': '/tools/buildbot/bin/python'} 11:22:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:47 INFO - Downloading/unpacking jsonschema==2.5.1 11:22:47 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 11:22:47 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 11:22:47 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 11:22:47 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 11:22:47 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 11:22:47 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 11:22:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:22:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:22:49 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 11:22:49 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 11:22:49 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 11:22:49 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 11:22:49 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 11:22:49 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 11:22:50 INFO - Downloading functools32-3.2.3-2.tar.gz 11:22:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:22:50 INFO - warning: no files found matching '*.txt' 11:22:50 INFO - no previously-included directories found matching 'build' 11:22:50 INFO - no previously-included directories found matching 'dist' 11:22:50 INFO - no previously-included directories found matching '.git*' 11:22:50 INFO - Installing collected packages: jsonschema, functools32 11:22:50 INFO - Running setup.py install for functools32 11:22:50 INFO - warning: no files found matching '*.txt' 11:22:50 INFO - no previously-included directories found matching 'build' 11:22:50 INFO - no previously-included directories found matching 'dist' 11:22:50 INFO - no previously-included directories found matching '.git*' 11:22:50 INFO - Successfully installed jsonschema functools32 11:22:50 INFO - Cleaning up... 11:22:50 INFO - Return code: 0 11:22:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:22: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')]} 11:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22: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')]} 11:22:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:50 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 0x7f0b7e658f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2836ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2833f60>, '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 0x2834d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28351d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1483816942.411184-1103399561', '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 11:22:50 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 11:22:50 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 11:22:50 INFO - Using env: {'DISPLAY': ':0', 11:22:50 INFO - 'HOME': '/home/cltbld', 11:22:50 INFO - 'LANG': 'en_US.UTF-8', 11:22:50 INFO - 'LANGUAGE': 'en_US:en', 11:22:50 INFO - 'LOGNAME': 'cltbld', 11:22:50 INFO - 'MAIL': '/var/mail/cltbld', 11:22:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:50 INFO - 'MOZ_NO_REMOTE': '1', 11:22:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:50 INFO - 'NO_EM_RESTART': '1', 11:22:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:50 INFO - 'PWD': '/builds/slave/test', 11:22:50 INFO - 'SHELL': '/bin/bash', 11:22:50 INFO - 'SHLVL': '1', 11:22:50 INFO - 'TERM': 'linux', 11:22:50 INFO - 'TMOUT': '86400', 11:22:50 INFO - 'USER': 'cltbld', 11:22:50 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1483816942.411184-1103399561', 11:22:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:50 INFO - '_': '/tools/buildbot/bin/python'} 11:22:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:22:50 INFO - Cleaning up... 11:22:50 INFO - Return code: 0 11:22:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:22: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')]} 11:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22: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')]} 11:22:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:50 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 0x7f0b7e658f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2836ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2833f60>, '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 0x2834d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28351d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1483816942.411184-1103399561', '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 11:22:50 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 11:22:50 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 11:22:50 INFO - Using env: {'DISPLAY': ':0', 11:22:50 INFO - 'HOME': '/home/cltbld', 11:22:50 INFO - 'LANG': 'en_US.UTF-8', 11:22:50 INFO - 'LANGUAGE': 'en_US:en', 11:22:50 INFO - 'LOGNAME': 'cltbld', 11:22:50 INFO - 'MAIL': '/var/mail/cltbld', 11:22:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:50 INFO - 'MOZ_NO_REMOTE': '1', 11:22:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:50 INFO - 'NO_EM_RESTART': '1', 11:22:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:50 INFO - 'PWD': '/builds/slave/test', 11:22:50 INFO - 'SHELL': '/bin/bash', 11:22:50 INFO - 'SHLVL': '1', 11:22:50 INFO - 'TERM': 'linux', 11:22:50 INFO - 'TMOUT': '86400', 11:22:50 INFO - 'USER': 'cltbld', 11:22:50 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1483816942.411184-1103399561', 11:22:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:50 INFO - '_': '/tools/buildbot/bin/python'} 11:22:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:50 INFO - Downloading/unpacking blobuploader==1.2.4 11:22:50 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 11:22:50 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 11:22:50 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 11:22:50 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 11:22:50 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 11:22:50 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 11:22:52 INFO - Downloading blobuploader-1.2.4.tar.gz 11:22:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:22:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:22:52 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 11:22:52 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 11:22:52 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 11:22:52 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 11:22:52 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 11:22:52 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 11:22:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:22:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:22:53 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 11:22:53 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 11:22:53 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 11:22:53 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 11:22:53 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 11:22:53 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 11:22:53 INFO - Downloading docopt-0.6.1.tar.gz 11:22:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:22:53 INFO - Installing collected packages: blobuploader, requests, docopt 11:22:53 INFO - Running setup.py install for blobuploader 11:22:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:22:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:22:53 INFO - Running setup.py install for requests 11:22:54 INFO - Running setup.py install for docopt 11:22:54 INFO - Successfully installed blobuploader requests docopt 11:22:54 INFO - Cleaning up... 11:22:54 INFO - Return code: 0 11:22:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:22:54 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')]} 11:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:54 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')]} 11:22:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:54 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 0x7f0b7e658f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2836ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2833f60>, '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 0x2834d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28351d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1483816942.411184-1103399561', '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 11:22:54 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 11:22:54 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 11:22:54 INFO - Using env: {'DISPLAY': ':0', 11:22:54 INFO - 'HOME': '/home/cltbld', 11:22:54 INFO - 'LANG': 'en_US.UTF-8', 11:22:54 INFO - 'LANGUAGE': 'en_US:en', 11:22:54 INFO - 'LOGNAME': 'cltbld', 11:22:54 INFO - 'MAIL': '/var/mail/cltbld', 11:22:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:54 INFO - 'MOZ_NO_REMOTE': '1', 11:22:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:54 INFO - 'NO_EM_RESTART': '1', 11:22:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:54 INFO - 'PWD': '/builds/slave/test', 11:22:54 INFO - 'SHELL': '/bin/bash', 11:22:54 INFO - 'SHLVL': '1', 11:22:54 INFO - 'TERM': 'linux', 11:22:54 INFO - 'TMOUT': '86400', 11:22:54 INFO - 'USER': 'cltbld', 11:22:54 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1483816942.411184-1103399561', 11:22:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:54 INFO - '_': '/tools/buildbot/bin/python'} 11:22:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:22:54 INFO - Running setup.py (path:/tmp/pip-9vupju-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:22:54 INFO - Running setup.py (path:/tmp/pip-qJohu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:22:54 INFO - Running setup.py (path:/tmp/pip-zGYAqf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:22:54 INFO - Running setup.py (path:/tmp/pip-vC1UKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:22:54 INFO - Running setup.py (path:/tmp/pip-94kQVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:22:54 INFO - Running setup.py (path:/tmp/pip-rbjdKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:22:54 INFO - Running setup.py (path:/tmp/pip-j9hPQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:22:55 INFO - Running setup.py (path:/tmp/pip-DitsJc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:22:55 INFO - Running setup.py (path:/tmp/pip-6p56Im-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:22:55 INFO - Running setup.py (path:/tmp/pip-9jzG7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:22:55 INFO - Running setup.py (path:/tmp/pip-b_4yj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:22:55 INFO - Running setup.py (path:/tmp/pip-NjIoi4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:22:55 INFO - Running setup.py (path:/tmp/pip-XhDRWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:22:55 INFO - Running setup.py (path:/tmp/pip-4IZEpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:22:55 INFO - Running setup.py (path:/tmp/pip-ZbskZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:22:55 INFO - Running setup.py (path:/tmp/pip-EQQeqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:22:55 INFO - Running setup.py (path:/tmp/pip-Cj70wb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:22:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:22:55 INFO - Running setup.py install for manifestparser 11:22:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:22:55 INFO - Running setup.py install for mozcrash 11:22:55 INFO - Running setup.py install for mozdebug 11:22:56 INFO - Running setup.py install for mozdevice 11:22:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:22:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:22:56 INFO - Running setup.py install for mozfile 11:22:56 INFO - Running setup.py install for mozhttpd 11:22:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:22:56 INFO - Running setup.py install for mozinfo 11:22:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:22:56 INFO - Running setup.py install for mozInstall 11:22:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:22:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:22:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:22:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:22:56 INFO - Running setup.py install for mozleak 11:22:56 INFO - Running setup.py install for mozlog 11:22:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:22:56 INFO - Running setup.py install for moznetwork 11:22:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:22:56 INFO - Running setup.py install for mozprocess 11:22:56 INFO - Running setup.py install for mozprofile 11:22:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:22:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:22:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:22:57 INFO - Running setup.py install for mozrunner 11:22:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:22:57 INFO - Running setup.py install for mozscreenshot 11:22:57 INFO - Running setup.py install for moztest 11:22:57 INFO - Running setup.py install for mozversion 11:22:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:22:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:22:57 INFO - Cleaning up... 11:22:57 INFO - Return code: 0 11:22:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:22: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')]} 11:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:22:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22: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')]} 11:22:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:22:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:22:57 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 0x7f0b7e658f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2836ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2833f60>, '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 0x2834d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28351d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1483816942.411184-1103399561', '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 11:22:57 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 11:22:57 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 11:22:57 INFO - Using env: {'DISPLAY': ':0', 11:22:57 INFO - 'HOME': '/home/cltbld', 11:22:57 INFO - 'LANG': 'en_US.UTF-8', 11:22:57 INFO - 'LANGUAGE': 'en_US:en', 11:22:57 INFO - 'LOGNAME': 'cltbld', 11:22:57 INFO - 'MAIL': '/var/mail/cltbld', 11:22:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:22:57 INFO - 'MOZ_NO_REMOTE': '1', 11:22:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:22:57 INFO - 'NO_EM_RESTART': '1', 11:22:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:22:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:22:57 INFO - 'PWD': '/builds/slave/test', 11:22:57 INFO - 'SHELL': '/bin/bash', 11:22:57 INFO - 'SHLVL': '1', 11:22:57 INFO - 'TERM': 'linux', 11:22:57 INFO - 'TMOUT': '86400', 11:22:57 INFO - 'USER': 'cltbld', 11:22:57 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1483816942.411184-1103399561', 11:22:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:22:57 INFO - '_': '/tools/buildbot/bin/python'} 11:22:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:22:57 INFO - Running setup.py (path:/tmp/pip-8LBpGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:22:57 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)) 11:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:22:57 INFO - Running setup.py (path:/tmp/pip-li6djc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:22:57 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)) 11:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:22:57 INFO - Running setup.py (path:/tmp/pip-LZ8b5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:22:58 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)) 11:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:22:58 INFO - Running setup.py (path:/tmp/pip-Kv3KDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:22:58 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)) 11:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:22:58 INFO - Running setup.py (path:/tmp/pip-h2cO8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:22:58 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)) 11:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:22:58 INFO - Running setup.py (path:/tmp/pip-xAnrN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:22:58 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)) 11:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:22:58 INFO - Running setup.py (path:/tmp/pip-NpHKcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:22:58 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)) 11:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:22:58 INFO - Running setup.py (path:/tmp/pip-lzwgaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:22:58 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)) 11:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:22:58 INFO - Running setup.py (path:/tmp/pip-IINk2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:22:58 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)) 11:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:22:58 INFO - Running setup.py (path:/tmp/pip-ALwJsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:22:58 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)) 11:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:22:58 INFO - Running setup.py (path:/tmp/pip-w9fJs1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:22:58 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)) 11:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:22:58 INFO - Running setup.py (path:/tmp/pip-5wfX0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:22:58 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)) 11:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:22:58 INFO - Running setup.py (path:/tmp/pip-r4Hjq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:22:58 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)) 11:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:22:58 INFO - Running setup.py (path:/tmp/pip-NdYEsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:22:58 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)) 11:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:22:58 INFO - Running setup.py (path:/tmp/pip-55VAOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:22:58 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)) 11:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:22:58 INFO - Running setup.py (path:/tmp/pip-rA64Ap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 11:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:22:58 INFO - Running setup.py (path:/tmp/pip-ay3Sjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:22:59 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)) 11:22:59 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)) 11:22:59 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)) 11:22:59 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)) 11:22:59 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)) 11:22:59 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)) 11:22:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:22:59 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 11:22:59 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 11:22:59 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 11:22:59 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 11:22:59 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 11:22:59 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 11:23:01 INFO - Downloading blessings-1.6.tar.gz 11:23:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:23:01 INFO - Installing collected packages: blessings 11:23:01 INFO - Running setup.py install for blessings 11:23:01 INFO - Successfully installed blessings 11:23:01 INFO - Cleaning up... 11:23:01 INFO - Return code: 0 11:23:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:23:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:23:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:23:01 INFO - Reading from file tmpfile_stdout 11:23:01 INFO - Current package versions: 11:23:01 INFO - argparse == 1.2.1 11:23:01 INFO - blessings == 1.6 11:23:01 INFO - blobuploader == 1.2.4 11:23:01 INFO - docopt == 0.6.1 11:23:01 INFO - functools32 == 3.2.3-2 11:23:01 INFO - jsonschema == 2.5.1 11:23:01 INFO - manifestparser == 1.1 11:23:01 INFO - mozInstall == 1.12 11:23:01 INFO - mozcrash == 1.0 11:23:01 INFO - mozdebug == 0.1 11:23:01 INFO - mozdevice == 0.48 11:23:01 INFO - mozfile == 1.2 11:23:01 INFO - mozhttpd == 0.7 11:23:01 INFO - mozinfo == 0.9 11:23:01 INFO - mozleak == 0.1 11:23:01 INFO - mozlog == 3.4 11:23:01 INFO - moznetwork == 0.27 11:23:01 INFO - mozprocess == 0.23 11:23:01 INFO - mozprofile == 0.28 11:23:01 INFO - mozrunner == 6.13 11:23:01 INFO - mozscreenshot == 0.1 11:23:01 INFO - mozsystemmonitor == 0.3 11:23:01 INFO - moztest == 0.8 11:23:01 INFO - mozversion == 1.4 11:23:01 INFO - psutil == 3.1.1 11:23:01 INFO - requests == 1.2.3 11:23:01 INFO - wsgiref == 0.1.2 11:23:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:23:01 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')]} 11:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:01 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')]} 11:23:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:01 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 0x7f0b7e658f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2836ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2833f60>, '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 0x2834d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28351d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1483816942.411184-1103399561', '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 11:23:01 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 11:23:01 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 11:23:01 INFO - Using env: {'DISPLAY': ':0', 11:23:01 INFO - 'HOME': '/home/cltbld', 11:23:01 INFO - 'LANG': 'en_US.UTF-8', 11:23:01 INFO - 'LANGUAGE': 'en_US:en', 11:23:01 INFO - 'LOGNAME': 'cltbld', 11:23:01 INFO - 'MAIL': '/var/mail/cltbld', 11:23:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:01 INFO - 'MOZ_NO_REMOTE': '1', 11:23:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:23:01 INFO - 'NO_EM_RESTART': '1', 11:23:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:23:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:01 INFO - 'PWD': '/builds/slave/test', 11:23:01 INFO - 'SHELL': '/bin/bash', 11:23:01 INFO - 'SHLVL': '1', 11:23:01 INFO - 'TERM': 'linux', 11:23:01 INFO - 'TMOUT': '86400', 11:23:01 INFO - 'USER': 'cltbld', 11:23:01 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1483816942.411184-1103399561', 11:23:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:01 INFO - '_': '/tools/buildbot/bin/python'} 11:23:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:01 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)) 11:23:01 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)) 11:23:01 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)) 11:23:01 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)) 11:23:01 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)) 11:23:01 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)) 11:23:01 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)) 11:23:01 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)) 11:23:01 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)) 11:23:01 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)) 11:23:01 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)) 11:23:01 INFO - Cleaning up... 11:23:01 INFO - Return code: 0 11:23:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:23:01 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')]} 11:23:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:23:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:01 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')]} 11:23:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:23:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:23:01 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 0x7f0b7e658f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27698a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2836ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2833f60>, '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 0x2834d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28351d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1483816942.411184-1103399561', '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 11:23:01 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 11:23:01 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 11:23:01 INFO - Using env: {'DISPLAY': ':0', 11:23:01 INFO - 'HOME': '/home/cltbld', 11:23:01 INFO - 'LANG': 'en_US.UTF-8', 11:23:01 INFO - 'LANGUAGE': 'en_US:en', 11:23:01 INFO - 'LOGNAME': 'cltbld', 11:23:01 INFO - 'MAIL': '/var/mail/cltbld', 11:23:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:01 INFO - 'MOZ_NO_REMOTE': '1', 11:23:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:23:01 INFO - 'NO_EM_RESTART': '1', 11:23:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:23:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:01 INFO - 'PWD': '/builds/slave/test', 11:23:01 INFO - 'SHELL': '/bin/bash', 11:23:01 INFO - 'SHLVL': '1', 11:23:01 INFO - 'TERM': 'linux', 11:23:01 INFO - 'TMOUT': '86400', 11:23:01 INFO - 'USER': 'cltbld', 11:23:01 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1483816942.411184-1103399561', 11:23:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:01 INFO - '_': '/tools/buildbot/bin/python'} 11:23:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:23:01 INFO - Cleaning up... 11:23:01 INFO - Return code: 0 11:23:01 INFO - Running post-action listener: _resource_record_post_action 11:23:01 INFO - Running post-action listener: _start_resource_monitoring 11:23:01 INFO - Starting resource monitoring. 11:23:01 INFO - [mozharness: 2017-01-07 19:23:01.981263Z] Finished create-virtualenv step (success) 11:23:01 INFO - [mozharness: 2017-01-07 19:23:01.981719Z] Running install step. 11:23:01 INFO - Running pre-action listener: _resource_record_pre_action 11:23:01 INFO - Running main action method: install 11:23:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:23:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:23:02 INFO - Reading from file tmpfile_stdout 11:23:02 INFO - Detecting whether we're running mozinstall >=1.0... 11:23:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:23:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:23:02 INFO - Reading from file tmpfile_stdout 11:23:02 INFO - Output received: 11:23:02 INFO - Usage: mozinstall [options] installer 11:23:02 INFO - Options: 11:23:02 INFO - -h, --help show this help message and exit 11:23:02 INFO - -d DEST, --destination=DEST 11:23:02 INFO - Directory to install application into. [default: 11:23:02 INFO - "/builds/slave/test"] 11:23:02 INFO - --app=APP Application being installed. [default: firefox] 11:23:02 INFO - mkdir: /builds/slave/test/build/application 11:23:02 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'] 11:23:02 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 11:23:18 INFO - Reading from file tmpfile_stdout 11:23:18 INFO - Output received: 11:23:18 INFO - /builds/slave/test/build/application/firefox/firefox 11:23:18 INFO - Running post-action listener: _resource_record_post_action 11:23:18 INFO - [mozharness: 2017-01-07 19:23:18.257957Z] Finished install step (success) 11:23:18 INFO - [mozharness: 2017-01-07 19:23:18.258199Z] Running run-tests step. 11:23:18 INFO - Running pre-action listener: _resource_record_pre_action 11:23:18 INFO - Running main action method: run_tests 11:23:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:23:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:23:18 INFO - Python 2.7.3 11:23:18 INFO - Return code: 0 11:23:18 INFO - grabbing minidump binary from tooltool 11:23:18 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')]} 11:23:18 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 0x2833f60>, '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 0x2834d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28351d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:23:18 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 11:23:18 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 11:23:18 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 11:23:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:23:18 INFO - Return code: 0 11:23:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:23:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:23:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:23:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:23:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:23:18 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/A0_xom9tRX6DK8uQXHeoMA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 11:23:18 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/A0_xom9tRX6DK8uQXHeoMA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 11:23:18 INFO - Using env: {'DISPLAY': ':0', 11:23:18 INFO - 'HOME': '/home/cltbld', 11:23:18 INFO - 'LANG': 'en_US.UTF-8', 11:23:18 INFO - 'LANGUAGE': 'en_US:en', 11:23:18 INFO - 'LOGNAME': 'cltbld', 11:23:18 INFO - 'MAIL': '/var/mail/cltbld', 11:23:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:23:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:23:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:23:18 INFO - 'MOZ_NO_REMOTE': '1', 11:23:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:23:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:23:18 INFO - 'NO_EM_RESTART': '1', 11:23:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:23:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:23:18 INFO - 'PWD': '/builds/slave/test', 11:23:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:23:18 INFO - 'SHELL': '/bin/bash', 11:23:18 INFO - 'SHLVL': '1', 11:23:18 INFO - 'TERM': 'linux', 11:23:18 INFO - 'TMOUT': '86400', 11:23:18 INFO - 'USER': 'cltbld', 11:23:18 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1483816942.411184-1103399561', 11:23:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:23:18 INFO - '_': '/tools/buildbot/bin/python'} 11:23:18 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/A0_xom9tRX6DK8uQXHeoMA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 11:23:18 INFO - mozversion application_buildid: 20170107094256 11:23:18 INFO - mozversion application_changeset: 4195687bda73679988aaff7b27a8c3b31e38a0fc 11:23:18 INFO - mozversion application_display_name: FirefoxDeveloperEdition 11:23:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:23:18 INFO - mozversion application_name: Firefox 11:23:18 INFO - mozversion application_remotingname: firefox-dev 11:23:18 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:23:18 INFO - mozversion application_vendor: Mozilla 11:23:18 INFO - mozversion application_version: 52.0a2 11:23:18 INFO - mozversion platform_buildid: 20170107094256 11:23:18 INFO - mozversion platform_changeset: 4195687bda73679988aaff7b27a8c3b31e38a0fc 11:23:18 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 11:23:18 INFO - mozversion platform_version: 52.0a2 11:23:18 INFO - using testdate: 1483816998 11:23:18 INFO - actual date: 1483816998 11:23:18 INFO - starting webserver on 'localhost:50480' 11:23:18 INFO - SUITE-START | Running 2 tests 11:23:18 INFO - TEST-START | dromaeo_css 11:23:18 INFO - operating with platform_type : linux_ 11:23:18 INFO - Initialising browser for dromaeo_css test... 11:23:18 INFO - TEST-INFO | started process 4509 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv8_JCb/profile http://localhost:50480/getInfo.html) 11:23:22 INFO - PROCESS | 4509 | __metrics Screen width/height:1600/1200 11:23:22 INFO - PROCESS | 4509 | colorDepth:24 11:23:22 INFO - PROCESS | 4509 | Browser inner width/height: 1024/697 11:23:22 INFO - PROCESS | 4509 | __metrics 11:23:23 INFO - PROCESS | 4509 | 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" 11:23:23 INFO - PROCESS | 4509 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:23:23 INFO - PROCESS | 4509 | console.error: PushService: 11:23:23 INFO - PROCESS | 4509 | stateChangeProcessEnqueue: Error transitioning state 11:23:23 INFO - PROCESS | 4509 | UnknownError 11:23:24 INFO - TEST-INFO | 4509: exit 0 11:23:24 INFO - Browser initialized. 11:23:24 INFO - Running cycle 1/1 for dromaeo_css test... 11:23:24 INFO - TEST-INFO | started process 4605 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv8_JCb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:23:36 INFO - PROCESS | 4605 | RSS: Main: 144879616 11:23:36 INFO - PROCESS | 4605 | 11:26:38 INFO - PROCESS | 4605 | Cycle 1(1): loaded http://localhost:50480/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50480/tests/dromaeo/cssquery-ext.html) 11:26:39 INFO - PROCESS | 4605 | RSS: Main: 238690304 11:26:39 INFO - PROCESS | 4605 | 11:29:41 INFO - PROCESS | 4605 | Cycle 1(1): loaded http://localhost:50480/tests/dromaeo/cssquery-ext.html (next: http://localhost:50480/tests/dromaeo/cssquery-jquery.html) 11:29:42 INFO - PROCESS | 4605 | RSS: Main: 215998464 11:29:42 INFO - PROCESS | 4605 | 11:32:44 INFO - PROCESS | 4605 | Cycle 1(1): loaded http://localhost:50480/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50480/tests/dromaeo/cssquery-mootools.html) 11:32:44 INFO - PROCESS | 4605 | RSS: Main: 191807488 11:32:44 INFO - PROCESS | 4605 | 11:35:46 INFO - PROCESS | 4605 | Cycle 1(1): loaded http://localhost:50480/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50480/tests/dromaeo/cssquery-prototype.html) 11:35:47 INFO - PROCESS | 4605 | RSS: Main: 206655488 11:35:47 INFO - PROCESS | 4605 | 11:38:50 INFO - PROCESS | 4605 | Cycle 1(1): loaded http://localhost:50480/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50480/tests/dromaeo/cssquery-yui.html) 11:38:50 INFO - PROCESS | 4605 | RSS: Main: 174227456 11:38:50 INFO - PROCESS | 4605 | 11:41:53 INFO - PROCESS | 4605 | Cycle 1(1): loaded http://localhost:50480/tests/dromaeo/cssquery-yui.html (next: http://localhost:50480/tests/dromaeo/cssquery-dojo.html) 11:41:53 INFO - PROCESS | 4605 | RSS: Main: 268496896 11:41:53 INFO - PROCESS | 4605 | 11:41:53 INFO - PROCESS | 4605 | __start_tp_report 11:41:53 INFO - PROCESS | 4605 | _x_x_mozilla_page_load 11:41:53 INFO - PROCESS | 4605 | _x_x_mozilla_page_load_details 11:41:53 INFO - PROCESS | 4605 | |i|pagename|runs| 11:41:53 INFO - PROCESS | 4605 | |0;dojo.html;3233.4018206631777;3283.4910588858734;3297.8515966781492;3323.7174840138587;3335.24956884701;5539.335279766428;5605.327360716709;5640.802571909984;5642.097264437685;5644.858878528039;5579.581531385153;5620.269364982547;5641.8589535261635;5649.745761440735;5671.319441667006;5050.722210278424;5067.695938243699;5069.188929771238;5094.592432605401;5129.461406552315;4837.0325934813;4848.224284114543;5120.052790233819;5137.871553211162;5140.588752899759;4985.975070124662;5012.699238045729;5035;5038.370203724535;5044.243363495487;5087.084324821531;5088.7201203933955;5152.793888244466;5161.277421161003;5187.325647665817;4785.9521404785855;5043.167877300241;5069.986002799418;5100.642954993152;5122.3853137623355;5351.812686555952;5422.3764267109;5434.049041417736;5467.234587157801;5494.983428065821;5887.646741195542;5899.2920849497905;5992.730327135289;5999.310079340888;6000.819975400745;5668.064769313059;6019.398060193989;6031.969840150771;6042.425969532887;6053.727582258809;5342.706151161685;5485.451454854562;5559.27729395176;5561.972190139104;5566.165075238747;6055.333913269536;6090.756369745249;6095.695215239309;6096.512279017668;6097.024476083805;5652.208690783294;5838.678872662044;5852.561057920673;5854.795082172103;5856.941430585724;5779.566532509994;5883.61756485827;5941.257342832146;5949.077892926603;6026.216591843032;5960.433758792908;5974.163617093611;5974.462298393166;5985.431384018511;6007.669578173242;5924.644521328734;5978.940210597925;5983.880322393527;5995.940040599626;5995.970020149872;4467.061916997467;4518.051209246029;4523.886902827456;4599.724016559017;4635.258358662598;4169.854055108057;4194.6853985951175;4215.346621273708;4221.852235171754;4235.724677895989;5821.592488525847;5829.8251052468495;5830.950428922834;5833.125031245348;5838.182654428383;5733.0540460823495;5744.684042377709;5792.536597072224;6063.090536419572;6081.5742897996715;5648.350439699405;5677.744501497443;5679.233303503974;5755.251817263729;5778.902008618349;5177.378714554277;5184.066867963727;5184.896302074013;5186.092433824141;5186.170212766015;6019.1573179754;6226.533010024175;6282.2147231596055;6301.8109456716375;6302.086197501429;5770.2498675171955;5926.318473375444;5934.732937017931;5975.40245975399;6081.118237855575;6337.556371053982;6345.333739957238;6391.936080639134;6396.648184349905;6398.712057957497;5927.673977931255;5934.584579079423;5935.732892019783;5944.256967879015;5947.167396564571;5590.944090559043;5633.464820842013;5894.440028197314;5937.584369094122;5951.107333899777;5874.618149820248;5876.059830427112;5884.32330282023;5892.558058145742;5897;5837.270341207349;5845.444682755132;5847.38602446737;5849.976254155421;5850.7074646266665;5496.477834605706;5497;5694.345150307602;5713.400092990176;5856.033754430641;5839.941600583939;5842.474177324061;5853.590248682552;5860.589758716849;5878.853028674317;5476.616636835383;5663.292088488939;5714.114312281603;5727.8854422912145;5730.08318669011 11:41:53 INFO - PROCESS | 4605 | |1;ext.html;597.2146627185251;617.6818938246802;651.7686221391405;653.5817077070673;657.9276279609239;34823.4776478353;35430;37115;45285.32072018922;46567.76716116415;48193;48554.75722621391;48586.27120593185;48594;48616.75691621537;8840.115988401156;9005.099490051009;9032.909670903273;9036.051214622468;9038.096190380942;8373.41386102973;8516.829663406728;8540.231379175873;8879.77800554988;10564.313319634237;10686.091682206983;11042.889571104306;11058.281211721252;11058.447077646086;11064;10837.078848297904;10876;10894.128469722404;10900;10906.236563440561;10812.67561973142;10850.457477126112;10867.673969780919;10875.619353322674;10875.891241087567;44748.10503789938;44813.327800083025;44919.55080449186;45113.548864511264;45170.548294516964;3734.8879533614036;3804.90487737806;3890.2219556088894;3962.9405558916637;3963.6036396360423;32347.676523234702;35076.82461587701;35076.947691569294;35193.296134077435;35283;4044.797760112012;4181.916361672749;4200.957990420118;4205.179989901971;4232.153569286155;393533;400835;403673;403938;404174;70405;71393.64303178451;71402;71458.28541714621;71530;41405.585944140774;42139.367909481385;42259.57740422618;45306.54693453023;45313.773431132635;19244;19543;19547.218111275673;19548.8045119547;19554.608907821763;14499.420023198954;14716.632084197767;14737.926310368379;14752.926235368754;14755;18738.668057196825;21383.893080534497;21949.231776887733;23159.421014474436;23289.18487852917;8106.015574658956;8113.8782918256275;8261.83476330482;8396;8426.747197584082;994.2692121290845;1081.0270756319376;1094.2504384496644;1139.834723965037;1219.40249277855;34302.93579632389;34686.826565867515;34767.13082172915;34909.301813963575;35135.824320878746;995.3629677006721;1107.5071593141136;1140.766142940695;1201.4773573495556;1224.3143839449936;16409;18323.90838045801;18686.25254989785;19387.321443749683;19425.4172374829;560312;560442;560974;562293;563432;64166.358336416975;64920;64935;64953.675231623536;64990;1340.3767248229426;1361.217300052454;1372.2726954714017;1374.8350197976106;1432.8065711129072;28434.57348139821;34999;35829.64170358367;37659;38676.41985370166;63110.36889631045;63717.36282637114;63837;63928;63979;501324;504751;506999;507157;508190;31488;32496;40417;40857;45052.549474504835;47524.524754753395;51368.22947655863;51545.22682159846;51861.740691296305;52162.73918630383;43137.78431107824;44191.55808441874;44650.55349446594;44930.77534612306;45922.311165333216;43038.139237215706;43425.7828710867;43811;44907.10185796201;44907.10185796331;44316;44321.335179971684;44964;45152.54847451615;45462.318065228385;38052.619473806015;39254.2149157021;39765.403518947816;40040.59959400369;40141;29779.70220297856;30118.397632047676;30345.69654303517;30612.846935765177;30817.537736933515 11:41:53 INFO - PROCESS | 4605 | |2;jquery.html;394.75919688989694;425.7285562590947;433.687744823727;437.03633488158596;441.282915262698;15780.368785248576;19204.039798010097;20750.27374041909;21038.789612103876;21177.364679059654;19905.701414478757;20578.89710551445;20656.793432065675;20686;20786.480337991557;5756.971215143918;5964.254468191476;5969.791057312973;5977.1034344848185;5977.432143946318;5841.415858414167;6041.577089603729;6110.511159107283;6184.134221209034;6188.5358598105095;5962.672053037081;6114.480269177103;6170.413810687977;6175.876482470348;6181.81454556364;6177.166082578839;6180.072989051633;6217.129601855721;6239.001759718469;6243.843903902393;5877.764889404419;6036.637801731867;6069.15031895535;6069.332373438918;6070.57505974582;14752.778708319383;14939.775903361458;14948.925255373653;22772.544549108927;23523;2335.100986120339;2380.0276840040347;2458.864762438065;2562.7309132541186;2771.5704065869822;10605.098566621846;11097.611583594535;14592.854071459362;14981;15614.45349412765;1942.7668679758378;1952.1215453046186;1960.862739608228;2031.4210450021674;2049.467138543974;81317;85229.44311670659;85383;88306;89725.55137224273;10805.567777288978;11868.406579670982;11891.16761826681;11974.700632484257;12260.509579616715;15790.9210453947;15955.920220399055;16641.251143698562;16665.583360416087;17146.39987600453;8891.822163556693;8959.776005599912;8996.910030899608;9102.590383432762;9152.54237288133;8823.073577274294;8889.288856891433;8939.73180804577;9009.324300677476;9073.909260907438;4770.260609605517;4929.334539837076;5043.4956504349275;5103.566196873233;5174.922376164361;2049.7291679159016;2068.348470231872;2105.610462064523;2110.6728457089175;2115.724955755742;478.4354461735186;884.4737381258141;983.1663946739279;1042.5048102151418;1057.0750593230923;12254.142210045211;12822.743545129231;13335.533256335983;13367.197968121944;13583.185008899498;492.57884508745224;499.28103530915365;501.9949800502021;502.08119141970104;513.0559770023175;6896.689648965808;7184.9640751795905;7236.276372362827;7236.855262894818;7300.233475485104;417892;424944;464346;487163;495066;96502.51748741211;105786;108400;111918.44040779745;113583;1092.639428988432;1095.6439157273917;1106.4854842498278;1110.6001839337832;1115.5091759625577;18520.81479185245;18646.53383665365;18770.25235051894;18860.905695471436;18944.621107577495;33836.32327353489;42215.155696886504;42427;42834.357484637134;43962.46131385386;58825.70587147037;60329;61471.385286146564;61568.07647885196;61889.38110618836;8838.027816940003;9040.321975851706;9105.954470227607;9140.765996590375;9219.907800921905;13644.590662280147;14065.648358791112;14272.500462483764;14456.349464273922;14484.782728258873;12030.458629361525;12187.878121218675;12273.386330683608;12590.370481475706;12699.746005080031;11918.225315354473;12199.817002744789;12208.816867746813;12272.202306850026;12672.873271267537;11735.647930562096;12176.75646487083;12396.194247373893;12486.500539978299;12567.87432125667;8820.294376449998;9220.124088211609;9243;9268.582913768762;9482.952585237306;11944.64166075019;12017.038636908852;12031.27812331263;12094.939525302318;12240.143189976616 11:41:53 INFO - PROCESS | 4605 | |3;mootools.html;1334.499562664001;1503.4737841755386;1527.2807026288765;1653.4295667994538;1805.9187336569853;7141.107361579802;8052;8282.958585207065;8294.212049855269;8520.105388934166;8335.249827515538;8406.95796521018;8414.03238627558;8418.789530261747;8426.494410335385;2439.085342996381;2467.703875534938;2467.864267465298;2469.1481438903547;2474.7648973347505;2402.8438151520095;2511.4474815540552;2511.9246422607353;2513.5349960257317;2514.53481105996;2431.112643884987;2431.598786200275;2432.343267317823;2443.657887895696;2458.2010846474877;2402.1952645863657;2421.4793819328843;2454.7054353477606;2461.113998960373;2468.8888999995042;2405.20628192696;2408.301592538179;2423.915162969305;2430.2344761400277;2439;8309.667613295462;8348.874766878502;8364.958175209145;8389.832203355898;8442.113578074275;5272.868178295535;5375.408705042442;5471.206675032138;5514.200440936042;5526.751296191681;3381.5773028371455;3598.4962105305276;3672.8347224374966;3674.876355098172;3702.426123950765;1086.6468397770757;1088.967330980072;1111.9833202501968;1120.0311730353185;1120.910327173824;11393.658190254306;11411.42942852854;11493.42532873353;11536.59621913229;11537.423128843524;4473.619742321874;4661.673682842168;4761.9047619048115;4764.356811830427;4765.523447655276;9161;9178.265738740885;9178.908210917938;9180.44917304964;9183.357164998386;5393.7033463159905;5396.703181324986;5405.702686352289;5412.78348866041;5414;4105.486814148231;4280.293751530962;4451.043025749479;5035.723035233024;5078.365204349457;3851.8459261629223;3878.903027424337;3974.940375894364;3979.960200397959;3988.700847436454;1176.2178151529308;1189.0606420927543;1192.9940350298193;1198.4547031100828;1211.9151659383758;912.8813254277035;939.7979434421495;948.4404201521136;953.1945506047379;973.9610415583297;5442.591805614595;5488.368837583649;5602.243697100921;5652.434756524397;5692.544596432275;936.3585943628636;957.4016239850093;973.124188230584;978.2907392140642;1032.0659802878406;3694.131879008431;3751.793651349202;3808;3821.7133714971487;4063.817128229237;10080.59677612902;10282.331648442827;10376.42929638862;10379.896201038044;10389.324693895023;10031.498425078717;10116.696499105039;10283.74290642725;10288.2798204125;10304.021117993778;7892.802679932933;8090.7054871220325;8097.635606397844;8099.473534220257;8107.310878575269;5532.446755324436;5541.750621221974;5645.971770141123;5671.602987790815;5753.568482363756;9551.235901128031;9632.855507167258;9669.129778319984;9690.95154524223;9711.417314961125;8272.751817445485;8543.530105844238;9625.663101791404;9635.22918166531;9776.755581110245;7302.707891684273;7424.443166762407;7441.776746697607;7612.467127301035;7614.695412183451;7863.410244231591;8032.357411407191;8104.716334928485;8274.048484424367;8277.710280140167;7355.926440735739;7430.814229644302;7447.888281675888;7456.179820219663;7585.317321440876;7219.530730502711;7266.7093316266755;7368.963155184189;7415.369693576106;7425.591592462466;6468.482521398371;6492.28584855656;6539.6403197824575;6547.9672601636685;6555.672216389066;4840.080384726891;4927.236278376858;4947.40631124253;4992.176290912104;5008.073506401327;4968.3044373788425;5030.647854650139;5100.897982040413;5132.9743351283005;5197.324347834758 11:41:53 INFO - PROCESS | 4605 | |4;prototype.html;347.9491934358238;356.93039857227853;360.23629904602245;360.3064101604411;360.63395653411794;5212.5308722214995;5316.0962636351815;5320.148776195804;5378.91931621026;5388.8113916013;5141.82003629873;5222.216667499877;5262.236975638531;5263.184206448007;5290.470952904708;4172.979135104335;4192;4200.928763165404;4201.327787553992;4212.852550160753;3978.820953057105;4175.749455032693;4189.79051047448;4197.685173611976;4207.389928460387;4144.129732756125;4149.356849688304;4151.252774500589;4154.569576797577;4156.833726650931;4122.340425531916;4132.793360331972;4134.400511925754;4142.958570414287;4168.333066709342;3707.94438083429;3712.2761061593;3717.442383642448;3719.5350581177354;3731.7201209909094;5012.974935125338;5123.949590333973;5153.896922061575;5169.638125331228;5172.870678233036;4754.9286760698615;4766.594839438617;4769.236922092448;4777.402824646919;4783.402074740658;5517.724113794335;5537.695426751527;5550.389457159709;5556.611037227396;5575.749091290902;3944.763314201128;4066.1867626474823;4084.9387259191135;4127.814248358831;4127.958720412787;5696.11710184922;5776.797812076557;5788.697543052822;5793.942060579382;5796.855078623068;4307.8492252771;4314.180305741899;4319.092990472036;4321.848735294249;4326.783660816946;4232.349383740344;4327.285997810326;4331.696781225347;4343.956560434355;4357.520672725997;4828.251620998751;4842.951570484321;4847.733374664427;4863.571182316529;4864;5631.324241091013;5636.379998200195;5644.435556444323;5645.633033852787;5649.293838270216;1360.265456653396;1366.1598117157876;1440.9567712968628;1445.4868521674864;1449.4347204590217;1003.693873368615;1016.9186465082776;1017.8931212222758;1035.5236591168148;1048.9475526223812;5159.581115193352;5195.636305458657;5224.216367544823;5232.502912223333;5234.345706786652;5388.703621300788;5422.213779002022;5424.965637885793;5430.972845135749;5470.589705772083;5247.763850626731;5258.2112683097075;5275.657082289639;5277.973610132001;5545.500904918576;2954.926126846846;2962.155785601093;2962.9407411851644;2972.390659914712;2973.7323640872423;5883.941160588425;5894.762099959056;5921.703914804242;5930.318013428425;5964.522838172936;5433.809816656398;5621.325440947031;5633.239512665819;5639.830805075854;5669.518090962314;5855.004649209644;5855.2973643163095;5873.767968172067;5896.852578685567;5922.496587790086;5360.418676490523;5590.133529302964;5591.440855914376;5606.299212598426;5636;5445.83662490126;5530.419305972815;5539.806106786243;5542.72286385671;5566.777328906798;5819.0689489681445;5838.12428135783;5848.385919478564;5848.561357898089;5877.911831322448;3924.234774219;3975.821088050987;3990.9822995136055;4004.4593979813517;4009.2983727846927;5411.675299482044;5457.99027179973;5486.369067557122;5498.3127109111365;5567.192757050286;5474.397816240131;5494.148406996922;5513.58648101386;5514.641548299348;5551.750171242385;5439.972800135974;5550.583706221969;5595.104783234826;5610.887782244414;5612.550995920398;5378.381486129145;5488.38092762644;5514.310711161105;5516.3797196331425;5585;5592.580556458363;5597.412271711574;5599.776008959596;5599.972000139973;5601;5239.842804715865;5473.31583552056;5475.6584636762655;5500.477454641803;5503.559715222693 11:41:53 INFO - PROCESS | 4605 | |5;yui.html;773.238360215188;774.7570782584414;838.1241602525361;882.479337191058;900.6127365232949;14825.77761333581;15100.773488397683;15601.843981560181;16450.917745411287;16543.09013004284;15094.47169349073;15101.395944162221;15224.314905829237;15259.237038148103;15265.618359541017;751.6542390500376;763.4426868386081;872.2498651159997;876.7676565710092;878.5080355001188;863.408565132886;878.1218781218781;884.6196135661695;893.63361021981;894.8478758611019;931.4318265857821;935.7426707655382;935.976600584984;935.9812803743921;936.1574582875432;930.2418528898926;931.776373670321;931.920786733125;932.6549176804558;933.2487347685077;680.0003994128673;680.1328306409318;680.3944489404435;680.829792551862;681.0397339750928;15230.619234519116;15284;15330.310136043905;15356.07863528192;15885.36458541657;12908.18705906861;13597.388117534734;13811.309434528233;13981.650458738512;14072.577822665336;12840.422181001877;13120.737585248336;13156;13369.064165508418;13676.316184190751;4625.121226966866;4628.305754136873;4722.291656251556;4725.929111063337;4838.540338667821;41834.790826045675;46262;51533.74233128848;65458.67270663664;68114.31885681179;12033.759324813454;12432.37838108091;12437.37813109359;12452.190607610657;12536.937315313366;21961.890190549264;21987.890060549915;22110.668339974913;22153;22213.55572888533;8843.248323892412;8978.955105224431;9057.094290571022;9323.673671421468;9475.289353298393;4909.975450122726;5024.246363045572;5091.592672586185;5098.821541246039;5103.260027296022;3536.487209354629;3653.178034942117;3662.597114317476;3667.651573100551;3669.5229620149744;643.6492111799081;656.8128083496181;661.7187695229508;662.2615783401473;662.2648859765657;708.674009955416;721.2138768741992;728.1407938632465;732.1177980533445;756.6443771427421;9268.582913768896;9504.90495095054;10126.44304563256;10291.38251704885;10409.895901041044;589.5872888977733;659.5482094765101;679.6873438218377;764.7399884039341;810.1129263456505;4343.283358245917;4880.487548807395;4964.528369804862;5034.11902916988;5126.846194614168;70759.2924070763;72789.6360518194;73273;80671.59664201642;84107.5794621023;57152;71833.2816671837;71876.64061679658;71985.28014719786;72183;42708.572914271084;42765.358519622234;43089.78455107767;43139;44697.776511117234;10054.245931555017;10117.08946194846;10402.063814256753;10599.841002384816;10671;34008.65991340055;42433;45371.54628453805;45529.77235113803;46155;36770;47605;59444.10833837582;60365.396346037734;62839.371606283356;12953.935230323788;12978;13223.471061157446;13297.800532992207;13326.733465330833;14040.368183431974;14066.156030638194;14391.424343026161;14777.187254701095;14854.702905941604;13745.175289482662;14034.368453419826;14065.718685626434;14640.92679536638;14690.779638305648;13137.277449740355;13139.408726607517;13166.341682915625;13234;13437;13872.722545549233;14050.297485125498;14213.50252741149;14272.429102836186;14431.42274309016;10613.310134841211;10638.946805266234;11080.5567777288;11216.775664486828;11248.94375528117;11589.826152607886;11728.88271117312;11746.647600571996;11768.646940591796;12180.634580962585 11:41:53 INFO - PROCESS | 4605 | __end_tp_report 11:41:53 INFO - PROCESS | 4605 | __start_cc_report 11:41:53 INFO - PROCESS | 4605 | _x_x_mozilla_cycle_collect,975 11:41:53 INFO - PROCESS | 4605 | __end_cc_report 11:41:53 INFO - PROCESS | 4605 | __startTimestamp1483818113322__endTimestamp 11:41:53 INFO - PROCESS | 4605 | 11:41:53 INFO - PROCESS | 4605 | ------- Summary: start ------- 11:41:53 INFO - PROCESS | 4605 | Number of tests: 6 11:41:53 INFO - PROCESS | 4605 | 11:41:53 INFO - PROCESS | 4605 | [#0] dojo.html Cycles:165 Average:5545.14 Median:5744.68 stddev:622.25 (10.8%) stddev-sans-first:597.14 11:41:53 INFO - PROCESS | 4605 | Values: 3233.4 3283.5 3297.9 3323.7 3335.2 5539.3 5605.3 5640.8 5642.1 5644.9 5579.6 5620.3 5641.9 5649.7 5671.3 5050.7 5067.7 5069.2 5094.6 5129.5 4837.0 4848.2 5120.1 5137.9 5140.6 4986.0 5012.7 5035.0 5038.4 5044.2 5087.1 5088.7 5152.8 5161.3 5187.3 4786.0 5043.2 5070.0 5100.6 5122.4 5351.8 5422.4 5434.0 5467.2 5495.0 5887.6 5899.3 5992.7 5999.3 6000.8 5668.1 6019.4 6032.0 6042.4 6053.7 5342.7 5485.5 5559.3 5562.0 5566.2 6055.3 6090.8 6095.7 6096.5 6097.0 5652.2 5838.7 5852.6 5854.8 5856.9 5779.6 5883.6 5941.3 5949.1 6026.2 5960.4 5974.2 5974.5 5985.4 6007.7 5924.6 5978.9 5983.9 5995.9 5996.0 4467.1 4518.1 4523.9 4599.7 4635.3 4169.9 4194.7 4215.3 4221.9 4235.7 5821.6 5829.8 5831.0 5833.1 5838.2 5733.1 5744.7 5792.5 6063.1 6081.6 5648.4 5677.7 5679.2 5755.3 5778.9 5177.4 5184.1 5184.9 5186.1 5186.2 6019.2 6226.5 6282.2 6301.8 6302.1 5770.2 5926.3 5934.7 5975.4 6081.1 6337.6 6345.3 6391.9 6396.6 6398.7 5927.7 5934.6 5935.7 5944.3 5947.2 5590.9 5633.5 5894.4 5937.6 5951.1 5874.6 5876.1 5884.3 5892.6 5897.0 5837.3 5845.4 5847.4 5850.0 5850.7 5496.5 5497.0 5694.3 5713.4 5856.0 5839.9 5842.5 5853.6 5860.6 5878.9 5476.6 5663.3 5714.1 5727.9 5730.1 11:41:53 INFO - PROCESS | 4605 | 11:41:53 INFO - PROCESS | 4605 | [#1] ext.html Cycles:180 Average:66304.42 Median:22450.90 stddev:130865.07 (582.9%) stddev-sans-first:131139.19 11:41:53 INFO - PROCESS | 4605 | Values: 597.2 617.7 651.8 653.6 657.9 34823.5 35430.0 37115.0 45285.3 46567.8 48193.0 48554.8 48586.3 48594.0 48616.8 8840.1 9005.1 9032.9 9036.1 9038.1 8373.4 8516.8 8540.2 8879.8 10564.3 10686.1 11042.9 11058.3 11058.4 11064.0 10837.1 10876.0 10894.1 10900.0 10906.2 10812.7 10850.5 10867.7 10875.6 10875.9 44748.1 44813.3 44919.6 45113.5 45170.5 3734.9 3804.9 3890.2 3962.9 3963.6 32347.7 35076.8 35076.9 35193.3 35283.0 4044.8 4181.9 4201.0 4205.2 4232.2 393533.0 400835.0 403673.0 403938.0 404174.0 70405.0 71393.6 71402.0 71458.3 71530.0 41405.6 42139.4 42259.6 45306.5 45313.8 19244.0 19543.0 19547.2 19548.8 19554.6 14499.4 14716.6 14737.9 14752.9 14755.0 18738.7 21383.9 21949.2 23159.4 23289.2 8106.0 8113.9 8261.8 8396.0 8426.7 994.3 1081.0 1094.3 1139.8 1219.4 34302.9 34686.8 34767.1 34909.3 35135.8 995.4 1107.5 1140.8 1201.5 1224.3 16409.0 18323.9 18686.3 19387.3 19425.4 560312.0 560442.0 560974.0 562293.0 563432.0 64166.4 64920.0 64935.0 64953.7 64990.0 1340.4 1361.2 1372.3 1374.8 1432.8 28434.6 34999.0 35829.6 37659.0 38676.4 63110.4 63717.4 63837.0 63928.0 63979.0 501324.0 504751.0 506999.0 507157.0 508190.0 31488.0 32496.0 40417.0 40857.0 45052.5 47524.5 51368.2 51545.2 51861.7 52162.7 43137.8 44191.6 44650.6 44930.8 45922.3 43038.1 43425.8 43811.0 44907.1 44907.1 44316.0 44321.3 44964.0 45152.5 45462.3 38052.6 39254.2 39765.4 40040.6 40141.0 29779.7 30118.4 30345.7 30612.8 30817.5 11:41:53 INFO - PROCESS | 4605 | 11:41:53 INFO - PROCESS | 4605 | [#2] jquery.html Cycles:180 Average:28780.47 Median:18303.95 stddev:76378.70 (417.3%) stddev-sans-first:76563.22 11:41:53 INFO - PROCESS | 4605 | Values: 394.8 425.7 433.7 437.0 441.3 15780.4 19204.0 20750.3 21038.8 21177.4 19905.7 20578.9 20656.8 20686.0 20786.5 5757.0 5964.3 5969.8 5977.1 5977.4 5841.4 6041.6 6110.5 6184.1 6188.5 5962.7 6114.5 6170.4 6175.9 6181.8 6177.2 6180.1 6217.1 6239.0 6243.8 5877.8 6036.6 6069.2 6069.3 6070.6 14752.8 14939.8 14948.9 22772.5 23523.0 2335.1 2380.0 2458.9 2562.7 2771.6 10605.1 11097.6 14592.9 14981.0 15614.5 1942.8 1952.1 1960.9 2031.4 2049.5 81317.0 85229.4 85383.0 88306.0 89725.6 10805.6 11868.4 11891.2 11974.7 12260.5 15790.9 15955.9 16641.3 16665.6 17146.4 8891.8 8959.8 8996.9 9102.6 9152.5 8823.1 8889.3 8939.7 9009.3 9073.9 4770.3 4929.3 5043.5 5103.6 5174.9 2049.7 2068.3 2105.6 2110.7 2115.7 478.4 884.5 983.2 1042.5 1057.1 12254.1 12822.7 13335.5 13367.2 13583.2 492.6 499.3 502.0 502.1 513.1 6896.7 7185.0 7236.3 7236.9 7300.2 417892.0 424944.0 464346.0 487163.0 495066.0 96502.5 105786.0 108400.0 111918.4 113583.0 1092.6 1095.6 1106.5 1110.6 1115.5 18520.8 18646.5 18770.3 18860.9 18944.6 33836.3 42215.2 42427.0 42834.4 43962.5 58825.7 60329.0 61471.4 61568.1 61889.4 8838.0 9040.3 9106.0 9140.8 9219.9 13644.6 14065.6 14272.5 14456.3 14484.8 12030.5 12187.9 12273.4 12590.4 12699.7 11918.2 12199.8 12208.8 12272.2 12672.9 11735.6 12176.8 12396.2 12486.5 12567.9 8820.3 9220.1 9243.0 9268.6 9483.0 11944.6 12017.0 12031.3 12094.9 12240.1 11:41:53 INFO - PROCESS | 4605 | 11:41:53 INFO - PROCESS | 4605 | [#3] mootools.html Cycles:180 Average:5570.24 Median:5235.10 stddev:3020.00 (57.7%) stddev-sans-first:3011.69 11:41:53 INFO - PROCESS | 4605 | Values: 1334.5 1503.5 1527.3 1653.4 1805.9 7141.1 8052.0 8283.0 8294.2 8520.1 8335.2 8407.0 8414.0 8418.8 8426.5 2439.1 2467.7 2467.9 2469.1 2474.8 2402.8 2511.4 2511.9 2513.5 2514.5 2431.1 2431.6 2432.3 2443.7 2458.2 2402.2 2421.5 2454.7 2461.1 2468.9 2405.2 2408.3 2423.9 2430.2 2439.0 8309.7 8348.9 8365.0 8389.8 8442.1 5272.9 5375.4 5471.2 5514.2 5526.8 3381.6 3598.5 3672.8 3674.9 3702.4 1086.6 1089.0 1112.0 1120.0 1120.9 11393.7 11411.4 11493.4 11536.6 11537.4 4473.6 4661.7 4761.9 4764.4 4765.5 9161.0 9178.3 9178.9 9180.4 9183.4 5393.7 5396.7 5405.7 5412.8 5414.0 4105.5 4280.3 4451.0 5035.7 5078.4 3851.8 3878.9 3974.9 3980.0 3988.7 1176.2 1189.1 1193.0 1198.5 1211.9 912.9 939.8 948.4 953.2 974.0 5442.6 5488.4 5602.2 5652.4 5692.5 936.4 957.4 973.1 978.3 1032.1 3694.1 3751.8 3808.0 3821.7 4063.8 10080.6 10282.3 10376.4 10379.9 10389.3 10031.5 10116.7 10283.7 10288.3 10304.0 7892.8 8090.7 8097.6 8099.5 8107.3 5532.4 5541.8 5646.0 5671.6 5753.6 9551.2 9632.9 9669.1 9691.0 9711.4 8272.8 8543.5 9625.7 9635.2 9776.8 7302.7 7424.4 7441.8 7612.5 7614.7 7863.4 8032.4 8104.7 8274.0 8277.7 7355.9 7430.8 7447.9 7456.2 7585.3 7219.5 7266.7 7369.0 7415.4 7425.6 6468.5 6492.3 6539.6 6548.0 6555.7 4840.1 4927.2 4947.4 4992.2 5008.1 4968.3 5030.6 5100.9 5133.0 5197.3 11:41:53 INFO - PROCESS | 4605 | 11:41:53 INFO - PROCESS | 4605 | [#4] prototype.html Cycles:180 Average:4678.94 Median:5260.22 stddev:1345.65 (25.6%) stddev-sans-first:1309.57 11:41:53 INFO - PROCESS | 4605 | Values: 347.9 356.9 360.2 360.3 360.6 5212.5 5316.1 5320.1 5378.9 5388.8 5141.8 5222.2 5262.2 5263.2 5290.5 4173.0 4192.0 4200.9 4201.3 4212.9 3978.8 4175.7 4189.8 4197.7 4207.4 4144.1 4149.4 4151.3 4154.6 4156.8 4122.3 4132.8 4134.4 4143.0 4168.3 3707.9 3712.3 3717.4 3719.5 3731.7 5013.0 5123.9 5153.9 5169.6 5172.9 4754.9 4766.6 4769.2 4777.4 4783.4 5517.7 5537.7 5550.4 5556.6 5575.7 3944.8 4066.2 4084.9 4127.8 4128.0 5696.1 5776.8 5788.7 5793.9 5796.9 4307.8 4314.2 4319.1 4321.8 4326.8 4232.3 4327.3 4331.7 4344.0 4357.5 4828.3 4843.0 4847.7 4863.6 4864.0 5631.3 5636.4 5644.4 5645.6 5649.3 1360.3 1366.2 1441.0 1445.5 1449.4 1003.7 1016.9 1017.9 1035.5 1048.9 5159.6 5195.6 5224.2 5232.5 5234.3 5388.7 5422.2 5425.0 5431.0 5470.6 5247.8 5258.2 5275.7 5278.0 5545.5 2954.9 2962.2 2962.9 2972.4 2973.7 5883.9 5894.8 5921.7 5930.3 5964.5 5433.8 5621.3 5633.2 5639.8 5669.5 5855.0 5855.3 5873.8 5896.9 5922.5 5360.4 5590.1 5591.4 5606.3 5636.0 5445.8 5530.4 5539.8 5542.7 5566.8 5819.1 5838.1 5848.4 5848.6 5877.9 3924.2 3975.8 3991.0 4004.5 4009.3 5411.7 5458.0 5486.4 5498.3 5567.2 5474.4 5494.1 5513.6 5514.6 5551.8 5440.0 5550.6 5595.1 5610.9 5612.6 5378.4 5488.4 5514.3 5516.4 5585.0 5592.6 5597.4 5599.8 5600.0 5601.0 5239.8 5473.3 5475.7 5500.5 5503.6 11:41:53 INFO - PROCESS | 4605 | 11:41:53 INFO - PROCESS | 4605 | [#5] yui.html Cycles:180 Average:16496.39 Median:23741.14 stddev:19726.07 (83.1%) stddev-sans-first:19746.07 11:41:53 INFO - PROCESS | 4605 | Values: 773.2 774.8 838.1 882.5 900.6 14825.8 15100.8 15601.8 16450.9 16543.1 15094.5 15101.4 15224.3 15259.2 15265.6 751.7 763.4 872.2 876.8 878.5 863.4 878.1 884.6 893.6 894.8 931.4 935.7 936.0 936.0 936.2 930.2 931.8 931.9 932.7 933.2 680.0 680.1 680.4 680.8 681.0 15230.6 15284.0 15330.3 15356.1 15885.4 12908.2 13597.4 13811.3 13981.7 14072.6 12840.4 13120.7 13156.0 13369.1 13676.3 4625.1 4628.3 4722.3 4725.9 4838.5 41834.8 46262.0 51533.7 65458.7 68114.3 12033.8 12432.4 12437.4 12452.2 12536.9 21961.9 21987.9 22110.7 22153.0 22213.6 8843.2 8979.0 9057.1 9323.7 9475.3 4910.0 5024.2 5091.6 5098.8 5103.3 3536.5 3653.2 3662.6 3667.7 3669.5 643.6 656.8 661.7 662.3 662.3 708.7 721.2 728.1 732.1 756.6 9268.6 9504.9 10126.4 10291.4 10409.9 589.6 659.5 679.7 764.7 810.1 4343.3 4880.5 4964.5 5034.1 5126.8 70759.3 72789.6 73273.0 80671.6 84107.6 57152.0 71833.3 71876.6 71985.3 72183.0 42708.6 42765.4 43089.8 43139.0 44697.8 10054.2 10117.1 10402.1 10599.8 10671.0 34008.7 42433.0 45371.5 45529.8 46155.0 36770.0 47605.0 59444.1 60365.4 62839.4 12953.9 12978.0 13223.5 13297.8 13326.7 14040.4 14066.2 14391.4 14777.2 14854.7 13745.2 14034.4 14065.7 14640.9 14690.8 13137.3 13139.4 13166.3 13234.0 13437.0 13872.7 14050.3 14213.5 14272.4 14431.4 10613.3 10638.9 11080.6 11216.8 11248.9 11589.8 11728.9 11746.6 11768.6 12180.6 11:41:53 INFO - PROCESS | 4605 | -------- Summary: end -------- 11:41:53 INFO - PROCESS | 4605 | 11:41:54 INFO - TEST-INFO | 4605: exit 0 11:41:54 INFO - TEST-OK | dromaeo_css | took 1115556ms 11:41:54 INFO - TEST-START | kraken 11:41:54 INFO - operating with platform_type : linux_ 11:41:54 INFO - Initialising browser for kraken test... 11:41:54 INFO - TEST-INFO | started process 4929 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpToK06s/profile http://localhost:50480/getInfo.html) 11:41:57 INFO - PROCESS | 4929 | __metrics Screen width/height:1600/1200 11:41:57 INFO - PROCESS | 4929 | colorDepth:24 11:41:57 INFO - PROCESS | 4929 | Browser inner width/height: 1024/697 11:41:57 INFO - PROCESS | 4929 | __metrics 11:41:58 INFO - PROCESS | 4929 | 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" 11:41:58 INFO - PROCESS | 4929 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:41:58 INFO - PROCESS | 4929 | console.error: PushService: 11:41:58 INFO - PROCESS | 4929 | stateChangeProcessEnqueue: Error transitioning state 11:41:58 INFO - PROCESS | 4929 | UnknownError 11:41:59 INFO - TEST-INFO | 4929: exit 0 11:41:59 INFO - Browser initialized. 11:41:59 INFO - Running cycle 1/1 for kraken test... 11:41:59 INFO - TEST-INFO | started process 5023 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpToK06s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:42:11 INFO - PROCESS | 5023 | RSS: Main: 144453632 11:42:11 INFO - PROCESS | 5023 | 11:42:13 INFO - PROCESS | 5023 | Cycle 1(1): loaded http://localhost:50480/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50480/tests/kraken/driver.html?testName=audio-beat-detection) 11:42:14 INFO - PROCESS | 5023 | RSS: Main: 185802752 11:42:14 INFO - PROCESS | 5023 | 11:42:17 INFO - PROCESS | 5023 | Cycle 1(1): loaded http://localhost:50480/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50480/tests/kraken/driver.html?testName=audio-dft) 11:42:17 INFO - PROCESS | 5023 | RSS: Main: 175202304 11:42:17 INFO - PROCESS | 5023 | 11:42:20 INFO - PROCESS | 5023 | Cycle 1(1): loaded http://localhost:50480/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50480/tests/kraken/driver.html?testName=audio-fft) 11:42:21 INFO - PROCESS | 5023 | RSS: Main: 266842112 11:42:21 INFO - PROCESS | 5023 | 11:42:23 INFO - PROCESS | 5023 | Cycle 1(1): loaded http://localhost:50480/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50480/tests/kraken/driver.html?testName=audio-oscillator) 11:42:23 INFO - PROCESS | 5023 | RSS: Main: 172716032 11:42:23 INFO - PROCESS | 5023 | 11:42:25 INFO - PROCESS | 5023 | Cycle 1(1): loaded http://localhost:50480/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50480/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:42:26 INFO - PROCESS | 5023 | RSS: Main: 175898624 11:42:26 INFO - PROCESS | 5023 | 11:42:29 INFO - PROCESS | 5023 | Cycle 1(1): loaded http://localhost:50480/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50480/tests/kraken/driver.html?testName=imaging-darkroom) 11:42:30 INFO - PROCESS | 5023 | RSS: Main: 214454272 11:42:30 INFO - PROCESS | 5023 | 11:42:33 INFO - PROCESS | 5023 | Cycle 1(1): loaded http://localhost:50480/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50480/tests/kraken/driver.html?testName=imaging-desaturate) 11:42:33 INFO - PROCESS | 5023 | RSS: Main: 213188608 11:42:33 INFO - PROCESS | 5023 | 11:42:36 INFO - PROCESS | 5023 | Cycle 1(1): loaded http://localhost:50480/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50480/tests/kraken/driver.html?testName=json-parse-financial) 11:42:37 INFO - PROCESS | 5023 | RSS: Main: 211492864 11:42:37 INFO - PROCESS | 5023 | 11:42:38 INFO - PROCESS | 5023 | Cycle 1(1): loaded http://localhost:50480/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50480/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:42:39 INFO - PROCESS | 5023 | RSS: Main: 174211072 11:42:39 INFO - PROCESS | 5023 | 11:42:40 INFO - PROCESS | 5023 | Cycle 1(1): loaded http://localhost:50480/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50480/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:42:41 INFO - PROCESS | 5023 | RSS: Main: 180948992 11:42:41 INFO - PROCESS | 5023 | 11:42:43 INFO - PROCESS | 5023 | Cycle 1(1): loaded http://localhost:50480/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50480/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:42:44 INFO - PROCESS | 5023 | RSS: Main: 189419520 11:42:44 INFO - PROCESS | 5023 | 11:42:46 INFO - PROCESS | 5023 | Cycle 1(1): loaded http://localhost:50480/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50480/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:42:47 INFO - PROCESS | 5023 | RSS: Main: 197791744 11:42:47 INFO - PROCESS | 5023 | 11:42:50 INFO - PROCESS | 5023 | Cycle 1(1): loaded http://localhost:50480/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50480/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:42:50 INFO - PROCESS | 5023 | RSS: Main: 194732032 11:42:50 INFO - PROCESS | 5023 | 11:42:52 INFO - PROCESS | 5023 | Cycle 1(1): loaded http://localhost:50480/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50480/tests/kraken/driver.html?testName=ai-astar) 11:42:52 INFO - PROCESS | 5023 | RSS: Main: 246497280 11:42:52 INFO - PROCESS | 5023 | 11:42:52 INFO - PROCESS | 5023 | __start_tp_report 11:42:52 INFO - PROCESS | 5023 | _x_x_mozilla_page_load 11:42:52 INFO - PROCESS | 5023 | _x_x_mozilla_page_load_details 11:42:52 INFO - PROCESS | 5023 | |i|pagename|runs| 11:42:52 INFO - PROCESS | 5023 | |0;ai-astar;104;109;110;114;112;112;111;112;111;111 11:42:52 INFO - PROCESS | 5023 | |1;audio-beat-detection;146;116;119;174;120;118;116;119;151;119 11:42:52 INFO - PROCESS | 5023 | |2;audio-dft;161;160;162;160;160;161;161;161;161;161 11:42:52 INFO - PROCESS | 5023 | |3;audio-fft;76;75;75;100;75;75;76;77;97;76 11:42:52 INFO - PROCESS | 5023 | |4;audio-oscillator;83;82;110;82;82;81;105;81;82;119 11:42:52 INFO - PROCESS | 5023 | |5;imaging-gaussian-blur;116;116;117;116;118;116;116;117;117;116 11:42:52 INFO - PROCESS | 5023 | |6;imaging-darkroom;147;146;145;146;145;146;146;146;146;146 11:42:52 INFO - PROCESS | 5023 | |7;imaging-desaturate;85;85;85;85;84;85;84;85;85;84 11:42:52 INFO - PROCESS | 5023 | |8;json-parse-financial;51;51;52;50;50;51;51;50;51;51 11:42:52 INFO - PROCESS | 5023 | |9;json-stringify-tinderbox;61;61;60;61;61;61;61;61;60;61 11:42:52 INFO - PROCESS | 5023 | |10;stanford-crypto-aes;75;74;80;74;76;74;74;75;74;74 11:42:52 INFO - PROCESS | 5023 | |11;stanford-crypto-ccm;123;121;129;121;120;120;120;121;168;125 11:42:52 INFO - PROCESS | 5023 | |12;stanford-crypto-pbkdf2;155;159;159;158;154;159;153;152;155;158 11:42:52 INFO - PROCESS | 5023 | |13;stanford-crypto-sha256-iterative;69;63;63;64;64;68;70;63;64;61 11:42:52 INFO - PROCESS | 5023 | __end_tp_report 11:42:52 INFO - PROCESS | 5023 | __start_cc_report 11:42:52 INFO - PROCESS | 5023 | _x_x_mozilla_cycle_collect,1612 11:42:52 INFO - PROCESS | 5023 | __end_cc_report 11:42:52 INFO - PROCESS | 5023 | __startTimestamp1483818172530__endTimestamp 11:42:52 INFO - PROCESS | 5023 | 11:42:52 INFO - PROCESS | 5023 | ------- Summary: start ------- 11:42:52 INFO - PROCESS | 5023 | Number of tests: 14 11:42:52 INFO - PROCESS | 5023 | 11:42:52 INFO - PROCESS | 5023 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.50 stddev:2.67 (2.4%) stddev-sans-first:1.41 11:42:52 INFO - PROCESS | 5023 | Values: 104.0 109.0 110.0 114.0 112.0 112.0 111.0 112.0 111.0 111.0 11:42:52 INFO - PROCESS | 5023 | 11:42:52 INFO - PROCESS | 5023 | [#1] audio-beat-detection Cycles:10 Average:129.80 Median:119.50 stddev:20.09 (16.8%) stddev-sans-first:20.43 11:42:52 INFO - PROCESS | 5023 | Values: 146.0 116.0 119.0 174.0 120.0 118.0 116.0 119.0 151.0 119.0 11:42:52 INFO - PROCESS | 5023 | 11:42:52 INFO - PROCESS | 5023 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 11:42:52 INFO - PROCESS | 5023 | Values: 161.0 160.0 162.0 160.0 160.0 161.0 161.0 161.0 161.0 161.0 11:42:52 INFO - PROCESS | 5023 | 11:42:52 INFO - PROCESS | 5023 | [#3] audio-fft Cycles:10 Average:80.20 Median:76.00 stddev:9.69 (12.8%) stddev-sans-first:10.16 11:42:52 INFO - PROCESS | 5023 | Values: 76.0 75.0 75.0 100.0 75.0 75.0 76.0 77.0 97.0 76.0 11:42:52 INFO - PROCESS | 5023 | 11:42:52 INFO - PROCESS | 5023 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:82.00 stddev:14.64 (17.8%) stddev-sans-first:15.26 11:42:52 INFO - PROCESS | 5023 | Values: 83.0 82.0 110.0 82.0 82.0 81.0 105.0 81.0 82.0 119.0 11:42:52 INFO - PROCESS | 5023 | 11:42:52 INFO - PROCESS | 5023 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:116.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 11:42:52 INFO - PROCESS | 5023 | Values: 116.0 116.0 117.0 116.0 118.0 116.0 116.0 117.0 117.0 116.0 11:42:52 INFO - PROCESS | 5023 | 11:42:52 INFO - PROCESS | 5023 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.44 11:42:52 INFO - PROCESS | 5023 | Values: 147.0 146.0 145.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 11:42:52 INFO - PROCESS | 5023 | 11:42:52 INFO - PROCESS | 5023 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 11:42:52 INFO - PROCESS | 5023 | Values: 85.0 85.0 85.0 85.0 84.0 85.0 84.0 85.0 85.0 84.0 11:42:52 INFO - PROCESS | 5023 | 11:42:52 INFO - PROCESS | 5023 | [#8] json-parse-financial Cycles:10 Average:50.80 Median:51.00 stddev:0.63 (1.2%) stddev-sans-first:0.67 11:42:52 INFO - PROCESS | 5023 | Values: 51.0 51.0 52.0 50.0 50.0 51.0 51.0 50.0 51.0 51.0 11:42:52 INFO - PROCESS | 5023 | 11:42:52 INFO - PROCESS | 5023 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 11:42:52 INFO - PROCESS | 5023 | Values: 61.0 61.0 60.0 61.0 61.0 61.0 61.0 61.0 60.0 61.0 11:42:52 INFO - PROCESS | 5023 | 11:42:52 INFO - PROCESS | 5023 | [#10] stanford-crypto-aes Cycles:10 Average:75.00 Median:74.50 stddev:1.89 (2.5%) stddev-sans-first:2.00 11:42:52 INFO - PROCESS | 5023 | Values: 75.0 74.0 80.0 74.0 76.0 74.0 74.0 75.0 74.0 74.0 11:42:52 INFO - PROCESS | 5023 | 11:42:52 INFO - PROCESS | 5023 | [#11] stanford-crypto-ccm Cycles:10 Average:126.80 Median:122.00 stddev:14.76 (12.1%) stddev-sans-first:15.59 11:42:52 INFO - PROCESS | 5023 | Values: 123.0 121.0 129.0 121.0 120.0 120.0 120.0 121.0 168.0 125.0 11:42:52 INFO - PROCESS | 5023 | 11:42:52 INFO - PROCESS | 5023 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.20 Median:158.00 stddev:2.70 (1.7%) stddev-sans-first:2.83 11:42:52 INFO - PROCESS | 5023 | Values: 155.0 159.0 159.0 158.0 154.0 159.0 153.0 152.0 155.0 158.0 11:42:52 INFO - PROCESS | 5023 | 11:42:52 INFO - PROCESS | 5023 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:64.00 stddev:3.00 (4.7%) stddev-sans-first:2.79 11:42:52 INFO - PROCESS | 5023 | Values: 69.0 63.0 63.0 64.0 64.0 68.0 70.0 63.0 64.0 61.0 11:42:52 INFO - PROCESS | 5023 | -------- Summary: end -------- 11:42:52 INFO - PROCESS | 5023 | 11:42:53 INFO - TEST-INFO | 5023: exit 0 11:42:53 INFO - TEST-OK | kraken | took 59526ms 11:42:53 INFO - SUITE-END | took 1175s 11:42:53 INFO - Completed test suite (00:19:35) 11:42:53 INFO - javascript benchmark 11:42:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3233.4018206631777, 3283.4910588858734, 3297.8515966781492, 3323.7174840138587, 3335.24956884701, 5539.335279766428, 5605.327360716709, 5640.802571909984, 5642.097264437685, 5644.858878528039, 5579.581531385153, 5620.269364982547, 5641.8589535261635, 5649.745761440735, 5671.319441667006, 5050.722210278424, 5067.695938243699, 5069.188929771238, 5094.592432605401, 5129.461406552315, 4837.0325934813, 4848.224284114543, 5120.052790233819, 5137.871553211162, 5140.588752899759, 4985.975070124662, 5012.699238045729, 5035.0, 5038.370203724535, 5044.243363495487, 5087.084324821531, 5088.7201203933955, 5152.793888244466, 5161.277421161003, 5187.325647665817, 4785.9521404785855, 5043.167877300241, 5069.986002799418, 5100.642954993152, 5122.3853137623355, 5351.812686555952, 5422.3764267109, 5434.049041417736, 5467.234587157801, 5494.983428065821, 5887.646741195542, 5899.2920849497905, 5992.730327135289, 5999.310079340888, 6000.819975400745, 5668.064769313059, 6019.398060193989, 6031.969840150771, 6042.425969532887, 6053.727582258809, 5342.706151161685, 5485.451454854562, 5559.27729395176, 5561.972190139104, 5566.165075238747, 6055.333913269536, 6090.756369745249, 6095.695215239309, 6096.512279017668, 6097.024476083805, 5652.208690783294, 5838.678872662044, 5852.561057920673, 5854.795082172103, 5856.941430585724, 5779.566532509994, 5883.61756485827, 5941.257342832146, 5949.077892926603, 6026.216591843032, 5960.433758792908, 5974.163617093611, 5974.462298393166, 5985.431384018511, 6007.669578173242, 5924.644521328734, 5978.940210597925, 5983.880322393527, 5995.940040599626, 5995.970020149872, 4467.061916997467, 4518.051209246029, 4523.886902827456, 4599.724016559017, 4635.258358662598, 4169.854055108057, 4194.6853985951175, 4215.346621273708, 4221.852235171754, 4235.724677895989, 5821.592488525847, 5829.8251052468495, 5830.950428922834, 5833.125031245348, 5838.182654428383, 5733.0540460823495, 5744.684042377709, 5792.536597072224, 6063.090536419572, 6081.5742897996715, 5648.350439699405, 5677.744501497443, 5679.233303503974, 5755.251817263729, 5778.902008618349, 5177.378714554277, 5184.066867963727, 5184.896302074013, 5186.092433824141, 5186.170212766015, 6019.1573179754, 6226.533010024175, 6282.2147231596055, 6301.8109456716375, 6302.086197501429, 5770.2498675171955, 5926.318473375444, 5934.732937017931, 5975.40245975399, 6081.118237855575, 6337.556371053982, 6345.333739957238, 6391.936080639134, 6396.648184349905, 6398.712057957497, 5927.673977931255, 5934.584579079423, 5935.732892019783, 5944.256967879015, 5947.167396564571, 5590.944090559043, 5633.464820842013, 5894.440028197314, 5937.584369094122, 5951.107333899777, 5874.618149820248, 5876.059830427112, 5884.32330282023, 5892.558058145742, 5897.0, 5837.270341207349, 5845.444682755132, 5847.38602446737, 5849.976254155421, 5850.7074646266665, 5496.477834605706, 5497.0, 5694.345150307602, 5713.400092990176, 5856.033754430641, 5839.941600583939, 5842.474177324061, 5853.590248682552, 5860.589758716849, 5878.853028674317, 5476.616636835383, 5663.292088488939, 5714.114312281603, 5727.8854422912145, 5730.08318669011], "value": 5504.645595681627, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.2146627185251, 617.6818938246802, 651.7686221391405, 653.5817077070673, 657.9276279609239, 34823.4776478353, 35430.0, 37115.0, 45285.32072018922, 46567.76716116415, 48193.0, 48554.75722621391, 48586.27120593185, 48594.0, 48616.75691621537, 8840.115988401156, 9005.099490051009, 9032.909670903273, 9036.051214622468, 9038.096190380942, 8373.41386102973, 8516.829663406728, 8540.231379175873, 8879.77800554988, 10564.313319634237, 10686.091682206983, 11042.889571104306, 11058.281211721252, 11058.447077646086, 11064.0, 10837.078848297904, 10876.0, 10894.128469722404, 10900.0, 10906.236563440561, 10812.67561973142, 10850.457477126112, 10867.673969780919, 10875.619353322674, 10875.891241087567, 44748.10503789938, 44813.327800083025, 44919.55080449186, 45113.548864511264, 45170.548294516964, 3734.8879533614036, 3804.90487737806, 3890.2219556088894, 3962.9405558916637, 3963.6036396360423, 32347.676523234702, 35076.82461587701, 35076.947691569294, 35193.296134077435, 35283.0, 4044.797760112012, 4181.916361672749, 4200.957990420118, 4205.179989901971, 4232.153569286155, 393533.0, 400835.0, 403673.0, 403938.0, 404174.0, 70405.0, 71393.64303178451, 71402.0, 71458.28541714621, 71530.0, 41405.585944140774, 42139.367909481385, 42259.57740422618, 45306.54693453023, 45313.773431132635, 19244.0, 19543.0, 19547.218111275673, 19548.8045119547, 19554.608907821763, 14499.420023198954, 14716.632084197767, 14737.926310368379, 14752.926235368754, 14755.0, 18738.668057196825, 21383.893080534497, 21949.231776887733, 23159.421014474436, 23289.18487852917, 8106.015574658956, 8113.8782918256275, 8261.83476330482, 8396.0, 8426.747197584082, 994.2692121290845, 1081.0270756319376, 1094.2504384496644, 1139.834723965037, 1219.40249277855, 34302.93579632389, 34686.826565867515, 34767.13082172915, 34909.301813963575, 35135.824320878746, 995.3629677006721, 1107.5071593141136, 1140.766142940695, 1201.4773573495556, 1224.3143839449936, 16409.0, 18323.90838045801, 18686.25254989785, 19387.321443749683, 19425.4172374829, 560312.0, 560442.0, 560974.0, 562293.0, 563432.0, 64166.358336416975, 64920.0, 64935.0, 64953.675231623536, 64990.0, 1340.3767248229426, 1361.217300052454, 1372.2726954714017, 1374.8350197976106, 1432.8065711129072, 28434.57348139821, 34999.0, 35829.64170358367, 37659.0, 38676.41985370166, 63110.36889631045, 63717.36282637114, 63837.0, 63928.0, 63979.0, 501324.0, 504751.0, 506999.0, 507157.0, 508190.0, 31488.0, 32496.0, 40417.0, 40857.0, 45052.549474504835, 47524.524754753395, 51368.22947655863, 51545.22682159846, 51861.740691296305, 52162.73918630383, 43137.78431107824, 44191.55808441874, 44650.55349446594, 44930.77534612306, 45922.311165333216, 43038.139237215706, 43425.7828710867, 43811.0, 44907.10185796201, 44907.10185796331, 44316.0, 44321.335179971684, 44964.0, 45152.54847451615, 45462.318065228385, 38052.619473806015, 39254.2149157021, 39765.403518947816, 40040.59959400369, 40141.0, 29779.70220297856, 30118.397632047676, 30345.69654303517, 30612.846935765177, 30817.537736933515], "value": 21936.50396780646, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.75919688989694, 425.7285562590947, 433.687744823727, 437.03633488158596, 441.282915262698, 15780.368785248576, 19204.039798010097, 20750.27374041909, 21038.789612103876, 21177.364679059654, 19905.701414478757, 20578.89710551445, 20656.793432065675, 20686.0, 20786.480337991557, 5756.971215143918, 5964.254468191476, 5969.791057312973, 5977.1034344848185, 5977.432143946318, 5841.415858414167, 6041.577089603729, 6110.511159107283, 6184.134221209034, 6188.5358598105095, 5962.672053037081, 6114.480269177103, 6170.413810687977, 6175.876482470348, 6181.81454556364, 6177.166082578839, 6180.072989051633, 6217.129601855721, 6239.001759718469, 6243.843903902393, 5877.764889404419, 6036.637801731867, 6069.15031895535, 6069.332373438918, 6070.57505974582, 14752.778708319383, 14939.775903361458, 14948.925255373653, 22772.544549108927, 23523.0, 2335.100986120339, 2380.0276840040347, 2458.864762438065, 2562.7309132541186, 2771.5704065869822, 10605.098566621846, 11097.611583594535, 14592.854071459362, 14981.0, 15614.45349412765, 1942.7668679758378, 1952.1215453046186, 1960.862739608228, 2031.4210450021674, 2049.467138543974, 81317.0, 85229.44311670659, 85383.0, 88306.0, 89725.55137224273, 10805.567777288978, 11868.406579670982, 11891.16761826681, 11974.700632484257, 12260.509579616715, 15790.9210453947, 15955.920220399055, 16641.251143698562, 16665.583360416087, 17146.39987600453, 8891.822163556693, 8959.776005599912, 8996.910030899608, 9102.590383432762, 9152.54237288133, 8823.073577274294, 8889.288856891433, 8939.73180804577, 9009.324300677476, 9073.909260907438, 4770.260609605517, 4929.334539837076, 5043.4956504349275, 5103.566196873233, 5174.922376164361, 2049.7291679159016, 2068.348470231872, 2105.610462064523, 2110.6728457089175, 2115.724955755742, 478.4354461735186, 884.4737381258141, 983.1663946739279, 1042.5048102151418, 1057.0750593230923, 12254.142210045211, 12822.743545129231, 13335.533256335983, 13367.197968121944, 13583.185008899498, 492.57884508745224, 499.28103530915365, 501.9949800502021, 502.08119141970104, 513.0559770023175, 6896.689648965808, 7184.9640751795905, 7236.276372362827, 7236.855262894818, 7300.233475485104, 417892.0, 424944.0, 464346.0, 487163.0, 495066.0, 96502.51748741211, 105786.0, 108400.0, 111918.44040779745, 113583.0, 1092.639428988432, 1095.6439157273917, 1106.4854842498278, 1110.6001839337832, 1115.5091759625577, 18520.81479185245, 18646.53383665365, 18770.25235051894, 18860.905695471436, 18944.621107577495, 33836.32327353489, 42215.155696886504, 42427.0, 42834.357484637134, 43962.46131385386, 58825.70587147037, 60329.0, 61471.385286146564, 61568.07647885196, 61889.38110618836, 8838.027816940003, 9040.321975851706, 9105.954470227607, 9140.765996590375, 9219.907800921905, 13644.590662280147, 14065.648358791112, 14272.500462483764, 14456.349464273922, 14484.782728258873, 12030.458629361525, 12187.878121218675, 12273.386330683608, 12590.370481475706, 12699.746005080031, 11918.225315354473, 12199.817002744789, 12208.816867746813, 12272.202306850026, 12672.873271267537, 11735.647930562096, 12176.75646487083, 12396.194247373893, 12486.500539978299, 12567.87432125667, 8820.294376449998, 9220.124088211609, 9243.0, 9268.582913768762, 9482.952585237306, 11944.64166075019, 12017.038636908852, 12031.27812331263, 12094.939525302318, 12240.143189976616], "value": 9280.937657434255, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1334.499562664001, 1503.4737841755386, 1527.2807026288765, 1653.4295667994538, 1805.9187336569853, 7141.107361579802, 8052.0, 8282.958585207065, 8294.212049855269, 8520.105388934166, 8335.249827515538, 8406.95796521018, 8414.03238627558, 8418.789530261747, 8426.494410335385, 2439.085342996381, 2467.703875534938, 2467.864267465298, 2469.1481438903547, 2474.7648973347505, 2402.8438151520095, 2511.4474815540552, 2511.9246422607353, 2513.5349960257317, 2514.53481105996, 2431.112643884987, 2431.598786200275, 2432.343267317823, 2443.657887895696, 2458.2010846474877, 2402.1952645863657, 2421.4793819328843, 2454.7054353477606, 2461.113998960373, 2468.8888999995042, 2405.20628192696, 2408.301592538179, 2423.915162969305, 2430.2344761400277, 2439.0, 8309.667613295462, 8348.874766878502, 8364.958175209145, 8389.832203355898, 8442.113578074275, 5272.868178295535, 5375.408705042442, 5471.206675032138, 5514.200440936042, 5526.751296191681, 3381.5773028371455, 3598.4962105305276, 3672.8347224374966, 3674.876355098172, 3702.426123950765, 1086.6468397770757, 1088.967330980072, 1111.9833202501968, 1120.0311730353185, 1120.910327173824, 11393.658190254306, 11411.42942852854, 11493.42532873353, 11536.59621913229, 11537.423128843524, 4473.619742321874, 4661.673682842168, 4761.9047619048115, 4764.356811830427, 4765.523447655276, 9161.0, 9178.265738740885, 9178.908210917938, 9180.44917304964, 9183.357164998386, 5393.7033463159905, 5396.703181324986, 5405.702686352289, 5412.78348866041, 5414.0, 4105.486814148231, 4280.293751530962, 4451.043025749479, 5035.723035233024, 5078.365204349457, 3851.8459261629223, 3878.903027424337, 3974.940375894364, 3979.960200397959, 3988.700847436454, 1176.2178151529308, 1189.0606420927543, 1192.9940350298193, 1198.4547031100828, 1211.9151659383758, 912.8813254277035, 939.7979434421495, 948.4404201521136, 953.1945506047379, 973.9610415583297, 5442.591805614595, 5488.368837583649, 5602.243697100921, 5652.434756524397, 5692.544596432275, 936.3585943628636, 957.4016239850093, 973.124188230584, 978.2907392140642, 1032.0659802878406, 3694.131879008431, 3751.793651349202, 3808.0, 3821.7133714971487, 4063.817128229237, 10080.59677612902, 10282.331648442827, 10376.42929638862, 10379.896201038044, 10389.324693895023, 10031.498425078717, 10116.696499105039, 10283.74290642725, 10288.2798204125, 10304.021117993778, 7892.802679932933, 8090.7054871220325, 8097.635606397844, 8099.473534220257, 8107.310878575269, 5532.446755324436, 5541.750621221974, 5645.971770141123, 5671.602987790815, 5753.568482363756, 9551.235901128031, 9632.855507167258, 9669.129778319984, 9690.95154524223, 9711.417314961125, 8272.751817445485, 8543.530105844238, 9625.663101791404, 9635.22918166531, 9776.755581110245, 7302.707891684273, 7424.443166762407, 7441.776746697607, 7612.467127301035, 7614.695412183451, 7863.410244231591, 8032.357411407191, 8104.716334928485, 8274.048484424367, 8277.710280140167, 7355.926440735739, 7430.814229644302, 7447.888281675888, 7456.179820219663, 7585.317321440876, 7219.530730502711, 7266.7093316266755, 7368.963155184189, 7415.369693576106, 7425.591592462466, 6468.482521398371, 6492.28584855656, 6539.6403197824575, 6547.9672601636685, 6555.672216389066, 4840.080384726891, 4927.236278376858, 4947.40631124253, 4992.176290912104, 5008.073506401327, 4968.3044373788425, 5030.647854650139, 5100.897982040413, 5132.9743351283005, 5197.324347834758], "value": 4537.780474437231, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.9491934358238, 356.93039857227853, 360.23629904602245, 360.3064101604411, 360.63395653411794, 5212.5308722214995, 5316.0962636351815, 5320.148776195804, 5378.91931621026, 5388.8113916013, 5141.82003629873, 5222.216667499877, 5262.236975638531, 5263.184206448007, 5290.470952904708, 4172.979135104335, 4192.0, 4200.928763165404, 4201.327787553992, 4212.852550160753, 3978.820953057105, 4175.749455032693, 4189.79051047448, 4197.685173611976, 4207.389928460387, 4144.129732756125, 4149.356849688304, 4151.252774500589, 4154.569576797577, 4156.833726650931, 4122.340425531916, 4132.793360331972, 4134.400511925754, 4142.958570414287, 4168.333066709342, 3707.94438083429, 3712.2761061593, 3717.442383642448, 3719.5350581177354, 3731.7201209909094, 5012.974935125338, 5123.949590333973, 5153.896922061575, 5169.638125331228, 5172.870678233036, 4754.9286760698615, 4766.594839438617, 4769.236922092448, 4777.402824646919, 4783.402074740658, 5517.724113794335, 5537.695426751527, 5550.389457159709, 5556.611037227396, 5575.749091290902, 3944.763314201128, 4066.1867626474823, 4084.9387259191135, 4127.814248358831, 4127.958720412787, 5696.11710184922, 5776.797812076557, 5788.697543052822, 5793.942060579382, 5796.855078623068, 4307.8492252771, 4314.180305741899, 4319.092990472036, 4321.848735294249, 4326.783660816946, 4232.349383740344, 4327.285997810326, 4331.696781225347, 4343.956560434355, 4357.520672725997, 4828.251620998751, 4842.951570484321, 4847.733374664427, 4863.571182316529, 4864.0, 5631.324241091013, 5636.379998200195, 5644.435556444323, 5645.633033852787, 5649.293838270216, 1360.265456653396, 1366.1598117157876, 1440.9567712968628, 1445.4868521674864, 1449.4347204590217, 1003.693873368615, 1016.9186465082776, 1017.8931212222758, 1035.5236591168148, 1048.9475526223812, 5159.581115193352, 5195.636305458657, 5224.216367544823, 5232.502912223333, 5234.345706786652, 5388.703621300788, 5422.213779002022, 5424.965637885793, 5430.972845135749, 5470.589705772083, 5247.763850626731, 5258.2112683097075, 5275.657082289639, 5277.973610132001, 5545.500904918576, 2954.926126846846, 2962.155785601093, 2962.9407411851644, 2972.390659914712, 2973.7323640872423, 5883.941160588425, 5894.762099959056, 5921.703914804242, 5930.318013428425, 5964.522838172936, 5433.809816656398, 5621.325440947031, 5633.239512665819, 5639.830805075854, 5669.518090962314, 5855.004649209644, 5855.2973643163095, 5873.767968172067, 5896.852578685567, 5922.496587790086, 5360.418676490523, 5590.133529302964, 5591.440855914376, 5606.299212598426, 5636.0, 5445.83662490126, 5530.419305972815, 5539.806106786243, 5542.72286385671, 5566.777328906798, 5819.0689489681445, 5838.12428135783, 5848.385919478564, 5848.561357898089, 5877.911831322448, 3924.234774219, 3975.821088050987, 3990.9822995136055, 4004.4593979813517, 4009.2983727846927, 5411.675299482044, 5457.99027179973, 5486.369067557122, 5498.3127109111365, 5567.192757050286, 5474.397816240131, 5494.148406996922, 5513.58648101386, 5514.641548299348, 5551.750171242385, 5439.972800135974, 5550.583706221969, 5595.104783234826, 5610.887782244414, 5612.550995920398, 5378.381486129145, 5488.38092762644, 5514.310711161105, 5516.3797196331425, 5585.0, 5592.580556458363, 5597.412271711574, 5599.776008959596, 5599.972000139973, 5601.0, 5239.842804715865, 5473.31583552056, 5475.6584636762655, 5500.477454641803, 5503.559715222693], "value": 4260.232207127436, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [773.238360215188, 774.7570782584414, 838.1241602525361, 882.479337191058, 900.6127365232949, 14825.77761333581, 15100.773488397683, 15601.843981560181, 16450.917745411287, 16543.09013004284, 15094.47169349073, 15101.395944162221, 15224.314905829237, 15259.237038148103, 15265.618359541017, 751.6542390500376, 763.4426868386081, 872.2498651159997, 876.7676565710092, 878.5080355001188, 863.408565132886, 878.1218781218781, 884.6196135661695, 893.63361021981, 894.8478758611019, 931.4318265857821, 935.7426707655382, 935.976600584984, 935.9812803743921, 936.1574582875432, 930.2418528898926, 931.776373670321, 931.920786733125, 932.6549176804558, 933.2487347685077, 680.0003994128673, 680.1328306409318, 680.3944489404435, 680.829792551862, 681.0397339750928, 15230.619234519116, 15284.0, 15330.310136043905, 15356.07863528192, 15885.36458541657, 12908.18705906861, 13597.388117534734, 13811.309434528233, 13981.650458738512, 14072.577822665336, 12840.422181001877, 13120.737585248336, 13156.0, 13369.064165508418, 13676.316184190751, 4625.121226966866, 4628.305754136873, 4722.291656251556, 4725.929111063337, 4838.540338667821, 41834.790826045675, 46262.0, 51533.74233128848, 65458.67270663664, 68114.31885681179, 12033.759324813454, 12432.37838108091, 12437.37813109359, 12452.190607610657, 12536.937315313366, 21961.890190549264, 21987.890060549915, 22110.668339974913, 22153.0, 22213.55572888533, 8843.248323892412, 8978.955105224431, 9057.094290571022, 9323.673671421468, 9475.289353298393, 4909.975450122726, 5024.246363045572, 5091.592672586185, 5098.821541246039, 5103.260027296022, 3536.487209354629, 3653.178034942117, 3662.597114317476, 3667.651573100551, 3669.5229620149744, 643.6492111799081, 656.8128083496181, 661.7187695229508, 662.2615783401473, 662.2648859765657, 708.674009955416, 721.2138768741992, 728.1407938632465, 732.1177980533445, 756.6443771427421, 9268.582913768896, 9504.90495095054, 10126.44304563256, 10291.38251704885, 10409.895901041044, 589.5872888977733, 659.5482094765101, 679.6873438218377, 764.7399884039341, 810.1129263456505, 4343.283358245917, 4880.487548807395, 4964.528369804862, 5034.11902916988, 5126.846194614168, 70759.2924070763, 72789.6360518194, 73273.0, 80671.59664201642, 84107.5794621023, 57152.0, 71833.2816671837, 71876.64061679658, 71985.28014719786, 72183.0, 42708.572914271084, 42765.358519622234, 43089.78455107767, 43139.0, 44697.776511117234, 10054.245931555017, 10117.08946194846, 10402.063814256753, 10599.841002384816, 10671.0, 34008.65991340055, 42433.0, 45371.54628453805, 45529.77235113803, 46155.0, 36770.0, 47605.0, 59444.10833837582, 60365.396346037734, 62839.371606283356, 12953.935230323788, 12978.0, 13223.471061157446, 13297.800532992207, 13326.733465330833, 14040.368183431974, 14066.156030638194, 14391.424343026161, 14777.187254701095, 14854.702905941604, 13745.175289482662, 14034.368453419826, 14065.718685626434, 14640.92679536638, 14690.779638305648, 13137.277449740355, 13139.408726607517, 13166.341682915625, 13234.0, 13437.0, 13872.722545549233, 14050.297485125498, 14213.50252741149, 14272.429102836186, 14431.42274309016, 10613.310134841211, 10638.946805266234, 11080.5567777288, 11216.775664486828, 11248.94375528117, 11589.826152607886, 11728.88271117312, 11746.647600571996, 11768.646940591796, 12180.634580962585], "value": 7363.436305999079, "unit": "score"}], "name": "dromaeo_css", "value": 7364.597794298398, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 109.0, 110.0, 114.0, 112.0, 112.0, 111.0, 112.0, 111.0, 111.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 116.0, 119.0, 174.0, 120.0, 118.0, 116.0, 119.0, 151.0, 119.0], "value": 129.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 160.0, 160.0, 161.0, 161.0, 161.0, 161.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 100.0, 75.0, 75.0, 76.0, 77.0, 97.0, 76.0], "value": 80.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 110.0, 82.0, 82.0, 81.0, 105.0, 81.0, 82.0, 119.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 116.0, 118.0, 116.0, 116.0, 117.0, 117.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 84.0, 85.0, 84.0, 85.0, 85.0, 84.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 52.0, 50.0, 50.0, 51.0, 51.0, 50.0, 51.0, 51.0], "value": 50.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 61.0, 61.0, 61.0, 61.0, 61.0, 60.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 80.0, 74.0, 76.0, 74.0, 74.0, 75.0, 74.0, 74.0], "value": 75.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 121.0, 129.0, 121.0, 120.0, 120.0, 120.0, 121.0, 168.0, 125.0], "value": 126.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 159.0, 159.0, 158.0, 154.0, 159.0, 153.0, 152.0, 155.0, 158.0], "value": 156.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 63.0, 63.0, 64.0, 64.0, 68.0, 70.0, 63.0, 64.0, 61.0], "value": 64.9, "unit": "score"}], "name": "kraken", "value": 1453.7, "alertThreshold": 2.0}]} 11:42:53 INFO - Return code: 0 11:42:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:42:53 INFO - # TBPL SUCCESS # 11:42:53 INFO - Running post-action listener: _resource_record_post_action 11:42:53 INFO - [mozharness: 2017-01-07 19:42:53.860534Z] Finished run-tests step (success) 11:42:53 INFO - Running post-run listener: _resource_record_post_run 11:42:53 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 348942336; Read time: 12; Write time: 224816 11:42:53 INFO - TinderboxPrint: CPU usage
13.0% 11:42:53 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 11:42:53 INFO - TinderboxPrint: I/O write bytes / time
348,942,336 / 224,816 11:42:53 INFO - TinderboxPrint: CPU idle
8,270.9 (87.0%) 11:42:53 INFO - TinderboxPrint: CPU user
1,191.4 (12.5%) 11:42:53 INFO - TinderboxPrint: Swap in / out
0 / 0 11:42:53 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 111284224; Read time: 0; Write time: 72864 11:42:53 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 237658112; Read time: 0; Write time: 151952 11:42:54 INFO - Running post-run listener: _upload_blobber_files 11:42:54 INFO - Blob upload gear active. 11:42:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:42:54 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 11:42:54 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'] 11:42:54 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 11:42:54 INFO - (blobuploader) - INFO - Open directory for files ... 11:42:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:42:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:42:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:42:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:42:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:42:55 INFO - (blobuploader) - INFO - Done attempting. 11:42:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:42:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:42:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:42:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:42:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:42:56 INFO - (blobuploader) - INFO - Done attempting. 11:42:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:42:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:42:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:42:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:42:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:42:59 INFO - (blobuploader) - INFO - Done attempting. 11:42:59 INFO - (blobuploader) - INFO - Iteration through files over. 11:42:59 INFO - Return code: 0 11:42:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:42:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:42:59 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4e7bfe6bbb3d11c8f6e2983964cdc9d6c764a1c728e9d22f81a3493cf6f2968f877be8115fb3c18ec66822669b0773b7fa3dc443650578da9d91fdea9b8c2bc1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/57274eb3b9942f532bdc7b5b07c672811431f3d1e55f359a5228c5c0710463b7ac8c8271b89fc748984aec4575b9f1bbbfdd077f976ee73579f3d4c2830c9954", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f2646516c50dcc73e036ec5ab23bda11898ad1a7f647711c6f3d42204fd509c5c910d52a302cbb77f5162e1324457686a26b782ba1b78328a739c4567bc4e298"} 11:42:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:42:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:42:59 INFO - Contents: 11:42:59 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4e7bfe6bbb3d11c8f6e2983964cdc9d6c764a1c728e9d22f81a3493cf6f2968f877be8115fb3c18ec66822669b0773b7fa3dc443650578da9d91fdea9b8c2bc1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/57274eb3b9942f532bdc7b5b07c672811431f3d1e55f359a5228c5c0710463b7ac8c8271b89fc748984aec4575b9f1bbbfdd077f976ee73579f3d4c2830c9954", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f2646516c50dcc73e036ec5ab23bda11898ad1a7f647711c6f3d42204fd509c5c910d52a302cbb77f5162e1324457686a26b782ba1b78328a739c4567bc4e298"} 11:42:59 INFO - Running post-run listener: copy_logs_to_upload_dir 11:42:59 INFO - Copying logs to upload dir... 11:42:59 INFO - mkdir: /builds/slave/test/build/upload/logs 11:42:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.173750 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-07 11:42:59.234836) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-07 11:42:59.238461) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1483816942.411184-1103399561 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/4e7bfe6bbb3d11c8f6e2983964cdc9d6c764a1c728e9d22f81a3493cf6f2968f877be8115fb3c18ec66822669b0773b7fa3dc443650578da9d91fdea9b8c2bc1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/57274eb3b9942f532bdc7b5b07c672811431f3d1e55f359a5228c5c0710463b7ac8c8271b89fc748984aec4575b9f1bbbfdd077f976ee73579f3d4c2830c9954", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f2646516c50dcc73e036ec5ab23bda11898ad1a7f647711c6f3d42204fd509c5c910d52a302cbb77f5162e1324457686a26b782ba1b78328a739c4567bc4e298"} build_url:https://queue.taskcluster.net/v1/task/A0_xom9tRX6DK8uQXHeoMA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011489 build_url: 'https://queue.taskcluster.net/v1/task/A0_xom9tRX6DK8uQXHeoMA/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/4e7bfe6bbb3d11c8f6e2983964cdc9d6c764a1c728e9d22f81a3493cf6f2968f877be8115fb3c18ec66822669b0773b7fa3dc443650578da9d91fdea9b8c2bc1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/57274eb3b9942f532bdc7b5b07c672811431f3d1e55f359a5228c5c0710463b7ac8c8271b89fc748984aec4575b9f1bbbfdd077f976ee73579f3d4c2830c9954", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f2646516c50dcc73e036ec5ab23bda11898ad1a7f647711c6f3d42204fd509c5c910d52a302cbb77f5162e1324457686a26b782ba1b78328a739c4567bc4e298"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-07 11:42:59.264249) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 11:42:59.264570) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1483816942.411184-1103399561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004431 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 11:42:59.347889) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-07 11:42:59.348211) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-07 11:42:59.348508) ========= ========= Total master_lag: 0.16 =========