builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-065 starttime: 1476357740.64 results: success (0) buildid: 20161013013001 builduid: 463cd5ad647f4176b1cc211f64cc1eb7 revision: 9a047a39cb2f7e4f97a8b5c0bccc3096efd0aa05 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 04:22:20.640023) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 04:22:20.640576) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 04:22:20.640875) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 04:22:20.652386) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 04:22:20.652774) ========= 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=523ca41ca1e0623de333ad52000001bf-1476357740.760330-2080187500 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-13 04:22:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 139M=0s 2016-10-13 04:22:21 (139 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.139544 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 04:22:20.803936) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 04:22:20.804265) ========= 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=523ca41ca1e0623de333ad52000001bf-1476357740.760330-2080187500 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015863 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 04:22:20.854882) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 04:22:20.855305) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9a047a39cb2f7e4f97a8b5c0bccc3096efd0aa05 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 9a047a39cb2f7e4f97a8b5c0bccc3096efd0aa05 --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=523ca41ca1e0623de333ad52000001bf-1476357740.760330-2080187500 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-13 04:22:21,876 truncating revision to first 12 chars 2016-10-13 04:22:21,876 Setting DEBUG logging. 2016-10-13 04:22:21,876 attempt 1/10 2016-10-13 04:22:21,876 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9a047a39cb2f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-13 04:22:22,177 unpacking tar archive at: mozilla-central-9a047a39cb2f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.603316 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 04:22:21.472139) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 04:22:21.472471) ========= script_repo_revision: 9a047a39cb2f7e4f97a8b5c0bccc3096efd0aa05 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 04:22:21.472889) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 04:22:21.473170) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 04:22:21.483419) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-13 04:22:21.483714) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=523ca41ca1e0623de333ad52000001bf-1476357740.760330-2080187500 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:22:22 INFO - MultiFileLogger online at 20161013 04:22:22 in /builds/slave/test 04:22:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:22:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:22:22 INFO - {'append_to_log': False, 04:22:22 INFO - 'base_work_dir': '/builds/slave/test', 04:22:22 INFO - 'blob_upload_branch': 'Firefox', 04:22:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:22:22 INFO - 'branch': 'Firefox', 04:22:22 INFO - 'buildbot_json_path': 'buildprops.json', 04:22:22 INFO - 'config_files': ('talos/linux_config.py',), 04:22:22 INFO - 'default_actions': ('clobber', 04:22:22 INFO - 'read-buildbot-config', 04:22:22 INFO - 'download-and-extract', 04:22:22 INFO - 'populate-webroot', 04:22:22 INFO - 'create-virtualenv', 04:22:22 INFO - 'install', 04:22:22 INFO - 'run-tests'), 04:22:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:22:22 INFO - 'download_minidump_stackwalk': True, 04:22:22 INFO - 'download_symbols': 'ondemand', 04:22:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:22:22 INFO - 'tooltool.py': '/tools/tooltool.py', 04:22:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:22:22 INFO - '/tools/misc-python/virtualenv.py')}, 04:22:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:22:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:22:22 INFO - 'installer_path': 'installer.exe', 04:22:22 INFO - 'log_level': 'info', 04:22:22 INFO - 'log_name': 'talos', 04:22:22 INFO - 'log_to_console': True, 04:22:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:22:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:22:22 INFO - 'opt_config_files': (), 04:22:22 INFO - 'pip_index': False, 04:22:22 INFO - 'sps_profile': False, 04:22:22 INFO - 'sps_profile_interval': 0, 04:22:22 INFO - 'suite': 'dromaeojs', 04:22:22 INFO - 'system_bits': '32', 04:22:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:22:22 INFO - 'title': 'talos-linux64-ix-065', 04:22:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:22:22 INFO - 'use_talos_json': True, 04:22:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:22:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:22:22 INFO - 'work_dir': 'build'} 04:22:22 INFO - [mozharness: 2016-10-13 11:22:22.601798Z] Running clobber step. 04:22:22 INFO - Running pre-action listener: _resource_record_pre_action 04:22:22 INFO - Running main action method: clobber 04:22:22 INFO - rmtree: /builds/slave/test/build 04:22:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:22:23 INFO - Running post-action listener: _resource_record_post_action 04:22:23 INFO - [mozharness: 2016-10-13 11:22:23.079516Z] Finished clobber step (success) 04:22:23 INFO - [mozharness: 2016-10-13 11:22:23.079617Z] Running read-buildbot-config step. 04:22:23 INFO - Running pre-action listener: _resource_record_pre_action 04:22:23 INFO - Running main action method: read_buildbot_config 04:22:23 INFO - Using buildbot properties: 04:22:23 INFO - { 04:22:23 INFO - "project": "", 04:22:23 INFO - "product": "firefox", 04:22:23 INFO - "script_repo_revision": "production", 04:22:23 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:22:23 INFO - "repository": "", 04:22:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 04:22:23 INFO - "buildid": "20161013013001", 04:22:23 INFO - "pgo_build": "True", 04:22:23 INFO - "basedir": "/builds/slave/test", 04:22:23 INFO - "buildnumber": 35, 04:22:23 INFO - "slavename": "talos-linux64-ix-065", 04:22:23 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:22:23 INFO - "platform": "ubuntu64_hw", 04:22:23 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 04:22:23 INFO - "branch": "mozilla-central", 04:22:23 INFO - "repo_path": "mozilla-central", 04:22:23 INFO - "revision": "9a047a39cb2f7e4f97a8b5c0bccc3096efd0aa05", 04:22:23 INFO - "stage_platform": "linux64-pgo", 04:22:23 INFO - "builduid": "463cd5ad647f4176b1cc211f64cc1eb7", 04:22:23 INFO - "slavebuilddir": "test" 04:22:23 INFO - } 04:22:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/Xf-B2-E3TkChYPYsjabF7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 04:22:23 INFO - Running post-action listener: _resource_record_post_action 04:22:23 INFO - [mozharness: 2016-10-13 11:22:23.082057Z] Finished read-buildbot-config step (success) 04:22:23 INFO - [mozharness: 2016-10-13 11:22:23.082147Z] Running download-and-extract step. 04:22:23 INFO - Running pre-action listener: _resource_record_pre_action 04:22:23 INFO - Running main action method: download_and_extract 04:22:23 INFO - mkdir: /builds/slave/test/build/tests 04:22:23 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')]} 04:22:23 INFO - trying https://queue.taskcluster.net/v1/task/Xf-B2-E3TkChYPYsjabF7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:22:23 INFO - Downloading https://queue.taskcluster.net/v1/task/Xf-B2-E3TkChYPYsjabF7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:22:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xf-B2-E3TkChYPYsjabF7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:22:23 INFO - Downloaded 1361 bytes. 04:22:23 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 04:22:23 INFO - Using the following test package requirements: 04:22:23 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:22:23 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:22:23 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:22:23 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:23 INFO - u'jsshell-linux-x86_64.zip'], 04:22:23 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:22:23 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 04:22:23 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:22:23 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:22:23 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:22:23 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 04:22:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:22:23 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:22:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xf-B2-E3TkChYPYsjabF7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:22:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xf-B2-E3TkChYPYsjabF7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:22:23 INFO - Fetch https://queue.taskcluster.net/v1/task/Xf-B2-E3TkChYPYsjabF7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:22:24 INFO - Http code: 200 04:22:24 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 04:22:24 INFO - x-amz-cf-id: IKDQHLHAAV5pLSdc9mYCpSs7oBPyg8C3DeSffsb_XlhBakKfaFwz5Q== 04:22:24 INFO - x-amz-version-id: 4pRdp5uopiunoi68Bi8BBLih2jshvPF4 04:22:24 INFO - Expected file size: 22117477 04:22:24 INFO - Obtained file size: 22117477 04:22:28 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:22:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xf-B2-E3TkChYPYsjabF7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 04:22:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xf-B2-E3TkChYPYsjabF7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:22:28 INFO - Fetch https://queue.taskcluster.net/v1/task/Xf-B2-E3TkChYPYsjabF7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:22:29 INFO - Http code: 200 04:22:29 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 04:22:29 INFO - x-amz-cf-id: 1Hpv2PmOyKAdeS1YjcptUd7yaV3VK363mMxhaxMnpsBjQCieogBbqg== 04:22:29 INFO - x-amz-version-id: 4pRdp5uopiunoi68Bi8BBLih2jshvPF4 04:22:29 INFO - Expected file size: 22117477 04:22:29 INFO - Obtained file size: 22117477 04:22:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Xf-B2-E3TkChYPYsjabF7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 04:22:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Xf-B2-E3TkChYPYsjabF7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:22:33 INFO - Fetch https://queue.taskcluster.net/v1/task/Xf-B2-E3TkChYPYsjabF7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 04:22:34 INFO - Http code: 200 04:22:34 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 04:22:34 INFO - x-amz-cf-id: 4nwt4ZbVblsxy4nYQDMlH1OXPcKAvXnggZcZAm-EvoXXFbryZyuJ2g== 04:22:34 INFO - x-amz-version-id: zqcQKTSjf4hP.gkEO5f8mKnvFbHinJt6 04:22:34 INFO - Expected file size: 14409006 04:22:34 INFO - Obtained file size: 14409006 04:22:34 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')]} 04:22:34 INFO - trying https://queue.taskcluster.net/v1/task/Xf-B2-E3TkChYPYsjabF7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:22:34 INFO - Downloading https://queue.taskcluster.net/v1/task/Xf-B2-E3TkChYPYsjabF7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:22:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Xf-B2-E3TkChYPYsjabF7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:22:36 INFO - Downloaded 59797316 bytes. 04:22:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Xf-B2-E3TkChYPYsjabF7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:22:36 INFO - mkdir: /builds/slave/test/properties 04:22:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:22:36 INFO - Writing to file /builds/slave/test/properties/build_url 04:22:36 INFO - Contents: 04:22:36 INFO - build_url:https://queue.taskcluster.net/v1/task/Xf-B2-E3TkChYPYsjabF7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 04:22:36 INFO - Running post-action listener: _resource_record_post_action 04:22:36 INFO - Running post-action listener: set_extra_try_arguments 04:22:36 INFO - [mozharness: 2016-10-13 11:22:36.803283Z] Finished download-and-extract step (success) 04:22:36 INFO - [mozharness: 2016-10-13 11:22:36.803511Z] Running populate-webroot step. 04:22:36 INFO - Running pre-action listener: _resource_record_pre_action 04:22:36 INFO - Running main action method: populate_webroot 04:22:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:22:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:22:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:22:36 INFO - '--tppagecycles', 04:22:36 INFO - '7'], 04:22:36 INFO - 'tests': ['tsvgm']}}, 04:22:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:22:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:22:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:22:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:22:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:22:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:22:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:36 INFO - 'talos_options': ['--disable-e10s'], 04:22:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:22:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:22:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:36 INFO - 'talos_options': ['--disable-e10s'], 04:22:36 INFO - 'tests': ['damp', 'tps']}, 04:22:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:36 INFO - 'tests': ['damp', 'tps']}, 04:22:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:22:36 INFO - 'tests': ['dromaeo_dom']}, 04:22:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:22:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:22:36 INFO - 'tests': ['basic_compositor_video']}, 04:22:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:22:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:22:36 INFO - 'tests': ['a11yr', 04:22:36 INFO - 'ts_paint', 04:22:36 INFO - 'tpaint', 04:22:36 INFO - 'sessionrestore', 04:22:36 INFO - 'sessionrestore_no_auto_restore', 04:22:36 INFO - 'tabpaint']}, 04:22:36 INFO - 'other-e10s': {'tests': ['a11yr', 04:22:36 INFO - 'ts_paint', 04:22:36 INFO - 'tpaint', 04:22:36 INFO - 'sessionrestore', 04:22:36 INFO - 'sessionrestore_no_auto_restore', 04:22:36 INFO - 'tabpaint']}, 04:22:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:22:36 INFO - 'ts_paint', 04:22:36 INFO - 'tpaint', 04:22:36 INFO - 'sessionrestore', 04:22:36 INFO - 'sessionrestore_no_auto_restore', 04:22:36 INFO - 'tabpaint']}, 04:22:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:22:36 INFO - 'ts_paint', 04:22:36 INFO - 'tpaint', 04:22:36 INFO - 'sessionrestore', 04:22:36 INFO - 'sessionrestore_no_auto_restore', 04:22:36 INFO - 'tabpaint']}, 04:22:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:22:36 INFO - 'tests': ['a11yr', 04:22:36 INFO - 'ts_paint', 04:22:36 INFO - 'tpaint', 04:22:36 INFO - 'sessionrestore', 04:22:36 INFO - 'sessionrestore_no_auto_restore', 04:22:36 INFO - 'tabpaint']}, 04:22:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:22:36 INFO - 'tests': ['a11yr', 04:22:36 INFO - 'ts_paint', 04:22:36 INFO - 'tpaint', 04:22:36 INFO - 'sessionrestore', 04:22:36 INFO - 'sessionrestore_no_auto_restore', 04:22:36 INFO - 'tabpaint']}, 04:22:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:22:36 INFO - 'tests': ['tsvgx', 04:22:36 INFO - 'tsvgr_opacity', 04:22:36 INFO - 'tart', 04:22:36 INFO - 'tscrollx', 04:22:36 INFO - 'cart']}, 04:22:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:22:36 INFO - 'tsvgr_opacity', 04:22:36 INFO - 'tart', 04:22:36 INFO - 'tscrollx', 04:22:36 INFO - 'cart']}, 04:22:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:36 INFO - 'talos_options': ['--disable-e10s'], 04:22:36 INFO - 'tests': ['tp5o']}, 04:22:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:36 INFO - 'tests': ['tp5o']}, 04:22:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:36 INFO - 'talos_options': ['--disable-e10s', 04:22:36 INFO - '--xperf_path', 04:22:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:22:36 INFO - 'tests': ['tp5n']}, 04:22:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:22:36 INFO - 'talos_options': ['--xperf_path', 04:22:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:22:36 INFO - 'tests': ['tp5n']}}, 04:22:36 INFO - 'talos.zip': {'path': '', 04:22:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:22:36 INFO - Running post-action listener: _resource_record_post_action 04:22:36 INFO - [mozharness: 2016-10-13 11:22:36.825928Z] Finished populate-webroot step (success) 04:22:36 INFO - [mozharness: 2016-10-13 11:22:36.826017Z] Running create-virtualenv step. 04:22:36 INFO - Running pre-action listener: _resource_record_pre_action 04:22:36 INFO - Running main action method: create_virtualenv 04:22:36 INFO - Creating virtualenv /builds/slave/test/build/venv 04:22:36 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 04:22:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:22:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:22:36 INFO - Using real prefix '/usr' 04:22:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:22:37 INFO - Installing distribute.............................................................................................................................................................................................done. 04:22:39 INFO - Installing pip.................done. 04:22:39 INFO - Return code: 0 04:22:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:22:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:22:39 INFO - Reading from file tmpfile_stdout 04:22:39 INFO - Output received: 04:22:39 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) 04:22:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:22: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')]} 04:22:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22: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')]} 04:22:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f02773ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17457b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d4790>, '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 0x17d5690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d5b20>, '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': '523ca41ca1e0623de333ad52000001bf-1476357740.760330-2080187500', '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 04:22: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', 'pip>=1.5'] in /builds/slave/test/build 04:22: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 pip>=1.5 04:22:39 INFO - Using env: {'DISPLAY': ':0', 04:22:39 INFO - 'HOME': '/home/cltbld', 04:22:39 INFO - 'LANG': 'en_US.UTF-8', 04:22:39 INFO - 'LANGUAGE': 'en_US:en', 04:22:39 INFO - 'LOGNAME': 'cltbld', 04:22:39 INFO - 'MAIL': '/var/mail/cltbld', 04:22:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:39 INFO - 'MOZ_NO_REMOTE': '1', 04:22:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:39 INFO - 'NO_EM_RESTART': '1', 04:22:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:39 INFO - 'PWD': '/builds/slave/test', 04:22:39 INFO - 'SHELL': '/bin/bash', 04:22:39 INFO - 'SHLVL': '1', 04:22:39 INFO - 'TERM': 'linux', 04:22:39 INFO - 'TMOUT': '86400', 04:22:39 INFO - 'USER': 'cltbld', 04:22:39 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476357740.760330-2080187500', 04:22:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:39 INFO - '_': '/tools/buildbot/bin/python'} 04:22:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:39 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 04:22:39 INFO - Cleaning up... 04:22:39 INFO - Return code: 0 04:22:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:22: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')]} 04:22:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22: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')]} 04:22:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22: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', '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 0x7f02773ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17457b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d4790>, '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 0x17d5690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d5b20>, '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': '523ca41ca1e0623de333ad52000001bf-1476357740.760330-2080187500', '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 04:22: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', 'psutil>=3.1.1'] in /builds/slave/test/build 04:22: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 psutil>=3.1.1 04:22:39 INFO - Using env: {'DISPLAY': ':0', 04:22:39 INFO - 'HOME': '/home/cltbld', 04:22:39 INFO - 'LANG': 'en_US.UTF-8', 04:22:39 INFO - 'LANGUAGE': 'en_US:en', 04:22:39 INFO - 'LOGNAME': 'cltbld', 04:22:39 INFO - 'MAIL': '/var/mail/cltbld', 04:22:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:39 INFO - 'MOZ_NO_REMOTE': '1', 04:22:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:39 INFO - 'NO_EM_RESTART': '1', 04:22:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:39 INFO - 'PWD': '/builds/slave/test', 04:22:39 INFO - 'SHELL': '/bin/bash', 04:22:39 INFO - 'SHLVL': '1', 04:22:39 INFO - 'TERM': 'linux', 04:22:39 INFO - 'TMOUT': '86400', 04:22:39 INFO - 'USER': 'cltbld', 04:22:39 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476357740.760330-2080187500', 04:22:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:39 INFO - '_': '/tools/buildbot/bin/python'} 04:22:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:40 INFO - Downloading/unpacking psutil>=3.1.1 04:22:40 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 04:22:40 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 04:22:40 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 04:22:40 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 04:22:40 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 04:22:40 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 04:22:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:22:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:22:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:22:42 INFO - Installing collected packages: psutil 04:22:42 INFO - Running setup.py install for psutil 04:22:42 INFO - building 'psutil._psutil_linux' extension 04:22:42 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 04:22:42 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 04:22:42 INFO - building 'psutil._psutil_posix' extension 04:22:42 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 04:22:42 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 04:22:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:22:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:22:42 INFO - Successfully installed psutil 04:22:42 INFO - Cleaning up... 04:22:42 INFO - Return code: 0 04:22:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f02773ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17457b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d4790>, '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 0x17d5690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d5b20>, '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': '523ca41ca1e0623de333ad52000001bf-1476357740.760330-2080187500', '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 04:22:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:22:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:22:42 INFO - Using env: {'DISPLAY': ':0', 04:22:42 INFO - 'HOME': '/home/cltbld', 04:22:42 INFO - 'LANG': 'en_US.UTF-8', 04:22:42 INFO - 'LANGUAGE': 'en_US:en', 04:22:42 INFO - 'LOGNAME': 'cltbld', 04:22:42 INFO - 'MAIL': '/var/mail/cltbld', 04:22:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:42 INFO - 'MOZ_NO_REMOTE': '1', 04:22:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:42 INFO - 'NO_EM_RESTART': '1', 04:22:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:42 INFO - 'PWD': '/builds/slave/test', 04:22:42 INFO - 'SHELL': '/bin/bash', 04:22:42 INFO - 'SHLVL': '1', 04:22:42 INFO - 'TERM': 'linux', 04:22:42 INFO - 'TMOUT': '86400', 04:22:42 INFO - 'USER': 'cltbld', 04:22:42 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476357740.760330-2080187500', 04:22:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:42 INFO - '_': '/tools/buildbot/bin/python'} 04:22:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:22:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:22:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:22:44 INFO - Installing collected packages: mozsystemmonitor 04:22:44 INFO - Running setup.py install for mozsystemmonitor 04:22:44 INFO - Successfully installed mozsystemmonitor 04:22:44 INFO - Cleaning up... 04:22:45 INFO - Return code: 0 04:22:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f02773ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17457b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d4790>, '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 0x17d5690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d5b20>, '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': '523ca41ca1e0623de333ad52000001bf-1476357740.760330-2080187500', '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 04:22:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:22:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:22:45 INFO - Using env: {'DISPLAY': ':0', 04:22:45 INFO - 'HOME': '/home/cltbld', 04:22:45 INFO - 'LANG': 'en_US.UTF-8', 04:22:45 INFO - 'LANGUAGE': 'en_US:en', 04:22:45 INFO - 'LOGNAME': 'cltbld', 04:22:45 INFO - 'MAIL': '/var/mail/cltbld', 04:22:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:45 INFO - 'MOZ_NO_REMOTE': '1', 04:22:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:45 INFO - 'NO_EM_RESTART': '1', 04:22:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:45 INFO - 'PWD': '/builds/slave/test', 04:22:45 INFO - 'SHELL': '/bin/bash', 04:22:45 INFO - 'SHLVL': '1', 04:22:45 INFO - 'TERM': 'linux', 04:22:45 INFO - 'TMOUT': '86400', 04:22:45 INFO - 'USER': 'cltbld', 04:22:45 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476357740.760330-2080187500', 04:22:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:45 INFO - '_': '/tools/buildbot/bin/python'} 04:22:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:45 INFO - Downloading/unpacking jsonschema==2.5.1 04:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:22:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:47 INFO - Downloading functools32-3.2.3-2.tar.gz 04:22:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:22:47 INFO - warning: no files found matching '*.txt' 04:22:47 INFO - no previously-included directories found matching 'build' 04:22:47 INFO - no previously-included directories found matching 'dist' 04:22:47 INFO - no previously-included directories found matching '.git*' 04:22:47 INFO - Installing collected packages: jsonschema, functools32 04:22:47 INFO - Running setup.py install for functools32 04:22:47 INFO - warning: no files found matching '*.txt' 04:22:47 INFO - no previously-included directories found matching 'build' 04:22:47 INFO - no previously-included directories found matching 'dist' 04:22:47 INFO - no previously-included directories found matching '.git*' 04:22:47 INFO - Successfully installed jsonschema functools32 04:22:47 INFO - Cleaning up... 04:22:47 INFO - Return code: 0 04:22:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:22:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f02773ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17457b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d4790>, '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 0x17d5690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d5b20>, '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': '523ca41ca1e0623de333ad52000001bf-1476357740.760330-2080187500', '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 04:22:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:22:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:22:47 INFO - Using env: {'DISPLAY': ':0', 04:22:47 INFO - 'HOME': '/home/cltbld', 04:22:47 INFO - 'LANG': 'en_US.UTF-8', 04:22:47 INFO - 'LANGUAGE': 'en_US:en', 04:22:47 INFO - 'LOGNAME': 'cltbld', 04:22:47 INFO - 'MAIL': '/var/mail/cltbld', 04:22:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:47 INFO - 'MOZ_NO_REMOTE': '1', 04:22:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:47 INFO - 'NO_EM_RESTART': '1', 04:22:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:47 INFO - 'PWD': '/builds/slave/test', 04:22:47 INFO - 'SHELL': '/bin/bash', 04:22:47 INFO - 'SHLVL': '1', 04:22:47 INFO - 'TERM': 'linux', 04:22:47 INFO - 'TMOUT': '86400', 04:22:47 INFO - 'USER': 'cltbld', 04:22:47 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476357740.760330-2080187500', 04:22:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:47 INFO - '_': '/tools/buildbot/bin/python'} 04:22:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:22:47 INFO - Cleaning up... 04:22:47 INFO - Return code: 0 04:22:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:22:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f02773ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17457b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d4790>, '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 0x17d5690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d5b20>, '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': '523ca41ca1e0623de333ad52000001bf-1476357740.760330-2080187500', '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 04:22:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:22:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:22:47 INFO - Using env: {'DISPLAY': ':0', 04:22:47 INFO - 'HOME': '/home/cltbld', 04:22:47 INFO - 'LANG': 'en_US.UTF-8', 04:22:47 INFO - 'LANGUAGE': 'en_US:en', 04:22:47 INFO - 'LOGNAME': 'cltbld', 04:22:47 INFO - 'MAIL': '/var/mail/cltbld', 04:22:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:47 INFO - 'MOZ_NO_REMOTE': '1', 04:22:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:47 INFO - 'NO_EM_RESTART': '1', 04:22:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:47 INFO - 'PWD': '/builds/slave/test', 04:22:47 INFO - 'SHELL': '/bin/bash', 04:22:47 INFO - 'SHLVL': '1', 04:22:47 INFO - 'TERM': 'linux', 04:22:47 INFO - 'TMOUT': '86400', 04:22:47 INFO - 'USER': 'cltbld', 04:22:47 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476357740.760330-2080187500', 04:22:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:47 INFO - '_': '/tools/buildbot/bin/python'} 04:22:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:48 INFO - Downloading/unpacking blobuploader==1.2.4 04:22:48 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 04:22:48 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 04:22:48 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 04:22:48 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 04:22:48 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 04:22:48 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 04:22:50 INFO - Downloading blobuploader-1.2.4.tar.gz 04:22:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:22:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:22:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:22:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:22:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:22:50 INFO - Downloading docopt-0.6.1.tar.gz 04:22:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:22:50 INFO - Installing collected packages: blobuploader, requests, docopt 04:22:50 INFO - Running setup.py install for blobuploader 04:22:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:22:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:22:50 INFO - Running setup.py install for requests 04:22:51 INFO - Running setup.py install for docopt 04:22:51 INFO - Successfully installed blobuploader requests docopt 04:22:51 INFO - Cleaning up... 04:22:51 INFO - Return code: 0 04:22:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:22:51 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')]} 04:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:51 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')]} 04:22:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:51 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 0x7f02773ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17457b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d4790>, '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 0x17d5690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d5b20>, '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': '523ca41ca1e0623de333ad52000001bf-1476357740.760330-2080187500', '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 04:22:51 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 04:22:51 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 04:22:51 INFO - Using env: {'DISPLAY': ':0', 04:22:51 INFO - 'HOME': '/home/cltbld', 04:22:51 INFO - 'LANG': 'en_US.UTF-8', 04:22:51 INFO - 'LANGUAGE': 'en_US:en', 04:22:51 INFO - 'LOGNAME': 'cltbld', 04:22:51 INFO - 'MAIL': '/var/mail/cltbld', 04:22:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:51 INFO - 'MOZ_NO_REMOTE': '1', 04:22:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:51 INFO - 'NO_EM_RESTART': '1', 04:22:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:51 INFO - 'PWD': '/builds/slave/test', 04:22:51 INFO - 'SHELL': '/bin/bash', 04:22:51 INFO - 'SHLVL': '1', 04:22:51 INFO - 'TERM': 'linux', 04:22:51 INFO - 'TMOUT': '86400', 04:22:51 INFO - 'USER': 'cltbld', 04:22:51 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476357740.760330-2080187500', 04:22:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:51 INFO - '_': '/tools/buildbot/bin/python'} 04:22:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:22:51 INFO - Running setup.py (path:/tmp/pip-GhYIva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:22:51 INFO - Running setup.py (path:/tmp/pip-irIaZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:22:51 INFO - Running setup.py (path:/tmp/pip-Sn_FJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:22:51 INFO - Running setup.py (path:/tmp/pip-4J6nb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:22:51 INFO - Running setup.py (path:/tmp/pip-cDTinm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:22:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:22:51 INFO - Running setup.py (path:/tmp/pip-djIVfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:22:52 INFO - Running setup.py (path:/tmp/pip-ZGq4tG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:22:52 INFO - Running setup.py (path:/tmp/pip-H_1CPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:22:52 INFO - Running setup.py (path:/tmp/pip-h4e_8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:22:52 INFO - Running setup.py (path:/tmp/pip-dVfA0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:22:52 INFO - Running setup.py (path:/tmp/pip-trClss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:22:52 INFO - Running setup.py (path:/tmp/pip-BXKXiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:22:52 INFO - Running setup.py (path:/tmp/pip-2mGjVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:22:52 INFO - Running setup.py (path:/tmp/pip-xldoTV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:22:52 INFO - Running setup.py (path:/tmp/pip-DM5R8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:22:52 INFO - Running setup.py (path:/tmp/pip-rus1Il-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:22:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:22:52 INFO - Running setup.py (path:/tmp/pip-jSvDmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:22:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:22:52 INFO - Running setup.py install for manifestparser 04:22:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:22:52 INFO - Running setup.py install for mozcrash 04:22:53 INFO - Running setup.py install for mozdebug 04:22:53 INFO - Running setup.py install for mozdevice 04:22:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:22:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:22:53 INFO - Running setup.py install for mozfile 04:22:53 INFO - Running setup.py install for mozhttpd 04:22:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:22:53 INFO - Running setup.py install for mozinfo 04:22:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:22:53 INFO - Running setup.py install for mozInstall 04:22:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:22:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:22:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:22:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:22:53 INFO - Running setup.py install for mozleak 04:22:53 INFO - Running setup.py install for mozlog 04:22:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:22:53 INFO - Running setup.py install for moznetwork 04:22:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:22:53 INFO - Running setup.py install for mozprocess 04:22:54 INFO - Running setup.py install for mozprofile 04:22:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:22:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:22:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:22:54 INFO - Running setup.py install for mozrunner 04:22:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:22:54 INFO - Running setup.py install for mozscreenshot 04:22:54 INFO - Running setup.py install for moztest 04:22:54 INFO - Running setup.py install for mozversion 04:22:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:22:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:22:54 INFO - Cleaning up... 04:22:54 INFO - Return code: 0 04:22:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:22:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:54 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 0x7f02773ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17457b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d4790>, '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 0x17d5690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d5b20>, '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': '523ca41ca1e0623de333ad52000001bf-1476357740.760330-2080187500', '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 04:22:54 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 04:22:54 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 04:22:54 INFO - Using env: {'DISPLAY': ':0', 04:22:54 INFO - 'HOME': '/home/cltbld', 04:22:54 INFO - 'LANG': 'en_US.UTF-8', 04:22:54 INFO - 'LANGUAGE': 'en_US:en', 04:22:54 INFO - 'LOGNAME': 'cltbld', 04:22:54 INFO - 'MAIL': '/var/mail/cltbld', 04:22:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:54 INFO - 'MOZ_NO_REMOTE': '1', 04:22:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:54 INFO - 'NO_EM_RESTART': '1', 04:22:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:54 INFO - 'PWD': '/builds/slave/test', 04:22:54 INFO - 'SHELL': '/bin/bash', 04:22:54 INFO - 'SHLVL': '1', 04:22:54 INFO - 'TERM': 'linux', 04:22:54 INFO - 'TMOUT': '86400', 04:22:54 INFO - 'USER': 'cltbld', 04:22:54 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476357740.760330-2080187500', 04:22:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:54 INFO - '_': '/tools/buildbot/bin/python'} 04:22:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:22:54 INFO - Running setup.py (path:/tmp/pip-jWWYm8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:22:54 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)) 04:22:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:22:54 INFO - Running setup.py (path:/tmp/pip-LV5LlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:22:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 04:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:22:55 INFO - Running setup.py (path:/tmp/pip-yswVcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:22:55 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)) 04:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:22:55 INFO - Running setup.py (path:/tmp/pip-7PhawU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:22:55 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)) 04:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:22:55 INFO - Running setup.py (path:/tmp/pip-6MxeVY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:22:55 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)) 04:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:22:55 INFO - Running setup.py (path:/tmp/pip-tHq3wx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:22:55 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)) 04:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:22:55 INFO - Running setup.py (path:/tmp/pip-fQFqbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:22:55 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)) 04:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:22:55 INFO - Running setup.py (path:/tmp/pip-xfKYtv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:22:55 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)) 04:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:22:55 INFO - Running setup.py (path:/tmp/pip-7v3gL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:22:55 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)) 04:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:22:55 INFO - Running setup.py (path:/tmp/pip-Erjm53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:22:55 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)) 04:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:22:55 INFO - Running setup.py (path:/tmp/pip-P9alos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:22:55 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)) 04:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:22:55 INFO - Running setup.py (path:/tmp/pip-6u3WUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:22:55 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)) 04:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:22:55 INFO - Running setup.py (path:/tmp/pip-oEGKI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:22:55 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)) 04:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:22:55 INFO - Running setup.py (path:/tmp/pip-MCEppf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:22:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 04:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:22:55 INFO - Running setup.py (path:/tmp/pip-ehKBL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:22:55 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)) 04:22:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:22:55 INFO - Running setup.py (path:/tmp/pip-ZxAoKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:22:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:22:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:22:56 INFO - Running setup.py (path:/tmp/pip-gvetrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:22:56 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)) 04:22:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:22:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:22:56 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)) 04:22:56 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)) 04:22:56 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)) 04:22:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:22:56 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 04:22:56 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 04:22:56 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 04:22:56 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 04:22:56 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 04:22:56 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 04:22:58 INFO - Downloading blessings-1.6.tar.gz 04:22:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:22:58 INFO - Installing collected packages: blessings 04:22:58 INFO - Running setup.py install for blessings 04:22:58 INFO - Successfully installed blessings 04:22:58 INFO - Cleaning up... 04:22:58 INFO - Return code: 0 04:22:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:22:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:22:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:22:58 INFO - Reading from file tmpfile_stdout 04:22:58 INFO - Current package versions: 04:22:58 INFO - argparse == 1.2.1 04:22:58 INFO - blessings == 1.6 04:22:58 INFO - blobuploader == 1.2.4 04:22:58 INFO - docopt == 0.6.1 04:22:58 INFO - functools32 == 3.2.3-2 04:22:58 INFO - jsonschema == 2.5.1 04:22:58 INFO - manifestparser == 1.1 04:22:58 INFO - mozInstall == 1.12 04:22:58 INFO - mozcrash == 0.17 04:22:58 INFO - mozdebug == 0.1 04:22:58 INFO - mozdevice == 0.48 04:22:58 INFO - mozfile == 1.2 04:22:58 INFO - mozhttpd == 0.7 04:22:58 INFO - mozinfo == 0.9 04:22:58 INFO - mozleak == 0.1 04:22:58 INFO - mozlog == 3.4 04:22:58 INFO - moznetwork == 0.27 04:22:58 INFO - mozprocess == 0.23 04:22:58 INFO - mozprofile == 0.28 04:22:58 INFO - mozrunner == 6.12 04:22:58 INFO - mozscreenshot == 0.1 04:22:58 INFO - mozsystemmonitor == 0.3 04:22:58 INFO - moztest == 0.7 04:22:58 INFO - mozversion == 1.4 04:22:58 INFO - psutil == 3.1.1 04:22:58 INFO - requests == 1.2.3 04:22:58 INFO - wsgiref == 0.1.2 04:22:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:22:58 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')]} 04:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:58 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')]} 04:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:58 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 0x7f02773ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17457b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d4790>, '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 0x17d5690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d5b20>, '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': '523ca41ca1e0623de333ad52000001bf-1476357740.760330-2080187500', '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 04:22:58 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 04:22:58 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 04:22:58 INFO - Using env: {'DISPLAY': ':0', 04:22:58 INFO - 'HOME': '/home/cltbld', 04:22:58 INFO - 'LANG': 'en_US.UTF-8', 04:22:58 INFO - 'LANGUAGE': 'en_US:en', 04:22:58 INFO - 'LOGNAME': 'cltbld', 04:22:58 INFO - 'MAIL': '/var/mail/cltbld', 04:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:58 INFO - 'MOZ_NO_REMOTE': '1', 04:22:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:58 INFO - 'NO_EM_RESTART': '1', 04:22:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:58 INFO - 'PWD': '/builds/slave/test', 04:22:58 INFO - 'SHELL': '/bin/bash', 04:22:58 INFO - 'SHLVL': '1', 04:22:58 INFO - 'TERM': 'linux', 04:22:58 INFO - 'TMOUT': '86400', 04:22:58 INFO - 'USER': 'cltbld', 04:22:58 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476357740.760330-2080187500', 04:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:58 INFO - '_': '/tools/buildbot/bin/python'} 04:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:58 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)) 04:22:58 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)) 04:22:58 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)) 04:22:58 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)) 04:22:58 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)) 04:22:58 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)) 04:22:58 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)) 04:22:58 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)) 04:22:58 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)) 04:22:58 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)) 04:22:58 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)) 04:22:58 INFO - Cleaning up... 04:22:58 INFO - Return code: 0 04:22:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:22:58 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')]} 04:22:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:58 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')]} 04:22:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:58 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 0x7f02773ecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16798a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17457b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17d4790>, '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 0x17d5690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d5b20>, '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': '523ca41ca1e0623de333ad52000001bf-1476357740.760330-2080187500', '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 04:22:58 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 04:22:58 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 04:22:58 INFO - Using env: {'DISPLAY': ':0', 04:22:58 INFO - 'HOME': '/home/cltbld', 04:22:58 INFO - 'LANG': 'en_US.UTF-8', 04:22:58 INFO - 'LANGUAGE': 'en_US:en', 04:22:58 INFO - 'LOGNAME': 'cltbld', 04:22:58 INFO - 'MAIL': '/var/mail/cltbld', 04:22:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:58 INFO - 'MOZ_NO_REMOTE': '1', 04:22:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:58 INFO - 'NO_EM_RESTART': '1', 04:22:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:58 INFO - 'PWD': '/builds/slave/test', 04:22:58 INFO - 'SHELL': '/bin/bash', 04:22:58 INFO - 'SHLVL': '1', 04:22:58 INFO - 'TERM': 'linux', 04:22:58 INFO - 'TMOUT': '86400', 04:22:58 INFO - 'USER': 'cltbld', 04:22:58 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476357740.760330-2080187500', 04:22:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:58 INFO - '_': '/tools/buildbot/bin/python'} 04:22:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:22:58 INFO - Cleaning up... 04:22:59 INFO - Return code: 0 04:22:59 INFO - Running post-action listener: _resource_record_post_action 04:22:59 INFO - Running post-action listener: _start_resource_monitoring 04:22:59 INFO - Starting resource monitoring. 04:22:59 INFO - [mozharness: 2016-10-13 11:22:59.044669Z] Finished create-virtualenv step (success) 04:22:59 INFO - [mozharness: 2016-10-13 11:22:59.045188Z] Running install step. 04:22:59 INFO - Running pre-action listener: _resource_record_pre_action 04:22:59 INFO - Running main action method: install 04:22:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:22:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:22:59 INFO - Reading from file tmpfile_stdout 04:22:59 INFO - Detecting whether we're running mozinstall >=1.0... 04:22:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:22:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:22:59 INFO - Reading from file tmpfile_stdout 04:22:59 INFO - Output received: 04:22:59 INFO - Usage: mozinstall [options] installer 04:22:59 INFO - Options: 04:22:59 INFO - -h, --help show this help message and exit 04:22:59 INFO - -d DEST, --destination=DEST 04:22:59 INFO - Directory to install application into. [default: 04:22:59 INFO - "/builds/slave/test"] 04:22:59 INFO - --app=APP Application being installed. [default: firefox] 04:22:59 INFO - mkdir: /builds/slave/test/build/application 04:22:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:22:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:23:16 INFO - Reading from file tmpfile_stdout 04:23:16 INFO - Output received: 04:23:16 INFO - /builds/slave/test/build/application/firefox/firefox 04:23:16 INFO - Running post-action listener: _resource_record_post_action 04:23:16 INFO - [mozharness: 2016-10-13 11:23:16.384774Z] Finished install step (success) 04:23:16 INFO - [mozharness: 2016-10-13 11:23:16.385022Z] Running run-tests step. 04:23:16 INFO - Running pre-action listener: _resource_record_pre_action 04:23:16 INFO - Running main action method: run_tests 04:23:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:23:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:23:16 INFO - Python 2.7.3 04:23:16 INFO - Return code: 0 04:23:16 INFO - grabbing minidump binary from tooltool 04:23:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:23:16 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 0x17d4790>, '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 0x17d5690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17d5b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:23:16 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 04:23:16 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 04:23:16 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 04:23:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:23:16 INFO - Return code: 0 04:23:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:23:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:23:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:23:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:23:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:23:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xf-B2-E3TkChYPYsjabF7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 04:23:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Xf-B2-E3TkChYPYsjabF7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 04:23:16 INFO - Using env: {'DISPLAY': ':0', 04:23:16 INFO - 'HOME': '/home/cltbld', 04:23:16 INFO - 'LANG': 'en_US.UTF-8', 04:23:16 INFO - 'LANGUAGE': 'en_US:en', 04:23:16 INFO - 'LOGNAME': 'cltbld', 04:23:16 INFO - 'MAIL': '/var/mail/cltbld', 04:23:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:23:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:23:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:16 INFO - 'MOZ_NO_REMOTE': '1', 04:23:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:23:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:16 INFO - 'NO_EM_RESTART': '1', 04:23:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:16 INFO - 'PWD': '/builds/slave/test', 04:23:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:23:16 INFO - 'SHELL': '/bin/bash', 04:23:16 INFO - 'SHLVL': '1', 04:23:16 INFO - 'TERM': 'linux', 04:23:16 INFO - 'TMOUT': '86400', 04:23:16 INFO - 'USER': 'cltbld', 04:23:16 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476357740.760330-2080187500', 04:23:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:16 INFO - '_': '/tools/buildbot/bin/python'} 04:23:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xf-B2-E3TkChYPYsjabF7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 04:23:16 INFO - mozversion application_buildid: 20161013013001 04:23:16 INFO - mozversion application_changeset: 9a047a39cb2f7e4f97a8b5c0bccc3096efd0aa05 04:23:16 INFO - mozversion application_display_name: Nightly 04:23:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:23:16 INFO - mozversion application_name: Firefox 04:23:16 INFO - mozversion application_remotingname: firefox 04:23:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:23:16 INFO - mozversion application_vendor: Mozilla 04:23:16 INFO - mozversion application_version: 52.0a1 04:23:16 INFO - mozversion platform_buildid: 20161013013001 04:23:16 INFO - mozversion platform_changeset: 9a047a39cb2f7e4f97a8b5c0bccc3096efd0aa05 04:23:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:23:16 INFO - mozversion platform_version: 52.0a1 04:23:16 INFO - using testdate: 1476357796 04:23:16 INFO - actual date: 1476357796 04:23:16 INFO - starting webserver on 'localhost:38342' 04:23:16 INFO - SUITE-START | Running 2 tests 04:23:16 INFO - TEST-START | dromaeo_css 04:23:16 INFO - operating with platform_type : linux_ 04:23:16 INFO - Initialising browser for dromaeo_css test... 04:23:16 INFO - TEST-INFO | started process 27582 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4XnzY7/profile http://localhost:38342/getInfo.html) 04:23:20 INFO - PROCESS | 27582 | __metrics Screen width/height:1600/1200 04:23:20 INFO - PROCESS | 27582 | colorDepth:24 04:23:20 INFO - PROCESS | 27582 | Browser inner width/height: 1024/697 04:23:20 INFO - PROCESS | 27582 | __metrics 04:23:21 INFO - PROCESS | 27582 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:23:21 INFO - PROCESS | 27582 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:23:21 INFO - PROCESS | 27582 | console.error: PushService: 04:23:21 INFO - PROCESS | 27582 | stateChangeProcessEnqueue: Error transitioning state 04:23:21 INFO - PROCESS | 27582 | UnknownError 04:23:22 INFO - TEST-INFO | 27582: exit 0 04:23:22 INFO - Browser initialized. 04:23:22 INFO - Running cycle 1/1 for dromaeo_css test... 04:23:22 INFO - TEST-INFO | started process 27662 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4XnzY7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:23:34 INFO - PROCESS | 27662 | RSS: Main: 172691456 04:23:34 INFO - PROCESS | 27662 | 04:24:25 INFO - PROCESS | 27662 | 1476357865952 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:26:36 INFO - PROCESS | 27662 | Cycle 1(1): loaded http://localhost:38342/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38342/tests/dromaeo/cssquery-ext.html) 04:26:38 INFO - PROCESS | 27662 | RSS: Main: 275877888 04:26:38 INFO - PROCESS | 27662 | 04:29:40 INFO - PROCESS | 27662 | Cycle 1(1): loaded http://localhost:38342/tests/dromaeo/cssquery-ext.html (next: http://localhost:38342/tests/dromaeo/cssquery-jquery.html) 04:29:41 INFO - PROCESS | 27662 | RSS: Main: 278732800 04:29:41 INFO - PROCESS | 27662 | 04:32:43 INFO - PROCESS | 27662 | Cycle 1(1): loaded http://localhost:38342/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38342/tests/dromaeo/cssquery-mootools.html) 04:32:43 INFO - PROCESS | 27662 | RSS: Main: 217202688 04:32:43 INFO - PROCESS | 27662 | 04:35:45 INFO - PROCESS | 27662 | Cycle 1(1): loaded http://localhost:38342/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38342/tests/dromaeo/cssquery-prototype.html) 04:35:46 INFO - PROCESS | 27662 | RSS: Main: 275550208 04:35:46 INFO - PROCESS | 27662 | 04:38:49 INFO - PROCESS | 27662 | Cycle 1(1): loaded http://localhost:38342/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38342/tests/dromaeo/cssquery-yui.html) 04:38:49 INFO - PROCESS | 27662 | RSS: Main: 219803648 04:38:49 INFO - PROCESS | 27662 | 04:41:52 INFO - PROCESS | 27662 | Cycle 1(1): loaded http://localhost:38342/tests/dromaeo/cssquery-yui.html (next: http://localhost:38342/tests/dromaeo/cssquery-dojo.html) 04:41:53 INFO - PROCESS | 27662 | RSS: Main: 310050816 04:41:53 INFO - PROCESS | 27662 | 04:41:53 INFO - PROCESS | 27662 | __start_tp_report 04:41:53 INFO - PROCESS | 27662 | _x_x_mozilla_page_load 04:41:53 INFO - PROCESS | 27662 | _x_x_mozilla_page_load_details 04:41:53 INFO - PROCESS | 27662 | |i|pagename|runs| 04:41:53 INFO - PROCESS | 27662 | |0;dojo.html;2967.020883108573;2970.272283290594;3001.7148370904756;3004.954925676115;3044.3302473455847;5021.995600879821;5092.312537807395;5108.284840122381;5210.895782084356;5264.921026184606;5120.308758317626;5129.179331306992;5187.6628019178725;5210.2445145453985;5257.395399529055;4693.061387722452;4728.361671174399;4779.28310753388;4782.163121453732;4783.760811959405;4755.976220118894;4803.78382972767;4872.585830204437;4876.366072410599;4931.3835770528685;4588.4723256825555;4826;4831.661783675144;4841;4938.728369939652;4632.62938964882;4700.600448961843;4701.200795864711;4701.553352431513;4708.458527269374;4650.488446270908;4665.206914824454;4672.509386514435;4673.345731597579;4678.672492925497;5075.162598171298;5123.974380128113;5172.560332371753;5179.766910489037;5239.947600523984;5603.60774745768;5606.635568688022;5620.747066382022;5625.240592519998;5626.099824028136;5558.471945165203;5603.215549823028;5607.551395888319;5612.579056570774;5612.943870561283;5232.973835130838;5233.084210263189;5240.213967904845;5240.68555886648;5295.179247216687;5426.75579598919;5505.779768809283;5549.306336707911;5637.661740295595;5686.2039314496005;5479.835604931858;5480.890382192334;5489.505944465017;5516.448355164532;5545.417731138253;5552.305961754781;5560.4161563036105;5562.638428502215;5572.86067848307;5573.972130139405;5288.92066619001;5307.124324486416;5317.494837990384;5544.556435485232;5620.185073164368;5399.676019438846;5405.459454054563;5408.37803652585;5410.377806552218;5412.621116521806;4211.136716973013;4213.515445723781;4214.072903961123;4225.852095176654;4259.829606815692;3793.203427280302;3833.8083095845654;3835.9232815344094;3849.480320156799;3860.3630400984084;5206.479352064839;5208.088584497697;5215;5215.973920130451;5228.529432351107;5306.416294207634;5521.723913804293;5553.750081246354;5556.777728890799;5561.332640083216;5061.063703214917;5141.845744627667;5189.532942035235;5269.657472264367;5274.736263186902;4860.854174374775;4868.732219727878;4869.391326084239;4912.164931961575;4922.606191504671;5748.45389687979;5786.276715410574;5806.912896306559;5807.970960145172;5813.447722466443;5349.625526213128;5398.974194903113;5492.121260598445;5526.723663816873;5591.356993945748;5745.97127014379;5752.33848107473;5754.108113242287;5789.884202316014;5814.389489103753;5444.945550544444;5445.50990410865;5455.290812194548;5456.645318054314;5457.836264912059;5348.786048558014;5408.378036525693;5517.531009864207;5551.944480555143;5561.93519396868;5402.729863506887;5451.536619387396;5451.890962180813;5491.341039075177;5512.5314348280845;5389.865253368697;5421.674699518042;5446.918296225481;5450.672959622277;5452.127659574449;5234.816781412632;5276.841694749163;5345.1714984177515;5409.161579955114;5459.890802184013;5443.482869127427;5489.58828087903;5492.80775172867;5510.366307874646;5573.6098473106495;5388.56891448691;5399.865003374947;5400.594955378284;5406.135018397038;5463.644863083887 04:41:53 INFO - PROCESS | 27662 | |1;ext.html;537.2961420539093;559.1919676068084;567.8239745678837;567.8580354911271;578.3955766224295;28091.859540702295;35760;37104.257914841684;37154.814225928836;37261.81369093151;37569.43645845314;37921.431178532344;37944.24111517775;37954.620453795455;37988;8454.61954212062;8603.741887743347;8617.310615150773;8621.956890215572;8623.223909848113;7789.727359542417;8009.759707208793;9733.805323893517;9983.500824958759;10010.949945250264;10273.691789246297;10326.638567650134;10376.94811525945;10380.896191038106;10393.32443391181;10163.79672406555;10176.287659863812;10183.18534517237;10235.692929212135;10247.897521024768;9989.950050249776;10042.397456152654;10045.547950342252;10045.648402305884;10049.949750251275;35332.11669708252;35672.821635891654;35708.464373034425;35732;35752;3026.788124831263;3122.2506598416444;3129.8278594677286;3178.2054486378406;3604.1710406606367;27528.724712752817;27766.444671106667;28056.579151312748;28200.43599128006;29075.709242907513;4249.87250382489;4269.466316710411;4284;4347.652187824967;4461.42001539801;313305;313792;314373.42813286016;315879;316592;45058;45298.320525192146;45323.320150197775;45403.31895021578;45488.77255613767;31275;31954.84022579872;32009.839950800564;33685;33725.32549349048;12325.630231093082;12490.375481225903;12506;12511.061670374758;12513.311767852674;8546.572671366532;8769;9515.191208747334;9564.378315409476;9592.808143837085;14524.346404411826;14849.480268190562;14988.700225995419;15324.923375383274;15412.922935385252;5554.250176226238;5680;5685.260916080966;5742.13867919807;5898.292204935436;790.9683612655544;857.5969294431607;889.9644014239487;938.8826396700413;962.7208109648124;27098.45803083967;27585.86207068992;27880.72119278822;27925.16224513268;28101.71898281032;928.7770934975557;974.2498276327188;978.1978777402604;992.7220378294089;1041.375174895057;14449.711005779825;14451.205183714786;14671.266436678123;14736;14803.703925921422;494182;499819;501000;501008;502389;45840.77079614581;46263.76868115705;46273.76863115663;46295.30557041647;46360;1042.9634962776418;1055.757175849559;1086.3373342261214;1115.3085087245797;1139.1684070628487;27104.864475677496;28449.43101137924;28667.28331791722;28771.856140719163;28840.855795721727;37092.629073708915;37402.625973739916;37419;37453.6254637461;37459.06352341213;363666;364302;365076;365970;369166;24462.877685611456;25433;25445.10942117017;26470.338241543344;26821.597676034486;37672;38112;38206.61793382031;38837;38866.805665971486;32927.67072329246;33223.83388083141;33355.49966750452;33527.83236083804;34113.14717131992;33327.666723332455;33328.66671333255;34035.319293614484;34128.65871341255;34671.13322166966;33333.49999749957;33428.66571334353;33812.492812607336;33908;34008;26390.73609263883;29399.559006615345;30403.2399190022;30690.693093069676;31626.525602115526;24182.758172418755;24617;24629.261122166365;24884.875575622005;25100.24699259025 04:41:53 INFO - PROCESS | 27662 | |2;jquery.html;350.1246882793017;374.17867780222406;377.79628748215134;378.15859712140485;403.8525938032619;13354.866451335483;14007.579772606812;14285.286065426342;17202.311907523683;17853.19660615272;15460.381584736597;15811.92094039531;15932.601684957854;15960.84039159608;15980.76028859568;4929.827456039048;5191.792328306863;5224.216367544861;5292.073887069748;5295;3686.7972261525606;5196.766145523442;5252.606054545905;5257.158854583248;5262.8684282892855;4152.294110001307;4302.720323178999;6305.527085468585;6410.583312084723;6422.357764223587;5701.572382071361;5913.113033045078;6374.585651932633;6386.201724784379;6391.201099862517;5579.46995035471;5607.831765047055;5613.410591887875;5619.719014049281;5622.85942851432;13379.665508362272;15802.841971580252;20132.396028119034;20350;20563;2200.922967696123;2303.332033710222;2336.6144586143437;2347.471818840764;2372.027468737809;9538.236941044699;9939.304248702594;10410.219233557438;10503.36979781208;12011.939940300243;1865.7201419787004;1943.3489780923408;1945.3580318494862;1961.137099676138;1966.5108068842856;82528.44803094295;86228.56885715657;86263.56868215681;86743;87291.56354218251;10460.424676642706;10463.267571270091;10570.52432640533;10580.153587712965;10684.732881678021;14859.331330090172;14880.851191487947;14913.627159321104;14923.253837308092;14937;6647.468202543785;6761.18865736105;6859.416949559343;6928.549644273106;7022.12223472066;6067.453929146398;6148.477379422709;6325.335839736854;6328.5886417383645;6393.104965304861;4381.715188512737;4426.734395936254;4458.910821783611;4562.680612357103;4596.448426188878;1842.3828017613982;1862.824736000155;1926.8169523895208;1953.1991883327767;2002.5594369238745;778.7067087427585;832.1553623072587;860.3418384935529;864.6411739128317;923.4920793563513;17030.57423564421;17330.273991091723;17462.166472520457;18083.54791130232;18522.81477185238;856.8928883889514;864.8097418567905;887.1084560017271;897.7261935109855;909.7998440343114;9269.258459323239;9934.50327483623;10037.120860124767;10057.59769609222;10075.848862267072;437236;444763;444958.97684604273;445093;445703;91086;91291;92290;92944.53527732454;93875.53062234646;857.1642648417867;881.2245224202788;910.1671970147373;913.821804748081;915.057490784493;15223.314950827018;15254.542363729106;15692.607684807514;15908.363665453253;15977.440789572309;40221;40448.595514044486;40925;41870;42500.57499424966;56353.71823140858;57674;57923.4207657918;58258.4174158253;58437.70781146067;7218.783436496913;7403.814904627212;7588.582627955516;7634.083909930621;7705.730299439493;11640.01059909917;11942.701432464259;12032.157748957488;12067.336296503425;12672;6126.846828829315;10748.677539673823;10783.622573210214;10828.783424331627;11166.609168679057;10794.460276985963;10938.070264027647;11028.338299702044;11289.943550282196;11514.53941842317;10770.24608277413;11028.172887033345;11093.94453027762;11161.441927903736;11339.319640821248;7521.323080922743;7658.578778167254;7829.060512738508;7984.800379990546;8186.181381861767;10718.89281107179;10989.61536346224;10997.395143267197;11017.669469915916;11091.889081109086 04:41:53 INFO - PROCESS | 27662 | |3;mootools.html;1116.7264020315024;1195.8445402097725;1202.705337192388;1232.2421710647952;1401.6355747505645;7615.77152685419;8316.958415207922;8606.139386061392;8614.483131012144;8885.68900088497;8558.400911936167;8638.049814520398;8640.39517233794;8647.264982476481;8648.870266946002;2328.930132096036;2331.4521087544413;2354.1407386304045;2359.1978727232736;2368.0882860098814;2298.678185054094;2327.767223277676;2376.025829409942;2381.880905954704;2384.046381447426;2347.084636991566;2354;2362.6692263083182;2367.2898130560848;2384.225126833786;2264.9886750566307;2277.077783497686;2277.601419751545;2289.255991802654;2322.3381336319067;2256.3907744908947;2257.198694463458;2257.6613507973934;2257.8532395394245;2259.5029093599383;8490.66037358505;8502.872456913152;8669.263112635434;8674.913250867474;8778.47329160246;5167.638265321391;5288.127458969266;5291.259223708684;5292.259083728281;5298.152295632719;3556.4665300205174;3562.608113107556;3585.515955346021;3639.108418437473;3640.3083414151492;1085.8262677971566;1114.9554017839278;1126.763379690266;1151.3840095548842;1166.4925757295603;12128;12282.07884408664;12283.57007504733;12330.691732706664;12372.81440778389;4347.391365208873;4407.493138289074;4541.250693635579;4588.587027167571;4596.218642830727;9131.771705707277;9133;9138.08619138081;9163.404378715362;9171.77070573241;4816.807327706852;4864.513548645178;4883.975580122076;4892.217245240744;4893.584045356185;4230.534641189467;4384.934225986549;4522.253828118323;4561.498235194126;4741.336212930192;3731.8134093295225;3779.093017675738;3909.338531124261;3913.8043097844993;3915.7846318452757;1269.4351013798955;1294.2558029133286;1294.9676258093434;1305.4908585651604;1306.7125232448846;683.7606837606897;852.2968550945495;854.7734850264685;861.5304658960881;866.0603245478726;5724.77100915967;5848.795292164754;5855.853603659943;6072.453479186895;6183.258009038854;427.7006095732999;428.29545397821033;428.71062033127515;431.86180422264573;433.43653250773866;4040.515138183378;4153.1070819773895;4159.958400416018;4186.644135248538;4198.832046718097;10601.522931468102;10857.37139429092;10997.175211859143;11021.669349919515;11033.503492342863;10809.459527023775;10810.135189185004;10839.83740243897;10849.403282819521;10865;7822.569758663214;7858.803529911798;7895.486793358298;7898.328642065489;7915;5755.223044888887;5757.251557297692;5830.53355731549;5860;5919.6744179070565;9942.950285248817;9950.4527250999;10013.148882345082;10023.949880250551;10042.397456152654;9654.71035868925;10065.295429319878;10201.540930658286;10558.683239502827;10568.260221784401;6620.437262832521;6833;7167.8566428672175;7477.738279160203;7633.580153091633;8004.399670024888;8414.200650938152;8416.284615807725;8425.789355265922;8439.535825529654;7449.925500744923;7452.956586077845;7562.470627056054;7587.279208475186;7725.884111738216;7276.745313913988;7365.079365079365;7411.518251313647;7650.579218143055;7723.150453450228;6811.318868113149;6917.965410172917;6938.063361446342;6939.514234003571;6943.756968506078;4920.138975679313;5054.873628159326;5162.561182299547;5175.171972484384;5258.816766227568;5300.814471493479;5329.280547126088;5345.116167855571;5381.838544843661;5582.469665381782 04:41:53 INFO - PROCESS | 27662 | |4;prototype.html;303.664450781886;311.48604802076574;321.5177234148777;321.8246055899535;323.55995845649926;4732.195526760451;5007.599392048636;5236.397814251362;5272.4991125843035;5273.103572392698;5158.277841102249;5179.637425380215;5201.141811601091;5212.853172302088;5217.7563647631505;4104.179164167163;4120.423140760296;4124.711270211086;4130.731502452346;4136.896577585554;3915.885421872186;4122.546519882811;4150.3359462486005;4159.604837540429;4185.644220241283;3818.8090595470253;4064.9187016259657;4091.9181616367655;4097.344424892018;4102.425660407545;4066.7356621819486;4076.449679293302;4090.2228576570355;4091.89770255743;4100.5899410059055;3614.7469677122613;3646.161382881952;3648.8175591220333;3650.5801832789302;3654.488371627974;4870.687932206099;5079.466656001141;5085.491450854922;5123.821521050179;5164.32863727713;4648.930266046012;4653.488116307203;4664.787155339603;4677.88305292367;4683.2975053741875;5472.974999250303;5476.342838859323;5510.311211098613;5529.502344788988;5552.11166213408;3837.961620383788;3906.785126818024;3907.159960608454;3911.550171730259;3927.4894263745814;5365.678059316453;5516.503514683698;5608.055770720363;5676.687782171979;5680.466274106009;3851.2490064437725;3945.9605403946166;3951.8024098794945;3957.2679054375035;3969.4915931945675;4018.015586181404;4019.0354314964197;4020.2562525932794;4023.517177938666;4032.6572241359227;4540.523245059288;4615.922834724387;4636.420447444069;4636.536346365404;4643.558861908181;5359.5712343012465;5375.220593013991;5381.789097453042;5399.70301633414;5414;1346.9259190744408;1367.548708926052;1368.117564171124;1373.203541945669;1376.7108907129616;843.6161546496452;874.6195404998846;886.1448702002598;888.6045709659269;896.4979611417627;4668.992333296715;4687.414073240845;4701.224297990793;4720.026383378449;4737.24204127338;4879.902401951941;4890.608751299887;4930.841252305705;4945.315739773891;4991.800327986913;4325.913481730411;4672.252439609646;4685.695429797052;4698.647601429906;4732.834350797705;2587.573050446655;2596.1562492190114;2598.6621739174166;2607.960880586793;2612.2163350994624;5024.84925452237;5052.7726252318735;5066.794560514764;5086.491350864884;5116.56509196715;4772.665913386029;4878.583457058268;4937.580305673986;4965.205567109245;4978.352814134139;5006.574441172541;5015.677111417372;5044.8234311798915;5046.6719663221775;5047;4839.7096174229655;4851.636127290397;4855.854324370274;4893.828715994923;4953.603711702983;4577.741121191699;4838.758062096811;4845.709257444564;4874.781974201801;4890.413150421972;4981.2030075187795;5075.842766824011;5486.259354987185;5610.49505544503;5676.403977582459;3917.334053211018;3919.8236079375924;3945.270125026879;3971.185906889023;3980.8009599520487;5636.238243260691;5636.802711905064;5643.971780141237;5645.729710815034;5665.716714164193;5201.375834899836;5362.839114826562;5398.731298144854;5441.646292990943;5522.282103326542;5404.270423492935;5425.755840987244;5429.429909859408;5446.618736688394;5450.563954883521;5317.57459403239;5454.59090568201;5456.48163424474;5460.208269800936;5492.176173573836;5432.619716619799;5464.207689885024;5471.534919531884;5488.5334746545395;5496.148097044965;5346.7059311736675;5370.194470829407;5383.192521121863;5395.487428694268;5478.424765399575 04:41:53 INFO - PROCESS | 27662 | |5;yui.html;593.6230493636541;641.1184621145925;650.8860949333865;655.1123228026028;667.1427216027404;12869.742605147903;13573.253471059088;13688.657783555416;13690.247036412993;13716.588502344921;11957.521699132025;12047.939760301208;12052.758944821098;12085.697857553565;12090.395480225976;547.5154488277873;562.7186406796602;563.9718014099299;564.5737468211495;564.6499170514287;483.0773223143796;494.3375876325723;546.7484956919802;558.1627558662007;561.1554610311496;586.1881294407256;592.4697395830729;592.7451195985724;592.7747455966727;592.9080992446178;589.5107061139244;590.35356284868;590.5128269177945;590.7312172961335;590.7341696236667;368.06695028103894;375.5981100222763;415.4723501153518;421.4668444417814;429.7163871844568;11661.766764664659;12043.156979011474;12044.518219271218;12065.939670301681;12118.272903625812;13027.413766380536;13268.270245136513;13423;13481.932590337083;13755;12158.5136594537;12270.079744019235;12290.139690221687;12381.62855114348;12492.937535312356;4164.646005089571;4171.582841715835;4218.894527636803;4254.659627229814;4394.011347446799;78538;78558.21441785566;82263.17736822675;82329;82559.58720206421;10288.228382871315;10444.73888152787;10502.479404942758;10624.256302058782;10781.784364312669;19415;19431.61136777285;19455.610887782164;19456.319028833925;19466.124024418936;7833.099193592696;7879.645415956295;8034.839303213903;8100.270975612106;8221.917780822116;4485.125400546862;4581.816727330936;4615.376924115269;4690.343351930733;4738.147133515931;3397.9660203398143;3494.807785571818;3496.0735405117666;3497.7726447780815;3499.720022398202;576.8211854325173;578.733782460073;582.2750675409059;582.4990508162977;600.3246347858659;509.3700159489574;514.6191818054688;548.0217811207056;578.6412424296963;580.9803794340904;8718.782030449289;8895.377323587416;9028.187463128219;9043.683471078612;9262;555.3807504632387;583.3204316970682;599.7690889007763;605.4369436424167;616.3805375597585;4107.116969851496;4188.958110418917;4195.895102622459;4234.830606775756;4350.477942646839;91118.54440727754;117638;121516;121575;122733;64373.03440448397;65583.34416655867;89423.10576894278;100972.49513752385;104397.47801260946;89938.55030724936;92967;92976.53511732533;93155.53422232845;93553;8024.317932975762;8199.549024803693;8301.128381520095;8322.216059838354;8675.262602678842;53804;54166.458335417716;54419.91160176854;54609;55475.72262138664;73222;77874.61062694651;80333.59833200797;81143.5942820282;82314.17685823065;10502.687164104487;10580.365178089032;10651.733706657396;10812.621558245739;10834.133269338276;11050.392228427514;11082.556697732;11164.553417863195;12463.937680311541;12487.562935297221;11703.648890533297;12101.636950891487;12874.291913944822;12931.159474634118;12954.676133096747;10405.483033892562;12714;12838.486460541848;12953.352332383532;13910.443582256596;12886.935565322488;13463.192208467523;13514.526991555249;13656.93171534136;13977.58067257984;10758.623448179276;10799.40603266828;11190.160737944523;11240.7751844961;11377.20359574855;10476.895231047896;11381;11786.351750653796;12143.939280303543;12154.270743755404 04:41:53 INFO - PROCESS | 27662 | __end_tp_report 04:41:53 INFO - PROCESS | 27662 | __start_cc_report 04:41:53 INFO - PROCESS | 27662 | _x_x_mozilla_cycle_collect,1445 04:41:53 INFO - PROCESS | 27662 | __end_cc_report 04:41:53 INFO - PROCESS | 27662 | __startTimestamp1476358913070__endTimestamp 04:41:53 INFO - PROCESS | 27662 | 04:41:53 INFO - PROCESS | 27662 | ------- Summary: start ------- 04:41:53 INFO - PROCESS | 27662 | Number of tests: 6 04:41:53 INFO - PROCESS | 27662 | 04:41:53 INFO - PROCESS | 27662 | [#0] dojo.html Cycles:165 Average:5155.21 Median:5348.79 stddev:575.84 (10.8%) stddev-sans-first:551.42 04:41:53 INFO - PROCESS | 27662 | Values: 2967.0 2970.3 3001.7 3005.0 3044.3 5022.0 5092.3 5108.3 5210.9 5264.9 5120.3 5129.2 5187.7 5210.2 5257.4 4693.1 4728.4 4779.3 4782.2 4783.8 4756.0 4803.8 4872.6 4876.4 4931.4 4588.5 4826.0 4831.7 4841.0 4938.7 4632.6 4700.6 4701.2 4701.6 4708.5 4650.5 4665.2 4672.5 4673.3 4678.7 5075.2 5124.0 5172.6 5179.8 5239.9 5603.6 5606.6 5620.7 5625.2 5626.1 5558.5 5603.2 5607.6 5612.6 5612.9 5233.0 5233.1 5240.2 5240.7 5295.2 5426.8 5505.8 5549.3 5637.7 5686.2 5479.8 5480.9 5489.5 5516.4 5545.4 5552.3 5560.4 5562.6 5572.9 5574.0 5288.9 5307.1 5317.5 5544.6 5620.2 5399.7 5405.5 5408.4 5410.4 5412.6 4211.1 4213.5 4214.1 4225.9 4259.8 3793.2 3833.8 3835.9 3849.5 3860.4 5206.5 5208.1 5215.0 5216.0 5228.5 5306.4 5521.7 5553.8 5556.8 5561.3 5061.1 5141.8 5189.5 5269.7 5274.7 4860.9 4868.7 4869.4 4912.2 4922.6 5748.5 5786.3 5806.9 5808.0 5813.4 5349.6 5399.0 5492.1 5526.7 5591.4 5746.0 5752.3 5754.1 5789.9 5814.4 5444.9 5445.5 5455.3 5456.6 5457.8 5348.8 5408.4 5517.5 5551.9 5561.9 5402.7 5451.5 5451.9 5491.3 5512.5 5389.9 5421.7 5446.9 5450.7 5452.1 5234.8 5276.8 5345.2 5409.2 5459.9 5443.5 5489.6 5492.8 5510.4 5573.6 5388.6 5399.9 5400.6 5406.1 5463.6 04:41:53 INFO - PROCESS | 27662 | 04:41:53 INFO - PROCESS | 27662 | [#1] ext.html Cycles:180 Average:51948.62 Median:33958.00 stddev:106561.73 (313.8%) stddev-sans-first:106790.75 04:41:53 INFO - PROCESS | 27662 | Values: 537.3 559.2 567.8 567.9 578.4 28091.9 35760.0 37104.3 37154.8 37261.8 37569.4 37921.4 37944.2 37954.6 37988.0 8454.6 8603.7 8617.3 8622.0 8623.2 7789.7 8009.8 9733.8 9983.5 10010.9 10273.7 10326.6 10376.9 10380.9 10393.3 10163.8 10176.3 10183.2 10235.7 10247.9 9990.0 10042.4 10045.5 10045.6 10049.9 35332.1 35672.8 35708.5 35732.0 35752.0 3026.8 3122.3 3129.8 3178.2 3604.2 27528.7 27766.4 28056.6 28200.4 29075.7 4249.9 4269.5 4284.0 4347.7 4461.4 313305.0 313792.0 314373.4 315879.0 316592.0 45058.0 45298.3 45323.3 45403.3 45488.8 31275.0 31954.8 32009.8 33685.0 33725.3 12325.6 12490.4 12506.0 12511.1 12513.3 8546.6 8769.0 9515.2 9564.4 9592.8 14524.3 14849.5 14988.7 15324.9 15412.9 5554.3 5680.0 5685.3 5742.1 5898.3 791.0 857.6 890.0 938.9 962.7 27098.5 27585.9 27880.7 27925.2 28101.7 928.8 974.2 978.2 992.7 1041.4 14449.7 14451.2 14671.3 14736.0 14803.7 494182.0 499819.0 501000.0 501008.0 502389.0 45840.8 46263.8 46273.8 46295.3 46360.0 1043.0 1055.8 1086.3 1115.3 1139.2 27104.9 28449.4 28667.3 28771.9 28840.9 37092.6 37402.6 37419.0 37453.6 37459.1 363666.0 364302.0 365076.0 365970.0 369166.0 24462.9 25433.0 25445.1 26470.3 26821.6 37672.0 38112.0 38206.6 38837.0 38866.8 32927.7 33223.8 33355.5 33527.8 34113.1 33327.7 33328.7 34035.3 34128.7 34671.1 33333.5 33428.7 33812.5 33908.0 34008.0 26390.7 29399.6 30403.2 30690.7 31626.5 24182.8 24617.0 24629.3 24884.9 25100.2 04:41:53 INFO - PROCESS | 27662 | 04:41:53 INFO - PROCESS | 27662 | [#2] jquery.html Cycles:180 Average:27043.36 Median:42185.29 stddev:73663.99 (174.6%) stddev-sans-first:73843.37 04:41:53 INFO - PROCESS | 27662 | Values: 350.1 374.2 377.8 378.2 403.9 13354.9 14007.6 14285.3 17202.3 17853.2 15460.4 15811.9 15932.6 15960.8 15980.8 4929.8 5191.8 5224.2 5292.1 5295.0 3686.8 5196.8 5252.6 5257.2 5262.9 4152.3 4302.7 6305.5 6410.6 6422.4 5701.6 5913.1 6374.6 6386.2 6391.2 5579.5 5607.8 5613.4 5619.7 5622.9 13379.7 15802.8 20132.4 20350.0 20563.0 2200.9 2303.3 2336.6 2347.5 2372.0 9538.2 9939.3 10410.2 10503.4 12011.9 1865.7 1943.3 1945.4 1961.1 1966.5 82528.4 86228.6 86263.6 86743.0 87291.6 10460.4 10463.3 10570.5 10580.2 10684.7 14859.3 14880.9 14913.6 14923.3 14937.0 6647.5 6761.2 6859.4 6928.5 7022.1 6067.5 6148.5 6325.3 6328.6 6393.1 4381.7 4426.7 4458.9 4562.7 4596.4 1842.4 1862.8 1926.8 1953.2 2002.6 778.7 832.2 860.3 864.6 923.5 17030.6 17330.3 17462.2 18083.5 18522.8 856.9 864.8 887.1 897.7 909.8 9269.3 9934.5 10037.1 10057.6 10075.8 437236.0 444763.0 444959.0 445093.0 445703.0 91086.0 91291.0 92290.0 92944.5 93875.5 857.2 881.2 910.2 913.8 915.1 15223.3 15254.5 15692.6 15908.4 15977.4 40221.0 40448.6 40925.0 41870.0 42500.6 56353.7 57674.0 57923.4 58258.4 58437.7 7218.8 7403.8 7588.6 7634.1 7705.7 11640.0 11942.7 12032.2 12067.3 12672.0 6126.8 10748.7 10783.6 10828.8 11166.6 10794.5 10938.1 11028.3 11289.9 11514.5 10770.2 11028.2 11093.9 11161.4 11339.3 7521.3 7658.6 7829.1 7984.8 8186.2 10718.9 10989.6 10997.4 11017.7 11091.9 04:41:53 INFO - PROCESS | 27662 | 04:41:53 INFO - PROCESS | 27662 | [#3] mootools.html Cycles:180 Average:5662.17 Median:4668.78 stddev:3248.73 (69.6%) stddev-sans-first:3239.88 04:41:53 INFO - PROCESS | 27662 | Values: 1116.7 1195.8 1202.7 1232.2 1401.6 7615.8 8317.0 8606.1 8614.5 8885.7 8558.4 8638.0 8640.4 8647.3 8648.9 2328.9 2331.5 2354.1 2359.2 2368.1 2298.7 2327.8 2376.0 2381.9 2384.0 2347.1 2354.0 2362.7 2367.3 2384.2 2265.0 2277.1 2277.6 2289.3 2322.3 2256.4 2257.2 2257.7 2257.9 2259.5 8490.7 8502.9 8669.3 8674.9 8778.5 5167.6 5288.1 5291.3 5292.3 5298.2 3556.5 3562.6 3585.5 3639.1 3640.3 1085.8 1115.0 1126.8 1151.4 1166.5 12128.0 12282.1 12283.6 12330.7 12372.8 4347.4 4407.5 4541.3 4588.6 4596.2 9131.8 9133.0 9138.1 9163.4 9171.8 4816.8 4864.5 4884.0 4892.2 4893.6 4230.5 4384.9 4522.3 4561.5 4741.3 3731.8 3779.1 3909.3 3913.8 3915.8 1269.4 1294.3 1295.0 1305.5 1306.7 683.8 852.3 854.8 861.5 866.1 5724.8 5848.8 5855.9 6072.5 6183.3 427.7 428.3 428.7 431.9 433.4 4040.5 4153.1 4160.0 4186.6 4198.8 10601.5 10857.4 10997.2 11021.7 11033.5 10809.5 10810.1 10839.8 10849.4 10865.0 7822.6 7858.8 7895.5 7898.3 7915.0 5755.2 5757.3 5830.5 5860.0 5919.7 9943.0 9950.5 10013.1 10023.9 10042.4 9654.7 10065.3 10201.5 10558.7 10568.3 6620.4 6833.0 7167.9 7477.7 7633.6 8004.4 8414.2 8416.3 8425.8 8439.5 7449.9 7453.0 7562.5 7587.3 7725.9 7276.7 7365.1 7411.5 7650.6 7723.2 6811.3 6918.0 6938.1 6939.5 6943.8 4920.1 5054.9 5162.6 5175.2 5258.8 5300.8 5329.3 5345.1 5381.8 5582.5 04:41:53 INFO - PROCESS | 27662 | 04:41:53 INFO - PROCESS | 27662 | [#4] prototype.html Cycles:180 Average:4420.59 Median:4879.24 stddev:1277.58 (26.2%) stddev-sans-first:1243.23 04:41:53 INFO - PROCESS | 27662 | Values: 303.7 311.5 321.5 321.8 323.6 4732.2 5007.6 5236.4 5272.5 5273.1 5158.3 5179.6 5201.1 5212.9 5217.8 4104.2 4120.4 4124.7 4130.7 4136.9 3915.9 4122.5 4150.3 4159.6 4185.6 3818.8 4064.9 4091.9 4097.3 4102.4 4066.7 4076.4 4090.2 4091.9 4100.6 3614.7 3646.2 3648.8 3650.6 3654.5 4870.7 5079.5 5085.5 5123.8 5164.3 4648.9 4653.5 4664.8 4677.9 4683.3 5473.0 5476.3 5510.3 5529.5 5552.1 3838.0 3906.8 3907.2 3911.6 3927.5 5365.7 5516.5 5608.1 5676.7 5680.5 3851.2 3946.0 3951.8 3957.3 3969.5 4018.0 4019.0 4020.3 4023.5 4032.7 4540.5 4615.9 4636.4 4636.5 4643.6 5359.6 5375.2 5381.8 5399.7 5414.0 1346.9 1367.5 1368.1 1373.2 1376.7 843.6 874.6 886.1 888.6 896.5 4669.0 4687.4 4701.2 4720.0 4737.2 4879.9 4890.6 4930.8 4945.3 4991.8 4325.9 4672.3 4685.7 4698.6 4732.8 2587.6 2596.2 2598.7 2608.0 2612.2 5024.8 5052.8 5066.8 5086.5 5116.6 4772.7 4878.6 4937.6 4965.2 4978.4 5006.6 5015.7 5044.8 5046.7 5047.0 4839.7 4851.6 4855.9 4893.8 4953.6 4577.7 4838.8 4845.7 4874.8 4890.4 4981.2 5075.8 5486.3 5610.5 5676.4 3917.3 3919.8 3945.3 3971.2 3980.8 5636.2 5636.8 5644.0 5645.7 5665.7 5201.4 5362.8 5398.7 5441.6 5522.3 5404.3 5425.8 5429.4 5446.6 5450.6 5317.6 5454.6 5456.5 5460.2 5492.2 5432.6 5464.2 5471.5 5488.5 5496.1 5346.7 5370.2 5383.2 5395.5 5478.4 04:41:53 INFO - PROCESS | 27662 | 04:41:53 INFO - PROCESS | 27662 | [#5] yui.html Cycles:180 Average:20288.80 Median:4226.86 stddev:30334.09 (717.7%) stddev-sans-first:30383.13 04:41:53 INFO - PROCESS | 27662 | Values: 593.6 641.1 650.9 655.1 667.1 12869.7 13573.3 13688.7 13690.2 13716.6 11957.5 12047.9 12052.8 12085.7 12090.4 547.5 562.7 564.0 564.6 564.6 483.1 494.3 546.7 558.2 561.2 586.2 592.5 592.7 592.8 592.9 589.5 590.4 590.5 590.7 590.7 368.1 375.6 415.5 421.5 429.7 11661.8 12043.2 12044.5 12065.9 12118.3 13027.4 13268.3 13423.0 13481.9 13755.0 12158.5 12270.1 12290.1 12381.6 12492.9 4164.6 4171.6 4218.9 4254.7 4394.0 78538.0 78558.2 82263.2 82329.0 82559.6 10288.2 10444.7 10502.5 10624.3 10781.8 19415.0 19431.6 19455.6 19456.3 19466.1 7833.1 7879.6 8034.8 8100.3 8221.9 4485.1 4581.8 4615.4 4690.3 4738.1 3398.0 3494.8 3496.1 3497.8 3499.7 576.8 578.7 582.3 582.5 600.3 509.4 514.6 548.0 578.6 581.0 8718.8 8895.4 9028.2 9043.7 9262.0 555.4 583.3 599.8 605.4 616.4 4107.1 4189.0 4195.9 4234.8 4350.5 91118.5 117638.0 121516.0 121575.0 122733.0 64373.0 65583.3 89423.1 100972.5 104397.5 89938.6 92967.0 92976.5 93155.5 93553.0 8024.3 8199.5 8301.1 8322.2 8675.3 53804.0 54166.5 54419.9 54609.0 55475.7 73222.0 77874.6 80333.6 81143.6 82314.2 10502.7 10580.4 10651.7 10812.6 10834.1 11050.4 11082.6 11164.6 12463.9 12487.6 11703.6 12101.6 12874.3 12931.2 12954.7 10405.5 12714.0 12838.5 12953.4 13910.4 12886.9 13463.2 13514.5 13656.9 13977.6 10758.6 10799.4 11190.2 11240.8 11377.2 10476.9 11381.0 11786.4 12143.9 12154.3 04:41:53 INFO - PROCESS | 27662 | -------- Summary: end -------- 04:41:53 INFO - PROCESS | 27662 | 04:41:54 INFO - TEST-INFO | 27662: exit 0 04:41:54 INFO - TEST-OK | dromaeo_css | took 1117376ms 04:41:54 INFO - TEST-START | kraken 04:41:54 INFO - operating with platform_type : linux_ 04:41:54 INFO - Initialising browser for kraken test... 04:41:54 INFO - TEST-INFO | started process 27969 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6tqDmS/profile http://localhost:38342/getInfo.html) 04:41:57 INFO - PROCESS | 27969 | __metrics Screen width/height:1600/1200 04:41:57 INFO - PROCESS | 27969 | colorDepth:24 04:41:57 INFO - PROCESS | 27969 | Browser inner width/height: 1024/697 04:41:57 INFO - PROCESS | 27969 | __metrics 04:41:58 INFO - PROCESS | 27969 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:41:58 INFO - PROCESS | 27969 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:41:58 INFO - PROCESS | 27969 | console.error: PushService: 04:41:58 INFO - PROCESS | 27969 | stateChangeProcessEnqueue: Error transitioning state 04:41:58 INFO - PROCESS | 27969 | UnknownError 04:41:59 INFO - TEST-INFO | 27969: exit 0 04:41:59 INFO - Browser initialized. 04:41:59 INFO - Running cycle 1/1 for kraken test... 04:41:59 INFO - TEST-INFO | started process 28050 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6tqDmS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:42:11 INFO - PROCESS | 28050 | RSS: Main: 172474368 04:42:11 INFO - PROCESS | 28050 | 04:42:14 INFO - PROCESS | 28050 | Cycle 1(1): loaded http://localhost:38342/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38342/tests/kraken/driver.html?testName=audio-beat-detection) 04:42:15 INFO - PROCESS | 28050 | RSS: Main: 232071168 04:42:15 INFO - PROCESS | 28050 | 04:42:17 INFO - PROCESS | 28050 | Cycle 1(1): loaded http://localhost:38342/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38342/tests/kraken/driver.html?testName=audio-dft) 04:42:18 INFO - PROCESS | 28050 | RSS: Main: 216502272 04:42:18 INFO - PROCESS | 28050 | 04:42:21 INFO - PROCESS | 28050 | Cycle 1(1): loaded http://localhost:38342/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38342/tests/kraken/driver.html?testName=audio-fft) 04:42:22 INFO - PROCESS | 28050 | RSS: Main: 298704896 04:42:22 INFO - PROCESS | 28050 | 04:42:24 INFO - PROCESS | 28050 | Cycle 1(1): loaded http://localhost:38342/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38342/tests/kraken/driver.html?testName=audio-oscillator) 04:42:24 INFO - PROCESS | 28050 | RSS: Main: 209915904 04:42:24 INFO - PROCESS | 28050 | 04:42:26 INFO - PROCESS | 28050 | Cycle 1(1): loaded http://localhost:38342/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38342/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:42:27 INFO - PROCESS | 28050 | RSS: Main: 212463616 04:42:27 INFO - PROCESS | 28050 | 04:42:30 INFO - PROCESS | 28050 | Cycle 1(1): loaded http://localhost:38342/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38342/tests/kraken/driver.html?testName=imaging-darkroom) 04:42:31 INFO - PROCESS | 28050 | RSS: Main: 248651776 04:42:31 INFO - PROCESS | 28050 | 04:42:34 INFO - PROCESS | 28050 | Cycle 1(1): loaded http://localhost:38342/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38342/tests/kraken/driver.html?testName=imaging-desaturate) 04:42:35 INFO - PROCESS | 28050 | RSS: Main: 247926784 04:42:35 INFO - PROCESS | 28050 | 04:42:37 INFO - PROCESS | 28050 | Cycle 1(1): loaded http://localhost:38342/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38342/tests/kraken/driver.html?testName=json-parse-financial) 04:42:38 INFO - PROCESS | 28050 | RSS: Main: 247963648 04:42:38 INFO - PROCESS | 28050 | 04:42:39 INFO - PROCESS | 28050 | Cycle 1(1): loaded http://localhost:38342/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38342/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:42:40 INFO - PROCESS | 28050 | RSS: Main: 210030592 04:42:40 INFO - PROCESS | 28050 | 04:42:42 INFO - PROCESS | 28050 | Cycle 1(1): loaded http://localhost:38342/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38342/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:42:42 INFO - PROCESS | 28050 | RSS: Main: 218042368 04:42:42 INFO - PROCESS | 28050 | 04:42:44 INFO - PROCESS | 28050 | Cycle 1(1): loaded http://localhost:38342/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38342/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:42:45 INFO - PROCESS | 28050 | RSS: Main: 226353152 04:42:45 INFO - PROCESS | 28050 | 04:42:48 INFO - PROCESS | 28050 | Cycle 1(1): loaded http://localhost:38342/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38342/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:42:49 INFO - PROCESS | 28050 | RSS: Main: 231653376 04:42:49 INFO - PROCESS | 28050 | 04:42:51 INFO - PROCESS | 28050 | Cycle 1(1): loaded http://localhost:38342/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38342/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:42:52 INFO - PROCESS | 28050 | RSS: Main: 231874560 04:42:52 INFO - PROCESS | 28050 | 04:42:54 INFO - PROCESS | 28050 | Cycle 1(1): loaded http://localhost:38342/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38342/tests/kraken/driver.html?testName=ai-astar) 04:42:54 INFO - PROCESS | 28050 | RSS: Main: 282947584 04:42:54 INFO - PROCESS | 28050 | 04:42:54 INFO - PROCESS | 28050 | __start_tp_report 04:42:54 INFO - PROCESS | 28050 | _x_x_mozilla_page_load 04:42:54 INFO - PROCESS | 28050 | _x_x_mozilla_page_load_details 04:42:54 INFO - PROCESS | 28050 | |i|pagename|runs| 04:42:54 INFO - PROCESS | 28050 | |0;ai-astar;108;110;109;111;113;109;110;111;109;112 04:42:54 INFO - PROCESS | 28050 | |1;audio-beat-detection;152;122;123;169;123;122;120;120;150;123 04:42:54 INFO - PROCESS | 28050 | |2;audio-dft;160;160;162;164;165;163;162;162;162;163 04:42:54 INFO - PROCESS | 28050 | |3;audio-fft;76;75;75;115;76;76;75;75;104;76 04:42:54 INFO - PROCESS | 28050 | |4;audio-oscillator;84;82;116;84;83;83;102;83;83;113 04:42:54 INFO - PROCESS | 28050 | |5;imaging-gaussian-blur;118;118;118;117;117;117;118;117;118;117 04:42:54 INFO - PROCESS | 28050 | |6;imaging-darkroom;145;146;146;145;145;145;146;146;146;145 04:42:54 INFO - PROCESS | 28050 | |7;imaging-desaturate;95;96;96;95;96;95;96;95;96;96 04:42:54 INFO - PROCESS | 28050 | |8;json-parse-financial;52;51;50;51;52;53;53;53;52;52 04:42:54 INFO - PROCESS | 28050 | |9;json-stringify-tinderbox;60;61;60;60;60;60;60;61;61;60 04:42:54 INFO - PROCESS | 28050 | |10;stanford-crypto-aes;82;86;79;79;80;86;79;79;89;79 04:42:54 INFO - PROCESS | 28050 | |11;stanford-crypto-ccm;142;138;139;128;139;136;136;132;165;131 04:42:54 INFO - PROCESS | 28050 | |12;stanford-crypto-pbkdf2;166;165;161;164;164;165;175;169;171;163 04:42:54 INFO - PROCESS | 28050 | |13;stanford-crypto-sha256-iterative;69;67;65;67;65;66;64;65;69;65 04:42:54 INFO - PROCESS | 28050 | __end_tp_report 04:42:54 INFO - PROCESS | 28050 | __start_cc_report 04:42:54 INFO - PROCESS | 28050 | _x_x_mozilla_cycle_collect,1675 04:42:54 INFO - PROCESS | 28050 | __end_cc_report 04:42:54 INFO - PROCESS | 28050 | __startTimestamp1476358974289__endTimestamp 04:42:54 INFO - PROCESS | 28050 | 04:42:54 INFO - PROCESS | 28050 | ------- Summary: start ------- 04:42:54 INFO - PROCESS | 28050 | Number of tests: 14 04:42:54 INFO - PROCESS | 28050 | 04:42:54 INFO - PROCESS | 28050 | [#0] ai-astar Cycles:10 Average:110.20 Median:110.50 stddev:1.55 (1.4%) stddev-sans-first:1.42 04:42:54 INFO - PROCESS | 28050 | Values: 108.0 110.0 109.0 111.0 113.0 109.0 110.0 111.0 109.0 112.0 04:42:54 INFO - PROCESS | 28050 | 04:42:54 INFO - PROCESS | 28050 | [#1] audio-beat-detection Cycles:10 Average:132.40 Median:123.00 stddev:17.71 (14.4%) stddev-sans-first:17.30 04:42:54 INFO - PROCESS | 28050 | Values: 152.0 122.0 123.0 169.0 123.0 122.0 120.0 120.0 150.0 123.0 04:42:54 INFO - PROCESS | 28050 | 04:42:54 INFO - PROCESS | 28050 | [#2] audio-dft Cycles:10 Average:162.30 Median:162.50 stddev:1.57 (1.0%) stddev-sans-first:1.42 04:42:54 INFO - PROCESS | 28050 | Values: 160.0 160.0 162.0 164.0 165.0 163.0 162.0 162.0 162.0 163.0 04:42:54 INFO - PROCESS | 28050 | 04:42:54 INFO - PROCESS | 28050 | [#3] audio-fft Cycles:10 Average:82.30 Median:75.50 stddev:14.58 (19.3%) stddev-sans-first:15.28 04:42:54 INFO - PROCESS | 28050 | Values: 76.0 75.0 75.0 115.0 76.0 76.0 75.0 75.0 104.0 76.0 04:42:54 INFO - PROCESS | 28050 | 04:42:54 INFO - PROCESS | 28050 | [#4] audio-oscillator Cycles:10 Average:91.30 Median:83.00 stddev:13.60 (16.4%) stddev-sans-first:14.16 04:42:54 INFO - PROCESS | 28050 | Values: 84.0 82.0 116.0 84.0 83.0 83.0 102.0 83.0 83.0 113.0 04:42:54 INFO - PROCESS | 28050 | 04:42:54 INFO - PROCESS | 28050 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 04:42:54 INFO - PROCESS | 28050 | Values: 118.0 118.0 118.0 117.0 117.0 117.0 118.0 117.0 118.0 117.0 04:42:54 INFO - PROCESS | 28050 | 04:42:54 INFO - PROCESS | 28050 | [#6] imaging-darkroom Cycles:10 Average:145.50 Median:146.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 04:42:54 INFO - PROCESS | 28050 | Values: 145.0 146.0 146.0 145.0 145.0 145.0 146.0 146.0 146.0 145.0 04:42:54 INFO - PROCESS | 28050 | 04:42:54 INFO - PROCESS | 28050 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 04:42:54 INFO - PROCESS | 28050 | Values: 95.0 96.0 96.0 95.0 96.0 95.0 96.0 95.0 96.0 96.0 04:42:54 INFO - PROCESS | 28050 | 04:42:54 INFO - PROCESS | 28050 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.00 stddev:0.99 (1.9%) stddev-sans-first:1.05 04:42:54 INFO - PROCESS | 28050 | Values: 52.0 51.0 50.0 51.0 52.0 53.0 53.0 53.0 52.0 52.0 04:42:54 INFO - PROCESS | 28050 | 04:42:54 INFO - PROCESS | 28050 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 04:42:54 INFO - PROCESS | 28050 | Values: 60.0 61.0 60.0 60.0 60.0 60.0 60.0 61.0 61.0 60.0 04:42:54 INFO - PROCESS | 28050 | 04:42:54 INFO - PROCESS | 28050 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:81.00 stddev:3.79 (4.7%) stddev-sans-first:4.02 04:42:54 INFO - PROCESS | 28050 | Values: 82.0 86.0 79.0 79.0 80.0 86.0 79.0 79.0 89.0 79.0 04:42:54 INFO - PROCESS | 28050 | 04:42:54 INFO - PROCESS | 28050 | [#11] stanford-crypto-ccm Cycles:10 Average:138.60 Median:138.50 stddev:10.20 (7.4%) stddev-sans-first:10.74 04:42:54 INFO - PROCESS | 28050 | Values: 142.0 138.0 139.0 128.0 139.0 136.0 136.0 132.0 165.0 131.0 04:42:54 INFO - PROCESS | 28050 | 04:42:54 INFO - PROCESS | 28050 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.30 Median:165.50 stddev:4.19 (2.5%) stddev-sans-first:4.44 04:42:54 INFO - PROCESS | 28050 | Values: 166.0 165.0 161.0 164.0 164.0 165.0 175.0 169.0 171.0 163.0 04:42:54 INFO - PROCESS | 28050 | 04:42:54 INFO - PROCESS | 28050 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:66.50 stddev:1.75 (2.6%) stddev-sans-first:1.54 04:42:54 INFO - PROCESS | 28050 | Values: 69.0 67.0 65.0 67.0 65.0 66.0 64.0 65.0 69.0 65.0 04:42:54 INFO - PROCESS | 28050 | -------- Summary: end -------- 04:42:54 INFO - PROCESS | 28050 | 04:42:55 INFO - TEST-INFO | 28050: exit 0 04:42:55 INFO - TEST-OK | kraken | took 61427ms 04:42:55 INFO - SUITE-END | took 1178s 04:42:55 INFO - Completed test suite (00:19:39) 04:42:55 INFO - javascript benchmark 04:42:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2967.020883108573, 2970.272283290594, 3001.7148370904756, 3004.954925676115, 3044.3302473455847, 5021.995600879821, 5092.312537807395, 5108.284840122381, 5210.895782084356, 5264.921026184606, 5120.308758317626, 5129.179331306992, 5187.6628019178725, 5210.2445145453985, 5257.395399529055, 4693.061387722452, 4728.361671174399, 4779.28310753388, 4782.163121453732, 4783.760811959405, 4755.976220118894, 4803.78382972767, 4872.585830204437, 4876.366072410599, 4931.3835770528685, 4588.4723256825555, 4826.0, 4831.661783675144, 4841.0, 4938.728369939652, 4632.62938964882, 4700.600448961843, 4701.200795864711, 4701.553352431513, 4708.458527269374, 4650.488446270908, 4665.206914824454, 4672.509386514435, 4673.345731597579, 4678.672492925497, 5075.162598171298, 5123.974380128113, 5172.560332371753, 5179.766910489037, 5239.947600523984, 5603.60774745768, 5606.635568688022, 5620.747066382022, 5625.240592519998, 5626.099824028136, 5558.471945165203, 5603.215549823028, 5607.551395888319, 5612.579056570774, 5612.943870561283, 5232.973835130838, 5233.084210263189, 5240.213967904845, 5240.68555886648, 5295.179247216687, 5426.75579598919, 5505.779768809283, 5549.306336707911, 5637.661740295595, 5686.2039314496005, 5479.835604931858, 5480.890382192334, 5489.505944465017, 5516.448355164532, 5545.417731138253, 5552.305961754781, 5560.4161563036105, 5562.638428502215, 5572.86067848307, 5573.972130139405, 5288.92066619001, 5307.124324486416, 5317.494837990384, 5544.556435485232, 5620.185073164368, 5399.676019438846, 5405.459454054563, 5408.37803652585, 5410.377806552218, 5412.621116521806, 4211.136716973013, 4213.515445723781, 4214.072903961123, 4225.852095176654, 4259.829606815692, 3793.203427280302, 3833.8083095845654, 3835.9232815344094, 3849.480320156799, 3860.3630400984084, 5206.479352064839, 5208.088584497697, 5215.0, 5215.973920130451, 5228.529432351107, 5306.416294207634, 5521.723913804293, 5553.750081246354, 5556.777728890799, 5561.332640083216, 5061.063703214917, 5141.845744627667, 5189.532942035235, 5269.657472264367, 5274.736263186902, 4860.854174374775, 4868.732219727878, 4869.391326084239, 4912.164931961575, 4922.606191504671, 5748.45389687979, 5786.276715410574, 5806.912896306559, 5807.970960145172, 5813.447722466443, 5349.625526213128, 5398.974194903113, 5492.121260598445, 5526.723663816873, 5591.356993945748, 5745.97127014379, 5752.33848107473, 5754.108113242287, 5789.884202316014, 5814.389489103753, 5444.945550544444, 5445.50990410865, 5455.290812194548, 5456.645318054314, 5457.836264912059, 5348.786048558014, 5408.378036525693, 5517.531009864207, 5551.944480555143, 5561.93519396868, 5402.729863506887, 5451.536619387396, 5451.890962180813, 5491.341039075177, 5512.5314348280845, 5389.865253368697, 5421.674699518042, 5446.918296225481, 5450.672959622277, 5452.127659574449, 5234.816781412632, 5276.841694749163, 5345.1714984177515, 5409.161579955114, 5459.890802184013, 5443.482869127427, 5489.58828087903, 5492.80775172867, 5510.366307874646, 5573.6098473106495, 5388.56891448691, 5399.865003374947, 5400.594955378284, 5406.135018397038, 5463.644863083887], "value": 5116.886764703534, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.2961420539093, 559.1919676068084, 567.8239745678837, 567.8580354911271, 578.3955766224295, 28091.859540702295, 35760.0, 37104.257914841684, 37154.814225928836, 37261.81369093151, 37569.43645845314, 37921.431178532344, 37944.24111517775, 37954.620453795455, 37988.0, 8454.61954212062, 8603.741887743347, 8617.310615150773, 8621.956890215572, 8623.223909848113, 7789.727359542417, 8009.759707208793, 9733.805323893517, 9983.500824958759, 10010.949945250264, 10273.691789246297, 10326.638567650134, 10376.94811525945, 10380.896191038106, 10393.32443391181, 10163.79672406555, 10176.287659863812, 10183.18534517237, 10235.692929212135, 10247.897521024768, 9989.950050249776, 10042.397456152654, 10045.547950342252, 10045.648402305884, 10049.949750251275, 35332.11669708252, 35672.821635891654, 35708.464373034425, 35732.0, 35752.0, 3026.788124831263, 3122.2506598416444, 3129.8278594677286, 3178.2054486378406, 3604.1710406606367, 27528.724712752817, 27766.444671106667, 28056.579151312748, 28200.43599128006, 29075.709242907513, 4249.87250382489, 4269.466316710411, 4284.0, 4347.652187824967, 4461.42001539801, 313305.0, 313792.0, 314373.42813286016, 315879.0, 316592.0, 45058.0, 45298.320525192146, 45323.320150197775, 45403.31895021578, 45488.77255613767, 31275.0, 31954.84022579872, 32009.839950800564, 33685.0, 33725.32549349048, 12325.630231093082, 12490.375481225903, 12506.0, 12511.061670374758, 12513.311767852674, 8546.572671366532, 8769.0, 9515.191208747334, 9564.378315409476, 9592.808143837085, 14524.346404411826, 14849.480268190562, 14988.700225995419, 15324.923375383274, 15412.922935385252, 5554.250176226238, 5680.0, 5685.260916080966, 5742.13867919807, 5898.292204935436, 790.9683612655544, 857.5969294431607, 889.9644014239487, 938.8826396700413, 962.7208109648124, 27098.45803083967, 27585.86207068992, 27880.72119278822, 27925.16224513268, 28101.71898281032, 928.7770934975557, 974.2498276327188, 978.1978777402604, 992.7220378294089, 1041.375174895057, 14449.711005779825, 14451.205183714786, 14671.266436678123, 14736.0, 14803.703925921422, 494182.0, 499819.0, 501000.0, 501008.0, 502389.0, 45840.77079614581, 46263.76868115705, 46273.76863115663, 46295.30557041647, 46360.0, 1042.9634962776418, 1055.757175849559, 1086.3373342261214, 1115.3085087245797, 1139.1684070628487, 27104.864475677496, 28449.43101137924, 28667.28331791722, 28771.856140719163, 28840.855795721727, 37092.629073708915, 37402.625973739916, 37419.0, 37453.6254637461, 37459.06352341213, 363666.0, 364302.0, 365076.0, 365970.0, 369166.0, 24462.877685611456, 25433.0, 25445.10942117017, 26470.338241543344, 26821.597676034486, 37672.0, 38112.0, 38206.61793382031, 38837.0, 38866.805665971486, 32927.67072329246, 33223.83388083141, 33355.49966750452, 33527.83236083804, 34113.14717131992, 33327.666723332455, 33328.66671333255, 34035.319293614484, 34128.65871341255, 34671.13322166966, 33333.49999749957, 33428.66571334353, 33812.492812607336, 33908.0, 34008.0, 26390.73609263883, 29399.559006615345, 30403.2399190022, 30690.693093069676, 31626.525602115526, 24182.758172418755, 24617.0, 24629.261122166365, 24884.875575622005, 25100.24699259025], "value": 17305.59998782065, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.1246882793017, 374.17867780222406, 377.79628748215134, 378.15859712140485, 403.8525938032619, 13354.866451335483, 14007.579772606812, 14285.286065426342, 17202.311907523683, 17853.19660615272, 15460.381584736597, 15811.92094039531, 15932.601684957854, 15960.84039159608, 15980.76028859568, 4929.827456039048, 5191.792328306863, 5224.216367544861, 5292.073887069748, 5295.0, 3686.7972261525606, 5196.766145523442, 5252.606054545905, 5257.158854583248, 5262.8684282892855, 4152.294110001307, 4302.720323178999, 6305.527085468585, 6410.583312084723, 6422.357764223587, 5701.572382071361, 5913.113033045078, 6374.585651932633, 6386.201724784379, 6391.201099862517, 5579.46995035471, 5607.831765047055, 5613.410591887875, 5619.719014049281, 5622.85942851432, 13379.665508362272, 15802.841971580252, 20132.396028119034, 20350.0, 20563.0, 2200.922967696123, 2303.332033710222, 2336.6144586143437, 2347.471818840764, 2372.027468737809, 9538.236941044699, 9939.304248702594, 10410.219233557438, 10503.36979781208, 12011.939940300243, 1865.7201419787004, 1943.3489780923408, 1945.3580318494862, 1961.137099676138, 1966.5108068842856, 82528.44803094295, 86228.56885715657, 86263.56868215681, 86743.0, 87291.56354218251, 10460.424676642706, 10463.267571270091, 10570.52432640533, 10580.153587712965, 10684.732881678021, 14859.331330090172, 14880.851191487947, 14913.627159321104, 14923.253837308092, 14937.0, 6647.468202543785, 6761.18865736105, 6859.416949559343, 6928.549644273106, 7022.12223472066, 6067.453929146398, 6148.477379422709, 6325.335839736854, 6328.5886417383645, 6393.104965304861, 4381.715188512737, 4426.734395936254, 4458.910821783611, 4562.680612357103, 4596.448426188878, 1842.3828017613982, 1862.824736000155, 1926.8169523895208, 1953.1991883327767, 2002.5594369238745, 778.7067087427585, 832.1553623072587, 860.3418384935529, 864.6411739128317, 923.4920793563513, 17030.57423564421, 17330.273991091723, 17462.166472520457, 18083.54791130232, 18522.81477185238, 856.8928883889514, 864.8097418567905, 887.1084560017271, 897.7261935109855, 909.7998440343114, 9269.258459323239, 9934.50327483623, 10037.120860124767, 10057.59769609222, 10075.848862267072, 437236.0, 444763.0, 444958.97684604273, 445093.0, 445703.0, 91086.0, 91291.0, 92290.0, 92944.53527732454, 93875.53062234646, 857.1642648417867, 881.2245224202788, 910.1671970147373, 913.821804748081, 915.057490784493, 15223.314950827018, 15254.542363729106, 15692.607684807514, 15908.363665453253, 15977.440789572309, 40221.0, 40448.595514044486, 40925.0, 41870.0, 42500.57499424966, 56353.71823140858, 57674.0, 57923.4207657918, 58258.4174158253, 58437.70781146067, 7218.783436496913, 7403.814904627212, 7588.582627955516, 7634.083909930621, 7705.730299439493, 11640.01059909917, 11942.701432464259, 12032.157748957488, 12067.336296503425, 12672.0, 6126.846828829315, 10748.677539673823, 10783.622573210214, 10828.783424331627, 11166.609168679057, 10794.460276985963, 10938.070264027647, 11028.338299702044, 11289.943550282196, 11514.53941842317, 10770.24608277413, 11028.172887033345, 11093.94453027762, 11161.441927903736, 11339.319640821248, 7521.323080922743, 7658.578778167254, 7829.060512738508, 7984.800379990546, 8186.181381861767, 10718.89281107179, 10989.61536346224, 10997.395143267197, 11017.669469915916, 11091.889081109086], "value": 8525.9665632402, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1116.7264020315024, 1195.8445402097725, 1202.705337192388, 1232.2421710647952, 1401.6355747505645, 7615.77152685419, 8316.958415207922, 8606.139386061392, 8614.483131012144, 8885.68900088497, 8558.400911936167, 8638.049814520398, 8640.39517233794, 8647.264982476481, 8648.870266946002, 2328.930132096036, 2331.4521087544413, 2354.1407386304045, 2359.1978727232736, 2368.0882860098814, 2298.678185054094, 2327.767223277676, 2376.025829409942, 2381.880905954704, 2384.046381447426, 2347.084636991566, 2354.0, 2362.6692263083182, 2367.2898130560848, 2384.225126833786, 2264.9886750566307, 2277.077783497686, 2277.601419751545, 2289.255991802654, 2322.3381336319067, 2256.3907744908947, 2257.198694463458, 2257.6613507973934, 2257.8532395394245, 2259.5029093599383, 8490.66037358505, 8502.872456913152, 8669.263112635434, 8674.913250867474, 8778.47329160246, 5167.638265321391, 5288.127458969266, 5291.259223708684, 5292.259083728281, 5298.152295632719, 3556.4665300205174, 3562.608113107556, 3585.515955346021, 3639.108418437473, 3640.3083414151492, 1085.8262677971566, 1114.9554017839278, 1126.763379690266, 1151.3840095548842, 1166.4925757295603, 12128.0, 12282.07884408664, 12283.57007504733, 12330.691732706664, 12372.81440778389, 4347.391365208873, 4407.493138289074, 4541.250693635579, 4588.587027167571, 4596.218642830727, 9131.771705707277, 9133.0, 9138.08619138081, 9163.404378715362, 9171.77070573241, 4816.807327706852, 4864.513548645178, 4883.975580122076, 4892.217245240744, 4893.584045356185, 4230.534641189467, 4384.934225986549, 4522.253828118323, 4561.498235194126, 4741.336212930192, 3731.8134093295225, 3779.093017675738, 3909.338531124261, 3913.8043097844993, 3915.7846318452757, 1269.4351013798955, 1294.2558029133286, 1294.9676258093434, 1305.4908585651604, 1306.7125232448846, 683.7606837606897, 852.2968550945495, 854.7734850264685, 861.5304658960881, 866.0603245478726, 5724.77100915967, 5848.795292164754, 5855.853603659943, 6072.453479186895, 6183.258009038854, 427.7006095732999, 428.29545397821033, 428.71062033127515, 431.86180422264573, 433.43653250773866, 4040.515138183378, 4153.1070819773895, 4159.958400416018, 4186.644135248538, 4198.832046718097, 10601.522931468102, 10857.37139429092, 10997.175211859143, 11021.669349919515, 11033.503492342863, 10809.459527023775, 10810.135189185004, 10839.83740243897, 10849.403282819521, 10865.0, 7822.569758663214, 7858.803529911798, 7895.486793358298, 7898.328642065489, 7915.0, 5755.223044888887, 5757.251557297692, 5830.53355731549, 5860.0, 5919.6744179070565, 9942.950285248817, 9950.4527250999, 10013.148882345082, 10023.949880250551, 10042.397456152654, 9654.71035868925, 10065.295429319878, 10201.540930658286, 10558.683239502827, 10568.260221784401, 6620.437262832521, 6833.0, 7167.8566428672175, 7477.738279160203, 7633.580153091633, 8004.399670024888, 8414.200650938152, 8416.284615807725, 8425.789355265922, 8439.535825529654, 7449.925500744923, 7452.956586077845, 7562.470627056054, 7587.279208475186, 7725.884111738216, 7276.745313913988, 7365.079365079365, 7411.518251313647, 7650.579218143055, 7723.150453450228, 6811.318868113149, 6917.965410172917, 6938.063361446342, 6939.514234003571, 6943.756968506078, 4920.138975679313, 5054.873628159326, 5162.561182299547, 5175.171972484384, 5258.816766227568, 5300.814471493479, 5329.280547126088, 5345.116167855571, 5381.838544843661, 5582.469665381782], "value": 4432.142664582371, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.664450781886, 311.48604802076574, 321.5177234148777, 321.8246055899535, 323.55995845649926, 4732.195526760451, 5007.599392048636, 5236.397814251362, 5272.4991125843035, 5273.103572392698, 5158.277841102249, 5179.637425380215, 5201.141811601091, 5212.853172302088, 5217.7563647631505, 4104.179164167163, 4120.423140760296, 4124.711270211086, 4130.731502452346, 4136.896577585554, 3915.885421872186, 4122.546519882811, 4150.3359462486005, 4159.604837540429, 4185.644220241283, 3818.8090595470253, 4064.9187016259657, 4091.9181616367655, 4097.344424892018, 4102.425660407545, 4066.7356621819486, 4076.449679293302, 4090.2228576570355, 4091.89770255743, 4100.5899410059055, 3614.7469677122613, 3646.161382881952, 3648.8175591220333, 3650.5801832789302, 3654.488371627974, 4870.687932206099, 5079.466656001141, 5085.491450854922, 5123.821521050179, 5164.32863727713, 4648.930266046012, 4653.488116307203, 4664.787155339603, 4677.88305292367, 4683.2975053741875, 5472.974999250303, 5476.342838859323, 5510.311211098613, 5529.502344788988, 5552.11166213408, 3837.961620383788, 3906.785126818024, 3907.159960608454, 3911.550171730259, 3927.4894263745814, 5365.678059316453, 5516.503514683698, 5608.055770720363, 5676.687782171979, 5680.466274106009, 3851.2490064437725, 3945.9605403946166, 3951.8024098794945, 3957.2679054375035, 3969.4915931945675, 4018.015586181404, 4019.0354314964197, 4020.2562525932794, 4023.517177938666, 4032.6572241359227, 4540.523245059288, 4615.922834724387, 4636.420447444069, 4636.536346365404, 4643.558861908181, 5359.5712343012465, 5375.220593013991, 5381.789097453042, 5399.70301633414, 5414.0, 1346.9259190744408, 1367.548708926052, 1368.117564171124, 1373.203541945669, 1376.7108907129616, 843.6161546496452, 874.6195404998846, 886.1448702002598, 888.6045709659269, 896.4979611417627, 4668.992333296715, 4687.414073240845, 4701.224297990793, 4720.026383378449, 4737.24204127338, 4879.902401951941, 4890.608751299887, 4930.841252305705, 4945.315739773891, 4991.800327986913, 4325.913481730411, 4672.252439609646, 4685.695429797052, 4698.647601429906, 4732.834350797705, 2587.573050446655, 2596.1562492190114, 2598.6621739174166, 2607.960880586793, 2612.2163350994624, 5024.84925452237, 5052.7726252318735, 5066.794560514764, 5086.491350864884, 5116.56509196715, 4772.665913386029, 4878.583457058268, 4937.580305673986, 4965.205567109245, 4978.352814134139, 5006.574441172541, 5015.677111417372, 5044.8234311798915, 5046.6719663221775, 5047.0, 4839.7096174229655, 4851.636127290397, 4855.854324370274, 4893.828715994923, 4953.603711702983, 4577.741121191699, 4838.758062096811, 4845.709257444564, 4874.781974201801, 4890.413150421972, 4981.2030075187795, 5075.842766824011, 5486.259354987185, 5610.49505544503, 5676.403977582459, 3917.334053211018, 3919.8236079375924, 3945.270125026879, 3971.185906889023, 3980.8009599520487, 5636.238243260691, 5636.802711905064, 5643.971780141237, 5645.729710815034, 5665.716714164193, 5201.375834899836, 5362.839114826562, 5398.731298144854, 5441.646292990943, 5522.282103326542, 5404.270423492935, 5425.755840987244, 5429.429909859408, 5446.618736688394, 5450.563954883521, 5317.57459403239, 5454.59090568201, 5456.48163424474, 5460.208269800936, 5492.176173573836, 5432.619716619799, 5464.207689885024, 5471.534919531884, 5488.5334746545395, 5496.148097044965, 5346.7059311736675, 5370.194470829407, 5383.192521121863, 5395.487428694268, 5478.424765399575], "value": 4011.504807813922, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.6230493636541, 641.1184621145925, 650.8860949333865, 655.1123228026028, 667.1427216027404, 12869.742605147903, 13573.253471059088, 13688.657783555416, 13690.247036412993, 13716.588502344921, 11957.521699132025, 12047.939760301208, 12052.758944821098, 12085.697857553565, 12090.395480225976, 547.5154488277873, 562.7186406796602, 563.9718014099299, 564.5737468211495, 564.6499170514287, 483.0773223143796, 494.3375876325723, 546.7484956919802, 558.1627558662007, 561.1554610311496, 586.1881294407256, 592.4697395830729, 592.7451195985724, 592.7747455966727, 592.9080992446178, 589.5107061139244, 590.35356284868, 590.5128269177945, 590.7312172961335, 590.7341696236667, 368.06695028103894, 375.5981100222763, 415.4723501153518, 421.4668444417814, 429.7163871844568, 11661.766764664659, 12043.156979011474, 12044.518219271218, 12065.939670301681, 12118.272903625812, 13027.413766380536, 13268.270245136513, 13423.0, 13481.932590337083, 13755.0, 12158.5136594537, 12270.079744019235, 12290.139690221687, 12381.62855114348, 12492.937535312356, 4164.646005089571, 4171.582841715835, 4218.894527636803, 4254.659627229814, 4394.011347446799, 78538.0, 78558.21441785566, 82263.17736822675, 82329.0, 82559.58720206421, 10288.228382871315, 10444.73888152787, 10502.479404942758, 10624.256302058782, 10781.784364312669, 19415.0, 19431.61136777285, 19455.610887782164, 19456.319028833925, 19466.124024418936, 7833.099193592696, 7879.645415956295, 8034.839303213903, 8100.270975612106, 8221.917780822116, 4485.125400546862, 4581.816727330936, 4615.376924115269, 4690.343351930733, 4738.147133515931, 3397.9660203398143, 3494.807785571818, 3496.0735405117666, 3497.7726447780815, 3499.720022398202, 576.8211854325173, 578.733782460073, 582.2750675409059, 582.4990508162977, 600.3246347858659, 509.3700159489574, 514.6191818054688, 548.0217811207056, 578.6412424296963, 580.9803794340904, 8718.782030449289, 8895.377323587416, 9028.187463128219, 9043.683471078612, 9262.0, 555.3807504632387, 583.3204316970682, 599.7690889007763, 605.4369436424167, 616.3805375597585, 4107.116969851496, 4188.958110418917, 4195.895102622459, 4234.830606775756, 4350.477942646839, 91118.54440727754, 117638.0, 121516.0, 121575.0, 122733.0, 64373.03440448397, 65583.34416655867, 89423.10576894278, 100972.49513752385, 104397.47801260946, 89938.55030724936, 92967.0, 92976.53511732533, 93155.53422232845, 93553.0, 8024.317932975762, 8199.549024803693, 8301.128381520095, 8322.216059838354, 8675.262602678842, 53804.0, 54166.458335417716, 54419.91160176854, 54609.0, 55475.72262138664, 73222.0, 77874.61062694651, 80333.59833200797, 81143.5942820282, 82314.17685823065, 10502.687164104487, 10580.365178089032, 10651.733706657396, 10812.621558245739, 10834.133269338276, 11050.392228427514, 11082.556697732, 11164.553417863195, 12463.937680311541, 12487.562935297221, 11703.648890533297, 12101.636950891487, 12874.291913944822, 12931.159474634118, 12954.676133096747, 10405.483033892562, 12714.0, 12838.486460541848, 12953.352332383532, 13910.443582256596, 12886.935565322488, 13463.192208467523, 13514.526991555249, 13656.93171534136, 13977.58067257984, 10758.623448179276, 10799.40603266828, 11190.160737944523, 11240.7751844961, 11377.20359574855, 10476.895231047896, 11381.0, 11786.351750653796, 12143.939280303543, 12154.270743755404], "value": 6721.952293043172, "unit": "score"}], "name": "dromaeo_css", "value": 6697.291578600569, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 110.0, 109.0, 111.0, 113.0, 109.0, 110.0, 111.0, 109.0, 112.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 122.0, 123.0, 169.0, 123.0, 122.0, 120.0, 120.0, 150.0, 123.0], "value": 132.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 164.0, 165.0, 163.0, 162.0, 162.0, 162.0, 163.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 115.0, 76.0, 76.0, 75.0, 75.0, 104.0, 76.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 116.0, 84.0, 83.0, 83.0, 102.0, 83.0, 83.0, 113.0], "value": 91.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 50.0, 51.0, 52.0, 53.0, 53.0, 53.0, 52.0, 52.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 60.0, 60.0, 60.0, 60.0, 61.0, 61.0, 60.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 86.0, 79.0, 79.0, 80.0, 86.0, 79.0, 79.0, 89.0, 79.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 138.0, 139.0, 128.0, 139.0, 136.0, 136.0, 132.0, 165.0, 131.0], "value": 138.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 161.0, 164.0, 164.0, 165.0, 175.0, 169.0, 171.0, 163.0], "value": 166.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 65.0, 67.0, 65.0, 66.0, 64.0, 65.0, 69.0, 65.0], "value": 66.2, "unit": "score"}], "name": "kraken", "value": 1502.1999999999998, "alertThreshold": 2.0}]} 04:42:56 INFO - Return code: 0 04:42:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:42:56 INFO - # TBPL SUCCESS # 04:42:56 INFO - Running post-action listener: _resource_record_post_action 04:42:56 INFO - [mozharness: 2016-10-13 11:42:56.083583Z] Finished run-tests step (success) 04:42:56 INFO - Running post-run listener: _resource_record_post_run 04:42:56 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 394788864; Read time: 20; Write time: 261068 04:42:56 INFO - TinderboxPrint: CPU usage
13.1% 04:42:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 04:42:56 INFO - TinderboxPrint: I/O write bytes / time
394,788,864 / 261,068 04:42:56 INFO - TinderboxPrint: CPU idle
8,290.2 (86.9%) 04:42:56 INFO - TinderboxPrint: CPU user
1,203.8 (12.6%) 04:42:56 INFO - TinderboxPrint: Swap in / out
0 / 0 04:42:56 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103895040; Read time: 0; Write time: 91440 04:42:56 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 290893824; Read time: 0; Write time: 169628 04:42:56 INFO - Running post-run listener: _upload_blobber_files 04:42:56 INFO - Blob upload gear active. 04:42:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:42:56 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 04:42:56 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:42:56 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:42:57 INFO - (blobuploader) - INFO - Open directory for files ... 04:42:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:42:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:42:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:43:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:00 INFO - (blobuploader) - INFO - Done attempting. 04:43:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:43:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:43:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:01 INFO - (blobuploader) - INFO - Done attempting. 04:43:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:43:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:43:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:43:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:43:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:43:02 INFO - (blobuploader) - INFO - Done attempting. 04:43:02 INFO - (blobuploader) - INFO - Iteration through files over. 04:43:02 INFO - Return code: 0 04:43:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:43:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:43:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5991593875190a2321c6fda31a7a99522efefffafc231dd42d28d260028fa6d087eaaf498ee02f31fcc768c4df2bc8e400cf2ebb9aba9e035e1f679ac28bf9ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ad0aa8277b7b8b68e9f6c4ef333ec52d1c95a8b8541a9c3a578ce48abd6529d056617cd0add2813b86d9d18022e7a285500bc2eca035f8bebaaf236ab490a35", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eac1c35d44b29c23496b6abe3caa2a9740c8a2b0c315d58a4a15083dcfc798fa63bdb44882e2518ef321634231c5f4611c7f742dcccb2d2fc5bd51e3231a623c"} 04:43:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:43:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:43:02 INFO - Contents: 04:43:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5991593875190a2321c6fda31a7a99522efefffafc231dd42d28d260028fa6d087eaaf498ee02f31fcc768c4df2bc8e400cf2ebb9aba9e035e1f679ac28bf9ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ad0aa8277b7b8b68e9f6c4ef333ec52d1c95a8b8541a9c3a578ce48abd6529d056617cd0add2813b86d9d18022e7a285500bc2eca035f8bebaaf236ab490a35", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eac1c35d44b29c23496b6abe3caa2a9740c8a2b0c315d58a4a15083dcfc798fa63bdb44882e2518ef321634231c5f4611c7f742dcccb2d2fc5bd51e3231a623c"} 04:43:02 INFO - Running post-run listener: copy_logs_to_upload_dir 04:43:02 INFO - Copying logs to upload dir... 04:43:02 INFO - mkdir: /builds/slave/test/build/upload/logs 04:43:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.690216 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-13 04:43:01.176608) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 04:43:01.180620) ========= 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=523ca41ca1e0623de333ad52000001bf-1476357740.760330-2080187500 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5991593875190a2321c6fda31a7a99522efefffafc231dd42d28d260028fa6d087eaaf498ee02f31fcc768c4df2bc8e400cf2ebb9aba9e035e1f679ac28bf9ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ad0aa8277b7b8b68e9f6c4ef333ec52d1c95a8b8541a9c3a578ce48abd6529d056617cd0add2813b86d9d18022e7a285500bc2eca035f8bebaaf236ab490a35", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eac1c35d44b29c23496b6abe3caa2a9740c8a2b0c315d58a4a15083dcfc798fa63bdb44882e2518ef321634231c5f4611c7f742dcccb2d2fc5bd51e3231a623c"} build_url:https://queue.taskcluster.net/v1/task/Xf-B2-E3TkChYPYsjabF7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011314 build_url: 'https://queue.taskcluster.net/v1/task/Xf-B2-E3TkChYPYsjabF7Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5991593875190a2321c6fda31a7a99522efefffafc231dd42d28d260028fa6d087eaaf498ee02f31fcc768c4df2bc8e400cf2ebb9aba9e035e1f679ac28bf9ee", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8ad0aa8277b7b8b68e9f6c4ef333ec52d1c95a8b8541a9c3a578ce48abd6529d056617cd0add2813b86d9d18022e7a285500bc2eca035f8bebaaf236ab490a35", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eac1c35d44b29c23496b6abe3caa2a9740c8a2b0c315d58a4a15083dcfc798fa63bdb44882e2518ef321634231c5f4611c7f742dcccb2d2fc5bd51e3231a623c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 04:43:01.206466) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 04:43:01.206857) ========= 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=523ca41ca1e0623de333ad52000001bf-1476357740.760330-2080187500 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 04:43:01.289003) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 04:43:01.289323) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 04:43:01.289610) ========= ========= Total master_lag: 0.15 =========