builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-056 starttime: 1484675872.1 results: success (0) buildid: 20170117082323 builduid: 2e25c7f9115c4702a00748e9cf4bbbc4 revision: 412036d99f78afc1e68c1d7088a3ce1fa275405e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-17 09:57:52.095902) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-17 09:57:52.096343) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-17 09:57:52.096749) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-17 09:57:52.111835) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 09:57:52.112172) ========= 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=52faae308a556c440401f8e5000001e8-1484675299.809550-2129882312 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-17 09:57:53-- 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% 37.9M=0s 2017-01-17 09:57:53 (37.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.109800 ========= master_lag: 0.23 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 09:57:52.454550) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 09:57:52.455167) ========= 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=52faae308a556c440401f8e5000001e8-1484675299.809550-2129882312 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015119 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 09:57:52.518485) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 09:57:52.518846) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 412036d99f78afc1e68c1d7088a3ce1fa275405e --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 412036d99f78afc1e68c1d7088a3ce1fa275405e --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=52faae308a556c440401f8e5000001e8-1484675299.809550-2129882312 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-17 09:57:54,216 truncating revision to first 12 chars 2017-01-17 09:57:54,216 Setting DEBUG logging. 2017-01-17 09:57:54,216 attempt 1/10 2017-01-17 09:57:54,216 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/412036d99f78?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-17 09:57:54,573 unpacking tar archive at: mozilla-aurora-412036d99f78/testing/mozharness/ program finished with exit code 0 elapsedTime=0.646787 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 09:57:53.192383) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-17 09:57:53.192752) ========= script_repo_revision: 412036d99f78afc1e68c1d7088a3ce1fa275405e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-17 09:57:53.193268) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-17 09:57:53.193624) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-17 09:57:53.205269) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-01-17 09:57:53.205783) ========= /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=52faae308a556c440401f8e5000001e8-1484675299.809550-2129882312 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:57:54 INFO - MultiFileLogger online at 20170117 09:57:54 in /builds/slave/test 09:57: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 09:57:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:57:54 INFO - {'append_to_log': False, 09:57:54 INFO - 'base_work_dir': '/builds/slave/test', 09:57:54 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:57:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:57:54 INFO - 'branch': 'Mozilla-Aurora', 09:57:54 INFO - 'buildbot_json_path': 'buildprops.json', 09:57:54 INFO - 'config_files': ('talos/linux_config.py',), 09:57:54 INFO - 'default_actions': ('clobber', 09:57:54 INFO - 'read-buildbot-config', 09:57:54 INFO - 'download-and-extract', 09:57:54 INFO - 'populate-webroot', 09:57:54 INFO - 'create-virtualenv', 09:57:54 INFO - 'install', 09:57:54 INFO - 'run-tests'), 09:57:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:57:54 INFO - 'download_minidump_stackwalk': True, 09:57:54 INFO - 'download_symbols': 'ondemand', 09:57:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:57:54 INFO - 'tooltool.py': '/tools/tooltool.py', 09:57:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:57:54 INFO - '/tools/misc-python/virtualenv.py')}, 09:57:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:57:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:57:54 INFO - 'installer_path': 'installer.exe', 09:57:54 INFO - 'log_level': 'info', 09:57:54 INFO - 'log_name': 'talos', 09:57:54 INFO - 'log_to_console': True, 09:57:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:57:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:57:54 INFO - 'opt_config_files': (), 09:57:54 INFO - 'pip_index': False, 09:57:54 INFO - 'sps_profile': False, 09:57:54 INFO - 'sps_profile_interval': 0, 09:57:54 INFO - 'suite': 'dromaeojs', 09:57:54 INFO - 'system_bits': '32', 09:57:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:57:54 INFO - 'title': 'talos-linux64-ix-056', 09:57:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:57:54 INFO - 'use_talos_json': True, 09:57:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:57:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:57:54 INFO - 'work_dir': 'build'} 09:57:54 INFO - [mozharness: 2017-01-17 17:57:54.992578Z] Running clobber step. 09:57:54 INFO - Running pre-action listener: _resource_record_pre_action 09:57:54 INFO - Running main action method: clobber 09:57:54 INFO - rmtree: /builds/slave/test/build 09:57:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:57:55 INFO - Running post-action listener: _resource_record_post_action 09:57:55 INFO - [mozharness: 2017-01-17 17:57:55.990457Z] Finished clobber step (success) 09:57:55 INFO - [mozharness: 2017-01-17 17:57:55.990557Z] Running read-buildbot-config step. 09:57:55 INFO - Running pre-action listener: _resource_record_pre_action 09:57:55 INFO - Running main action method: read_buildbot_config 09:57:55 INFO - Using buildbot properties: 09:57:55 INFO - { 09:57:55 INFO - "project": "", 09:57:55 INFO - "product": "firefox", 09:57:55 INFO - "script_repo_revision": "production", 09:57:55 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:57:55 INFO - "repository": "", 09:57:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 09:57:55 INFO - "buildid": "20170117082323", 09:57:55 INFO - "pgo_build": "True", 09:57:55 INFO - "basedir": "/builds/slave/test", 09:57:55 INFO - "buildnumber": 1010, 09:57:55 INFO - "slavename": "talos-linux64-ix-056", 09:57:55 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:57:55 INFO - "platform": "ubuntu64_hw", 09:57:55 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 09:57:55 INFO - "branch": "mozilla-aurora", 09:57:55 INFO - "repo_path": "releases/mozilla-aurora", 09:57:55 INFO - "revision": "412036d99f78afc1e68c1d7088a3ce1fa275405e", 09:57:55 INFO - "stage_platform": "linux64-pgo", 09:57:55 INFO - "builduid": "2e25c7f9115c4702a00748e9cf4bbbc4", 09:57:55 INFO - "slavebuilddir": "test" 09:57:55 INFO - } 09:57:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/Gv1monBCSVelJN1Ib5FKqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 09:57:55 INFO - Running post-action listener: _resource_record_post_action 09:57:55 INFO - [mozharness: 2017-01-17 17:57:55.993011Z] Finished read-buildbot-config step (success) 09:57:55 INFO - [mozharness: 2017-01-17 17:57:55.993100Z] Running download-and-extract step. 09:57:55 INFO - Running pre-action listener: _resource_record_pre_action 09:57:55 INFO - Running main action method: download_and_extract 09:57:55 INFO - mkdir: /builds/slave/test/build/tests 09:57: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')]} 09:57:55 INFO - trying https://queue.taskcluster.net/v1/task/Gv1monBCSVelJN1Ib5FKqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:57:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Gv1monBCSVelJN1Ib5FKqA/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 09:57:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Gv1monBCSVelJN1Ib5FKqA/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 09:57:56 INFO - Downloaded 1361 bytes. 09:57:56 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 09:57:56 INFO - Using the following test package requirements: 09:57:56 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 09:57:56 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 09:57:56 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 09:57:56 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:56 INFO - u'jsshell-linux-x86_64.zip'], 09:57:56 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 09:57:56 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 09:57:56 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 09:57:56 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 09:57:56 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 09:57:56 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 09:57:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 09:57:56 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:57:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Gv1monBCSVelJN1Ib5FKqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 09:57:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gv1monBCSVelJN1Ib5FKqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:57:56 INFO - Fetch https://queue.taskcluster.net/v1/task/Gv1monBCSVelJN1Ib5FKqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:57:57 INFO - Http code: 200 09:57:57 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 09:57:57 INFO - x-amz-cf-id: IzpgxSDaVJgOqWNMKoI-5Hn-DM79J_9GxD47X3xfvyPDxUWV5kkMgA== 09:57:57 INFO - x-amz-version-id: VvZmo3YC8oJhgtY1XslMTbmxOPXVWkKs 09:57:58 INFO - Expected file size: 21948774 09:57:58 INFO - Obtained file size: 21948774 09:58:02 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 09:58:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Gv1monBCSVelJN1Ib5FKqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 09:58:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gv1monBCSVelJN1Ib5FKqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:58:02 INFO - Fetch https://queue.taskcluster.net/v1/task/Gv1monBCSVelJN1Ib5FKqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 09:58:02 INFO - Http code: 200 09:58:02 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 09:58:02 INFO - x-amz-cf-id: WNmMLZCZeaP5kelujuNfO-63lCVCtkKOorqpp5A655P3-p6XOVnE5A== 09:58:02 INFO - x-amz-version-id: VvZmo3YC8oJhgtY1XslMTbmxOPXVWkKs 09:58:03 INFO - Expected file size: 21948774 09:58:03 INFO - Obtained file size: 21948774 09:58:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Gv1monBCSVelJN1Ib5FKqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 09:58:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Gv1monBCSVelJN1Ib5FKqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:58:08 INFO - Fetch https://queue.taskcluster.net/v1/task/Gv1monBCSVelJN1Ib5FKqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 09:58:08 INFO - Http code: 200 09:58:08 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 09:58:08 INFO - x-amz-cf-id: nEbF9Z-lrjuJqpxJbzE2ZLY3C6kaF-O31TU2UqDy-xGfX5Wj9a4eOA== 09:58:08 INFO - x-amz-version-id: ydtvu05Pqlexq0ugRotnLYpZtLgkpIYX 09:58:09 INFO - Expected file size: 14409038 09:58:09 INFO - Obtained file size: 14409038 09:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:09 INFO - trying https://queue.taskcluster.net/v1/task/Gv1monBCSVelJN1Ib5FKqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:58:09 INFO - Downloading https://queue.taskcluster.net/v1/task/Gv1monBCSVelJN1Ib5FKqA/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 09:58:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Gv1monBCSVelJN1Ib5FKqA/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 09:58:13 INFO - Downloaded 64163422 bytes. 09:58:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Gv1monBCSVelJN1Ib5FKqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:58:13 INFO - mkdir: /builds/slave/test/properties 09:58:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:58:13 INFO - Writing to file /builds/slave/test/properties/build_url 09:58:13 INFO - Contents: 09:58:13 INFO - build_url:https://queue.taskcluster.net/v1/task/Gv1monBCSVelJN1Ib5FKqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 09:58:14 INFO - Running post-action listener: _resource_record_post_action 09:58:14 INFO - Running post-action listener: set_extra_try_arguments 09:58:14 INFO - [mozharness: 2017-01-17 17:58:14.651251Z] Finished download-and-extract step (success) 09:58:14 INFO - [mozharness: 2017-01-17 17:58:14.651475Z] Running populate-webroot step. 09:58:14 INFO - Running pre-action listener: _resource_record_pre_action 09:58:14 INFO - Running main action method: populate_webroot 09:58:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:58:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:58:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:58:14 INFO - '--tppagecycles', 09:58:14 INFO - '7'], 09:58:14 INFO - 'tests': ['tsvgm']}}, 09:58:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:58:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:58:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:58:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:58:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:58:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:58:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:14 INFO - 'talos_options': ['--disable-e10s'], 09:58:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:58:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:58:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:14 INFO - 'talos_options': ['--disable-e10s'], 09:58:14 INFO - 'tests': ['damp', 'tps']}, 09:58:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:14 INFO - 'tests': ['damp', 'tps']}, 09:58:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:58:14 INFO - 'tests': ['dromaeo_dom']}, 09:58:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:58:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:58:14 INFO - 'tests': ['basic_compositor_video']}, 09:58:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:58:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:58:14 INFO - 'tests': ['a11yr', 09:58:14 INFO - 'ts_paint', 09:58:14 INFO - 'tpaint', 09:58:14 INFO - 'sessionrestore', 09:58:14 INFO - 'sessionrestore_no_auto_restore', 09:58:14 INFO - 'tabpaint']}, 09:58:14 INFO - 'other-e10s': {'tests': ['a11yr', 09:58:14 INFO - 'ts_paint', 09:58:14 INFO - 'tpaint', 09:58:14 INFO - 'sessionrestore', 09:58:14 INFO - 'sessionrestore_no_auto_restore', 09:58:14 INFO - 'tabpaint']}, 09:58:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:58:14 INFO - 'ts_paint', 09:58:14 INFO - 'tpaint', 09:58:14 INFO - 'sessionrestore', 09:58:14 INFO - 'sessionrestore_no_auto_restore', 09:58:14 INFO - 'tabpaint']}, 09:58:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:58:14 INFO - 'ts_paint', 09:58:14 INFO - 'tpaint', 09:58:14 INFO - 'sessionrestore', 09:58:14 INFO - 'sessionrestore_no_auto_restore', 09:58:14 INFO - 'tabpaint']}, 09:58:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:58:14 INFO - 'tests': ['a11yr', 09:58:14 INFO - 'ts_paint', 09:58:14 INFO - 'tpaint', 09:58:14 INFO - 'sessionrestore', 09:58:14 INFO - 'sessionrestore_no_auto_restore', 09:58:14 INFO - 'tabpaint']}, 09:58:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:58:14 INFO - 'tests': ['a11yr', 09:58:14 INFO - 'ts_paint', 09:58:14 INFO - 'tpaint', 09:58:14 INFO - 'sessionrestore', 09:58:14 INFO - 'sessionrestore_no_auto_restore', 09:58:14 INFO - 'tabpaint']}, 09:58:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:58:14 INFO - 'tests': ['tsvgx', 09:58:14 INFO - 'tsvgr_opacity', 09:58:14 INFO - 'tart', 09:58:14 INFO - 'tscrollx', 09:58:14 INFO - 'cart']}, 09:58:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:58:14 INFO - 'tsvgr_opacity', 09:58:14 INFO - 'tart', 09:58:14 INFO - 'tscrollx', 09:58:14 INFO - 'cart']}, 09:58:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:14 INFO - 'talos_options': ['--disable-e10s'], 09:58:14 INFO - 'tests': ['tp5o']}, 09:58:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:14 INFO - 'tests': ['tp5o']}, 09:58:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:14 INFO - 'talos_options': ['--disable-e10s', 09:58:14 INFO - '--xperf_path', 09:58:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:58:14 INFO - 'tests': ['tp5n']}, 09:58:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:58:14 INFO - 'talos_options': ['--xperf_path', 09:58:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:58:14 INFO - 'tests': ['tp5n']}}, 09:58:14 INFO - 'talos.zip': {'path': '', 09:58:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:58:14 INFO - Running post-action listener: _resource_record_post_action 09:58:14 INFO - [mozharness: 2017-01-17 17:58:14.666713Z] Finished populate-webroot step (success) 09:58:14 INFO - [mozharness: 2017-01-17 17:58:14.666801Z] Running create-virtualenv step. 09:58:14 INFO - Running pre-action listener: _resource_record_pre_action 09:58:14 INFO - Running main action method: create_virtualenv 09:58:14 INFO - Creating virtualenv /builds/slave/test/build/venv 09:58:14 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 09:58:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:58:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:58:14 INFO - Using real prefix '/usr' 09:58:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:58:15 INFO - Installing distribute.............................................................................................................................................................................................done. 09:58:17 INFO - Installing pip.................done. 09:58:17 INFO - Return code: 0 09:58:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:58:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:58:17 INFO - Reading from file tmpfile_stdout 09:58:17 INFO - Output received: 09:58:17 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) 09:58:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:58: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')]} 09:58:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58: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')]} 09:58:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2ee67a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2069ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2066f60>, '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 0x2067d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20681d0>, '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': '52faae308a556c440401f8e5000001e8-1484675299.809550-2129882312', '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 09:58: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', 'pip>=1.5'] in /builds/slave/test/build 09:58: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 pip>=1.5 09:58:17 INFO - Using env: {'DISPLAY': ':0', 09:58:17 INFO - 'HOME': '/home/cltbld', 09:58:17 INFO - 'LANG': 'en_US.UTF-8', 09:58:17 INFO - 'LANGUAGE': 'en_US:en', 09:58:17 INFO - 'LOGNAME': 'cltbld', 09:58:17 INFO - 'MAIL': '/var/mail/cltbld', 09:58:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:17 INFO - 'MOZ_NO_REMOTE': '1', 09:58:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:17 INFO - 'NO_EM_RESTART': '1', 09:58:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:17 INFO - 'PWD': '/builds/slave/test', 09:58:17 INFO - 'SHELL': '/bin/bash', 09:58:17 INFO - 'SHLVL': '1', 09:58:17 INFO - 'TERM': 'linux', 09:58:17 INFO - 'TMOUT': '86400', 09:58:17 INFO - 'USER': 'cltbld', 09:58:17 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1484675299.809550-2129882312', 09:58:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:17 INFO - '_': '/tools/buildbot/bin/python'} 09:58:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:17 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 09:58:17 INFO - Cleaning up... 09:58:17 INFO - Return code: 0 09:58:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:58: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')]} 09:58:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58: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')]} 09:58:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:18 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 0x7f2ee67a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2069ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2066f60>, '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 0x2067d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20681d0>, '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': '52faae308a556c440401f8e5000001e8-1484675299.809550-2129882312', '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 09:58:18 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 09:58:18 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 09:58:18 INFO - Using env: {'DISPLAY': ':0', 09:58:18 INFO - 'HOME': '/home/cltbld', 09:58:18 INFO - 'LANG': 'en_US.UTF-8', 09:58:18 INFO - 'LANGUAGE': 'en_US:en', 09:58:18 INFO - 'LOGNAME': 'cltbld', 09:58:18 INFO - 'MAIL': '/var/mail/cltbld', 09:58:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:18 INFO - 'MOZ_NO_REMOTE': '1', 09:58:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:18 INFO - 'NO_EM_RESTART': '1', 09:58:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:18 INFO - 'PWD': '/builds/slave/test', 09:58:18 INFO - 'SHELL': '/bin/bash', 09:58:18 INFO - 'SHLVL': '1', 09:58:18 INFO - 'TERM': 'linux', 09:58:18 INFO - 'TMOUT': '86400', 09:58:18 INFO - 'USER': 'cltbld', 09:58:18 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1484675299.809550-2129882312', 09:58:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:18 INFO - '_': '/tools/buildbot/bin/python'} 09:58:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:18 INFO - Downloading/unpacking psutil>=3.1.1 09:58:18 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 09:58:18 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 09:58:18 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 09:58:18 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 09:58:18 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 09:58:18 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 09:58:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:58:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:58:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:58:21 INFO - Installing collected packages: psutil 09:58:21 INFO - Running setup.py install for psutil 09:58:21 INFO - building 'psutil._psutil_linux' extension 09:58:21 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 09:58:21 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 09:58:22 INFO - building 'psutil._psutil_posix' extension 09:58:22 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 09:58:22 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 09:58:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:58:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:58:22 INFO - Successfully installed psutil 09:58:22 INFO - Cleaning up... 09:58:22 INFO - Return code: 0 09:58:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:58:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2ee67a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2069ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2066f60>, '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 0x2067d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20681d0>, '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': '52faae308a556c440401f8e5000001e8-1484675299.809550-2129882312', '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 09:58:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:58:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:58:22 INFO - Using env: {'DISPLAY': ':0', 09:58:22 INFO - 'HOME': '/home/cltbld', 09:58:22 INFO - 'LANG': 'en_US.UTF-8', 09:58:22 INFO - 'LANGUAGE': 'en_US:en', 09:58:22 INFO - 'LOGNAME': 'cltbld', 09:58:22 INFO - 'MAIL': '/var/mail/cltbld', 09:58:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:22 INFO - 'MOZ_NO_REMOTE': '1', 09:58:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:22 INFO - 'NO_EM_RESTART': '1', 09:58:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:22 INFO - 'PWD': '/builds/slave/test', 09:58:22 INFO - 'SHELL': '/bin/bash', 09:58:22 INFO - 'SHLVL': '1', 09:58:22 INFO - 'TERM': 'linux', 09:58:22 INFO - 'TMOUT': '86400', 09:58:22 INFO - 'USER': 'cltbld', 09:58:22 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1484675299.809550-2129882312', 09:58:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:22 INFO - '_': '/tools/buildbot/bin/python'} 09:58:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:58: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 09:58: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 09:58: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 09:58: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 09:58: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 09:58: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 09:58:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:58:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:58:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:58:24 INFO - Installing collected packages: mozsystemmonitor 09:58:24 INFO - Running setup.py install for mozsystemmonitor 09:58:24 INFO - Successfully installed mozsystemmonitor 09:58:24 INFO - Cleaning up... 09:58:24 INFO - Return code: 0 09:58:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:58: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')]} 09:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58: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')]} 09:58:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2ee67a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2069ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2066f60>, '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 0x2067d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20681d0>, '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': '52faae308a556c440401f8e5000001e8-1484675299.809550-2129882312', '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 09:58:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:58:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:58:24 INFO - Using env: {'DISPLAY': ':0', 09:58:24 INFO - 'HOME': '/home/cltbld', 09:58:24 INFO - 'LANG': 'en_US.UTF-8', 09:58:24 INFO - 'LANGUAGE': 'en_US:en', 09:58:24 INFO - 'LOGNAME': 'cltbld', 09:58:24 INFO - 'MAIL': '/var/mail/cltbld', 09:58:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:24 INFO - 'MOZ_NO_REMOTE': '1', 09:58:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:24 INFO - 'NO_EM_RESTART': '1', 09:58:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:24 INFO - 'PWD': '/builds/slave/test', 09:58:24 INFO - 'SHELL': '/bin/bash', 09:58:24 INFO - 'SHLVL': '1', 09:58:24 INFO - 'TERM': 'linux', 09:58:24 INFO - 'TMOUT': '86400', 09:58:24 INFO - 'USER': 'cltbld', 09:58:24 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1484675299.809550-2129882312', 09:58:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:24 INFO - '_': '/tools/buildbot/bin/python'} 09:58:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:24 INFO - Downloading/unpacking jsonschema==2.5.1 09:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:58:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:26 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 09:58:26 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 09:58:26 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 09:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:26 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 09:58:27 INFO - Downloading functools32-3.2.3-2.tar.gz 09:58:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:58:27 INFO - warning: no files found matching '*.txt' 09:58:27 INFO - no previously-included directories found matching 'build' 09:58:27 INFO - no previously-included directories found matching 'dist' 09:58:27 INFO - no previously-included directories found matching '.git*' 09:58:27 INFO - Installing collected packages: jsonschema, functools32 09:58:27 INFO - Running setup.py install for functools32 09:58:27 INFO - warning: no files found matching '*.txt' 09:58:27 INFO - no previously-included directories found matching 'build' 09:58:27 INFO - no previously-included directories found matching 'dist' 09:58:27 INFO - no previously-included directories found matching '.git*' 09:58:27 INFO - Successfully installed jsonschema functools32 09:58:27 INFO - Cleaning up... 09:58:27 INFO - Return code: 0 09:58:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:58: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')]} 09:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58: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')]} 09:58:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:27 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 0x7f2ee67a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2069ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2066f60>, '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 0x2067d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20681d0>, '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': '52faae308a556c440401f8e5000001e8-1484675299.809550-2129882312', '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 09:58:27 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 09:58:27 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 09:58:27 INFO - Using env: {'DISPLAY': ':0', 09:58:27 INFO - 'HOME': '/home/cltbld', 09:58:27 INFO - 'LANG': 'en_US.UTF-8', 09:58:27 INFO - 'LANGUAGE': 'en_US:en', 09:58:27 INFO - 'LOGNAME': 'cltbld', 09:58:27 INFO - 'MAIL': '/var/mail/cltbld', 09:58:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:27 INFO - 'MOZ_NO_REMOTE': '1', 09:58:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:27 INFO - 'NO_EM_RESTART': '1', 09:58:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:27 INFO - 'PWD': '/builds/slave/test', 09:58:27 INFO - 'SHELL': '/bin/bash', 09:58:27 INFO - 'SHLVL': '1', 09:58:27 INFO - 'TERM': 'linux', 09:58:27 INFO - 'TMOUT': '86400', 09:58:27 INFO - 'USER': 'cltbld', 09:58:27 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1484675299.809550-2129882312', 09:58:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:27 INFO - '_': '/tools/buildbot/bin/python'} 09:58:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:58:27 INFO - Cleaning up... 09:58:27 INFO - Return code: 0 09:58:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:58: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')]} 09:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58: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')]} 09:58:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:27 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 0x7f2ee67a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2069ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2066f60>, '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 0x2067d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20681d0>, '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': '52faae308a556c440401f8e5000001e8-1484675299.809550-2129882312', '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 09:58:27 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 09:58:27 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 09:58:27 INFO - Using env: {'DISPLAY': ':0', 09:58:27 INFO - 'HOME': '/home/cltbld', 09:58:27 INFO - 'LANG': 'en_US.UTF-8', 09:58:27 INFO - 'LANGUAGE': 'en_US:en', 09:58:27 INFO - 'LOGNAME': 'cltbld', 09:58:27 INFO - 'MAIL': '/var/mail/cltbld', 09:58:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:27 INFO - 'MOZ_NO_REMOTE': '1', 09:58:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:27 INFO - 'NO_EM_RESTART': '1', 09:58:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:27 INFO - 'PWD': '/builds/slave/test', 09:58:27 INFO - 'SHELL': '/bin/bash', 09:58:27 INFO - 'SHLVL': '1', 09:58:27 INFO - 'TERM': 'linux', 09:58:27 INFO - 'TMOUT': '86400', 09:58:27 INFO - 'USER': 'cltbld', 09:58:27 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1484675299.809550-2129882312', 09:58:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:27 INFO - '_': '/tools/buildbot/bin/python'} 09:58:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:28 INFO - Downloading/unpacking blobuploader==1.2.4 09:58: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 09:58: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 09:58: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 09:58: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 09:58: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 09:58: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 09:58:30 INFO - Downloading blobuploader-1.2.4.tar.gz 09:58:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:58:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:58:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:58:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:58:31 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 09:58:31 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 09:58:31 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 09:58:31 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 09:58:31 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 09:58:31 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 09:58:31 INFO - Downloading docopt-0.6.1.tar.gz 09:58:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:58:31 INFO - Installing collected packages: blobuploader, requests, docopt 09:58:31 INFO - Running setup.py install for blobuploader 09:58:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:58:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:58:31 INFO - Running setup.py install for requests 09:58:32 INFO - Running setup.py install for docopt 09:58:32 INFO - Successfully installed blobuploader requests docopt 09:58:32 INFO - Cleaning up... 09:58:32 INFO - Return code: 0 09:58:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:32 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 0x7f2ee67a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2069ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2066f60>, '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 0x2067d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20681d0>, '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': '52faae308a556c440401f8e5000001e8-1484675299.809550-2129882312', '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 09:58:32 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 09:58:32 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 09:58:32 INFO - Using env: {'DISPLAY': ':0', 09:58:32 INFO - 'HOME': '/home/cltbld', 09:58:32 INFO - 'LANG': 'en_US.UTF-8', 09:58:32 INFO - 'LANGUAGE': 'en_US:en', 09:58:32 INFO - 'LOGNAME': 'cltbld', 09:58:32 INFO - 'MAIL': '/var/mail/cltbld', 09:58:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:32 INFO - 'MOZ_NO_REMOTE': '1', 09:58:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:32 INFO - 'NO_EM_RESTART': '1', 09:58:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:32 INFO - 'PWD': '/builds/slave/test', 09:58:32 INFO - 'SHELL': '/bin/bash', 09:58:32 INFO - 'SHLVL': '1', 09:58:32 INFO - 'TERM': 'linux', 09:58:32 INFO - 'TMOUT': '86400', 09:58:32 INFO - 'USER': 'cltbld', 09:58:32 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1484675299.809550-2129882312', 09:58:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:32 INFO - '_': '/tools/buildbot/bin/python'} 09:58:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:58:32 INFO - Running setup.py (path:/tmp/pip-Gh7753-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:58:32 INFO - Running setup.py (path:/tmp/pip-9KQtMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:58:32 INFO - Running setup.py (path:/tmp/pip-mOkX2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:58:32 INFO - Running setup.py (path:/tmp/pip-RPDllW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:58:32 INFO - Running setup.py (path:/tmp/pip-NQTAr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:58:32 INFO - Running setup.py (path:/tmp/pip-XJtQe1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:58:32 INFO - Running setup.py (path:/tmp/pip-Rolr5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:58:32 INFO - Running setup.py (path:/tmp/pip-mcsTQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:58:33 INFO - Running setup.py (path:/tmp/pip-9jVn5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:58:33 INFO - Running setup.py (path:/tmp/pip-fnJJRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:58:33 INFO - Running setup.py (path:/tmp/pip-jJ_y8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:58:33 INFO - Running setup.py (path:/tmp/pip-d_RIt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:58:33 INFO - Running setup.py (path:/tmp/pip-wi3IIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:58:33 INFO - Running setup.py (path:/tmp/pip-Kim9p0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:33 INFO - Running setup.py (path:/tmp/pip-CTx_6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:58:33 INFO - Running setup.py (path:/tmp/pip-fyJPJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:58:33 INFO - Running setup.py (path:/tmp/pip-8sx2Nh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:58:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:58:33 INFO - Running setup.py install for manifestparser 09:58:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:58:33 INFO - Running setup.py install for mozcrash 09:58:33 INFO - Running setup.py install for mozdebug 09:58:34 INFO - Running setup.py install for mozdevice 09:58:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:58:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:58:34 INFO - Running setup.py install for mozfile 09:58:34 INFO - Running setup.py install for mozhttpd 09:58:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:58:34 INFO - Running setup.py install for mozinfo 09:58:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:58:34 INFO - Running setup.py install for mozInstall 09:58:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:58:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:58:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:58:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:58:34 INFO - Running setup.py install for mozleak 09:58:34 INFO - Running setup.py install for mozlog 09:58:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:58:34 INFO - Running setup.py install for moznetwork 09:58:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:58:34 INFO - Running setup.py install for mozprocess 09:58:34 INFO - Running setup.py install for mozprofile 09:58:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:58:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:58:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:58:35 INFO - Running setup.py install for mozrunner 09:58:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:58:35 INFO - Running setup.py install for mozscreenshot 09:58:35 INFO - Running setup.py install for moztest 09:58:35 INFO - Running setup.py install for mozversion 09:58:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:58:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:58:35 INFO - Cleaning up... 09:58:35 INFO - Return code: 0 09:58:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:58:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:35 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 0x7f2ee67a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2069ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2066f60>, '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 0x2067d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20681d0>, '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': '52faae308a556c440401f8e5000001e8-1484675299.809550-2129882312', '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 09:58:35 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 09:58:35 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 09:58:35 INFO - Using env: {'DISPLAY': ':0', 09:58:35 INFO - 'HOME': '/home/cltbld', 09:58:35 INFO - 'LANG': 'en_US.UTF-8', 09:58:35 INFO - 'LANGUAGE': 'en_US:en', 09:58:35 INFO - 'LOGNAME': 'cltbld', 09:58:35 INFO - 'MAIL': '/var/mail/cltbld', 09:58:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:35 INFO - 'MOZ_NO_REMOTE': '1', 09:58:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:35 INFO - 'NO_EM_RESTART': '1', 09:58:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:35 INFO - 'PWD': '/builds/slave/test', 09:58:35 INFO - 'SHELL': '/bin/bash', 09:58:35 INFO - 'SHLVL': '1', 09:58:35 INFO - 'TERM': 'linux', 09:58:35 INFO - 'TMOUT': '86400', 09:58:35 INFO - 'USER': 'cltbld', 09:58:35 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1484675299.809550-2129882312', 09:58:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:35 INFO - '_': '/tools/buildbot/bin/python'} 09:58:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:58:35 INFO - Running setup.py (path:/tmp/pip-K72SUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:58:35 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)) 09:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:58:35 INFO - Running setup.py (path:/tmp/pip-W2Alyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:58:35 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)) 09:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:58:35 INFO - Running setup.py (path:/tmp/pip-J0vKie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:58:35 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)) 09:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:58:35 INFO - Running setup.py (path:/tmp/pip-Tfc_Ax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:58:36 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)) 09:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:58:36 INFO - Running setup.py (path:/tmp/pip-IJG79G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:58:36 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)) 09:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:58:36 INFO - Running setup.py (path:/tmp/pip-oa5H5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:58:36 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)) 09:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:58:36 INFO - Running setup.py (path:/tmp/pip-CDp0R2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:58:36 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)) 09:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:58:36 INFO - Running setup.py (path:/tmp/pip-Ncm5fX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:58:36 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)) 09:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:58:36 INFO - Running setup.py (path:/tmp/pip-ok_AzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:58:36 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)) 09:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:58:36 INFO - Running setup.py (path:/tmp/pip-85zEoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:58:36 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)) 09:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:58:36 INFO - Running setup.py (path:/tmp/pip-CxYwIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:58:36 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)) 09:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:58:36 INFO - Running setup.py (path:/tmp/pip-oJWuTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:58:36 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)) 09:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:58:36 INFO - Running setup.py (path:/tmp/pip-jLJnY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:58:36 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)) 09:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:58:36 INFO - Running setup.py (path:/tmp/pip-52WOAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:58:36 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)) 09:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:36 INFO - Running setup.py (path:/tmp/pip-rvfuCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:58:36 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)) 09:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:58:36 INFO - Running setup.py (path:/tmp/pip-rJvvbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:58:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:58:36 INFO - Running setup.py (path:/tmp/pip-g4MCnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:58:37 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)) 09:58:37 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)) 09:58:37 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)) 09:58:37 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)) 09:58:37 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)) 09:58:37 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)) 09:58:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:58:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:58:39 INFO - Downloading blessings-1.6.tar.gz 09:58:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:58:39 INFO - Installing collected packages: blessings 09:58:39 INFO - Running setup.py install for blessings 09:58:39 INFO - Successfully installed blessings 09:58:39 INFO - Cleaning up... 09:58:39 INFO - Return code: 0 09:58:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:58:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:58:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:58:39 INFO - Reading from file tmpfile_stdout 09:58:39 INFO - Current package versions: 09:58:39 INFO - argparse == 1.2.1 09:58:39 INFO - blessings == 1.6 09:58:39 INFO - blobuploader == 1.2.4 09:58:39 INFO - docopt == 0.6.1 09:58:39 INFO - functools32 == 3.2.3-2 09:58:39 INFO - jsonschema == 2.5.1 09:58:39 INFO - manifestparser == 1.1 09:58:39 INFO - mozInstall == 1.12 09:58:39 INFO - mozcrash == 1.0 09:58:39 INFO - mozdebug == 0.1 09:58:39 INFO - mozdevice == 0.48 09:58:39 INFO - mozfile == 1.2 09:58:39 INFO - mozhttpd == 0.7 09:58:39 INFO - mozinfo == 0.9 09:58:39 INFO - mozleak == 0.1 09:58:39 INFO - mozlog == 3.4 09:58:39 INFO - moznetwork == 0.27 09:58:39 INFO - mozprocess == 0.23 09:58:39 INFO - mozprofile == 0.28 09:58:39 INFO - mozrunner == 6.13 09:58:39 INFO - mozscreenshot == 0.1 09:58:39 INFO - mozsystemmonitor == 0.3 09:58:39 INFO - moztest == 0.8 09:58:39 INFO - mozversion == 1.4 09:58:39 INFO - psutil == 3.1.1 09:58:39 INFO - requests == 1.2.3 09:58:39 INFO - wsgiref == 0.1.2 09:58:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:58:39 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')]} 09:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:39 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')]} 09:58:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:39 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 0x7f2ee67a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2069ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2066f60>, '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 0x2067d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20681d0>, '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': '52faae308a556c440401f8e5000001e8-1484675299.809550-2129882312', '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 09:58:39 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 09:58:39 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 09:58:39 INFO - Using env: {'DISPLAY': ':0', 09:58:39 INFO - 'HOME': '/home/cltbld', 09:58:39 INFO - 'LANG': 'en_US.UTF-8', 09:58:39 INFO - 'LANGUAGE': 'en_US:en', 09:58:39 INFO - 'LOGNAME': 'cltbld', 09:58:39 INFO - 'MAIL': '/var/mail/cltbld', 09:58:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:39 INFO - 'MOZ_NO_REMOTE': '1', 09:58:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:39 INFO - 'NO_EM_RESTART': '1', 09:58:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:39 INFO - 'PWD': '/builds/slave/test', 09:58:39 INFO - 'SHELL': '/bin/bash', 09:58:39 INFO - 'SHLVL': '1', 09:58:39 INFO - 'TERM': 'linux', 09:58:39 INFO - 'TMOUT': '86400', 09:58:39 INFO - 'USER': 'cltbld', 09:58:39 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1484675299.809550-2129882312', 09:58:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:39 INFO - '_': '/tools/buildbot/bin/python'} 09:58:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:39 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)) 09:58:39 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)) 09:58:39 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)) 09:58:39 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)) 09:58:39 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)) 09:58:39 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)) 09:58:39 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)) 09:58:39 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)) 09:58:39 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)) 09:58:39 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)) 09:58:39 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)) 09:58:39 INFO - Cleaning up... 09:58:39 INFO - Return code: 0 09:58:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:58:39 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')]} 09:58:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:58:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:39 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')]} 09:58:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:58:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:58:39 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 0x7f2ee67a4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f9c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2069ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2066f60>, '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 0x2067d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20681d0>, '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': '52faae308a556c440401f8e5000001e8-1484675299.809550-2129882312', '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 09:58:39 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 09:58:39 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 09:58:39 INFO - Using env: {'DISPLAY': ':0', 09:58:39 INFO - 'HOME': '/home/cltbld', 09:58:39 INFO - 'LANG': 'en_US.UTF-8', 09:58:39 INFO - 'LANGUAGE': 'en_US:en', 09:58:39 INFO - 'LOGNAME': 'cltbld', 09:58:39 INFO - 'MAIL': '/var/mail/cltbld', 09:58:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:39 INFO - 'MOZ_NO_REMOTE': '1', 09:58:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:39 INFO - 'NO_EM_RESTART': '1', 09:58:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:39 INFO - 'PWD': '/builds/slave/test', 09:58:39 INFO - 'SHELL': '/bin/bash', 09:58:39 INFO - 'SHLVL': '1', 09:58:39 INFO - 'TERM': 'linux', 09:58:39 INFO - 'TMOUT': '86400', 09:58:39 INFO - 'USER': 'cltbld', 09:58:39 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1484675299.809550-2129882312', 09:58:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:39 INFO - '_': '/tools/buildbot/bin/python'} 09:58:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:58:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:58:39 INFO - Cleaning up... 09:58:39 INFO - Return code: 0 09:58:39 INFO - Running post-action listener: _resource_record_post_action 09:58:39 INFO - Running post-action listener: _start_resource_monitoring 09:58:40 INFO - Starting resource monitoring. 09:58:40 INFO - [mozharness: 2017-01-17 17:58:40.014740Z] Finished create-virtualenv step (success) 09:58:40 INFO - [mozharness: 2017-01-17 17:58:40.015327Z] Running install step. 09:58:40 INFO - Running pre-action listener: _resource_record_pre_action 09:58:40 INFO - Running main action method: install 09:58:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:58:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:58:40 INFO - Reading from file tmpfile_stdout 09:58:40 INFO - Detecting whether we're running mozinstall >=1.0... 09:58:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:58:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:58:40 INFO - Reading from file tmpfile_stdout 09:58:40 INFO - Output received: 09:58:40 INFO - Usage: mozinstall [options] installer 09:58:40 INFO - Options: 09:58:40 INFO - -h, --help show this help message and exit 09:58:40 INFO - -d DEST, --destination=DEST 09:58:40 INFO - Directory to install application into. [default: 09:58:40 INFO - "/builds/slave/test"] 09:58:40 INFO - --app=APP Application being installed. [default: firefox] 09:58:40 INFO - mkdir: /builds/slave/test/build/application 09:58:40 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'] 09:58:40 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 09:58:56 INFO - Reading from file tmpfile_stdout 09:58:56 INFO - Output received: 09:58:56 INFO - /builds/slave/test/build/application/firefox/firefox 09:58:56 INFO - Running post-action listener: _resource_record_post_action 09:58:56 INFO - [mozharness: 2017-01-17 17:58:56.303498Z] Finished install step (success) 09:58:56 INFO - [mozharness: 2017-01-17 17:58:56.303739Z] Running run-tests step. 09:58:56 INFO - Running pre-action listener: _resource_record_pre_action 09:58:56 INFO - Running main action method: run_tests 09:58:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:58:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:58:56 INFO - Python 2.7.3 09:58:56 INFO - Return code: 0 09:58:56 INFO - grabbing minidump binary from tooltool 09:58:56 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')]} 09:58:56 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 0x2066f60>, '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 0x2067d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20681d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:58:56 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 09:58:56 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 09:58:56 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 09:58:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:58:56 INFO - Return code: 0 09:58:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:58:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:58:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:58:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:58:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:58:56 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/Gv1monBCSVelJN1Ib5FKqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 09:58:56 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/Gv1monBCSVelJN1Ib5FKqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --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 09:58:56 INFO - Using env: {'DISPLAY': ':0', 09:58:56 INFO - 'HOME': '/home/cltbld', 09:58:56 INFO - 'LANG': 'en_US.UTF-8', 09:58:56 INFO - 'LANGUAGE': 'en_US:en', 09:58:56 INFO - 'LOGNAME': 'cltbld', 09:58:56 INFO - 'MAIL': '/var/mail/cltbld', 09:58:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:58:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:58:56 INFO - 'MOZ_NO_REMOTE': '1', 09:58:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:58:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:58:56 INFO - 'NO_EM_RESTART': '1', 09:58:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:58:56 INFO - 'PWD': '/builds/slave/test', 09:58:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:58:56 INFO - 'SHELL': '/bin/bash', 09:58:56 INFO - 'SHLVL': '1', 09:58:56 INFO - 'TERM': 'linux', 09:58:56 INFO - 'TMOUT': '86400', 09:58:56 INFO - 'USER': 'cltbld', 09:58:56 INFO - 'XDG_SESSION_COOKIE': '52faae308a556c440401f8e5000001e8-1484675299.809550-2129882312', 09:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:58:56 INFO - '_': '/tools/buildbot/bin/python'} 09:58:56 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/Gv1monBCSVelJN1Ib5FKqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--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 09:58:56 INFO - mozversion application_buildid: 20170117082323 09:58:56 INFO - mozversion application_changeset: 412036d99f78afc1e68c1d7088a3ce1fa275405e 09:58:56 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:58:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:58:56 INFO - mozversion application_name: Firefox 09:58:56 INFO - mozversion application_remotingname: firefox-dev 09:58:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:58:56 INFO - mozversion application_vendor: Mozilla 09:58:56 INFO - mozversion application_version: 52.0a2 09:58:56 INFO - mozversion platform_buildid: 20170117082323 09:58:56 INFO - mozversion platform_changeset: 412036d99f78afc1e68c1d7088a3ce1fa275405e 09:58:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:58:56 INFO - mozversion platform_version: 52.0a2 09:58:56 INFO - using testdate: 1484675936 09:58:56 INFO - actual date: 1484675936 09:58:56 INFO - starting webserver on 'localhost:39218' 09:58:56 INFO - SUITE-START | Running 2 tests 09:58:56 INFO - TEST-START | dromaeo_css 09:58:56 INFO - operating with platform_type : linux_ 09:58:56 INFO - Initialising browser for dromaeo_css test... 09:58:56 INFO - TEST-INFO | started process 19963 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpASuzWV/profile http://localhost:39218/getInfo.html) 09:59:00 INFO - PROCESS | 19963 | __metrics Screen width/height:1600/1200 09:59:00 INFO - PROCESS | 19963 | colorDepth:24 09:59:00 INFO - PROCESS | 19963 | Browser inner width/height: 1024/697 09:59:00 INFO - PROCESS | 19963 | __metrics 09:59:01 INFO - PROCESS | 19963 | 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" 09:59:01 INFO - PROCESS | 19963 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:59:01 INFO - PROCESS | 19963 | console.error: PushService: 09:59:01 INFO - PROCESS | 19963 | stateChangeProcessEnqueue: Error transitioning state 09:59:01 INFO - PROCESS | 19963 | UnknownError 09:59:02 INFO - TEST-INFO | 19963: exit 0 09:59:02 INFO - Browser initialized. 09:59:02 INFO - Running cycle 1/1 for dromaeo_css test... 09:59:02 INFO - TEST-INFO | started process 20055 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpASuzWV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:59:14 INFO - PROCESS | 20055 | RSS: Main: 143478784 09:59:14 INFO - PROCESS | 20055 | 10:02:15 INFO - PROCESS | 20055 | Cycle 1(1): loaded http://localhost:39218/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39218/tests/dromaeo/cssquery-ext.html) 10:02:17 INFO - PROCESS | 20055 | RSS: Main: 181055488 10:02:17 INFO - PROCESS | 20055 | 10:05:19 INFO - PROCESS | 20055 | Cycle 1(1): loaded http://localhost:39218/tests/dromaeo/cssquery-ext.html (next: http://localhost:39218/tests/dromaeo/cssquery-jquery.html) 10:05:20 INFO - PROCESS | 20055 | RSS: Main: 232779776 10:05:20 INFO - PROCESS | 20055 | 10:08:22 INFO - PROCESS | 20055 | Cycle 1(1): loaded http://localhost:39218/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39218/tests/dromaeo/cssquery-mootools.html) 10:08:22 INFO - PROCESS | 20055 | RSS: Main: 172175360 10:08:22 INFO - PROCESS | 20055 | 10:11:24 INFO - PROCESS | 20055 | Cycle 1(1): loaded http://localhost:39218/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39218/tests/dromaeo/cssquery-prototype.html) 10:11:25 INFO - PROCESS | 20055 | RSS: Main: 197120000 10:11:25 INFO - PROCESS | 20055 | 10:14:28 INFO - PROCESS | 20055 | Cycle 1(1): loaded http://localhost:39218/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39218/tests/dromaeo/cssquery-yui.html) 10:14:28 INFO - PROCESS | 20055 | RSS: Main: 173539328 10:14:28 INFO - PROCESS | 20055 | 10:17:31 INFO - PROCESS | 20055 | Cycle 1(1): loaded http://localhost:39218/tests/dromaeo/cssquery-yui.html (next: http://localhost:39218/tests/dromaeo/cssquery-dojo.html) 10:17:31 INFO - PROCESS | 20055 | RSS: Main: 269758464 10:17:31 INFO - PROCESS | 20055 | 10:17:31 INFO - PROCESS | 20055 | __start_tp_report 10:17:31 INFO - PROCESS | 20055 | _x_x_mozilla_page_load 10:17:31 INFO - PROCESS | 20055 | _x_x_mozilla_page_load_details 10:17:31 INFO - PROCESS | 20055 | |i|pagename|runs| 10:17:31 INFO - PROCESS | 20055 | |0;dojo.html;3133.655297917229;3244.3511297740442;3251.8211498367596;3268.0849362178596;3294.6375898651145;5542.861428464285;5583.8604034899145;5642.181883626871;5645.915311270329;5663.207150998858;5618.522425593819;5652.660840349582;5679.346875109363;5684.801031963882;5689.374168841424;5130.384353877531;5131.179011358184;5134.640575159721;5142.151544995071;5210.713410762407;4965.28003439501;5204.089284375238;5211.088059589576;5226.92159617606;5232.686038837663;4955.876103097416;5023.547880690737;5082.923756143661;5128.358955130609;5129.410117836459;5081.491850814908;5084.186530155176;5099.107656160157;5195.064888320101;5195.506426889439;5041.344625198701;5088.669236499616;5160.561352285023;5164.586833053384;5185.481451854822;5411.702356370398;5417.674939503642;5476.151196564539;5484.780608775644;5590.273264475592;5925.992581261196;5933.258342707161;5939.821805345847;6028.608140470899;6034.6982650867285;6053.667048312341;6068.241469816273;6076.210092687967;6077.422644848776;6087.421694938974;5518.255035570227;5545.833624991256;5563.610547261694;5669.064604340238;5750.597458177887;6201.627902325785;6206.193194884636;6238.438540531374;6242.063690446469;6246.3441338659695;5978.1929439525975;5988.161657367972;5988.820335389945;5989.251343582052;6010.338862725097;5811.535077193815;5870.207521984563;5934.347221805598;6028.246469191351;6050.909236361458;6094.39056094387;6102.389761023862;6102.389761023951;6122.479589234965;6124.0201567748945;6055.969720151459;6109.419605137505;6119;6121.357257487989;6127.356627554132;4483.708558943658;4526.049529598821;4536.659750518725;4611.031683346468;4673.7429441381055;4114.280000999813;4153.169366126726;4169.499660040754;4174.77038762871;4176.582341765799;5613.691246981455;5614.017546929353;5637.041702910515;5658.660480371191;5660.773569057192;5749.338826034976;5789.073748200268;5862.765489380462;5979.970100149471;5993.190919225936;5645.2096706461125;5646.20953066571;5647.068233741386;5664.178694089416;5678.517326027334;5075.796968121308;5092.439831618519;5093.516115968977;5099.6685215460875;5142.331496905378;6092.482139018056;6125.1424800527075;6175.413335733008;6231.813045608639;6239.937600623935;5992.221011268682;6059.424354686298;6136.539759517965;6173.259208894961;6193.4425901669065;6397.040443933447;6403.455706265019;6406.391392817675;6426.967865160645;6427.421532062137;6063.333033366238;6065.848353791014;6069.33237343883;6076.422739839708;6084.239470066242;5733.3406658234835;5850.5904586678525;5964.522838172849;6020.638761674313;6078.635281883101;5975.671338076448;6021.096835474714;6027.638341699512;6033.185519954925;6059.636421814529;5914.556408269483;5960.046392577166;5963.165156877953;5966.403359663999;5966.522678185822;5607.5513958884;5648.068068768607;5778.104393818965;5838.591298609056;5905.527557795452;5993.490553303018;6042.244719410074;6047.455728984412;6063.969680151571;6082.787102451393;5658.151277308437;5732;5873.794417195378;5875.970620146872;5880.088586269135 10:17:31 INFO - PROCESS | 20055 | |1;ext.html;592.5052581094785;643.173522024199;651.8109748173027;652.9836754081146;663.7278715726547;33784.4932326015;43632;44741.55258447414;44796;44876.551234487684;46191.76904115483;46503.767481162635;46523.76738116313;46532.30201546971;46537.7673111634;8380.83238335233;8939.865902011476;8975.192232699055;9087.31845111616;9088.727338179831;8319.83360332793;10504.212184086186;10774.892251077506;10802.135829133651;11112.61105861295;10864.076553492963;10933.398663073527;10933.453327333602;10935.179861510378;10939;10706.946465267663;10764.515596798085;10796.622118225863;10843.132549396028;10910.563577456893;10604.469776511221;10690.572377104907;10797.62208322705;10803.027727504563;10813.243072984895;43925.78037109826;44554.55445445536;44555;44629.33056004163;44703.32945005828;3698.593154752975;3775.112848480605;4363.258246098139;4398.142362239365;4485.596296333346;33035.834820825985;33306.6669333306;33338.499922501185;33365;33625;4466.82132714691;4483.878163027558;4500.324951257305;4527.705699129546;4549.795259213343;357708;358772;359272;360241;360274;61494;61930.380696192464;61966;62002;62041;40310.39534406986;41187;41311.793441032605;43449;64469.355306446334;17997.820021799875;18119.18463669138;18246.817531824778;18275.268989240547;18287.359942401952;13064.54274100402;13441.663958400923;13614.591562253148;13797.51708690191;14025.649358766112;19859.106340214727;20577;20737;20738.377848664564;20773.480662983246;7194.928050719531;7414.925850741532;7511.117773447194;7589.658465369072;7718.652660630285;993.895640957689;1042.827933390982;1086.7446150154708;1100.6808025672465;1134.1493879590307;33839.49240761391;34148.48777268343;34199.65800342015;34393.65606343905;34602;1142.7943519586915;1194.3490797515376;1237.2267332916927;1255.7865162922326;1334.813126162338;17275.74086388705;17809.910950445166;17965.7305140423;18082.63834723298;18129.818701813077;557048;564583;565475;566588;569071;60312.396876031555;61423;61442;61548;61720;1337.6321511584392;1362.9182249065088;1401.9299035048207;1454.4836583013089;1455.6870272891379;30138.69861301359;33138.337233254715;34529.48205776966;35206;36357;59895.40104598898;60435.39564604474;60561.394386055574;60634.39365606464;60780.392196077475;528303.433931327;533443;534055;535088;536124;31675.52486712747;32418.513722293712;32820.83589582037;32910.34179316353;45905.540944590124;50213;50360.49639503558;50488.495115048376;50620.49379506158;50938.235926460395;41499.58500414957;42260.154796904506;43083.353749694405;44135.55864441315;44694.88262793456;42171;42351.3647295297;42913.35629965615;43087.784561076995;44529.33206001978;42831.78584107184;43632.12735745204;43915.34126988162;44298.11403771971;44350.89122771956;36705.63294367129;38186.18846245857;38308.80845595754;38718.225635487695;38799;28738.84764863964;29233;29235.269118272212;29239.561406578494;29508.409831802815 10:17:31 INFO - PROCESS | 20055 | |2;jquery.html;383.54166770709014;422.4822277738659;430.7178797887384;438.38844811487974;440.3065172353543;16382;19945.800541994577;20195.39413817584;20368.490787730316;20372.490687732778;19643.901780491076;20522.589548209027;20596.279130230443;20668.06993685284;20826.89586552065;5678.886422271562;5923.792667256647;5932;5939.1388248703915;5939.584229103964;5738.340090889559;6004.189434426362;6031.065184896348;6116.296625888013;6117.755289788425;5926.051831706928;6078.878422431549;6105.54208434367;6114.144019837227;6116.938830611703;6145.354737752538;6176.104464852616;6185.505159587222;6186.226721659793;6186.319504854462;5802.854928626818;5986;6002.8199154025015;6023.488003519706;6037.516998640098;14756.704865902622;15003.024803387854;15025.098494090389;15073;15094.849051509564;2243.32700189944;2295.36877358726;2614.346413396651;2717.1033558925506;2723.482538317713;10059.748506287327;10540.420276884768;10847.945760271226;10991.340519568852;11036.730775960707;1924.124523341876;1963.7054441833695;2024.4736368544138;2031.492126968258;2037.1036743832815;81553.59223203905;87498;88390;88451.11548884494;89412;10334;11488.310701357945;11795.646130615924;11863.339132521454;12208;15079.849201508065;15188.544343669708;15780.526584202493;15803.36786528549;15805.68388632221;8079.798005049804;8216.876746848802;8227.629756660965;8234.505929644121;8248.422610417214;7620.657070431844;7645.235476452311;7690.846183076307;7911.129775724666;7944.563049032358;5047.823326183639;5076.847694569169;5079.415867175248;5101.336826212569;5108.514691104339;1994.8204661580237;2006.5084054406473;2046.2326627514683;2055.54777948851;2099.9265025724026;909.1999040844015;989.9950500247453;991.8809742830762;1009.3842755918884;1065.94137322448;20023;20072;20100;20101.29645462431;20273.79726202719;1046.3774054437597;1055.1927775251938;1058.3755584205355;1078.3529882070695;1120.5125770289949;10647.361158330525;11293.548258069584;11462.885371146349;11528.76942461146;11592.130590205768;392383;396200;398781;516320;553772;62308.68845655743;85800;99482;105031;105847.4707626457;1034.13132968307;1078.37454276521;1093.830456279278;1104.8839871813504;1106.673531308266;18116.547086322946;18472.81527184765;18585;18691.57944196222;18984.240630374632;35021.82489087538;42106.36840447457;42933;43387.783061085756;44857.775711121234;49021.5097849017;56235.71882140563;58936.410635894805;59357;60161;8795.768592396942;9070.546472676207;9090.681826136319;9228.446293222429;9356.111169438893;10354.896451035393;12621.432035558606;13306.866931330564;13375.464981400635;13516.459341626618;10247.690640256915;10863.891361086287;11198.608048718255;11925.582604608797;12124.636260912186;7754.457187996786;7964.601769911365;11707.824382634437;11720.06239500855;12305.26168429897;12215.26708397499;12339.383030848243;12394.070444716503;12427.254364738144;12665.240085594894;7578.886316705364;8278.337732981467;8403.361344537941;8412.873806893023;9354.625814967325;9379.390339627902;11859.52561897549;12295.877041229473;12319.938400307941;12325.568605098779 10:17:31 INFO - PROCESS | 20055 | |3;mootools.html;1515.2953876447452;1536.492957324083;1673.3808490858385;1832.4319460967092;1839.8436132928691;8683.652653893845;9228.354015218938;9295.442273463597;9306.767330816725;9308.86036709449;7568.659410326535;7752.883706744389;8639.308855291578;8930.508822014786;9183.586738596763;2461.8030557555444;2493.6882889638796;2496.6879140107485;2497;2505.812064095191;2497.2882728422405;2571.0872640212738;2581.315951272905;2590.235880415282;2593.7665610095087;2498.3254521279246;2503.2615378463397;2530.911418100367;2531.6708827852353;2548.7323830997757;2451.669024681672;2469.4196863737006;2469.592517234654;2506.2230708480247;2506.7743903048813;2436.683231179953;2445.6698345723275;2461.101697880261;2461.2985299189645;2464.950700985988;9017.594208260643;9140.634374625008;9163.541822908894;9167.862482062774;9218.124278193562;5557.249771280865;5737.483626473596;5739.282589676291;5742.310922689304;5742.885142297172;3529.7882127072457;3605.891823245307;3610.6750392464805;3659.505966694489;3668.6514781095752;1071.4267866691282;1099.19758576239;1104.0780947908427;1214.2653694514868;1218.6831423829778;12597.685057873536;12639.684007899785;12646.873531264662;12652.367381630973;12719.30043847588;4754.23932170851;4988.9501104988485;5003.899922001539;5009.223570346602;5086.77109530072;9847.212223022285;9891.35706179096;9906.157976571927;9911.355761875455;9926.652567160114;5486.506214440719;5492.725363731797;5499.917501237484;5503.257060296889;5504.146857237135;4522.570355816192;4830.686005409637;5057.924131138036;5154.355705536808;5215.739213039409;4210.389493523422;4251.957480425218;4312.741235525878;4357.629601483846;4373.803178856959;1395.7278330725412;1410.675544624742;1424.316328162467;1435.0456946130705;1443.4154167562153;945.7588314979773;1023.6263763726187;1026.312370711625;1039.4023436524028;1040.8230600797883;5804.4195580442465;6147.907781383283;6263.812085637438;6411.711472983727;6477.093206951031;1030.7219048379955;1052.163529993657;1056.587930707025;1057.456114073446;1077.9622713205158;4300.62380038391;4428.22506061438;4434.645228381786;4519.435070616173;4639.164950308909;11292.661220163409;11393.25943813666;11507.942460287812;11538.59614913474;11564.24832385909;10168.593256269667;11370.09039276856;11390.202685812079;11425.428728563538;11465;8306.252437280673;8605.870911936327;8620.525871077025;8633.136686331316;8634.093420190915;5880.529557635294;6042.607230530001;6307.684615769102;6312.652804095819;6433.72212641815;10221.795564088825;10250.58997640086;10297.07326340633;10328.173746100445;10564.894351056391;10523.842142368023;10632.574697012342;10646.574137034431;10701.89298107009;10703;7996.280334769898;8127.512349259064;8189.79525511867;8230.506169629842;8231.382646301432;8262.380321475794;8538.615762290836;8625.525596092275;8638.438501497383;8649.524276164871;7771.22287771241;7861.921380786119;7917.841643166989;8009.559474228973;8012.198780121941;7688.923110768821;7710.383169346326;7710.614469276626;7840.960795196215;7900;7073.681684324115;7082.079329687108;7099.07711997437;7135;7146.714131434893;5225.242339860775;5300;5319.920201196907;5372.516473517402;5376.274202982548;5503.504684578407;5562.193481945014;5579.442055794388;5596.300462442195;5625.324961004706 10:17:31 INFO - PROCESS | 20055 | |4;prototype.html;353.5986655146408;363.9326724555957;365.2074997255954;365.48831635710013;365.9752692461108;5394.1908713692965;5403.378611459683;5414.050941661004;5455.5908306876945;5456.154296084108;5071.746412679369;5144;5184.300119483869;5254.553362964152;5302.204669299607;4208.45290112285;4212.3260278355465;4225.450691410128;4230.619244268015;4261.808218630169;4225.661947044229;4235.8729238122905;4251.4685664291965;4257.3613957906255;4267.509236437819;3950.091478959841;3952.762834229941;4208.674267605695;4218.303979843322;4245.575442455761;4181.665466762652;4192.182524407742;4210.85262015831;4211.726237794549;4227.302495088306;3767.321882061228;3788.4317352397084;3789.7726136431625;3807.866724664651;3831.080540670247;5044.369453818273;5198.92201616976;5199.974000130013;5262.500062494057;5312.362516498045;4817.975910120427;4825.155597770411;4835.492273311287;4842.709437433765;4863.537963893425;5605.551555875561;5609.1305847593685;5631.802886898939;5641.1102280736;5702.572307076985;3902.512185976753;4091.1204091120253;4114.156597897424;4227.556106608792;4239.40648309237;5772.624779389368;5788.913166302509;5806.941930580725;5814.825555233349;5822.650640961556;4179.582041795857;4199.404226394012;4219.860637627823;4241.597048280409;4250.128723611652;4203.97898010508;4218.535961044283;4218.894527636834;4289.241411021466;4316.5467625899455;4750.643701722384;4781.784819683123;4788.138135135709;4788.592969597623;4798.592119669797;5616.887662246732;5629.690367029771;5653.325338529989;5669.829905102853;5678.829635110953;1397.1966119481135;1425.4961016128084;1428.128841406741;1429.399652146101;1436.3177490692046;917.4128557723062;937.821813855379;981.6318880419842;1002.8044531316469;1007.8639383683109;5209.817656382009;5261.684578855286;5269.682579355162;5313.6811791291875;5320.388155362183;5564.244135208718;5597.384287728347;5633.183188437735;5661.7735290588735;5679;5035.395752509649;5201.5838732901275;5210.843674689765;5232.450592687789;5296.973515132477;2956.2847258622464;2959.940801183964;2960.9703902961123;2972.212363723615;2982.194807402033;5480.972595136999;5681.659100453986;5796;5854.560907931922;5858.648481091148;5552.222688823568;5559.388467268597;5572.609917305831;5572.832815015556;5603.075492543685;5692.715364231772;5738.454846789632;5739.885202295847;5782.826515204551;5785.479306862402;5207.29701490294;5536.169574563686;5538.756803494591;5545.195946587642;5551.333839939233;5424.728763561727;5442.374126975448;5462.126059830408;5475.698836564027;5487.698176600165;5353.678779273256;5732.5413966881715;5733.795902860446;5767.538596912321;5774.9133762994425;3949.54580223278;3984.7210695251056;3989.3617021276455;4008.1382502762044;4013.2776100302226;5492.395836457907;5532.253145825262;5542;5582.330120385417;5670.206171135962;5328.13515269668;5505.752241149078;5532.1425179097305;5535.861603459945;5544.3346798384455;5652.971735141463;5653.660780353192;5666;5671.6029877909805;5677.659340439587;5368.731563421891;5526.668399896019;5618.522425593706;5619.129034999582;5624.578156638187;5522.3649280331665;5699.2590963174525;5701.629394089371;5705.286839145107;5721.542276617944;5576.776928922797;5584.916226256691;5586.944130558642;5605.775768969359;5615.971920140373 10:17:31 INFO - PROCESS | 20055 | |5;yui.html;769.8190925132593;796.3191471292041;797.5294576200041;847.3052097280231;865.0398058155442;14606.19665918374;14821;15100.54698359051;15200.163990980505;15698.058116513002;13492.595222143327;14658.853411465881;14789.186594737284;14802.925985370084;14881.702365952675;839.0812060793421;858.2490320969152;858.5321000054954;858.7509622209583;859.2739135430551;861.6553378648528;862.65062649627;863.8229163021597;865.0484467086218;867.4968518259426;896.6906417286026;900.6487469886716;901.3825529512305;901.7384958362068;902.1069141549884;890.4078787606234;891.17121077398;894.883665123533;895.1809094678362;897.1970086772335;655.7672026430644;657.7500549791097;658.1049772309655;659.5976454362835;660.4221306356937;14052.297385130805;14154.575362739135;14190.148591084568;14294.356753945993;14407.279636018262;12488;12951.158174718614;13135.34323283832;13211.867881321255;13264.933675331658;10884.401357925311;10935.83596246057;10944.726381840517;11068.778624427547;11219.102471802236;3738.6261373862667;3759.8496060157563;3779.811009449544;3822.311983842907;3880.3985382265796;65373.67313163451;69174.65412672955;69312.30687693109;69578.65210673965;70323;9413.48225847585;9610.95194524023;9716.125548700651;9800.36297640651;9858.112769850748;19720.70418943717;19778.10998505071;19890.50273743168;19928;20081.799182008286;8856.247218986458;8979.955100224588;9006;9089.95455022734;9174.082591740773;4866.853994380174;4966.975165124223;4996.975015124901;5070.974645126751;5104.642675012714;3536.504889315498;3631.055925459347;3671.210689701727;3676.6139555346303;3682.1899182179877;584.7018020809418;593.3888095261888;604.685563506974;614.7725341623538;618.913352130702;674.3223060823841;721.8989341492195;730.4193166432699;732.9230430804795;786.194150995223;9339.20616747584;9638.518074096408;9759.365641233297;10281.228907831943;10312.484375781181;544.1918750655274;559.446148313167;565.8988741695532;574.5891687443415;700.527144177678;4165.562615925284;4232.280512312914;4525.027119169395;4539.931901021488;4686.601638860667;60255.397446025854;87258.56370718233;89282.55358723165;91020.54489727641;93084;51892;65279;84159.57920210483;84954.57522712347;87115;75550;76291;76758.61620691973;77046.6147669258;77224;9465.384749991228;9774.902250977399;9976;10011.949940250252;10014.549345279625;48287.275690863964;48387.5161248383;48591.514084860115;49271;49501.75249123731;64674.676626616565;65679.67160164169;68858.3114168872;68909.65545172241;71255;13092.410841511964;13362.465501379836;13402.396892140072;13504.86495135036;13556.796648050484;14809.629759256104;15032.849671503145;15072.623184420478;15197.6200594986;16187.352505899633;14273.64315892111;14341.067830590979;14417.567472975408;14469.565913022627;14637;12071.094667899766;12342.44458999365;12445.688857778629;12884.549040783528;12967.935160324138;13024.348782560644;13096.934515327363;13391.933040334736;13406.463741450232;13426.664333391744;10256.12822910061;10401.843972340572;10762.892371076188;10876.456177191267;11000.944995274973;10411.531481083219;11324.716882077684;11656.766864662828;11696.590619328283;11935.986885507933 10:17:31 INFO - PROCESS | 20055 | __end_tp_report 10:17:31 INFO - PROCESS | 20055 | __start_cc_report 10:17:31 INFO - PROCESS | 20055 | _x_x_mozilla_cycle_collect,1361 10:17:31 INFO - PROCESS | 20055 | __end_cc_report 10:17:31 INFO - PROCESS | 20055 | __startTimestamp1484677051253__endTimestamp 10:17:31 INFO - PROCESS | 20055 | 10:17:31 INFO - PROCESS | 20055 | ------- Summary: start ------- 10:17:31 INFO - PROCESS | 20055 | Number of tests: 6 10:17:31 INFO - PROCESS | 20055 | 10:17:31 INFO - PROCESS | 20055 | [#0] dojo.html Cycles:165 Average:5604.14 Median:5789.07 stddev:653.24 (11.3%) stddev-sans-first:625.84 10:17:31 INFO - PROCESS | 20055 | Values: 3133.7 3244.4 3251.8 3268.1 3294.6 5542.9 5583.9 5642.2 5645.9 5663.2 5618.5 5652.7 5679.3 5684.8 5689.4 5130.4 5131.2 5134.6 5142.2 5210.7 4965.3 5204.1 5211.1 5226.9 5232.7 4955.9 5023.5 5082.9 5128.4 5129.4 5081.5 5084.2 5099.1 5195.1 5195.5 5041.3 5088.7 5160.6 5164.6 5185.5 5411.7 5417.7 5476.2 5484.8 5590.3 5926.0 5933.3 5939.8 6028.6 6034.7 6053.7 6068.2 6076.2 6077.4 6087.4 5518.3 5545.8 5563.6 5669.1 5750.6 6201.6 6206.2 6238.4 6242.1 6246.3 5978.2 5988.2 5988.8 5989.3 6010.3 5811.5 5870.2 5934.3 6028.2 6050.9 6094.4 6102.4 6102.4 6122.5 6124.0 6056.0 6109.4 6119.0 6121.4 6127.4 4483.7 4526.0 4536.7 4611.0 4673.7 4114.3 4153.2 4169.5 4174.8 4176.6 5613.7 5614.0 5637.0 5658.7 5660.8 5749.3 5789.1 5862.8 5980.0 5993.2 5645.2 5646.2 5647.1 5664.2 5678.5 5075.8 5092.4 5093.5 5099.7 5142.3 6092.5 6125.1 6175.4 6231.8 6239.9 5992.2 6059.4 6136.5 6173.3 6193.4 6397.0 6403.5 6406.4 6427.0 6427.4 6063.3 6065.8 6069.3 6076.4 6084.2 5733.3 5850.6 5964.5 6020.6 6078.6 5975.7 6021.1 6027.6 6033.2 6059.6 5914.6 5960.0 5963.2 5966.4 5966.5 5607.6 5648.1 5778.1 5838.6 5905.5 5993.5 6042.2 6047.5 6064.0 6082.8 5658.2 5732.0 5873.8 5876.0 5880.1 10:17:31 INFO - PROCESS | 20055 | 10:17:31 INFO - PROCESS | 20055 | [#1] ext.html Cycles:180 Average:65194.49 Median:40748.70 stddev:131153.65 (321.9%) stddev-sans-first:131431.88 10:17:31 INFO - PROCESS | 20055 | Values: 592.5 643.2 651.8 653.0 663.7 33784.5 43632.0 44741.6 44796.0 44876.6 46191.8 46503.8 46523.8 46532.3 46537.8 8380.8 8939.9 8975.2 9087.3 9088.7 8319.8 10504.2 10774.9 10802.1 11112.6 10864.1 10933.4 10933.5 10935.2 10939.0 10706.9 10764.5 10796.6 10843.1 10910.6 10604.5 10690.6 10797.6 10803.0 10813.2 43925.8 44554.6 44555.0 44629.3 44703.3 3698.6 3775.1 4363.3 4398.1 4485.6 33035.8 33306.7 33338.5 33365.0 33625.0 4466.8 4483.9 4500.3 4527.7 4549.8 357708.0 358772.0 359272.0 360241.0 360274.0 61494.0 61930.4 61966.0 62002.0 62041.0 40310.4 41187.0 41311.8 43449.0 64469.4 17997.8 18119.2 18246.8 18275.3 18287.4 13064.5 13441.7 13614.6 13797.5 14025.6 19859.1 20577.0 20737.0 20738.4 20773.5 7194.9 7414.9 7511.1 7589.7 7718.7 993.9 1042.8 1086.7 1100.7 1134.1 33839.5 34148.5 34199.7 34393.7 34602.0 1142.8 1194.3 1237.2 1255.8 1334.8 17275.7 17809.9 17965.7 18082.6 18129.8 557048.0 564583.0 565475.0 566588.0 569071.0 60312.4 61423.0 61442.0 61548.0 61720.0 1337.6 1362.9 1401.9 1454.5 1455.7 30138.7 33138.3 34529.5 35206.0 36357.0 59895.4 60435.4 60561.4 60634.4 60780.4 528303.4 533443.0 534055.0 535088.0 536124.0 31675.5 32418.5 32820.8 32910.3 45905.5 50213.0 50360.5 50488.5 50620.5 50938.2 41499.6 42260.2 43083.4 44135.6 44694.9 42171.0 42351.4 42913.4 43087.8 44529.3 42831.8 43632.1 43915.3 44298.1 44350.9 36705.6 38186.2 38308.8 38718.2 38799.0 28738.8 29233.0 29235.3 29239.6 29508.4 10:17:31 INFO - PROCESS | 20055 | 10:17:31 INFO - PROCESS | 20055 | [#2] jquery.html Cycles:180 Average:28009.08 Median:2171.63 stddev:75715.18 (3486.6%) stddev-sans-first:75899.17 10:17:31 INFO - PROCESS | 20055 | Values: 383.5 422.5 430.7 438.4 440.3 16382.0 19945.8 20195.4 20368.5 20372.5 19643.9 20522.6 20596.3 20668.1 20826.9 5678.9 5923.8 5932.0 5939.1 5939.6 5738.3 6004.2 6031.1 6116.3 6117.8 5926.1 6078.9 6105.5 6114.1 6116.9 6145.4 6176.1 6185.5 6186.2 6186.3 5802.9 5986.0 6002.8 6023.5 6037.5 14756.7 15003.0 15025.1 15073.0 15094.8 2243.3 2295.4 2614.3 2717.1 2723.5 10059.7 10540.4 10847.9 10991.3 11036.7 1924.1 1963.7 2024.5 2031.5 2037.1 81553.6 87498.0 88390.0 88451.1 89412.0 10334.0 11488.3 11795.6 11863.3 12208.0 15079.8 15188.5 15780.5 15803.4 15805.7 8079.8 8216.9 8227.6 8234.5 8248.4 7620.7 7645.2 7690.8 7911.1 7944.6 5047.8 5076.8 5079.4 5101.3 5108.5 1994.8 2006.5 2046.2 2055.5 2099.9 909.2 990.0 991.9 1009.4 1065.9 20023.0 20072.0 20100.0 20101.3 20273.8 1046.4 1055.2 1058.4 1078.4 1120.5 10647.4 11293.5 11462.9 11528.8 11592.1 392383.0 396200.0 398781.0 516320.0 553772.0 62308.7 85800.0 99482.0 105031.0 105847.5 1034.1 1078.4 1093.8 1104.9 1106.7 18116.5 18472.8 18585.0 18691.6 18984.2 35021.8 42106.4 42933.0 43387.8 44857.8 49021.5 56235.7 58936.4 59357.0 60161.0 8795.8 9070.5 9090.7 9228.4 9356.1 10354.9 12621.4 13306.9 13375.5 13516.5 10247.7 10863.9 11198.6 11925.6 12124.6 7754.5 7964.6 11707.8 11720.1 12305.3 12215.3 12339.4 12394.1 12427.3 12665.2 7578.9 8278.3 8403.4 8412.9 9354.6 9379.4 11859.5 12295.9 12319.9 12325.6 10:17:31 INFO - PROCESS | 20055 | 10:17:31 INFO - PROCESS | 20055 | [#3] mootools.html Cycles:180 Average:6015.54 Median:4792.46 stddev:3327.96 (69.4%) stddev-sans-first:3320.11 10:17:31 INFO - PROCESS | 20055 | Values: 1515.3 1536.5 1673.4 1832.4 1839.8 8683.7 9228.4 9295.4 9306.8 9308.9 7568.7 7752.9 8639.3 8930.5 9183.6 2461.8 2493.7 2496.7 2497.0 2505.8 2497.3 2571.1 2581.3 2590.2 2593.8 2498.3 2503.3 2530.9 2531.7 2548.7 2451.7 2469.4 2469.6 2506.2 2506.8 2436.7 2445.7 2461.1 2461.3 2465.0 9017.6 9140.6 9163.5 9167.9 9218.1 5557.2 5737.5 5739.3 5742.3 5742.9 3529.8 3605.9 3610.7 3659.5 3668.7 1071.4 1099.2 1104.1 1214.3 1218.7 12597.7 12639.7 12646.9 12652.4 12719.3 4754.2 4989.0 5003.9 5009.2 5086.8 9847.2 9891.4 9906.2 9911.4 9926.7 5486.5 5492.7 5499.9 5503.3 5504.1 4522.6 4830.7 5057.9 5154.4 5215.7 4210.4 4252.0 4312.7 4357.6 4373.8 1395.7 1410.7 1424.3 1435.0 1443.4 945.8 1023.6 1026.3 1039.4 1040.8 5804.4 6147.9 6263.8 6411.7 6477.1 1030.7 1052.2 1056.6 1057.5 1078.0 4300.6 4428.2 4434.6 4519.4 4639.2 11292.7 11393.3 11507.9 11538.6 11564.2 10168.6 11370.1 11390.2 11425.4 11465.0 8306.3 8605.9 8620.5 8633.1 8634.1 5880.5 6042.6 6307.7 6312.7 6433.7 10221.8 10250.6 10297.1 10328.2 10564.9 10523.8 10632.6 10646.6 10701.9 10703.0 7996.3 8127.5 8189.8 8230.5 8231.4 8262.4 8538.6 8625.5 8638.4 8649.5 7771.2 7861.9 7917.8 8009.6 8012.2 7688.9 7710.4 7710.6 7841.0 7900.0 7073.7 7082.1 7099.1 7135.0 7146.7 5225.2 5300.0 5319.9 5372.5 5376.3 5503.5 5562.2 5579.4 5596.3 5625.3 10:17:31 INFO - PROCESS | 20055 | 10:17:31 INFO - PROCESS | 20055 | [#4] prototype.html Cycles:180 Average:4686.23 Median:5313.02 stddev:1347.75 (25.4%) stddev-sans-first:1311.71 10:17:31 INFO - PROCESS | 20055 | Values: 353.6 363.9 365.2 365.5 366.0 5394.2 5403.4 5414.1 5455.6 5456.2 5071.7 5144.0 5184.3 5254.6 5302.2 4208.5 4212.3 4225.5 4230.6 4261.8 4225.7 4235.9 4251.5 4257.4 4267.5 3950.1 3952.8 4208.7 4218.3 4245.6 4181.7 4192.2 4210.9 4211.7 4227.3 3767.3 3788.4 3789.8 3807.9 3831.1 5044.4 5198.9 5200.0 5262.5 5312.4 4818.0 4825.2 4835.5 4842.7 4863.5 5605.6 5609.1 5631.8 5641.1 5702.6 3902.5 4091.1 4114.2 4227.6 4239.4 5772.6 5788.9 5806.9 5814.8 5822.7 4179.6 4199.4 4219.9 4241.6 4250.1 4204.0 4218.5 4218.9 4289.2 4316.5 4750.6 4781.8 4788.1 4788.6 4798.6 5616.9 5629.7 5653.3 5669.8 5678.8 1397.2 1425.5 1428.1 1429.4 1436.3 917.4 937.8 981.6 1002.8 1007.9 5209.8 5261.7 5269.7 5313.7 5320.4 5564.2 5597.4 5633.2 5661.8 5679.0 5035.4 5201.6 5210.8 5232.5 5297.0 2956.3 2959.9 2961.0 2972.2 2982.2 5481.0 5681.7 5796.0 5854.6 5858.6 5552.2 5559.4 5572.6 5572.8 5603.1 5692.7 5738.5 5739.9 5782.8 5785.5 5207.3 5536.2 5538.8 5545.2 5551.3 5424.7 5442.4 5462.1 5475.7 5487.7 5353.7 5732.5 5733.8 5767.5 5774.9 3949.5 3984.7 3989.4 4008.1 4013.3 5492.4 5532.3 5542.0 5582.3 5670.2 5328.1 5505.8 5532.1 5535.9 5544.3 5653.0 5653.7 5666.0 5671.6 5677.7 5368.7 5526.7 5618.5 5619.1 5624.6 5522.4 5699.3 5701.6 5705.3 5721.5 5576.8 5584.9 5586.9 5605.8 5616.0 10:17:31 INFO - PROCESS | 20055 | 10:17:31 INFO - PROCESS | 20055 | [#5] yui.html Cycles:180 Average:18381.65 Median:4981.98 stddev:24448.90 (490.7%) stddev-sans-first:24481.72 10:17:31 INFO - PROCESS | 20055 | Values: 769.8 796.3 797.5 847.3 865.0 14606.2 14821.0 15100.5 15200.2 15698.1 13492.6 14658.9 14789.2 14802.9 14881.7 839.1 858.2 858.5 858.8 859.3 861.7 862.7 863.8 865.0 867.5 896.7 900.6 901.4 901.7 902.1 890.4 891.2 894.9 895.2 897.2 655.8 657.8 658.1 659.6 660.4 14052.3 14154.6 14190.1 14294.4 14407.3 12488.0 12951.2 13135.3 13211.9 13264.9 10884.4 10935.8 10944.7 11068.8 11219.1 3738.6 3759.8 3779.8 3822.3 3880.4 65373.7 69174.7 69312.3 69578.7 70323.0 9413.5 9611.0 9716.1 9800.4 9858.1 19720.7 19778.1 19890.5 19928.0 20081.8 8856.2 8980.0 9006.0 9090.0 9174.1 4866.9 4967.0 4997.0 5071.0 5104.6 3536.5 3631.1 3671.2 3676.6 3682.2 584.7 593.4 604.7 614.8 618.9 674.3 721.9 730.4 732.9 786.2 9339.2 9638.5 9759.4 10281.2 10312.5 544.2 559.4 565.9 574.6 700.5 4165.6 4232.3 4525.0 4539.9 4686.6 60255.4 87258.6 89282.6 91020.5 93084.0 51892.0 65279.0 84159.6 84954.6 87115.0 75550.0 76291.0 76758.6 77046.6 77224.0 9465.4 9774.9 9976.0 10011.9 10014.5 48287.3 48387.5 48591.5 49271.0 49501.8 64674.7 65679.7 68858.3 68909.7 71255.0 13092.4 13362.5 13402.4 13504.9 13556.8 14809.6 15032.8 15072.6 15197.6 16187.4 14273.6 14341.1 14417.6 14469.6 14637.0 12071.1 12342.4 12445.7 12884.5 12967.9 13024.3 13096.9 13391.9 13406.5 13426.7 10256.1 10401.8 10762.9 10876.5 11000.9 10411.5 11324.7 11656.8 11696.6 11936.0 10:17:31 INFO - PROCESS | 20055 | -------- Summary: end -------- 10:17:31 INFO - PROCESS | 20055 | 10:17:32 INFO - TEST-INFO | 20055: exit 0 10:17:32 INFO - TEST-OK | dromaeo_css | took 1115481ms 10:17:32 INFO - TEST-START | kraken 10:17:32 INFO - operating with platform_type : linux_ 10:17:32 INFO - Initialising browser for kraken test... 10:17:32 INFO - TEST-INFO | started process 20371 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcxB7kK/profile http://localhost:39218/getInfo.html) 10:17:36 INFO - PROCESS | 20371 | __metrics Screen width/height:1600/1200 10:17:36 INFO - PROCESS | 20371 | colorDepth:24 10:17:36 INFO - PROCESS | 20371 | Browser inner width/height: 1024/697 10:17:36 INFO - PROCESS | 20371 | __metrics 10:17:36 INFO - PROCESS | 20371 | 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:17:36 INFO - PROCESS | 20371 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:17:37 INFO - PROCESS | 20371 | console.error: PushService: 10:17:37 INFO - PROCESS | 20371 | stateChangeProcessEnqueue: Error transitioning state 10:17:37 INFO - PROCESS | 20371 | UnknownError 10:17:37 INFO - TEST-INFO | 20371: exit 0 10:17:37 INFO - Browser initialized. 10:17:37 INFO - Running cycle 1/1 for kraken test... 10:17:37 INFO - TEST-INFO | started process 20464 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcxB7kK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:17:49 INFO - PROCESS | 20464 | RSS: Main: 143212544 10:17:49 INFO - PROCESS | 20464 | 10:17:52 INFO - PROCESS | 20464 | Cycle 1(1): loaded http://localhost:39218/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39218/tests/kraken/driver.html?testName=audio-beat-detection) 10:17:53 INFO - PROCESS | 20464 | RSS: Main: 185401344 10:17:53 INFO - PROCESS | 20464 | 10:17:55 INFO - PROCESS | 20464 | Cycle 1(1): loaded http://localhost:39218/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39218/tests/kraken/driver.html?testName=audio-dft) 10:17:56 INFO - PROCESS | 20464 | RSS: Main: 174452736 10:17:56 INFO - PROCESS | 20464 | 10:17:59 INFO - PROCESS | 20464 | Cycle 1(1): loaded http://localhost:39218/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39218/tests/kraken/driver.html?testName=audio-fft) 10:17:59 INFO - PROCESS | 20464 | RSS: Main: 266477568 10:17:59 INFO - PROCESS | 20464 | 10:18:01 INFO - PROCESS | 20464 | Cycle 1(1): loaded http://localhost:39218/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39218/tests/kraken/driver.html?testName=audio-oscillator) 10:18:02 INFO - PROCESS | 20464 | RSS: Main: 172576768 10:18:02 INFO - PROCESS | 20464 | 10:18:04 INFO - PROCESS | 20464 | Cycle 1(1): loaded http://localhost:39218/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39218/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:18:05 INFO - PROCESS | 20464 | RSS: Main: 174845952 10:18:05 INFO - PROCESS | 20464 | 10:18:07 INFO - PROCESS | 20464 | Cycle 1(1): loaded http://localhost:39218/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39218/tests/kraken/driver.html?testName=imaging-darkroom) 10:18:08 INFO - PROCESS | 20464 | RSS: Main: 213864448 10:18:08 INFO - PROCESS | 20464 | 10:18:11 INFO - PROCESS | 20464 | Cycle 1(1): loaded http://localhost:39218/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39218/tests/kraken/driver.html?testName=imaging-desaturate) 10:18:12 INFO - PROCESS | 20464 | RSS: Main: 212549632 10:18:12 INFO - PROCESS | 20464 | 10:18:15 INFO - PROCESS | 20464 | Cycle 1(1): loaded http://localhost:39218/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39218/tests/kraken/driver.html?testName=json-parse-financial) 10:18:15 INFO - PROCESS | 20464 | RSS: Main: 211484672 10:18:15 INFO - PROCESS | 20464 | 10:18:17 INFO - PROCESS | 20464 | Cycle 1(1): loaded http://localhost:39218/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39218/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:18:17 INFO - PROCESS | 20464 | RSS: Main: 173690880 10:18:17 INFO - PROCESS | 20464 | 10:18:19 INFO - PROCESS | 20464 | Cycle 1(1): loaded http://localhost:39218/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39218/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:18:20 INFO - PROCESS | 20464 | RSS: Main: 180940800 10:18:20 INFO - PROCESS | 20464 | 10:18:22 INFO - PROCESS | 20464 | Cycle 1(1): loaded http://localhost:39218/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39218/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:18:22 INFO - PROCESS | 20464 | RSS: Main: 189677568 10:18:22 INFO - PROCESS | 20464 | 10:18:25 INFO - PROCESS | 20464 | Cycle 1(1): loaded http://localhost:39218/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39218/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:18:25 INFO - PROCESS | 20464 | RSS: Main: 197980160 10:18:25 INFO - PROCESS | 20464 | 10:18:28 INFO - PROCESS | 20464 | Cycle 1(1): loaded http://localhost:39218/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39218/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:18:29 INFO - PROCESS | 20464 | RSS: Main: 194437120 10:18:29 INFO - PROCESS | 20464 | 10:18:30 INFO - PROCESS | 20464 | Cycle 1(1): loaded http://localhost:39218/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39218/tests/kraken/driver.html?testName=ai-astar) 10:18:31 INFO - PROCESS | 20464 | RSS: Main: 245870592 10:18:31 INFO - PROCESS | 20464 | 10:18:31 INFO - PROCESS | 20464 | __start_tp_report 10:18:31 INFO - PROCESS | 20464 | _x_x_mozilla_page_load 10:18:31 INFO - PROCESS | 20464 | _x_x_mozilla_page_load_details 10:18:31 INFO - PROCESS | 20464 | |i|pagename|runs| 10:18:31 INFO - PROCESS | 20464 | |0;ai-astar;106;113;112;111;112;112;112;112;112;111 10:18:31 INFO - PROCESS | 20464 | |1;audio-beat-detection;157;119;120;155;119;137;118;118;147;119 10:18:31 INFO - PROCESS | 20464 | |2;audio-dft;163;163;163;162;161;161;162;162;160;161 10:18:31 INFO - PROCESS | 20464 | |3;audio-fft;76;76;77;113;77;77;80;77;106;76 10:18:31 INFO - PROCESS | 20464 | |4;audio-oscillator;82;81;109;82;82;82;98;82;82;114 10:18:31 INFO - PROCESS | 20464 | |5;imaging-gaussian-blur;117;117;117;117;117;118;117;117;117;117 10:18:31 INFO - PROCESS | 20464 | |6;imaging-darkroom;146;146;146;146;146;146;147;146;146;147 10:18:31 INFO - PROCESS | 20464 | |7;imaging-desaturate;85;85;85;85;84;86;85;86;86;84 10:18:31 INFO - PROCESS | 20464 | |8;json-parse-financial;52;50;50;50;52;53;50;50;51;52 10:18:31 INFO - PROCESS | 20464 | |9;json-stringify-tinderbox;61;62;61;60;62;60;61;62;61;61 10:18:31 INFO - PROCESS | 20464 | |10;stanford-crypto-aes;76;76;76;76;76;77;75;76;75;75 10:18:31 INFO - PROCESS | 20464 | |11;stanford-crypto-ccm;140;130;123;121;122;123;119;120;166;139 10:18:31 INFO - PROCESS | 20464 | |12;stanford-crypto-pbkdf2;159;152;152;156;155;151;151;153;152;152 10:18:31 INFO - PROCESS | 20464 | |13;stanford-crypto-sha256-iterative;63;63;63;69;62;63;64;64;61;62 10:18:31 INFO - PROCESS | 20464 | __end_tp_report 10:18:31 INFO - PROCESS | 20464 | __start_cc_report 10:18:31 INFO - PROCESS | 20464 | _x_x_mozilla_cycle_collect,1580 10:18:31 INFO - PROCESS | 20464 | __end_cc_report 10:18:31 INFO - PROCESS | 20464 | __startTimestamp1484677111062__endTimestamp 10:18:31 INFO - PROCESS | 20464 | 10:18:31 INFO - PROCESS | 20464 | ------- Summary: start ------- 10:18:31 INFO - PROCESS | 20464 | Number of tests: 14 10:18:31 INFO - PROCESS | 20464 | 10:18:31 INFO - PROCESS | 20464 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:1.95 (1.7%) stddev-sans-first:0.60 10:18:31 INFO - PROCESS | 20464 | Values: 106.0 113.0 112.0 111.0 112.0 112.0 112.0 112.0 112.0 111.0 10:18:31 INFO - PROCESS | 20464 | 10:18:31 INFO - PROCESS | 20464 | [#1] audio-beat-detection Cycles:10 Average:130.90 Median:128.50 stddev:16.45 (12.8%) stddev-sans-first:14.48 10:18:31 INFO - PROCESS | 20464 | Values: 157.0 119.0 120.0 155.0 119.0 137.0 118.0 118.0 147.0 119.0 10:18:31 INFO - PROCESS | 20464 | 10:18:31 INFO - PROCESS | 20464 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.03 (0.6%) stddev-sans-first:1.00 10:18:31 INFO - PROCESS | 20464 | Values: 163.0 163.0 163.0 162.0 161.0 161.0 162.0 162.0 160.0 161.0 10:18:31 INFO - PROCESS | 20464 | 10:18:31 INFO - PROCESS | 20464 | [#3] audio-fft Cycles:10 Average:83.50 Median:77.00 stddev:13.85 (18.0%) stddev-sans-first:14.42 10:18:31 INFO - PROCESS | 20464 | Values: 76.0 76.0 77.0 113.0 77.0 77.0 80.0 77.0 106.0 76.0 10:18:31 INFO - PROCESS | 20464 | 10:18:31 INFO - PROCESS | 20464 | [#4] audio-oscillator Cycles:10 Average:89.40 Median:82.00 stddev:12.75 (15.5%) stddev-sans-first:13.24 10:18:31 INFO - PROCESS | 20464 | Values: 82.0 81.0 109.0 82.0 82.0 82.0 98.0 82.0 82.0 114.0 10:18:31 INFO - PROCESS | 20464 | 10:18:31 INFO - PROCESS | 20464 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:18:31 INFO - PROCESS | 20464 | Values: 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 10:18:31 INFO - PROCESS | 20464 | 10:18:31 INFO - PROCESS | 20464 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 10:18:31 INFO - PROCESS | 20464 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 147.0 10:18:31 INFO - PROCESS | 20464 | 10:18:31 INFO - PROCESS | 20464 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:0.74 (0.9%) stddev-sans-first:0.78 10:18:31 INFO - PROCESS | 20464 | Values: 85.0 85.0 85.0 85.0 84.0 86.0 85.0 86.0 86.0 84.0 10:18:31 INFO - PROCESS | 20464 | 10:18:31 INFO - PROCESS | 20464 | [#8] json-parse-financial Cycles:10 Average:51.00 Median:51.50 stddev:1.15 (2.2%) stddev-sans-first:1.17 10:18:31 INFO - PROCESS | 20464 | Values: 52.0 50.0 50.0 50.0 52.0 53.0 50.0 50.0 51.0 52.0 10:18:31 INFO - PROCESS | 20464 | 10:18:31 INFO - PROCESS | 20464 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 10:18:31 INFO - PROCESS | 20464 | Values: 61.0 62.0 61.0 60.0 62.0 60.0 61.0 62.0 61.0 61.0 10:18:31 INFO - PROCESS | 20464 | 10:18:31 INFO - PROCESS | 20464 | [#10] stanford-crypto-aes Cycles:10 Average:75.80 Median:76.00 stddev:0.63 (0.8%) stddev-sans-first:0.67 10:18:31 INFO - PROCESS | 20464 | Values: 76.0 76.0 76.0 76.0 76.0 77.0 75.0 76.0 75.0 75.0 10:18:31 INFO - PROCESS | 20464 | 10:18:31 INFO - PROCESS | 20464 | [#11] stanford-crypto-ccm Cycles:10 Average:130.30 Median:126.50 stddev:14.68 (11.6%) stddev-sans-first:15.15 10:18:31 INFO - PROCESS | 20464 | Values: 140.0 130.0 123.0 121.0 122.0 123.0 119.0 120.0 166.0 139.0 10:18:31 INFO - PROCESS | 20464 | 10:18:31 INFO - PROCESS | 20464 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.30 Median:152.50 stddev:2.58 (1.7%) stddev-sans-first:1.73 10:18:31 INFO - PROCESS | 20464 | Values: 159.0 152.0 152.0 156.0 155.0 151.0 151.0 153.0 152.0 152.0 10:18:31 INFO - PROCESS | 20464 | 10:18:31 INFO - PROCESS | 20464 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.00 stddev:2.17 (3.4%) stddev-sans-first:2.30 10:18:31 INFO - PROCESS | 20464 | Values: 63.0 63.0 63.0 69.0 62.0 63.0 64.0 64.0 61.0 62.0 10:18:31 INFO - PROCESS | 20464 | -------- Summary: end -------- 10:18:31 INFO - PROCESS | 20464 | 10:18:32 INFO - TEST-INFO | 20464: exit 0 10:18:32 INFO - TEST-OK | kraken | took 60044ms 10:18:32 INFO - SUITE-END | took 1175s 10:18:32 INFO - Completed test suite (00:19:35) 10:18:32 INFO - javascript benchmark 10:18:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3133.655297917229, 3244.3511297740442, 3251.8211498367596, 3268.0849362178596, 3294.6375898651145, 5542.861428464285, 5583.8604034899145, 5642.181883626871, 5645.915311270329, 5663.207150998858, 5618.522425593819, 5652.660840349582, 5679.346875109363, 5684.801031963882, 5689.374168841424, 5130.384353877531, 5131.179011358184, 5134.640575159721, 5142.151544995071, 5210.713410762407, 4965.28003439501, 5204.089284375238, 5211.088059589576, 5226.92159617606, 5232.686038837663, 4955.876103097416, 5023.547880690737, 5082.923756143661, 5128.358955130609, 5129.410117836459, 5081.491850814908, 5084.186530155176, 5099.107656160157, 5195.064888320101, 5195.506426889439, 5041.344625198701, 5088.669236499616, 5160.561352285023, 5164.586833053384, 5185.481451854822, 5411.702356370398, 5417.674939503642, 5476.151196564539, 5484.780608775644, 5590.273264475592, 5925.992581261196, 5933.258342707161, 5939.821805345847, 6028.608140470899, 6034.6982650867285, 6053.667048312341, 6068.241469816273, 6076.210092687967, 6077.422644848776, 6087.421694938974, 5518.255035570227, 5545.833624991256, 5563.610547261694, 5669.064604340238, 5750.597458177887, 6201.627902325785, 6206.193194884636, 6238.438540531374, 6242.063690446469, 6246.3441338659695, 5978.1929439525975, 5988.161657367972, 5988.820335389945, 5989.251343582052, 6010.338862725097, 5811.535077193815, 5870.207521984563, 5934.347221805598, 6028.246469191351, 6050.909236361458, 6094.39056094387, 6102.389761023862, 6102.389761023951, 6122.479589234965, 6124.0201567748945, 6055.969720151459, 6109.419605137505, 6119.0, 6121.357257487989, 6127.356627554132, 4483.708558943658, 4526.049529598821, 4536.659750518725, 4611.031683346468, 4673.7429441381055, 4114.280000999813, 4153.169366126726, 4169.499660040754, 4174.77038762871, 4176.582341765799, 5613.691246981455, 5614.017546929353, 5637.041702910515, 5658.660480371191, 5660.773569057192, 5749.338826034976, 5789.073748200268, 5862.765489380462, 5979.970100149471, 5993.190919225936, 5645.2096706461125, 5646.20953066571, 5647.068233741386, 5664.178694089416, 5678.517326027334, 5075.796968121308, 5092.439831618519, 5093.516115968977, 5099.6685215460875, 5142.331496905378, 6092.482139018056, 6125.1424800527075, 6175.413335733008, 6231.813045608639, 6239.937600623935, 5992.221011268682, 6059.424354686298, 6136.539759517965, 6173.259208894961, 6193.4425901669065, 6397.040443933447, 6403.455706265019, 6406.391392817675, 6426.967865160645, 6427.421532062137, 6063.333033366238, 6065.848353791014, 6069.33237343883, 6076.422739839708, 6084.239470066242, 5733.3406658234835, 5850.5904586678525, 5964.522838172849, 6020.638761674313, 6078.635281883101, 5975.671338076448, 6021.096835474714, 6027.638341699512, 6033.185519954925, 6059.636421814529, 5914.556408269483, 5960.046392577166, 5963.165156877953, 5966.403359663999, 5966.522678185822, 5607.5513958884, 5648.068068768607, 5778.104393818965, 5838.591298609056, 5905.527557795452, 5993.490553303018, 6042.244719410074, 6047.455728984412, 6063.969680151571, 6082.787102451393, 5658.151277308437, 5732.0, 5873.794417195378, 5875.970620146872, 5880.088586269135], "value": 5559.212297011189, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.5052581094785, 643.173522024199, 651.8109748173027, 652.9836754081146, 663.7278715726547, 33784.4932326015, 43632.0, 44741.55258447414, 44796.0, 44876.551234487684, 46191.76904115483, 46503.767481162635, 46523.76738116313, 46532.30201546971, 46537.7673111634, 8380.83238335233, 8939.865902011476, 8975.192232699055, 9087.31845111616, 9088.727338179831, 8319.83360332793, 10504.212184086186, 10774.892251077506, 10802.135829133651, 11112.61105861295, 10864.076553492963, 10933.398663073527, 10933.453327333602, 10935.179861510378, 10939.0, 10706.946465267663, 10764.515596798085, 10796.622118225863, 10843.132549396028, 10910.563577456893, 10604.469776511221, 10690.572377104907, 10797.62208322705, 10803.027727504563, 10813.243072984895, 43925.78037109826, 44554.55445445536, 44555.0, 44629.33056004163, 44703.32945005828, 3698.593154752975, 3775.112848480605, 4363.258246098139, 4398.142362239365, 4485.596296333346, 33035.834820825985, 33306.6669333306, 33338.499922501185, 33365.0, 33625.0, 4466.82132714691, 4483.878163027558, 4500.324951257305, 4527.705699129546, 4549.795259213343, 357708.0, 358772.0, 359272.0, 360241.0, 360274.0, 61494.0, 61930.380696192464, 61966.0, 62002.0, 62041.0, 40310.39534406986, 41187.0, 41311.793441032605, 43449.0, 64469.355306446334, 17997.820021799875, 18119.18463669138, 18246.817531824778, 18275.268989240547, 18287.359942401952, 13064.54274100402, 13441.663958400923, 13614.591562253148, 13797.51708690191, 14025.649358766112, 19859.106340214727, 20577.0, 20737.0, 20738.377848664564, 20773.480662983246, 7194.928050719531, 7414.925850741532, 7511.117773447194, 7589.658465369072, 7718.652660630285, 993.895640957689, 1042.827933390982, 1086.7446150154708, 1100.6808025672465, 1134.1493879590307, 33839.49240761391, 34148.48777268343, 34199.65800342015, 34393.65606343905, 34602.0, 1142.7943519586915, 1194.3490797515376, 1237.2267332916927, 1255.7865162922326, 1334.813126162338, 17275.74086388705, 17809.910950445166, 17965.7305140423, 18082.63834723298, 18129.818701813077, 557048.0, 564583.0, 565475.0, 566588.0, 569071.0, 60312.396876031555, 61423.0, 61442.0, 61548.0, 61720.0, 1337.6321511584392, 1362.9182249065088, 1401.9299035048207, 1454.4836583013089, 1455.6870272891379, 30138.69861301359, 33138.337233254715, 34529.48205776966, 35206.0, 36357.0, 59895.40104598898, 60435.39564604474, 60561.394386055574, 60634.39365606464, 60780.392196077475, 528303.433931327, 533443.0, 534055.0, 535088.0, 536124.0, 31675.52486712747, 32418.513722293712, 32820.83589582037, 32910.34179316353, 45905.540944590124, 50213.0, 50360.49639503558, 50488.495115048376, 50620.49379506158, 50938.235926460395, 41499.58500414957, 42260.154796904506, 43083.353749694405, 44135.55864441315, 44694.88262793456, 42171.0, 42351.3647295297, 42913.35629965615, 43087.784561076995, 44529.33206001978, 42831.78584107184, 43632.12735745204, 43915.34126988162, 44298.11403771971, 44350.89122771956, 36705.63294367129, 38186.18846245857, 38308.80845595754, 38718.225635487695, 38799.0, 28738.84764863964, 29233.0, 29235.269118272212, 29239.561406578494, 29508.409831802815], "value": 21597.04372878408, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.54166770709014, 422.4822277738659, 430.7178797887384, 438.38844811487974, 440.3065172353543, 16382.0, 19945.800541994577, 20195.39413817584, 20368.490787730316, 20372.490687732778, 19643.901780491076, 20522.589548209027, 20596.279130230443, 20668.06993685284, 20826.89586552065, 5678.886422271562, 5923.792667256647, 5932.0, 5939.1388248703915, 5939.584229103964, 5738.340090889559, 6004.189434426362, 6031.065184896348, 6116.296625888013, 6117.755289788425, 5926.051831706928, 6078.878422431549, 6105.54208434367, 6114.144019837227, 6116.938830611703, 6145.354737752538, 6176.104464852616, 6185.505159587222, 6186.226721659793, 6186.319504854462, 5802.854928626818, 5986.0, 6002.8199154025015, 6023.488003519706, 6037.516998640098, 14756.704865902622, 15003.024803387854, 15025.098494090389, 15073.0, 15094.849051509564, 2243.32700189944, 2295.36877358726, 2614.346413396651, 2717.1033558925506, 2723.482538317713, 10059.748506287327, 10540.420276884768, 10847.945760271226, 10991.340519568852, 11036.730775960707, 1924.124523341876, 1963.7054441833695, 2024.4736368544138, 2031.492126968258, 2037.1036743832815, 81553.59223203905, 87498.0, 88390.0, 88451.11548884494, 89412.0, 10334.0, 11488.310701357945, 11795.646130615924, 11863.339132521454, 12208.0, 15079.849201508065, 15188.544343669708, 15780.526584202493, 15803.36786528549, 15805.68388632221, 8079.798005049804, 8216.876746848802, 8227.629756660965, 8234.505929644121, 8248.422610417214, 7620.657070431844, 7645.235476452311, 7690.846183076307, 7911.129775724666, 7944.563049032358, 5047.823326183639, 5076.847694569169, 5079.415867175248, 5101.336826212569, 5108.514691104339, 1994.8204661580237, 2006.5084054406473, 2046.2326627514683, 2055.54777948851, 2099.9265025724026, 909.1999040844015, 989.9950500247453, 991.8809742830762, 1009.3842755918884, 1065.94137322448, 20023.0, 20072.0, 20100.0, 20101.29645462431, 20273.79726202719, 1046.3774054437597, 1055.1927775251938, 1058.3755584205355, 1078.3529882070695, 1120.5125770289949, 10647.361158330525, 11293.548258069584, 11462.885371146349, 11528.76942461146, 11592.130590205768, 392383.0, 396200.0, 398781.0, 516320.0, 553772.0, 62308.68845655743, 85800.0, 99482.0, 105031.0, 105847.4707626457, 1034.13132968307, 1078.37454276521, 1093.830456279278, 1104.8839871813504, 1106.673531308266, 18116.547086322946, 18472.81527184765, 18585.0, 18691.57944196222, 18984.240630374632, 35021.82489087538, 42106.36840447457, 42933.0, 43387.783061085756, 44857.775711121234, 49021.5097849017, 56235.71882140563, 58936.410635894805, 59357.0, 60161.0, 8795.768592396942, 9070.546472676207, 9090.681826136319, 9228.446293222429, 9356.111169438893, 10354.896451035393, 12621.432035558606, 13306.866931330564, 13375.464981400635, 13516.459341626618, 10247.690640256915, 10863.891361086287, 11198.608048718255, 11925.582604608797, 12124.636260912186, 7754.457187996786, 7964.601769911365, 11707.824382634437, 11720.06239500855, 12305.26168429897, 12215.26708397499, 12339.383030848243, 12394.070444716503, 12427.254364738144, 12665.240085594894, 7578.886316705364, 8278.337732981467, 8403.361344537941, 8412.873806893023, 9354.625814967325, 9379.390339627902, 11859.52561897549, 12295.877041229473, 12319.938400307941, 12325.568605098779], "value": 9340.408467173573, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1515.2953876447452, 1536.492957324083, 1673.3808490858385, 1832.4319460967092, 1839.8436132928691, 8683.652653893845, 9228.354015218938, 9295.442273463597, 9306.767330816725, 9308.86036709449, 7568.659410326535, 7752.883706744389, 8639.308855291578, 8930.508822014786, 9183.586738596763, 2461.8030557555444, 2493.6882889638796, 2496.6879140107485, 2497.0, 2505.812064095191, 2497.2882728422405, 2571.0872640212738, 2581.315951272905, 2590.235880415282, 2593.7665610095087, 2498.3254521279246, 2503.2615378463397, 2530.911418100367, 2531.6708827852353, 2548.7323830997757, 2451.669024681672, 2469.4196863737006, 2469.592517234654, 2506.2230708480247, 2506.7743903048813, 2436.683231179953, 2445.6698345723275, 2461.101697880261, 2461.2985299189645, 2464.950700985988, 9017.594208260643, 9140.634374625008, 9163.541822908894, 9167.862482062774, 9218.124278193562, 5557.249771280865, 5737.483626473596, 5739.282589676291, 5742.310922689304, 5742.885142297172, 3529.7882127072457, 3605.891823245307, 3610.6750392464805, 3659.505966694489, 3668.6514781095752, 1071.4267866691282, 1099.19758576239, 1104.0780947908427, 1214.2653694514868, 1218.6831423829778, 12597.685057873536, 12639.684007899785, 12646.873531264662, 12652.367381630973, 12719.30043847588, 4754.23932170851, 4988.9501104988485, 5003.899922001539, 5009.223570346602, 5086.77109530072, 9847.212223022285, 9891.35706179096, 9906.157976571927, 9911.355761875455, 9926.652567160114, 5486.506214440719, 5492.725363731797, 5499.917501237484, 5503.257060296889, 5504.146857237135, 4522.570355816192, 4830.686005409637, 5057.924131138036, 5154.355705536808, 5215.739213039409, 4210.389493523422, 4251.957480425218, 4312.741235525878, 4357.629601483846, 4373.803178856959, 1395.7278330725412, 1410.675544624742, 1424.316328162467, 1435.0456946130705, 1443.4154167562153, 945.7588314979773, 1023.6263763726187, 1026.312370711625, 1039.4023436524028, 1040.8230600797883, 5804.4195580442465, 6147.907781383283, 6263.812085637438, 6411.711472983727, 6477.093206951031, 1030.7219048379955, 1052.163529993657, 1056.587930707025, 1057.456114073446, 1077.9622713205158, 4300.62380038391, 4428.22506061438, 4434.645228381786, 4519.435070616173, 4639.164950308909, 11292.661220163409, 11393.25943813666, 11507.942460287812, 11538.59614913474, 11564.24832385909, 10168.593256269667, 11370.09039276856, 11390.202685812079, 11425.428728563538, 11465.0, 8306.252437280673, 8605.870911936327, 8620.525871077025, 8633.136686331316, 8634.093420190915, 5880.529557635294, 6042.607230530001, 6307.684615769102, 6312.652804095819, 6433.72212641815, 10221.795564088825, 10250.58997640086, 10297.07326340633, 10328.173746100445, 10564.894351056391, 10523.842142368023, 10632.574697012342, 10646.574137034431, 10701.89298107009, 10703.0, 7996.280334769898, 8127.512349259064, 8189.79525511867, 8230.506169629842, 8231.382646301432, 8262.380321475794, 8538.615762290836, 8625.525596092275, 8638.438501497383, 8649.524276164871, 7771.22287771241, 7861.921380786119, 7917.841643166989, 8009.559474228973, 8012.198780121941, 7688.923110768821, 7710.383169346326, 7710.614469276626, 7840.960795196215, 7900.0, 7073.681684324115, 7082.079329687108, 7099.07711997437, 7135.0, 7146.714131434893, 5225.242339860775, 5300.0, 5319.920201196907, 5372.516473517402, 5376.274202982548, 5503.504684578407, 5562.193481945014, 5579.442055794388, 5596.300462442195, 5625.324961004706], "value": 4871.399518062536, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.5986655146408, 363.9326724555957, 365.2074997255954, 365.48831635710013, 365.9752692461108, 5394.1908713692965, 5403.378611459683, 5414.050941661004, 5455.5908306876945, 5456.154296084108, 5071.746412679369, 5144.0, 5184.300119483869, 5254.553362964152, 5302.204669299607, 4208.45290112285, 4212.3260278355465, 4225.450691410128, 4230.619244268015, 4261.808218630169, 4225.661947044229, 4235.8729238122905, 4251.4685664291965, 4257.3613957906255, 4267.509236437819, 3950.091478959841, 3952.762834229941, 4208.674267605695, 4218.303979843322, 4245.575442455761, 4181.665466762652, 4192.182524407742, 4210.85262015831, 4211.726237794549, 4227.302495088306, 3767.321882061228, 3788.4317352397084, 3789.7726136431625, 3807.866724664651, 3831.080540670247, 5044.369453818273, 5198.92201616976, 5199.974000130013, 5262.500062494057, 5312.362516498045, 4817.975910120427, 4825.155597770411, 4835.492273311287, 4842.709437433765, 4863.537963893425, 5605.551555875561, 5609.1305847593685, 5631.802886898939, 5641.1102280736, 5702.572307076985, 3902.512185976753, 4091.1204091120253, 4114.156597897424, 4227.556106608792, 4239.40648309237, 5772.624779389368, 5788.913166302509, 5806.941930580725, 5814.825555233349, 5822.650640961556, 4179.582041795857, 4199.404226394012, 4219.860637627823, 4241.597048280409, 4250.128723611652, 4203.97898010508, 4218.535961044283, 4218.894527636834, 4289.241411021466, 4316.5467625899455, 4750.643701722384, 4781.784819683123, 4788.138135135709, 4788.592969597623, 4798.592119669797, 5616.887662246732, 5629.690367029771, 5653.325338529989, 5669.829905102853, 5678.829635110953, 1397.1966119481135, 1425.4961016128084, 1428.128841406741, 1429.399652146101, 1436.3177490692046, 917.4128557723062, 937.821813855379, 981.6318880419842, 1002.8044531316469, 1007.8639383683109, 5209.817656382009, 5261.684578855286, 5269.682579355162, 5313.6811791291875, 5320.388155362183, 5564.244135208718, 5597.384287728347, 5633.183188437735, 5661.7735290588735, 5679.0, 5035.395752509649, 5201.5838732901275, 5210.843674689765, 5232.450592687789, 5296.973515132477, 2956.2847258622464, 2959.940801183964, 2960.9703902961123, 2972.212363723615, 2982.194807402033, 5480.972595136999, 5681.659100453986, 5796.0, 5854.560907931922, 5858.648481091148, 5552.222688823568, 5559.388467268597, 5572.609917305831, 5572.832815015556, 5603.075492543685, 5692.715364231772, 5738.454846789632, 5739.885202295847, 5782.826515204551, 5785.479306862402, 5207.29701490294, 5536.169574563686, 5538.756803494591, 5545.195946587642, 5551.333839939233, 5424.728763561727, 5442.374126975448, 5462.126059830408, 5475.698836564027, 5487.698176600165, 5353.678779273256, 5732.5413966881715, 5733.795902860446, 5767.538596912321, 5774.9133762994425, 3949.54580223278, 3984.7210695251056, 3989.3617021276455, 4008.1382502762044, 4013.2776100302226, 5492.395836457907, 5532.253145825262, 5542.0, 5582.330120385417, 5670.206171135962, 5328.13515269668, 5505.752241149078, 5532.1425179097305, 5535.861603459945, 5544.3346798384455, 5652.971735141463, 5653.660780353192, 5666.0, 5671.6029877909805, 5677.659340439587, 5368.731563421891, 5526.668399896019, 5618.522425593706, 5619.129034999582, 5624.578156638187, 5522.3649280331665, 5699.2590963174525, 5701.629394089371, 5705.286839145107, 5721.542276617944, 5576.776928922797, 5584.916226256691, 5586.944130558642, 5605.775768969359, 5615.971920140373], "value": 4264.550850015521, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [769.8190925132593, 796.3191471292041, 797.5294576200041, 847.3052097280231, 865.0398058155442, 14606.19665918374, 14821.0, 15100.54698359051, 15200.163990980505, 15698.058116513002, 13492.595222143327, 14658.853411465881, 14789.186594737284, 14802.925985370084, 14881.702365952675, 839.0812060793421, 858.2490320969152, 858.5321000054954, 858.7509622209583, 859.2739135430551, 861.6553378648528, 862.65062649627, 863.8229163021597, 865.0484467086218, 867.4968518259426, 896.6906417286026, 900.6487469886716, 901.3825529512305, 901.7384958362068, 902.1069141549884, 890.4078787606234, 891.17121077398, 894.883665123533, 895.1809094678362, 897.1970086772335, 655.7672026430644, 657.7500549791097, 658.1049772309655, 659.5976454362835, 660.4221306356937, 14052.297385130805, 14154.575362739135, 14190.148591084568, 14294.356753945993, 14407.279636018262, 12488.0, 12951.158174718614, 13135.34323283832, 13211.867881321255, 13264.933675331658, 10884.401357925311, 10935.83596246057, 10944.726381840517, 11068.778624427547, 11219.102471802236, 3738.6261373862667, 3759.8496060157563, 3779.811009449544, 3822.311983842907, 3880.3985382265796, 65373.67313163451, 69174.65412672955, 69312.30687693109, 69578.65210673965, 70323.0, 9413.48225847585, 9610.95194524023, 9716.125548700651, 9800.36297640651, 9858.112769850748, 19720.70418943717, 19778.10998505071, 19890.50273743168, 19928.0, 20081.799182008286, 8856.247218986458, 8979.955100224588, 9006.0, 9089.95455022734, 9174.082591740773, 4866.853994380174, 4966.975165124223, 4996.975015124901, 5070.974645126751, 5104.642675012714, 3536.504889315498, 3631.055925459347, 3671.210689701727, 3676.6139555346303, 3682.1899182179877, 584.7018020809418, 593.3888095261888, 604.685563506974, 614.7725341623538, 618.913352130702, 674.3223060823841, 721.8989341492195, 730.4193166432699, 732.9230430804795, 786.194150995223, 9339.20616747584, 9638.518074096408, 9759.365641233297, 10281.228907831943, 10312.484375781181, 544.1918750655274, 559.446148313167, 565.8988741695532, 574.5891687443415, 700.527144177678, 4165.562615925284, 4232.280512312914, 4525.027119169395, 4539.931901021488, 4686.601638860667, 60255.397446025854, 87258.56370718233, 89282.55358723165, 91020.54489727641, 93084.0, 51892.0, 65279.0, 84159.57920210483, 84954.57522712347, 87115.0, 75550.0, 76291.0, 76758.61620691973, 77046.6147669258, 77224.0, 9465.384749991228, 9774.902250977399, 9976.0, 10011.949940250252, 10014.549345279625, 48287.275690863964, 48387.5161248383, 48591.514084860115, 49271.0, 49501.75249123731, 64674.676626616565, 65679.67160164169, 68858.3114168872, 68909.65545172241, 71255.0, 13092.410841511964, 13362.465501379836, 13402.396892140072, 13504.86495135036, 13556.796648050484, 14809.629759256104, 15032.849671503145, 15072.623184420478, 15197.6200594986, 16187.352505899633, 14273.64315892111, 14341.067830590979, 14417.567472975408, 14469.565913022627, 14637.0, 12071.094667899766, 12342.44458999365, 12445.688857778629, 12884.549040783528, 12967.935160324138, 13024.348782560644, 13096.934515327363, 13391.933040334736, 13406.463741450232, 13426.664333391744, 10256.12822910061, 10401.843972340572, 10762.892371076188, 10876.456177191267, 11000.944995274973, 10411.531481083219, 11324.716882077684, 11656.766864662828, 11696.590619328283, 11935.986885507933], "value": 7309.232974319018, "unit": "score"}], "name": "dromaeo_css", "value": 7445.083424114797, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 113.0, 112.0, 111.0, 112.0, 112.0, 112.0, 112.0, 112.0, 111.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 119.0, 120.0, 155.0, 119.0, 137.0, 118.0, 118.0, 147.0, 119.0], "value": 130.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 163.0, 162.0, 161.0, 161.0, 162.0, 162.0, 160.0, 161.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 113.0, 77.0, 77.0, 80.0, 77.0, 106.0, 76.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 109.0, 82.0, 82.0, 82.0, 98.0, 82.0, 82.0, 114.0], "value": 89.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 84.0, 86.0, 85.0, 86.0, 86.0, 84.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 50.0, 50.0, 52.0, 53.0, 50.0, 50.0, 51.0, 52.0], "value": 51.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 61.0, 60.0, 62.0, 60.0, 61.0, 62.0, 61.0, 61.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 76.0, 76.0, 77.0, 75.0, 76.0, 75.0, 75.0], "value": 75.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 130.0, 123.0, 121.0, 122.0, 123.0, 119.0, 120.0, 166.0, 139.0], "value": 130.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 152.0, 152.0, 156.0, 155.0, 151.0, 151.0, 153.0, 152.0, 152.0], "value": 153.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 69.0, 62.0, 63.0, 64.0, 64.0, 61.0, 62.0], "value": 63.4, "unit": "score"}], "name": "kraken", "value": 1460.2, "alertThreshold": 2.0}]} 10:18:32 INFO - Return code: 0 10:18:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:18:32 INFO - # TBPL SUCCESS # 10:18:32 INFO - Running post-action listener: _resource_record_post_action 10:18:32 INFO - [mozharness: 2017-01-17 18:18:32.356599Z] Finished run-tests step (success) 10:18:32 INFO - Running post-run listener: _resource_record_post_run 10:18:32 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 266240; Write bytes: 357806080; Read time: 24; Write time: 242280 10:18:32 INFO - TinderboxPrint: CPU usage
13.0% 10:18:32 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 24 10:18:32 INFO - TinderboxPrint: I/O write bytes / time
357,806,080 / 242,280 10:18:32 INFO - TinderboxPrint: CPU idle
8,272.0 (87.0%) 10:18:32 INFO - TinderboxPrint: CPU user
1,193.4 (12.5%) 10:18:32 INFO - TinderboxPrint: Swap in / out
0 / 0 10:18:32 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108294144; Read time: 0; Write time: 90388 10:18:32 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 262144; Write bytes: 249511936; Read time: 16; Write time: 151892 10:18:32 INFO - Running post-run listener: _upload_blobber_files 10:18:32 INFO - Blob upload gear active. 10:18:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:18:32 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 10:18:32 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'] 10:18:32 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 10:18:33 INFO - (blobuploader) - INFO - Open directory for files ... 10:18:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:18:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:18:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:18:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:18:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:18:36 INFO - (blobuploader) - INFO - Done attempting. 10:18:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:18:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:18:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:18:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:18:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:18:37 INFO - (blobuploader) - INFO - Done attempting. 10:18:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:18:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:18:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:18:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:18:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:18:40 INFO - (blobuploader) - INFO - Done attempting. 10:18:40 INFO - (blobuploader) - INFO - Iteration through files over. 10:18:40 INFO - Return code: 0 10:18:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:18:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:18:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4b8322239f8afcd8971fd428a718beff26ee4d948b1d6eb2ea0d9e95498940378591a99c633c672184a1f1b35e62606a670fd20b4a2b4b5cf7a03ad353cc5dd6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a79de2a3bbacb687041379bdff0412654576527dcc6f1b51f6acbf1a9c76f888a10b3c7e014b73e0ff735cfcd05a9c25ac3b001d784b8f45f980998c4cb3589b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0aa01e72e0766aaefc5c3e291942df3bcd2fc20e12e0b0bc4043fa3848e16c9ddde9eb1569c652936282cc1830fcc85e7d9ba1453548f512072d3c321b23224d"} 10:18:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:18:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:18:40 INFO - Contents: 10:18:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4b8322239f8afcd8971fd428a718beff26ee4d948b1d6eb2ea0d9e95498940378591a99c633c672184a1f1b35e62606a670fd20b4a2b4b5cf7a03ad353cc5dd6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a79de2a3bbacb687041379bdff0412654576527dcc6f1b51f6acbf1a9c76f888a10b3c7e014b73e0ff735cfcd05a9c25ac3b001d784b8f45f980998c4cb3589b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0aa01e72e0766aaefc5c3e291942df3bcd2fc20e12e0b0bc4043fa3848e16c9ddde9eb1569c652936282cc1830fcc85e7d9ba1453548f512072d3c321b23224d"} 10:18:40 INFO - Running post-run listener: copy_logs_to_upload_dir 10:18:40 INFO - Copying logs to upload dir... 10:18:40 INFO - mkdir: /builds/slave/test/build/upload/logs 10:18:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.377392 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-01-17 10:18:38.576235) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-17 10:18:38.579977) ========= 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=52faae308a556c440401f8e5000001e8-1484675299.809550-2129882312 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/4b8322239f8afcd8971fd428a718beff26ee4d948b1d6eb2ea0d9e95498940378591a99c633c672184a1f1b35e62606a670fd20b4a2b4b5cf7a03ad353cc5dd6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a79de2a3bbacb687041379bdff0412654576527dcc6f1b51f6acbf1a9c76f888a10b3c7e014b73e0ff735cfcd05a9c25ac3b001d784b8f45f980998c4cb3589b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0aa01e72e0766aaefc5c3e291942df3bcd2fc20e12e0b0bc4043fa3848e16c9ddde9eb1569c652936282cc1830fcc85e7d9ba1453548f512072d3c321b23224d"} build_url:https://queue.taskcluster.net/v1/task/Gv1monBCSVelJN1Ib5FKqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011504 build_url: 'https://queue.taskcluster.net/v1/task/Gv1monBCSVelJN1Ib5FKqA/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/4b8322239f8afcd8971fd428a718beff26ee4d948b1d6eb2ea0d9e95498940378591a99c633c672184a1f1b35e62606a670fd20b4a2b4b5cf7a03ad353cc5dd6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a79de2a3bbacb687041379bdff0412654576527dcc6f1b51f6acbf1a9c76f888a10b3c7e014b73e0ff735cfcd05a9c25ac3b001d784b8f45f980998c4cb3589b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0aa01e72e0766aaefc5c3e291942df3bcd2fc20e12e0b0bc4043fa3848e16c9ddde9eb1569c652936282cc1830fcc85e7d9ba1453548f512072d3c321b23224d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-17 10:18:38.605366) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 10:18:38.605701) ========= 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=52faae308a556c440401f8e5000001e8-1484675299.809550-2129882312 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-17 10:18:38.690387) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-17 10:18:38.690709) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-17 10:18:38.690996) ========= ========= Total master_lag: 0.39 =========