builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-015 starttime: 1480956472.92 results: success (0) buildid: 20161205070638 builduid: ca6df37595034678b897c7b624369dfe revision: 46049b21980d67b13d6915c052a3025c273a1788 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-05 08:47:52.919767) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-05 08:47:52.920180) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-05 08:47:52.920524) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-05 08:47:52.970754) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 08:47:52.971046) ========= 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=20e666a3d4cfbb71505a330e000001b4-1480956077.431752-1292481603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-05 08:47:53-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2016-12-05 08:47:53 (227 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.207160 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 08:47:53.226896) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 08:47:53.227296) ========= 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=20e666a3d4cfbb71505a330e000001b4-1480956077.431752-1292481603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.065458 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 08:47:53.306113) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 08:47:53.306465) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 46049b21980d67b13d6915c052a3025c273a1788 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 46049b21980d67b13d6915c052a3025c273a1788 --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=20e666a3d4cfbb71505a330e000001b4-1480956077.431752-1292481603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-05 08:47:53,366 truncating revision to first 12 chars 2016-12-05 08:47:53,366 Setting DEBUG logging. 2016-12-05 08:47:53,366 attempt 1/10 2016-12-05 08:47:53,366 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/46049b21980d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-05 08:47:53,679 unpacking tar archive at: mozilla-aurora-46049b21980d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.630213 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 08:47:53.951438) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-05 08:47:53.951762) ========= script_repo_revision: 46049b21980d67b13d6915c052a3025c273a1788 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-05 08:47:53.952149) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-05 08:47:53.952414) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-05 08:47:53.963164) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-12-05 08:47:53.963528) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1480956077.431752-1292481603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:47:54 INFO - MultiFileLogger online at 20161205 08:47:54 in /builds/slave/test 08:47:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:47:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:47:54 INFO - {'append_to_log': False, 08:47:54 INFO - 'base_work_dir': '/builds/slave/test', 08:47:54 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:47:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:47:54 INFO - 'branch': 'Mozilla-Aurora', 08:47:54 INFO - 'buildbot_json_path': 'buildprops.json', 08:47:54 INFO - 'config_files': ('talos/linux_config.py',), 08:47:54 INFO - 'default_actions': ('clobber', 08:47:54 INFO - 'read-buildbot-config', 08:47:54 INFO - 'download-and-extract', 08:47:54 INFO - 'populate-webroot', 08:47:54 INFO - 'create-virtualenv', 08:47:54 INFO - 'install', 08:47:54 INFO - 'run-tests'), 08:47:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:47:54 INFO - 'download_minidump_stackwalk': True, 08:47:54 INFO - 'download_symbols': 'ondemand', 08:47:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:47:54 INFO - 'tooltool.py': '/tools/tooltool.py', 08:47:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:47:54 INFO - '/tools/misc-python/virtualenv.py')}, 08:47:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:47:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:47:54 INFO - 'installer_path': 'installer.exe', 08:47:54 INFO - 'log_level': 'info', 08:47:54 INFO - 'log_name': 'talos', 08:47:54 INFO - 'log_to_console': True, 08:47:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:47:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:47:54 INFO - 'opt_config_files': (), 08:47:54 INFO - 'pip_index': False, 08:47:54 INFO - 'sps_profile': False, 08:47:54 INFO - 'sps_profile_interval': 0, 08:47:54 INFO - 'suite': 'dromaeojs', 08:47:54 INFO - 'system_bits': '32', 08:47:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:47:54 INFO - 'title': 'talos-linux64-ix-015', 08:47:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:47:54 INFO - 'use_talos_json': True, 08:47:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:47:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:47:54 INFO - 'work_dir': 'build'} 08:47:54 INFO - [mozharness: 2016-12-05 16:47:54.220901Z] Running clobber step. 08:47:54 INFO - Running pre-action listener: _resource_record_pre_action 08:47:54 INFO - Running main action method: clobber 08:47:54 INFO - rmtree: /builds/slave/test/build 08:47:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:47:55 INFO - Running post-action listener: _resource_record_post_action 08:47:55 INFO - [mozharness: 2016-12-05 16:47:55.240578Z] Finished clobber step (success) 08:47:55 INFO - [mozharness: 2016-12-05 16:47:55.240708Z] Running read-buildbot-config step. 08:47:55 INFO - Running pre-action listener: _resource_record_pre_action 08:47:55 INFO - Running main action method: read_buildbot_config 08:47:55 INFO - Using buildbot properties: 08:47:55 INFO - { 08:47:55 INFO - "project": "", 08:47:55 INFO - "product": "firefox", 08:47:55 INFO - "script_repo_revision": "production", 08:47:55 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:47:55 INFO - "repository": "", 08:47:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 08:47:55 INFO - "buildid": "20161205070638", 08:47:55 INFO - "pgo_build": "True", 08:47:55 INFO - "basedir": "/builds/slave/test", 08:47:55 INFO - "buildnumber": 630, 08:47:55 INFO - "slavename": "talos-linux64-ix-015", 08:47:55 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:47:55 INFO - "platform": "ubuntu64_hw", 08:47:55 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:47:55 INFO - "branch": "mozilla-aurora", 08:47:55 INFO - "repo_path": "releases/mozilla-aurora", 08:47:55 INFO - "revision": "46049b21980d67b13d6915c052a3025c273a1788", 08:47:55 INFO - "stage_platform": "linux64-pgo", 08:47:55 INFO - "builduid": "ca6df37595034678b897c7b624369dfe", 08:47:55 INFO - "slavebuilddir": "test" 08:47:55 INFO - } 08:47:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 08:47:55 INFO - Running post-action listener: _resource_record_post_action 08:47:55 INFO - [mozharness: 2016-12-05 16:47:55.243948Z] Finished read-buildbot-config step (success) 08:47:55 INFO - [mozharness: 2016-12-05 16:47:55.244065Z] Running download-and-extract step. 08:47:55 INFO - Running pre-action listener: _resource_record_pre_action 08:47:55 INFO - Running main action method: download_and_extract 08:47:55 INFO - mkdir: /builds/slave/test/build/tests 08:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:47:55 INFO - trying https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:47:55 INFO - Downloading https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:47:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:47:55 INFO - Downloaded 1361 bytes. 08:47:55 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:47:55 INFO - Using the following test package requirements: 08:47:55 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:47:55 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:47:55 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:47:55 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:47:55 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:47:55 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:47:55 INFO - u'jsshell-linux-x86_64.zip'], 08:47:55 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:47:55 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:47:55 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:47:55 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:47:55 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:47:55 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:47:55 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:47:55 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:47:55 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:47:55 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:47:55 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:47:55 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:47:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:47:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:47:55 INFO - Fetch https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:47:56 INFO - Http code: 200 08:47:56 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 08:47:56 INFO - x-amz-cf-id: _jcZszz4kKajUXyuaYSFb9wh-P45ID1ux8_zhSOB-XeBn1sj-07bRA== 08:47:56 INFO - x-amz-version-id: KqWZvKDpblLqtW1i2bA.CSkZ2ptCSO1S 08:47:56 INFO - Expected file size: 21954501 08:47:56 INFO - Obtained file size: 21954501 08:48:00 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:48:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:48:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:48:00 INFO - Fetch https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:48:01 INFO - Http code: 200 08:48:01 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 08:48:01 INFO - x-amz-cf-id: J1-itkn7w4G-mOMkk-ADnQkpQCV5xq35hHb3kH1naG4rEB_8h2egog== 08:48:01 INFO - x-amz-version-id: KqWZvKDpblLqtW1i2bA.CSkZ2ptCSO1S 08:48:01 INFO - Expected file size: 21954501 08:48:01 INFO - Obtained file size: 21954501 08:48:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 08:48:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:48:06 INFO - Fetch https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 08:48:07 INFO - Http code: 200 08:48:07 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 08:48:07 INFO - x-amz-cf-id: MCFYmHZZLq4LkrLTIFMdK8ZvvNQ34kmPP2YsmqHAIIXpKijuOFkRmA== 08:48:07 INFO - x-amz-version-id: eAa_42RlakpvmLEJGtt93LWTNXz6JRCa 08:48:07 INFO - Expected file size: 14409038 08:48:07 INFO - Obtained file size: 14409038 08:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:07 INFO - trying https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:48:07 INFO - Downloading https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:48:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:48:10 INFO - Downloaded 63987567 bytes. 08:48:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:48:10 INFO - mkdir: /builds/slave/test/properties 08:48:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:48:10 INFO - Writing to file /builds/slave/test/properties/build_url 08:48:10 INFO - Contents: 08:48:10 INFO - build_url:https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:48:11 INFO - Running post-action listener: _resource_record_post_action 08:48:11 INFO - Running post-action listener: set_extra_try_arguments 08:48:11 INFO - [mozharness: 2016-12-05 16:48:11.063008Z] Finished download-and-extract step (success) 08:48:11 INFO - [mozharness: 2016-12-05 16:48:11.063238Z] Running populate-webroot step. 08:48:11 INFO - Running pre-action listener: _resource_record_pre_action 08:48:11 INFO - Running main action method: populate_webroot 08:48:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:48:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:48:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:48:11 INFO - '--tppagecycles', 08:48:11 INFO - '7'], 08:48:11 INFO - 'tests': ['tsvgm']}}, 08:48:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:48:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:48:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:48:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:48:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:48:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:48:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:11 INFO - 'talos_options': ['--disable-e10s'], 08:48:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:48:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:48:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:11 INFO - 'talos_options': ['--disable-e10s'], 08:48:11 INFO - 'tests': ['damp', 'tps']}, 08:48:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:11 INFO - 'tests': ['damp', 'tps']}, 08:48:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:48:11 INFO - 'tests': ['dromaeo_dom']}, 08:48:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:48:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:48:11 INFO - 'tests': ['basic_compositor_video']}, 08:48:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:48:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:48:11 INFO - 'tests': ['a11yr', 08:48:11 INFO - 'ts_paint', 08:48:11 INFO - 'tpaint', 08:48:11 INFO - 'sessionrestore', 08:48:11 INFO - 'sessionrestore_no_auto_restore', 08:48:11 INFO - 'tabpaint']}, 08:48:11 INFO - 'other-e10s': {'tests': ['a11yr', 08:48:11 INFO - 'ts_paint', 08:48:11 INFO - 'tpaint', 08:48:11 INFO - 'sessionrestore', 08:48:11 INFO - 'sessionrestore_no_auto_restore', 08:48:11 INFO - 'tabpaint']}, 08:48:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:48:11 INFO - 'ts_paint', 08:48:11 INFO - 'tpaint', 08:48:11 INFO - 'sessionrestore', 08:48:11 INFO - 'sessionrestore_no_auto_restore', 08:48:11 INFO - 'tabpaint']}, 08:48:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:48:11 INFO - 'ts_paint', 08:48:11 INFO - 'tpaint', 08:48:11 INFO - 'sessionrestore', 08:48:11 INFO - 'sessionrestore_no_auto_restore', 08:48:11 INFO - 'tabpaint']}, 08:48:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:48:11 INFO - 'tests': ['a11yr', 08:48:11 INFO - 'ts_paint', 08:48:11 INFO - 'tpaint', 08:48:11 INFO - 'sessionrestore', 08:48:11 INFO - 'sessionrestore_no_auto_restore', 08:48:11 INFO - 'tabpaint']}, 08:48:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:48:11 INFO - 'tests': ['a11yr', 08:48:11 INFO - 'ts_paint', 08:48:11 INFO - 'tpaint', 08:48:11 INFO - 'sessionrestore', 08:48:11 INFO - 'sessionrestore_no_auto_restore', 08:48:11 INFO - 'tabpaint']}, 08:48:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:48:11 INFO - 'tests': ['tsvgx', 08:48:11 INFO - 'tsvgr_opacity', 08:48:11 INFO - 'tart', 08:48:11 INFO - 'tscrollx', 08:48:11 INFO - 'cart']}, 08:48:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:48:11 INFO - 'tsvgr_opacity', 08:48:11 INFO - 'tart', 08:48:11 INFO - 'tscrollx', 08:48:11 INFO - 'cart']}, 08:48:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:11 INFO - 'talos_options': ['--disable-e10s'], 08:48:11 INFO - 'tests': ['tp5o']}, 08:48:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:11 INFO - 'tests': ['tp5o']}, 08:48:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:11 INFO - 'talos_options': ['--disable-e10s', 08:48:11 INFO - '--xperf_path', 08:48:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:48:11 INFO - 'tests': ['tp5n']}, 08:48:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:48:11 INFO - 'talos_options': ['--xperf_path', 08:48:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:48:11 INFO - 'tests': ['tp5n']}}, 08:48:11 INFO - 'talos.zip': {'path': '', 08:48:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:48:11 INFO - Running post-action listener: _resource_record_post_action 08:48:11 INFO - [mozharness: 2016-12-05 16:48:11.080484Z] Finished populate-webroot step (success) 08:48:11 INFO - [mozharness: 2016-12-05 16:48:11.080572Z] Running create-virtualenv step. 08:48:11 INFO - Running pre-action listener: _resource_record_pre_action 08:48:11 INFO - Running main action method: create_virtualenv 08:48:11 INFO - Creating virtualenv /builds/slave/test/build/venv 08:48:11 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:48:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:48:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:48:11 INFO - Using real prefix '/usr' 08:48:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:48:11 INFO - Installing distribute.............................................................................................................................................................................................done. 08:48:14 INFO - Installing pip.................done. 08:48:14 INFO - Return code: 0 08:48:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:48:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:48:15 INFO - Reading from file tmpfile_stdout 08:48:15 INFO - Output received: 08:48:15 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:48:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac139bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177cf60>, '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 0x177dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177e1d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1480956077.431752-1292481603', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:48:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:48:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:48:15 INFO - Using env: {'DISPLAY': ':0', 08:48:15 INFO - 'HOME': '/home/cltbld', 08:48:15 INFO - 'LANG': 'en_US.UTF-8', 08:48:15 INFO - 'LANGUAGE': 'en_US:en', 08:48:15 INFO - 'LOGNAME': 'cltbld', 08:48:15 INFO - 'MAIL': '/var/mail/cltbld', 08:48:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:15 INFO - 'MOZ_NO_REMOTE': '1', 08:48:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:15 INFO - 'NO_EM_RESTART': '1', 08:48:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:15 INFO - 'PWD': '/builds/slave/test', 08:48:15 INFO - 'SHELL': '/bin/bash', 08:48:15 INFO - 'SHLVL': '1', 08:48:15 INFO - 'TERM': 'linux', 08:48:15 INFO - 'TMOUT': '86400', 08:48:15 INFO - 'USER': 'cltbld', 08:48:15 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1480956077.431752-1292481603', 08:48:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:15 INFO - '_': '/tools/buildbot/bin/python'} 08:48:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:48:15 INFO - Cleaning up... 08:48:15 INFO - Return code: 0 08:48:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8ac139bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177cf60>, '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 0x177dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177e1d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1480956077.431752-1292481603', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:48:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:48:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:48:15 INFO - Using env: {'DISPLAY': ':0', 08:48:15 INFO - 'HOME': '/home/cltbld', 08:48:15 INFO - 'LANG': 'en_US.UTF-8', 08:48:15 INFO - 'LANGUAGE': 'en_US:en', 08:48:15 INFO - 'LOGNAME': 'cltbld', 08:48:15 INFO - 'MAIL': '/var/mail/cltbld', 08:48:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:15 INFO - 'MOZ_NO_REMOTE': '1', 08:48:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:15 INFO - 'NO_EM_RESTART': '1', 08:48:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:15 INFO - 'PWD': '/builds/slave/test', 08:48:15 INFO - 'SHELL': '/bin/bash', 08:48:15 INFO - 'SHLVL': '1', 08:48:15 INFO - 'TERM': 'linux', 08:48:15 INFO - 'TMOUT': '86400', 08:48:15 INFO - 'USER': 'cltbld', 08:48:15 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1480956077.431752-1292481603', 08:48:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:15 INFO - '_': '/tools/buildbot/bin/python'} 08:48:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:15 INFO - Downloading/unpacking psutil>=3.1.1 08:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:48:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:48:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:48:17 INFO - Installing collected packages: psutil 08:48:17 INFO - Running setup.py install for psutil 08:48:17 INFO - building 'psutil._psutil_linux' extension 08:48:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:48:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:48:19 INFO - building 'psutil._psutil_posix' extension 08:48:19 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:48:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:48:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:48:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:48:19 INFO - Successfully installed psutil 08:48:19 INFO - Cleaning up... 08:48:19 INFO - Return code: 0 08:48:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:48:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac139bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177cf60>, '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 0x177dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177e1d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1480956077.431752-1292481603', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:48:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:48:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:48:19 INFO - Using env: {'DISPLAY': ':0', 08:48:19 INFO - 'HOME': '/home/cltbld', 08:48:19 INFO - 'LANG': 'en_US.UTF-8', 08:48:19 INFO - 'LANGUAGE': 'en_US:en', 08:48:19 INFO - 'LOGNAME': 'cltbld', 08:48:19 INFO - 'MAIL': '/var/mail/cltbld', 08:48:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:19 INFO - 'MOZ_NO_REMOTE': '1', 08:48:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:19 INFO - 'NO_EM_RESTART': '1', 08:48:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:19 INFO - 'PWD': '/builds/slave/test', 08:48:19 INFO - 'SHELL': '/bin/bash', 08:48:19 INFO - 'SHLVL': '1', 08:48:19 INFO - 'TERM': 'linux', 08:48:19 INFO - 'TMOUT': '86400', 08:48:19 INFO - 'USER': 'cltbld', 08:48:19 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1480956077.431752-1292481603', 08:48:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:19 INFO - '_': '/tools/buildbot/bin/python'} 08:48:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:48:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:48:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:48:22 INFO - Installing collected packages: mozsystemmonitor 08:48:22 INFO - Running setup.py install for mozsystemmonitor 08:48:22 INFO - Successfully installed mozsystemmonitor 08:48:22 INFO - Cleaning up... 08:48:22 INFO - Return code: 0 08:48:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8ac139bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177cf60>, '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 0x177dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177e1d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1480956077.431752-1292481603', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:48:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:48:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:48:22 INFO - Using env: {'DISPLAY': ':0', 08:48:22 INFO - 'HOME': '/home/cltbld', 08:48:22 INFO - 'LANG': 'en_US.UTF-8', 08:48:22 INFO - 'LANGUAGE': 'en_US:en', 08:48:22 INFO - 'LOGNAME': 'cltbld', 08:48:22 INFO - 'MAIL': '/var/mail/cltbld', 08:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:22 INFO - 'MOZ_NO_REMOTE': '1', 08:48:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:22 INFO - 'NO_EM_RESTART': '1', 08:48:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:22 INFO - 'PWD': '/builds/slave/test', 08:48:22 INFO - 'SHELL': '/bin/bash', 08:48:22 INFO - 'SHLVL': '1', 08:48:22 INFO - 'TERM': 'linux', 08:48:22 INFO - 'TMOUT': '86400', 08:48:22 INFO - 'USER': 'cltbld', 08:48:22 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1480956077.431752-1292481603', 08:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:22 INFO - '_': '/tools/buildbot/bin/python'} 08:48:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:22 INFO - Downloading/unpacking jsonschema==2.5.1 08:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:48:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:48:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:24 INFO - Downloading functools32-3.2.3-2.tar.gz 08:48:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:48:24 INFO - warning: no files found matching '*.txt' 08:48:24 INFO - no previously-included directories found matching 'build' 08:48:24 INFO - no previously-included directories found matching 'dist' 08:48:24 INFO - no previously-included directories found matching '.git*' 08:48:24 INFO - Installing collected packages: jsonschema, functools32 08:48:24 INFO - Running setup.py install for functools32 08:48:24 INFO - warning: no files found matching '*.txt' 08:48:24 INFO - no previously-included directories found matching 'build' 08:48:24 INFO - no previously-included directories found matching 'dist' 08:48:24 INFO - no previously-included directories found matching '.git*' 08:48:24 INFO - Successfully installed jsonschema functools32 08:48:24 INFO - Cleaning up... 08:48:24 INFO - Return code: 0 08:48:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:48:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac139bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177cf60>, '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 0x177dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177e1d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1480956077.431752-1292481603', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:48:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:48:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:48:24 INFO - Using env: {'DISPLAY': ':0', 08:48:24 INFO - 'HOME': '/home/cltbld', 08:48:24 INFO - 'LANG': 'en_US.UTF-8', 08:48:24 INFO - 'LANGUAGE': 'en_US:en', 08:48:24 INFO - 'LOGNAME': 'cltbld', 08:48:24 INFO - 'MAIL': '/var/mail/cltbld', 08:48:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:24 INFO - 'MOZ_NO_REMOTE': '1', 08:48:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:24 INFO - 'NO_EM_RESTART': '1', 08:48:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:24 INFO - 'PWD': '/builds/slave/test', 08:48:24 INFO - 'SHELL': '/bin/bash', 08:48:24 INFO - 'SHLVL': '1', 08:48:24 INFO - 'TERM': 'linux', 08:48:24 INFO - 'TMOUT': '86400', 08:48:24 INFO - 'USER': 'cltbld', 08:48:24 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1480956077.431752-1292481603', 08:48:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:24 INFO - '_': '/tools/buildbot/bin/python'} 08:48:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:48:25 INFO - Cleaning up... 08:48:25 INFO - Return code: 0 08:48:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:48:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:25 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 0x7f8ac139bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177cf60>, '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 0x177dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177e1d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1480956077.431752-1292481603', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:48:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:48:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:48:25 INFO - Using env: {'DISPLAY': ':0', 08:48:25 INFO - 'HOME': '/home/cltbld', 08:48:25 INFO - 'LANG': 'en_US.UTF-8', 08:48:25 INFO - 'LANGUAGE': 'en_US:en', 08:48:25 INFO - 'LOGNAME': 'cltbld', 08:48:25 INFO - 'MAIL': '/var/mail/cltbld', 08:48:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:25 INFO - 'MOZ_NO_REMOTE': '1', 08:48:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:25 INFO - 'NO_EM_RESTART': '1', 08:48:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:25 INFO - 'PWD': '/builds/slave/test', 08:48:25 INFO - 'SHELL': '/bin/bash', 08:48:25 INFO - 'SHLVL': '1', 08:48:25 INFO - 'TERM': 'linux', 08:48:25 INFO - 'TMOUT': '86400', 08:48:25 INFO - 'USER': 'cltbld', 08:48:25 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1480956077.431752-1292481603', 08:48:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:25 INFO - '_': '/tools/buildbot/bin/python'} 08:48:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:25 INFO - Downloading/unpacking blobuploader==1.2.4 08:48:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:27 INFO - Downloading blobuploader-1.2.4.tar.gz 08:48:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:48:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:48:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:28 INFO - Downloading docopt-0.6.1.tar.gz 08:48:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:48:28 INFO - Installing collected packages: blobuploader, requests, docopt 08:48:28 INFO - Running setup.py install for blobuploader 08:48:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:48:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:48:28 INFO - Running setup.py install for requests 08:48:28 INFO - Running setup.py install for docopt 08:48:28 INFO - Successfully installed blobuploader requests docopt 08:48:28 INFO - Cleaning up... 08:48:28 INFO - Return code: 0 08:48:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac139bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177cf60>, '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 0x177dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177e1d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1480956077.431752-1292481603', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:48:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:48:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:48:28 INFO - Using env: {'DISPLAY': ':0', 08:48:28 INFO - 'HOME': '/home/cltbld', 08:48:28 INFO - 'LANG': 'en_US.UTF-8', 08:48:28 INFO - 'LANGUAGE': 'en_US:en', 08:48:28 INFO - 'LOGNAME': 'cltbld', 08:48:28 INFO - 'MAIL': '/var/mail/cltbld', 08:48:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:28 INFO - 'MOZ_NO_REMOTE': '1', 08:48:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:28 INFO - 'NO_EM_RESTART': '1', 08:48:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:28 INFO - 'PWD': '/builds/slave/test', 08:48:28 INFO - 'SHELL': '/bin/bash', 08:48:28 INFO - 'SHLVL': '1', 08:48:28 INFO - 'TERM': 'linux', 08:48:28 INFO - 'TMOUT': '86400', 08:48:28 INFO - 'USER': 'cltbld', 08:48:28 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1480956077.431752-1292481603', 08:48:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:28 INFO - '_': '/tools/buildbot/bin/python'} 08:48:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:48:28 INFO - Running setup.py (path:/tmp/pip-kRRAQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:48:29 INFO - Running setup.py (path:/tmp/pip-RgK22i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:48:29 INFO - Running setup.py (path:/tmp/pip-vyJdP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:48:29 INFO - Running setup.py (path:/tmp/pip-nj3mXg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:48:29 INFO - Running setup.py (path:/tmp/pip-SivrQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:48:29 INFO - Running setup.py (path:/tmp/pip-ocvJyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:48:29 INFO - Running setup.py (path:/tmp/pip-ULLg9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:48:29 INFO - Running setup.py (path:/tmp/pip-CLA91r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:48:29 INFO - Running setup.py (path:/tmp/pip-xotaft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:48:29 INFO - Running setup.py (path:/tmp/pip-ABDlVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:48:29 INFO - Running setup.py (path:/tmp/pip-LZbODH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:48:29 INFO - Running setup.py (path:/tmp/pip-dJc71C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:48:29 INFO - Running setup.py (path:/tmp/pip-iFPxxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:48:29 INFO - Running setup.py (path:/tmp/pip-XXVRBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:48:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:29 INFO - Running setup.py (path:/tmp/pip-e29VpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:48:30 INFO - Running setup.py (path:/tmp/pip-ACMvCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:48:30 INFO - Running setup.py (path:/tmp/pip-75vOIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:48:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:48:30 INFO - Running setup.py install for manifestparser 08:48:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:48:30 INFO - Running setup.py install for mozcrash 08:48:30 INFO - Running setup.py install for mozdebug 08:48:30 INFO - Running setup.py install for mozdevice 08:48:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:48:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:48:30 INFO - Running setup.py install for mozfile 08:48:30 INFO - Running setup.py install for mozhttpd 08:48:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:48:30 INFO - Running setup.py install for mozinfo 08:48:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:48:30 INFO - Running setup.py install for mozInstall 08:48:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:48:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:48:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:48:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:48:30 INFO - Running setup.py install for mozleak 08:48:31 INFO - Running setup.py install for mozlog 08:48:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:48:31 INFO - Running setup.py install for moznetwork 08:48:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:48:31 INFO - Running setup.py install for mozprocess 08:48:31 INFO - Running setup.py install for mozprofile 08:48:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:48:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:48:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:48:31 INFO - Running setup.py install for mozrunner 08:48:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:48:31 INFO - Running setup.py install for mozscreenshot 08:48:31 INFO - Running setup.py install for moztest 08:48:31 INFO - Running setup.py install for mozversion 08:48:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:48:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:48:31 INFO - Cleaning up... 08:48:31 INFO - Return code: 0 08:48:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac139bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177cf60>, '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 0x177dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177e1d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1480956077.431752-1292481603', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:48:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:48:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:48:31 INFO - Using env: {'DISPLAY': ':0', 08:48:31 INFO - 'HOME': '/home/cltbld', 08:48:31 INFO - 'LANG': 'en_US.UTF-8', 08:48:31 INFO - 'LANGUAGE': 'en_US:en', 08:48:31 INFO - 'LOGNAME': 'cltbld', 08:48:31 INFO - 'MAIL': '/var/mail/cltbld', 08:48:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:31 INFO - 'MOZ_NO_REMOTE': '1', 08:48:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:31 INFO - 'NO_EM_RESTART': '1', 08:48:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:31 INFO - 'PWD': '/builds/slave/test', 08:48:31 INFO - 'SHELL': '/bin/bash', 08:48:31 INFO - 'SHLVL': '1', 08:48:31 INFO - 'TERM': 'linux', 08:48:31 INFO - 'TMOUT': '86400', 08:48:31 INFO - 'USER': 'cltbld', 08:48:31 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1480956077.431752-1292481603', 08:48:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:31 INFO - '_': '/tools/buildbot/bin/python'} 08:48:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:48:32 INFO - Running setup.py (path:/tmp/pip-IBsSEy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:48:32 INFO - Running setup.py (path:/tmp/pip-0uNvd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:48:32 INFO - Running setup.py (path:/tmp/pip-BlA9gD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:48:32 INFO - Running setup.py (path:/tmp/pip-cdbAOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:48:32 INFO - Running setup.py (path:/tmp/pip-TszijN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:48:32 INFO - Running setup.py (path:/tmp/pip-nilD8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:48:32 INFO - Running setup.py (path:/tmp/pip-9T_No9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:48:32 INFO - Running setup.py (path:/tmp/pip-8X7Mk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:48:32 INFO - Running setup.py (path:/tmp/pip-S0ZTyC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:48:32 INFO - Running setup.py (path:/tmp/pip-tRZEYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:48:32 INFO - Running setup.py (path:/tmp/pip-yy0CQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:48:32 INFO - Running setup.py (path:/tmp/pip-vrfc49-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:48:33 INFO - Running setup.py (path:/tmp/pip-Pmjaat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:48:33 INFO - Running setup.py (path:/tmp/pip-TQ_Ddp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:33 INFO - Running setup.py (path:/tmp/pip-XnQolJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:48:33 INFO - Running setup.py (path:/tmp/pip-k72gGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:48:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:48:33 INFO - Running setup.py (path:/tmp/pip-M9ETEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:48:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:35 INFO - Downloading blessings-1.6.tar.gz 08:48:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:48:35 INFO - Installing collected packages: blessings 08:48:35 INFO - Running setup.py install for blessings 08:48:35 INFO - Successfully installed blessings 08:48:35 INFO - Cleaning up... 08:48:35 INFO - Return code: 0 08:48:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:48:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:48:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:48:35 INFO - Reading from file tmpfile_stdout 08:48:35 INFO - Current package versions: 08:48:35 INFO - argparse == 1.2.1 08:48:35 INFO - blessings == 1.6 08:48:35 INFO - blobuploader == 1.2.4 08:48:35 INFO - docopt == 0.6.1 08:48:35 INFO - functools32 == 3.2.3-2 08:48:35 INFO - jsonschema == 2.5.1 08:48:35 INFO - manifestparser == 1.1 08:48:35 INFO - mozInstall == 1.12 08:48:35 INFO - mozcrash == 1.0 08:48:35 INFO - mozdebug == 0.1 08:48:35 INFO - mozdevice == 0.48 08:48:35 INFO - mozfile == 1.2 08:48:35 INFO - mozhttpd == 0.7 08:48:35 INFO - mozinfo == 0.9 08:48:35 INFO - mozleak == 0.1 08:48:35 INFO - mozlog == 3.4 08:48:35 INFO - moznetwork == 0.27 08:48:35 INFO - mozprocess == 0.23 08:48:35 INFO - mozprofile == 0.28 08:48:35 INFO - mozrunner == 6.13 08:48:35 INFO - mozscreenshot == 0.1 08:48:35 INFO - mozsystemmonitor == 0.3 08:48:35 INFO - moztest == 0.7 08:48:35 INFO - mozversion == 1.4 08:48:35 INFO - psutil == 3.1.1 08:48:35 INFO - requests == 1.2.3 08:48:35 INFO - wsgiref == 0.1.2 08:48:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac139bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177cf60>, '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 0x177dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177e1d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1480956077.431752-1292481603', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:48:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:48:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:48:35 INFO - Using env: {'DISPLAY': ':0', 08:48:35 INFO - 'HOME': '/home/cltbld', 08:48:35 INFO - 'LANG': 'en_US.UTF-8', 08:48:35 INFO - 'LANGUAGE': 'en_US:en', 08:48:35 INFO - 'LOGNAME': 'cltbld', 08:48:35 INFO - 'MAIL': '/var/mail/cltbld', 08:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:35 INFO - 'MOZ_NO_REMOTE': '1', 08:48:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:35 INFO - 'NO_EM_RESTART': '1', 08:48:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:35 INFO - 'PWD': '/builds/slave/test', 08:48:35 INFO - 'SHELL': '/bin/bash', 08:48:35 INFO - 'SHLVL': '1', 08:48:35 INFO - 'TERM': 'linux', 08:48:35 INFO - 'TMOUT': '86400', 08:48:35 INFO - 'USER': 'cltbld', 08:48:35 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1480956077.431752-1292481603', 08:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:35 INFO - '_': '/tools/buildbot/bin/python'} 08:48:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:48:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:48:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:48:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:48:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:48:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:48:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:48:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:48:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:48:36 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:48:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:48:36 INFO - Cleaning up... 08:48:36 INFO - Return code: 0 08:48:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:48:36 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 0x7f8ac139bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x177fca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177cf60>, '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 0x177dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177e1d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1480956077.431752-1292481603', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:48:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:48:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:48:36 INFO - Using env: {'DISPLAY': ':0', 08:48:36 INFO - 'HOME': '/home/cltbld', 08:48:36 INFO - 'LANG': 'en_US.UTF-8', 08:48:36 INFO - 'LANGUAGE': 'en_US:en', 08:48:36 INFO - 'LOGNAME': 'cltbld', 08:48:36 INFO - 'MAIL': '/var/mail/cltbld', 08:48:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:36 INFO - 'MOZ_NO_REMOTE': '1', 08:48:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:36 INFO - 'NO_EM_RESTART': '1', 08:48:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:36 INFO - 'PWD': '/builds/slave/test', 08:48:36 INFO - 'SHELL': '/bin/bash', 08:48:36 INFO - 'SHLVL': '1', 08:48:36 INFO - 'TERM': 'linux', 08:48:36 INFO - 'TMOUT': '86400', 08:48:36 INFO - 'USER': 'cltbld', 08:48:36 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1480956077.431752-1292481603', 08:48:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:36 INFO - '_': '/tools/buildbot/bin/python'} 08:48:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:48:36 INFO - Cleaning up... 08:48:36 INFO - Return code: 0 08:48:36 INFO - Running post-action listener: _resource_record_post_action 08:48:36 INFO - Running post-action listener: _start_resource_monitoring 08:48:36 INFO - Starting resource monitoring. 08:48:36 INFO - [mozharness: 2016-12-05 16:48:36.416640Z] Finished create-virtualenv step (success) 08:48:36 INFO - [mozharness: 2016-12-05 16:48:36.417659Z] Running install step. 08:48:36 INFO - Running pre-action listener: _resource_record_pre_action 08:48:36 INFO - Running main action method: install 08:48:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:48:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:48:36 INFO - Reading from file tmpfile_stdout 08:48:36 INFO - Detecting whether we're running mozinstall >=1.0... 08:48:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:48:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:48:36 INFO - Reading from file tmpfile_stdout 08:48:36 INFO - Output received: 08:48:36 INFO - Usage: mozinstall [options] installer 08:48:36 INFO - Options: 08:48:36 INFO - -h, --help show this help message and exit 08:48:36 INFO - -d DEST, --destination=DEST 08:48:36 INFO - Directory to install application into. [default: 08:48:36 INFO - "/builds/slave/test"] 08:48:36 INFO - --app=APP Application being installed. [default: firefox] 08:48:36 INFO - mkdir: /builds/slave/test/build/application 08:48:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:48:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:48:52 INFO - Reading from file tmpfile_stdout 08:48:52 INFO - Output received: 08:48:52 INFO - /builds/slave/test/build/application/firefox/firefox 08:48:52 INFO - Running post-action listener: _resource_record_post_action 08:48:52 INFO - [mozharness: 2016-12-05 16:48:52.778675Z] Finished install step (success) 08:48:52 INFO - [mozharness: 2016-12-05 16:48:52.778918Z] Running run-tests step. 08:48:52 INFO - Running pre-action listener: _resource_record_pre_action 08:48:52 INFO - Running main action method: run_tests 08:48:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:48:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:48:52 INFO - Python 2.7.3 08:48:52 INFO - Return code: 0 08:48:52 INFO - grabbing minidump binary from tooltool 08:48:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:52 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x177cf60>, '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 0x177dd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x177e1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:48:52 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:48:52 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:48:52 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:48:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:48:52 INFO - Return code: 0 08:48:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:48:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:48:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:48:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:48:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:48:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:48:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:48:52 INFO - Using env: {'DISPLAY': ':0', 08:48:52 INFO - 'HOME': '/home/cltbld', 08:48:52 INFO - 'LANG': 'en_US.UTF-8', 08:48:52 INFO - 'LANGUAGE': 'en_US:en', 08:48:52 INFO - 'LOGNAME': 'cltbld', 08:48:52 INFO - 'MAIL': '/var/mail/cltbld', 08:48:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:48:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:48:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:52 INFO - 'MOZ_NO_REMOTE': '1', 08:48:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:48:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:52 INFO - 'NO_EM_RESTART': '1', 08:48:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:52 INFO - 'PWD': '/builds/slave/test', 08:48:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:48:52 INFO - 'SHELL': '/bin/bash', 08:48:52 INFO - 'SHLVL': '1', 08:48:52 INFO - 'TERM': 'linux', 08:48:52 INFO - 'TMOUT': '86400', 08:48:52 INFO - 'USER': 'cltbld', 08:48:52 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1480956077.431752-1292481603', 08:48:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:52 INFO - '_': '/tools/buildbot/bin/python'} 08:48:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:48:53 INFO - mozversion application_buildid: 20161205070638 08:48:53 INFO - mozversion application_changeset: 46049b21980d67b13d6915c052a3025c273a1788 08:48:53 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:48:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:48:53 INFO - mozversion application_name: Firefox 08:48:53 INFO - mozversion application_remotingname: firefox-dev 08:48:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:48:53 INFO - mozversion application_vendor: Mozilla 08:48:53 INFO - mozversion application_version: 52.0a2 08:48:53 INFO - mozversion platform_buildid: 20161205070638 08:48:53 INFO - mozversion platform_changeset: 46049b21980d67b13d6915c052a3025c273a1788 08:48:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:48:53 INFO - mozversion platform_version: 52.0a2 08:48:53 INFO - using testdate: 1480956533 08:48:53 INFO - actual date: 1480956533 08:48:53 INFO - starting webserver on 'localhost:39149' 08:48:53 INFO - SUITE-START | Running 2 tests 08:48:53 INFO - TEST-START | dromaeo_css 08:48:53 INFO - operating with platform_type : linux_ 08:48:53 INFO - Initialising browser for dromaeo_css test... 08:48:53 INFO - TEST-INFO | started process 3309 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwyf5X5/profile http://localhost:39149/getInfo.html) 08:49:00 INFO - PROCESS | 3309 | __metrics Screen width/height:1600/1200 08:49:00 INFO - PROCESS | 3309 | colorDepth:24 08:49:00 INFO - PROCESS | 3309 | Browser inner width/height: 1024/697 08:49:00 INFO - PROCESS | 3309 | __metrics 08:49:01 INFO - PROCESS | 3309 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:49:01 INFO - PROCESS | 3309 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:49:01 INFO - PROCESS | 3309 | console.error: PushService: 08:49:01 INFO - PROCESS | 3309 | stateChangeProcessEnqueue: Error transitioning state 08:49:01 INFO - PROCESS | 3309 | UnknownError 08:49:02 INFO - TEST-INFO | 3309: exit 0 08:49:02 INFO - Browser initialized. 08:49:02 INFO - Running cycle 1/1 for dromaeo_css test... 08:49:02 INFO - TEST-INFO | started process 3402 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwyf5X5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:49:14 INFO - PROCESS | 3402 | RSS: Main: 144736256 08:49:14 INFO - PROCESS | 3402 | 08:50:05 INFO - PROCESS | 3402 | 1480956605631 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:52:15 INFO - PROCESS | 3402 | Cycle 1(1): loaded http://localhost:39149/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39149/tests/dromaeo/cssquery-ext.html) 08:52:17 INFO - PROCESS | 3402 | RSS: Main: 234287104 08:52:17 INFO - PROCESS | 3402 | 08:55:19 INFO - PROCESS | 3402 | Cycle 1(1): loaded http://localhost:39149/tests/dromaeo/cssquery-ext.html (next: http://localhost:39149/tests/dromaeo/cssquery-jquery.html) 08:55:20 INFO - PROCESS | 3402 | RSS: Main: 228175872 08:55:20 INFO - PROCESS | 3402 | 08:58:22 INFO - PROCESS | 3402 | Cycle 1(1): loaded http://localhost:39149/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39149/tests/dromaeo/cssquery-mootools.html) 08:58:22 INFO - PROCESS | 3402 | RSS: Main: 207929344 08:58:22 INFO - PROCESS | 3402 | 09:01:24 INFO - PROCESS | 3402 | Cycle 1(1): loaded http://localhost:39149/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39149/tests/dromaeo/cssquery-prototype.html) 09:01:25 INFO - PROCESS | 3402 | RSS: Main: 222265344 09:01:25 INFO - PROCESS | 3402 | 09:04:28 INFO - PROCESS | 3402 | Cycle 1(1): loaded http://localhost:39149/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39149/tests/dromaeo/cssquery-yui.html) 09:04:28 INFO - PROCESS | 3402 | RSS: Main: 173215744 09:04:28 INFO - PROCESS | 3402 | 09:07:31 INFO - PROCESS | 3402 | Cycle 1(1): loaded http://localhost:39149/tests/dromaeo/cssquery-yui.html (next: http://localhost:39149/tests/dromaeo/cssquery-dojo.html) 09:07:31 INFO - PROCESS | 3402 | RSS: Main: 269049856 09:07:31 INFO - PROCESS | 3402 | 09:07:31 INFO - PROCESS | 3402 | __start_tp_report 09:07:31 INFO - PROCESS | 3402 | _x_x_mozilla_page_load 09:07:31 INFO - PROCESS | 3402 | _x_x_mozilla_page_load_details 09:07:31 INFO - PROCESS | 3402 | |i|pagename|runs| 09:07:31 INFO - PROCESS | 3402 | |0;dojo.html;3173;3177.1262902701756;3192.297694507208;3197.960662784593;3214.260720034392;5501.779928802848;5590.496855283029;5654.293213348332;5661.66030038198;5681.573881958849;5589.636673616223;5656.717164141787;5665.886682266352;5666.178404131399;5680.488756011958;5082.84751457456;5137.717425541594;5173.042987047408;5198.350206224222;5215.087359712054;4946.579540739023;4966.627502937276;5200.6099542534275;5214.217867319913;5229.294045303893;5023.14606516893;5100.821471248507;5114.360704911886;5129.974350128244;5162.664426812245;5101.260317253996;5122.743862806882;5149.2791009258735;5178.611604129667;5203.869903252411;5055.772490237948;5148.742562871841;5177.326947496801;5177.37871455424;5204.245384419276;5376.1398176292;5406.810761623364;5531.640443371168;5589.832305030855;5603.271574695264;6028.819135425944;6053.485453736438;6063.848403789896;6063.969125248718;6080.574359794816;6079.361667024988;6092.451679348836;6094.055421409688;6104.206453161105;6107.633541987495;5532.944670553243;5536.086545719952;5547.944520554743;5581.581381396411;5691.971540142315;6173.135760993465;6177.567570270128;6177.938220617826;6187.752489900444;6191.504679625619;5887;5910;5928.614640048383;5966.105084237312;5993.940060599425;5777.62445441045;5858.47273745365;5959.046552551571;5997.970010149921;6000.459958603659;5959.374265702126;5983.581149319506;6011.218541589653;6100.420460056288;6102.572819902564;6033.064874944391;6045.516358691294;6050.334463209044;6051.515878729691;6055.485283750931;4552.476465206543;4637.3275874997935;4697.976510117496;4707.670463067621;4723.858284251478;4017.1764788218347;4059.3505039193587;4096.508418989741;4097.13960068383;4126.525449573338;5710.2862142232225;5744.396838331915;5745.540356771448;5754.251947246831;5760.683162426023;6027.246594175728;6031.577789554689;6045.455908968214;6053.727582258721;6059;5577.888442231133;5641.464060914206;5699.230603868425;5734.942650573525;5771.278590176228;5214.45248248936;5217.243499692523;5219.5041471060185;5225.608079394061;5247.10799164143;6202.317745048132;6246.750129994749;6259.155014073133;6264.906026409608;6267.717952692049;5917.585768996301;5982.192404025401;6013.699315034319;6019.217501724747;6113.449789518964;6197.411245931629;6213.285472170577;6243.7814676486105;6254.124422580751;6254.562180647311;5999.880002400015;6007.669578173242;6015.578909476295;6016.578929036926;6051.485623721856;5844.211031510862;5845.678487683218;5962.165296858357;6101.60339577926;6128.203333566607;5904.202932604044;5966.224390829165;5970.432808883149;5989.490893274121;5996.5502587305255;5932.228810254639;5935.2877654681715;5941.1385349125;5941.7623295067715;5948.851278718067;5617.522510586482;5719.828405147852;5856.12158176277;5874.500667443315;5876.265466816648;5856.12158176277;5883.794067207627;5904.586678932434;5947.405259474018;5951.880962380642;5782.913256301074;5783.306003279633;5790.160426738184;5795.507381872588;5833.67914764692 09:07:31 INFO - PROCESS | 3402 | |1;ext.html;586.4663156527561;621.0621960839132;644.0950464597242;662.7481557008339;671.2984930747368;33912.15219619511;44250.77874610626;45238;45568.54431455684;45628.315575266395;45854.77072614641;45992.540074599325;46275.76862115685;46452.07095858081;46477.7676111619;8306.501609903395;8637.352198585084;8790.34072444566;8801.943766748;8815.338849586275;8267.917320826806;10404.583816647326;10646.307989980627;10659.573617055308;10963.068139208177;10730.980556847087;10789.19081068919;10797.190210734227;10800.027997480225;10801.459927003658;10632.46837658114;10686.251962362638;10707.625233116882;10710.785784284348;10720.785584288271;10550.577976880915;10613.46932653372;10631.574737010511;10633.893661063445;10633.946830265877;42487.57512424867;42640.57359426397;42896.14207715859;42926.35610465846;42990.57009429897;3548.4677298405186;3610.729195310336;3669.3578623741005;3681.834317455721;3713.3130370881204;31931.52102718461;32150;32200.67799322;32297.51553726696;32465.188370290696;4351.456067991501;4377.430933978594;4432.711873728197;4472.172648060119;4571.977140114312;366885;367008;368979;369010;370160;37323.81338093346;59348.703256483444;59789.40210597925;59811.700941495015;59893;38559;40774.184516309506;40848;40967.38548921768;41027;17018.404355847735;17176.141192940304;17192.570185745208;17194.1402929853;17220.569485762706;11998.100142489347;12095.879041209651;13990.0906441081;14466.493672721404;14574.125552466887;9307.488088155216;9471.857922131174;9487.667931622498;9540.3321767477;9544.570494327772;3593.3352329819068;3608.0979755061235;3628.9496434514413;3646.1431563582537;3659.7438179327723;989.3964681544252;1006.1347241372414;1009.6769033909079;1071.8177909755361;1084.9945750271197;32950.34099318048;32965;33217.3356532868;33310.167245818564;33560.49659255113;1053.694428615693;1120.7366268926796;1168.3865970365625;1179.1392283632997;1220.8840160184768;15998.360065597246;17884;18007.459776206735;18372;18571.907140464213;517340;521315;521854;522303;524515;61182;61942.38057619456;61945.69027154835;61967;62035.6898215506;1268.7272236469203;1295.1257900916844;1362.8841548468292;1395;1449.6230979945078;31761.523577146825;35172.82413588018;35173.29653406969;35214.823925880206;35232.82383588168;51940.22089668734;52561.474385257185;52795.736021319644;52820;52898.73550632222;360735;363756;364216;364791;366759;29626.259343516584;30579.541306879968;30877.0736877894;32265;32273.838630806695;49983.50016499789;50004;50577.24134138064;50593;50763.492365077356;41312;41540;41792.582074180085;41855;43423.34864976965;42790;42803.357949631405;42997.35503967381;43786.34320485131;43903.78048109739;42908.78545607377;43458;44112.338314925946;44139.337909930735;44292.7785361084;34900.301993960486;37050;37446;37724.81137594295;38274.425883612326;28546.78955790081;29046.564301535072;29170.416591668472;29215.85392073026;29281 09:07:31 INFO - PROCESS | 3402 | |2;jquery.html;396.72824115480915;427.65146405679377;431.7431128478555;434.2149799332722;443.07618615187334;15866.286017129229;19310.227590896364;20255.797442025574;20898.686519702216;21024.053917573707;19095.236190552398;19421.805781942177;20148.194072237093;20279.087441065152;20565.897170514127;5830.912536311958;6052.425019623151;6053.697315134225;6064.636121832682;6064.818055458343;5646.971765141189;5928.318243402021;5971.283445986488;5975.52195824333;5976.5517586180995;5675.3757086720425;5937.050071988483;5938.910916336258;5942.108683697436;5943.791967281146;5861.062230043194;5888.617239879415;5933.970330148365;5936.940630593682;5939.287285525765;5137.871553211162;5381;5385.111456609655;5387.24578559002;5400.21696853954;14544.2000689962;14767.704645907022;14814.851851481455;15908.602284942854;23518.412039698975;2365.1721897335965;2414.8913298901593;2417.468157005456;2920.9123726288244;2998.025641666445;10638.308509946828;10760.300580462323;10768.24622276441;11052.557897684082;11254.54981800727;1828.6434145341664;1855.8236967488067;1944.2417457191707;1947.6396866579728;1958.7355706979517;74482;85932;85975.57012214899;87077;87869;10505.474726263808;11204.15968802343;11594.362310073027;11633.76732465346;11792.823107653221;15425.305861236271;16032.75950860738;16049.358025679076;16057.19714014318;16066.598335041484;8186.386021048445;8887.289016878634;8963.966215203185;9031.954840225888;9193.356465047382;8639.006514250816;8715;8744.68829675541;8941.105889411137;8963.014068452465;4904;5089.541941225308;5125.56432703217;5141.2288156776785;5150.4334523202415;1940.7185958036005;1979.6931475621302;2046.4167712201952;2050.5796311756053;2092.591944570794;920.7559996600907;985.8225519406576;1003.7540802503287;1036.3678156324636;1046.8063408269495;19966.836467934634;20686.275980340615;20817.68773468399;20897;21265.78734212638;970.2189737261431;982.6904525074722;1077.8167711489066;1089.3953855610055;1092.9945350273197;10629.681109566725;11439.714007149722;11537.48081336342;11564.537418503165;11579.189456738117;482974;493279;501251;501591;536491;90860.5456972711;92499.53750231206;100251;106511;106613;1057.7038429239826;1081.4808891732014;1094.9288296260718;1106.4965440724452;1106.9667909962714;17753.467395978143;18382.1728022242;18737.250509979993;18807.529811754815;19081;45245;45715.54284457246;46308.7684561575;46533.3020004707;47028;58936.70531647314;59337;59702.958022365274;60086.69956650189;60399.396006041134;7862.056642544484;7977.521348719096;9305.488198148896;9420.434773913586;9435.29235307341;10279.383237005804;13629.522966696119;13886.583402497941;14000.579982600539;14135.929320353744;6058.939410605837;7253.746118885813;12423.44094515767;12479;12782.36088195568;11716.297022178696;12235.510579576718;12240.816387754012;12399.566015189424;12806.487740490276;11818.349990750592;12740.362981850685;12809.871901280869;12837.908777753995;13118.278494682503;9120.863187052331;9191.816163676824;9247.815043698954;9615.471149086588;9618.759531011501;11549.076073913899;11908.821367679666;12115.333656648969;12429.689257768629;12459.750804983669 09:07:31 INFO - PROCESS | 3402 | |3;mootools.html;1378.441731098904;1538.73841446954;1544.227886056971;1733.0987886299124;1844.206990993873;7662.808429789251;8332.45839020464;8675;8678.218960293572;8879.60041798119;8678.652853885837;8753.824923501526;8754.781130471742;8763.956180219106;8764.474131552111;2457.0908763757434;2484.1057219401;2487.6641653376832;2487.7387874273213;2489.5269898719275;2406.6630671705975;2478.2689106713565;2488.962665560018;2490.1533478617266;2492.5513407586627;2323.256557901472;2335.4278201840575;2417.697787776528;2422.34596658902;2423.6001059825107;2254.9210777622707;2272.670462782887;2298.1496846166942;2307.90768369265;2319.698439202901;2346.2257455039967;2354.587947109249;2365.0657990093987;2367.3134790910617;2367.3726462487452;7589.241075892422;8312.459690120122;8376.581170941428;8422.78943026423;8425.031121420992;4656.511066338019;5175.896482070375;5416.512513873731;5418.106012507931;5423.376311724123;3280.425925463034;3324.501324801275;3372.2749608833974;3382.9830850845833;3509.842057107436;1109.1404161774608;1118.9440527973568;1128.5880653561474;1130.9434528273637;1146.0716819376332;11863;11885.049196064294;11928.165028448013;11945.820812687816;11949.522019119311;4537.865533616596;4572.634189264851;4716.693414928087;4728.834490792806;4728.905421891612;9757.512124393752;9765.316427850124;9767.072128147956;9772.804543909082;9781.315307928377;5287.814926477555;5323.866903327448;5328.760205790749;5332.360116786011;5335.226392173113;4208.494980602347;4369;4389.034412429261;4391.780410979438;4923.803047878117;4049.817758200888;4112.261302591871;4161.001359673717;4172.123853990635;4211.789410529461;1294.0430422892593;1325.973480530384;1333.0076421118617;1338.3107699534748;1347.818044563991;869.1916517638531;952.7999120184838;996.267743208741;1033.7570670892485;1034.6430481483876;5982.5948183427845;6101.176341193971;6130.816075517741;6159.6612186329285;6267.623942563369;484.5542101266843;489.9779509922062;494.3227777944239;511.9897602047938;514.2928473349145;4179;4199.622034016892;4323.827046918151;4349.739015659071;4386.122775444924;10417.635382761568;10733.034026937614;10737.463126843626;10752.139828813833;10787;10923.453827308762;11032;11064.225504214788;11067.557297708163;11094.167937404565;7884.250996155356;8181.100078991306;8429.4942303462;8444.704435344733;8449;6033.487153591994;6123.2958209804665;6203.2556093269095;6210.254769427697;6296.212973378328;9927.751806204613;10140.290179687647;10170.982901709769;10186;10219.284650074424;8817.294616430541;10013.098821106136;10150.340227885164;10182.287239893136;10189.694309170736;7817.101033381234;7906.367490600623;7983.361331093614;7987.600619969095;7988.760337189894;8349.248567628943;8362.038365588036;8409.747707568782;8414.368922330972;8416.873746893923;7480.513766605153;7598.924010760043;7630.236976302325;7649.655765490677;7749.961250193938;7138.928610713826;7497.812554686177;7543.3965282778345;7552.66013029404;7766.029246344207;6820.317968203339;6934.4452443805385;6934.757283495053;6936.479764017819;6940.444764418733;5295.867603309948;5380.166074258496;5397.9730101350815;5403.567714582902;5618.4662457066515;5283.709395983258;5287.4976877196605;5319.893602128013;5367.194920761917;5454.727263636882 09:07:31 INFO - PROCESS | 3402 | |4;prototype.html;351.15371953591847;356.3727839003354;362.746077745578;365.72205124105704;367.606660872866;5297.443768404315;5336.946630533694;5340.25236466894;5343.851072019515;5358;4963.826266080688;5063.9493605063935;5105.795768169278;5128.461511541291;5255.632105752599;4141.792910354486;4159.23054234966;4171.478565179353;4192.979035104828;4194.119234960662;4190.601892820192;4198.286291330466;4199.139176468817;4223.809928553207;4244.469441319835;3975.9602403976023;3993.7818965215597;4039.333509970851;4158.251514727348;4177.268977928866;4147.979260103711;4149.298787497111;4155.646770024551;4159.604837540429;4205.7897105144775;3731.7760934343755;3738.214974855284;3749.850005999757;3754.2116155607355;3755.117547376364;5042.697438153723;5051.545360917535;5056.823011194628;5076.974615126901;5138.3577052868395;4720;4731.187090589575;4737.59730422911;4741.57325840676;4759.262314341283;5433.755481003364;5435.347758268994;5445.727713614304;5457.454254574551;5460.6177567570285;4001.3197756381487;4080.510338759338;4109.2808758467145;4124.092699606082;4127.2570937231285;5552.750126244288;5613.736909195439;5616.9157462638095;5631.493165615073;5631.915521267184;4203.4115223868685;4204.936925946114;4217.198732240864;4235.9364609530885;4239.491261048694;4130.814113364846;4183.995840998138;4228.344606585984;4296.484421869396;4299.269124248885;4709.693869898446;4730.172219861579;4732.313814496879;4751.691140075884;4762.857114286577;5443.836684899459;5452.291202143775;5452.59105567084;5471.50756431923;5513.09034009384;1365.8360996680262;1388.2572823539358;1404.8524904885044;1421.8791402730676;1423.9644008899654;936.6253498600614;949.8670186173941;982.268210183418;1004.9899501005043;1006.7382480555109;5111.795528178831;5134.435212126663;5142;5146.974265128651;5190.169572868398;5386.434424385461;5405.324334458192;5408.675479471244;5410.513053825096;5439.592030597721;5099.490050994871;5133.948660513422;5366.382865970463;5391.406945236021;5422.755975981011;2877.316769689755;2885.6825749167574;2890.1762997545597;2910.6070680457865;2916.4458752836895;5558.694271815089;5560.638558493766;5575.818136397702;5591.217229587861;5612.887742245214;5740.196372507852;5742.224799652077;5750.482456578844;5751.712414379264;5774.913376299359;5746.741396637161;5759.164921086419;5778.306603207642;5808.634970781863;5855.209546711139;5581.302337207849;5613.326400831927;5649.36751863468;5663.631863928831;5712.971435142797;5623.381428042994;5633.267675202197;5636.633618814764;5653.830385088454;5654.6889921054735;5658.971705141448;5805.970970145122;5845.444682755132;5859.472647461749;5869.73586188614;4118.464599602033;4134;4164.541900391016;4167.4790651168605;4170.812313445963;5647.774089036392;5682.943170568242;5709.800941802268;5715.171300161536;5738.99567575681;5444.6188766785945;5558.360788509373;5598.916016259841;5632.211490391266;5644.153376993484;5493.423190564933;5520.861978450571;5538.335399752055;5547.972260138674;5556.499915007668;5263.263143159884;5402.108652072364;5467.699276539828;5483.122700367922;5506.559475241891;5412.83761487156;5510.421405752339;5546.72266386671;5578.748956296895;5584.352615978378;5365;5414.3232095988005;5447;5453.072977593739;5480.931218412371 09:07:31 INFO - PROCESS | 3402 | |5;yui.html;728.4063488257074;740.5593671765301;763.1567118334241;784.3019712455913;837.7151768398743;14668.266586670663;15230.543083707478;15302.464413745522;15359.232038398091;15366.769498457517;14697.118172909606;14770.335334909929;14780.852191478081;14784.112953222788;14867.776983345258;712.7683502861565;736.9078865141857;858.3862538285125;870.0472982084607;871.9258862996653;842.2882664148784;874.4272501511489;883.7437143228489;885.2033170146855;885.313881741649;911.8723378726984;913.456493386434;914.3096961793836;914.4787471141452;914.4833169259347;723.706898706025;755.7543798265585;898.9550522473883;901.175424486594;901.4816480523725;640.0591131037368;659.5086660437956;663.6681659170415;664.0935123556359;664.2560332427712;14609.488667896572;14716.33776480061;14773.482928097572;14779.926100369537;14795;12801.679958001032;12921.483140674361;13105;13125.474981000749;13181.868181318256;12692.682682932907;12711.427985740664;12940.288284144368;13061.281629510373;13181.802272965913;4164.83340666373;4166.7708276044805;4182.2890108681295;4200.3699445083175;4283.20760659279;61843;62848.68575657138;62934;63071.684641576954;63613.36386636121;10627.14982801374;10746.78506429867;10812;10872.45637718111;11293.491792869341;20182.293619723532;20307;20310.39068827908;20396.79603203949;20580.38258852207;7580.469367144357;7655.961720191363;7777.5722335270975;7838.255365740246;7918.366530677532;4505.189065968158;4535.614472769786;4559.316102584638;4618.261078227468;4624.768761561909;3392.2876195999115;3473.0622731862254;3496.7727097738566;3496.8426420811124;3504.8948531544092;596.3797650443577;610.5024405109822;618.2735286038886;624.1760875644197;632.3992207402986;540.4730387871872;585.1836687820552;688.8564982129641;719.3166491832675;727.1782885339533;8616.353773467015;8909.866352004725;9163;9182.403143795633;9237.214836738953;695.982600434983;700.3556727810427;706.6819931031057;708.8759467093341;716.6022857314136;4473.955260447419;4491.405551029403;4525.094981003813;4554.225781617133;4555.202839503074;85811.57094214488;88584.5570772142;90494;92954;93075.53462232645;46449;70856.291437086;73425;75714;76980;70561.29438705547;71684.64157679178;73348.63325683444;73753.63123184457;75869.62065189639;8080;8131.878021829795;8210.630521626661;8474.406791524534;8481.109483504144;48770;48813.51186488232;49306;49340.75329623329;49447.25829112494;60818.69590652018;63400;67156;68574.3142568568;70603.64698176681;11407.144464165054;11711.355875426932;11776.352300623548;11850.288982661068;11963;12563.05777066742;12570.182938108994;12649.367531623198;12694.428750706425;12739.235645861278;12049.397530123633;12054.99680715209;12188.146829722189;12635.93682031584;12800.74398512043;11915.40422978865;11969.461374238006;12080;12274;12316.014718822293;11973.102017348909;12066.517339306329;12177.573784917486;12275.877241227474;12303;10055.346402483816;10120.746981325232;10341.534630941776;10424.739381515523;10485.475726213812;9968.800623987625;10316.484175791331;10373.688789336333;10401.58393664245;10532.36805791655 09:07:31 INFO - PROCESS | 3402 | __end_tp_report 09:07:31 INFO - PROCESS | 3402 | __start_cc_report 09:07:31 INFO - PROCESS | 3402 | _x_x_mozilla_cycle_collect,1354 09:07:31 INFO - PROCESS | 3402 | __end_cc_report 09:07:31 INFO - PROCESS | 3402 | __startTimestamp1480957651520__endTimestamp 09:07:31 INFO - PROCESS | 3402 | 09:07:31 INFO - PROCESS | 3402 | ------- Summary: start ------- 09:07:31 INFO - PROCESS | 3402 | Number of tests: 6 09:07:31 INFO - PROCESS | 3402 | 09:07:31 INFO - PROCESS | 3402 | [#0] dojo.html Cycles:165 Average:5600.51 Median:5833.68 stddev:645.46 (11.1%) stddev-sans-first:618.71 09:07:31 INFO - PROCESS | 3402 | Values: 3173.0 3177.1 3192.3 3198.0 3214.3 5501.8 5590.5 5654.3 5661.7 5681.6 5589.6 5656.7 5665.9 5666.2 5680.5 5082.8 5137.7 5173.0 5198.4 5215.1 4946.6 4966.6 5200.6 5214.2 5229.3 5023.1 5100.8 5114.4 5130.0 5162.7 5101.3 5122.7 5149.3 5178.6 5203.9 5055.8 5148.7 5177.3 5177.4 5204.2 5376.1 5406.8 5531.6 5589.8 5603.3 6028.8 6053.5 6063.8 6064.0 6080.6 6079.4 6092.5 6094.1 6104.2 6107.6 5532.9 5536.1 5547.9 5581.6 5692.0 6173.1 6177.6 6177.9 6187.8 6191.5 5887.0 5910.0 5928.6 5966.1 5993.9 5777.6 5858.5 5959.0 5998.0 6000.5 5959.4 5983.6 6011.2 6100.4 6102.6 6033.1 6045.5 6050.3 6051.5 6055.5 4552.5 4637.3 4698.0 4707.7 4723.9 4017.2 4059.4 4096.5 4097.1 4126.5 5710.3 5744.4 5745.5 5754.3 5760.7 6027.2 6031.6 6045.5 6053.7 6059.0 5577.9 5641.5 5699.2 5734.9 5771.3 5214.5 5217.2 5219.5 5225.6 5247.1 6202.3 6246.8 6259.2 6264.9 6267.7 5917.6 5982.2 6013.7 6019.2 6113.4 6197.4 6213.3 6243.8 6254.1 6254.6 5999.9 6007.7 6015.6 6016.6 6051.5 5844.2 5845.7 5962.2 6101.6 6128.2 5904.2 5966.2 5970.4 5989.5 5996.6 5932.2 5935.3 5941.1 5941.8 5948.9 5617.5 5719.8 5856.1 5874.5 5876.3 5856.1 5883.8 5904.6 5947.4 5951.9 5782.9 5783.3 5790.2 5795.5 5833.7 09:07:31 INFO - PROCESS | 3402 | 09:07:31 INFO - PROCESS | 3402 | [#1] ext.html Cycles:180 Average:58254.66 Median:186330.42 stddev:112274.47 (60.3%) stddev-sans-first:112505.94 09:07:31 INFO - PROCESS | 3402 | Values: 586.5 621.1 644.1 662.7 671.3 33912.2 44250.8 45238.0 45568.5 45628.3 45854.8 45992.5 46275.8 46452.1 46477.8 8306.5 8637.4 8790.3 8801.9 8815.3 8267.9 10404.6 10646.3 10659.6 10963.1 10731.0 10789.2 10797.2 10800.0 10801.5 10632.5 10686.3 10707.6 10710.8 10720.8 10550.6 10613.5 10631.6 10633.9 10633.9 42487.6 42640.6 42896.1 42926.4 42990.6 3548.5 3610.7 3669.4 3681.8 3713.3 31931.5 32150.0 32200.7 32297.5 32465.2 4351.5 4377.4 4432.7 4472.2 4572.0 366885.0 367008.0 368979.0 369010.0 370160.0 37323.8 59348.7 59789.4 59811.7 59893.0 38559.0 40774.2 40848.0 40967.4 41027.0 17018.4 17176.1 17192.6 17194.1 17220.6 11998.1 12095.9 13990.1 14466.5 14574.1 9307.5 9471.9 9487.7 9540.3 9544.6 3593.3 3608.1 3628.9 3646.1 3659.7 989.4 1006.1 1009.7 1071.8 1085.0 32950.3 32965.0 33217.3 33310.2 33560.5 1053.7 1120.7 1168.4 1179.1 1220.9 15998.4 17884.0 18007.5 18372.0 18571.9 517340.0 521315.0 521854.0 522303.0 524515.0 61182.0 61942.4 61945.7 61967.0 62035.7 1268.7 1295.1 1362.9 1395.0 1449.6 31761.5 35172.8 35173.3 35214.8 35232.8 51940.2 52561.5 52795.7 52820.0 52898.7 360735.0 363756.0 364216.0 364791.0 366759.0 29626.3 30579.5 30877.1 32265.0 32273.8 49983.5 50004.0 50577.2 50593.0 50763.5 41312.0 41540.0 41792.6 41855.0 43423.3 42790.0 42803.4 42997.4 43786.3 43903.8 42908.8 43458.0 44112.3 44139.3 44292.8 34900.3 37050.0 37446.0 37724.8 38274.4 28546.8 29046.6 29170.4 29215.9 29281.0 09:07:31 INFO - PROCESS | 3402 | 09:07:31 INFO - PROCESS | 3402 | [#2] jquery.html Cycles:180 Average:29943.01 Median:22392.10 stddev:83174.67 (371.4%) stddev-sans-first:83378.41 09:07:31 INFO - PROCESS | 3402 | Values: 396.7 427.7 431.7 434.2 443.1 15866.3 19310.2 20255.8 20898.7 21024.1 19095.2 19421.8 20148.2 20279.1 20565.9 5830.9 6052.4 6053.7 6064.6 6064.8 5647.0 5928.3 5971.3 5975.5 5976.6 5675.4 5937.1 5938.9 5942.1 5943.8 5861.1 5888.6 5934.0 5936.9 5939.3 5137.9 5381.0 5385.1 5387.2 5400.2 14544.2 14767.7 14814.9 15908.6 23518.4 2365.2 2414.9 2417.5 2920.9 2998.0 10638.3 10760.3 10768.2 11052.6 11254.5 1828.6 1855.8 1944.2 1947.6 1958.7 74482.0 85932.0 85975.6 87077.0 87869.0 10505.5 11204.2 11594.4 11633.8 11792.8 15425.3 16032.8 16049.4 16057.2 16066.6 8186.4 8887.3 8964.0 9032.0 9193.4 8639.0 8715.0 8744.7 8941.1 8963.0 4904.0 5089.5 5125.6 5141.2 5150.4 1940.7 1979.7 2046.4 2050.6 2092.6 920.8 985.8 1003.8 1036.4 1046.8 19966.8 20686.3 20817.7 20897.0 21265.8 970.2 982.7 1077.8 1089.4 1093.0 10629.7 11439.7 11537.5 11564.5 11579.2 482974.0 493279.0 501251.0 501591.0 536491.0 90860.5 92499.5 100251.0 106511.0 106613.0 1057.7 1081.5 1094.9 1106.5 1107.0 17753.5 18382.2 18737.3 18807.5 19081.0 45245.0 45715.5 46308.8 46533.3 47028.0 58936.7 59337.0 59703.0 60086.7 60399.4 7862.1 7977.5 9305.5 9420.4 9435.3 10279.4 13629.5 13886.6 14000.6 14135.9 6058.9 7253.7 12423.4 12479.0 12782.4 11716.3 12235.5 12240.8 12399.6 12806.5 11818.3 12740.4 12809.9 12837.9 13118.3 9120.9 9191.8 9247.8 9615.5 9618.8 11549.1 11908.8 12115.3 12429.7 12459.8 09:07:31 INFO - PROCESS | 3402 | 09:07:31 INFO - PROCESS | 3402 | [#3] mootools.html Cycles:180 Average:5764.00 Median:487.27 stddev:3218.84 (660.6%) stddev-sans-first:3210.99 09:07:31 INFO - PROCESS | 3402 | Values: 1378.4 1538.7 1544.2 1733.1 1844.2 7662.8 8332.5 8675.0 8678.2 8879.6 8678.7 8753.8 8754.8 8764.0 8764.5 2457.1 2484.1 2487.7 2487.7 2489.5 2406.7 2478.3 2489.0 2490.2 2492.6 2323.3 2335.4 2417.7 2422.3 2423.6 2254.9 2272.7 2298.1 2307.9 2319.7 2346.2 2354.6 2365.1 2367.3 2367.4 7589.2 8312.5 8376.6 8422.8 8425.0 4656.5 5175.9 5416.5 5418.1 5423.4 3280.4 3324.5 3372.3 3383.0 3509.8 1109.1 1118.9 1128.6 1130.9 1146.1 11863.0 11885.0 11928.2 11945.8 11949.5 4537.9 4572.6 4716.7 4728.8 4728.9 9757.5 9765.3 9767.1 9772.8 9781.3 5287.8 5323.9 5328.8 5332.4 5335.2 4208.5 4369.0 4389.0 4391.8 4923.8 4049.8 4112.3 4161.0 4172.1 4211.8 1294.0 1326.0 1333.0 1338.3 1347.8 869.2 952.8 996.3 1033.8 1034.6 5982.6 6101.2 6130.8 6159.7 6267.6 484.6 490.0 494.3 512.0 514.3 4179.0 4199.6 4323.8 4349.7 4386.1 10417.6 10733.0 10737.5 10752.1 10787.0 10923.5 11032.0 11064.2 11067.6 11094.2 7884.3 8181.1 8429.5 8444.7 8449.0 6033.5 6123.3 6203.3 6210.3 6296.2 9927.8 10140.3 10171.0 10186.0 10219.3 8817.3 10013.1 10150.3 10182.3 10189.7 7817.1 7906.4 7983.4 7987.6 7988.8 8349.2 8362.0 8409.7 8414.4 8416.9 7480.5 7598.9 7630.2 7649.7 7750.0 7138.9 7497.8 7543.4 7552.7 7766.0 6820.3 6934.4 6934.8 6936.5 6940.4 5295.9 5380.2 5398.0 5403.6 5618.5 5283.7 5287.5 5319.9 5367.2 5454.7 09:07:31 INFO - PROCESS | 3402 | 09:07:31 INFO - PROCESS | 3402 | [#4] prototype.html Cycles:180 Average:4650.94 Median:5317.20 stddev:1337.72 (25.2%) stddev-sans-first:1301.96 09:07:31 INFO - PROCESS | 3402 | Values: 351.2 356.4 362.7 365.7 367.6 5297.4 5336.9 5340.3 5343.9 5358.0 4963.8 5063.9 5105.8 5128.5 5255.6 4141.8 4159.2 4171.5 4193.0 4194.1 4190.6 4198.3 4199.1 4223.8 4244.5 3976.0 3993.8 4039.3 4158.3 4177.3 4148.0 4149.3 4155.6 4159.6 4205.8 3731.8 3738.2 3749.9 3754.2 3755.1 5042.7 5051.5 5056.8 5077.0 5138.4 4720.0 4731.2 4737.6 4741.6 4759.3 5433.8 5435.3 5445.7 5457.5 5460.6 4001.3 4080.5 4109.3 4124.1 4127.3 5552.8 5613.7 5616.9 5631.5 5631.9 4203.4 4204.9 4217.2 4235.9 4239.5 4130.8 4184.0 4228.3 4296.5 4299.3 4709.7 4730.2 4732.3 4751.7 4762.9 5443.8 5452.3 5452.6 5471.5 5513.1 1365.8 1388.3 1404.9 1421.9 1424.0 936.6 949.9 982.3 1005.0 1006.7 5111.8 5134.4 5142.0 5147.0 5190.2 5386.4 5405.3 5408.7 5410.5 5439.6 5099.5 5133.9 5366.4 5391.4 5422.8 2877.3 2885.7 2890.2 2910.6 2916.4 5558.7 5560.6 5575.8 5591.2 5612.9 5740.2 5742.2 5750.5 5751.7 5774.9 5746.7 5759.2 5778.3 5808.6 5855.2 5581.3 5613.3 5649.4 5663.6 5713.0 5623.4 5633.3 5636.6 5653.8 5654.7 5659.0 5806.0 5845.4 5859.5 5869.7 4118.5 4134.0 4164.5 4167.5 4170.8 5647.8 5682.9 5709.8 5715.2 5739.0 5444.6 5558.4 5598.9 5632.2 5644.2 5493.4 5520.9 5538.3 5548.0 5556.5 5263.3 5402.1 5467.7 5483.1 5506.6 5412.8 5510.4 5546.7 5578.7 5584.4 5365.0 5414.3 5447.0 5453.1 5480.9 09:07:31 INFO - PROCESS | 3402 | 09:07:31 INFO - PROCESS | 3402 | [#5] yui.html Cycles:180 Average:17837.39 Median:48791.76 stddev:23870.73 (48.9%) stddev-sans-first:23903.13 09:07:31 INFO - PROCESS | 3402 | Values: 728.4 740.6 763.2 784.3 837.7 14668.3 15230.5 15302.5 15359.2 15366.8 14697.1 14770.3 14780.9 14784.1 14867.8 712.8 736.9 858.4 870.0 871.9 842.3 874.4 883.7 885.2 885.3 911.9 913.5 914.3 914.5 914.5 723.7 755.8 899.0 901.2 901.5 640.1 659.5 663.7 664.1 664.3 14609.5 14716.3 14773.5 14779.9 14795.0 12801.7 12921.5 13105.0 13125.5 13181.9 12692.7 12711.4 12940.3 13061.3 13181.8 4164.8 4166.8 4182.3 4200.4 4283.2 61843.0 62848.7 62934.0 63071.7 63613.4 10627.1 10746.8 10812.0 10872.5 11293.5 20182.3 20307.0 20310.4 20396.8 20580.4 7580.5 7656.0 7777.6 7838.3 7918.4 4505.2 4535.6 4559.3 4618.3 4624.8 3392.3 3473.1 3496.8 3496.8 3504.9 596.4 610.5 618.3 624.2 632.4 540.5 585.2 688.9 719.3 727.2 8616.4 8909.9 9163.0 9182.4 9237.2 696.0 700.4 706.7 708.9 716.6 4474.0 4491.4 4525.1 4554.2 4555.2 85811.6 88584.6 90494.0 92954.0 93075.5 46449.0 70856.3 73425.0 75714.0 76980.0 70561.3 71684.6 73348.6 73753.6 75869.6 8080.0 8131.9 8210.6 8474.4 8481.1 48770.0 48813.5 49306.0 49340.8 49447.3 60818.7 63400.0 67156.0 68574.3 70603.6 11407.1 11711.4 11776.4 11850.3 11963.0 12563.1 12570.2 12649.4 12694.4 12739.2 12049.4 12055.0 12188.1 12635.9 12800.7 11915.4 11969.5 12080.0 12274.0 12316.0 11973.1 12066.5 12177.6 12275.9 12303.0 10055.3 10120.7 10341.5 10424.7 10485.5 9968.8 10316.5 10373.7 10401.6 10532.4 09:07:31 INFO - PROCESS | 3402 | -------- Summary: end -------- 09:07:31 INFO - PROCESS | 3402 | 09:07:32 INFO - TEST-INFO | 3402: exit 0 09:07:32 INFO - TEST-OK | dromaeo_css | took 1119195ms 09:07:32 INFO - TEST-START | kraken 09:07:32 INFO - operating with platform_type : linux_ 09:07:32 INFO - Initialising browser for kraken test... 09:07:32 INFO - TEST-INFO | started process 3724 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_wEF5X/profile http://localhost:39149/getInfo.html) 09:07:36 INFO - PROCESS | 3724 | __metrics Screen width/height:1600/1200 09:07:36 INFO - PROCESS | 3724 | colorDepth:24 09:07:36 INFO - PROCESS | 3724 | Browser inner width/height: 1024/697 09:07:36 INFO - PROCESS | 3724 | __metrics 09:07:37 INFO - PROCESS | 3724 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:07:37 INFO - PROCESS | 3724 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:07:37 INFO - PROCESS | 3724 | console.error: PushService: 09:07:37 INFO - PROCESS | 3724 | stateChangeProcessEnqueue: Error transitioning state 09:07:37 INFO - PROCESS | 3724 | UnknownError 09:07:38 INFO - TEST-INFO | 3724: exit 0 09:07:38 INFO - Browser initialized. 09:07:38 INFO - Running cycle 1/1 for kraken test... 09:07:38 INFO - TEST-INFO | started process 3812 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_wEF5X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:07:49 INFO - PROCESS | 3812 | RSS: Main: 144408576 09:07:49 INFO - PROCESS | 3812 | 09:07:52 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:39149/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39149/tests/kraken/driver.html?testName=audio-beat-detection) 09:07:53 INFO - PROCESS | 3812 | RSS: Main: 186093568 09:07:53 INFO - PROCESS | 3812 | 09:07:55 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:39149/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39149/tests/kraken/driver.html?testName=audio-dft) 09:07:56 INFO - PROCESS | 3812 | RSS: Main: 175845376 09:07:56 INFO - PROCESS | 3812 | 09:07:59 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:39149/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39149/tests/kraken/driver.html?testName=audio-fft) 09:07:59 INFO - PROCESS | 3812 | RSS: Main: 266862592 09:07:59 INFO - PROCESS | 3812 | 09:08:01 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:39149/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39149/tests/kraken/driver.html?testName=audio-oscillator) 09:08:02 INFO - PROCESS | 3812 | RSS: Main: 172732416 09:08:02 INFO - PROCESS | 3812 | 09:08:04 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:39149/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39149/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:08:05 INFO - PROCESS | 3812 | RSS: Main: 175800320 09:08:05 INFO - PROCESS | 3812 | 09:08:08 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:39149/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39149/tests/kraken/driver.html?testName=imaging-darkroom) 09:08:08 INFO - PROCESS | 3812 | RSS: Main: 214274048 09:08:08 INFO - PROCESS | 3812 | 09:08:12 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:39149/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39149/tests/kraken/driver.html?testName=imaging-desaturate) 09:08:12 INFO - PROCESS | 3812 | RSS: Main: 213307392 09:08:12 INFO - PROCESS | 3812 | 09:08:15 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:39149/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39149/tests/kraken/driver.html?testName=json-parse-financial) 09:08:15 INFO - PROCESS | 3812 | RSS: Main: 211558400 09:08:15 INFO - PROCESS | 3812 | 09:08:17 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:39149/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39149/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:08:18 INFO - PROCESS | 3812 | RSS: Main: 173916160 09:08:18 INFO - PROCESS | 3812 | 09:08:19 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:39149/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39149/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:08:20 INFO - PROCESS | 3812 | RSS: Main: 181035008 09:08:20 INFO - PROCESS | 3812 | 09:08:22 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:39149/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39149/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:08:22 INFO - PROCESS | 3812 | RSS: Main: 189820928 09:08:22 INFO - PROCESS | 3812 | 09:08:25 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:39149/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39149/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:08:26 INFO - PROCESS | 3812 | RSS: Main: 198664192 09:08:26 INFO - PROCESS | 3812 | 09:08:28 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:39149/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39149/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:08:29 INFO - PROCESS | 3812 | RSS: Main: 195534848 09:08:29 INFO - PROCESS | 3812 | 09:08:31 INFO - PROCESS | 3812 | Cycle 1(1): loaded http://localhost:39149/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39149/tests/kraken/driver.html?testName=ai-astar) 09:08:31 INFO - PROCESS | 3812 | RSS: Main: 247037952 09:08:31 INFO - PROCESS | 3812 | 09:08:31 INFO - PROCESS | 3812 | __start_tp_report 09:08:31 INFO - PROCESS | 3812 | _x_x_mozilla_page_load 09:08:31 INFO - PROCESS | 3812 | _x_x_mozilla_page_load_details 09:08:31 INFO - PROCESS | 3812 | |i|pagename|runs| 09:08:31 INFO - PROCESS | 3812 | |0;ai-astar;100;110;111;109;110;112;111;110;110;110 09:08:31 INFO - PROCESS | 3812 | |1;audio-beat-detection;155;129;123;163;122;124;127;121;148;129 09:08:31 INFO - PROCESS | 3812 | |2;audio-dft;163;160;162;162;162;161;160;161;160;159 09:08:31 INFO - PROCESS | 3812 | |3;audio-fft;74;75;76;108;76;77;76;75;97;76 09:08:31 INFO - PROCESS | 3812 | |4;audio-oscillator;82;82;116;83;84;83;103;82;82;113 09:08:31 INFO - PROCESS | 3812 | |5;imaging-gaussian-blur;117;117;116;116;117;117;118;117;117;117 09:08:31 INFO - PROCESS | 3812 | |6;imaging-darkroom;146;146;146;147;147;147;146;147;145;145 09:08:31 INFO - PROCESS | 3812 | |7;imaging-desaturate;85;84;85;84;84;86;84;84;84;84 09:08:31 INFO - PROCESS | 3812 | |8;json-parse-financial;52;51;53;51;51;54;50;50;50;50 09:08:31 INFO - PROCESS | 3812 | |9;json-stringify-tinderbox;58;60;58;60;58;59;59;58;58;59 09:08:31 INFO - PROCESS | 3812 | |10;stanford-crypto-aes;76;75;76;76;76;83;78;76;75;76 09:08:31 INFO - PROCESS | 3812 | |11;stanford-crypto-ccm;135;134;129;126;125;124;126;130;173;128 09:08:31 INFO - PROCESS | 3812 | |12;stanford-crypto-pbkdf2;159;157;163;161;160;160;161;160;163;161 09:08:31 INFO - PROCESS | 3812 | |13;stanford-crypto-sha256-iterative;65;65;65;64;67;64;63;64;67;62 09:08:31 INFO - PROCESS | 3812 | __end_tp_report 09:08:31 INFO - PROCESS | 3812 | __start_cc_report 09:08:31 INFO - PROCESS | 3812 | _x_x_mozilla_cycle_collect,1611 09:08:31 INFO - PROCESS | 3812 | __end_cc_report 09:08:31 INFO - PROCESS | 3812 | __startTimestamp1480957711499__endTimestamp 09:08:31 INFO - PROCESS | 3812 | 09:08:31 INFO - PROCESS | 3812 | ------- Summary: start ------- 09:08:31 INFO - PROCESS | 3812 | Number of tests: 14 09:08:31 INFO - PROCESS | 3812 | 09:08:31 INFO - PROCESS | 3812 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:3.37 (3.1%) stddev-sans-first:0.87 09:08:31 INFO - PROCESS | 3812 | Values: 100.0 110.0 111.0 109.0 110.0 112.0 111.0 110.0 110.0 110.0 09:08:31 INFO - PROCESS | 3812 | 09:08:31 INFO - PROCESS | 3812 | [#1] audio-beat-detection Cycles:10 Average:134.10 Median:129.00 stddev:15.31 (11.9%) stddev-sans-first:14.25 09:08:31 INFO - PROCESS | 3812 | Values: 155.0 129.0 123.0 163.0 122.0 124.0 127.0 121.0 148.0 129.0 09:08:31 INFO - PROCESS | 3812 | 09:08:31 INFO - PROCESS | 3812 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:1.25 (0.8%) stddev-sans-first:1.09 09:08:31 INFO - PROCESS | 3812 | Values: 163.0 160.0 162.0 162.0 162.0 161.0 160.0 161.0 160.0 159.0 09:08:31 INFO - PROCESS | 3812 | 09:08:31 INFO - PROCESS | 3812 | [#3] audio-fft Cycles:10 Average:81.00 Median:76.00 stddev:11.65 (15.3%) stddev-sans-first:12.08 09:08:31 INFO - PROCESS | 3812 | Values: 74.0 75.0 76.0 108.0 76.0 77.0 76.0 75.0 97.0 76.0 09:08:31 INFO - PROCESS | 3812 | 09:08:31 INFO - PROCESS | 3812 | [#4] audio-oscillator Cycles:10 Average:91.00 Median:82.00 stddev:13.96 (17.0%) stddev-sans-first:14.42 09:08:31 INFO - PROCESS | 3812 | Values: 82.0 82.0 116.0 83.0 84.0 83.0 103.0 82.0 82.0 113.0 09:08:31 INFO - PROCESS | 3812 | 09:08:31 INFO - PROCESS | 3812 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 09:08:31 INFO - PROCESS | 3812 | Values: 117.0 117.0 116.0 116.0 117.0 117.0 118.0 117.0 117.0 117.0 09:08:31 INFO - PROCESS | 3812 | 09:08:31 INFO - PROCESS | 3812 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.50 stddev:0.79 (0.5%) stddev-sans-first:0.83 09:08:31 INFO - PROCESS | 3812 | Values: 146.0 146.0 146.0 147.0 147.0 147.0 146.0 147.0 145.0 145.0 09:08:31 INFO - PROCESS | 3812 | 09:08:31 INFO - PROCESS | 3812 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.00 stddev:0.70 (0.8%) stddev-sans-first:0.71 09:08:31 INFO - PROCESS | 3812 | Values: 85.0 84.0 85.0 84.0 84.0 86.0 84.0 84.0 84.0 84.0 09:08:31 INFO - PROCESS | 3812 | 09:08:31 INFO - PROCESS | 3812 | [#8] json-parse-financial Cycles:10 Average:51.20 Median:51.00 stddev:1.40 (2.7%) stddev-sans-first:1.45 09:08:31 INFO - PROCESS | 3812 | Values: 52.0 51.0 53.0 51.0 51.0 54.0 50.0 50.0 50.0 50.0 09:08:31 INFO - PROCESS | 3812 | 09:08:31 INFO - PROCESS | 3812 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:59.00 stddev:0.82 (1.4%) stddev-sans-first:0.83 09:08:31 INFO - PROCESS | 3812 | Values: 58.0 60.0 58.0 60.0 58.0 59.0 59.0 58.0 58.0 59.0 09:08:31 INFO - PROCESS | 3812 | 09:08:31 INFO - PROCESS | 3812 | [#10] stanford-crypto-aes Cycles:10 Average:76.70 Median:76.00 stddev:2.36 (3.1%) stddev-sans-first:2.49 09:08:31 INFO - PROCESS | 3812 | Values: 76.0 75.0 76.0 76.0 76.0 83.0 78.0 76.0 75.0 76.0 09:08:31 INFO - PROCESS | 3812 | 09:08:31 INFO - PROCESS | 3812 | [#11] stanford-crypto-ccm Cycles:10 Average:133.00 Median:129.50 stddev:14.52 (11.2%) stddev-sans-first:15.38 09:08:31 INFO - PROCESS | 3812 | Values: 135.0 134.0 129.0 126.0 125.0 124.0 126.0 130.0 173.0 128.0 09:08:31 INFO - PROCESS | 3812 | 09:08:31 INFO - PROCESS | 3812 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.50 Median:161.00 stddev:1.78 (1.1%) stddev-sans-first:1.80 09:08:31 INFO - PROCESS | 3812 | Values: 159.0 157.0 163.0 161.0 160.0 160.0 161.0 160.0 163.0 161.0 09:08:31 INFO - PROCESS | 3812 | 09:08:31 INFO - PROCESS | 3812 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:65.00 stddev:1.58 (2.4%) stddev-sans-first:1.67 09:08:31 INFO - PROCESS | 3812 | Values: 65.0 65.0 65.0 64.0 67.0 64.0 63.0 64.0 67.0 62.0 09:08:31 INFO - PROCESS | 3812 | -------- Summary: end -------- 09:08:31 INFO - PROCESS | 3812 | 09:08:32 INFO - TEST-INFO | 3812: exit 0 09:08:32 INFO - TEST-OK | kraken | took 60252ms 09:08:32 INFO - SUITE-END | took 1179s 09:08:32 INFO - Completed test suite (00:19:39) 09:08:32 INFO - javascript benchmark 09:08:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3173.0, 3177.1262902701756, 3192.297694507208, 3197.960662784593, 3214.260720034392, 5501.779928802848, 5590.496855283029, 5654.293213348332, 5661.66030038198, 5681.573881958849, 5589.636673616223, 5656.717164141787, 5665.886682266352, 5666.178404131399, 5680.488756011958, 5082.84751457456, 5137.717425541594, 5173.042987047408, 5198.350206224222, 5215.087359712054, 4946.579540739023, 4966.627502937276, 5200.6099542534275, 5214.217867319913, 5229.294045303893, 5023.14606516893, 5100.821471248507, 5114.360704911886, 5129.974350128244, 5162.664426812245, 5101.260317253996, 5122.743862806882, 5149.2791009258735, 5178.611604129667, 5203.869903252411, 5055.772490237948, 5148.742562871841, 5177.326947496801, 5177.37871455424, 5204.245384419276, 5376.1398176292, 5406.810761623364, 5531.640443371168, 5589.832305030855, 5603.271574695264, 6028.819135425944, 6053.485453736438, 6063.848403789896, 6063.969125248718, 6080.574359794816, 6079.361667024988, 6092.451679348836, 6094.055421409688, 6104.206453161105, 6107.633541987495, 5532.944670553243, 5536.086545719952, 5547.944520554743, 5581.581381396411, 5691.971540142315, 6173.135760993465, 6177.567570270128, 6177.938220617826, 6187.752489900444, 6191.504679625619, 5887.0, 5910.0, 5928.614640048383, 5966.105084237312, 5993.940060599425, 5777.62445441045, 5858.47273745365, 5959.046552551571, 5997.970010149921, 6000.459958603659, 5959.374265702126, 5983.581149319506, 6011.218541589653, 6100.420460056288, 6102.572819902564, 6033.064874944391, 6045.516358691294, 6050.334463209044, 6051.515878729691, 6055.485283750931, 4552.476465206543, 4637.3275874997935, 4697.976510117496, 4707.670463067621, 4723.858284251478, 4017.1764788218347, 4059.3505039193587, 4096.508418989741, 4097.13960068383, 4126.525449573338, 5710.2862142232225, 5744.396838331915, 5745.540356771448, 5754.251947246831, 5760.683162426023, 6027.246594175728, 6031.577789554689, 6045.455908968214, 6053.727582258721, 6059.0, 5577.888442231133, 5641.464060914206, 5699.230603868425, 5734.942650573525, 5771.278590176228, 5214.45248248936, 5217.243499692523, 5219.5041471060185, 5225.608079394061, 5247.10799164143, 6202.317745048132, 6246.750129994749, 6259.155014073133, 6264.906026409608, 6267.717952692049, 5917.585768996301, 5982.192404025401, 6013.699315034319, 6019.217501724747, 6113.449789518964, 6197.411245931629, 6213.285472170577, 6243.7814676486105, 6254.124422580751, 6254.562180647311, 5999.880002400015, 6007.669578173242, 6015.578909476295, 6016.578929036926, 6051.485623721856, 5844.211031510862, 5845.678487683218, 5962.165296858357, 6101.60339577926, 6128.203333566607, 5904.202932604044, 5966.224390829165, 5970.432808883149, 5989.490893274121, 5996.5502587305255, 5932.228810254639, 5935.2877654681715, 5941.1385349125, 5941.7623295067715, 5948.851278718067, 5617.522510586482, 5719.828405147852, 5856.12158176277, 5874.500667443315, 5876.265466816648, 5856.12158176277, 5883.794067207627, 5904.586678932434, 5947.405259474018, 5951.880962380642, 5782.913256301074, 5783.306003279633, 5790.160426738184, 5795.507381872588, 5833.67914764692], "value": 5555.814311675873, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.4663156527561, 621.0621960839132, 644.0950464597242, 662.7481557008339, 671.2984930747368, 33912.15219619511, 44250.77874610626, 45238.0, 45568.54431455684, 45628.315575266395, 45854.77072614641, 45992.540074599325, 46275.76862115685, 46452.07095858081, 46477.7676111619, 8306.501609903395, 8637.352198585084, 8790.34072444566, 8801.943766748, 8815.338849586275, 8267.917320826806, 10404.583816647326, 10646.307989980627, 10659.573617055308, 10963.068139208177, 10730.980556847087, 10789.19081068919, 10797.190210734227, 10800.027997480225, 10801.459927003658, 10632.46837658114, 10686.251962362638, 10707.625233116882, 10710.785784284348, 10720.785584288271, 10550.577976880915, 10613.46932653372, 10631.574737010511, 10633.893661063445, 10633.946830265877, 42487.57512424867, 42640.57359426397, 42896.14207715859, 42926.35610465846, 42990.57009429897, 3548.4677298405186, 3610.729195310336, 3669.3578623741005, 3681.834317455721, 3713.3130370881204, 31931.52102718461, 32150.0, 32200.67799322, 32297.51553726696, 32465.188370290696, 4351.456067991501, 4377.430933978594, 4432.711873728197, 4472.172648060119, 4571.977140114312, 366885.0, 367008.0, 368979.0, 369010.0, 370160.0, 37323.81338093346, 59348.703256483444, 59789.40210597925, 59811.700941495015, 59893.0, 38559.0, 40774.184516309506, 40848.0, 40967.38548921768, 41027.0, 17018.404355847735, 17176.141192940304, 17192.570185745208, 17194.1402929853, 17220.569485762706, 11998.100142489347, 12095.879041209651, 13990.0906441081, 14466.493672721404, 14574.125552466887, 9307.488088155216, 9471.857922131174, 9487.667931622498, 9540.3321767477, 9544.570494327772, 3593.3352329819068, 3608.0979755061235, 3628.9496434514413, 3646.1431563582537, 3659.7438179327723, 989.3964681544252, 1006.1347241372414, 1009.6769033909079, 1071.8177909755361, 1084.9945750271197, 32950.34099318048, 32965.0, 33217.3356532868, 33310.167245818564, 33560.49659255113, 1053.694428615693, 1120.7366268926796, 1168.3865970365625, 1179.1392283632997, 1220.8840160184768, 15998.360065597246, 17884.0, 18007.459776206735, 18372.0, 18571.907140464213, 517340.0, 521315.0, 521854.0, 522303.0, 524515.0, 61182.0, 61942.38057619456, 61945.69027154835, 61967.0, 62035.6898215506, 1268.7272236469203, 1295.1257900916844, 1362.8841548468292, 1395.0, 1449.6230979945078, 31761.523577146825, 35172.82413588018, 35173.29653406969, 35214.823925880206, 35232.82383588168, 51940.22089668734, 52561.474385257185, 52795.736021319644, 52820.0, 52898.73550632222, 360735.0, 363756.0, 364216.0, 364791.0, 366759.0, 29626.259343516584, 30579.541306879968, 30877.0736877894, 32265.0, 32273.838630806695, 49983.50016499789, 50004.0, 50577.24134138064, 50593.0, 50763.492365077356, 41312.0, 41540.0, 41792.582074180085, 41855.0, 43423.34864976965, 42790.0, 42803.357949631405, 42997.35503967381, 43786.34320485131, 43903.78048109739, 42908.78545607377, 43458.0, 44112.338314925946, 44139.337909930735, 44292.7785361084, 34900.301993960486, 37050.0, 37446.0, 37724.81137594295, 38274.425883612326, 28546.78955790081, 29046.564301535072, 29170.416591668472, 29215.85392073026, 29281.0], "value": 19866.629122560633, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.72824115480915, 427.65146405679377, 431.7431128478555, 434.2149799332722, 443.07618615187334, 15866.286017129229, 19310.227590896364, 20255.797442025574, 20898.686519702216, 21024.053917573707, 19095.236190552398, 19421.805781942177, 20148.194072237093, 20279.087441065152, 20565.897170514127, 5830.912536311958, 6052.425019623151, 6053.697315134225, 6064.636121832682, 6064.818055458343, 5646.971765141189, 5928.318243402021, 5971.283445986488, 5975.52195824333, 5976.5517586180995, 5675.3757086720425, 5937.050071988483, 5938.910916336258, 5942.108683697436, 5943.791967281146, 5861.062230043194, 5888.617239879415, 5933.970330148365, 5936.940630593682, 5939.287285525765, 5137.871553211162, 5381.0, 5385.111456609655, 5387.24578559002, 5400.21696853954, 14544.2000689962, 14767.704645907022, 14814.851851481455, 15908.602284942854, 23518.412039698975, 2365.1721897335965, 2414.8913298901593, 2417.468157005456, 2920.9123726288244, 2998.025641666445, 10638.308509946828, 10760.300580462323, 10768.24622276441, 11052.557897684082, 11254.54981800727, 1828.6434145341664, 1855.8236967488067, 1944.2417457191707, 1947.6396866579728, 1958.7355706979517, 74482.0, 85932.0, 85975.57012214899, 87077.0, 87869.0, 10505.474726263808, 11204.15968802343, 11594.362310073027, 11633.76732465346, 11792.823107653221, 15425.305861236271, 16032.75950860738, 16049.358025679076, 16057.19714014318, 16066.598335041484, 8186.386021048445, 8887.289016878634, 8963.966215203185, 9031.954840225888, 9193.356465047382, 8639.006514250816, 8715.0, 8744.68829675541, 8941.105889411137, 8963.014068452465, 4904.0, 5089.541941225308, 5125.56432703217, 5141.2288156776785, 5150.4334523202415, 1940.7185958036005, 1979.6931475621302, 2046.4167712201952, 2050.5796311756053, 2092.591944570794, 920.7559996600907, 985.8225519406576, 1003.7540802503287, 1036.3678156324636, 1046.8063408269495, 19966.836467934634, 20686.275980340615, 20817.68773468399, 20897.0, 21265.78734212638, 970.2189737261431, 982.6904525074722, 1077.8167711489066, 1089.3953855610055, 1092.9945350273197, 10629.681109566725, 11439.714007149722, 11537.48081336342, 11564.537418503165, 11579.189456738117, 482974.0, 493279.0, 501251.0, 501591.0, 536491.0, 90860.5456972711, 92499.53750231206, 100251.0, 106511.0, 106613.0, 1057.7038429239826, 1081.4808891732014, 1094.9288296260718, 1106.4965440724452, 1106.9667909962714, 17753.467395978143, 18382.1728022242, 18737.250509979993, 18807.529811754815, 19081.0, 45245.0, 45715.54284457246, 46308.7684561575, 46533.3020004707, 47028.0, 58936.70531647314, 59337.0, 59702.958022365274, 60086.69956650189, 60399.396006041134, 7862.056642544484, 7977.521348719096, 9305.488198148896, 9420.434773913586, 9435.29235307341, 10279.383237005804, 13629.522966696119, 13886.583402497941, 14000.579982600539, 14135.929320353744, 6058.939410605837, 7253.746118885813, 12423.44094515767, 12479.0, 12782.36088195568, 11716.297022178696, 12235.510579576718, 12240.816387754012, 12399.566015189424, 12806.487740490276, 11818.349990750592, 12740.362981850685, 12809.871901280869, 12837.908777753995, 13118.278494682503, 9120.863187052331, 9191.816163676824, 9247.815043698954, 9615.471149086588, 9618.759531011501, 11549.076073913899, 11908.821367679666, 12115.333656648969, 12429.689257768629, 12459.750804983669], "value": 9524.135522464052, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1378.441731098904, 1538.73841446954, 1544.227886056971, 1733.0987886299124, 1844.206990993873, 7662.808429789251, 8332.45839020464, 8675.0, 8678.218960293572, 8879.60041798119, 8678.652853885837, 8753.824923501526, 8754.781130471742, 8763.956180219106, 8764.474131552111, 2457.0908763757434, 2484.1057219401, 2487.6641653376832, 2487.7387874273213, 2489.5269898719275, 2406.6630671705975, 2478.2689106713565, 2488.962665560018, 2490.1533478617266, 2492.5513407586627, 2323.256557901472, 2335.4278201840575, 2417.697787776528, 2422.34596658902, 2423.6001059825107, 2254.9210777622707, 2272.670462782887, 2298.1496846166942, 2307.90768369265, 2319.698439202901, 2346.2257455039967, 2354.587947109249, 2365.0657990093987, 2367.3134790910617, 2367.3726462487452, 7589.241075892422, 8312.459690120122, 8376.581170941428, 8422.78943026423, 8425.031121420992, 4656.511066338019, 5175.896482070375, 5416.512513873731, 5418.106012507931, 5423.376311724123, 3280.425925463034, 3324.501324801275, 3372.2749608833974, 3382.9830850845833, 3509.842057107436, 1109.1404161774608, 1118.9440527973568, 1128.5880653561474, 1130.9434528273637, 1146.0716819376332, 11863.0, 11885.049196064294, 11928.165028448013, 11945.820812687816, 11949.522019119311, 4537.865533616596, 4572.634189264851, 4716.693414928087, 4728.834490792806, 4728.905421891612, 9757.512124393752, 9765.316427850124, 9767.072128147956, 9772.804543909082, 9781.315307928377, 5287.814926477555, 5323.866903327448, 5328.760205790749, 5332.360116786011, 5335.226392173113, 4208.494980602347, 4369.0, 4389.034412429261, 4391.780410979438, 4923.803047878117, 4049.817758200888, 4112.261302591871, 4161.001359673717, 4172.123853990635, 4211.789410529461, 1294.0430422892593, 1325.973480530384, 1333.0076421118617, 1338.3107699534748, 1347.818044563991, 869.1916517638531, 952.7999120184838, 996.267743208741, 1033.7570670892485, 1034.6430481483876, 5982.5948183427845, 6101.176341193971, 6130.816075517741, 6159.6612186329285, 6267.623942563369, 484.5542101266843, 489.9779509922062, 494.3227777944239, 511.9897602047938, 514.2928473349145, 4179.0, 4199.622034016892, 4323.827046918151, 4349.739015659071, 4386.122775444924, 10417.635382761568, 10733.034026937614, 10737.463126843626, 10752.139828813833, 10787.0, 10923.453827308762, 11032.0, 11064.225504214788, 11067.557297708163, 11094.167937404565, 7884.250996155356, 8181.100078991306, 8429.4942303462, 8444.704435344733, 8449.0, 6033.487153591994, 6123.2958209804665, 6203.2556093269095, 6210.254769427697, 6296.212973378328, 9927.751806204613, 10140.290179687647, 10170.982901709769, 10186.0, 10219.284650074424, 8817.294616430541, 10013.098821106136, 10150.340227885164, 10182.287239893136, 10189.694309170736, 7817.101033381234, 7906.367490600623, 7983.361331093614, 7987.600619969095, 7988.760337189894, 8349.248567628943, 8362.038365588036, 8409.747707568782, 8414.368922330972, 8416.873746893923, 7480.513766605153, 7598.924010760043, 7630.236976302325, 7649.655765490677, 7749.961250193938, 7138.928610713826, 7497.812554686177, 7543.3965282778345, 7552.66013029404, 7766.029246344207, 6820.317968203339, 6934.4452443805385, 6934.757283495053, 6936.479764017819, 6940.444764418733, 5295.867603309948, 5380.166074258496, 5397.9730101350815, 5403.567714582902, 5618.4662457066515, 5283.709395983258, 5287.4976877196605, 5319.893602128013, 5367.194920761917, 5454.727263636882], "value": 4584.192575438821, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.15371953591847, 356.3727839003354, 362.746077745578, 365.72205124105704, 367.606660872866, 5297.443768404315, 5336.946630533694, 5340.25236466894, 5343.851072019515, 5358.0, 4963.826266080688, 5063.9493605063935, 5105.795768169278, 5128.461511541291, 5255.632105752599, 4141.792910354486, 4159.23054234966, 4171.478565179353, 4192.979035104828, 4194.119234960662, 4190.601892820192, 4198.286291330466, 4199.139176468817, 4223.809928553207, 4244.469441319835, 3975.9602403976023, 3993.7818965215597, 4039.333509970851, 4158.251514727348, 4177.268977928866, 4147.979260103711, 4149.298787497111, 4155.646770024551, 4159.604837540429, 4205.7897105144775, 3731.7760934343755, 3738.214974855284, 3749.850005999757, 3754.2116155607355, 3755.117547376364, 5042.697438153723, 5051.545360917535, 5056.823011194628, 5076.974615126901, 5138.3577052868395, 4720.0, 4731.187090589575, 4737.59730422911, 4741.57325840676, 4759.262314341283, 5433.755481003364, 5435.347758268994, 5445.727713614304, 5457.454254574551, 5460.6177567570285, 4001.3197756381487, 4080.510338759338, 4109.2808758467145, 4124.092699606082, 4127.2570937231285, 5552.750126244288, 5613.736909195439, 5616.9157462638095, 5631.493165615073, 5631.915521267184, 4203.4115223868685, 4204.936925946114, 4217.198732240864, 4235.9364609530885, 4239.491261048694, 4130.814113364846, 4183.995840998138, 4228.344606585984, 4296.484421869396, 4299.269124248885, 4709.693869898446, 4730.172219861579, 4732.313814496879, 4751.691140075884, 4762.857114286577, 5443.836684899459, 5452.291202143775, 5452.59105567084, 5471.50756431923, 5513.09034009384, 1365.8360996680262, 1388.2572823539358, 1404.8524904885044, 1421.8791402730676, 1423.9644008899654, 936.6253498600614, 949.8670186173941, 982.268210183418, 1004.9899501005043, 1006.7382480555109, 5111.795528178831, 5134.435212126663, 5142.0, 5146.974265128651, 5190.169572868398, 5386.434424385461, 5405.324334458192, 5408.675479471244, 5410.513053825096, 5439.592030597721, 5099.490050994871, 5133.948660513422, 5366.382865970463, 5391.406945236021, 5422.755975981011, 2877.316769689755, 2885.6825749167574, 2890.1762997545597, 2910.6070680457865, 2916.4458752836895, 5558.694271815089, 5560.638558493766, 5575.818136397702, 5591.217229587861, 5612.887742245214, 5740.196372507852, 5742.224799652077, 5750.482456578844, 5751.712414379264, 5774.913376299359, 5746.741396637161, 5759.164921086419, 5778.306603207642, 5808.634970781863, 5855.209546711139, 5581.302337207849, 5613.326400831927, 5649.36751863468, 5663.631863928831, 5712.971435142797, 5623.381428042994, 5633.267675202197, 5636.633618814764, 5653.830385088454, 5654.6889921054735, 5658.971705141448, 5805.970970145122, 5845.444682755132, 5859.472647461749, 5869.73586188614, 4118.464599602033, 4134.0, 4164.541900391016, 4167.4790651168605, 4170.812313445963, 5647.774089036392, 5682.943170568242, 5709.800941802268, 5715.171300161536, 5738.99567575681, 5444.6188766785945, 5558.360788509373, 5598.916016259841, 5632.211490391266, 5644.153376993484, 5493.423190564933, 5520.861978450571, 5538.335399752055, 5547.972260138674, 5556.499915007668, 5263.263143159884, 5402.108652072364, 5467.699276539828, 5483.122700367922, 5506.559475241891, 5412.83761487156, 5510.421405752339, 5546.72266386671, 5578.748956296895, 5584.352615978378, 5365.0, 5414.3232095988005, 5447.0, 5453.072977593739, 5480.931218412371], "value": 4232.883884918844, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.4063488257074, 740.5593671765301, 763.1567118334241, 784.3019712455913, 837.7151768398743, 14668.266586670663, 15230.543083707478, 15302.464413745522, 15359.232038398091, 15366.769498457517, 14697.118172909606, 14770.335334909929, 14780.852191478081, 14784.112953222788, 14867.776983345258, 712.7683502861565, 736.9078865141857, 858.3862538285125, 870.0472982084607, 871.9258862996653, 842.2882664148784, 874.4272501511489, 883.7437143228489, 885.2033170146855, 885.313881741649, 911.8723378726984, 913.456493386434, 914.3096961793836, 914.4787471141452, 914.4833169259347, 723.706898706025, 755.7543798265585, 898.9550522473883, 901.175424486594, 901.4816480523725, 640.0591131037368, 659.5086660437956, 663.6681659170415, 664.0935123556359, 664.2560332427712, 14609.488667896572, 14716.33776480061, 14773.482928097572, 14779.926100369537, 14795.0, 12801.679958001032, 12921.483140674361, 13105.0, 13125.474981000749, 13181.868181318256, 12692.682682932907, 12711.427985740664, 12940.288284144368, 13061.281629510373, 13181.802272965913, 4164.83340666373, 4166.7708276044805, 4182.2890108681295, 4200.3699445083175, 4283.20760659279, 61843.0, 62848.68575657138, 62934.0, 63071.684641576954, 63613.36386636121, 10627.14982801374, 10746.78506429867, 10812.0, 10872.45637718111, 11293.491792869341, 20182.293619723532, 20307.0, 20310.39068827908, 20396.79603203949, 20580.38258852207, 7580.469367144357, 7655.961720191363, 7777.5722335270975, 7838.255365740246, 7918.366530677532, 4505.189065968158, 4535.614472769786, 4559.316102584638, 4618.261078227468, 4624.768761561909, 3392.2876195999115, 3473.0622731862254, 3496.7727097738566, 3496.8426420811124, 3504.8948531544092, 596.3797650443577, 610.5024405109822, 618.2735286038886, 624.1760875644197, 632.3992207402986, 540.4730387871872, 585.1836687820552, 688.8564982129641, 719.3166491832675, 727.1782885339533, 8616.353773467015, 8909.866352004725, 9163.0, 9182.403143795633, 9237.214836738953, 695.982600434983, 700.3556727810427, 706.6819931031057, 708.8759467093341, 716.6022857314136, 4473.955260447419, 4491.405551029403, 4525.094981003813, 4554.225781617133, 4555.202839503074, 85811.57094214488, 88584.5570772142, 90494.0, 92954.0, 93075.53462232645, 46449.0, 70856.291437086, 73425.0, 75714.0, 76980.0, 70561.29438705547, 71684.64157679178, 73348.63325683444, 73753.63123184457, 75869.62065189639, 8080.0, 8131.878021829795, 8210.630521626661, 8474.406791524534, 8481.109483504144, 48770.0, 48813.51186488232, 49306.0, 49340.75329623329, 49447.25829112494, 60818.69590652018, 63400.0, 67156.0, 68574.3142568568, 70603.64698176681, 11407.144464165054, 11711.355875426932, 11776.352300623548, 11850.288982661068, 11963.0, 12563.05777066742, 12570.182938108994, 12649.367531623198, 12694.428750706425, 12739.235645861278, 12049.397530123633, 12054.99680715209, 12188.146829722189, 12635.93682031584, 12800.74398512043, 11915.40422978865, 11969.461374238006, 12080.0, 12274.0, 12316.014718822293, 11973.102017348909, 12066.517339306329, 12177.573784917486, 12275.877241227474, 12303.0, 10055.346402483816, 10120.746981325232, 10341.534630941776, 10424.739381515523, 10485.475726213812, 9968.800623987625, 10316.484175791331, 10373.688789336333, 10401.58393664245, 10532.36805791655], "value": 7102.1616490818205, "unit": "score"}], "name": "dromaeo_css", "value": 7247.228661818157, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 110.0, 111.0, 109.0, 110.0, 112.0, 111.0, 110.0, 110.0, 110.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 129.0, 123.0, 163.0, 122.0, 124.0, 127.0, 121.0, 148.0, 129.0], "value": 134.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 162.0, 162.0, 162.0, 161.0, 160.0, 161.0, 160.0, 159.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 108.0, 76.0, 77.0, 76.0, 75.0, 97.0, 76.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 116.0, 83.0, 84.0, 83.0, 103.0, 82.0, 82.0, 113.0], "value": 91.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 145.0, 145.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 85.0, 84.0, 84.0, 86.0, 84.0, 84.0, 84.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 53.0, 51.0, 51.0, 54.0, 50.0, 50.0, 50.0, 50.0], "value": 51.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 58.0, 60.0, 58.0, 59.0, 59.0, 58.0, 58.0, 59.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 76.0, 76.0, 83.0, 78.0, 76.0, 75.0, 76.0], "value": 76.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 134.0, 129.0, 126.0, 125.0, 124.0, 126.0, 130.0, 173.0, 128.0], "value": 133.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 157.0, 163.0, 161.0, 160.0, 160.0, 161.0, 160.0, 163.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 67.0, 64.0, 63.0, 64.0, 67.0, 62.0], "value": 64.6, "unit": "score"}], "name": "kraken", "value": 1468.6, "alertThreshold": 2.0}]} 09:08:32 INFO - Return code: 0 09:08:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:08:32 INFO - # TBPL SUCCESS # 09:08:32 INFO - Running post-action listener: _resource_record_post_action 09:08:32 INFO - [mozharness: 2016-12-05 17:08:32.828627Z] Finished run-tests step (success) 09:08:32 INFO - Running post-run listener: _resource_record_post_run 09:08:32 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 9953280; Write bytes: 376840192; Read time: 1164; Write time: 435636 09:08:32 INFO - TinderboxPrint: CPU usage
13.0% 09:08:32 INFO - TinderboxPrint: I/O read bytes / time
9,953,280 / 1,164 09:08:32 INFO - TinderboxPrint: I/O write bytes / time
376,840,192 / 435,636 09:08:32 INFO - TinderboxPrint: CPU idle
8,307.6 (87.0%) 09:08:32 INFO - TinderboxPrint: CPU user
1,188.6 (12.5%) 09:08:32 INFO - TinderboxPrint: Swap in / out
0 / 0 09:08:32 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 503808; Read time: 0; Write time: 44 09:08:32 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 7282688; Write bytes: 376336384; Read time: 988; Write time: 435592 09:08:33 INFO - Running post-run listener: _upload_blobber_files 09:08:33 INFO - Blob upload gear active. 09:08:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:08:33 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 09:08:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:08:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:08:33 INFO - (blobuploader) - INFO - Open directory for files ... 09:08:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:08:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:08:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:37 INFO - (blobuploader) - INFO - Done attempting. 09:08:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:08:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:08:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:38 INFO - (blobuploader) - INFO - Done attempting. 09:08:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:08:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:08:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:08:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:08:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:08:39 INFO - (blobuploader) - INFO - Done attempting. 09:08:39 INFO - (blobuploader) - INFO - Iteration through files over. 09:08:39 INFO - Return code: 0 09:08:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:08:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:08:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dbf2e25d0a0dfa10d11c19840ed696eb29b4aa19182939817b138b1c493c06d520250a229813cbb2c735576ac14886e0fcd5fad3557debb1ae85523321acccb5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d4a45dd4847db6a5ca2913408a087a57655230f6f1356b1bfc3f46d17c1cc8e844fb69f0f8e471ff23d4f5316960c2fa740eeb2f409125e73a2f9eaee9e096d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f187a06fe8faa17182fcd866a3943e0ce9992943bb1f91b232102d010ef6182fa0197e5df39af20f005b557a9111dfb5aa884e2a4daa75c123b6a506611174b9"} 09:08:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:08:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:08:39 INFO - Contents: 09:08:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dbf2e25d0a0dfa10d11c19840ed696eb29b4aa19182939817b138b1c493c06d520250a229813cbb2c735576ac14886e0fcd5fad3557debb1ae85523321acccb5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d4a45dd4847db6a5ca2913408a087a57655230f6f1356b1bfc3f46d17c1cc8e844fb69f0f8e471ff23d4f5316960c2fa740eeb2f409125e73a2f9eaee9e096d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f187a06fe8faa17182fcd866a3943e0ce9992943bb1f91b232102d010ef6182fa0197e5df39af20f005b557a9111dfb5aa884e2a4daa75c123b6a506611174b9"} 09:08:39 INFO - Running post-run listener: copy_logs_to_upload_dir 09:08:39 INFO - Copying logs to upload dir... 09:08:39 INFO - mkdir: /builds/slave/test/build/upload/logs 09:08:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.426400 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-12-05 09:08:39.410547) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-05 09:08:39.414003) ========= 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=20e666a3d4cfbb71505a330e000001b4-1480956077.431752-1292481603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dbf2e25d0a0dfa10d11c19840ed696eb29b4aa19182939817b138b1c493c06d520250a229813cbb2c735576ac14886e0fcd5fad3557debb1ae85523321acccb5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d4a45dd4847db6a5ca2913408a087a57655230f6f1356b1bfc3f46d17c1cc8e844fb69f0f8e471ff23d4f5316960c2fa740eeb2f409125e73a2f9eaee9e096d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f187a06fe8faa17182fcd866a3943e0ce9992943bb1f91b232102d010ef6182fa0197e5df39af20f005b557a9111dfb5aa884e2a4daa75c123b6a506611174b9"} build_url:https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011313 build_url: 'https://queue.taskcluster.net/v1/task/WaHaLNPgSPy0CCmmlXGkxw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dbf2e25d0a0dfa10d11c19840ed696eb29b4aa19182939817b138b1c493c06d520250a229813cbb2c735576ac14886e0fcd5fad3557debb1ae85523321acccb5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d4a45dd4847db6a5ca2913408a087a57655230f6f1356b1bfc3f46d17c1cc8e844fb69f0f8e471ff23d4f5316960c2fa740eeb2f409125e73a2f9eaee9e096d9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f187a06fe8faa17182fcd866a3943e0ce9992943bb1f91b232102d010ef6182fa0197e5df39af20f005b557a9111dfb5aa884e2a4daa75c123b6a506611174b9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-05 09:08:39.439223) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 09:08:39.439561) ========= 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=20e666a3d4cfbb71505a330e000001b4-1480956077.431752-1292481603 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004423 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 09:08:39.524418) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-05 09:08:39.524739) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-05 09:08:39.525053) ========= ========= Total master_lag: 0.19 =========