builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-046 starttime: 1479149452.51 results: success (0) buildid: 20161114074144 builduid: c0ce765cf2c74afa85cbf7cb62a44e31 revision: 8cdff71808a0e11361bca7f218658c4343c730ca ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 10:50:52.511941) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 10:50:52.512383) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 10:50:52.512725) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 10:50:52.527106) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 10:50:52.527363) ========= 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=652eb03db935cfc1c15ebda0000001ad-1479149452.94839-805848729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-14 10:50:52-- 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% 29.4M=0s 2016-11-14 10:50:53 (29.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.153237 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 10:50:52.694284) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 10:50:52.694680) ========= 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=652eb03db935cfc1c15ebda0000001ad-1479149452.94839-805848729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019511 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 10:50:52.744562) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 10:50:52.744937) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8cdff71808a0e11361bca7f218658c4343c730ca --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 8cdff71808a0e11361bca7f218658c4343c730ca --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=652eb03db935cfc1c15ebda0000001ad-1479149452.94839-805848729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-14 10:50:53,128 truncating revision to first 12 chars 2016-11-14 10:50:53,128 Setting DEBUG logging. 2016-11-14 10:50:53,128 attempt 1/10 2016-11-14 10:50:53,128 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8cdff71808a0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 10:50:54,349 unpacking tar archive at: mozilla-aurora-8cdff71808a0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.532018 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 10:50:54.290234) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 10:50:54.290564) ========= script_repo_revision: 8cdff71808a0e11361bca7f218658c4343c730ca ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 10:50:54.290954) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 10:50:54.291323) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 10:50:54.300621) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-11-14 10:50:54.300905) ========= /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=652eb03db935cfc1c15ebda0000001ad-1479149452.94839-805848729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:50:54 INFO - MultiFileLogger online at 20161114 10:50:54 in /builds/slave/test 10:50:54 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 10:50:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:50:54 INFO - {'append_to_log': False, 10:50:54 INFO - 'base_work_dir': '/builds/slave/test', 10:50:54 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:50:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:50:54 INFO - 'branch': 'Mozilla-Aurora', 10:50:54 INFO - 'buildbot_json_path': 'buildprops.json', 10:50:54 INFO - 'config_files': ('talos/linux_config.py',), 10:50:54 INFO - 'default_actions': ('clobber', 10:50:54 INFO - 'read-buildbot-config', 10:50:54 INFO - 'download-and-extract', 10:50:54 INFO - 'populate-webroot', 10:50:54 INFO - 'create-virtualenv', 10:50:54 INFO - 'install', 10:50:54 INFO - 'run-tests'), 10:50:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:50:54 INFO - 'download_minidump_stackwalk': True, 10:50:54 INFO - 'download_symbols': 'ondemand', 10:50:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:50:54 INFO - 'tooltool.py': '/tools/tooltool.py', 10:50:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:50:54 INFO - '/tools/misc-python/virtualenv.py')}, 10:50:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:50:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:50:54 INFO - 'installer_path': 'installer.exe', 10:50:54 INFO - 'log_level': 'info', 10:50:54 INFO - 'log_name': 'talos', 10:50:54 INFO - 'log_to_console': True, 10:50:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:50:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:50:54 INFO - 'opt_config_files': (), 10:50:54 INFO - 'pip_index': False, 10:50:54 INFO - 'sps_profile': False, 10:50:54 INFO - 'sps_profile_interval': 0, 10:50:54 INFO - 'suite': 'dromaeojs', 10:50:54 INFO - 'system_bits': '32', 10:50:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:50:54 INFO - 'title': 'talos-linux64-ix-046', 10:50:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:50:54 INFO - 'use_talos_json': True, 10:50:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:50:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:50:54 INFO - 'work_dir': 'build'} 10:50:54 INFO - [mozharness: 2016-11-14 18:50:54.785581Z] Running clobber step. 10:50:54 INFO - Running pre-action listener: _resource_record_pre_action 10:50:54 INFO - Running main action method: clobber 10:50:54 INFO - rmtree: /builds/slave/test/build 10:50:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:50:55 INFO - Running post-action listener: _resource_record_post_action 10:50:55 INFO - [mozharness: 2016-11-14 18:50:55.758343Z] Finished clobber step (success) 10:50:55 INFO - [mozharness: 2016-11-14 18:50:55.758440Z] Running read-buildbot-config step. 10:50:55 INFO - Running pre-action listener: _resource_record_pre_action 10:50:55 INFO - Running main action method: read_buildbot_config 10:50:55 INFO - Using buildbot properties: 10:50:55 INFO - { 10:50:55 INFO - "project": "", 10:50:55 INFO - "product": "firefox", 10:50:55 INFO - "script_repo_revision": "production", 10:50:55 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 10:50:55 INFO - "repository": "", 10:50:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 10:50:55 INFO - "buildid": "20161114074144", 10:50:55 INFO - "pgo_build": "True", 10:50:55 INFO - "basedir": "/builds/slave/test", 10:50:55 INFO - "buildnumber": 627, 10:50:55 INFO - "slavename": "talos-linux64-ix-046", 10:50:55 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:50:55 INFO - "platform": "ubuntu64_hw", 10:50:55 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 10:50:55 INFO - "branch": "mozilla-aurora", 10:50:55 INFO - "repo_path": "releases/mozilla-aurora", 10:50:55 INFO - "revision": "8cdff71808a0e11361bca7f218658c4343c730ca", 10:50:55 INFO - "stage_platform": "linux64-pgo", 10:50:55 INFO - "builduid": "c0ce765cf2c74afa85cbf7cb62a44e31", 10:50:55 INFO - "slavebuilddir": "test" 10:50:55 INFO - } 10:50:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/Zw4L7bX4SnawuKWOZkFitQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 10:50:55 INFO - Running post-action listener: _resource_record_post_action 10:50:55 INFO - [mozharness: 2016-11-14 18:50:55.760895Z] Finished read-buildbot-config step (success) 10:50:55 INFO - [mozharness: 2016-11-14 18:50:55.760983Z] Running download-and-extract step. 10:50:55 INFO - Running pre-action listener: _resource_record_pre_action 10:50:55 INFO - Running main action method: download_and_extract 10:50:55 INFO - mkdir: /builds/slave/test/build/tests 10:50:55 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')]} 10:50:55 INFO - trying https://queue.taskcluster.net/v1/task/Zw4L7bX4SnawuKWOZkFitQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 10:50:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Zw4L7bX4SnawuKWOZkFitQ/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 10:50:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zw4L7bX4SnawuKWOZkFitQ/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 10:50:56 INFO - Downloaded 1361 bytes. 10:50:56 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 10:50:56 INFO - Using the following test package requirements: 10:50:56 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 10:50:56 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 10:50:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 10:50:56 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 10:50:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 10:50:56 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 10:50:56 INFO - u'jsshell-linux-x86_64.zip'], 10:50:56 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 10:50:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 10:50:56 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 10:50:56 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 10:50:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 10:50:56 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 10:50:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 10:50:56 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 10:50:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 10:50:56 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 10:50:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 10:50:56 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:50:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zw4L7bX4SnawuKWOZkFitQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 10:50:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zw4L7bX4SnawuKWOZkFitQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:50:56 INFO - Fetch https://queue.taskcluster.net/v1/task/Zw4L7bX4SnawuKWOZkFitQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 10:50:56 INFO - Http code: 200 10:50:56 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 10:50:56 INFO - x-amz-cf-id: Cyi-5LwfMWXlLlM8wzeG8tkEYTcUWf5YElNbW5NNX5_2PiUGj2YNEA== 10:50:56 INFO - x-amz-version-id: dhxqN2bPQ6oZYTShbmOMQuy1B5XBoKlW 10:50:57 INFO - Expected file size: 21999823 10:50:57 INFO - Obtained file size: 21999823 10:51:01 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 10:51:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zw4L7bX4SnawuKWOZkFitQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 10:51:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zw4L7bX4SnawuKWOZkFitQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:51:01 INFO - Fetch https://queue.taskcluster.net/v1/task/Zw4L7bX4SnawuKWOZkFitQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 10:51:01 INFO - Http code: 200 10:51:01 INFO - via: 1.1 441811a054e8d055b893175754efd0c3.cloudfront.net (CloudFront) 10:51:01 INFO - x-amz-cf-id: ysmNUrCb3xhlQ0PpKUFxQtk2XcrIfYLXBDbsD_6sFROPC5ikXrKAYA== 10:51:01 INFO - x-amz-version-id: dhxqN2bPQ6oZYTShbmOMQuy1B5XBoKlW 10:51:02 INFO - Expected file size: 21999823 10:51:02 INFO - Obtained file size: 21999823 10:51:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zw4L7bX4SnawuKWOZkFitQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 10:51:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zw4L7bX4SnawuKWOZkFitQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:51:06 INFO - Fetch https://queue.taskcluster.net/v1/task/Zw4L7bX4SnawuKWOZkFitQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 10:51:07 INFO - Http code: 200 10:51:07 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 10:51:07 INFO - x-amz-cf-id: mQJ9uJ2l3n7qJO0HE9th7TJxMie_7Hp27xyxt3VlHeetH6zEj_RFAQ== 10:51:07 INFO - x-amz-version-id: fZ4p8hYkTbOMfM6R_ZFTc6jYMPkTwrSk 10:51:07 INFO - Expected file size: 14409038 10:51:07 INFO - Obtained file size: 14409038 10:51:07 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')]} 10:51:07 INFO - trying https://queue.taskcluster.net/v1/task/Zw4L7bX4SnawuKWOZkFitQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 10:51:07 INFO - Downloading https://queue.taskcluster.net/v1/task/Zw4L7bX4SnawuKWOZkFitQ/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 10:51:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zw4L7bX4SnawuKWOZkFitQ/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 10:51:08 INFO - Downloaded 63922323 bytes. 10:51:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zw4L7bX4SnawuKWOZkFitQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 10:51:08 INFO - mkdir: /builds/slave/test/properties 10:51:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:51:08 INFO - Writing to file /builds/slave/test/properties/build_url 10:51:08 INFO - Contents: 10:51:08 INFO - build_url:https://queue.taskcluster.net/v1/task/Zw4L7bX4SnawuKWOZkFitQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 10:51:09 INFO - Running post-action listener: _resource_record_post_action 10:51:09 INFO - Running post-action listener: set_extra_try_arguments 10:51:09 INFO - [mozharness: 2016-11-14 18:51:09.397717Z] Finished download-and-extract step (success) 10:51:09 INFO - [mozharness: 2016-11-14 18:51:09.398020Z] Running populate-webroot step. 10:51:09 INFO - Running pre-action listener: _resource_record_pre_action 10:51:09 INFO - Running main action method: populate_webroot 10:51:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:51:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:51:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:51:09 INFO - '--tppagecycles', 10:51:09 INFO - '7'], 10:51:09 INFO - 'tests': ['tsvgm']}}, 10:51:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:51:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:51:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:51:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:51:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:51:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:51:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:09 INFO - 'talos_options': ['--disable-e10s'], 10:51:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:51:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:51:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:09 INFO - 'talos_options': ['--disable-e10s'], 10:51:09 INFO - 'tests': ['damp', 'tps']}, 10:51:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:09 INFO - 'tests': ['damp', 'tps']}, 10:51:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:51:09 INFO - 'tests': ['dromaeo_dom']}, 10:51:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:51:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:51:09 INFO - 'tests': ['basic_compositor_video']}, 10:51:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:51:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:51:09 INFO - 'tests': ['a11yr', 10:51:09 INFO - 'ts_paint', 10:51:09 INFO - 'tpaint', 10:51:09 INFO - 'sessionrestore', 10:51:09 INFO - 'sessionrestore_no_auto_restore', 10:51:09 INFO - 'tabpaint']}, 10:51:09 INFO - 'other-e10s': {'tests': ['a11yr', 10:51:09 INFO - 'ts_paint', 10:51:09 INFO - 'tpaint', 10:51:09 INFO - 'sessionrestore', 10:51:09 INFO - 'sessionrestore_no_auto_restore', 10:51:09 INFO - 'tabpaint']}, 10:51:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:51:09 INFO - 'ts_paint', 10:51:09 INFO - 'tpaint', 10:51:09 INFO - 'sessionrestore', 10:51:09 INFO - 'sessionrestore_no_auto_restore', 10:51:09 INFO - 'tabpaint']}, 10:51:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:51:09 INFO - 'ts_paint', 10:51:09 INFO - 'tpaint', 10:51:09 INFO - 'sessionrestore', 10:51:09 INFO - 'sessionrestore_no_auto_restore', 10:51:09 INFO - 'tabpaint']}, 10:51:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:51:09 INFO - 'tests': ['a11yr', 10:51:09 INFO - 'ts_paint', 10:51:09 INFO - 'tpaint', 10:51:09 INFO - 'sessionrestore', 10:51:09 INFO - 'sessionrestore_no_auto_restore', 10:51:09 INFO - 'tabpaint']}, 10:51:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:51:09 INFO - 'tests': ['a11yr', 10:51:09 INFO - 'ts_paint', 10:51:09 INFO - 'tpaint', 10:51:09 INFO - 'sessionrestore', 10:51:09 INFO - 'sessionrestore_no_auto_restore', 10:51:09 INFO - 'tabpaint']}, 10:51:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:51:09 INFO - 'tests': ['tsvgx', 10:51:09 INFO - 'tsvgr_opacity', 10:51:09 INFO - 'tart', 10:51:09 INFO - 'tscrollx', 10:51:09 INFO - 'cart']}, 10:51:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:51:09 INFO - 'tsvgr_opacity', 10:51:09 INFO - 'tart', 10:51:09 INFO - 'tscrollx', 10:51:09 INFO - 'cart']}, 10:51:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:09 INFO - 'talos_options': ['--disable-e10s'], 10:51:09 INFO - 'tests': ['tp5o']}, 10:51:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:09 INFO - 'tests': ['tp5o']}, 10:51:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:09 INFO - 'talos_options': ['--disable-e10s', 10:51:09 INFO - '--xperf_path', 10:51:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:51:09 INFO - 'tests': ['tp5n']}, 10:51:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:51:09 INFO - 'talos_options': ['--xperf_path', 10:51:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:51:09 INFO - 'tests': ['tp5n']}}, 10:51:09 INFO - 'talos.zip': {'path': '', 10:51:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:51:09 INFO - Running post-action listener: _resource_record_post_action 10:51:09 INFO - [mozharness: 2016-11-14 18:51:09.414590Z] Finished populate-webroot step (success) 10:51:09 INFO - [mozharness: 2016-11-14 18:51:09.414682Z] Running create-virtualenv step. 10:51:09 INFO - Running pre-action listener: _resource_record_pre_action 10:51:09 INFO - Running main action method: create_virtualenv 10:51:09 INFO - Creating virtualenv /builds/slave/test/build/venv 10:51:09 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 10:51:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:51:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:51:09 INFO - Using real prefix '/usr' 10:51:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:51:10 INFO - Installing distribute.............................................................................................................................................................................................done. 10:51:11 INFO - Installing pip.................done. 10:51:12 INFO - Return code: 0 10:51:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:51:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:51:12 INFO - Reading from file tmpfile_stdout 10:51:12 INFO - Output received: 10:51:12 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) 10:51:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca84de3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229ff60>, '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 0x22a0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a11d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1479149452.94839-805848729', '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 10:51:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:51:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:51:12 INFO - Using env: {'DISPLAY': ':0', 10:51:12 INFO - 'HOME': '/home/cltbld', 10:51:12 INFO - 'LANG': 'en_US.UTF-8', 10:51:12 INFO - 'LANGUAGE': 'en_US:en', 10:51:12 INFO - 'LOGNAME': 'cltbld', 10:51:12 INFO - 'MAIL': '/var/mail/cltbld', 10:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:12 INFO - 'MOZ_NO_REMOTE': '1', 10:51:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:12 INFO - 'NO_EM_RESTART': '1', 10:51:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:12 INFO - 'PWD': '/builds/slave/test', 10:51:12 INFO - 'SHELL': '/bin/bash', 10:51:12 INFO - 'SHLVL': '1', 10:51:12 INFO - 'TERM': 'linux', 10:51:12 INFO - 'TMOUT': '86400', 10:51:12 INFO - 'USER': 'cltbld', 10:51:12 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1479149452.94839-805848729', 10:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:12 INFO - '_': '/tools/buildbot/bin/python'} 10:51:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:12 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 10:51:12 INFO - Cleaning up... 10:51:12 INFO - Return code: 0 10:51:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fca84de3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229ff60>, '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 0x22a0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a11d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1479149452.94839-805848729', '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 10:51:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:51:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:51:12 INFO - Using env: {'DISPLAY': ':0', 10:51:12 INFO - 'HOME': '/home/cltbld', 10:51:12 INFO - 'LANG': 'en_US.UTF-8', 10:51:12 INFO - 'LANGUAGE': 'en_US:en', 10:51:12 INFO - 'LOGNAME': 'cltbld', 10:51:12 INFO - 'MAIL': '/var/mail/cltbld', 10:51:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:12 INFO - 'MOZ_NO_REMOTE': '1', 10:51:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:12 INFO - 'NO_EM_RESTART': '1', 10:51:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:12 INFO - 'PWD': '/builds/slave/test', 10:51:12 INFO - 'SHELL': '/bin/bash', 10:51:12 INFO - 'SHLVL': '1', 10:51:12 INFO - 'TERM': 'linux', 10:51:12 INFO - 'TMOUT': '86400', 10:51:12 INFO - 'USER': 'cltbld', 10:51:12 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1479149452.94839-805848729', 10:51:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:12 INFO - '_': '/tools/buildbot/bin/python'} 10:51:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:12 INFO - Downloading/unpacking psutil>=3.1.1 10:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:51:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:51:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:51:14 INFO - Installing collected packages: psutil 10:51:14 INFO - Running setup.py install for psutil 10:51:14 INFO - building 'psutil._psutil_linux' extension 10:51:14 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 10:51:14 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 10:51:14 INFO - building 'psutil._psutil_posix' extension 10:51:14 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 10:51:15 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 10:51:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:51:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:51:15 INFO - Successfully installed psutil 10:51:15 INFO - Cleaning up... 10:51:15 INFO - Return code: 0 10:51:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:51:15 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')]} 10:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:15 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')]} 10:51:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:15 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 0x7fca84de3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229ff60>, '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 0x22a0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a11d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1479149452.94839-805848729', '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 10:51:15 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 10:51:15 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 10:51:15 INFO - Using env: {'DISPLAY': ':0', 10:51:15 INFO - 'HOME': '/home/cltbld', 10:51:15 INFO - 'LANG': 'en_US.UTF-8', 10:51:15 INFO - 'LANGUAGE': 'en_US:en', 10:51:15 INFO - 'LOGNAME': 'cltbld', 10:51:15 INFO - 'MAIL': '/var/mail/cltbld', 10:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:15 INFO - 'MOZ_NO_REMOTE': '1', 10:51:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:15 INFO - 'NO_EM_RESTART': '1', 10:51:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:15 INFO - 'PWD': '/builds/slave/test', 10:51:15 INFO - 'SHELL': '/bin/bash', 10:51:15 INFO - 'SHLVL': '1', 10:51:15 INFO - 'TERM': 'linux', 10:51:15 INFO - 'TMOUT': '86400', 10:51:15 INFO - 'USER': 'cltbld', 10:51:15 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1479149452.94839-805848729', 10:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:15 INFO - '_': '/tools/buildbot/bin/python'} 10:51:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:51:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:51:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:51:17 INFO - Installing collected packages: mozsystemmonitor 10:51:17 INFO - Running setup.py install for mozsystemmonitor 10:51:17 INFO - Successfully installed mozsystemmonitor 10:51:17 INFO - Cleaning up... 10:51:17 INFO - Return code: 0 10:51:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fca84de3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229ff60>, '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 0x22a0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a11d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1479149452.94839-805848729', '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 10:51:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:51:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:51:17 INFO - Using env: {'DISPLAY': ':0', 10:51:17 INFO - 'HOME': '/home/cltbld', 10:51:17 INFO - 'LANG': 'en_US.UTF-8', 10:51:17 INFO - 'LANGUAGE': 'en_US:en', 10:51:17 INFO - 'LOGNAME': 'cltbld', 10:51:17 INFO - 'MAIL': '/var/mail/cltbld', 10:51:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:17 INFO - 'MOZ_NO_REMOTE': '1', 10:51:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:17 INFO - 'NO_EM_RESTART': '1', 10:51:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:17 INFO - 'PWD': '/builds/slave/test', 10:51:17 INFO - 'SHELL': '/bin/bash', 10:51:17 INFO - 'SHLVL': '1', 10:51:17 INFO - 'TERM': 'linux', 10:51:17 INFO - 'TMOUT': '86400', 10:51:17 INFO - 'USER': 'cltbld', 10:51:17 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1479149452.94839-805848729', 10:51:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:17 INFO - '_': '/tools/buildbot/bin/python'} 10:51:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:17 INFO - Downloading/unpacking jsonschema==2.5.1 10:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:51:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:51: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 10:51: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 10:51: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 10:51: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 10:51: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 10:51: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 10:51:19 INFO - Downloading functools32-3.2.3-2.tar.gz 10:51:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:51:20 INFO - warning: no files found matching '*.txt' 10:51:20 INFO - no previously-included directories found matching 'build' 10:51:20 INFO - no previously-included directories found matching 'dist' 10:51:20 INFO - no previously-included directories found matching '.git*' 10:51:20 INFO - Installing collected packages: jsonschema, functools32 10:51:20 INFO - Running setup.py install for functools32 10:51:20 INFO - warning: no files found matching '*.txt' 10:51:20 INFO - no previously-included directories found matching 'build' 10:51:20 INFO - no previously-included directories found matching 'dist' 10:51:20 INFO - no previously-included directories found matching '.git*' 10:51:20 INFO - Successfully installed jsonschema functools32 10:51:20 INFO - Cleaning up... 10:51:20 INFO - Return code: 0 10:51:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:51:20 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')]} 10:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:20 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')]} 10:51:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:20 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 0x7fca84de3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229ff60>, '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 0x22a0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a11d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1479149452.94839-805848729', '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 10:51:20 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 10:51:20 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 10:51:20 INFO - Using env: {'DISPLAY': ':0', 10:51:20 INFO - 'HOME': '/home/cltbld', 10:51:20 INFO - 'LANG': 'en_US.UTF-8', 10:51:20 INFO - 'LANGUAGE': 'en_US:en', 10:51:20 INFO - 'LOGNAME': 'cltbld', 10:51:20 INFO - 'MAIL': '/var/mail/cltbld', 10:51:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:20 INFO - 'MOZ_NO_REMOTE': '1', 10:51:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:20 INFO - 'NO_EM_RESTART': '1', 10:51:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:20 INFO - 'PWD': '/builds/slave/test', 10:51:20 INFO - 'SHELL': '/bin/bash', 10:51:20 INFO - 'SHLVL': '1', 10:51:20 INFO - 'TERM': 'linux', 10:51:20 INFO - 'TMOUT': '86400', 10:51:20 INFO - 'USER': 'cltbld', 10:51:20 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1479149452.94839-805848729', 10:51:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:20 INFO - '_': '/tools/buildbot/bin/python'} 10:51:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:51:20 INFO - Cleaning up... 10:51:20 INFO - Return code: 0 10:51:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:51:20 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')]} 10:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:20 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')]} 10:51:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:20 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 0x7fca84de3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229ff60>, '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 0x22a0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a11d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1479149452.94839-805848729', '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 10:51:20 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 10:51:20 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 10:51:20 INFO - Using env: {'DISPLAY': ':0', 10:51:20 INFO - 'HOME': '/home/cltbld', 10:51:20 INFO - 'LANG': 'en_US.UTF-8', 10:51:20 INFO - 'LANGUAGE': 'en_US:en', 10:51:20 INFO - 'LOGNAME': 'cltbld', 10:51:20 INFO - 'MAIL': '/var/mail/cltbld', 10:51:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:20 INFO - 'MOZ_NO_REMOTE': '1', 10:51:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:20 INFO - 'NO_EM_RESTART': '1', 10:51:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:20 INFO - 'PWD': '/builds/slave/test', 10:51:20 INFO - 'SHELL': '/bin/bash', 10:51:20 INFO - 'SHLVL': '1', 10:51:20 INFO - 'TERM': 'linux', 10:51:20 INFO - 'TMOUT': '86400', 10:51:20 INFO - 'USER': 'cltbld', 10:51:20 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1479149452.94839-805848729', 10:51:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:20 INFO - '_': '/tools/buildbot/bin/python'} 10:51:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:20 INFO - Downloading/unpacking blobuploader==1.2.4 10:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:51:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:51:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:51:22 INFO - Downloading blobuploader-1.2.4.tar.gz 10:51:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:51:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:51: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 10:51: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 10:51: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 10:51: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 10:51: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 10:51: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 10:51:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:51:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:51:23 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 10:51:23 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 10:51:23 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 10:51:23 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 10:51:23 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 10:51:23 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 10:51:23 INFO - Downloading docopt-0.6.1.tar.gz 10:51:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:51:23 INFO - Installing collected packages: blobuploader, requests, docopt 10:51:23 INFO - Running setup.py install for blobuploader 10:51:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:51:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:51:23 INFO - Running setup.py install for requests 10:51:23 INFO - Running setup.py install for docopt 10:51:23 INFO - Successfully installed blobuploader requests docopt 10:51:23 INFO - Cleaning up... 10:51:24 INFO - Return code: 0 10:51:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:51: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')]} 10:51:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51: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')]} 10:51:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:24 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 0x7fca84de3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229ff60>, '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 0x22a0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a11d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1479149452.94839-805848729', '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 10:51:24 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 10:51:24 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 10:51:24 INFO - Using env: {'DISPLAY': ':0', 10:51:24 INFO - 'HOME': '/home/cltbld', 10:51:24 INFO - 'LANG': 'en_US.UTF-8', 10:51:24 INFO - 'LANGUAGE': 'en_US:en', 10:51:24 INFO - 'LOGNAME': 'cltbld', 10:51:24 INFO - 'MAIL': '/var/mail/cltbld', 10:51:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:24 INFO - 'MOZ_NO_REMOTE': '1', 10:51:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:24 INFO - 'NO_EM_RESTART': '1', 10:51:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:24 INFO - 'PWD': '/builds/slave/test', 10:51:24 INFO - 'SHELL': '/bin/bash', 10:51:24 INFO - 'SHLVL': '1', 10:51:24 INFO - 'TERM': 'linux', 10:51:24 INFO - 'TMOUT': '86400', 10:51:24 INFO - 'USER': 'cltbld', 10:51:24 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1479149452.94839-805848729', 10:51:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:24 INFO - '_': '/tools/buildbot/bin/python'} 10:51:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:51:24 INFO - Running setup.py (path:/tmp/pip-oFhD5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:51:24 INFO - Running setup.py (path:/tmp/pip-kEvIrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:51:24 INFO - Running setup.py (path:/tmp/pip-dw7Xhb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:51:24 INFO - Running setup.py (path:/tmp/pip-ACFriP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:51:24 INFO - Running setup.py (path:/tmp/pip-dcF7qT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:51:24 INFO - Running setup.py (path:/tmp/pip-0gtyCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:51:24 INFO - Running setup.py (path:/tmp/pip-F1KfMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:51:24 INFO - Running setup.py (path:/tmp/pip-undu7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:51:24 INFO - Running setup.py (path:/tmp/pip-79tVAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:51:24 INFO - Running setup.py (path:/tmp/pip-_fdrh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:51:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:51:24 INFO - Running setup.py (path:/tmp/pip-QsZIFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:51:25 INFO - Running setup.py (path:/tmp/pip-yBWWR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:51:25 INFO - Running setup.py (path:/tmp/pip-Boc6Nd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:51:25 INFO - Running setup.py (path:/tmp/pip-5c1MJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:51:25 INFO - Running setup.py (path:/tmp/pip-d1nw9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:51:25 INFO - Running setup.py (path:/tmp/pip-7x1cXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:51:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:51:25 INFO - Running setup.py (path:/tmp/pip-rytPiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:51:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:51:25 INFO - Running setup.py install for manifestparser 10:51:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:51:25 INFO - Running setup.py install for mozcrash 10:51:25 INFO - Running setup.py install for mozdebug 10:51:25 INFO - Running setup.py install for mozdevice 10:51:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:51:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:51:25 INFO - Running setup.py install for mozfile 10:51:26 INFO - Running setup.py install for mozhttpd 10:51:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:51:26 INFO - Running setup.py install for mozinfo 10:51:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:51:26 INFO - Running setup.py install for mozInstall 10:51:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:51:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:51:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:51:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:51:26 INFO - Running setup.py install for mozleak 10:51:26 INFO - Running setup.py install for mozlog 10:51:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:51:26 INFO - Running setup.py install for moznetwork 10:51:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:51:26 INFO - Running setup.py install for mozprocess 10:51:26 INFO - Running setup.py install for mozprofile 10:51:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:51:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:51:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:51:26 INFO - Running setup.py install for mozrunner 10:51:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:51:26 INFO - Running setup.py install for mozscreenshot 10:51:27 INFO - Running setup.py install for moztest 10:51:27 INFO - Running setup.py install for mozversion 10:51:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:51:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:51:27 INFO - Cleaning up... 10:51:27 INFO - Return code: 0 10:51:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:51:27 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')]} 10:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:27 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')]} 10:51:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:27 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 0x7fca84de3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229ff60>, '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 0x22a0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a11d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1479149452.94839-805848729', '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 10:51:27 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 10:51:27 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 10:51:27 INFO - Using env: {'DISPLAY': ':0', 10:51:27 INFO - 'HOME': '/home/cltbld', 10:51:27 INFO - 'LANG': 'en_US.UTF-8', 10:51:27 INFO - 'LANGUAGE': 'en_US:en', 10:51:27 INFO - 'LOGNAME': 'cltbld', 10:51:27 INFO - 'MAIL': '/var/mail/cltbld', 10:51:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:27 INFO - 'MOZ_NO_REMOTE': '1', 10:51:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:27 INFO - 'NO_EM_RESTART': '1', 10:51:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:27 INFO - 'PWD': '/builds/slave/test', 10:51:27 INFO - 'SHELL': '/bin/bash', 10:51:27 INFO - 'SHLVL': '1', 10:51:27 INFO - 'TERM': 'linux', 10:51:27 INFO - 'TMOUT': '86400', 10:51:27 INFO - 'USER': 'cltbld', 10:51:27 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1479149452.94839-805848729', 10:51:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:27 INFO - '_': '/tools/buildbot/bin/python'} 10:51:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:51:27 INFO - Running setup.py (path:/tmp/pip-xUbogn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:51:27 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)) 10:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:51:27 INFO - Running setup.py (path:/tmp/pip-nYl3vj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:51:27 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)) 10:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:51:27 INFO - Running setup.py (path:/tmp/pip-rwxKCA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:51:27 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)) 10:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:51:27 INFO - Running setup.py (path:/tmp/pip-8wjeq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:51:27 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)) 10:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:51:27 INFO - Running setup.py (path:/tmp/pip-wKHvUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:51:27 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)) 10:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:51:27 INFO - Running setup.py (path:/tmp/pip-p6arhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:51:27 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)) 10:51:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:51:27 INFO - Running setup.py (path:/tmp/pip-tB64pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:51:28 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)) 10:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:51:28 INFO - Running setup.py (path:/tmp/pip-cqJJCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:51:28 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)) 10:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:51:28 INFO - Running setup.py (path:/tmp/pip-T756em-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:51:28 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)) 10:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:51:28 INFO - Running setup.py (path:/tmp/pip-S9LLq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:51:28 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)) 10:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:51:28 INFO - Running setup.py (path:/tmp/pip-CuFRXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:51:28 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)) 10:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:51:28 INFO - Running setup.py (path:/tmp/pip-hvYWX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:51:28 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)) 10:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:51:28 INFO - Running setup.py (path:/tmp/pip-urqLKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:51:28 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)) 10:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:51:28 INFO - Running setup.py (path:/tmp/pip-k7kcZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:51:28 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)) 10:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:51:28 INFO - Running setup.py (path:/tmp/pip-pz80vd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:51:28 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)) 10:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:51:28 INFO - Running setup.py (path:/tmp/pip-1p2_vQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:51:28 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)) 10:51:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:51:28 INFO - Running setup.py (path:/tmp/pip-DIvYZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:51:28 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)) 10:51:28 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)) 10:51:28 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)) 10:51:28 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)) 10:51:28 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)) 10:51:28 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)) 10:51:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:51:28 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 10:51:28 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 10:51:28 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 10:51:28 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 10:51:28 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 10:51:28 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 10:51:30 INFO - Downloading blessings-1.6.tar.gz 10:51:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:51:30 INFO - Installing collected packages: blessings 10:51:30 INFO - Running setup.py install for blessings 10:51:30 INFO - Successfully installed blessings 10:51:30 INFO - Cleaning up... 10:51:30 INFO - Return code: 0 10:51:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:51:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:51:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:51:31 INFO - Reading from file tmpfile_stdout 10:51:31 INFO - Current package versions: 10:51:31 INFO - argparse == 1.2.1 10:51:31 INFO - blessings == 1.6 10:51:31 INFO - blobuploader == 1.2.4 10:51:31 INFO - docopt == 0.6.1 10:51:31 INFO - functools32 == 3.2.3-2 10:51:31 INFO - jsonschema == 2.5.1 10:51:31 INFO - manifestparser == 1.1 10:51:31 INFO - mozInstall == 1.12 10:51:31 INFO - mozcrash == 1.0 10:51:31 INFO - mozdebug == 0.1 10:51:31 INFO - mozdevice == 0.48 10:51:31 INFO - mozfile == 1.2 10:51:31 INFO - mozhttpd == 0.7 10:51:31 INFO - mozinfo == 0.9 10:51:31 INFO - mozleak == 0.1 10:51:31 INFO - mozlog == 3.4 10:51:31 INFO - moznetwork == 0.27 10:51:31 INFO - mozprocess == 0.23 10:51:31 INFO - mozprofile == 0.28 10:51:31 INFO - mozrunner == 6.13 10:51:31 INFO - mozscreenshot == 0.1 10:51:31 INFO - mozsystemmonitor == 0.3 10:51:31 INFO - moztest == 0.7 10:51:31 INFO - mozversion == 1.4 10:51:31 INFO - psutil == 3.1.1 10:51:31 INFO - requests == 1.2.3 10:51:31 INFO - wsgiref == 0.1.2 10:51:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:51: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')]} 10:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51: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')]} 10:51:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:31 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 0x7fca84de3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229ff60>, '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 0x22a0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a11d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1479149452.94839-805848729', '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 10:51:31 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 10:51:31 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 10:51:31 INFO - Using env: {'DISPLAY': ':0', 10:51:31 INFO - 'HOME': '/home/cltbld', 10:51:31 INFO - 'LANG': 'en_US.UTF-8', 10:51:31 INFO - 'LANGUAGE': 'en_US:en', 10:51:31 INFO - 'LOGNAME': 'cltbld', 10:51:31 INFO - 'MAIL': '/var/mail/cltbld', 10:51:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:31 INFO - 'MOZ_NO_REMOTE': '1', 10:51:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:31 INFO - 'NO_EM_RESTART': '1', 10:51:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:31 INFO - 'PWD': '/builds/slave/test', 10:51:31 INFO - 'SHELL': '/bin/bash', 10:51:31 INFO - 'SHLVL': '1', 10:51:31 INFO - 'TERM': 'linux', 10:51:31 INFO - 'TMOUT': '86400', 10:51:31 INFO - 'USER': 'cltbld', 10:51:31 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1479149452.94839-805848729', 10:51:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:31 INFO - '_': '/tools/buildbot/bin/python'} 10:51:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:31 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)) 10:51:31 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)) 10:51:31 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)) 10:51:31 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)) 10:51:31 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)) 10:51:31 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)) 10:51:31 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)) 10:51:31 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)) 10:51:31 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)) 10:51:31 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)) 10:51:31 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)) 10:51:31 INFO - Cleaning up... 10:51:31 INFO - Return code: 0 10:51:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:51: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')]} 10:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:51:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51: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')]} 10:51:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:51:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:51:31 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 0x7fca84de3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22a2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229ff60>, '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 0x22a0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a11d0>, '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': '652eb03db935cfc1c15ebda0000001ad-1479149452.94839-805848729', '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 10:51:31 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 10:51:31 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 10:51:31 INFO - Using env: {'DISPLAY': ':0', 10:51:31 INFO - 'HOME': '/home/cltbld', 10:51:31 INFO - 'LANG': 'en_US.UTF-8', 10:51:31 INFO - 'LANGUAGE': 'en_US:en', 10:51:31 INFO - 'LOGNAME': 'cltbld', 10:51:31 INFO - 'MAIL': '/var/mail/cltbld', 10:51:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:31 INFO - 'MOZ_NO_REMOTE': '1', 10:51:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:31 INFO - 'NO_EM_RESTART': '1', 10:51:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:31 INFO - 'PWD': '/builds/slave/test', 10:51:31 INFO - 'SHELL': '/bin/bash', 10:51:31 INFO - 'SHLVL': '1', 10:51:31 INFO - 'TERM': 'linux', 10:51:31 INFO - 'TMOUT': '86400', 10:51:31 INFO - 'USER': 'cltbld', 10:51:31 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1479149452.94839-805848729', 10:51:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:31 INFO - '_': '/tools/buildbot/bin/python'} 10:51:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:51:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:51:31 INFO - Cleaning up... 10:51:31 INFO - Return code: 0 10:51:31 INFO - Running post-action listener: _resource_record_post_action 10:51:31 INFO - Running post-action listener: _start_resource_monitoring 10:51:31 INFO - Starting resource monitoring. 10:51:31 INFO - [mozharness: 2016-11-14 18:51:31.669405Z] Finished create-virtualenv step (success) 10:51:31 INFO - [mozharness: 2016-11-14 18:51:31.669910Z] Running install step. 10:51:31 INFO - Running pre-action listener: _resource_record_pre_action 10:51:31 INFO - Running main action method: install 10:51:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:51:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:51:31 INFO - Reading from file tmpfile_stdout 10:51:31 INFO - Detecting whether we're running mozinstall >=1.0... 10:51:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:51:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:51:31 INFO - Reading from file tmpfile_stdout 10:51:31 INFO - Output received: 10:51:31 INFO - Usage: mozinstall [options] installer 10:51:31 INFO - Options: 10:51:31 INFO - -h, --help show this help message and exit 10:51:31 INFO - -d DEST, --destination=DEST 10:51:31 INFO - Directory to install application into. [default: 10:51:31 INFO - "/builds/slave/test"] 10:51:31 INFO - --app=APP Application being installed. [default: firefox] 10:51:31 INFO - mkdir: /builds/slave/test/build/application 10:51:31 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'] 10:51:31 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 10:51:47 INFO - Reading from file tmpfile_stdout 10:51:47 INFO - Output received: 10:51:47 INFO - /builds/slave/test/build/application/firefox/firefox 10:51:47 INFO - Running post-action listener: _resource_record_post_action 10:51:47 INFO - [mozharness: 2016-11-14 18:51:47.859972Z] Finished install step (success) 10:51:47 INFO - [mozharness: 2016-11-14 18:51:47.860213Z] Running run-tests step. 10:51:47 INFO - Running pre-action listener: _resource_record_pre_action 10:51:47 INFO - Running main action method: run_tests 10:51:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:51:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:51:47 INFO - Python 2.7.3 10:51:47 INFO - Return code: 0 10:51:47 INFO - grabbing minidump binary from tooltool 10:51:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:51:47 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 0x229ff60>, '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 0x22a0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22a11d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:51:47 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 10:51:47 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 10:51:47 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 10:51:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:51:47 INFO - Return code: 0 10:51:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:51:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:51:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:51:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:51:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:51:47 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/Zw4L7bX4SnawuKWOZkFitQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 10:51:47 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/Zw4L7bX4SnawuKWOZkFitQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 10:51:47 INFO - Using env: {'DISPLAY': ':0', 10:51:47 INFO - 'HOME': '/home/cltbld', 10:51:47 INFO - 'LANG': 'en_US.UTF-8', 10:51:47 INFO - 'LANGUAGE': 'en_US:en', 10:51:47 INFO - 'LOGNAME': 'cltbld', 10:51:47 INFO - 'MAIL': '/var/mail/cltbld', 10:51:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:51:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:51:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:51:47 INFO - 'MOZ_NO_REMOTE': '1', 10:51:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:51:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:51:47 INFO - 'NO_EM_RESTART': '1', 10:51:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:51:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:51:47 INFO - 'PWD': '/builds/slave/test', 10:51:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:51:47 INFO - 'SHELL': '/bin/bash', 10:51:47 INFO - 'SHLVL': '1', 10:51:47 INFO - 'TERM': 'linux', 10:51:47 INFO - 'TMOUT': '86400', 10:51:47 INFO - 'USER': 'cltbld', 10:51:47 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1479149452.94839-805848729', 10:51:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:51:47 INFO - '_': '/tools/buildbot/bin/python'} 10:51:47 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/Zw4L7bX4SnawuKWOZkFitQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 10:51:48 INFO - mozversion application_buildid: 20161114074144 10:51:48 INFO - mozversion application_changeset: 8cdff71808a0e11361bca7f218658c4343c730ca 10:51:48 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:51:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:51:48 INFO - mozversion application_name: Firefox 10:51:48 INFO - mozversion application_remotingname: firefox-dev 10:51:48 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:51:48 INFO - mozversion application_vendor: Mozilla 10:51:48 INFO - mozversion application_version: 52.0a2 10:51:48 INFO - mozversion platform_buildid: 20161114074144 10:51:48 INFO - mozversion platform_changeset: 8cdff71808a0e11361bca7f218658c4343c730ca 10:51:48 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:51:48 INFO - mozversion platform_version: 52.0a2 10:51:48 INFO - using testdate: 1479149508 10:51:48 INFO - actual date: 1479149508 10:51:48 INFO - starting webserver on 'localhost:54196' 10:51:48 INFO - SUITE-START | Running 2 tests 10:51:48 INFO - TEST-START | dromaeo_css 10:51:48 INFO - operating with platform_type : linux_ 10:51:48 INFO - Initialising browser for dromaeo_css test... 10:51:48 INFO - TEST-INFO | started process 27736 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4vkuh0/profile http://localhost:54196/getInfo.html) 10:51:51 ERROR - PROCESS | 27736 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 10:51:52 INFO - PROCESS | 27736 | __metrics Screen width/height:1600/1200 10:51:52 INFO - PROCESS | 27736 | colorDepth:24 10:51:52 INFO - PROCESS | 27736 | Browser inner width/height: 1024/697 10:51:52 INFO - PROCESS | 27736 | __metrics 10:51:52 INFO - PROCESS | 27736 | 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" 10:51:52 INFO - PROCESS | 27736 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:51:53 INFO - PROCESS | 27736 | console.error: PushService: 10:51:53 INFO - PROCESS | 27736 | stateChangeProcessEnqueue: Error transitioning state 10:51:53 INFO - PROCESS | 27736 | UnknownError 10:51:53 INFO - TEST-INFO | 27736: exit 0 10:51:53 INFO - Browser initialized. 10:51:53 INFO - Running cycle 1/1 for dromaeo_css test... 10:51:53 INFO - TEST-INFO | started process 27829 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4vkuh0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:52:05 INFO - PROCESS | 27829 | RSS: Main: 144863232 10:52:05 INFO - PROCESS | 27829 | 10:52:57 INFO - PROCESS | 27829 | 1479149577191 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] 10:55:07 INFO - PROCESS | 27829 | Cycle 1(1): loaded http://localhost:54196/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54196/tests/dromaeo/cssquery-ext.html) 10:55:08 INFO - PROCESS | 27829 | RSS: Main: 256311296 10:55:08 INFO - PROCESS | 27829 | 10:58:10 INFO - PROCESS | 27829 | Cycle 1(1): loaded http://localhost:54196/tests/dromaeo/cssquery-ext.html (next: http://localhost:54196/tests/dromaeo/cssquery-jquery.html) 10:58:11 INFO - PROCESS | 27829 | RSS: Main: 224776192 10:58:11 INFO - PROCESS | 27829 | 11:01:13 INFO - PROCESS | 27829 | Cycle 1(1): loaded http://localhost:54196/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54196/tests/dromaeo/cssquery-mootools.html) 11:01:13 INFO - PROCESS | 27829 | RSS: Main: 176640000 11:01:13 INFO - PROCESS | 27829 | 11:04:15 INFO - PROCESS | 27829 | Cycle 1(1): loaded http://localhost:54196/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54196/tests/dromaeo/cssquery-prototype.html) 11:04:16 INFO - PROCESS | 27829 | RSS: Main: 217657344 11:04:16 INFO - PROCESS | 27829 | 11:07:19 INFO - PROCESS | 27829 | Cycle 1(1): loaded http://localhost:54196/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54196/tests/dromaeo/cssquery-yui.html) 11:07:19 INFO - PROCESS | 27829 | RSS: Main: 174395392 11:07:19 INFO - PROCESS | 27829 | 11:10:22 INFO - PROCESS | 27829 | Cycle 1(1): loaded http://localhost:54196/tests/dromaeo/cssquery-yui.html (next: http://localhost:54196/tests/dromaeo/cssquery-dojo.html) 11:10:22 INFO - PROCESS | 27829 | RSS: Main: 266514432 11:10:22 INFO - PROCESS | 27829 | 11:10:22 INFO - PROCESS | 27829 | __start_tp_report 11:10:22 INFO - PROCESS | 27829 | _x_x_mozilla_page_load 11:10:22 INFO - PROCESS | 27829 | _x_x_mozilla_page_load_details 11:10:22 INFO - PROCESS | 27829 | |i|pagename|runs| 11:10:22 INFO - PROCESS | 27829 | |0;dojo.html;3199.216192032952;3245.253591673915;3252.7560432967525;3272.770906036577;3273.279878426745;5593.105103183487;5646.124850648151;5652.208690783294;5665.433456654332;5680.289963754531;5669.971650141754;5724.971375143129;5728.16941543476;5752.395998420168;5774.797882074128;5116.820911268106;5130.9230361544605;5149.536541711245;5176.663516871391;5220;4952.405711314647;4967.925481117786;5234.73826308685;5235.293235413209;5266.183741520071;5013.4234563025175;5038.445770965191;5066.518680725325;5068.594512439015;5070.442251352349;5059.7976080956905;5090.2110172922885;5096.362954630671;5143.485651434864;5152.355955505562;5068.163752980754;5136.486351364871;5207;5211.895762084775;5241.711705856176;5424.83725488236;5464.398916119224;5679.204911312419;5705.315362156526;5766.163906233614;5944.791932282349;5973.790917317917;5980.8504787380225;6002.609830361056;6024.0662697282;6037.822624588207;6045.6674882881425;6046;6061.66660833654;6109.022556390956;5446.373667028302;5491.2312276281355;5610.775568977277;5685.630434021776;5690.2033715279895;6131.804871721949;6212.316645169028;6214.471769899519;6220.284667263232;6224.190855188796;5967.492763115097;5971.19388882504;5977.581569290195;5980.192673989043;6015.218021657244;5817.0983497557945;5826.126081087871;6053.092036194518;6055.182550355646;6059.697015149225;5872.0898260769645;5917.142014407887;5919.585629005928;5919.644821310735;5923.08192230205;5937.346891841894;5938.168656388109;5939.049752039653;5943.673097979567;5947.37552556984;4626.375439315717;4700.858974230779;4719.174144524694;4720.291956206528;4728.550787675165;4175.394567787654;4178.623923846808;4195.181939521825;4212.220739163265;4222.514410842731;5547.916781248285;5786.132080188006;5793.62341447813;5798.072308430631;5800.970995144998;5840.269966254218;5936.792212272636;5978.940210597925;6040.154378387029;6042.244719410074;5739.62692424991;5775.48020678141;5778.248827652463;5795.478406943395;5801.796937107265;5269.209618557247;5279.234510995884;5281.9207711884355;5282.709450980233;5283.360798976368;6102.481289090389;6130.765048853506;6137.714085984065;6223.128761973237;6228.5017198624;6083.908741368971;6090.056041313426;6090.543209259412;6096.359882212481;6123.571350005457;6272.09054687077;6315.778947736807;6316.873662526816;6319.020551814476;6319.146915166394;5744.913826292525;5751.511121554715;5850.970745146247;5867.178594996789;5961.463468287701;6046.5767396281835;6085.543584231112;6088.969555152196;6105.328413874559;6122.969385153046;5904.704764761831;5915.970420147872;5921.467067963904;5924.407559244041;5940.6435613863305;5653.830385088454;5663.150527420919;5695.202671626059;5919.556033297606;5923.259592550931;5754.050581654147;5801.042827933344;5823.912641310469;5860.326062502867;5907.527397808251;5858.179854820414;5903.439173278532;5917.349091600006;5918.141869428822;5923.614965027259;5541.307336582927;5744.684042377709;5762.308522977102;5767.8558036049435;5773.04744717117 11:10:22 INFO - PROCESS | 27829 | |1;ext.html;576.9394213607571;618.9442950134487;639.2871947778228;646.4989633034401;646.5344951634825;32863.34273314532;44067;45115.32327015098;45195.32207016897;45241.77379113108;45367.54632453674;45916.311255331195;45958.8510287243;45981.54018459815;46039.309410358874;8812.51531165784;8977.281817454588;8980.28157747382;8983.95508022459;8989.685361012365;8789.165029322205;8846.424982376126;8854.690085846996;8856.955715221447;8860.24687901529;8838.823223535526;8861.778455538599;8901.376903616749;8905.332100092519;8913;8859.025507194203;8874.733757987238;8881.111888811132;8882.022977472472;8883.156100170474;8780.473171609723;8839.204471597586;8860.291176705912;8860.689875854314;8864.98052723932;42418.36372454416;42578.57421425808;42679;42688.35967460491;42843.14313713739;3471.444568868969;3583.140046388848;3671.8531258749617;3673.246984368198;3736.5516138063335;31975.840120799247;32159.51760723591;32194.356112877846;32523.674763252537;32926;3651.981740091309;3670.926581468382;3687.8893633191046;3721.218544105741;3739.626037396266;344864;344866;345528;345949.9999999975;346611;37966;39223.607763921995;60038.699806500685;60527.394726052175;60683.39316606866;40600.39099413511;40651;40774.79612601977;40788.79605601953;40809.387859182134;15358.385664573516;15519.301631426613;15520.223988800515;15524.37902483888;15535.76696349533;13431.328433578283;13615.31923403826;13629;13691.178529288274;13695.246761428218;9406.341556091007;9456.669016584525;9501.857472137923;9553.04469553053;9565.521723913776;3517.3492903812876;3595.3708101082207;3610.6930910872343;3624.329499042633;3634.6910512606196;1016.1312078173204;1052.2844465763355;1089.929154604948;1099.4612639806596;1126.6338440006866;31043.379132417223;32445;33143;33283.33433331368;33525.32949341;1101.3997371432588;1146.5643055638805;1156.3004382348727;1186.638075386998;1207.2334067866793;17074.402395916084;17218.741718874226;17225.827741722675;17404.39084632057;17502.649947001242;525260;547575;566073;845728;847513;60335.69832150811;61356;61505.69247153825;61514.69242653758;61666.69166654138;1279.1941077121353;1323.3317174826843;1401.1172961034483;1434.2613554019688;1476.8375478697549;31855;33806;34103.658963410046;34254.75870980607;34467.31065378729;50941;51613;51630.48369516257;51645.22532161945;51658.48341516537;382809;384235;384735;384862;386951;27268.863655681595;28176.577351339336;29570.112896613136;30304.393912122076;30555;46221.53778462307;46764.53235467738;46767.76616116898;47033;47264;40634.390484143354;40790.59209407868;41492.37761433521;42083.579164207964;42311.153776924904;40748.388774169005;40856.59143408647;41458.79270603628;41968.16063678648;42431.575684243995;40097;41215;41601;41636;41877.37183942182;33982.49026264658;36761.81619091887;36937.63062369342;37297;37705;28009.940131047748;28129.859350703115;28218;28361.858190708914;28434.85782571074 11:10:22 INFO - PROCESS | 27829 | |2;jquery.html;395.69926855589745;431.9439962266962;434.9130173965207;439.1743522178305;443.26639411773505;15947.202639868005;18946.431607051793;19233.615327693456;20649.277275295368;20831.375058748225;19969.900150499263;20332.8983355083;20457.18171273147;20587.27944521942;20631.896840515816;5716.28546431696;5944.910826337608;5946.405359464062;5949.940500594982;5953;5498.890022199574;5798.188253644493;5817.360090390053;5817.709114544277;5817.796377126801;5556.444355564452;5766.826995190151;5770.105633626795;5772.971135144339;5779.3642699303045;5755.68343741094;5760.62555933865;5778.335491418498;5788.884222315552;5793.217915581385;5064.797408103672;5224.9738751306;5230.163173892159;5232.136697444917;5244.737763111867;23600.76399236003;23896.761032389626;23921.40196495084;23950.880245598833;24240.636390454158;2657.2294034729907;2695.2318589202177;2928.4143171365813;2974.7471464925507;3168.714815666601;13880.305984700826;14030.228337441436;14215.857841421557;14232.928835355757;14238.430462781476;1878.9436316910378;1910.2196752626492;1941.8446524278024;1950.424624735692;1950.580625165582;83384.58307708423;85041;85885;86585.56707216424;86850;9981.201503879673;10766.761822390368;11076.501557429934;11417.143714221467;11565.76868462626;13910.58268251954;14725.852741472449;14821.184834833972;14844;14853.108813471226;8476.152384761597;8638.481691098428;8736.126387361213;8744.169303916246;8841.248493878093;8407.201315874981;8428.957855210685;8452.830943381097;8605.354598405145;8645.438046526955;6831.351021652935;6843.452523798084;6856.554323968926;6875.243723190445;6885.51801373899;1982.622077656015;1992.3923203422805;2004.9799502005085;2049.631066408061;2060.2804298326064;941.4962994797751;965.4545181972163;1054.2725519391595;1055.9651541489384;1070.3952266969138;19681.40955771329;20399.184032638826;20554.177832886817;20626.484337891674;20751.8962405187;954.465499320369;968.8401413766791;1043.5669197283044;1084.7884662490897;1090.6837017264904;8864.911350886408;10574.206934479946;10721.249512534203;10750.139988800876;10757.462126893624;358043;358593;361489;511411;528645;89453;90228;91017;91502.54248728848;92991;1002.5889385352117;1048.2400259811575;1050.8844027157006;1057.0909018244304;1067.0716476665195;16850.325986960874;17120.743188851928;17121.486355409357;17763.20065597077;17949.192286346886;40554.79722601368;40964.79517602393;41135.38296925489;41429.96425089397;41444.79277603592;57158;57892.710536448736;58004.4199557999;58221.70889145527;59741;8783.780405489659;8796.340274479311;8825;8930.910690893008;9116.726498205064;12596.937015314865;12792;13236.338183090615;13444.596662100153;13522.932385338403;11530.481128349076;11709.531618735155;11745.168331501809;12020.098492612915;12029.699257518281;11244.493997769956;11467.483963221843;11558;11786.823197652213;11930.284182949052;11452.198346115692;11623.535058597561;11631.243969141979;11776.293422394683;12061.396930153282;8600.311975041857;8651.437656552303;8676.098004627365;8773.078826723358;8819.735407937773;10409.635662751767;11551.942240288745;11631.47658355359;11675.708107297385;12060 11:10:22 INFO - PROCESS | 27829 | |3;mootools.html;1401.4114072089722;1495.4242616592612;1530.9846901530984;1650.9174541272932;1823.0702341805675;7777.377809775218;8366.330693544516;8546.316294696426;8645.61094750737;8814.162654547823;8663.913360866389;8737.08260632634;8738.86891696625;8743.956280218606;8751.737447876558;2439.195065628343;2462.347477918353;2473.468204336067;2473.9628905566433;2474.6288056791536;2433.7809597136256;2488.738682438345;2490.252924122765;2496.6379874918125;2502.8373155744907;2435.2450740270483;2440.8169387296025;2448.400141965221;2463.4949835283815;2471.3450935502105;2321.3732292281074;2352.6235802271553;2353.7320146107368;2358.716953965535;2379;2326.7789559991775;2375.7289849930203;2391.629297458897;2395.5807733646716;2396.2571602803014;7895.407844411635;8130.430869839113;8305.792355191108;8385.329173666152;8787.868181977276;5155.922661160085;5171.120909445403;5257.973710131463;5335.546478549328;5390.51485366315;3447.224374515739;3528.858845646171;3583.014670965479;3597.0467826026124;3598.5321908152036;1170.5551890281638;1180.7123895558402;1185.8339832423467;1193.69560762006;1216.1000859364008;12556.434960426803;12589.370531473482;12604.432800523906;12627.368631568384;12646.177998430072;4762.3570817939135;4923.679960802537;4926.4088309403105;4933.186024305949;5006.64953453262;10270.691879243635;10291;10315.381077135396;10328.225383096298;10343;5506.339239291311;5521.613487055867;5524.392316845144;5525.033119204123;5526.309211348582;5021.5229553192385;5057.721825299644;5061.215511595708;5093.490650934951;5176.301199338116;4126.324579017492;4172.561881002512;4196.349565817303;4251.022264879095;4276.037891474393;1322.5701646964776;1338.558275768994;1349.38602935666;1351.304078399625;1352.2900477249523;899.3075331994328;900.3742399032609;943.2925306020485;949.9572519236513;955.3217215776876;5475.589330800126;5952.672603006876;6010.909836352458;6025.78909738157;6316.62100273985;952.1525842000625;954.9236061115095;982.3074732313702;1028.3983869436463;1040.0275742181084;3923.4114882767813;4043.534993475729;4190.784672445017;4222.725522841006;4258.701890867672;10131.341462804894;10516;10665.89334106649;10760.3543787373;11011.559537618567;10441.84337234942;10752.677419677422;10758.354498730101;10787.730306742395;10820.72948176286;8204.384671149688;8460.857784199177;8461.619227134794;8481.533515656574;8482;5766.279215098113;5836.708164591839;5904.025835737055;5907.113932910098;5988.431099045583;9944.751381215527;10070.144037756872;10086.546105425421;10223.795524089624;10243.282970192015;10319.48402579853;10474.266801324138;10479.68560943173;10552.20858435605;10566.735831603964;7442.665080071301;7586.051743532059;7606.04924384452;7608.961955190189;7622.352100071556;8126.268635822805;8408.705695300636;8493.702720404755;8515.74452766418;8515.787105322417;7452.962735186289;7530.021097257321;7547.886781698388;7550.8673698945595;7774.533527988338;7412.481126321106;7594.164641889498;7683.308502234826;7772.222777722182;7790.844183116193;7200.71197152108;7202.783916482514;7233.855322893618;7243.348098671145;7260.346568808833;4991.725455100004;5035.773390197377;5101.7704203310195;5121.437961421653;5218.26944227816;5063.594912406925;5192.5586325162785;5219.060569097447;5233.215017747369;5272.78908843642 11:10:22 INFO - PROCESS | 27829 | |4;prototype.html;353.36923591389376;354.9307884962432;357.3246563994051;367.80506331644204;369.8132443116228;5408.972955135218;5471.534919531835;5479.726013699314;5501.9999999999945;5511.0906700394435;5111.514406131421;5204.973975130129;5258.815941442051;5301.469853014697;5392.4337944515755;4206.810693518799;4219.936700949488;4232.809523571431;4236.173946080516;4251.808668609904;4219.578042195786;4239.703220774547;4248.596383343593;4280.721753086055;4297.474396589213;3920.2551515212162;3967.781772002553;4188.455500784894;4200.537940826506;4203.3064544350145;4197.97901010496;4200.516940551845;4203.831846726127;4219.936700949473;4233.364995250707;3766.773993560395;3771.151490914522;3774.792386418746;3777.5655799583124;3782.1868298315717;5063.974680126613;5206.921896171561;5241.475852414728;5291.761870715827;5298.629095963284;4845.491223421525;4860.684055536379;4864.975675121637;4875.609951203895;4886.682365646222;5573.665580065209;5582.581306402036;5597.860053498654;5602.887942241173;5610.887782244332;3887.2031233597045;4094.508658960914;4095.7337773044956;4206.41110244566;4218.472690913636;5772.3361813391575;5773.364929857712;5794.0160817179185;5808.97095514524;5820.650760954356;4142.627163555234;4143.544210136883;4163.937540936889;4169.97915010423;4174.227767862955;4093.119979204426;4121.979390103031;4145.647619952278;4247.4265974093105;4253.255680255943;4715.198416269242;4717.575418212309;4719.315699223594;4735.857924262209;4784.545468180518;5590.608657393944;5608.719564021782;5613.270274864241;5618.550515958714;5625.184348269478;1354.2348573056192;1411.1533080151826;1416.9291535423188;1421.9715605688036;1423.6512054546495;926.5043201886958;952.7713348796239;973.245734555725;999.2855108597242;1001.9229328471922;5231.764570594332;5236.92144617831;5238.057149713089;5249.921251181236;5261.789788348701;5439.211314359396;5470.699111548903;5471.945280547223;5480.7533660985355;5494.752736126884;5200;5253.212018197224;5529.419410961791;5558.722063896789;5573.303337082864;2934.9706502935123;2952.1881482592457;2961.985190074036;2963.659179194377;2966.4956957316876;5700.8859822803315;5821.679807610622;5850.391142435864;5861.443162899518;5873.530117590582;5662.546996240291;5673.035583950738;5686.5735069869925;5696;5709.286339207599;5752.7698892043845;5761;5767.068032209173;5821.592488525763;5835.854103647443;5300.416954135119;5488.945110548843;5555.444455554412;5560.971220324253;5586.748596313095;5486.643368181056;5505.6696598204235;5506.972465137648;5509.347195841312;5541.418151094077;5618.353889302619;5824.883502330014;5829.396915848176;5870.152975806815;5873.324567674772;4146.771927544014;4197.412362269224;4200.970762163167;4221.451211342506;4236.78816059202;5795.594308398372;5822.272215973004;5836.9416305838095;5854.950767231435;5858.648481091148;5571.832845014656;5653.519450846724;5734.770609175586;5738.655680659173;5769.8557536061935;5608.2148499209325;5616.7191640416995;5622.791099913538;5629.971850140723;5642.887142257214;5389.8113566025;5558.166275058774;5613.971930140323;5631.7184140793615;5646.971765141148;5537.473939975695;5639.689817060101;5640.661560306395;5642.858928526655;5652.519535839499;5481.561475082063;5501.944980550304;5504.284443022381;5513.8145298759355;5523.143912693378 11:10:22 INFO - PROCESS | 27829 | |5;yui.html;678.525032477266;759.2293821770903;762.9084509858818;796.9003874515686;799.5322736199323;14391.64020899478;15133.09201447914;15725.764113538278;15742.212889355515;15951.760723589141;13980.300984950763;14050.367733451994;14071.155730656143;14080.929595352009;14081.859181408183;696.9860602787941;715.0954043135412;822.8560001999656;826.983460330793;843.3885433061043;842.2924743215698;842.5492361586553;843.4770442325736;843.7004863273542;844.1895780051127;887.0464250930244;887.6848718704864;888.076400543434;888.5912480259088;889.1952782731638;736.223284434921;757.2692351880406;866.7399780065955;884.8097659003313;888.4491615198554;658.2167221006987;659.0641289369107;659.446065305146;660.1352228580574;660.7819419591523;13690.726185476235;13710.17738935667;13723.862761372458;13768.655783605389;13799.310034498336;13918.791218131635;14192.85807141936;14212.360443780055;14246.786298205536;14406.135631862122;12630.747385052247;12696.365181740875;12848.87151128486;12968.157069790434;13174.407151678102;4478.686491945565;4496.190685676577;4554.521775213588;4556.316552517116;4587.885302867422;66889.66555167241;67273;69149.65425172843;69219.65390173068;69260.6536967317;11338.546458141747;11478.081753459703;11544.422778861024;11555;11747.588834390926;21068.78931210699;21077.578448430944;21078.47303817417;21132.260370886946;21160;8420.200080992296;8582.356323275779;8635.309175265964;8897.154770296811;8986.86519702205;4760.785764640599;4884.218525035977;4969.503049695074;5010.1733214020005;5172;3379.5775528058994;3395.7113645339928;3408.9147771305916;3445.793252404864;3452.154222215523;580.0660935893209;612.5038718637918;612.963222206669;613.163032460688;616.1189499016449;631.8451979265018;697.10770214126;708.6456771614193;710.573655806512;741.1291732214627;9232.630694772268;9496.810063798684;9714.562844672007;9834.655787047563;10007.49962501872;619.6468013232414;718.9144391968166;719.7840647805638;730.7515444748811;773.4740376544004;4573.320803687272;4585.518520555293;4595.862124136282;4618.237990731559;4685.718856868599;53070.469295307325;53503.46496534985;67886;86474.13525864786;89555.55222223977;65674;71610.64194678994;71773.64113179401;73024.63487682528;78122.21877781262;64866;65127;65738.67130664412;65832;66043.33956660372;9380.390274632127;9486.667966621135;9487.956324804403;9609.711708648752;9632.181264592587;39899.00252493711;44601.55398446104;44690.55309446864;46471.53528464672;46852.7657361711;39029;40868.591314087666;41444;47364;59225;11982.10134239918;12602.432890519765;12629.052821038642;12734.172278801849;12788;14436.639084022983;14476.710465790837;14511.1293322401;14533.34599942984;14715.632109197355;13937.233452160228;14108.435662573382;14301.64245893861;14502.347394367489;14858.85141148618;13568.728625427633;13758.243296618783;13929.373178207208;13931.58205253844;14366.425342986164;13274.668133296746;13284.601461956157;13358;13382.464701412224;13456.932715336361;10126.13927816144;10654.680359589225;10698.631094425542;10879.660872912362;11654;10901.563937442414;11426.428678566204;11426.771464570827;11762.294262344287;11776.11679124052 11:10:22 INFO - PROCESS | 27829 | __end_tp_report 11:10:22 INFO - PROCESS | 27829 | __start_cc_report 11:10:22 INFO - PROCESS | 27829 | _x_x_mozilla_cycle_collect,1148 11:10:22 INFO - PROCESS | 27829 | __end_cc_report 11:10:22 INFO - PROCESS | 27829 | __startTimestamp1479150622573__endTimestamp 11:10:22 INFO - PROCESS | 27829 | 11:10:22 INFO - PROCESS | 27829 | ------- Summary: start ------- 11:10:22 INFO - PROCESS | 27829 | Number of tests: 6 11:10:22 INFO - PROCESS | 27829 | 11:10:22 INFO - PROCESS | 27829 | [#0] dojo.html Cycles:165 Average:5599.67 Median:5795.48 stddev:623.56 (10.8%) stddev-sans-first:596.36 11:10:22 INFO - PROCESS | 27829 | Values: 3199.2 3245.3 3252.8 3272.8 3273.3 5593.1 5646.1 5652.2 5665.4 5680.3 5670.0 5725.0 5728.2 5752.4 5774.8 5116.8 5130.9 5149.5 5176.7 5220.0 4952.4 4967.9 5234.7 5235.3 5266.2 5013.4 5038.4 5066.5 5068.6 5070.4 5059.8 5090.2 5096.4 5143.5 5152.4 5068.2 5136.5 5207.0 5211.9 5241.7 5424.8 5464.4 5679.2 5705.3 5766.2 5944.8 5973.8 5980.9 6002.6 6024.1 6037.8 6045.7 6046.0 6061.7 6109.0 5446.4 5491.2 5610.8 5685.6 5690.2 6131.8 6212.3 6214.5 6220.3 6224.2 5967.5 5971.2 5977.6 5980.2 6015.2 5817.1 5826.1 6053.1 6055.2 6059.7 5872.1 5917.1 5919.6 5919.6 5923.1 5937.3 5938.2 5939.0 5943.7 5947.4 4626.4 4700.9 4719.2 4720.3 4728.6 4175.4 4178.6 4195.2 4212.2 4222.5 5547.9 5786.1 5793.6 5798.1 5801.0 5840.3 5936.8 5978.9 6040.2 6042.2 5739.6 5775.5 5778.2 5795.5 5801.8 5269.2 5279.2 5281.9 5282.7 5283.4 6102.5 6130.8 6137.7 6223.1 6228.5 6083.9 6090.1 6090.5 6096.4 6123.6 6272.1 6315.8 6316.9 6319.0 6319.1 5744.9 5751.5 5851.0 5867.2 5961.5 6046.6 6085.5 6089.0 6105.3 6123.0 5904.7 5916.0 5921.5 5924.4 5940.6 5653.8 5663.2 5695.2 5919.6 5923.3 5754.1 5801.0 5823.9 5860.3 5907.5 5858.2 5903.4 5917.3 5918.1 5923.6 5541.3 5744.7 5762.3 5767.9 5773.0 11:10:22 INFO - PROCESS | 27829 | 11:10:22 INFO - PROCESS | 27829 | [#1] ext.html Cycles:180 Average:61446.22 Median:40642.70 stddev:132538.13 (326.1%) stddev-sans-first:132831.14 11:10:22 INFO - PROCESS | 27829 | Values: 576.9 618.9 639.3 646.5 646.5 32863.3 44067.0 45115.3 45195.3 45241.8 45367.5 45916.3 45958.9 45981.5 46039.3 8812.5 8977.3 8980.3 8984.0 8989.7 8789.2 8846.4 8854.7 8857.0 8860.2 8838.8 8861.8 8901.4 8905.3 8913.0 8859.0 8874.7 8881.1 8882.0 8883.2 8780.5 8839.2 8860.3 8860.7 8865.0 42418.4 42578.6 42679.0 42688.4 42843.1 3471.4 3583.1 3671.9 3673.2 3736.6 31975.8 32159.5 32194.4 32523.7 32926.0 3652.0 3670.9 3687.9 3721.2 3739.6 344864.0 344866.0 345528.0 345950.0 346611.0 37966.0 39223.6 60038.7 60527.4 60683.4 40600.4 40651.0 40774.8 40788.8 40809.4 15358.4 15519.3 15520.2 15524.4 15535.8 13431.3 13615.3 13629.0 13691.2 13695.2 9406.3 9456.7 9501.9 9553.0 9565.5 3517.3 3595.4 3610.7 3624.3 3634.7 1016.1 1052.3 1089.9 1099.5 1126.6 31043.4 32445.0 33143.0 33283.3 33525.3 1101.4 1146.6 1156.3 1186.6 1207.2 17074.4 17218.7 17225.8 17404.4 17502.6 525260.0 547575.0 566073.0 845728.0 847513.0 60335.7 61356.0 61505.7 61514.7 61666.7 1279.2 1323.3 1401.1 1434.3 1476.8 31855.0 33806.0 34103.7 34254.8 34467.3 50941.0 51613.0 51630.5 51645.2 51658.5 382809.0 384235.0 384735.0 384862.0 386951.0 27268.9 28176.6 29570.1 30304.4 30555.0 46221.5 46764.5 46767.8 47033.0 47264.0 40634.4 40790.6 41492.4 42083.6 42311.2 40748.4 40856.6 41458.8 41968.2 42431.6 40097.0 41215.0 41601.0 41636.0 41877.4 33982.5 36761.8 36937.6 37297.0 37705.0 28009.9 28129.9 28218.0 28361.9 28434.9 11:10:22 INFO - PROCESS | 27829 | 11:10:22 INFO - PROCESS | 27829 | [#2] jquery.html Cycles:180 Average:27523.15 Median:2811.82 stddev:71510.42 (2543.2%) stddev-sans-first:71682.02 11:10:22 INFO - PROCESS | 27829 | Values: 395.7 431.9 434.9 439.2 443.3 15947.2 18946.4 19233.6 20649.3 20831.4 19969.9 20332.9 20457.2 20587.3 20631.9 5716.3 5944.9 5946.4 5949.9 5953.0 5498.9 5798.2 5817.4 5817.7 5817.8 5556.4 5766.8 5770.1 5773.0 5779.4 5755.7 5760.6 5778.3 5788.9 5793.2 5064.8 5225.0 5230.2 5232.1 5244.7 23600.8 23896.8 23921.4 23950.9 24240.6 2657.2 2695.2 2928.4 2974.7 3168.7 13880.3 14030.2 14215.9 14232.9 14238.4 1878.9 1910.2 1941.8 1950.4 1950.6 83384.6 85041.0 85885.0 86585.6 86850.0 9981.2 10766.8 11076.5 11417.1 11565.8 13910.6 14725.9 14821.2 14844.0 14853.1 8476.2 8638.5 8736.1 8744.2 8841.2 8407.2 8429.0 8452.8 8605.4 8645.4 6831.4 6843.5 6856.6 6875.2 6885.5 1982.6 1992.4 2005.0 2049.6 2060.3 941.5 965.5 1054.3 1056.0 1070.4 19681.4 20399.2 20554.2 20626.5 20751.9 954.5 968.8 1043.6 1084.8 1090.7 8864.9 10574.2 10721.2 10750.1 10757.5 358043.0 358593.0 361489.0 511411.0 528645.0 89453.0 90228.0 91017.0 91502.5 92991.0 1002.6 1048.2 1050.9 1057.1 1067.1 16850.3 17120.7 17121.5 17763.2 17949.2 40554.8 40964.8 41135.4 41430.0 41444.8 57158.0 57892.7 58004.4 58221.7 59741.0 8783.8 8796.3 8825.0 8930.9 9116.7 12596.9 12792.0 13236.3 13444.6 13522.9 11530.5 11709.5 11745.2 12020.1 12029.7 11244.5 11467.5 11558.0 11786.8 11930.3 11452.2 11623.5 11631.2 11776.3 12061.4 8600.3 8651.4 8676.1 8773.1 8819.7 10409.6 11551.9 11631.5 11675.7 12060.0 11:10:22 INFO - PROCESS | 27829 | 11:10:22 INFO - PROCESS | 27829 | [#3] mootools.html Cycles:180 Average:5836.00 Median:4999.19 stddev:3248.68 (65.0%) stddev-sans-first:3240.70 11:10:22 INFO - PROCESS | 27829 | Values: 1401.4 1495.4 1531.0 1650.9 1823.1 7777.4 8366.3 8546.3 8645.6 8814.2 8663.9 8737.1 8738.9 8744.0 8751.7 2439.2 2462.3 2473.5 2474.0 2474.6 2433.8 2488.7 2490.3 2496.6 2502.8 2435.2 2440.8 2448.4 2463.5 2471.3 2321.4 2352.6 2353.7 2358.7 2379.0 2326.8 2375.7 2391.6 2395.6 2396.3 7895.4 8130.4 8305.8 8385.3 8787.9 5155.9 5171.1 5258.0 5335.5 5390.5 3447.2 3528.9 3583.0 3597.0 3598.5 1170.6 1180.7 1185.8 1193.7 1216.1 12556.4 12589.4 12604.4 12627.4 12646.2 4762.4 4923.7 4926.4 4933.2 5006.6 10270.7 10291.0 10315.4 10328.2 10343.0 5506.3 5521.6 5524.4 5525.0 5526.3 5021.5 5057.7 5061.2 5093.5 5176.3 4126.3 4172.6 4196.3 4251.0 4276.0 1322.6 1338.6 1349.4 1351.3 1352.3 899.3 900.4 943.3 950.0 955.3 5475.6 5952.7 6010.9 6025.8 6316.6 952.2 954.9 982.3 1028.4 1040.0 3923.4 4043.5 4190.8 4222.7 4258.7 10131.3 10516.0 10665.9 10760.4 11011.6 10441.8 10752.7 10758.4 10787.7 10820.7 8204.4 8460.9 8461.6 8481.5 8482.0 5766.3 5836.7 5904.0 5907.1 5988.4 9944.8 10070.1 10086.5 10223.8 10243.3 10319.5 10474.3 10479.7 10552.2 10566.7 7442.7 7586.1 7606.0 7609.0 7622.4 8126.3 8408.7 8493.7 8515.7 8515.8 7453.0 7530.0 7547.9 7550.9 7774.5 7412.5 7594.2 7683.3 7772.2 7790.8 7200.7 7202.8 7233.9 7243.3 7260.3 4991.7 5035.8 5101.8 5121.4 5218.3 5063.6 5192.6 5219.1 5233.2 5272.8 11:10:22 INFO - PROCESS | 27829 | 11:10:22 INFO - PROCESS | 27829 | [#4] prototype.html Cycles:180 Average:4709.29 Median:5424.09 stddev:1363.54 (25.1%) stddev-sans-first:1327.59 11:10:22 INFO - PROCESS | 27829 | Values: 353.4 354.9 357.3 367.8 369.8 5409.0 5471.5 5479.7 5502.0 5511.1 5111.5 5205.0 5258.8 5301.5 5392.4 4206.8 4219.9 4232.8 4236.2 4251.8 4219.6 4239.7 4248.6 4280.7 4297.5 3920.3 3967.8 4188.5 4200.5 4203.3 4198.0 4200.5 4203.8 4219.9 4233.4 3766.8 3771.2 3774.8 3777.6 3782.2 5064.0 5206.9 5241.5 5291.8 5298.6 4845.5 4860.7 4865.0 4875.6 4886.7 5573.7 5582.6 5597.9 5602.9 5610.9 3887.2 4094.5 4095.7 4206.4 4218.5 5772.3 5773.4 5794.0 5809.0 5820.7 4142.6 4143.5 4163.9 4170.0 4174.2 4093.1 4122.0 4145.6 4247.4 4253.3 4715.2 4717.6 4719.3 4735.9 4784.5 5590.6 5608.7 5613.3 5618.6 5625.2 1354.2 1411.2 1416.9 1422.0 1423.7 926.5 952.8 973.2 999.3 1001.9 5231.8 5236.9 5238.1 5249.9 5261.8 5439.2 5470.7 5471.9 5480.8 5494.8 5200.0 5253.2 5529.4 5558.7 5573.3 2935.0 2952.2 2962.0 2963.7 2966.5 5700.9 5821.7 5850.4 5861.4 5873.5 5662.5 5673.0 5686.6 5696.0 5709.3 5752.8 5761.0 5767.1 5821.6 5835.9 5300.4 5488.9 5555.4 5561.0 5586.7 5486.6 5505.7 5507.0 5509.3 5541.4 5618.4 5824.9 5829.4 5870.2 5873.3 4146.8 4197.4 4201.0 4221.5 4236.8 5795.6 5822.3 5836.9 5855.0 5858.6 5571.8 5653.5 5734.8 5738.7 5769.9 5608.2 5616.7 5622.8 5630.0 5642.9 5389.8 5558.2 5614.0 5631.7 5647.0 5537.5 5639.7 5640.7 5642.9 5652.5 5481.6 5501.9 5504.3 5513.8 5523.1 11:10:22 INFO - PROCESS | 27829 | 11:10:22 INFO - PROCESS | 27829 | [#5] yui.html Cycles:180 Average:17003.04 Median:25544.89 stddev:21238.21 (83.1%) stddev-sans-first:21262.41 11:10:22 INFO - PROCESS | 27829 | Values: 678.5 759.2 762.9 796.9 799.5 14391.6 15133.1 15725.8 15742.2 15951.8 13980.3 14050.4 14071.2 14080.9 14081.9 697.0 715.1 822.9 827.0 843.4 842.3 842.5 843.5 843.7 844.2 887.0 887.7 888.1 888.6 889.2 736.2 757.3 866.7 884.8 888.4 658.2 659.1 659.4 660.1 660.8 13690.7 13710.2 13723.9 13768.7 13799.3 13918.8 14192.9 14212.4 14246.8 14406.1 12630.7 12696.4 12848.9 12968.2 13174.4 4478.7 4496.2 4554.5 4556.3 4587.9 66889.7 67273.0 69149.7 69219.7 69260.7 11338.5 11478.1 11544.4 11555.0 11747.6 21068.8 21077.6 21078.5 21132.3 21160.0 8420.2 8582.4 8635.3 8897.2 8986.9 4760.8 4884.2 4969.5 5010.2 5172.0 3379.6 3395.7 3408.9 3445.8 3452.2 580.1 612.5 613.0 613.2 616.1 631.8 697.1 708.6 710.6 741.1 9232.6 9496.8 9714.6 9834.7 10007.5 619.6 718.9 719.8 730.8 773.5 4573.3 4585.5 4595.9 4618.2 4685.7 53070.5 53503.5 67886.0 86474.1 89555.6 65674.0 71610.6 71773.6 73024.6 78122.2 64866.0 65127.0 65738.7 65832.0 66043.3 9380.4 9486.7 9488.0 9609.7 9632.2 39899.0 44601.6 44690.6 46471.5 46852.8 39029.0 40868.6 41444.0 47364.0 59225.0 11982.1 12602.4 12629.1 12734.2 12788.0 14436.6 14476.7 14511.1 14533.3 14715.6 13937.2 14108.4 14301.6 14502.3 14858.9 13568.7 13758.2 13929.4 13931.6 14366.4 13274.7 13284.6 13358.0 13382.5 13456.9 10126.1 10654.7 10698.6 10879.7 11654.0 10901.6 11426.4 11426.8 11762.3 11776.1 11:10:22 INFO - PROCESS | 27829 | -------- Summary: end -------- 11:10:22 INFO - PROCESS | 27829 | 11:10:23 INFO - TEST-INFO | 27829: exit 0 11:10:23 INFO - TEST-OK | dromaeo_css | took 1115184ms 11:10:23 INFO - TEST-START | kraken 11:10:23 INFO - operating with platform_type : linux_ 11:10:23 INFO - Initialising browser for kraken test... 11:10:23 INFO - TEST-INFO | started process 28147 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5qMJ4i/profile http://localhost:54196/getInfo.html) 11:10:26 ERROR - PROCESS | 28147 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 11:10:27 INFO - PROCESS | 28147 | __metrics Screen width/height:1600/1200 11:10:27 INFO - PROCESS | 28147 | colorDepth:24 11:10:27 INFO - PROCESS | 28147 | Browser inner width/height: 1024/697 11:10:27 INFO - PROCESS | 28147 | __metrics 11:10:27 INFO - PROCESS | 28147 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:10:27 INFO - PROCESS | 28147 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:10:28 INFO - PROCESS | 28147 | console.error: PushService: 11:10:28 INFO - PROCESS | 28147 | stateChangeProcessEnqueue: Error transitioning state 11:10:28 INFO - PROCESS | 28147 | UnknownError 11:10:28 INFO - TEST-INFO | 28147: exit 0 11:10:28 INFO - Browser initialized. 11:10:28 INFO - Running cycle 1/1 for kraken test... 11:10:28 INFO - TEST-INFO | started process 28240 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5qMJ4i/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:10:40 INFO - PROCESS | 28240 | RSS: Main: 144752640 11:10:40 INFO - PROCESS | 28240 | 11:10:43 INFO - PROCESS | 28240 | Cycle 1(1): loaded http://localhost:54196/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54196/tests/kraken/driver.html?testName=audio-beat-detection) 11:10:43 INFO - PROCESS | 28240 | RSS: Main: 186515456 11:10:43 INFO - PROCESS | 28240 | 11:10:46 INFO - PROCESS | 28240 | Cycle 1(1): loaded http://localhost:54196/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54196/tests/kraken/driver.html?testName=audio-dft) 11:10:47 INFO - PROCESS | 28240 | RSS: Main: 175271936 11:10:47 INFO - PROCESS | 28240 | 11:10:49 INFO - PROCESS | 28240 | Cycle 1(1): loaded http://localhost:54196/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54196/tests/kraken/driver.html?testName=audio-fft) 11:10:50 INFO - PROCESS | 28240 | RSS: Main: 267034624 11:10:50 INFO - PROCESS | 28240 | 11:10:52 INFO - PROCESS | 28240 | Cycle 1(1): loaded http://localhost:54196/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54196/tests/kraken/driver.html?testName=audio-oscillator) 11:10:53 INFO - PROCESS | 28240 | RSS: Main: 173305856 11:10:53 INFO - PROCESS | 28240 | 11:10:55 INFO - PROCESS | 28240 | Cycle 1(1): loaded http://localhost:54196/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54196/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:10:55 INFO - PROCESS | 28240 | RSS: Main: 175640576 11:10:55 INFO - PROCESS | 28240 | 11:10:58 INFO - PROCESS | 28240 | Cycle 1(1): loaded http://localhost:54196/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54196/tests/kraken/driver.html?testName=imaging-darkroom) 11:10:59 INFO - PROCESS | 28240 | RSS: Main: 213659648 11:10:59 INFO - PROCESS | 28240 | 11:11:02 INFO - PROCESS | 28240 | Cycle 1(1): loaded http://localhost:54196/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54196/tests/kraken/driver.html?testName=imaging-desaturate) 11:11:03 INFO - PROCESS | 28240 | RSS: Main: 213118976 11:11:03 INFO - PROCESS | 28240 | 11:11:06 INFO - PROCESS | 28240 | Cycle 1(1): loaded http://localhost:54196/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54196/tests/kraken/driver.html?testName=json-parse-financial) 11:11:06 INFO - PROCESS | 28240 | RSS: Main: 211574784 11:11:06 INFO - PROCESS | 28240 | 11:11:08 INFO - PROCESS | 28240 | Cycle 1(1): loaded http://localhost:54196/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54196/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:11:08 INFO - PROCESS | 28240 | RSS: Main: 173936640 11:11:08 INFO - PROCESS | 28240 | 11:11:10 INFO - PROCESS | 28240 | Cycle 1(1): loaded http://localhost:54196/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54196/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:11:11 INFO - PROCESS | 28240 | RSS: Main: 180948992 11:11:11 INFO - PROCESS | 28240 | 11:11:13 INFO - PROCESS | 28240 | Cycle 1(1): loaded http://localhost:54196/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54196/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:11:13 INFO - PROCESS | 28240 | RSS: Main: 190210048 11:11:13 INFO - PROCESS | 28240 | 11:11:16 INFO - PROCESS | 28240 | Cycle 1(1): loaded http://localhost:54196/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54196/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:11:16 INFO - PROCESS | 28240 | RSS: Main: 199004160 11:11:16 INFO - PROCESS | 28240 | 11:11:19 INFO - PROCESS | 28240 | Cycle 1(1): loaded http://localhost:54196/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54196/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:11:20 INFO - PROCESS | 28240 | RSS: Main: 195715072 11:11:20 INFO - PROCESS | 28240 | 11:11:21 INFO - PROCESS | 28240 | Cycle 1(1): loaded http://localhost:54196/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54196/tests/kraken/driver.html?testName=ai-astar) 11:11:22 INFO - PROCESS | 28240 | RSS: Main: 245518336 11:11:22 INFO - PROCESS | 28240 | 11:11:22 INFO - PROCESS | 28240 | __start_tp_report 11:11:22 INFO - PROCESS | 28240 | _x_x_mozilla_page_load 11:11:22 INFO - PROCESS | 28240 | _x_x_mozilla_page_load_details 11:11:22 INFO - PROCESS | 28240 | |i|pagename|runs| 11:11:22 INFO - PROCESS | 28240 | |0;ai-astar;110;112;111;111;111;111;110;111;110;110 11:11:22 INFO - PROCESS | 28240 | |1;audio-beat-detection;144;125;123;161;122;120;123;120;149;120 11:11:22 INFO - PROCESS | 28240 | |2;audio-dft;161;161;161;161;160;161;161;163;159;158 11:11:22 INFO - PROCESS | 28240 | |3;audio-fft;75;76;76;113;75;76;76;75;99;75 11:11:22 INFO - PROCESS | 28240 | |4;audio-oscillator;82;82;110;83;83;83;111;82;81;109 11:11:22 INFO - PROCESS | 28240 | |5;imaging-gaussian-blur;116;117;117;117;118;117;117;116;117;118 11:11:22 INFO - PROCESS | 28240 | |6;imaging-darkroom;146;146;146;146;146;146;146;146;146;146 11:11:22 INFO - PROCESS | 28240 | |7;imaging-desaturate;85;85;85;85;84;84;85;85;84;85 11:11:22 INFO - PROCESS | 28240 | |8;json-parse-financial;51;50;49;50;49;50;51;51;49;49 11:11:22 INFO - PROCESS | 28240 | |9;json-stringify-tinderbox;59;60;61;60;60;60;60;60;60;60 11:11:22 INFO - PROCESS | 28240 | |10;stanford-crypto-aes;74;83;74;74;74;74;75;84;74;74 11:11:22 INFO - PROCESS | 28240 | |11;stanford-crypto-ccm;131;128;126;123;130;131;125;122;166;128 11:11:22 INFO - PROCESS | 28240 | |12;stanford-crypto-pbkdf2;156;154;160;150;152;153;161;152;151;156 11:11:22 INFO - PROCESS | 28240 | |13;stanford-crypto-sha256-iterative;61;60;60;61;62;61;61;60;60;62 11:11:22 INFO - PROCESS | 28240 | __end_tp_report 11:11:22 INFO - PROCESS | 28240 | __start_cc_report 11:11:22 INFO - PROCESS | 28240 | _x_x_mozilla_cycle_collect,1669 11:11:22 INFO - PROCESS | 28240 | __end_cc_report 11:11:22 INFO - PROCESS | 28240 | __startTimestamp1479150682027__endTimestamp 11:11:22 INFO - PROCESS | 28240 | 11:11:22 INFO - PROCESS | 28240 | ------- Summary: start ------- 11:11:22 INFO - PROCESS | 28240 | Number of tests: 14 11:11:22 INFO - PROCESS | 28240 | 11:11:22 INFO - PROCESS | 28240 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 11:11:22 INFO - PROCESS | 28240 | Values: 110.0 112.0 111.0 111.0 111.0 111.0 110.0 111.0 110.0 110.0 11:11:22 INFO - PROCESS | 28240 | 11:11:22 INFO - PROCESS | 28240 | [#1] audio-beat-detection Cycles:10 Average:130.70 Median:124.00 stddev:14.91 (12.0%) stddev-sans-first:15.01 11:11:22 INFO - PROCESS | 28240 | Values: 144.0 125.0 123.0 161.0 122.0 120.0 123.0 120.0 149.0 120.0 11:11:22 INFO - PROCESS | 28240 | 11:11:22 INFO - PROCESS | 28240 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:1.35 (0.8%) stddev-sans-first:1.42 11:11:22 INFO - PROCESS | 28240 | Values: 161.0 161.0 161.0 161.0 160.0 161.0 161.0 163.0 159.0 158.0 11:11:22 INFO - PROCESS | 28240 | 11:11:22 INFO - PROCESS | 28240 | [#3] audio-fft Cycles:10 Average:81.60 Median:76.00 stddev:13.28 (17.5%) stddev-sans-first:13.87 11:11:22 INFO - PROCESS | 28240 | Values: 75.0 76.0 76.0 113.0 75.0 76.0 76.0 75.0 99.0 75.0 11:11:22 INFO - PROCESS | 28240 | 11:11:22 INFO - PROCESS | 28240 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:82.00 stddev:13.41 (16.4%) stddev-sans-first:13.86 11:11:22 INFO - PROCESS | 28240 | Values: 82.0 82.0 110.0 83.0 83.0 83.0 111.0 82.0 81.0 109.0 11:11:22 INFO - PROCESS | 28240 | 11:11:22 INFO - PROCESS | 28240 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 11:11:22 INFO - PROCESS | 28240 | Values: 116.0 117.0 117.0 117.0 118.0 117.0 117.0 116.0 117.0 118.0 11:11:22 INFO - PROCESS | 28240 | 11:11:22 INFO - PROCESS | 28240 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 11:11:22 INFO - PROCESS | 28240 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 11:11:22 INFO - PROCESS | 28240 | 11:11:22 INFO - PROCESS | 28240 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 11:11:22 INFO - PROCESS | 28240 | Values: 85.0 85.0 85.0 85.0 84.0 84.0 85.0 85.0 84.0 85.0 11:11:22 INFO - PROCESS | 28240 | 11:11:22 INFO - PROCESS | 28240 | [#8] json-parse-financial Cycles:10 Average:49.90 Median:50.00 stddev:0.88 (1.8%) stddev-sans-first:0.83 11:11:22 INFO - PROCESS | 28240 | Values: 51.0 50.0 49.0 50.0 49.0 50.0 51.0 51.0 49.0 49.0 11:11:22 INFO - PROCESS | 28240 | 11:11:22 INFO - PROCESS | 28240 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:0.47 (0.8%) stddev-sans-first:0.33 11:11:22 INFO - PROCESS | 28240 | Values: 59.0 60.0 61.0 60.0 60.0 60.0 60.0 60.0 60.0 60.0 11:11:22 INFO - PROCESS | 28240 | 11:11:22 INFO - PROCESS | 28240 | [#10] stanford-crypto-aes Cycles:10 Average:76.00 Median:74.00 stddev:3.97 (5.4%) stddev-sans-first:4.15 11:11:22 INFO - PROCESS | 28240 | Values: 74.0 83.0 74.0 74.0 74.0 74.0 75.0 84.0 74.0 74.0 11:11:22 INFO - PROCESS | 28240 | 11:11:22 INFO - PROCESS | 28240 | [#11] stanford-crypto-ccm Cycles:10 Average:131.00 Median:129.00 stddev:12.69 (9.8%) stddev-sans-first:13.46 11:11:22 INFO - PROCESS | 28240 | Values: 131.0 128.0 126.0 123.0 130.0 131.0 125.0 122.0 166.0 128.0 11:11:22 INFO - PROCESS | 28240 | 11:11:22 INFO - PROCESS | 28240 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.50 Median:155.00 stddev:3.72 (2.4%) stddev-sans-first:3.91 11:11:22 INFO - PROCESS | 28240 | Values: 156.0 154.0 160.0 150.0 152.0 153.0 161.0 152.0 151.0 156.0 11:11:22 INFO - PROCESS | 28240 | 11:11:22 INFO - PROCESS | 28240 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.80 Median:61.00 stddev:0.79 (1.3%) stddev-sans-first:0.83 11:11:22 INFO - PROCESS | 28240 | Values: 61.0 60.0 60.0 61.0 62.0 61.0 61.0 60.0 60.0 62.0 11:11:22 INFO - PROCESS | 28240 | -------- Summary: end -------- 11:11:22 INFO - PROCESS | 28240 | 11:11:23 INFO - TEST-INFO | 28240: exit 0 11:11:23 INFO - TEST-OK | kraken | took 59867ms 11:11:23 INFO - SUITE-END | took 1175s 11:11:23 INFO - Completed test suite (00:19:35) 11:11:23 INFO - javascript benchmark 11:11:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3199.216192032952, 3245.253591673915, 3252.7560432967525, 3272.770906036577, 3273.279878426745, 5593.105103183487, 5646.124850648151, 5652.208690783294, 5665.433456654332, 5680.289963754531, 5669.971650141754, 5724.971375143129, 5728.16941543476, 5752.395998420168, 5774.797882074128, 5116.820911268106, 5130.9230361544605, 5149.536541711245, 5176.663516871391, 5220.0, 4952.405711314647, 4967.925481117786, 5234.73826308685, 5235.293235413209, 5266.183741520071, 5013.4234563025175, 5038.445770965191, 5066.518680725325, 5068.594512439015, 5070.442251352349, 5059.7976080956905, 5090.2110172922885, 5096.362954630671, 5143.485651434864, 5152.355955505562, 5068.163752980754, 5136.486351364871, 5207.0, 5211.895762084775, 5241.711705856176, 5424.83725488236, 5464.398916119224, 5679.204911312419, 5705.315362156526, 5766.163906233614, 5944.791932282349, 5973.790917317917, 5980.8504787380225, 6002.609830361056, 6024.0662697282, 6037.822624588207, 6045.6674882881425, 6046.0, 6061.66660833654, 6109.022556390956, 5446.373667028302, 5491.2312276281355, 5610.775568977277, 5685.630434021776, 5690.2033715279895, 6131.804871721949, 6212.316645169028, 6214.471769899519, 6220.284667263232, 6224.190855188796, 5967.492763115097, 5971.19388882504, 5977.581569290195, 5980.192673989043, 6015.218021657244, 5817.0983497557945, 5826.126081087871, 6053.092036194518, 6055.182550355646, 6059.697015149225, 5872.0898260769645, 5917.142014407887, 5919.585629005928, 5919.644821310735, 5923.08192230205, 5937.346891841894, 5938.168656388109, 5939.049752039653, 5943.673097979567, 5947.37552556984, 4626.375439315717, 4700.858974230779, 4719.174144524694, 4720.291956206528, 4728.550787675165, 4175.394567787654, 4178.623923846808, 4195.181939521825, 4212.220739163265, 4222.514410842731, 5547.916781248285, 5786.132080188006, 5793.62341447813, 5798.072308430631, 5800.970995144998, 5840.269966254218, 5936.792212272636, 5978.940210597925, 6040.154378387029, 6042.244719410074, 5739.62692424991, 5775.48020678141, 5778.248827652463, 5795.478406943395, 5801.796937107265, 5269.209618557247, 5279.234510995884, 5281.9207711884355, 5282.709450980233, 5283.360798976368, 6102.481289090389, 6130.765048853506, 6137.714085984065, 6223.128761973237, 6228.5017198624, 6083.908741368971, 6090.056041313426, 6090.543209259412, 6096.359882212481, 6123.571350005457, 6272.09054687077, 6315.778947736807, 6316.873662526816, 6319.020551814476, 6319.146915166394, 5744.913826292525, 5751.511121554715, 5850.970745146247, 5867.178594996789, 5961.463468287701, 6046.5767396281835, 6085.543584231112, 6088.969555152196, 6105.328413874559, 6122.969385153046, 5904.704764761831, 5915.970420147872, 5921.467067963904, 5924.407559244041, 5940.6435613863305, 5653.830385088454, 5663.150527420919, 5695.202671626059, 5919.556033297606, 5923.259592550931, 5754.050581654147, 5801.042827933344, 5823.912641310469, 5860.326062502867, 5907.527397808251, 5858.179854820414, 5903.439173278532, 5917.349091600006, 5918.141869428822, 5923.614965027259, 5541.307336582927, 5744.684042377709, 5762.308522977102, 5767.8558036049435, 5773.04744717117], "value": 5558.359451770426, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.9394213607571, 618.9442950134487, 639.2871947778228, 646.4989633034401, 646.5344951634825, 32863.34273314532, 44067.0, 45115.32327015098, 45195.32207016897, 45241.77379113108, 45367.54632453674, 45916.311255331195, 45958.8510287243, 45981.54018459815, 46039.309410358874, 8812.51531165784, 8977.281817454588, 8980.28157747382, 8983.95508022459, 8989.685361012365, 8789.165029322205, 8846.424982376126, 8854.690085846996, 8856.955715221447, 8860.24687901529, 8838.823223535526, 8861.778455538599, 8901.376903616749, 8905.332100092519, 8913.0, 8859.025507194203, 8874.733757987238, 8881.111888811132, 8882.022977472472, 8883.156100170474, 8780.473171609723, 8839.204471597586, 8860.291176705912, 8860.689875854314, 8864.98052723932, 42418.36372454416, 42578.57421425808, 42679.0, 42688.35967460491, 42843.14313713739, 3471.444568868969, 3583.140046388848, 3671.8531258749617, 3673.246984368198, 3736.5516138063335, 31975.840120799247, 32159.51760723591, 32194.356112877846, 32523.674763252537, 32926.0, 3651.981740091309, 3670.926581468382, 3687.8893633191046, 3721.218544105741, 3739.626037396266, 344864.0, 344866.0, 345528.0, 345949.9999999975, 346611.0, 37966.0, 39223.607763921995, 60038.699806500685, 60527.394726052175, 60683.39316606866, 40600.39099413511, 40651.0, 40774.79612601977, 40788.79605601953, 40809.387859182134, 15358.385664573516, 15519.301631426613, 15520.223988800515, 15524.37902483888, 15535.76696349533, 13431.328433578283, 13615.31923403826, 13629.0, 13691.178529288274, 13695.246761428218, 9406.341556091007, 9456.669016584525, 9501.857472137923, 9553.04469553053, 9565.521723913776, 3517.3492903812876, 3595.3708101082207, 3610.6930910872343, 3624.329499042633, 3634.6910512606196, 1016.1312078173204, 1052.2844465763355, 1089.929154604948, 1099.4612639806596, 1126.6338440006866, 31043.379132417223, 32445.0, 33143.0, 33283.33433331368, 33525.32949341, 1101.3997371432588, 1146.5643055638805, 1156.3004382348727, 1186.638075386998, 1207.2334067866793, 17074.402395916084, 17218.741718874226, 17225.827741722675, 17404.39084632057, 17502.649947001242, 525260.0, 547575.0, 566073.0, 845728.0, 847513.0, 60335.69832150811, 61356.0, 61505.69247153825, 61514.69242653758, 61666.69166654138, 1279.1941077121353, 1323.3317174826843, 1401.1172961034483, 1434.2613554019688, 1476.8375478697549, 31855.0, 33806.0, 34103.658963410046, 34254.75870980607, 34467.31065378729, 50941.0, 51613.0, 51630.48369516257, 51645.22532161945, 51658.48341516537, 382809.0, 384235.0, 384735.0, 384862.0, 386951.0, 27268.863655681595, 28176.577351339336, 29570.112896613136, 30304.393912122076, 30555.0, 46221.53778462307, 46764.53235467738, 46767.76616116898, 47033.0, 47264.0, 40634.390484143354, 40790.59209407868, 41492.37761433521, 42083.579164207964, 42311.153776924904, 40748.388774169005, 40856.59143408647, 41458.79270603628, 41968.16063678648, 42431.575684243995, 40097.0, 41215.0, 41601.0, 41636.0, 41877.37183942182, 33982.49026264658, 36761.81619091887, 36937.63062369342, 37297.0, 37705.0, 28009.940131047748, 28129.859350703115, 28218.0, 28361.858190708914, 28434.85782571074], "value": 19251.686550836977, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.69926855589745, 431.9439962266962, 434.9130173965207, 439.1743522178305, 443.26639411773505, 15947.202639868005, 18946.431607051793, 19233.615327693456, 20649.277275295368, 20831.375058748225, 19969.900150499263, 20332.8983355083, 20457.18171273147, 20587.27944521942, 20631.896840515816, 5716.28546431696, 5944.910826337608, 5946.405359464062, 5949.940500594982, 5953.0, 5498.890022199574, 5798.188253644493, 5817.360090390053, 5817.709114544277, 5817.796377126801, 5556.444355564452, 5766.826995190151, 5770.105633626795, 5772.971135144339, 5779.3642699303045, 5755.68343741094, 5760.62555933865, 5778.335491418498, 5788.884222315552, 5793.217915581385, 5064.797408103672, 5224.9738751306, 5230.163173892159, 5232.136697444917, 5244.737763111867, 23600.76399236003, 23896.761032389626, 23921.40196495084, 23950.880245598833, 24240.636390454158, 2657.2294034729907, 2695.2318589202177, 2928.4143171365813, 2974.7471464925507, 3168.714815666601, 13880.305984700826, 14030.228337441436, 14215.857841421557, 14232.928835355757, 14238.430462781476, 1878.9436316910378, 1910.2196752626492, 1941.8446524278024, 1950.424624735692, 1950.580625165582, 83384.58307708423, 85041.0, 85885.0, 86585.56707216424, 86850.0, 9981.201503879673, 10766.761822390368, 11076.501557429934, 11417.143714221467, 11565.76868462626, 13910.58268251954, 14725.852741472449, 14821.184834833972, 14844.0, 14853.108813471226, 8476.152384761597, 8638.481691098428, 8736.126387361213, 8744.169303916246, 8841.248493878093, 8407.201315874981, 8428.957855210685, 8452.830943381097, 8605.354598405145, 8645.438046526955, 6831.351021652935, 6843.452523798084, 6856.554323968926, 6875.243723190445, 6885.51801373899, 1982.622077656015, 1992.3923203422805, 2004.9799502005085, 2049.631066408061, 2060.2804298326064, 941.4962994797751, 965.4545181972163, 1054.2725519391595, 1055.9651541489384, 1070.3952266969138, 19681.40955771329, 20399.184032638826, 20554.177832886817, 20626.484337891674, 20751.8962405187, 954.465499320369, 968.8401413766791, 1043.5669197283044, 1084.7884662490897, 1090.6837017264904, 8864.911350886408, 10574.206934479946, 10721.249512534203, 10750.139988800876, 10757.462126893624, 358043.0, 358593.0, 361489.0, 511411.0, 528645.0, 89453.0, 90228.0, 91017.0, 91502.54248728848, 92991.0, 1002.5889385352117, 1048.2400259811575, 1050.8844027157006, 1057.0909018244304, 1067.0716476665195, 16850.325986960874, 17120.743188851928, 17121.486355409357, 17763.20065597077, 17949.192286346886, 40554.79722601368, 40964.79517602393, 41135.38296925489, 41429.96425089397, 41444.79277603592, 57158.0, 57892.710536448736, 58004.4199557999, 58221.70889145527, 59741.0, 8783.780405489659, 8796.340274479311, 8825.0, 8930.910690893008, 9116.726498205064, 12596.937015314865, 12792.0, 13236.338183090615, 13444.596662100153, 13522.932385338403, 11530.481128349076, 11709.531618735155, 11745.168331501809, 12020.098492612915, 12029.699257518281, 11244.493997769956, 11467.483963221843, 11558.0, 11786.823197652213, 11930.284182949052, 11452.198346115692, 11623.535058597561, 11631.243969141979, 11776.293422394683, 12061.396930153282, 8600.311975041857, 8651.437656552303, 8676.098004627365, 8773.078826723358, 8819.735407937773, 10409.635662751767, 11551.942240288745, 11631.47658355359, 11675.708107297385, 12060.0], "value": 9532.419735230184, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1401.4114072089722, 1495.4242616592612, 1530.9846901530984, 1650.9174541272932, 1823.0702341805675, 7777.377809775218, 8366.330693544516, 8546.316294696426, 8645.61094750737, 8814.162654547823, 8663.913360866389, 8737.08260632634, 8738.86891696625, 8743.956280218606, 8751.737447876558, 2439.195065628343, 2462.347477918353, 2473.468204336067, 2473.9628905566433, 2474.6288056791536, 2433.7809597136256, 2488.738682438345, 2490.252924122765, 2496.6379874918125, 2502.8373155744907, 2435.2450740270483, 2440.8169387296025, 2448.400141965221, 2463.4949835283815, 2471.3450935502105, 2321.3732292281074, 2352.6235802271553, 2353.7320146107368, 2358.716953965535, 2379.0, 2326.7789559991775, 2375.7289849930203, 2391.629297458897, 2395.5807733646716, 2396.2571602803014, 7895.407844411635, 8130.430869839113, 8305.792355191108, 8385.329173666152, 8787.868181977276, 5155.922661160085, 5171.120909445403, 5257.973710131463, 5335.546478549328, 5390.51485366315, 3447.224374515739, 3528.858845646171, 3583.014670965479, 3597.0467826026124, 3598.5321908152036, 1170.5551890281638, 1180.7123895558402, 1185.8339832423467, 1193.69560762006, 1216.1000859364008, 12556.434960426803, 12589.370531473482, 12604.432800523906, 12627.368631568384, 12646.177998430072, 4762.3570817939135, 4923.679960802537, 4926.4088309403105, 4933.186024305949, 5006.64953453262, 10270.691879243635, 10291.0, 10315.381077135396, 10328.225383096298, 10343.0, 5506.339239291311, 5521.613487055867, 5524.392316845144, 5525.033119204123, 5526.309211348582, 5021.5229553192385, 5057.721825299644, 5061.215511595708, 5093.490650934951, 5176.301199338116, 4126.324579017492, 4172.561881002512, 4196.349565817303, 4251.022264879095, 4276.037891474393, 1322.5701646964776, 1338.558275768994, 1349.38602935666, 1351.304078399625, 1352.2900477249523, 899.3075331994328, 900.3742399032609, 943.2925306020485, 949.9572519236513, 955.3217215776876, 5475.589330800126, 5952.672603006876, 6010.909836352458, 6025.78909738157, 6316.62100273985, 952.1525842000625, 954.9236061115095, 982.3074732313702, 1028.3983869436463, 1040.0275742181084, 3923.4114882767813, 4043.534993475729, 4190.784672445017, 4222.725522841006, 4258.701890867672, 10131.341462804894, 10516.0, 10665.89334106649, 10760.3543787373, 11011.559537618567, 10441.84337234942, 10752.677419677422, 10758.354498730101, 10787.730306742395, 10820.72948176286, 8204.384671149688, 8460.857784199177, 8461.619227134794, 8481.533515656574, 8482.0, 5766.279215098113, 5836.708164591839, 5904.025835737055, 5907.113932910098, 5988.431099045583, 9944.751381215527, 10070.144037756872, 10086.546105425421, 10223.795524089624, 10243.282970192015, 10319.48402579853, 10474.266801324138, 10479.68560943173, 10552.20858435605, 10566.735831603964, 7442.665080071301, 7586.051743532059, 7606.04924384452, 7608.961955190189, 7622.352100071556, 8126.268635822805, 8408.705695300636, 8493.702720404755, 8515.74452766418, 8515.787105322417, 7452.962735186289, 7530.021097257321, 7547.886781698388, 7550.8673698945595, 7774.533527988338, 7412.481126321106, 7594.164641889498, 7683.308502234826, 7772.222777722182, 7790.844183116193, 7200.71197152108, 7202.783916482514, 7233.855322893618, 7243.348098671145, 7260.346568808833, 4991.725455100004, 5035.773390197377, 5101.7704203310195, 5121.437961421653, 5218.26944227816, 5063.594912406925, 5192.5586325162785, 5219.060569097447, 5233.215017747369, 5272.78908843642], "value": 4713.676318571829, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.36923591389376, 354.9307884962432, 357.3246563994051, 367.80506331644204, 369.8132443116228, 5408.972955135218, 5471.534919531835, 5479.726013699314, 5501.9999999999945, 5511.0906700394435, 5111.514406131421, 5204.973975130129, 5258.815941442051, 5301.469853014697, 5392.4337944515755, 4206.810693518799, 4219.936700949488, 4232.809523571431, 4236.173946080516, 4251.808668609904, 4219.578042195786, 4239.703220774547, 4248.596383343593, 4280.721753086055, 4297.474396589213, 3920.2551515212162, 3967.781772002553, 4188.455500784894, 4200.537940826506, 4203.3064544350145, 4197.97901010496, 4200.516940551845, 4203.831846726127, 4219.936700949473, 4233.364995250707, 3766.773993560395, 3771.151490914522, 3774.792386418746, 3777.5655799583124, 3782.1868298315717, 5063.974680126613, 5206.921896171561, 5241.475852414728, 5291.761870715827, 5298.629095963284, 4845.491223421525, 4860.684055536379, 4864.975675121637, 4875.609951203895, 4886.682365646222, 5573.665580065209, 5582.581306402036, 5597.860053498654, 5602.887942241173, 5610.887782244332, 3887.2031233597045, 4094.508658960914, 4095.7337773044956, 4206.41110244566, 4218.472690913636, 5772.3361813391575, 5773.364929857712, 5794.0160817179185, 5808.97095514524, 5820.650760954356, 4142.627163555234, 4143.544210136883, 4163.937540936889, 4169.97915010423, 4174.227767862955, 4093.119979204426, 4121.979390103031, 4145.647619952278, 4247.4265974093105, 4253.255680255943, 4715.198416269242, 4717.575418212309, 4719.315699223594, 4735.857924262209, 4784.545468180518, 5590.608657393944, 5608.719564021782, 5613.270274864241, 5618.550515958714, 5625.184348269478, 1354.2348573056192, 1411.1533080151826, 1416.9291535423188, 1421.9715605688036, 1423.6512054546495, 926.5043201886958, 952.7713348796239, 973.245734555725, 999.2855108597242, 1001.9229328471922, 5231.764570594332, 5236.92144617831, 5238.057149713089, 5249.921251181236, 5261.789788348701, 5439.211314359396, 5470.699111548903, 5471.945280547223, 5480.7533660985355, 5494.752736126884, 5200.0, 5253.212018197224, 5529.419410961791, 5558.722063896789, 5573.303337082864, 2934.9706502935123, 2952.1881482592457, 2961.985190074036, 2963.659179194377, 2966.4956957316876, 5700.8859822803315, 5821.679807610622, 5850.391142435864, 5861.443162899518, 5873.530117590582, 5662.546996240291, 5673.035583950738, 5686.5735069869925, 5696.0, 5709.286339207599, 5752.7698892043845, 5761.0, 5767.068032209173, 5821.592488525763, 5835.854103647443, 5300.416954135119, 5488.945110548843, 5555.444455554412, 5560.971220324253, 5586.748596313095, 5486.643368181056, 5505.6696598204235, 5506.972465137648, 5509.347195841312, 5541.418151094077, 5618.353889302619, 5824.883502330014, 5829.396915848176, 5870.152975806815, 5873.324567674772, 4146.771927544014, 4197.412362269224, 4200.970762163167, 4221.451211342506, 4236.78816059202, 5795.594308398372, 5822.272215973004, 5836.9416305838095, 5854.950767231435, 5858.648481091148, 5571.832845014656, 5653.519450846724, 5734.770609175586, 5738.655680659173, 5769.8557536061935, 5608.2148499209325, 5616.7191640416995, 5622.791099913538, 5629.971850140723, 5642.887142257214, 5389.8113566025, 5558.166275058774, 5613.971930140323, 5631.7184140793615, 5646.971765141148, 5537.473939975695, 5639.689817060101, 5640.661560306395, 5642.858928526655, 5652.519535839499, 5481.561475082063, 5501.944980550304, 5504.284443022381, 5513.8145298759355, 5523.143912693378], "value": 4280.66903014361, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [678.525032477266, 759.2293821770903, 762.9084509858818, 796.9003874515686, 799.5322736199323, 14391.64020899478, 15133.09201447914, 15725.764113538278, 15742.212889355515, 15951.760723589141, 13980.300984950763, 14050.367733451994, 14071.155730656143, 14080.929595352009, 14081.859181408183, 696.9860602787941, 715.0954043135412, 822.8560001999656, 826.983460330793, 843.3885433061043, 842.2924743215698, 842.5492361586553, 843.4770442325736, 843.7004863273542, 844.1895780051127, 887.0464250930244, 887.6848718704864, 888.076400543434, 888.5912480259088, 889.1952782731638, 736.223284434921, 757.2692351880406, 866.7399780065955, 884.8097659003313, 888.4491615198554, 658.2167221006987, 659.0641289369107, 659.446065305146, 660.1352228580574, 660.7819419591523, 13690.726185476235, 13710.17738935667, 13723.862761372458, 13768.655783605389, 13799.310034498336, 13918.791218131635, 14192.85807141936, 14212.360443780055, 14246.786298205536, 14406.135631862122, 12630.747385052247, 12696.365181740875, 12848.87151128486, 12968.157069790434, 13174.407151678102, 4478.686491945565, 4496.190685676577, 4554.521775213588, 4556.316552517116, 4587.885302867422, 66889.66555167241, 67273.0, 69149.65425172843, 69219.65390173068, 69260.6536967317, 11338.546458141747, 11478.081753459703, 11544.422778861024, 11555.0, 11747.588834390926, 21068.78931210699, 21077.578448430944, 21078.47303817417, 21132.260370886946, 21160.0, 8420.200080992296, 8582.356323275779, 8635.309175265964, 8897.154770296811, 8986.86519702205, 4760.785764640599, 4884.218525035977, 4969.503049695074, 5010.1733214020005, 5172.0, 3379.5775528058994, 3395.7113645339928, 3408.9147771305916, 3445.793252404864, 3452.154222215523, 580.0660935893209, 612.5038718637918, 612.963222206669, 613.163032460688, 616.1189499016449, 631.8451979265018, 697.10770214126, 708.6456771614193, 710.573655806512, 741.1291732214627, 9232.630694772268, 9496.810063798684, 9714.562844672007, 9834.655787047563, 10007.49962501872, 619.6468013232414, 718.9144391968166, 719.7840647805638, 730.7515444748811, 773.4740376544004, 4573.320803687272, 4585.518520555293, 4595.862124136282, 4618.237990731559, 4685.718856868599, 53070.469295307325, 53503.46496534985, 67886.0, 86474.13525864786, 89555.55222223977, 65674.0, 71610.64194678994, 71773.64113179401, 73024.63487682528, 78122.21877781262, 64866.0, 65127.0, 65738.67130664412, 65832.0, 66043.33956660372, 9380.390274632127, 9486.667966621135, 9487.956324804403, 9609.711708648752, 9632.181264592587, 39899.00252493711, 44601.55398446104, 44690.55309446864, 46471.53528464672, 46852.7657361711, 39029.0, 40868.591314087666, 41444.0, 47364.0, 59225.0, 11982.10134239918, 12602.432890519765, 12629.052821038642, 12734.172278801849, 12788.0, 14436.639084022983, 14476.710465790837, 14511.1293322401, 14533.34599942984, 14715.632109197355, 13937.233452160228, 14108.435662573382, 14301.64245893861, 14502.347394367489, 14858.85141148618, 13568.728625427633, 13758.243296618783, 13929.373178207208, 13931.58205253844, 14366.425342986164, 13274.668133296746, 13284.601461956157, 13358.0, 13382.464701412224, 13456.932715336361, 10126.13927816144, 10654.680359589225, 10698.631094425542, 10879.660872912362, 11654.0, 10901.563937442414, 11426.428678566204, 11426.771464570827, 11762.294262344287, 11776.11679124052], "value": 7208.365449137879, "unit": "score"}], "name": "dromaeo_css", "value": 7276.035122734904, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 112.0, 111.0, 111.0, 111.0, 111.0, 110.0, 111.0, 110.0, 110.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 125.0, 123.0, 161.0, 122.0, 120.0, 123.0, 120.0, 149.0, 120.0], "value": 130.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 160.0, 161.0, 161.0, 163.0, 159.0, 158.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 113.0, 75.0, 76.0, 76.0, 75.0, 99.0, 75.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 110.0, 83.0, 83.0, 83.0, 111.0, 82.0, 81.0, 109.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 116.0, 117.0, 118.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.0, "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, 85.0, 84.0, 85.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 49.0, 50.0, 49.0, 50.0, 51.0, 51.0, 49.0, 49.0], "value": 49.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 61.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 60.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 83.0, 74.0, 74.0, 74.0, 74.0, 75.0, 84.0, 74.0, 74.0], "value": 76.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 128.0, 126.0, 123.0, 130.0, 131.0, 125.0, 122.0, 166.0, 128.0], "value": 131.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 154.0, 160.0, 150.0, 152.0, 153.0, 161.0, 152.0, 151.0, 156.0], "value": 154.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 61.0, 62.0, 61.0, 61.0, 60.0, 60.0, 62.0], "value": 60.8, "unit": "score"}], "name": "kraken", "value": 1454.1000000000001, "alertThreshold": 2.0}]} 11:11:23 INFO - Return code: 0 11:11:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:11:23 ERROR - # TBPL SUCCESS # 11:11:23 INFO - Running post-action listener: _resource_record_post_action 11:11:23 INFO - [mozharness: 2016-11-14 19:11:23.866377Z] Finished run-tests step (success) 11:11:23 INFO - Running post-run listener: _resource_record_post_run 11:11:23 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 357101568; Read time: 12; Write time: 266528 11:11:23 INFO - TinderboxPrint: CPU usage
13.0% 11:11:23 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 11:11:23 INFO - TinderboxPrint: I/O write bytes / time
357,101,568 / 266,528 11:11:23 INFO - TinderboxPrint: CPU idle
8,278.7 (87.0%) 11:11:23 INFO - TinderboxPrint: CPU user
1,190.3 (12.5%) 11:11:23 INFO - TinderboxPrint: Swap in / out
0 / 0 11:11:23 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107909120; Read time: 0; Write time: 91140 11:11:23 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 248733696; Read time: 0; Write time: 175348 11:11:24 INFO - Running post-run listener: _upload_blobber_files 11:11:24 INFO - Blob upload gear active. 11:11:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:11:24 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:11:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:11:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:11:24 INFO - (blobuploader) - INFO - Open directory for files ... 11:11:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:11:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:11:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:11:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:11:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:11:25 INFO - (blobuploader) - INFO - Done attempting. 11:11:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:11:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:11:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:11:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:11:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:11:26 INFO - (blobuploader) - INFO - Done attempting. 11:11:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:11:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:11:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:11:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:11:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:11:30 INFO - (blobuploader) - INFO - Done attempting. 11:11:30 INFO - (blobuploader) - INFO - Iteration through files over. 11:11:30 INFO - Return code: 0 11:11:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:11:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:11:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b0cdbac843b5d8ef4a571d0b7a5666515bb040cf5a55347902c8a67a754fce51aa74fc4c6901bb55ecb210c00e6538ffea0785520f73e641fb5bfa0243e20af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/844e2c89fdb6bd78180fed564492f99dbac907baab277cfbd4efddf6f9862b49562887b224487891f415bc5167d50c3972e7a6dced5a80e0fc2a35164f8d9c4f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a61055d212af2f1a9da3414098b1d4332faf225786c432246c38b94a3c58a82c0747ce0bc148ff51d8f57362aa491f0c9f163a163cd16cc8b08dd6c5628c3e1b"} 11:11:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:11:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:11:30 INFO - Contents: 11:11:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b0cdbac843b5d8ef4a571d0b7a5666515bb040cf5a55347902c8a67a754fce51aa74fc4c6901bb55ecb210c00e6538ffea0785520f73e641fb5bfa0243e20af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/844e2c89fdb6bd78180fed564492f99dbac907baab277cfbd4efddf6f9862b49562887b224487891f415bc5167d50c3972e7a6dced5a80e0fc2a35164f8d9c4f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a61055d212af2f1a9da3414098b1d4332faf225786c432246c38b94a3c58a82c0747ce0bc148ff51d8f57362aa491f0c9f163a163cd16cc8b08dd6c5628c3e1b"} 11:11:30 INFO - Running post-run listener: copy_logs_to_upload_dir 11:11:30 INFO - Copying logs to upload dir... 11:11:30 INFO - mkdir: /builds/slave/test/build/upload/logs 11:11:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.531899 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-11-14 11:11:29.843789) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 11:11:29.846939) ========= 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=652eb03db935cfc1c15ebda0000001ad-1479149452.94839-805848729 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/8b0cdbac843b5d8ef4a571d0b7a5666515bb040cf5a55347902c8a67a754fce51aa74fc4c6901bb55ecb210c00e6538ffea0785520f73e641fb5bfa0243e20af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/844e2c89fdb6bd78180fed564492f99dbac907baab277cfbd4efddf6f9862b49562887b224487891f415bc5167d50c3972e7a6dced5a80e0fc2a35164f8d9c4f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a61055d212af2f1a9da3414098b1d4332faf225786c432246c38b94a3c58a82c0747ce0bc148ff51d8f57362aa491f0c9f163a163cd16cc8b08dd6c5628c3e1b"} build_url:https://queue.taskcluster.net/v1/task/Zw4L7bX4SnawuKWOZkFitQ/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011747 build_url: 'https://queue.taskcluster.net/v1/task/Zw4L7bX4SnawuKWOZkFitQ/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/8b0cdbac843b5d8ef4a571d0b7a5666515bb040cf5a55347902c8a67a754fce51aa74fc4c6901bb55ecb210c00e6538ffea0785520f73e641fb5bfa0243e20af", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/844e2c89fdb6bd78180fed564492f99dbac907baab277cfbd4efddf6f9862b49562887b224487891f415bc5167d50c3972e7a6dced5a80e0fc2a35164f8d9c4f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a61055d212af2f1a9da3414098b1d4332faf225786c432246c38b94a3c58a82c0747ce0bc148ff51d8f57362aa491f0c9f163a163cd16cc8b08dd6c5628c3e1b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 11:11:29.872714) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:11:29.873043) ========= 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=652eb03db935cfc1c15ebda0000001ad-1479149452.94839-805848729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004444 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 11:11:29.956355) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 11:11:29.956672) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 11:11:29.956973) ========= ========= Total master_lag: 0.16 =========