builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-022 starttime: 1481126397.72 results: success (0) buildid: 20161207062538 builduid: b56b1ebfee5743d2bd842d23b787158f revision: 93266100e27057f116effff38f70d8563533097b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-07 07:59:57.723878) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-07 07:59:57.724383) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-07 07:59:57.724687) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-07 07:59:57.739408) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 07:59:57.739705) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1481124810.128781-1752951266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-07 07:59:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 26.3M=0s 2016-12-07 07:59:58 (26.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.082243 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 07:59:57.835234) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 07:59:57.835579) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1481124810.128781-1752951266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018506 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 07:59:57.885125) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 07:59:57.885462) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 93266100e27057f116effff38f70d8563533097b --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 93266100e27057f116effff38f70d8563533097b --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=9c43b49b387003dc8f5b4e5c000001c4-1481124810.128781-1752951266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-07 07:59:58,664 truncating revision to first 12 chars 2016-12-07 07:59:58,664 Setting DEBUG logging. 2016-12-07 07:59:58,664 attempt 1/10 2016-12-07 07:59:58,664 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/93266100e270?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-07 07:59:58,972 unpacking tar archive at: mozilla-aurora-93266100e270/testing/mozharness/ program finished with exit code 0 elapsedTime=0.646128 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 07:59:58.545149) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-07 07:59:58.545460) ========= script_repo_revision: 93266100e27057f116effff38f70d8563533097b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-07 07:59:58.545904) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-07 07:59:58.546178) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-07 07:59:58.555979) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-12-07 07:59:58.556268) ========= /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=9c43b49b387003dc8f5b4e5c000001c4-1481124810.128781-1752951266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:59:59 INFO - MultiFileLogger online at 20161207 07:59:59 in /builds/slave/test 07:59:59 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 07:59:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:59:59 INFO - {'append_to_log': False, 07:59:59 INFO - 'base_work_dir': '/builds/slave/test', 07:59:59 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:59:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:59:59 INFO - 'branch': 'Mozilla-Aurora', 07:59:59 INFO - 'buildbot_json_path': 'buildprops.json', 07:59:59 INFO - 'config_files': ('talos/linux_config.py',), 07:59:59 INFO - 'default_actions': ('clobber', 07:59:59 INFO - 'read-buildbot-config', 07:59:59 INFO - 'download-and-extract', 07:59:59 INFO - 'populate-webroot', 07:59:59 INFO - 'create-virtualenv', 07:59:59 INFO - 'install', 07:59:59 INFO - 'run-tests'), 07:59:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:59:59 INFO - 'download_minidump_stackwalk': True, 07:59:59 INFO - 'download_symbols': 'ondemand', 07:59:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:59:59 INFO - 'tooltool.py': '/tools/tooltool.py', 07:59:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:59:59 INFO - '/tools/misc-python/virtualenv.py')}, 07:59:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:59:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:59:59 INFO - 'installer_path': 'installer.exe', 07:59:59 INFO - 'log_level': 'info', 07:59:59 INFO - 'log_name': 'talos', 07:59:59 INFO - 'log_to_console': True, 07:59:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:59:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:59:59 INFO - 'opt_config_files': (), 07:59:59 INFO - 'pip_index': False, 07:59:59 INFO - 'sps_profile': False, 07:59:59 INFO - 'sps_profile_interval': 0, 07:59:59 INFO - 'suite': 'dromaeojs', 07:59:59 INFO - 'system_bits': '32', 07:59:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:59:59 INFO - 'title': 'talos-linux64-ix-022', 07:59:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:59:59 INFO - 'use_talos_json': True, 07:59:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:59:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:59:59 INFO - 'work_dir': 'build'} 07:59:59 INFO - [mozharness: 2016-12-07 15:59:59.436706Z] Running clobber step. 07:59:59 INFO - Running pre-action listener: _resource_record_pre_action 07:59:59 INFO - Running main action method: clobber 07:59:59 INFO - rmtree: /builds/slave/test/build 07:59:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:59:59 INFO - Running post-action listener: _resource_record_post_action 07:59:59 INFO - [mozharness: 2016-12-07 15:59:59.896976Z] Finished clobber step (success) 07:59:59 INFO - [mozharness: 2016-12-07 15:59:59.897077Z] Running read-buildbot-config step. 07:59:59 INFO - Running pre-action listener: _resource_record_pre_action 07:59:59 INFO - Running main action method: read_buildbot_config 07:59:59 INFO - Using buildbot properties: 07:59:59 INFO - { 07:59:59 INFO - "project": "", 07:59:59 INFO - "product": "firefox", 07:59:59 INFO - "script_repo_revision": "production", 07:59:59 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 07:59:59 INFO - "repository": "", 07:59:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 07:59:59 INFO - "buildid": "20161207062538", 07:59:59 INFO - "pgo_build": "True", 07:59:59 INFO - "basedir": "/builds/slave/test", 07:59:59 INFO - "buildnumber": 633, 07:59:59 INFO - "slavename": "talos-linux64-ix-022", 07:59:59 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:59:59 INFO - "platform": "ubuntu64_hw", 07:59:59 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 07:59:59 INFO - "branch": "mozilla-aurora", 07:59:59 INFO - "repo_path": "releases/mozilla-aurora", 07:59:59 INFO - "revision": "93266100e27057f116effff38f70d8563533097b", 07:59:59 INFO - "stage_platform": "linux64-pgo", 07:59:59 INFO - "builduid": "b56b1ebfee5743d2bd842d23b787158f", 07:59:59 INFO - "slavebuilddir": "test" 07:59:59 INFO - } 07:59:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 07:59:59 INFO - Running post-action listener: _resource_record_post_action 07:59:59 INFO - [mozharness: 2016-12-07 15:59:59.899529Z] Finished read-buildbot-config step (success) 07:59:59 INFO - [mozharness: 2016-12-07 15:59:59.899616Z] Running download-and-extract step. 07:59:59 INFO - Running pre-action listener: _resource_record_pre_action 07:59:59 INFO - Running main action method: download_and_extract 07:59:59 INFO - mkdir: /builds/slave/test/build/tests 07:59:59 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')]} 07:59:59 INFO - trying https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 07:59:59 INFO - Downloading https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/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 07:59:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:00:00 INFO - Downloaded 1361 bytes. 08:00:00 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:00:00 INFO - Using the following test package requirements: 08:00:00 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:00:00 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:00:00 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:00:00 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:00:00 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:00:00 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:00:00 INFO - u'jsshell-linux-x86_64.zip'], 08:00:00 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:00:00 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:00:00 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:00:00 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:00:00 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:00:00 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:00:00 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:00:00 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:00:00 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:00:00 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:00:00 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:00:00 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:00:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:00:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:00:00 INFO - Fetch https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:00:01 INFO - Http code: 200 08:00:01 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 08:00:01 INFO - x-amz-cf-id: 6PItbAltm0bu1LJ3aJY-bnJAmkrCSEXx3DK0q6B6srqzDutmT6g3MA== 08:00:01 INFO - x-amz-version-id: M9jX77fv.BTXxe08riFk04YAw9vbPURj 08:00:01 INFO - Expected file size: 21954855 08:00:01 INFO - Obtained file size: 21954855 08:00:05 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:00:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:00:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:00:05 INFO - Fetch https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:00:05 INFO - Http code: 200 08:00:05 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 08:00:05 INFO - x-amz-cf-id: fVsgplL671xZuRjw04-5WHYRzEqQaxEYXJNM6YW_4tp1SbQIpZRWrw== 08:00:05 INFO - x-amz-version-id: M9jX77fv.BTXxe08riFk04YAw9vbPURj 08:00:06 INFO - Expected file size: 21954855 08:00:06 INFO - Obtained file size: 21954855 08:00:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 08:00:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:00:10 INFO - Fetch https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 08:00:11 INFO - Http code: 200 08:00:11 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 08:00:11 INFO - x-amz-cf-id: -F_yCRzIQcl_D5RbvMn5O9ui8HK3bEkpDuDNqHnWxqweEfDowxO07Q== 08:00:11 INFO - x-amz-version-id: 6VVY2a0V.8czFybp_ekT3z9bal1.VsgU 08:00:11 INFO - Expected file size: 14409038 08:00:11 INFO - Obtained file size: 14409038 08:00:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:11 INFO - trying https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:00:11 INFO - Downloading https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:00:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:00:12 INFO - Downloaded 64015339 bytes. 08:00:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:00:12 INFO - mkdir: /builds/slave/test/properties 08:00:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:00:12 INFO - Writing to file /builds/slave/test/properties/build_url 08:00:12 INFO - Contents: 08:00:12 INFO - build_url:https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:00:13 INFO - Running post-action listener: _resource_record_post_action 08:00:13 INFO - Running post-action listener: set_extra_try_arguments 08:00:13 INFO - [mozharness: 2016-12-07 16:00:13.565310Z] Finished download-and-extract step (success) 08:00:13 INFO - [mozharness: 2016-12-07 16:00:13.565611Z] Running populate-webroot step. 08:00:13 INFO - Running pre-action listener: _resource_record_pre_action 08:00:13 INFO - Running main action method: populate_webroot 08:00:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:00:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:00:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:00:13 INFO - '--tppagecycles', 08:00:13 INFO - '7'], 08:00:13 INFO - 'tests': ['tsvgm']}}, 08:00:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:00:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:00:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:00:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:00:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:00:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:00:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:13 INFO - 'talos_options': ['--disable-e10s'], 08:00:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:00:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:00:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:13 INFO - 'talos_options': ['--disable-e10s'], 08:00:13 INFO - 'tests': ['damp', 'tps']}, 08:00:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:13 INFO - 'tests': ['damp', 'tps']}, 08:00:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:00:13 INFO - 'tests': ['dromaeo_dom']}, 08:00:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:00:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:00:13 INFO - 'tests': ['basic_compositor_video']}, 08:00:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:00:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:00:13 INFO - 'tests': ['a11yr', 08:00:13 INFO - 'ts_paint', 08:00:13 INFO - 'tpaint', 08:00:13 INFO - 'sessionrestore', 08:00:13 INFO - 'sessionrestore_no_auto_restore', 08:00:13 INFO - 'tabpaint']}, 08:00:13 INFO - 'other-e10s': {'tests': ['a11yr', 08:00:13 INFO - 'ts_paint', 08:00:13 INFO - 'tpaint', 08:00:13 INFO - 'sessionrestore', 08:00:13 INFO - 'sessionrestore_no_auto_restore', 08:00:13 INFO - 'tabpaint']}, 08:00:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:00:13 INFO - 'ts_paint', 08:00:13 INFO - 'tpaint', 08:00:13 INFO - 'sessionrestore', 08:00:13 INFO - 'sessionrestore_no_auto_restore', 08:00:13 INFO - 'tabpaint']}, 08:00:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:00:13 INFO - 'ts_paint', 08:00:13 INFO - 'tpaint', 08:00:13 INFO - 'sessionrestore', 08:00:13 INFO - 'sessionrestore_no_auto_restore', 08:00:13 INFO - 'tabpaint']}, 08:00:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:00:13 INFO - 'tests': ['a11yr', 08:00:13 INFO - 'ts_paint', 08:00:13 INFO - 'tpaint', 08:00:13 INFO - 'sessionrestore', 08:00:13 INFO - 'sessionrestore_no_auto_restore', 08:00:13 INFO - 'tabpaint']}, 08:00:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:00:13 INFO - 'tests': ['a11yr', 08:00:13 INFO - 'ts_paint', 08:00:13 INFO - 'tpaint', 08:00:13 INFO - 'sessionrestore', 08:00:13 INFO - 'sessionrestore_no_auto_restore', 08:00:13 INFO - 'tabpaint']}, 08:00:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:00:13 INFO - 'tests': ['tsvgx', 08:00:13 INFO - 'tsvgr_opacity', 08:00:13 INFO - 'tart', 08:00:13 INFO - 'tscrollx', 08:00:13 INFO - 'cart']}, 08:00:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:00:13 INFO - 'tsvgr_opacity', 08:00:13 INFO - 'tart', 08:00:13 INFO - 'tscrollx', 08:00:13 INFO - 'cart']}, 08:00:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:13 INFO - 'talos_options': ['--disable-e10s'], 08:00:13 INFO - 'tests': ['tp5o']}, 08:00:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:13 INFO - 'tests': ['tp5o']}, 08:00:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:13 INFO - 'talos_options': ['--disable-e10s', 08:00:13 INFO - '--xperf_path', 08:00:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:00:13 INFO - 'tests': ['tp5n']}, 08:00:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:00:13 INFO - 'talos_options': ['--xperf_path', 08:00:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:00:13 INFO - 'tests': ['tp5n']}}, 08:00:13 INFO - 'talos.zip': {'path': '', 08:00:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:00:13 INFO - Running post-action listener: _resource_record_post_action 08:00:13 INFO - [mozharness: 2016-12-07 16:00:13.583433Z] Finished populate-webroot step (success) 08:00:13 INFO - [mozharness: 2016-12-07 16:00:13.583527Z] Running create-virtualenv step. 08:00:13 INFO - Running pre-action listener: _resource_record_pre_action 08:00:13 INFO - Running main action method: create_virtualenv 08:00:13 INFO - Creating virtualenv /builds/slave/test/build/venv 08:00:13 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:00:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:00:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:00:13 INFO - Using real prefix '/usr' 08:00:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:00:14 INFO - Installing distribute.............................................................................................................................................................................................done. 08:00:16 INFO - Installing pip.................done. 08:00:16 INFO - Return code: 0 08:00:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:00:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:00:16 INFO - Reading from file tmpfile_stdout 08:00:16 INFO - Output received: 08:00:16 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:00:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf513a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14adf60>, '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 0x14aed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14af1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1481124810.128781-1752951266', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:00:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:00:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:00:16 INFO - Using env: {'DISPLAY': ':0', 08:00:16 INFO - 'HOME': '/home/cltbld', 08:00:16 INFO - 'LANG': 'en_US.UTF-8', 08:00:16 INFO - 'LANGUAGE': 'en_US:en', 08:00:16 INFO - 'LOGNAME': 'cltbld', 08:00:16 INFO - 'MAIL': '/var/mail/cltbld', 08:00:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:16 INFO - 'MOZ_NO_REMOTE': '1', 08:00:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:16 INFO - 'NO_EM_RESTART': '1', 08:00:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:16 INFO - 'PWD': '/builds/slave/test', 08:00:16 INFO - 'SHELL': '/bin/bash', 08:00:16 INFO - 'SHLVL': '1', 08:00:16 INFO - 'TERM': 'linux', 08:00:16 INFO - 'TMOUT': '86400', 08:00:16 INFO - 'USER': 'cltbld', 08:00:16 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1481124810.128781-1752951266', 08:00:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:16 INFO - '_': '/tools/buildbot/bin/python'} 08:00:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:16 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:00:16 INFO - Cleaning up... 08:00:16 INFO - Return code: 0 08:00:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdf513a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14adf60>, '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 0x14aed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14af1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1481124810.128781-1752951266', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:00:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:00:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:00:16 INFO - Using env: {'DISPLAY': ':0', 08:00:16 INFO - 'HOME': '/home/cltbld', 08:00:16 INFO - 'LANG': 'en_US.UTF-8', 08:00:16 INFO - 'LANGUAGE': 'en_US:en', 08:00:16 INFO - 'LOGNAME': 'cltbld', 08:00:16 INFO - 'MAIL': '/var/mail/cltbld', 08:00:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:16 INFO - 'MOZ_NO_REMOTE': '1', 08:00:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:16 INFO - 'NO_EM_RESTART': '1', 08:00:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:16 INFO - 'PWD': '/builds/slave/test', 08:00:16 INFO - 'SHELL': '/bin/bash', 08:00:16 INFO - 'SHLVL': '1', 08:00:16 INFO - 'TERM': 'linux', 08:00:16 INFO - 'TMOUT': '86400', 08:00:16 INFO - 'USER': 'cltbld', 08:00:16 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1481124810.128781-1752951266', 08:00:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:16 INFO - '_': '/tools/buildbot/bin/python'} 08:00:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:16 INFO - Downloading/unpacking psutil>=3.1.1 08:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:00:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:00:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:00:18 INFO - Installing collected packages: psutil 08:00:18 INFO - Running setup.py install for psutil 08:00:18 INFO - building 'psutil._psutil_linux' extension 08:00:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:00:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:00:19 INFO - building 'psutil._psutil_posix' extension 08:00:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:00:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:00:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:00:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:00:19 INFO - Successfully installed psutil 08:00:19 INFO - Cleaning up... 08:00:19 INFO - Return code: 0 08:00:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf513a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14adf60>, '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 0x14aed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14af1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1481124810.128781-1752951266', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:00:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:00:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:00:19 INFO - Using env: {'DISPLAY': ':0', 08:00:19 INFO - 'HOME': '/home/cltbld', 08:00:19 INFO - 'LANG': 'en_US.UTF-8', 08:00:19 INFO - 'LANGUAGE': 'en_US:en', 08:00:19 INFO - 'LOGNAME': 'cltbld', 08:00:19 INFO - 'MAIL': '/var/mail/cltbld', 08:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:19 INFO - 'MOZ_NO_REMOTE': '1', 08:00:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:19 INFO - 'NO_EM_RESTART': '1', 08:00:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:19 INFO - 'PWD': '/builds/slave/test', 08:00:19 INFO - 'SHELL': '/bin/bash', 08:00:19 INFO - 'SHLVL': '1', 08:00:19 INFO - 'TERM': 'linux', 08:00:19 INFO - 'TMOUT': '86400', 08:00:19 INFO - 'USER': 'cltbld', 08:00:19 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1481124810.128781-1752951266', 08:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:19 INFO - '_': '/tools/buildbot/bin/python'} 08:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:00:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:00:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:00:21 INFO - Installing collected packages: mozsystemmonitor 08:00:21 INFO - Running setup.py install for mozsystemmonitor 08:00:21 INFO - Successfully installed mozsystemmonitor 08:00:21 INFO - Cleaning up... 08:00:21 INFO - Return code: 0 08:00:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:00:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fdf513a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14adf60>, '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 0x14aed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14af1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1481124810.128781-1752951266', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:00:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:00:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:00:21 INFO - Using env: {'DISPLAY': ':0', 08:00:21 INFO - 'HOME': '/home/cltbld', 08:00:21 INFO - 'LANG': 'en_US.UTF-8', 08:00:21 INFO - 'LANGUAGE': 'en_US:en', 08:00:21 INFO - 'LOGNAME': 'cltbld', 08:00:21 INFO - 'MAIL': '/var/mail/cltbld', 08:00:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:21 INFO - 'MOZ_NO_REMOTE': '1', 08:00:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:21 INFO - 'NO_EM_RESTART': '1', 08:00:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:21 INFO - 'PWD': '/builds/slave/test', 08:00:21 INFO - 'SHELL': '/bin/bash', 08:00:21 INFO - 'SHLVL': '1', 08:00:21 INFO - 'TERM': 'linux', 08:00:21 INFO - 'TMOUT': '86400', 08:00:21 INFO - 'USER': 'cltbld', 08:00:21 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1481124810.128781-1752951266', 08:00:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:21 INFO - '_': '/tools/buildbot/bin/python'} 08:00:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:22 INFO - Downloading/unpacking jsonschema==2.5.1 08:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:00:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:24 INFO - Downloading functools32-3.2.3-2.tar.gz 08:00:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:00:24 INFO - warning: no files found matching '*.txt' 08:00:24 INFO - no previously-included directories found matching 'build' 08:00:24 INFO - no previously-included directories found matching 'dist' 08:00:24 INFO - no previously-included directories found matching '.git*' 08:00:24 INFO - Installing collected packages: jsonschema, functools32 08:00:24 INFO - Running setup.py install for functools32 08:00:24 INFO - warning: no files found matching '*.txt' 08:00:24 INFO - no previously-included directories found matching 'build' 08:00:24 INFO - no previously-included directories found matching 'dist' 08:00:24 INFO - no previously-included directories found matching '.git*' 08:00:24 INFO - Successfully installed jsonschema functools32 08:00:24 INFO - Cleaning up... 08:00:24 INFO - Return code: 0 08:00:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:00:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:24 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 0x7fdf513a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14adf60>, '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 0x14aed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14af1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1481124810.128781-1752951266', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:00:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:00:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:00:24 INFO - Using env: {'DISPLAY': ':0', 08:00:24 INFO - 'HOME': '/home/cltbld', 08:00:24 INFO - 'LANG': 'en_US.UTF-8', 08:00:24 INFO - 'LANGUAGE': 'en_US:en', 08:00:24 INFO - 'LOGNAME': 'cltbld', 08:00:24 INFO - 'MAIL': '/var/mail/cltbld', 08:00:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:24 INFO - 'MOZ_NO_REMOTE': '1', 08:00:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:24 INFO - 'NO_EM_RESTART': '1', 08:00:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:24 INFO - 'PWD': '/builds/slave/test', 08:00:24 INFO - 'SHELL': '/bin/bash', 08:00:24 INFO - 'SHLVL': '1', 08:00:24 INFO - 'TERM': 'linux', 08:00:24 INFO - 'TMOUT': '86400', 08:00:24 INFO - 'USER': 'cltbld', 08:00:24 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1481124810.128781-1752951266', 08:00:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:24 INFO - '_': '/tools/buildbot/bin/python'} 08:00:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:00:24 INFO - Cleaning up... 08:00:24 INFO - Return code: 0 08:00:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:00:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:24 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 0x7fdf513a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14adf60>, '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 0x14aed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14af1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1481124810.128781-1752951266', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:00:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:00:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:00:24 INFO - Using env: {'DISPLAY': ':0', 08:00:24 INFO - 'HOME': '/home/cltbld', 08:00:24 INFO - 'LANG': 'en_US.UTF-8', 08:00:24 INFO - 'LANGUAGE': 'en_US:en', 08:00:24 INFO - 'LOGNAME': 'cltbld', 08:00:24 INFO - 'MAIL': '/var/mail/cltbld', 08:00:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:24 INFO - 'MOZ_NO_REMOTE': '1', 08:00:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:24 INFO - 'NO_EM_RESTART': '1', 08:00:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:24 INFO - 'PWD': '/builds/slave/test', 08:00:24 INFO - 'SHELL': '/bin/bash', 08:00:24 INFO - 'SHLVL': '1', 08:00:24 INFO - 'TERM': 'linux', 08:00:24 INFO - 'TMOUT': '86400', 08:00:24 INFO - 'USER': 'cltbld', 08:00:24 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1481124810.128781-1752951266', 08:00:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:24 INFO - '_': '/tools/buildbot/bin/python'} 08:00:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:25 INFO - Downloading/unpacking blobuploader==1.2.4 08:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:26 INFO - Downloading blobuploader-1.2.4.tar.gz 08:00:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:00:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:00:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:27 INFO - Downloading docopt-0.6.1.tar.gz 08:00:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:00:27 INFO - Installing collected packages: blobuploader, requests, docopt 08:00:27 INFO - Running setup.py install for blobuploader 08:00:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:00:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:00:27 INFO - Running setup.py install for requests 08:00:28 INFO - Running setup.py install for docopt 08:00:28 INFO - Successfully installed blobuploader requests docopt 08:00:28 INFO - Cleaning up... 08:00:28 INFO - Return code: 0 08:00:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:28 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 0x7fdf513a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14adf60>, '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 0x14aed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14af1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1481124810.128781-1752951266', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:00:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:00:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:00:28 INFO - Using env: {'DISPLAY': ':0', 08:00:28 INFO - 'HOME': '/home/cltbld', 08:00:28 INFO - 'LANG': 'en_US.UTF-8', 08:00:28 INFO - 'LANGUAGE': 'en_US:en', 08:00:28 INFO - 'LOGNAME': 'cltbld', 08:00:28 INFO - 'MAIL': '/var/mail/cltbld', 08:00:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:28 INFO - 'MOZ_NO_REMOTE': '1', 08:00:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:28 INFO - 'NO_EM_RESTART': '1', 08:00:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:28 INFO - 'PWD': '/builds/slave/test', 08:00:28 INFO - 'SHELL': '/bin/bash', 08:00:28 INFO - 'SHLVL': '1', 08:00:28 INFO - 'TERM': 'linux', 08:00:28 INFO - 'TMOUT': '86400', 08:00:28 INFO - 'USER': 'cltbld', 08:00:28 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1481124810.128781-1752951266', 08:00:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:28 INFO - '_': '/tools/buildbot/bin/python'} 08:00:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:00:28 INFO - Running setup.py (path:/tmp/pip-kV4MJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:00:28 INFO - Running setup.py (path:/tmp/pip-DfxibC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:00:28 INFO - Running setup.py (path:/tmp/pip-74NpVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:00:28 INFO - Running setup.py (path:/tmp/pip-Q0sIML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:00:28 INFO - Running setup.py (path:/tmp/pip-0ULKoD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:00:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:00:28 INFO - Running setup.py (path:/tmp/pip-ngoQS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:00:29 INFO - Running setup.py (path:/tmp/pip-ryR1M1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:00:29 INFO - Running setup.py (path:/tmp/pip-q5x6HC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:00:29 INFO - Running setup.py (path:/tmp/pip-ITr5Uy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:00:29 INFO - Running setup.py (path:/tmp/pip-vdnjxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:00:29 INFO - Running setup.py (path:/tmp/pip-PObsB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:00:29 INFO - Running setup.py (path:/tmp/pip-lqey9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:00:29 INFO - Running setup.py (path:/tmp/pip-nQnVQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:00:29 INFO - Running setup.py (path:/tmp/pip-QKPsZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:00:29 INFO - Running setup.py (path:/tmp/pip-IfdduD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:00:29 INFO - Running setup.py (path:/tmp/pip-csHAxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:00:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:00:29 INFO - Running setup.py (path:/tmp/pip-lQX_pk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:00:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:00:29 INFO - Running setup.py install for manifestparser 08:00:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:00:29 INFO - Running setup.py install for mozcrash 08:00:30 INFO - Running setup.py install for mozdebug 08:00:30 INFO - Running setup.py install for mozdevice 08:00:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:00:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:00:30 INFO - Running setup.py install for mozfile 08:00:30 INFO - Running setup.py install for mozhttpd 08:00:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:00:30 INFO - Running setup.py install for mozinfo 08:00:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:00:30 INFO - Running setup.py install for mozInstall 08:00:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:00:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:00:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:00:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:00:30 INFO - Running setup.py install for mozleak 08:00:30 INFO - Running setup.py install for mozlog 08:00:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:00:30 INFO - Running setup.py install for moznetwork 08:00:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:00:30 INFO - Running setup.py install for mozprocess 08:00:31 INFO - Running setup.py install for mozprofile 08:00:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:00:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:00:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:00:31 INFO - Running setup.py install for mozrunner 08:00:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:00:31 INFO - Running setup.py install for mozscreenshot 08:00:31 INFO - Running setup.py install for moztest 08:00:31 INFO - Running setup.py install for mozversion 08:00:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:00:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:00:31 INFO - Cleaning up... 08:00:31 INFO - Return code: 0 08:00:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:00:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:31 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 0x7fdf513a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14adf60>, '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 0x14aed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14af1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1481124810.128781-1752951266', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:00:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:00:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:00:31 INFO - Using env: {'DISPLAY': ':0', 08:00:31 INFO - 'HOME': '/home/cltbld', 08:00:31 INFO - 'LANG': 'en_US.UTF-8', 08:00:31 INFO - 'LANGUAGE': 'en_US:en', 08:00:31 INFO - 'LOGNAME': 'cltbld', 08:00:31 INFO - 'MAIL': '/var/mail/cltbld', 08:00:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:31 INFO - 'MOZ_NO_REMOTE': '1', 08:00:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:31 INFO - 'NO_EM_RESTART': '1', 08:00:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:31 INFO - 'PWD': '/builds/slave/test', 08:00:31 INFO - 'SHELL': '/bin/bash', 08:00:31 INFO - 'SHLVL': '1', 08:00:31 INFO - 'TERM': 'linux', 08:00:31 INFO - 'TMOUT': '86400', 08:00:31 INFO - 'USER': 'cltbld', 08:00:31 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1481124810.128781-1752951266', 08:00:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:31 INFO - '_': '/tools/buildbot/bin/python'} 08:00:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:00:31 INFO - Running setup.py (path:/tmp/pip-tg7ULK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:00:31 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:00:31 INFO - Running setup.py (path:/tmp/pip-auOBEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:00:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:00:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:00:31 INFO - Running setup.py (path:/tmp/pip-DSOqjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:00:32 INFO - Running setup.py (path:/tmp/pip-geMeW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:00:32 INFO - Running setup.py (path:/tmp/pip-yZth6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:00:32 INFO - Running setup.py (path:/tmp/pip-ffxMNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:00:32 INFO - Running setup.py (path:/tmp/pip-so6B0L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:00:32 INFO - Running setup.py (path:/tmp/pip-mOwskp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:00:32 INFO - Running setup.py (path:/tmp/pip-zSU1UF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:00:32 INFO - Running setup.py (path:/tmp/pip-ar1H3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:00:32 INFO - Running setup.py (path:/tmp/pip-fuksn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:00:32 INFO - Running setup.py (path:/tmp/pip-0aq65j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:00:32 INFO - Running setup.py (path:/tmp/pip-_G36Va-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:00:32 INFO - Running setup.py (path:/tmp/pip-iadid7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:00:32 INFO - Running setup.py (path:/tmp/pip-aBeoig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:00:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:00:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:00:32 INFO - Running setup.py (path:/tmp/pip-DPNPc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:00:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:00:33 INFO - Running setup.py (path:/tmp/pip-85d8Pw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:00:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:00:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:00:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:00:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:00:35 INFO - Downloading blessings-1.6.tar.gz 08:00:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:00:35 INFO - Installing collected packages: blessings 08:00:35 INFO - Running setup.py install for blessings 08:00:35 INFO - Successfully installed blessings 08:00:35 INFO - Cleaning up... 08:00:35 INFO - Return code: 0 08:00:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:00:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:00:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:00:35 INFO - Reading from file tmpfile_stdout 08:00:35 INFO - Current package versions: 08:00:35 INFO - argparse == 1.2.1 08:00:35 INFO - blessings == 1.6 08:00:35 INFO - blobuploader == 1.2.4 08:00:35 INFO - docopt == 0.6.1 08:00:35 INFO - functools32 == 3.2.3-2 08:00:35 INFO - jsonschema == 2.5.1 08:00:35 INFO - manifestparser == 1.1 08:00:35 INFO - mozInstall == 1.12 08:00:35 INFO - mozcrash == 1.0 08:00:35 INFO - mozdebug == 0.1 08:00:35 INFO - mozdevice == 0.48 08:00:35 INFO - mozfile == 1.2 08:00:35 INFO - mozhttpd == 0.7 08:00:35 INFO - mozinfo == 0.9 08:00:35 INFO - mozleak == 0.1 08:00:35 INFO - mozlog == 3.4 08:00:35 INFO - moznetwork == 0.27 08:00:35 INFO - mozprocess == 0.23 08:00:35 INFO - mozprofile == 0.28 08:00:35 INFO - mozrunner == 6.13 08:00:35 INFO - mozscreenshot == 0.1 08:00:35 INFO - mozsystemmonitor == 0.3 08:00:35 INFO - moztest == 0.7 08:00:35 INFO - mozversion == 1.4 08:00:35 INFO - psutil == 3.1.1 08:00:35 INFO - requests == 1.2.3 08:00:35 INFO - wsgiref == 0.1.2 08:00:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:00:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:35 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 0x7fdf513a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14adf60>, '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 0x14aed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14af1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1481124810.128781-1752951266', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:00:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:00:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:00:35 INFO - Using env: {'DISPLAY': ':0', 08:00:35 INFO - 'HOME': '/home/cltbld', 08:00:35 INFO - 'LANG': 'en_US.UTF-8', 08:00:35 INFO - 'LANGUAGE': 'en_US:en', 08:00:35 INFO - 'LOGNAME': 'cltbld', 08:00:35 INFO - 'MAIL': '/var/mail/cltbld', 08:00:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:35 INFO - 'MOZ_NO_REMOTE': '1', 08:00:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:35 INFO - 'NO_EM_RESTART': '1', 08:00:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:35 INFO - 'PWD': '/builds/slave/test', 08:00:35 INFO - 'SHELL': '/bin/bash', 08:00:35 INFO - 'SHLVL': '1', 08:00:35 INFO - 'TERM': 'linux', 08:00:35 INFO - 'TMOUT': '86400', 08:00:35 INFO - 'USER': 'cltbld', 08:00:35 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1481124810.128781-1752951266', 08:00:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:35 INFO - '_': '/tools/buildbot/bin/python'} 08:00:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:00:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:00:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:00:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:00:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:00:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:00:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:00:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:00:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:00:35 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:00:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:00:35 INFO - Cleaning up... 08:00:35 INFO - Return code: 0 08:00:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:00:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:00:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:00:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:00:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf513a6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14adf60>, '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 0x14aed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14af1d0>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1481124810.128781-1752951266', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:00:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:00:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:00:35 INFO - Using env: {'DISPLAY': ':0', 08:00:35 INFO - 'HOME': '/home/cltbld', 08:00:35 INFO - 'LANG': 'en_US.UTF-8', 08:00:35 INFO - 'LANGUAGE': 'en_US:en', 08:00:35 INFO - 'LOGNAME': 'cltbld', 08:00:35 INFO - 'MAIL': '/var/mail/cltbld', 08:00:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:35 INFO - 'MOZ_NO_REMOTE': '1', 08:00:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:35 INFO - 'NO_EM_RESTART': '1', 08:00:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:35 INFO - 'PWD': '/builds/slave/test', 08:00:35 INFO - 'SHELL': '/bin/bash', 08:00:35 INFO - 'SHLVL': '1', 08:00:35 INFO - 'TERM': 'linux', 08:00:35 INFO - 'TMOUT': '86400', 08:00:35 INFO - 'USER': 'cltbld', 08:00:35 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1481124810.128781-1752951266', 08:00:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:35 INFO - '_': '/tools/buildbot/bin/python'} 08:00:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:00:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:00:36 INFO - Cleaning up... 08:00:36 INFO - Return code: 0 08:00:36 INFO - Running post-action listener: _resource_record_post_action 08:00:36 INFO - Running post-action listener: _start_resource_monitoring 08:00:36 INFO - Starting resource monitoring. 08:00:36 INFO - [mozharness: 2016-12-07 16:00:36.051129Z] Finished create-virtualenv step (success) 08:00:36 INFO - [mozharness: 2016-12-07 16:00:36.051646Z] Running install step. 08:00:36 INFO - Running pre-action listener: _resource_record_pre_action 08:00:36 INFO - Running main action method: install 08:00:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:00:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:00:36 INFO - Reading from file tmpfile_stdout 08:00:36 INFO - Detecting whether we're running mozinstall >=1.0... 08:00:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:00:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:00:36 INFO - Reading from file tmpfile_stdout 08:00:36 INFO - Output received: 08:00:36 INFO - Usage: mozinstall [options] installer 08:00:36 INFO - Options: 08:00:36 INFO - -h, --help show this help message and exit 08:00:36 INFO - -d DEST, --destination=DEST 08:00:36 INFO - Directory to install application into. [default: 08:00:36 INFO - "/builds/slave/test"] 08:00:36 INFO - --app=APP Application being installed. [default: firefox] 08:00:36 INFO - mkdir: /builds/slave/test/build/application 08:00:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:00:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:00:52 INFO - Reading from file tmpfile_stdout 08:00:52 INFO - Output received: 08:00:52 INFO - /builds/slave/test/build/application/firefox/firefox 08:00:52 INFO - Running post-action listener: _resource_record_post_action 08:00:52 INFO - [mozharness: 2016-12-07 16:00:52.274444Z] Finished install step (success) 08:00:52 INFO - [mozharness: 2016-12-07 16:00:52.274690Z] Running run-tests step. 08:00:52 INFO - Running pre-action listener: _resource_record_pre_action 08:00:52 INFO - Running main action method: run_tests 08:00:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:00:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:00:52 INFO - Python 2.7.3 08:00:52 INFO - Return code: 0 08:00:52 INFO - grabbing minidump binary from tooltool 08:00:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:00:52 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 0x14adf60>, '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 0x14aed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14af1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:00:52 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:00:52 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:00:52 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:00:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:00:52 INFO - Return code: 0 08:00:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:00:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:00:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:00:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:00:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:00:52 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/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:00:52 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/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:00:52 INFO - Using env: {'DISPLAY': ':0', 08:00:52 INFO - 'HOME': '/home/cltbld', 08:00:52 INFO - 'LANG': 'en_US.UTF-8', 08:00:52 INFO - 'LANGUAGE': 'en_US:en', 08:00:52 INFO - 'LOGNAME': 'cltbld', 08:00:52 INFO - 'MAIL': '/var/mail/cltbld', 08:00:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:00:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:00:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:00:52 INFO - 'MOZ_NO_REMOTE': '1', 08:00:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:00:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:00:52 INFO - 'NO_EM_RESTART': '1', 08:00:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:00:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:00:52 INFO - 'PWD': '/builds/slave/test', 08:00:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:00:52 INFO - 'SHELL': '/bin/bash', 08:00:52 INFO - 'SHLVL': '1', 08:00:52 INFO - 'TERM': 'linux', 08:00:52 INFO - 'TMOUT': '86400', 08:00:52 INFO - 'USER': 'cltbld', 08:00:52 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1481124810.128781-1752951266', 08:00:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:00:52 INFO - '_': '/tools/buildbot/bin/python'} 08:00:52 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/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:00:52 INFO - mozversion application_buildid: 20161207062538 08:00:52 INFO - mozversion application_changeset: 93266100e27057f116effff38f70d8563533097b 08:00:52 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:00:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:00:52 INFO - mozversion application_name: Firefox 08:00:52 INFO - mozversion application_remotingname: firefox-dev 08:00:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:00:52 INFO - mozversion application_vendor: Mozilla 08:00:52 INFO - mozversion application_version: 52.0a2 08:00:52 INFO - mozversion platform_buildid: 20161207062538 08:00:52 INFO - mozversion platform_changeset: 93266100e27057f116effff38f70d8563533097b 08:00:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:00:52 INFO - mozversion platform_version: 52.0a2 08:00:52 INFO - using testdate: 1481126452 08:00:52 INFO - actual date: 1481126452 08:00:52 INFO - starting webserver on 'localhost:53292' 08:00:52 INFO - SUITE-START | Running 2 tests 08:00:52 INFO - TEST-START | dromaeo_css 08:00:52 INFO - operating with platform_type : linux_ 08:00:52 INFO - Initialising browser for dromaeo_css test... 08:00:52 INFO - TEST-INFO | started process 12300 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHzH44Z/profile http://localhost:53292/getInfo.html) 08:00:56 INFO - PROCESS | 12300 | __metrics Screen width/height:1600/1200 08:00:56 INFO - PROCESS | 12300 | colorDepth:24 08:00:56 INFO - PROCESS | 12300 | Browser inner width/height: 1024/697 08:00:56 INFO - PROCESS | 12300 | __metrics 08:00:57 INFO - PROCESS | 12300 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:00:57 INFO - PROCESS | 12300 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:00:57 INFO - PROCESS | 12300 | console.error: PushService: 08:00:57 INFO - PROCESS | 12300 | stateChangeProcessEnqueue: Error transitioning state 08:00:57 INFO - PROCESS | 12300 | UnknownError 08:00:58 INFO - TEST-INFO | 12300: exit 0 08:00:58 INFO - Browser initialized. 08:00:58 INFO - Running cycle 1/1 for dromaeo_css test... 08:00:58 INFO - TEST-INFO | started process 12392 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHzH44Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:01:10 INFO - PROCESS | 12392 | RSS: Main: 144707584 08:01:10 INFO - PROCESS | 12392 | 08:02:01 INFO - PROCESS | 12392 | 1481126521869 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:04:12 INFO - PROCESS | 12392 | Cycle 1(1): loaded http://localhost:53292/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53292/tests/dromaeo/cssquery-ext.html) 08:04:13 INFO - PROCESS | 12392 | RSS: Main: 246996992 08:04:13 INFO - PROCESS | 12392 | 08:07:15 INFO - PROCESS | 12392 | Cycle 1(1): loaded http://localhost:53292/tests/dromaeo/cssquery-ext.html (next: http://localhost:53292/tests/dromaeo/cssquery-jquery.html) 08:07:16 INFO - PROCESS | 12392 | RSS: Main: 227799040 08:07:16 INFO - PROCESS | 12392 | 08:10:18 INFO - PROCESS | 12392 | Cycle 1(1): loaded http://localhost:53292/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53292/tests/dromaeo/cssquery-mootools.html) 08:10:18 INFO - PROCESS | 12392 | RSS: Main: 177692672 08:10:18 INFO - PROCESS | 12392 | 08:13:20 INFO - PROCESS | 12392 | Cycle 1(1): loaded http://localhost:53292/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53292/tests/dromaeo/cssquery-prototype.html) 08:13:21 INFO - PROCESS | 12392 | RSS: Main: 217837568 08:13:21 INFO - PROCESS | 12392 | 08:16:24 INFO - PROCESS | 12392 | Cycle 1(1): loaded http://localhost:53292/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53292/tests/dromaeo/cssquery-yui.html) 08:16:24 INFO - PROCESS | 12392 | RSS: Main: 175001600 08:16:24 INFO - PROCESS | 12392 | 08:19:27 INFO - PROCESS | 12392 | Cycle 1(1): loaded http://localhost:53292/tests/dromaeo/cssquery-yui.html (next: http://localhost:53292/tests/dromaeo/cssquery-dojo.html) 08:19:27 INFO - PROCESS | 12392 | RSS: Main: 264097792 08:19:27 INFO - PROCESS | 12392 | 08:19:27 INFO - PROCESS | 12392 | __start_tp_report 08:19:27 INFO - PROCESS | 12392 | _x_x_mozilla_page_load 08:19:27 INFO - PROCESS | 12392 | _x_x_mozilla_page_load_details 08:19:27 INFO - PROCESS | 12392 | |i|pagename|runs| 08:19:27 INFO - PROCESS | 12392 | |0;dojo.html;3229.499427588724;3281.9671803281967;3284.8850290239848;3301.653326400726;3305.966940330596;5483.862903427416;5574.219609254703;5588.105903055512;5593.412691667378;5604.215409842625;5512.91730624041;5569.916451253234;5571.247881536002;5580.441955804427;5592.189132575774;5051.292819005343;5080.593552515808;5111.335526381566;5118.232265160219;5174.094533456649;4978.751062446863;5113.948860511385;5180.274761533388;5185.351831021122;5186.351706036746;4977.402711674604;5014.69911805291;5038.420581633104;5071.949280507203;5087.949120508784;5051.747412629372;5075.9746201268945;5076.746162691888;5165.974170129163;5185.196294574347;5010.498950104997;5089.262057001714;5136.357955255593;5140.460251673595;5148.897022059576;5421.078416669176;5453.372862120827;5464.207689884985;5487.862803429906;5523.28197334348;5833.300003999547;5844.064949608085;5855.121731740231;5944.167816505693;5961;5999.190109335227;6001.51987840976;6013.428724271187;6016.8495787605225;6017.338092809788;5468.425815289377;5495.395506494282;5509.283793106871;5529.198266251371;5533.22534845122;6015.969920150371;6057.969710151421;6060.303065147476;6070.939290607037;6074.149619053336;5875.50058245054;5886.0288052471715;5889.587728858939;5892.499137573269;5898.14476900847;5665.12190610456;5714.428557144252;5837.211976383134;5878.2358293421585;5883.14694369314;5925.9407405925385;5927.851803704855;5928.229330187048;5960.523158147338;5962.761489540457;5873.530117590582;5930.140129681258;5932.021216499229;5934.080217566284;5945.881082378328;4490.146872094291;4539.727616342964;4571.040081582838;4601.171789077998;4601.608863246662;4127.504699436087;4131.814068366931;4136.4415803866095;4153.397757325171;4169.4162817205615;5756.798512052058;5757.050086735641;5759.94240057594;5768.653880767168;5769.278840144982;5808.680522571299;5849.649021058665;5886.852828679317;5929.080992446177;6044.335123136451;5661.915071273934;5664.915026274609;5666.660000399989;5672.716364181774;5690.630109042899;5047.545720885138;5049.8737531562;5058.064258112261;5073.061483625541;5093.694378337237;5948.315943666534;5984.16221728967;6103.755849765959;6169.475594574422;6177.104319873683;5965.552583556164;6018.037114061729;6030.6080104793045;6056.03103503455;6062.757489700362;6181.705587406903;6200;6215.036669316263;6216.751329946752;6232.626042437469;5708.971455142698;5710.914336284876;5920.259967504062;5924.407559244041;5936.228290322403;5916.852078697895;5947.6431414115295;5953.1367951647635;6016.729247183975;6044.697765111639;5880.353161152184;5882.5293976482635;5886.852828679317;5890.7054647266605;5892.793752218652;5537.390887002507;5870.471657550841;5874.676892770768;5880.735366908414;5884.32330282023;5582.609217354909;5678.20505129274;5720.971395142998;5749.022666146681;5835.67903765297;5865.589408741518;5884.58807883444;5890.263717035371;5894.970525147347;5900.409959004065;5539.639923404966;5614.6631202128;5622.634528755618;5739.827805165852;5751.166080918327 08:19:27 INFO - PROCESS | 12392 | |1;ext.html;587.7472686744701;623.6258245052968;636.8344230500069;652.0870780906733;677.5325025732242;34404.65595344046;44745.55254447454;45365.773171134184;45527.772361138144;45728.5427145728;46582.301265481045;47151.52848471514;47215.76392118035;47221.7638911805;47224.291635625494;8312.501249924993;8859.557022148883;8989.95505022474;8993.685221017266;8998.55007249635;8325.916740832605;8557.614907329185;8562.14378562142;10523.263371563993;10768.030877221048;10387.584496620126;10427.113695335906;10428.530716117755;10440.530176142054;10445.895541044607;10660.946695266513;10690.251682382237;10732.141428685687;10734.463276836166;10736.946315268451;10676.359418434919;10725.624603138931;10744.086752625957;10745.83881241782;10750.193735469793;43889.561104388864;44064;44250;44314.33528497075;44368.3344749829;3905.9609403906165;3930.351492003816;3976.284268831609;4025.8590949316927;4360.760158191299;33514.83242583796;33935.4909676355;34014.48978265328;34041.319173616386;34386.656133438846;4499.730016199039;4535.546445355471;4576.702514336591;4583.518730533279;4614.077184563067;340089;341155;341451;341584;342322;64065.35934640687;64483.35516644867;64563.354366456675;64589;64687.353126469076;39118.217635647125;40398;40489;43185.352219716726;68241.31758682449;19595;19842.305519306756;19842.50393740139;19845.801541984394;19849;13716.314184290944;15097.39610415593;15179.772303415457;15229.162396068323;15270.389184432499;18416.17127229278;19838.90080549588;20865.478363041046;20878;21597.35207943764;7416.480846340704;7531.924680753123;7542.358899493494;7562.2437756223935;7574.469787114849;973.1630797514132;989.2580564576567;1103.569607852938;1105.7677887643524;1109.8945600167972;31387.372252554822;32555.674443255266;32568.34863302768;32794;33286.334273314395;1031.293563908725;1136.2500749505452;1163.6799880032888;1171.3733152763232;1211.1098342718094;16037.198140092949;17421;17455.38906138279;18248.63502729938;18371.90814045921;582050;585232;585480;587020;587693;63097.369026310065;63581.682091589246;63615.6819215901;63761.68119159374;63832.36167638357;1327.6216278360814;1384.6607581142482;1394.714083612857;1428.6142741459955;1467.317697270753;29765.553516696833;33376.1655958603;33971.66028339784;34451.41614378882;34497;53372;54044;54099.459005409444;54110.72944635252;54163.18755218753;424807;425368;426865;427251;428100;29637;30775.692243078178;30930;32298.35403291874;32422.513662294612;48144.75927620479;49314;49381.75309123431;49614.25578616396;49802.75098624628;43212.351814723435;43339.34990975201;43390.783046084565;44181.77909110434;44752.55247447614;42745.78627106844;44289.557104428546;44361.556384435746;44561.10877782361;45208.32187517124;42024.789876050425;42741.35887961621;43302.350464743686;43351.13297734091;43442.78278608587;36726.816365918;38865.6113438862;39257.411138833515;39573.60426395814;39834;28459.58738591247;28539.990440531583;28552.714472855005;28559;28812.85593572019 08:19:27 INFO - PROCESS | 12392 | |2;jquery.html;400.24553716244867;413.25820152825696;430.57373200531475;432.8052376430606;442.0959138561641;15342.693146137071;19320.856550311095;20496.590068198628;20690.482737931557;20725.274615388465;18863.528411789677;20231.797682023174;20414.591708165866;20434.795652043475;20564.177432902667;5699.515541178995;5947.345791962881;5949.732262048218;5950.970245148768;5952.077427998645;5565.6104072714925;5832.766689332421;5879.353271140171;5886;5887.617304875191;5608.971955140219;5843.18195452637;5843.941560584403;5846.88306233875;5848.5321174305955;5759.539236861041;5789.334226563936;5816.592838501307;5819.039858423355;5819.709014549256;5174.379074511083;5210.218467229945;5214.791408343662;5214.8696282592855;5219.138842091088;24074.27777166688;24113;24189.758102418928;24217.394565135837;24317.39206519851;2377.48883989943;2436.3665446983737;2458.9016439342404;2478.479519300949;2927.107232294171;14657.70684586313;14807.851921480755;15102.54692359231;15621.062736235748;15838;1951.365806113019;1965.0174912543728;1965.1746266568075;2049.918003279867;2063.731714877071;83970.58014709948;84667.57666211692;84839;86374;89973;9618.615255389846;10590.57637694499;10744.516496757664;11064.446777661085;11100.222984391177;13503.59489215325;13675.384607692678;14196.432142714382;14214.786778198335;14765.261736913111;8252.958735206286;8525;8576.614052367659;8605.483670979762;8737.694180703646;8692.130786921258;8718.128187181232;8726.301895848317;8869.157430044135;8928.15182557656;6729.764458243938;6732.899006514906;6819.181698196248;6866.313368663194;7045.964770176219;1849.2140840142886;1856.2946080489328;1881.8332633767152;1896.5258685328668;1899.8955057471696;931.8043210925781;979.6571200079915;985.5811280205884;1003.5333569890037;1125.3248051169396;20201.59596808085;20672.379828605164;20678.689819652718;20834.58330833405;20853.478663033544;1001.8246806808779;1031.7884833609091;1033.4006276359844;1055.72551136705;1104.9889351243683;10864.72838179036;11853.407329633485;11938.28370297785;11955.820662690066;11998.280103193661;467125;469754;473487;478610;482805;81891;82830;84318.57840710758;85412.57293713492;86190.56904715436;1039.4802598700498;1051.915846732275;1071.5713714514102;1075.9085477734325;1081.2269227502375;17433.82566174373;17726.50478351715;17799.911000445434;18101.728474072635;18334;40129.39805902972;40140.3978940322;40475.59524404836;41720.165596687286;41723.37414938718;53835.46164538461;54044.18933716076;54091.72954135204;54237;55147.72426137843;8523.786905327417;8573.22840944318;8601.39790214679;8655.610497527501;8892.644294228417;13000;13292.867071329163;13502.459901603826;13665.521706740217;13747.381367838272;11616.361100139573;11889.167758257185;11930.701732456759;12047;12074.215176013531;11708.590199342982;11758.88241117612;11843.703907402383;12097.939510302393;12388.946939509882;11759.412029398325;11809.291442513477;12002.63992080239;12274.324912129918;12319.938400307941;8402.537860417735;8664.523451209992;8679.609417576097;8805.559722014003;8828.42615230008;11829.940850295694;11907.345096019802;11984.760304793681;12158.027357811177;12322.32227227511 08:19:27 INFO - PROCESS | 12392 | |3;mootools.html;1190.5832958464537;1203.7592481503702;1314.2049060318514;1322.3718733601538;1371.2389623758809;7670.578118203503;7890.921090789097;8148.918510814905;8160.183981601836;8386.454880432768;8188.181181881809;8206.630701618427;8268.958655206716;8277.710280140182;8291.046529649093;2445.461998360358;2471.295680730992;2475.8638274894874;2476.3809047738064;2477.430191056058;2399.844010139344;2458.029078513986;2463.0394146282874;2463.3841539615096;2473.4063824682034;2415.3599296186435;2428.7571242875747;2438.817088718344;2438.902443902242;2439.4389290463205;2344.765523447659;2363.1728894886737;2381.452265978817;2383.2373640435067;2384.2132096408145;2347.80043696286;2386.1052105460453;2409.168836751318;2409.6506006629115;2412.4210189554556;8220.05469371024;8266.13205613408;8283.585820709;8423.620937057847;8661.783455413602;5311.787528498855;5481.369642491125;5484.369297530795;5484.698341591211;5487.5884308677005;3363.3441478911623;3447.172678557153;3504.439289713659;3533.169705119295;3595.334863050318;1150.7065698246977;1159.744856131658;1198.7722332756834;1216.4221994552518;1217.0385395537514;11769.176157668966;11824.704382390422;11882.881171188264;11883.465244064038;11922;4431.82272709088;4627.838025669085;4694.812207511662;4696.319033740157;4719.480857105716;9615.134637882484;9635.662751803653;9643;9643.517824108767;9655.517224138765;5088.6946783193125;5152.819651312186;5154.226865970135;5162.664426812245;5163.225516172604;4430.7686305872185;4575.17646823575;4705.200115980291;4711.717296962193;4792.520747925179;3845.9615403846165;3883.4757307763657;4013.2174226025645;4021.4973128358956;4027.335489644176;1182.1429463638792;1186.6084192216547;1193.3138445393934;1195.7967145585098;1201.891829735328;871.4248595926658;884.3632584539122;932.6689025395887;989.8119357322086;1006.285537268533;5950.9107363389585;6070.332263451017;6149.3235744068115;6172.6913654318005;6202.56582039262;436.1669211805436;448.3230322213481;475.2704598441445;488.03369328729315;488.6091127098378;4328.935065974013;4367.170237654836;4385.122975404932;4424.778761061934;4432.84485043022;10339.689809305733;10763.784724305626;10773.569057237779;10777.407242601575;10780.083692886035;10073.445960472098;10426.27016108865;10456.581736730597;10788.78422431547;10801.297915635458;8120.944277244039;8287.917120828835;8317.625706843206;8332.541710205996;8334.166583341617;5881.059030555261;6103.206583144163;6131.448169664752;6199.1011303359855;6281.089242059968;9905.356151850106;9905.801883962136;9956.900430995887;10023.799524009333;10038;8928.241099506615;9197.954010229905;9837.360571563111;10124.291299608956;10222.948885255824;7488.925110749041;7495.7001719930595;7570.280823321776;7837.41219408558;7887.290143886848;8451.28164106058;8532.018817836028;8549;8554.486730796172;8577.571121444027;7208.495405321577;7436.851262974818;7525.924740752742;7548.811279718051;7615.504992175491;7352.70589176427;7418.925810741824;7536.3970882328185;7537.585432801248;7539.32146106853;7175.8564828704175;7188.173360063451;7226.313500217471;7228.9277107230355;7232.312930271616;4862.294967229661;4881.194602890483;5037.345145131256;5062.114130027304;5127.077126117186;5127.794888204579;5251.2123181523075;5306.25712400272;5326.36083669962;5465.945340546544 08:19:27 INFO - PROCESS | 12392 | |4;prototype.html;331.3952334649653;341.1947803184485;342.74294279290547;346.5044985670491;349.12021705302624;5327.520523152915;5392.764341395161;5407.864803379917;5415.350157981043;5424.891502169954;5094.261332106842;5134;5224.660397074197;5299.390570084432;5345.915093113689;4195;4214.136102099063;4219.11398606293;4235;4242.80907359168;4207.263728847454;4216.777134630954;4225.795648240237;4241.4274073000215;4259.510156332015;3929.351656976595;3994.4008398740275;4169.6455801256925;4197.4753155855515;4212.684048696345;4145.461090058303;4180.372944058385;4183.723964190921;4189.329707246826;4207.621314081732;3720.5163328767358;3729.776213427203;3737.897320290521;3739.925201495982;3741.5033986405383;5101.438841727407;5112.539871411554;5196.92204616931;5216.739163041832;5221.2951251580935;4794.904101917942;4798.184308667535;4803.783829727636;4812.783424745895;4827.927581086286;5495.395506494282;5538.418466061046;5580.162975553659;5591.664500130005;5595.440455954413;3934.7245692801516;4055.574164712692;4089.26393249215;4109.301418758789;4120.278951183561;5739.856503587402;5749.683767392792;5753.367129615739;5753.654780713129;5765.942340576583;4153.480814898077;4168.24971505132;4208.516020657602;4208.936865947013;4216.367544868233;3959.4456776051375;4113.136241389282;4271.700980931367;4285.292926667065;4293.463317085364;4717.127331443694;4730.810767569327;4750.239961606196;4760.285957106462;4772.141014617333;5562.137868630369;5582.581306402036;5583.860403489945;5596.804111856066;5618.606697531215;1332.946682132704;1385.4665953607732;1388.7500249954903;1393.6446206217552;1395.620467103586;914.6661468564059;937.1518775508176;939.7838497145694;961.7884065505577;974.1573538888811;5279.445658205833;5319.946800531945;5326.801469669371;5346.43862394443;5352.812651557177;5597.328320601472;5598.465243153059;5599.720013999284;5626.662400255997;5631.521320687787;5189.377274727057;5229.738513074331;5277.208418737144;5307.4692530746615;5313.787448502017;2948.2039849241014;2962.2742428105253;2966.896158634481;2967.744514169247;2974.330775575478;5610.204734484925;5727.656340619576;5748.770049197985;5774.68239246837;5778.855528611818;5558.3875578478055;5597.692126933058;5611.7755289788765;5615.904898544744;5646.3907786280715;5744.454276843777;5746.367899531048;5749.338826034976;5751.309842818889;5767.423257674199;5364.839054828361;5519.834404967857;5547.2233887256625;5561.833145005657;5573.5508767719875;5422.376426710821;5437;5463.590230732791;5497.39528651856;5503.752331145028;5422.728863556886;5669.603127781016;5684.77260909559;5709.22925405065;5711.228984087095;3950.7234493585174;3951.7431366961055;3956.2878681837547;3956.9010774730864;3957.2679054375035;5472.589555783253;5479.17812328138;5491.533219676372;5510.972445137749;5519.586031047767;5313.920291195713;5395.298611180521;5416.7020813855615;5424.237122934983;5426.891462170655;5572.777088916398;5654.575906806924;5675.460831221028;5684.204211410489;5692.459216374438;5372.543333816513;5541.810984661117;5612.326520817528;5617.943820561742;5645.576581756302;5478.424765399735;5635.887282254414;5678.233438485751;5678.517326027169;5683.602147849776;5573.526250268773;5574.721263936706;5576.7211639417055;5578.832635020955;5581.5255703265675 08:19:27 INFO - PROCESS | 12392 | |5;yui.html;773.7021246819976;792.9127795942449;799.4563696686254;828.3869936247179;863.0980625246617;14112.364943577539;15088.849111508895;15817.525474235763;16513;16725.16374181292;14321.570352889405;14800.777988330157;16441.09573973434;16628.75056874145;16649.33402663895;726.5967388099602;856.4903882190087;878.2973621103124;880.0187790613484;880.6389380354057;751.9774406767779;845.8223773007676;870.1863757386864;875.5009644502636;876.7632739160455;910.1490106750176;912.3886995712855;912.6760000199934;912.8448163812135;912.9087091290884;757.6174032113747;899.7615631857562;907.6233363154283;907.8592818113203;908.9500077495735;573.5211098732564;652.1098700274092;667.4993754683987;672.045695112936;673.1383828699272;15254.542363728995;15279.312430940634;15293.158876261801;15298.311575978996;15298.770518442232;13257.66855828612;13270.270135142564;13439.193648381031;13464.124831885896;13613.319334033358;11948.701282468008;12139.514419423213;12258.387080645933;12307.076969227344;12517.56188533406;4526.85739852352;4536.183486972343;4557.567031132037;4558.0655965526985;4623.884402889955;64694.67652661706;65208;65322;65519.67240163769;65606.34393656098;10717.89282107169;10839.83740243897;10894.72763180911;11104.278221915549;11198.160137989684;19752.3086691968;19808.20767169297;19891.104900279523;20110.095045722977;20537;8226.383021273428;8358;8386.622601982925;8496.70261540843;8566.571671416405;4645.837395691135;4675.0883577702025;4707.929381059287;4792.95207047932;4913.557779799835;3364.512145738854;3463.0995941055508;3466.913327166841;3467.6185619581825;3470.35798377301;633.3856159525253;638.1034646321832;646.0374042676378;664.1200409457392;665.6838001949036;648.6270394523074;664.7972368427579;669.7555392281782;730.477708438469;770.587735561472;9287.303452240974;9430.811383772287;9553.522323883779;9871.75320616976;10151.746206344753;644.1111266452359;713.8322494213855;731.8755811512056;737.1007371007363;755.316438623047;4329.610335069859;4706.199946009118;4720.291956206528;4745.0661586110955;4808.711477311373;87209.56395217983;89752.5512372434;93284.53357733168;93334.0666593339;95310;50179.74910125426;51265.23102153471;60706;67500;75222.62388688022;72823;73834;74045;74355;74887;9059.864102038342;9111.17999380059;9223.76940576491;9309.953450232706;9428.62285508572;35272.647273526934;37123.81438092792;46427.76786116048;47041.52958470509;47874.521254787;61894;62329.37670623236;65321.673391632736;66493;66712.33287667061;11722.94138529302;11870.703232419259;12087.697807554881;12638.747225055631;12737.426815793126;14473.782893256399;14683.92658036703;14754.065708623317;14843;15052.397904083715;11621.593244236412;12863.421146048264;12939.611811645666;13067.215967042008;13313.733725325634;13045.386095957898;13195.274259915797;13229.867701323248;13248.271345075727;13362.732745344843;13120.212787232796;13188.80216796768;13449.193048416735;13540.526081587097;13655.590332290047;10903;11188.66434006981;11235.66293011211;11648.184627076023;11873.228240164362;11279.605213817476;11475.942620287178;11476.598319058792;11754.823677645014;11828 08:19:27 INFO - PROCESS | 12392 | __end_tp_report 08:19:27 INFO - PROCESS | 12392 | __start_cc_report 08:19:27 INFO - PROCESS | 12392 | _x_x_mozilla_cycle_collect,1115 08:19:27 INFO - PROCESS | 12392 | __end_cc_report 08:19:27 INFO - PROCESS | 12392 | __startTimestamp1481127567467__endTimestamp 08:19:27 INFO - PROCESS | 12392 | 08:19:27 INFO - PROCESS | 12392 | ------- Summary: start ------- 08:19:27 INFO - PROCESS | 12392 | Number of tests: 6 08:19:27 INFO - PROCESS | 12392 | 08:19:27 INFO - PROCESS | 12392 | [#0] dojo.html Cycles:165 Average:5532.38 Median:5749.02 stddev:610.70 (10.6%) stddev-sans-first:585.24 08:19:27 INFO - PROCESS | 12392 | Values: 3229.5 3282.0 3284.9 3301.7 3306.0 5483.9 5574.2 5588.1 5593.4 5604.2 5512.9 5569.9 5571.2 5580.4 5592.2 5051.3 5080.6 5111.3 5118.2 5174.1 4978.8 5113.9 5180.3 5185.4 5186.4 4977.4 5014.7 5038.4 5071.9 5087.9 5051.7 5076.0 5076.7 5166.0 5185.2 5010.5 5089.3 5136.4 5140.5 5148.9 5421.1 5453.4 5464.2 5487.9 5523.3 5833.3 5844.1 5855.1 5944.2 5961.0 5999.2 6001.5 6013.4 6016.8 6017.3 5468.4 5495.4 5509.3 5529.2 5533.2 6016.0 6058.0 6060.3 6070.9 6074.1 5875.5 5886.0 5889.6 5892.5 5898.1 5665.1 5714.4 5837.2 5878.2 5883.1 5925.9 5927.9 5928.2 5960.5 5962.8 5873.5 5930.1 5932.0 5934.1 5945.9 4490.1 4539.7 4571.0 4601.2 4601.6 4127.5 4131.8 4136.4 4153.4 4169.4 5756.8 5757.1 5759.9 5768.7 5769.3 5808.7 5849.6 5886.9 5929.1 6044.3 5661.9 5664.9 5666.7 5672.7 5690.6 5047.5 5049.9 5058.1 5073.1 5093.7 5948.3 5984.2 6103.8 6169.5 6177.1 5965.6 6018.0 6030.6 6056.0 6062.8 6181.7 6200.0 6215.0 6216.8 6232.6 5709.0 5710.9 5920.3 5924.4 5936.2 5916.9 5947.6 5953.1 6016.7 6044.7 5880.4 5882.5 5886.9 5890.7 5892.8 5537.4 5870.5 5874.7 5880.7 5884.3 5582.6 5678.2 5721.0 5749.0 5835.7 5865.6 5884.6 5890.3 5895.0 5900.4 5539.6 5614.7 5622.6 5739.8 5751.2 08:19:27 INFO - PROCESS | 12392 | 08:19:27 INFO - PROCESS | 12392 | [#1] ext.html Cycles:180 Average:62153.34 Median:22211.93 stddev:122617.78 (552.0%) stddev-sans-first:122874.62 08:19:27 INFO - PROCESS | 12392 | Values: 587.7 623.6 636.8 652.1 677.5 34404.7 44745.6 45365.8 45527.8 45728.5 46582.3 47151.5 47215.8 47221.8 47224.3 8312.5 8859.6 8990.0 8993.7 8998.6 8325.9 8557.6 8562.1 10523.3 10768.0 10387.6 10427.1 10428.5 10440.5 10445.9 10660.9 10690.3 10732.1 10734.5 10736.9 10676.4 10725.6 10744.1 10745.8 10750.2 43889.6 44064.0 44250.0 44314.3 44368.3 3906.0 3930.4 3976.3 4025.9 4360.8 33514.8 33935.5 34014.5 34041.3 34386.7 4499.7 4535.5 4576.7 4583.5 4614.1 340089.0 341155.0 341451.0 341584.0 342322.0 64065.4 64483.4 64563.4 64589.0 64687.4 39118.2 40398.0 40489.0 43185.4 68241.3 19595.0 19842.3 19842.5 19845.8 19849.0 13716.3 15097.4 15179.8 15229.2 15270.4 18416.2 19838.9 20865.5 20878.0 21597.4 7416.5 7531.9 7542.4 7562.2 7574.5 973.2 989.3 1103.6 1105.8 1109.9 31387.4 32555.7 32568.3 32794.0 33286.3 1031.3 1136.3 1163.7 1171.4 1211.1 16037.2 17421.0 17455.4 18248.6 18371.9 582050.0 585232.0 585480.0 587020.0 587693.0 63097.4 63581.7 63615.7 63761.7 63832.4 1327.6 1384.7 1394.7 1428.6 1467.3 29765.6 33376.2 33971.7 34451.4 34497.0 53372.0 54044.0 54099.5 54110.7 54163.2 424807.0 425368.0 426865.0 427251.0 428100.0 29637.0 30775.7 30930.0 32298.4 32422.5 48144.8 49314.0 49381.8 49614.3 49802.8 43212.4 43339.3 43390.8 44181.8 44752.6 42745.8 44289.6 44361.6 44561.1 45208.3 42024.8 42741.4 43302.4 43351.1 43442.8 36726.8 38865.6 39257.4 39573.6 39834.0 28459.6 28540.0 28552.7 28559.0 28812.9 08:19:27 INFO - PROCESS | 12392 | 08:19:27 INFO - PROCESS | 12392 | [#2] jquery.html Cycles:180 Average:28740.29 Median:24267.39 stddev:78119.50 (321.9%) stddev-sans-first:78309.67 08:19:27 INFO - PROCESS | 12392 | Values: 400.2 413.3 430.6 432.8 442.1 15342.7 19320.9 20496.6 20690.5 20725.3 18863.5 20231.8 20414.6 20434.8 20564.2 5699.5 5947.3 5949.7 5951.0 5952.1 5565.6 5832.8 5879.4 5886.0 5887.6 5609.0 5843.2 5843.9 5846.9 5848.5 5759.5 5789.3 5816.6 5819.0 5819.7 5174.4 5210.2 5214.8 5214.9 5219.1 24074.3 24113.0 24189.8 24217.4 24317.4 2377.5 2436.4 2458.9 2478.5 2927.1 14657.7 14807.9 15102.5 15621.1 15838.0 1951.4 1965.0 1965.2 2049.9 2063.7 83970.6 84667.6 84839.0 86374.0 89973.0 9618.6 10590.6 10744.5 11064.4 11100.2 13503.6 13675.4 14196.4 14214.8 14765.3 8253.0 8525.0 8576.6 8605.5 8737.7 8692.1 8718.1 8726.3 8869.2 8928.2 6729.8 6732.9 6819.2 6866.3 7046.0 1849.2 1856.3 1881.8 1896.5 1899.9 931.8 979.7 985.6 1003.5 1125.3 20201.6 20672.4 20678.7 20834.6 20853.5 1001.8 1031.8 1033.4 1055.7 1105.0 10864.7 11853.4 11938.3 11955.8 11998.3 467125.0 469754.0 473487.0 478610.0 482805.0 81891.0 82830.0 84318.6 85412.6 86190.6 1039.5 1051.9 1071.6 1075.9 1081.2 17433.8 17726.5 17799.9 18101.7 18334.0 40129.4 40140.4 40475.6 41720.2 41723.4 53835.5 54044.2 54091.7 54237.0 55147.7 8523.8 8573.2 8601.4 8655.6 8892.6 13000.0 13292.9 13502.5 13665.5 13747.4 11616.4 11889.2 11930.7 12047.0 12074.2 11708.6 11758.9 11843.7 12097.9 12388.9 11759.4 11809.3 12002.6 12274.3 12319.9 8402.5 8664.5 8679.6 8805.6 8828.4 11829.9 11907.3 11984.8 12158.0 12322.3 08:19:27 INFO - PROCESS | 12392 | 08:19:27 INFO - PROCESS | 12392 | [#3] mootools.html Cycles:180 Average:5694.91 Median:2684.90 stddev:3168.39 (118.0%) stddev-sans-first:3159.19 08:19:27 INFO - PROCESS | 12392 | Values: 1190.6 1203.8 1314.2 1322.4 1371.2 7670.6 7890.9 8148.9 8160.2 8386.5 8188.2 8206.6 8269.0 8277.7 8291.0 2445.5 2471.3 2475.9 2476.4 2477.4 2399.8 2458.0 2463.0 2463.4 2473.4 2415.4 2428.8 2438.8 2438.9 2439.4 2344.8 2363.2 2381.5 2383.2 2384.2 2347.8 2386.1 2409.2 2409.7 2412.4 8220.1 8266.1 8283.6 8423.6 8661.8 5311.8 5481.4 5484.4 5484.7 5487.6 3363.3 3447.2 3504.4 3533.2 3595.3 1150.7 1159.7 1198.8 1216.4 1217.0 11769.2 11824.7 11882.9 11883.5 11922.0 4431.8 4627.8 4694.8 4696.3 4719.5 9615.1 9635.7 9643.0 9643.5 9655.5 5088.7 5152.8 5154.2 5162.7 5163.2 4430.8 4575.2 4705.2 4711.7 4792.5 3846.0 3883.5 4013.2 4021.5 4027.3 1182.1 1186.6 1193.3 1195.8 1201.9 871.4 884.4 932.7 989.8 1006.3 5950.9 6070.3 6149.3 6172.7 6202.6 436.2 448.3 475.3 488.0 488.6 4328.9 4367.2 4385.1 4424.8 4432.8 10339.7 10763.8 10773.6 10777.4 10780.1 10073.4 10426.3 10456.6 10788.8 10801.3 8120.9 8287.9 8317.6 8332.5 8334.2 5881.1 6103.2 6131.4 6199.1 6281.1 9905.4 9905.8 9956.9 10023.8 10038.0 8928.2 9198.0 9837.4 10124.3 10222.9 7488.9 7495.7 7570.3 7837.4 7887.3 8451.3 8532.0 8549.0 8554.5 8577.6 7208.5 7436.9 7525.9 7548.8 7615.5 7352.7 7418.9 7536.4 7537.6 7539.3 7175.9 7188.2 7226.3 7228.9 7232.3 4862.3 4881.2 5037.3 5062.1 5127.1 5127.8 5251.2 5306.3 5326.4 5465.9 08:19:27 INFO - PROCESS | 12392 | 08:19:27 INFO - PROCESS | 12392 | [#4] prototype.html Cycles:180 Average:4665.10 Median:5349.63 stddev:1351.17 (25.3%) stddev-sans-first:1315.22 08:19:27 INFO - PROCESS | 12392 | Values: 331.4 341.2 342.7 346.5 349.1 5327.5 5392.8 5407.9 5415.4 5424.9 5094.3 5134.0 5224.7 5299.4 5345.9 4195.0 4214.1 4219.1 4235.0 4242.8 4207.3 4216.8 4225.8 4241.4 4259.5 3929.4 3994.4 4169.6 4197.5 4212.7 4145.5 4180.4 4183.7 4189.3 4207.6 3720.5 3729.8 3737.9 3739.9 3741.5 5101.4 5112.5 5196.9 5216.7 5221.3 4794.9 4798.2 4803.8 4812.8 4827.9 5495.4 5538.4 5580.2 5591.7 5595.4 3934.7 4055.6 4089.3 4109.3 4120.3 5739.9 5749.7 5753.4 5753.7 5765.9 4153.5 4168.2 4208.5 4208.9 4216.4 3959.4 4113.1 4271.7 4285.3 4293.5 4717.1 4730.8 4750.2 4760.3 4772.1 5562.1 5582.6 5583.9 5596.8 5618.6 1332.9 1385.5 1388.8 1393.6 1395.6 914.7 937.2 939.8 961.8 974.2 5279.4 5319.9 5326.8 5346.4 5352.8 5597.3 5598.5 5599.7 5626.7 5631.5 5189.4 5229.7 5277.2 5307.5 5313.8 2948.2 2962.3 2966.9 2967.7 2974.3 5610.2 5727.7 5748.8 5774.7 5778.9 5558.4 5597.7 5611.8 5615.9 5646.4 5744.5 5746.4 5749.3 5751.3 5767.4 5364.8 5519.8 5547.2 5561.8 5573.6 5422.4 5437.0 5463.6 5497.4 5503.8 5422.7 5669.6 5684.8 5709.2 5711.2 3950.7 3951.7 3956.3 3956.9 3957.3 5472.6 5479.2 5491.5 5511.0 5519.6 5313.9 5395.3 5416.7 5424.2 5426.9 5572.8 5654.6 5675.5 5684.2 5692.5 5372.5 5541.8 5612.3 5617.9 5645.6 5478.4 5635.9 5678.2 5678.5 5683.6 5573.5 5574.7 5576.7 5578.8 5581.5 08:19:27 INFO - PROCESS | 12392 | 08:19:27 INFO - PROCESS | 12392 | [#5] yui.html Cycles:180 Average:17878.05 Median:4732.68 stddev:23372.02 (493.8%) stddev-sans-first:23402.30 08:19:27 INFO - PROCESS | 12392 | Values: 773.7 792.9 799.5 828.4 863.1 14112.4 15088.8 15817.5 16513.0 16725.2 14321.6 14800.8 16441.1 16628.8 16649.3 726.6 856.5 878.3 880.0 880.6 752.0 845.8 870.2 875.5 876.8 910.1 912.4 912.7 912.8 912.9 757.6 899.8 907.6 907.9 909.0 573.5 652.1 667.5 672.0 673.1 15254.5 15279.3 15293.2 15298.3 15298.8 13257.7 13270.3 13439.2 13464.1 13613.3 11948.7 12139.5 12258.4 12307.1 12517.6 4526.9 4536.2 4557.6 4558.1 4623.9 64694.7 65208.0 65322.0 65519.7 65606.3 10717.9 10839.8 10894.7 11104.3 11198.2 19752.3 19808.2 19891.1 20110.1 20537.0 8226.4 8358.0 8386.6 8496.7 8566.6 4645.8 4675.1 4707.9 4793.0 4913.6 3364.5 3463.1 3466.9 3467.6 3470.4 633.4 638.1 646.0 664.1 665.7 648.6 664.8 669.8 730.5 770.6 9287.3 9430.8 9553.5 9871.8 10151.7 644.1 713.8 731.9 737.1 755.3 4329.6 4706.2 4720.3 4745.1 4808.7 87209.6 89752.6 93284.5 93334.1 95310.0 50179.7 51265.2 60706.0 67500.0 75222.6 72823.0 73834.0 74045.0 74355.0 74887.0 9059.9 9111.2 9223.8 9310.0 9428.6 35272.6 37123.8 46427.8 47041.5 47874.5 61894.0 62329.4 65321.7 66493.0 66712.3 11722.9 11870.7 12087.7 12638.7 12737.4 14473.8 14683.9 14754.1 14843.0 15052.4 11621.6 12863.4 12939.6 13067.2 13313.7 13045.4 13195.3 13229.9 13248.3 13362.7 13120.2 13188.8 13449.2 13540.5 13655.6 10903.0 11188.7 11235.7 11648.2 11873.2 11279.6 11475.9 11476.6 11754.8 11828.0 08:19:27 INFO - PROCESS | 12392 | -------- Summary: end -------- 08:19:27 INFO - PROCESS | 12392 | 08:19:28 INFO - TEST-INFO | 12392: exit 0 08:19:28 INFO - TEST-OK | dromaeo_css | took 1115632ms 08:19:28 INFO - TEST-START | kraken 08:19:28 INFO - operating with platform_type : linux_ 08:19:28 INFO - Initialising browser for kraken test... 08:19:28 INFO - TEST-INFO | started process 12710 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1vV7QV/profile http://localhost:53292/getInfo.html) 08:19:32 INFO - PROCESS | 12710 | __metrics Screen width/height:1600/1200 08:19:32 INFO - PROCESS | 12710 | colorDepth:24 08:19:32 INFO - PROCESS | 12710 | Browser inner width/height: 1024/697 08:19:32 INFO - PROCESS | 12710 | __metrics 08:19:32 INFO - PROCESS | 12710 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:19:32 INFO - PROCESS | 12710 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:19:33 INFO - PROCESS | 12710 | console.error: PushService: 08:19:33 INFO - PROCESS | 12710 | stateChangeProcessEnqueue: Error transitioning state 08:19:33 INFO - PROCESS | 12710 | UnknownError 08:19:33 INFO - TEST-INFO | 12710: exit 0 08:19:33 INFO - Browser initialized. 08:19:33 INFO - Running cycle 1/1 for kraken test... 08:19:33 INFO - TEST-INFO | started process 12803 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1vV7QV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:19:45 INFO - PROCESS | 12803 | RSS: Main: 147173376 08:19:45 INFO - PROCESS | 12803 | 08:19:48 INFO - PROCESS | 12803 | Cycle 1(1): loaded http://localhost:53292/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53292/tests/kraken/driver.html?testName=audio-beat-detection) 08:19:49 INFO - PROCESS | 12803 | RSS: Main: 188469248 08:19:49 INFO - PROCESS | 12803 | 08:19:51 INFO - PROCESS | 12803 | Cycle 1(1): loaded http://localhost:53292/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53292/tests/kraken/driver.html?testName=audio-dft) 08:19:52 INFO - PROCESS | 12803 | RSS: Main: 178315264 08:19:52 INFO - PROCESS | 12803 | 08:19:55 INFO - PROCESS | 12803 | Cycle 1(1): loaded http://localhost:53292/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53292/tests/kraken/driver.html?testName=audio-fft) 08:19:55 INFO - PROCESS | 12803 | RSS: Main: 269443072 08:19:55 INFO - PROCESS | 12803 | 08:19:57 INFO - PROCESS | 12803 | Cycle 1(1): loaded http://localhost:53292/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53292/tests/kraken/driver.html?testName=audio-oscillator) 08:19:58 INFO - PROCESS | 12803 | RSS: Main: 176025600 08:19:58 INFO - PROCESS | 12803 | 08:20:00 INFO - PROCESS | 12803 | Cycle 1(1): loaded http://localhost:53292/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53292/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:20:01 INFO - PROCESS | 12803 | RSS: Main: 178532352 08:20:01 INFO - PROCESS | 12803 | 08:20:04 INFO - PROCESS | 12803 | Cycle 1(1): loaded http://localhost:53292/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53292/tests/kraken/driver.html?testName=imaging-darkroom) 08:20:04 INFO - PROCESS | 12803 | RSS: Main: 216383488 08:20:04 INFO - PROCESS | 12803 | 08:20:08 INFO - PROCESS | 12803 | Cycle 1(1): loaded http://localhost:53292/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53292/tests/kraken/driver.html?testName=imaging-desaturate) 08:20:08 INFO - PROCESS | 12803 | RSS: Main: 215834624 08:20:08 INFO - PROCESS | 12803 | 08:20:11 INFO - PROCESS | 12803 | Cycle 1(1): loaded http://localhost:53292/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53292/tests/kraken/driver.html?testName=json-parse-financial) 08:20:11 INFO - PROCESS | 12803 | RSS: Main: 214138880 08:20:11 INFO - PROCESS | 12803 | 08:20:13 INFO - PROCESS | 12803 | Cycle 1(1): loaded http://localhost:53292/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53292/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:20:13 INFO - PROCESS | 12803 | RSS: Main: 176447488 08:20:13 INFO - PROCESS | 12803 | 08:20:15 INFO - PROCESS | 12803 | Cycle 1(1): loaded http://localhost:53292/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53292/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:20:16 INFO - PROCESS | 12803 | RSS: Main: 182968320 08:20:16 INFO - PROCESS | 12803 | 08:20:18 INFO - PROCESS | 12803 | Cycle 1(1): loaded http://localhost:53292/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53292/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:20:18 INFO - PROCESS | 12803 | RSS: Main: 189779968 08:20:18 INFO - PROCESS | 12803 | 08:20:21 INFO - PROCESS | 12803 | Cycle 1(1): loaded http://localhost:53292/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53292/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:20:22 INFO - PROCESS | 12803 | RSS: Main: 199024640 08:20:22 INFO - PROCESS | 12803 | 08:20:24 INFO - PROCESS | 12803 | Cycle 1(1): loaded http://localhost:53292/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53292/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:20:25 INFO - PROCESS | 12803 | RSS: Main: 195047424 08:20:25 INFO - PROCESS | 12803 | 08:20:27 INFO - PROCESS | 12803 | Cycle 1(1): loaded http://localhost:53292/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53292/tests/kraken/driver.html?testName=ai-astar) 08:20:27 INFO - PROCESS | 12803 | RSS: Main: 246964224 08:20:27 INFO - PROCESS | 12803 | 08:20:27 INFO - PROCESS | 12803 | __start_tp_report 08:20:27 INFO - PROCESS | 12803 | _x_x_mozilla_page_load 08:20:27 INFO - PROCESS | 12803 | _x_x_mozilla_page_load_details 08:20:27 INFO - PROCESS | 12803 | |i|pagename|runs| 08:20:27 INFO - PROCESS | 12803 | |0;ai-astar;102;111;111;110;112;111;110;110;112;111 08:20:27 INFO - PROCESS | 12803 | |1;audio-beat-detection;149;124;126;171;122;121;121;126;160;125 08:20:27 INFO - PROCESS | 12803 | |2;audio-dft;159;162;162;161;161;162;159;162;166;161 08:20:27 INFO - PROCESS | 12803 | |3;audio-fft;74;76;76;110;75;75;76;74;97;75 08:20:27 INFO - PROCESS | 12803 | |4;audio-oscillator;82;81;116;82;82;82;112;81;82;118 08:20:27 INFO - PROCESS | 12803 | |5;imaging-gaussian-blur;118;118;117;117;116;117;117;116;117;117 08:20:27 INFO - PROCESS | 12803 | |6;imaging-darkroom;146;147;146;146;146;146;146;146;146;146 08:20:27 INFO - PROCESS | 12803 | |7;imaging-desaturate;85;85;85;85;84;84;85;84;85;84 08:20:27 INFO - PROCESS | 12803 | |8;json-parse-financial;51;52;52;51;51;51;51;51;51;52 08:20:27 INFO - PROCESS | 12803 | |9;json-stringify-tinderbox;58;59;57;59;58;59;59;58;59;59 08:20:27 INFO - PROCESS | 12803 | |10;stanford-crypto-aes;76;79;82;76;77;75;76;81;85;79 08:20:27 INFO - PROCESS | 12803 | |11;stanford-crypto-ccm;133;128;131;134;132;132;130;126;165;129 08:20:27 INFO - PROCESS | 12803 | |12;stanford-crypto-pbkdf2;158;158;161;167;158;159;158;166;160;159 08:20:27 INFO - PROCESS | 12803 | |13;stanford-crypto-sha256-iterative;64;64;64;65;63;63;63;65;63;63 08:20:27 INFO - PROCESS | 12803 | __end_tp_report 08:20:27 INFO - PROCESS | 12803 | __start_cc_report 08:20:27 INFO - PROCESS | 12803 | _x_x_mozilla_cycle_collect,1622 08:20:27 INFO - PROCESS | 12803 | __end_cc_report 08:20:27 INFO - PROCESS | 12803 | __startTimestamp1481127627310__endTimestamp 08:20:27 INFO - PROCESS | 12803 | 08:20:27 INFO - PROCESS | 12803 | ------- Summary: start ------- 08:20:27 INFO - PROCESS | 12803 | Number of tests: 14 08:20:27 INFO - PROCESS | 12803 | 08:20:27 INFO - PROCESS | 12803 | [#0] ai-astar Cycles:10 Average:110.00 Median:111.00 stddev:2.91 (2.6%) stddev-sans-first:0.78 08:20:27 INFO - PROCESS | 12803 | Values: 102.0 111.0 111.0 110.0 112.0 111.0 110.0 110.0 112.0 111.0 08:20:27 INFO - PROCESS | 12803 | 08:20:27 INFO - PROCESS | 12803 | [#1] audio-beat-detection Cycles:10 Average:134.50 Median:126.00 stddev:18.43 (14.6%) stddev-sans-first:18.79 08:20:27 INFO - PROCESS | 12803 | Values: 149.0 124.0 126.0 171.0 122.0 121.0 121.0 126.0 160.0 125.0 08:20:27 INFO - PROCESS | 12803 | 08:20:27 INFO - PROCESS | 12803 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.96 (1.2%) stddev-sans-first:1.86 08:20:27 INFO - PROCESS | 12803 | Values: 159.0 162.0 162.0 161.0 161.0 162.0 159.0 162.0 166.0 161.0 08:20:27 INFO - PROCESS | 12803 | 08:20:27 INFO - PROCESS | 12803 | [#3] audio-fft Cycles:10 Average:80.80 Median:75.50 stddev:12.37 (16.4%) stddev-sans-first:12.88 08:20:27 INFO - PROCESS | 12803 | Values: 74.0 76.0 76.0 110.0 75.0 75.0 76.0 74.0 97.0 75.0 08:20:27 INFO - PROCESS | 12803 | 08:20:27 INFO - PROCESS | 12803 | [#4] audio-oscillator Cycles:10 Average:91.80 Median:82.00 stddev:16.31 (19.9%) stddev-sans-first:16.91 08:20:27 INFO - PROCESS | 12803 | Values: 82.0 81.0 116.0 82.0 82.0 82.0 112.0 81.0 82.0 118.0 08:20:27 INFO - PROCESS | 12803 | 08:20:27 INFO - PROCESS | 12803 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 08:20:27 INFO - PROCESS | 12803 | Values: 118.0 118.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 117.0 08:20:27 INFO - PROCESS | 12803 | 08:20:27 INFO - PROCESS | 12803 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 08:20:27 INFO - PROCESS | 12803 | Values: 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 08:20:27 INFO - PROCESS | 12803 | 08:20:27 INFO - PROCESS | 12803 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.52 (0.6%) stddev-sans-first:0.53 08:20:27 INFO - PROCESS | 12803 | Values: 85.0 85.0 85.0 85.0 84.0 84.0 85.0 84.0 85.0 84.0 08:20:27 INFO - PROCESS | 12803 | 08:20:27 INFO - PROCESS | 12803 | [#8] json-parse-financial Cycles:10 Average:51.30 Median:51.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 08:20:27 INFO - PROCESS | 12803 | Values: 51.0 52.0 52.0 51.0 51.0 51.0 51.0 51.0 51.0 52.0 08:20:27 INFO - PROCESS | 12803 | 08:20:27 INFO - PROCESS | 12803 | [#9] json-stringify-tinderbox Cycles:10 Average:58.50 Median:59.00 stddev:0.71 (1.2%) stddev-sans-first:0.73 08:20:27 INFO - PROCESS | 12803 | Values: 58.0 59.0 57.0 59.0 58.0 59.0 59.0 58.0 59.0 59.0 08:20:27 INFO - PROCESS | 12803 | 08:20:27 INFO - PROCESS | 12803 | [#10] stanford-crypto-aes Cycles:10 Average:78.60 Median:79.00 stddev:3.24 (4.1%) stddev-sans-first:3.30 08:20:27 INFO - PROCESS | 12803 | Values: 76.0 79.0 82.0 76.0 77.0 75.0 76.0 81.0 85.0 79.0 08:20:27 INFO - PROCESS | 12803 | 08:20:27 INFO - PROCESS | 12803 | [#11] stanford-crypto-ccm Cycles:10 Average:134.00 Median:132.00 stddev:11.16 (8.5%) stddev-sans-first:11.83 08:20:27 INFO - PROCESS | 12803 | Values: 133.0 128.0 131.0 134.0 132.0 132.0 130.0 126.0 165.0 129.0 08:20:27 INFO - PROCESS | 12803 | 08:20:27 INFO - PROCESS | 12803 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.40 Median:159.50 stddev:3.37 (2.1%) stddev-sans-first:3.46 08:20:27 INFO - PROCESS | 12803 | Values: 158.0 158.0 161.0 167.0 158.0 159.0 158.0 166.0 160.0 159.0 08:20:27 INFO - PROCESS | 12803 | 08:20:27 INFO - PROCESS | 12803 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 08:20:27 INFO - PROCESS | 12803 | Values: 64.0 64.0 64.0 65.0 63.0 63.0 63.0 65.0 63.0 63.0 08:20:27 INFO - PROCESS | 12803 | -------- Summary: end -------- 08:20:27 INFO - PROCESS | 12803 | 08:20:28 INFO - TEST-INFO | 12803: exit 0 08:20:28 INFO - TEST-OK | kraken | took 60192ms 08:20:28 INFO - SUITE-END | took 1175s 08:20:28 INFO - Completed test suite (00:19:35) 08:20:28 INFO - javascript benchmark 08:20:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3229.499427588724, 3281.9671803281967, 3284.8850290239848, 3301.653326400726, 3305.966940330596, 5483.862903427416, 5574.219609254703, 5588.105903055512, 5593.412691667378, 5604.215409842625, 5512.91730624041, 5569.916451253234, 5571.247881536002, 5580.441955804427, 5592.189132575774, 5051.292819005343, 5080.593552515808, 5111.335526381566, 5118.232265160219, 5174.094533456649, 4978.751062446863, 5113.948860511385, 5180.274761533388, 5185.351831021122, 5186.351706036746, 4977.402711674604, 5014.69911805291, 5038.420581633104, 5071.949280507203, 5087.949120508784, 5051.747412629372, 5075.9746201268945, 5076.746162691888, 5165.974170129163, 5185.196294574347, 5010.498950104997, 5089.262057001714, 5136.357955255593, 5140.460251673595, 5148.897022059576, 5421.078416669176, 5453.372862120827, 5464.207689884985, 5487.862803429906, 5523.28197334348, 5833.300003999547, 5844.064949608085, 5855.121731740231, 5944.167816505693, 5961.0, 5999.190109335227, 6001.51987840976, 6013.428724271187, 6016.8495787605225, 6017.338092809788, 5468.425815289377, 5495.395506494282, 5509.283793106871, 5529.198266251371, 5533.22534845122, 6015.969920150371, 6057.969710151421, 6060.303065147476, 6070.939290607037, 6074.149619053336, 5875.50058245054, 5886.0288052471715, 5889.587728858939, 5892.499137573269, 5898.14476900847, 5665.12190610456, 5714.428557144252, 5837.211976383134, 5878.2358293421585, 5883.14694369314, 5925.9407405925385, 5927.851803704855, 5928.229330187048, 5960.523158147338, 5962.761489540457, 5873.530117590582, 5930.140129681258, 5932.021216499229, 5934.080217566284, 5945.881082378328, 4490.146872094291, 4539.727616342964, 4571.040081582838, 4601.171789077998, 4601.608863246662, 4127.504699436087, 4131.814068366931, 4136.4415803866095, 4153.397757325171, 4169.4162817205615, 5756.798512052058, 5757.050086735641, 5759.94240057594, 5768.653880767168, 5769.278840144982, 5808.680522571299, 5849.649021058665, 5886.852828679317, 5929.080992446177, 6044.335123136451, 5661.915071273934, 5664.915026274609, 5666.660000399989, 5672.716364181774, 5690.630109042899, 5047.545720885138, 5049.8737531562, 5058.064258112261, 5073.061483625541, 5093.694378337237, 5948.315943666534, 5984.16221728967, 6103.755849765959, 6169.475594574422, 6177.104319873683, 5965.552583556164, 6018.037114061729, 6030.6080104793045, 6056.03103503455, 6062.757489700362, 6181.705587406903, 6200.0, 6215.036669316263, 6216.751329946752, 6232.626042437469, 5708.971455142698, 5710.914336284876, 5920.259967504062, 5924.407559244041, 5936.228290322403, 5916.852078697895, 5947.6431414115295, 5953.1367951647635, 6016.729247183975, 6044.697765111639, 5880.353161152184, 5882.5293976482635, 5886.852828679317, 5890.7054647266605, 5892.793752218652, 5537.390887002507, 5870.471657550841, 5874.676892770768, 5880.735366908414, 5884.32330282023, 5582.609217354909, 5678.20505129274, 5720.971395142998, 5749.022666146681, 5835.67903765297, 5865.589408741518, 5884.58807883444, 5890.263717035371, 5894.970525147347, 5900.409959004065, 5539.639923404966, 5614.6631202128, 5622.634528755618, 5739.827805165852, 5751.166080918327], "value": 5492.611218262375, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.7472686744701, 623.6258245052968, 636.8344230500069, 652.0870780906733, 677.5325025732242, 34404.65595344046, 44745.55254447454, 45365.773171134184, 45527.772361138144, 45728.5427145728, 46582.301265481045, 47151.52848471514, 47215.76392118035, 47221.7638911805, 47224.291635625494, 8312.501249924993, 8859.557022148883, 8989.95505022474, 8993.685221017266, 8998.55007249635, 8325.916740832605, 8557.614907329185, 8562.14378562142, 10523.263371563993, 10768.030877221048, 10387.584496620126, 10427.113695335906, 10428.530716117755, 10440.530176142054, 10445.895541044607, 10660.946695266513, 10690.251682382237, 10732.141428685687, 10734.463276836166, 10736.946315268451, 10676.359418434919, 10725.624603138931, 10744.086752625957, 10745.83881241782, 10750.193735469793, 43889.561104388864, 44064.0, 44250.0, 44314.33528497075, 44368.3344749829, 3905.9609403906165, 3930.351492003816, 3976.284268831609, 4025.8590949316927, 4360.760158191299, 33514.83242583796, 33935.4909676355, 34014.48978265328, 34041.319173616386, 34386.656133438846, 4499.730016199039, 4535.546445355471, 4576.702514336591, 4583.518730533279, 4614.077184563067, 340089.0, 341155.0, 341451.0, 341584.0, 342322.0, 64065.35934640687, 64483.35516644867, 64563.354366456675, 64589.0, 64687.353126469076, 39118.217635647125, 40398.0, 40489.0, 43185.352219716726, 68241.31758682449, 19595.0, 19842.305519306756, 19842.50393740139, 19845.801541984394, 19849.0, 13716.314184290944, 15097.39610415593, 15179.772303415457, 15229.162396068323, 15270.389184432499, 18416.17127229278, 19838.90080549588, 20865.478363041046, 20878.0, 21597.35207943764, 7416.480846340704, 7531.924680753123, 7542.358899493494, 7562.2437756223935, 7574.469787114849, 973.1630797514132, 989.2580564576567, 1103.569607852938, 1105.7677887643524, 1109.8945600167972, 31387.372252554822, 32555.674443255266, 32568.34863302768, 32794.0, 33286.334273314395, 1031.293563908725, 1136.2500749505452, 1163.6799880032888, 1171.3733152763232, 1211.1098342718094, 16037.198140092949, 17421.0, 17455.38906138279, 18248.63502729938, 18371.90814045921, 582050.0, 585232.0, 585480.0, 587020.0, 587693.0, 63097.369026310065, 63581.682091589246, 63615.6819215901, 63761.68119159374, 63832.36167638357, 1327.6216278360814, 1384.6607581142482, 1394.714083612857, 1428.6142741459955, 1467.317697270753, 29765.553516696833, 33376.1655958603, 33971.66028339784, 34451.41614378882, 34497.0, 53372.0, 54044.0, 54099.459005409444, 54110.72944635252, 54163.18755218753, 424807.0, 425368.0, 426865.0, 427251.0, 428100.0, 29637.0, 30775.692243078178, 30930.0, 32298.35403291874, 32422.513662294612, 48144.75927620479, 49314.0, 49381.75309123431, 49614.25578616396, 49802.75098624628, 43212.351814723435, 43339.34990975201, 43390.783046084565, 44181.77909110434, 44752.55247447614, 42745.78627106844, 44289.557104428546, 44361.556384435746, 44561.10877782361, 45208.32187517124, 42024.789876050425, 42741.35887961621, 43302.350464743686, 43351.13297734091, 43442.78278608587, 36726.816365918, 38865.6113438862, 39257.411138833515, 39573.60426395814, 39834.0, 28459.58738591247, 28539.990440531583, 28552.714472855005, 28559.0, 28812.85593572019], "value": 21273.237549590634, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [400.24553716244867, 413.25820152825696, 430.57373200531475, 432.8052376430606, 442.0959138561641, 15342.693146137071, 19320.856550311095, 20496.590068198628, 20690.482737931557, 20725.274615388465, 18863.528411789677, 20231.797682023174, 20414.591708165866, 20434.795652043475, 20564.177432902667, 5699.515541178995, 5947.345791962881, 5949.732262048218, 5950.970245148768, 5952.077427998645, 5565.6104072714925, 5832.766689332421, 5879.353271140171, 5886.0, 5887.617304875191, 5608.971955140219, 5843.18195452637, 5843.941560584403, 5846.88306233875, 5848.5321174305955, 5759.539236861041, 5789.334226563936, 5816.592838501307, 5819.039858423355, 5819.709014549256, 5174.379074511083, 5210.218467229945, 5214.791408343662, 5214.8696282592855, 5219.138842091088, 24074.27777166688, 24113.0, 24189.758102418928, 24217.394565135837, 24317.39206519851, 2377.48883989943, 2436.3665446983737, 2458.9016439342404, 2478.479519300949, 2927.107232294171, 14657.70684586313, 14807.851921480755, 15102.54692359231, 15621.062736235748, 15838.0, 1951.365806113019, 1965.0174912543728, 1965.1746266568075, 2049.918003279867, 2063.731714877071, 83970.58014709948, 84667.57666211692, 84839.0, 86374.0, 89973.0, 9618.615255389846, 10590.57637694499, 10744.516496757664, 11064.446777661085, 11100.222984391177, 13503.59489215325, 13675.384607692678, 14196.432142714382, 14214.786778198335, 14765.261736913111, 8252.958735206286, 8525.0, 8576.614052367659, 8605.483670979762, 8737.694180703646, 8692.130786921258, 8718.128187181232, 8726.301895848317, 8869.157430044135, 8928.15182557656, 6729.764458243938, 6732.899006514906, 6819.181698196248, 6866.313368663194, 7045.964770176219, 1849.2140840142886, 1856.2946080489328, 1881.8332633767152, 1896.5258685328668, 1899.8955057471696, 931.8043210925781, 979.6571200079915, 985.5811280205884, 1003.5333569890037, 1125.3248051169396, 20201.59596808085, 20672.379828605164, 20678.689819652718, 20834.58330833405, 20853.478663033544, 1001.8246806808779, 1031.7884833609091, 1033.4006276359844, 1055.72551136705, 1104.9889351243683, 10864.72838179036, 11853.407329633485, 11938.28370297785, 11955.820662690066, 11998.280103193661, 467125.0, 469754.0, 473487.0, 478610.0, 482805.0, 81891.0, 82830.0, 84318.57840710758, 85412.57293713492, 86190.56904715436, 1039.4802598700498, 1051.915846732275, 1071.5713714514102, 1075.9085477734325, 1081.2269227502375, 17433.82566174373, 17726.50478351715, 17799.911000445434, 18101.728474072635, 18334.0, 40129.39805902972, 40140.3978940322, 40475.59524404836, 41720.165596687286, 41723.37414938718, 53835.46164538461, 54044.18933716076, 54091.72954135204, 54237.0, 55147.72426137843, 8523.786905327417, 8573.22840944318, 8601.39790214679, 8655.610497527501, 8892.644294228417, 13000.0, 13292.867071329163, 13502.459901603826, 13665.521706740217, 13747.381367838272, 11616.361100139573, 11889.167758257185, 11930.701732456759, 12047.0, 12074.215176013531, 11708.590199342982, 11758.88241117612, 11843.703907402383, 12097.939510302393, 12388.946939509882, 11759.412029398325, 11809.291442513477, 12002.63992080239, 12274.324912129918, 12319.938400307941, 8402.537860417735, 8664.523451209992, 8679.609417576097, 8805.559722014003, 8828.42615230008, 11829.940850295694, 11907.345096019802, 11984.760304793681, 12158.027357811177, 12322.32227227511], "value": 9568.239443740391, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1190.5832958464537, 1203.7592481503702, 1314.2049060318514, 1322.3718733601538, 1371.2389623758809, 7670.578118203503, 7890.921090789097, 8148.918510814905, 8160.183981601836, 8386.454880432768, 8188.181181881809, 8206.630701618427, 8268.958655206716, 8277.710280140182, 8291.046529649093, 2445.461998360358, 2471.295680730992, 2475.8638274894874, 2476.3809047738064, 2477.430191056058, 2399.844010139344, 2458.029078513986, 2463.0394146282874, 2463.3841539615096, 2473.4063824682034, 2415.3599296186435, 2428.7571242875747, 2438.817088718344, 2438.902443902242, 2439.4389290463205, 2344.765523447659, 2363.1728894886737, 2381.452265978817, 2383.2373640435067, 2384.2132096408145, 2347.80043696286, 2386.1052105460453, 2409.168836751318, 2409.6506006629115, 2412.4210189554556, 8220.05469371024, 8266.13205613408, 8283.585820709, 8423.620937057847, 8661.783455413602, 5311.787528498855, 5481.369642491125, 5484.369297530795, 5484.698341591211, 5487.5884308677005, 3363.3441478911623, 3447.172678557153, 3504.439289713659, 3533.169705119295, 3595.334863050318, 1150.7065698246977, 1159.744856131658, 1198.7722332756834, 1216.4221994552518, 1217.0385395537514, 11769.176157668966, 11824.704382390422, 11882.881171188264, 11883.465244064038, 11922.0, 4431.82272709088, 4627.838025669085, 4694.812207511662, 4696.319033740157, 4719.480857105716, 9615.134637882484, 9635.662751803653, 9643.0, 9643.517824108767, 9655.517224138765, 5088.6946783193125, 5152.819651312186, 5154.226865970135, 5162.664426812245, 5163.225516172604, 4430.7686305872185, 4575.17646823575, 4705.200115980291, 4711.717296962193, 4792.520747925179, 3845.9615403846165, 3883.4757307763657, 4013.2174226025645, 4021.4973128358956, 4027.335489644176, 1182.1429463638792, 1186.6084192216547, 1193.3138445393934, 1195.7967145585098, 1201.891829735328, 871.4248595926658, 884.3632584539122, 932.6689025395887, 989.8119357322086, 1006.285537268533, 5950.9107363389585, 6070.332263451017, 6149.3235744068115, 6172.6913654318005, 6202.56582039262, 436.1669211805436, 448.3230322213481, 475.2704598441445, 488.03369328729315, 488.6091127098378, 4328.935065974013, 4367.170237654836, 4385.122975404932, 4424.778761061934, 4432.84485043022, 10339.689809305733, 10763.784724305626, 10773.569057237779, 10777.407242601575, 10780.083692886035, 10073.445960472098, 10426.27016108865, 10456.581736730597, 10788.78422431547, 10801.297915635458, 8120.944277244039, 8287.917120828835, 8317.625706843206, 8332.541710205996, 8334.166583341617, 5881.059030555261, 6103.206583144163, 6131.448169664752, 6199.1011303359855, 6281.089242059968, 9905.356151850106, 9905.801883962136, 9956.900430995887, 10023.799524009333, 10038.0, 8928.241099506615, 9197.954010229905, 9837.360571563111, 10124.291299608956, 10222.948885255824, 7488.925110749041, 7495.7001719930595, 7570.280823321776, 7837.41219408558, 7887.290143886848, 8451.28164106058, 8532.018817836028, 8549.0, 8554.486730796172, 8577.571121444027, 7208.495405321577, 7436.851262974818, 7525.924740752742, 7548.811279718051, 7615.504992175491, 7352.70589176427, 7418.925810741824, 7536.3970882328185, 7537.585432801248, 7539.32146106853, 7175.8564828704175, 7188.173360063451, 7226.313500217471, 7228.9277107230355, 7232.312930271616, 4862.294967229661, 4881.194602890483, 5037.345145131256, 5062.114130027304, 5127.077126117186, 5127.794888204579, 5251.2123181523075, 5306.25712400272, 5326.36083669962, 5465.945340546544], "value": 4511.695665294668, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.3952334649653, 341.1947803184485, 342.74294279290547, 346.5044985670491, 349.12021705302624, 5327.520523152915, 5392.764341395161, 5407.864803379917, 5415.350157981043, 5424.891502169954, 5094.261332106842, 5134.0, 5224.660397074197, 5299.390570084432, 5345.915093113689, 4195.0, 4214.136102099063, 4219.11398606293, 4235.0, 4242.80907359168, 4207.263728847454, 4216.777134630954, 4225.795648240237, 4241.4274073000215, 4259.510156332015, 3929.351656976595, 3994.4008398740275, 4169.6455801256925, 4197.4753155855515, 4212.684048696345, 4145.461090058303, 4180.372944058385, 4183.723964190921, 4189.329707246826, 4207.621314081732, 3720.5163328767358, 3729.776213427203, 3737.897320290521, 3739.925201495982, 3741.5033986405383, 5101.438841727407, 5112.539871411554, 5196.92204616931, 5216.739163041832, 5221.2951251580935, 4794.904101917942, 4798.184308667535, 4803.783829727636, 4812.783424745895, 4827.927581086286, 5495.395506494282, 5538.418466061046, 5580.162975553659, 5591.664500130005, 5595.440455954413, 3934.7245692801516, 4055.574164712692, 4089.26393249215, 4109.301418758789, 4120.278951183561, 5739.856503587402, 5749.683767392792, 5753.367129615739, 5753.654780713129, 5765.942340576583, 4153.480814898077, 4168.24971505132, 4208.516020657602, 4208.936865947013, 4216.367544868233, 3959.4456776051375, 4113.136241389282, 4271.700980931367, 4285.292926667065, 4293.463317085364, 4717.127331443694, 4730.810767569327, 4750.239961606196, 4760.285957106462, 4772.141014617333, 5562.137868630369, 5582.581306402036, 5583.860403489945, 5596.804111856066, 5618.606697531215, 1332.946682132704, 1385.4665953607732, 1388.7500249954903, 1393.6446206217552, 1395.620467103586, 914.6661468564059, 937.1518775508176, 939.7838497145694, 961.7884065505577, 974.1573538888811, 5279.445658205833, 5319.946800531945, 5326.801469669371, 5346.43862394443, 5352.812651557177, 5597.328320601472, 5598.465243153059, 5599.720013999284, 5626.662400255997, 5631.521320687787, 5189.377274727057, 5229.738513074331, 5277.208418737144, 5307.4692530746615, 5313.787448502017, 2948.2039849241014, 2962.2742428105253, 2966.896158634481, 2967.744514169247, 2974.330775575478, 5610.204734484925, 5727.656340619576, 5748.770049197985, 5774.68239246837, 5778.855528611818, 5558.3875578478055, 5597.692126933058, 5611.7755289788765, 5615.904898544744, 5646.3907786280715, 5744.454276843777, 5746.367899531048, 5749.338826034976, 5751.309842818889, 5767.423257674199, 5364.839054828361, 5519.834404967857, 5547.2233887256625, 5561.833145005657, 5573.5508767719875, 5422.376426710821, 5437.0, 5463.590230732791, 5497.39528651856, 5503.752331145028, 5422.728863556886, 5669.603127781016, 5684.77260909559, 5709.22925405065, 5711.228984087095, 3950.7234493585174, 3951.7431366961055, 3956.2878681837547, 3956.9010774730864, 3957.2679054375035, 5472.589555783253, 5479.17812328138, 5491.533219676372, 5510.972445137749, 5519.586031047767, 5313.920291195713, 5395.298611180521, 5416.7020813855615, 5424.237122934983, 5426.891462170655, 5572.777088916398, 5654.575906806924, 5675.460831221028, 5684.204211410489, 5692.459216374438, 5372.543333816513, 5541.810984661117, 5612.326520817528, 5617.943820561742, 5645.576581756302, 5478.424765399735, 5635.887282254414, 5678.233438485751, 5678.517326027169, 5683.602147849776, 5573.526250268773, 5574.721263936706, 5576.7211639417055, 5578.832635020955, 5581.5255703265675], "value": 4234.238241318693, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [773.7021246819976, 792.9127795942449, 799.4563696686254, 828.3869936247179, 863.0980625246617, 14112.364943577539, 15088.849111508895, 15817.525474235763, 16513.0, 16725.16374181292, 14321.570352889405, 14800.777988330157, 16441.09573973434, 16628.75056874145, 16649.33402663895, 726.5967388099602, 856.4903882190087, 878.2973621103124, 880.0187790613484, 880.6389380354057, 751.9774406767779, 845.8223773007676, 870.1863757386864, 875.5009644502636, 876.7632739160455, 910.1490106750176, 912.3886995712855, 912.6760000199934, 912.8448163812135, 912.9087091290884, 757.6174032113747, 899.7615631857562, 907.6233363154283, 907.8592818113203, 908.9500077495735, 573.5211098732564, 652.1098700274092, 667.4993754683987, 672.045695112936, 673.1383828699272, 15254.542363728995, 15279.312430940634, 15293.158876261801, 15298.311575978996, 15298.770518442232, 13257.66855828612, 13270.270135142564, 13439.193648381031, 13464.124831885896, 13613.319334033358, 11948.701282468008, 12139.514419423213, 12258.387080645933, 12307.076969227344, 12517.56188533406, 4526.85739852352, 4536.183486972343, 4557.567031132037, 4558.0655965526985, 4623.884402889955, 64694.67652661706, 65208.0, 65322.0, 65519.67240163769, 65606.34393656098, 10717.89282107169, 10839.83740243897, 10894.72763180911, 11104.278221915549, 11198.160137989684, 19752.3086691968, 19808.20767169297, 19891.104900279523, 20110.095045722977, 20537.0, 8226.383021273428, 8358.0, 8386.622601982925, 8496.70261540843, 8566.571671416405, 4645.837395691135, 4675.0883577702025, 4707.929381059287, 4792.95207047932, 4913.557779799835, 3364.512145738854, 3463.0995941055508, 3466.913327166841, 3467.6185619581825, 3470.35798377301, 633.3856159525253, 638.1034646321832, 646.0374042676378, 664.1200409457392, 665.6838001949036, 648.6270394523074, 664.7972368427579, 669.7555392281782, 730.477708438469, 770.587735561472, 9287.303452240974, 9430.811383772287, 9553.522323883779, 9871.75320616976, 10151.746206344753, 644.1111266452359, 713.8322494213855, 731.8755811512056, 737.1007371007363, 755.316438623047, 4329.610335069859, 4706.199946009118, 4720.291956206528, 4745.0661586110955, 4808.711477311373, 87209.56395217983, 89752.5512372434, 93284.53357733168, 93334.0666593339, 95310.0, 50179.74910125426, 51265.23102153471, 60706.0, 67500.0, 75222.62388688022, 72823.0, 73834.0, 74045.0, 74355.0, 74887.0, 9059.864102038342, 9111.17999380059, 9223.76940576491, 9309.953450232706, 9428.62285508572, 35272.647273526934, 37123.81438092792, 46427.76786116048, 47041.52958470509, 47874.521254787, 61894.0, 62329.37670623236, 65321.673391632736, 66493.0, 66712.33287667061, 11722.94138529302, 11870.703232419259, 12087.697807554881, 12638.747225055631, 12737.426815793126, 14473.782893256399, 14683.92658036703, 14754.065708623317, 14843.0, 15052.397904083715, 11621.593244236412, 12863.421146048264, 12939.611811645666, 13067.215967042008, 13313.733725325634, 13045.386095957898, 13195.274259915797, 13229.867701323248, 13248.271345075727, 13362.732745344843, 13120.212787232796, 13188.80216796768, 13449.193048416735, 13540.526081587097, 13655.590332290047, 10903.0, 11188.66434006981, 11235.66293011211, 11648.184627076023, 11873.228240164362, 11279.605213817476, 11475.942620287178, 11476.598319058792, 11754.823677645014, 11828.0], "value": 7328.6275389204575, "unit": "score"}], "name": "dromaeo_css", "value": 7341.2785630911, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 111.0, 110.0, 112.0, 111.0, 110.0, 110.0, 112.0, 111.0], "value": 110.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 124.0, 126.0, 171.0, 122.0, 121.0, 121.0, 126.0, 160.0, 125.0], "value": 134.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 162.0, 162.0, 161.0, 161.0, 162.0, 159.0, 162.0, 166.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 110.0, 75.0, 75.0, 76.0, 74.0, 97.0, 75.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 116.0, 82.0, 82.0, 82.0, 112.0, 81.0, 82.0, 118.0], "value": 91.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 84.0, 84.0, 85.0, 84.0, 85.0, 84.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 52.0, 51.0, 51.0, 51.0, 51.0, 51.0, 51.0, 52.0], "value": 51.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 57.0, 59.0, 58.0, 59.0, 59.0, 58.0, 59.0, 59.0], "value": 58.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 82.0, 76.0, 77.0, 75.0, 76.0, 81.0, 85.0, 79.0], "value": 78.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 128.0, 131.0, 134.0, 132.0, 132.0, 130.0, 126.0, 165.0, 129.0], "value": 134.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 158.0, 161.0, 167.0, 158.0, 159.0, 158.0, 166.0, 160.0, 159.0], "value": 160.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 65.0, 63.0, 63.0, 63.0, 65.0, 63.0, 63.0], "value": 63.7, "unit": "score"}], "name": "kraken", "value": 1472.8, "alertThreshold": 2.0}]} 08:20:28 INFO - Return code: 0 08:20:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:20:28 INFO - # TBPL SUCCESS # 08:20:28 INFO - Running post-action listener: _resource_record_post_action 08:20:28 INFO - [mozharness: 2016-12-07 16:20:28.603246Z] Finished run-tests step (success) 08:20:28 INFO - Running post-run listener: _resource_record_post_run 08:20:28 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8192; Write bytes: 367570944; Read time: 176; Write time: 206328 08:20:28 INFO - TinderboxPrint: CPU usage
13.0% 08:20:28 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 176 08:20:28 INFO - TinderboxPrint: I/O write bytes / time
367,570,944 / 206,328 08:20:28 INFO - TinderboxPrint: CPU idle
8,276.8 (87.0%) 08:20:28 INFO - TinderboxPrint: CPU user
1,191.9 (12.5%) 08:20:28 INFO - TinderboxPrint: Swap in / out
0 / 0 08:20:28 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 118648832; Read time: 0; Write time: 69340 08:20:28 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 248352768; Read time: 156; Write time: 136972 08:20:29 INFO - Running post-run listener: _upload_blobber_files 08:20:29 INFO - Blob upload gear active. 08:20:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:20:29 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:20:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:20:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:20:29 INFO - (blobuploader) - INFO - Open directory for files ... 08:20:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:20:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:20:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:20:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:20:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:20:30 INFO - (blobuploader) - INFO - Done attempting. 08:20:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:20:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:20:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:20:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:20:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:20:35 INFO - (blobuploader) - INFO - Done attempting. 08:20:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:20:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:20:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:20:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:20:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:20:36 INFO - (blobuploader) - INFO - Done attempting. 08:20:36 INFO - (blobuploader) - INFO - Iteration through files over. 08:20:36 INFO - Return code: 0 08:20:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:20:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:20:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00b51986f7913fdd09c5ad596cde2ad009c22ac1930e155fff439238501bd9945e3a1af9d86a6a5ad45ac7acf2aba81cbb96c5b9e7df2d2ee43cf38441f75d83", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8271f2cfa51bc5656831a6cfd4d8a9e5dd1ae5500db656af518ce9e0c160be651ca0406e49a68b1990db76cd259529cbf11b255e3ae60ce4056fe4d62af87fbf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/11f3a8d5654620109de73fac47665edffa63f5e432e0a1cfdf9a259410d43881ffc0eece181277cfc9ac8c01f3d83e811afd62eb5cb2508d9e6f26a5f53cb253"} 08:20:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:20:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:20:36 INFO - Contents: 08:20:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00b51986f7913fdd09c5ad596cde2ad009c22ac1930e155fff439238501bd9945e3a1af9d86a6a5ad45ac7acf2aba81cbb96c5b9e7df2d2ee43cf38441f75d83", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8271f2cfa51bc5656831a6cfd4d8a9e5dd1ae5500db656af518ce9e0c160be651ca0406e49a68b1990db76cd259529cbf11b255e3ae60ce4056fe4d62af87fbf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/11f3a8d5654620109de73fac47665edffa63f5e432e0a1cfdf9a259410d43881ffc0eece181277cfc9ac8c01f3d83e811afd62eb5cb2508d9e6f26a5f53cb253"} 08:20:36 INFO - Running post-run listener: copy_logs_to_upload_dir 08:20:36 INFO - Copying logs to upload dir... 08:20:36 INFO - mkdir: /builds/slave/test/build/upload/logs 08:20:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.040660 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-12-07 08:20:35.616621) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-07 08:20:35.619926) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1481124810.128781-1752951266 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/00b51986f7913fdd09c5ad596cde2ad009c22ac1930e155fff439238501bd9945e3a1af9d86a6a5ad45ac7acf2aba81cbb96c5b9e7df2d2ee43cf38441f75d83", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8271f2cfa51bc5656831a6cfd4d8a9e5dd1ae5500db656af518ce9e0c160be651ca0406e49a68b1990db76cd259529cbf11b255e3ae60ce4056fe4d62af87fbf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/11f3a8d5654620109de73fac47665edffa63f5e432e0a1cfdf9a259410d43881ffc0eece181277cfc9ac8c01f3d83e811afd62eb5cb2508d9e6f26a5f53cb253"} build_url:https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011757 build_url: 'https://queue.taskcluster.net/v1/task/OIKsAul0TkiXci0KnkP4zw/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/00b51986f7913fdd09c5ad596cde2ad009c22ac1930e155fff439238501bd9945e3a1af9d86a6a5ad45ac7acf2aba81cbb96c5b9e7df2d2ee43cf38441f75d83", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8271f2cfa51bc5656831a6cfd4d8a9e5dd1ae5500db656af518ce9e0c160be651ca0406e49a68b1990db76cd259529cbf11b255e3ae60ce4056fe4d62af87fbf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/11f3a8d5654620109de73fac47665edffa63f5e432e0a1cfdf9a259410d43881ffc0eece181277cfc9ac8c01f3d83e811afd62eb5cb2508d9e6f26a5f53cb253"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-07 08:20:35.646658) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 08:20:35.646972) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1481124810.128781-1752951266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004496 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-07 08:20:35.732848) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-07 08:20:35.733203) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-07 08:20:35.733482) ========= ========= Total master_lag: 0.17 =========