builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-051 starttime: 1476851152.47 results: success (0) buildid: 20161018183007 builduid: 3f9f96fc2a8c4156879143bc6ea12788 revision: 12a9cca092f816fabb67cc8a139e0cbd5b1cea37 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-18 21:25:52.468926) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-18 21:25:52.469364) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-18 21:25:52.469640) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-18 21:25:52.484095) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 21:25:52.484491) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1476851152.95006-443706985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-18 21:25:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 112M=0s 2016-10-18 21:25:52 (112 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.186143 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 21:25:52.684339) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 21:25:52.684696) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1476851152.95006-443706985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017321 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 21:25:52.734127) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 21:25:52.734493) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 12a9cca092f816fabb67cc8a139e0cbd5b1cea37 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 12a9cca092f816fabb67cc8a139e0cbd5b1cea37 --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=5ac5dba3e01a12f1ff77ab15000001b1-1476851152.95006-443706985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-18 21:25:53,101 truncating revision to first 12 chars 2016-10-18 21:25:53,101 Setting DEBUG logging. 2016-10-18 21:25:53,101 attempt 1/10 2016-10-18 21:25:53,101 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/12a9cca092f8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-18 21:25:53,419 unpacking tar archive at: fx-team-12a9cca092f8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.639108 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 21:25:53.388388) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-18 21:25:53.388707) ========= script_repo_revision: 12a9cca092f816fabb67cc8a139e0cbd5b1cea37 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-18 21:25:53.389097) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-18 21:25:53.389411) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-18 21:25:53.398037) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-18 21:25:53.398331) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=5ac5dba3e01a12f1ff77ab15000001b1-1476851152.95006-443706985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:25:53 INFO - MultiFileLogger online at 20161018 21:25:53 in /builds/slave/test 21:25:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 21:25:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:25:53 INFO - {'append_to_log': False, 21:25:53 INFO - 'base_work_dir': '/builds/slave/test', 21:25:53 INFO - 'blob_upload_branch': 'Fx-Team', 21:25:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:25:53 INFO - 'branch': 'Fx-Team', 21:25:53 INFO - 'buildbot_json_path': 'buildprops.json', 21:25:53 INFO - 'config_files': ('talos/linux_config.py',), 21:25:53 INFO - 'default_actions': ('clobber', 21:25:53 INFO - 'read-buildbot-config', 21:25:53 INFO - 'download-and-extract', 21:25:53 INFO - 'populate-webroot', 21:25:53 INFO - 'create-virtualenv', 21:25:53 INFO - 'install', 21:25:53 INFO - 'run-tests'), 21:25:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:25:53 INFO - 'download_minidump_stackwalk': True, 21:25:53 INFO - 'download_symbols': 'ondemand', 21:25:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:25:53 INFO - 'tooltool.py': '/tools/tooltool.py', 21:25:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:25:53 INFO - '/tools/misc-python/virtualenv.py')}, 21:25:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:25:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:25:53 INFO - 'installer_path': 'installer.exe', 21:25:53 INFO - 'log_level': 'info', 21:25:53 INFO - 'log_name': 'talos', 21:25:53 INFO - 'log_to_console': True, 21:25:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:25:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:25:53 INFO - 'opt_config_files': (), 21:25:53 INFO - 'pip_index': False, 21:25:53 INFO - 'sps_profile': False, 21:25:53 INFO - 'sps_profile_interval': 0, 21:25:53 INFO - 'suite': 'dromaeojs', 21:25:53 INFO - 'system_bits': '32', 21:25:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:25:53 INFO - 'title': 'talos-linux64-ix-051', 21:25:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:25:53 INFO - 'use_talos_json': True, 21:25:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:25:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:25:53 INFO - 'work_dir': 'build'} 21:25:53 INFO - [mozharness: 2016-10-19 04:25:53.867670Z] Running clobber step. 21:25:53 INFO - Running pre-action listener: _resource_record_pre_action 21:25:53 INFO - Running main action method: clobber 21:25:53 INFO - rmtree: /builds/slave/test/build 21:25:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:25:54 INFO - Running post-action listener: _resource_record_post_action 21:25:54 INFO - [mozharness: 2016-10-19 04:25:54.350898Z] Finished clobber step (success) 21:25:54 INFO - [mozharness: 2016-10-19 04:25:54.351000Z] Running read-buildbot-config step. 21:25:54 INFO - Running pre-action listener: _resource_record_pre_action 21:25:54 INFO - Running main action method: read_buildbot_config 21:25:54 INFO - Using buildbot properties: 21:25:54 INFO - { 21:25:54 INFO - "project": "", 21:25:54 INFO - "product": "firefox", 21:25:54 INFO - "script_repo_revision": "production", 21:25:54 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 21:25:54 INFO - "repository": "", 21:25:54 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 21:25:54 INFO - "buildid": "20161018183007", 21:25:54 INFO - "pgo_build": "True", 21:25:54 INFO - "basedir": "/builds/slave/test", 21:25:54 INFO - "buildnumber": 539, 21:25:54 INFO - "slavename": "talos-linux64-ix-051", 21:25:54 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:25:54 INFO - "platform": "ubuntu64_hw", 21:25:54 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 21:25:54 INFO - "branch": "fx-team", 21:25:54 INFO - "repo_path": "integration/fx-team", 21:25:54 INFO - "revision": "12a9cca092f816fabb67cc8a139e0cbd5b1cea37", 21:25:54 INFO - "stage_platform": "linux64-pgo", 21:25:54 INFO - "builduid": "3f9f96fc2a8c4156879143bc6ea12788", 21:25:54 INFO - "slavebuilddir": "test" 21:25:54 INFO - } 21:25:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/dZ7YqQnzQyS6U6iKAiGnRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 21:25:54 INFO - Running post-action listener: _resource_record_post_action 21:25:54 INFO - [mozharness: 2016-10-19 04:25:54.353439Z] Finished read-buildbot-config step (success) 21:25:54 INFO - [mozharness: 2016-10-19 04:25:54.353527Z] Running download-and-extract step. 21:25:54 INFO - Running pre-action listener: _resource_record_pre_action 21:25:54 INFO - Running main action method: download_and_extract 21:25:54 INFO - mkdir: /builds/slave/test/build/tests 21:25:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:25:54 INFO - trying https://queue.taskcluster.net/v1/task/dZ7YqQnzQyS6U6iKAiGnRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:25:54 INFO - Downloading https://queue.taskcluster.net/v1/task/dZ7YqQnzQyS6U6iKAiGnRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:25:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dZ7YqQnzQyS6U6iKAiGnRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:25:54 INFO - Downloaded 1361 bytes. 21:25:54 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:25:54 INFO - Using the following test package requirements: 21:25:54 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:25:54 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:25:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:25:54 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:25:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:25:54 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:25:54 INFO - u'jsshell-linux-x86_64.zip'], 21:25:54 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:25:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:25:54 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:25:54 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:25:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:25:54 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:25:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:25:54 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:25:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:25:54 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:25:54 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:25:54 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:25:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dZ7YqQnzQyS6U6iKAiGnRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:25:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dZ7YqQnzQyS6U6iKAiGnRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:25:54 INFO - Fetch https://queue.taskcluster.net/v1/task/dZ7YqQnzQyS6U6iKAiGnRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:25:55 INFO - Http code: 200 21:25:55 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 21:25:55 INFO - x-amz-cf-id: vwFJ61oIj9H2cYwJgCwgIFxdToY-yZ3CuyTFGuxQM3HkNogKA7lCOg== 21:25:55 INFO - x-amz-version-id: UtwK5.Pbz3Qipx0GvpV52SsCWOi1fDbo 21:25:55 INFO - Expected file size: 22090357 21:25:55 INFO - Obtained file size: 22090357 21:25:59 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:25:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dZ7YqQnzQyS6U6iKAiGnRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:25:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dZ7YqQnzQyS6U6iKAiGnRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:25:59 INFO - Fetch https://queue.taskcluster.net/v1/task/dZ7YqQnzQyS6U6iKAiGnRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:26:00 INFO - Http code: 200 21:26:00 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 21:26:00 INFO - x-amz-cf-id: v45sRJ0s8zoqlWXjwDSwaO1WmpI1o683dVK3IGI_VnNCiZRffzeBDw== 21:26:00 INFO - x-amz-version-id: UtwK5.Pbz3Qipx0GvpV52SsCWOi1fDbo 21:26:01 INFO - Expected file size: 22090357 21:26:01 INFO - Obtained file size: 22090357 21:26:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dZ7YqQnzQyS6U6iKAiGnRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 21:26:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dZ7YqQnzQyS6U6iKAiGnRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:26:05 INFO - Fetch https://queue.taskcluster.net/v1/task/dZ7YqQnzQyS6U6iKAiGnRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:26:06 INFO - Http code: 200 21:26:06 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 21:26:06 INFO - x-amz-cf-id: _-j7OCuAyWBvWPaYZF_5v8BMFMV4MYen7t3U3l2KT40Vw7sIajlOEA== 21:26:06 INFO - x-amz-version-id: e4VVeZ62ikRlBUfVFmrUoYAVXSpfifMP 21:26:06 INFO - Expected file size: 14409028 21:26:06 INFO - Obtained file size: 14409028 21:26:06 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')]} 21:26:06 INFO - trying https://queue.taskcluster.net/v1/task/dZ7YqQnzQyS6U6iKAiGnRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:26:06 INFO - Downloading https://queue.taskcluster.net/v1/task/dZ7YqQnzQyS6U6iKAiGnRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:26:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dZ7YqQnzQyS6U6iKAiGnRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:26:07 INFO - Downloaded 59461534 bytes. 21:26:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dZ7YqQnzQyS6U6iKAiGnRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:26:07 INFO - mkdir: /builds/slave/test/properties 21:26:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:26:07 INFO - Writing to file /builds/slave/test/properties/build_url 21:26:07 INFO - Contents: 21:26:07 INFO - build_url:https://queue.taskcluster.net/v1/task/dZ7YqQnzQyS6U6iKAiGnRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:26:08 INFO - Running post-action listener: _resource_record_post_action 21:26:08 INFO - Running post-action listener: set_extra_try_arguments 21:26:08 INFO - [mozharness: 2016-10-19 04:26:08.299718Z] Finished download-and-extract step (success) 21:26:08 INFO - [mozharness: 2016-10-19 04:26:08.300017Z] Running populate-webroot step. 21:26:08 INFO - Running pre-action listener: _resource_record_pre_action 21:26:08 INFO - Running main action method: populate_webroot 21:26:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:26:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:26:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:26:08 INFO - '--tppagecycles', 21:26:08 INFO - '7'], 21:26:08 INFO - 'tests': ['tsvgm']}}, 21:26:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:26:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:26:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:26:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:26:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:26:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:26:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:26:08 INFO - 'talos_options': ['--disable-e10s'], 21:26:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:26:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:26:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:26:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:26:08 INFO - 'talos_options': ['--disable-e10s'], 21:26:08 INFO - 'tests': ['damp', 'tps']}, 21:26:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:26:08 INFO - 'tests': ['damp', 'tps']}, 21:26:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:26:08 INFO - 'tests': ['dromaeo_dom']}, 21:26:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:26:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:26:08 INFO - 'tests': ['basic_compositor_video']}, 21:26:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:26:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:26:08 INFO - 'tests': ['a11yr', 21:26:08 INFO - 'ts_paint', 21:26:08 INFO - 'tpaint', 21:26:08 INFO - 'sessionrestore', 21:26:08 INFO - 'sessionrestore_no_auto_restore', 21:26:08 INFO - 'tabpaint']}, 21:26:08 INFO - 'other-e10s': {'tests': ['a11yr', 21:26:08 INFO - 'ts_paint', 21:26:08 INFO - 'tpaint', 21:26:08 INFO - 'sessionrestore', 21:26:08 INFO - 'sessionrestore_no_auto_restore', 21:26:08 INFO - 'tabpaint']}, 21:26:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:26:08 INFO - 'ts_paint', 21:26:08 INFO - 'tpaint', 21:26:08 INFO - 'sessionrestore', 21:26:08 INFO - 'sessionrestore_no_auto_restore', 21:26:08 INFO - 'tabpaint']}, 21:26:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:26:08 INFO - 'ts_paint', 21:26:08 INFO - 'tpaint', 21:26:08 INFO - 'sessionrestore', 21:26:08 INFO - 'sessionrestore_no_auto_restore', 21:26:08 INFO - 'tabpaint']}, 21:26:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:26:08 INFO - 'tests': ['a11yr', 21:26:08 INFO - 'ts_paint', 21:26:08 INFO - 'tpaint', 21:26:08 INFO - 'sessionrestore', 21:26:08 INFO - 'sessionrestore_no_auto_restore', 21:26:08 INFO - 'tabpaint']}, 21:26:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:26:08 INFO - 'tests': ['a11yr', 21:26:08 INFO - 'ts_paint', 21:26:08 INFO - 'tpaint', 21:26:08 INFO - 'sessionrestore', 21:26:08 INFO - 'sessionrestore_no_auto_restore', 21:26:08 INFO - 'tabpaint']}, 21:26:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:26:08 INFO - 'tests': ['tsvgx', 21:26:08 INFO - 'tsvgr_opacity', 21:26:08 INFO - 'tart', 21:26:08 INFO - 'tscrollx', 21:26:08 INFO - 'cart']}, 21:26:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:26:08 INFO - 'tsvgr_opacity', 21:26:08 INFO - 'tart', 21:26:08 INFO - 'tscrollx', 21:26:08 INFO - 'cart']}, 21:26:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:26:08 INFO - 'talos_options': ['--disable-e10s'], 21:26:08 INFO - 'tests': ['tp5o']}, 21:26:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:26:08 INFO - 'tests': ['tp5o']}, 21:26:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:26:08 INFO - 'talos_options': ['--disable-e10s', 21:26:08 INFO - '--xperf_path', 21:26:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:26:08 INFO - 'tests': ['tp5n']}, 21:26:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:26:08 INFO - 'talos_options': ['--xperf_path', 21:26:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:26:08 INFO - 'tests': ['tp5n']}}, 21:26:08 INFO - 'talos.zip': {'path': '', 21:26:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:26:08 INFO - Running post-action listener: _resource_record_post_action 21:26:08 INFO - [mozharness: 2016-10-19 04:26:08.317960Z] Finished populate-webroot step (success) 21:26:08 INFO - [mozharness: 2016-10-19 04:26:08.318054Z] Running create-virtualenv step. 21:26:08 INFO - Running pre-action listener: _resource_record_pre_action 21:26:08 INFO - Running main action method: create_virtualenv 21:26:08 INFO - Creating virtualenv /builds/slave/test/build/venv 21:26:08 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 21:26:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:26:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:26:08 INFO - Using real prefix '/usr' 21:26:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:26:08 INFO - Installing distribute.............................................................................................................................................................................................done. 21:26:10 INFO - Installing pip.................done. 21:26:10 INFO - Return code: 0 21:26:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:26:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:26:11 INFO - Reading from file tmpfile_stdout 21:26:11 INFO - Output received: 21:26:11 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) 21:26:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:26:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:26:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:26:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:26:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:11 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 0x7f2cacc98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170b7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179a790>, '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 0x179b690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179bb20>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1476851152.95006-443706985', '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 21:26:11 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 21:26:11 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 21:26:11 INFO - Using env: {'DISPLAY': ':0', 21:26:11 INFO - 'HOME': '/home/cltbld', 21:26:11 INFO - 'LANG': 'en_US.UTF-8', 21:26:11 INFO - 'LANGUAGE': 'en_US:en', 21:26:11 INFO - 'LOGNAME': 'cltbld', 21:26:11 INFO - 'MAIL': '/var/mail/cltbld', 21:26:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:26:11 INFO - 'MOZ_NO_REMOTE': '1', 21:26:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:26:11 INFO - 'NO_EM_RESTART': '1', 21:26:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:26:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:26:11 INFO - 'PWD': '/builds/slave/test', 21:26:11 INFO - 'SHELL': '/bin/bash', 21:26:11 INFO - 'SHLVL': '1', 21:26:11 INFO - 'TERM': 'linux', 21:26:11 INFO - 'TMOUT': '86400', 21:26:11 INFO - 'USER': 'cltbld', 21:26:11 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1476851152.95006-443706985', 21:26:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:26:11 INFO - '_': '/tools/buildbot/bin/python'} 21:26:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:26:11 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 21:26:11 INFO - Cleaning up... 21:26:11 INFO - Return code: 0 21:26:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:26:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:26:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:26:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:26:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:11 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 0x7f2cacc98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170b7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179a790>, '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 0x179b690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179bb20>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1476851152.95006-443706985', '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 21:26:11 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 21:26:11 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 21:26:11 INFO - Using env: {'DISPLAY': ':0', 21:26:11 INFO - 'HOME': '/home/cltbld', 21:26:11 INFO - 'LANG': 'en_US.UTF-8', 21:26:11 INFO - 'LANGUAGE': 'en_US:en', 21:26:11 INFO - 'LOGNAME': 'cltbld', 21:26:11 INFO - 'MAIL': '/var/mail/cltbld', 21:26:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:26:11 INFO - 'MOZ_NO_REMOTE': '1', 21:26:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:26:11 INFO - 'NO_EM_RESTART': '1', 21:26:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:26:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:26:11 INFO - 'PWD': '/builds/slave/test', 21:26:11 INFO - 'SHELL': '/bin/bash', 21:26:11 INFO - 'SHLVL': '1', 21:26:11 INFO - 'TERM': 'linux', 21:26:11 INFO - 'TMOUT': '86400', 21:26:11 INFO - 'USER': 'cltbld', 21:26:11 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1476851152.95006-443706985', 21:26:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:26:11 INFO - '_': '/tools/buildbot/bin/python'} 21:26:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:26:11 INFO - Downloading/unpacking psutil>=3.1.1 21:26:11 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 21:26:11 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 21:26:11 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 21:26:11 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 21:26:11 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 21:26:11 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 21:26:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:26:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:26:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:26:13 INFO - Installing collected packages: psutil 21:26:13 INFO - Running setup.py install for psutil 21:26:13 INFO - building 'psutil._psutil_linux' extension 21:26:13 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 21:26:13 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 21:26:13 INFO - building 'psutil._psutil_posix' extension 21:26:13 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 21:26:13 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 21:26:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:26:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:26:14 INFO - Successfully installed psutil 21:26:14 INFO - Cleaning up... 21:26:14 INFO - Return code: 0 21:26:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:26:14 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')]} 21:26:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:26:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:14 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')]} 21:26:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:26:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:14 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 0x7f2cacc98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170b7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179a790>, '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 0x179b690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179bb20>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1476851152.95006-443706985', '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 21:26:14 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 21:26:14 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 21:26:14 INFO - Using env: {'DISPLAY': ':0', 21:26:14 INFO - 'HOME': '/home/cltbld', 21:26:14 INFO - 'LANG': 'en_US.UTF-8', 21:26:14 INFO - 'LANGUAGE': 'en_US:en', 21:26:14 INFO - 'LOGNAME': 'cltbld', 21:26:14 INFO - 'MAIL': '/var/mail/cltbld', 21:26:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:26:14 INFO - 'MOZ_NO_REMOTE': '1', 21:26:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:26:14 INFO - 'NO_EM_RESTART': '1', 21:26:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:26:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:26:14 INFO - 'PWD': '/builds/slave/test', 21:26:14 INFO - 'SHELL': '/bin/bash', 21:26:14 INFO - 'SHLVL': '1', 21:26:14 INFO - 'TERM': 'linux', 21:26:14 INFO - 'TMOUT': '86400', 21:26:14 INFO - 'USER': 'cltbld', 21:26:14 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1476851152.95006-443706985', 21:26:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:26:14 INFO - '_': '/tools/buildbot/bin/python'} 21:26:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:26:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:26:14 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 21:26:14 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 21:26:14 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 21:26:14 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 21:26:14 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 21:26:14 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 21:26:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:26:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:26:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:26:16 INFO - Installing collected packages: mozsystemmonitor 21:26:16 INFO - Running setup.py install for mozsystemmonitor 21:26:16 INFO - Successfully installed mozsystemmonitor 21:26:16 INFO - Cleaning up... 21:26:16 INFO - Return code: 0 21:26:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:26:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:26:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:26:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:26:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2cacc98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170b7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179a790>, '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 0x179b690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179bb20>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1476851152.95006-443706985', '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 21:26:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:26:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:26:16 INFO - Using env: {'DISPLAY': ':0', 21:26:16 INFO - 'HOME': '/home/cltbld', 21:26:16 INFO - 'LANG': 'en_US.UTF-8', 21:26:16 INFO - 'LANGUAGE': 'en_US:en', 21:26:16 INFO - 'LOGNAME': 'cltbld', 21:26:16 INFO - 'MAIL': '/var/mail/cltbld', 21:26:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:26:16 INFO - 'MOZ_NO_REMOTE': '1', 21:26:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:26:16 INFO - 'NO_EM_RESTART': '1', 21:26:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:26:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:26:16 INFO - 'PWD': '/builds/slave/test', 21:26:16 INFO - 'SHELL': '/bin/bash', 21:26:16 INFO - 'SHLVL': '1', 21:26:16 INFO - 'TERM': 'linux', 21:26:16 INFO - 'TMOUT': '86400', 21:26:16 INFO - 'USER': 'cltbld', 21:26:16 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1476851152.95006-443706985', 21:26:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:26:16 INFO - '_': '/tools/buildbot/bin/python'} 21:26:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:26:16 INFO - Downloading/unpacking jsonschema==2.5.1 21:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:26:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:26:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:26:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:26:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:26:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:26:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:26:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:26:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:26:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:26:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:26:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:26:18 INFO - Downloading functools32-3.2.3-2.tar.gz 21:26:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:26:18 INFO - warning: no files found matching '*.txt' 21:26:18 INFO - no previously-included directories found matching 'build' 21:26:18 INFO - no previously-included directories found matching 'dist' 21:26:18 INFO - no previously-included directories found matching '.git*' 21:26:18 INFO - Installing collected packages: jsonschema, functools32 21:26:18 INFO - Running setup.py install for functools32 21:26:18 INFO - warning: no files found matching '*.txt' 21:26:18 INFO - no previously-included directories found matching 'build' 21:26:18 INFO - no previously-included directories found matching 'dist' 21:26:18 INFO - no previously-included directories found matching '.git*' 21:26:18 INFO - Successfully installed jsonschema functools32 21:26:18 INFO - Cleaning up... 21:26:19 INFO - Return code: 0 21:26:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:26: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')]} 21:26:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:26:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26: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')]} 21:26:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:26:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26: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', '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 0x7f2cacc98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170b7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179a790>, '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 0x179b690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179bb20>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1476851152.95006-443706985', '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 21:26: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:26: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 functools32==3.2.3-2 21:26:19 INFO - Using env: {'DISPLAY': ':0', 21:26:19 INFO - 'HOME': '/home/cltbld', 21:26:19 INFO - 'LANG': 'en_US.UTF-8', 21:26:19 INFO - 'LANGUAGE': 'en_US:en', 21:26:19 INFO - 'LOGNAME': 'cltbld', 21:26:19 INFO - 'MAIL': '/var/mail/cltbld', 21:26:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:26:19 INFO - 'MOZ_NO_REMOTE': '1', 21:26:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:26:19 INFO - 'NO_EM_RESTART': '1', 21:26:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:26:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:26:19 INFO - 'PWD': '/builds/slave/test', 21:26:19 INFO - 'SHELL': '/bin/bash', 21:26:19 INFO - 'SHLVL': '1', 21:26:19 INFO - 'TERM': 'linux', 21:26:19 INFO - 'TMOUT': '86400', 21:26:19 INFO - 'USER': 'cltbld', 21:26:19 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1476851152.95006-443706985', 21:26:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:26:19 INFO - '_': '/tools/buildbot/bin/python'} 21:26:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:26:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:26:19 INFO - Cleaning up... 21:26:19 INFO - Return code: 0 21:26:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:26: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')]} 21:26:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:26:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26: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')]} 21:26:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:26:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26: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', '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 0x7f2cacc98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170b7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179a790>, '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 0x179b690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179bb20>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1476851152.95006-443706985', '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 21:26: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:26: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 blobuploader==1.2.4 21:26:19 INFO - Using env: {'DISPLAY': ':0', 21:26:19 INFO - 'HOME': '/home/cltbld', 21:26:19 INFO - 'LANG': 'en_US.UTF-8', 21:26:19 INFO - 'LANGUAGE': 'en_US:en', 21:26:19 INFO - 'LOGNAME': 'cltbld', 21:26:19 INFO - 'MAIL': '/var/mail/cltbld', 21:26:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:26:19 INFO - 'MOZ_NO_REMOTE': '1', 21:26:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:26:19 INFO - 'NO_EM_RESTART': '1', 21:26:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:26:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:26:19 INFO - 'PWD': '/builds/slave/test', 21:26:19 INFO - 'SHELL': '/bin/bash', 21:26:19 INFO - 'SHLVL': '1', 21:26:19 INFO - 'TERM': 'linux', 21:26:19 INFO - 'TMOUT': '86400', 21:26:19 INFO - 'USER': 'cltbld', 21:26:19 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1476851152.95006-443706985', 21:26:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:26:19 INFO - '_': '/tools/buildbot/bin/python'} 21:26:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:26:19 INFO - Downloading/unpacking blobuploader==1.2.4 21:26:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:26:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:26:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:26:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:26:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:26:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:26:21 INFO - Downloading blobuploader-1.2.4.tar.gz 21:26:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:26:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:26:21 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 21:26:21 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 21:26:21 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 21:26:21 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 21:26:21 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 21:26:21 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 21:26:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:26:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:26:21 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 21:26:21 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 21:26:21 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 21:26:21 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 21:26:21 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 21:26:21 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 21:26:22 INFO - Downloading docopt-0.6.1.tar.gz 21:26:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:26:22 INFO - Installing collected packages: blobuploader, requests, docopt 21:26:22 INFO - Running setup.py install for blobuploader 21:26:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:26:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:26:22 INFO - Running setup.py install for requests 21:26:22 INFO - Running setup.py install for docopt 21:26:22 INFO - Successfully installed blobuploader requests docopt 21:26:22 INFO - Cleaning up... 21:26:22 INFO - Return code: 0 21:26:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:26: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')]} 21:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:26:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26: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')]} 21:26:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:26:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:22 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 0x7f2cacc98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170b7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179a790>, '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 0x179b690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179bb20>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1476851152.95006-443706985', '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 21:26:22 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 21:26:22 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 21:26:22 INFO - Using env: {'DISPLAY': ':0', 21:26:22 INFO - 'HOME': '/home/cltbld', 21:26:22 INFO - 'LANG': 'en_US.UTF-8', 21:26:22 INFO - 'LANGUAGE': 'en_US:en', 21:26:22 INFO - 'LOGNAME': 'cltbld', 21:26:22 INFO - 'MAIL': '/var/mail/cltbld', 21:26:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:26:22 INFO - 'MOZ_NO_REMOTE': '1', 21:26:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:26:22 INFO - 'NO_EM_RESTART': '1', 21:26:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:26:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:26:22 INFO - 'PWD': '/builds/slave/test', 21:26:22 INFO - 'SHELL': '/bin/bash', 21:26:22 INFO - 'SHLVL': '1', 21:26:22 INFO - 'TERM': 'linux', 21:26:22 INFO - 'TMOUT': '86400', 21:26:22 INFO - 'USER': 'cltbld', 21:26:22 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1476851152.95006-443706985', 21:26:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:26:22 INFO - '_': '/tools/buildbot/bin/python'} 21:26:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:26:23 INFO - Running setup.py (path:/tmp/pip-vnWXWd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:26:23 INFO - Running setup.py (path:/tmp/pip-m0Xzlc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:26:23 INFO - Running setup.py (path:/tmp/pip-mOwKE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:26:23 INFO - Running setup.py (path:/tmp/pip-ZrbS2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:26:23 INFO - Running setup.py (path:/tmp/pip-q6IoLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:26:23 INFO - Running setup.py (path:/tmp/pip-YHYRZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:26:23 INFO - Running setup.py (path:/tmp/pip-W1e7G3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:26:23 INFO - Running setup.py (path:/tmp/pip-VHfGMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:26:23 INFO - Running setup.py (path:/tmp/pip-1p9mEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:26:23 INFO - Running setup.py (path:/tmp/pip-Ub88TY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:26:23 INFO - Running setup.py (path:/tmp/pip-WCkZt1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:26:23 INFO - Running setup.py (path:/tmp/pip-vUupvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:26:23 INFO - Running setup.py (path:/tmp/pip-v4mLRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:26:23 INFO - Running setup.py (path:/tmp/pip-Es1CNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:26:24 INFO - Running setup.py (path:/tmp/pip-JRLZ_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:26:24 INFO - Running setup.py (path:/tmp/pip-OIetx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:26:24 INFO - Running setup.py (path:/tmp/pip-SoQCfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:26:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:26:24 INFO - Running setup.py install for manifestparser 21:26:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:26:24 INFO - Running setup.py install for mozcrash 21:26:24 INFO - Running setup.py install for mozdebug 21:26:24 INFO - Running setup.py install for mozdevice 21:26:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:26:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:26:24 INFO - Running setup.py install for mozfile 21:26:24 INFO - Running setup.py install for mozhttpd 21:26:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:26:24 INFO - Running setup.py install for mozinfo 21:26:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:26:24 INFO - Running setup.py install for mozInstall 21:26:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:26:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:26:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:26:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:26:25 INFO - Running setup.py install for mozleak 21:26:25 INFO - Running setup.py install for mozlog 21:26:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:26:25 INFO - Running setup.py install for moznetwork 21:26:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:26:25 INFO - Running setup.py install for mozprocess 21:26:25 INFO - Running setup.py install for mozprofile 21:26:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:26:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:26:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:26:25 INFO - Running setup.py install for mozrunner 21:26:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:26:25 INFO - Running setup.py install for mozscreenshot 21:26:25 INFO - Running setup.py install for moztest 21:26:25 INFO - Running setup.py install for mozversion 21:26:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:26:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:26:26 INFO - Cleaning up... 21:26:26 INFO - Return code: 0 21:26:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:26:26 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')]} 21:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:26:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:26 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')]} 21:26:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:26:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:26 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 0x7f2cacc98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170b7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179a790>, '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 0x179b690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179bb20>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1476851152.95006-443706985', '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 21:26:26 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 21:26:26 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 21:26:26 INFO - Using env: {'DISPLAY': ':0', 21:26:26 INFO - 'HOME': '/home/cltbld', 21:26:26 INFO - 'LANG': 'en_US.UTF-8', 21:26:26 INFO - 'LANGUAGE': 'en_US:en', 21:26:26 INFO - 'LOGNAME': 'cltbld', 21:26:26 INFO - 'MAIL': '/var/mail/cltbld', 21:26:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:26:26 INFO - 'MOZ_NO_REMOTE': '1', 21:26:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:26:26 INFO - 'NO_EM_RESTART': '1', 21:26:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:26:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:26:26 INFO - 'PWD': '/builds/slave/test', 21:26:26 INFO - 'SHELL': '/bin/bash', 21:26:26 INFO - 'SHLVL': '1', 21:26:26 INFO - 'TERM': 'linux', 21:26:26 INFO - 'TMOUT': '86400', 21:26:26 INFO - 'USER': 'cltbld', 21:26:26 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1476851152.95006-443706985', 21:26:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:26:26 INFO - '_': '/tools/buildbot/bin/python'} 21:26:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:26:26 INFO - Running setup.py (path:/tmp/pip-1dLSYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:26:26 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)) 21:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:26:26 INFO - Running setup.py (path:/tmp/pip-pBsJBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:26:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:26:26 INFO - Running setup.py (path:/tmp/pip-cIOTZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:26:26 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)) 21:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:26:26 INFO - Running setup.py (path:/tmp/pip-jQNWzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:26:26 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)) 21:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:26:26 INFO - Running setup.py (path:/tmp/pip-41EUHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:26:26 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)) 21:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:26:26 INFO - Running setup.py (path:/tmp/pip-04FnrU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:26:26 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)) 21:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:26:26 INFO - Running setup.py (path:/tmp/pip-PA2qbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:26:26 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)) 21:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:26:26 INFO - Running setup.py (path:/tmp/pip-UzHmy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:26:26 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)) 21:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:26:26 INFO - Running setup.py (path:/tmp/pip-BWRKNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:26:26 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)) 21:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:26:26 INFO - Running setup.py (path:/tmp/pip-AUrapx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:26:26 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)) 21:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:26:26 INFO - Running setup.py (path:/tmp/pip-rButcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:26:27 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)) 21:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:26:27 INFO - Running setup.py (path:/tmp/pip-f_stLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:26:27 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)) 21:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:26:27 INFO - Running setup.py (path:/tmp/pip-CngqHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:26:27 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)) 21:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:26:27 INFO - Running setup.py (path:/tmp/pip-RbRtj8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:26:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:26:27 INFO - Running setup.py (path:/tmp/pip-QWXQet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:26:27 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)) 21:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:26:27 INFO - Running setup.py (path:/tmp/pip-VoYx43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:26:27 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)) 21:26:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:26:27 INFO - Running setup.py (path:/tmp/pip-PoNKQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:26:27 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)) 21:26:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:26:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:26:27 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)) 21:26:27 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)) 21:26:27 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)) 21:26:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:26: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 21:26: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 21:26: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 21:26: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 21:26: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 21:26: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 21:26:29 INFO - Downloading blessings-1.6.tar.gz 21:26:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:26:29 INFO - Installing collected packages: blessings 21:26:29 INFO - Running setup.py install for blessings 21:26:29 INFO - Successfully installed blessings 21:26:29 INFO - Cleaning up... 21:26:29 INFO - Return code: 0 21:26:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:26:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:26:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:26:29 INFO - Reading from file tmpfile_stdout 21:26:29 INFO - Current package versions: 21:26:29 INFO - argparse == 1.2.1 21:26:29 INFO - blessings == 1.6 21:26:29 INFO - blobuploader == 1.2.4 21:26:29 INFO - docopt == 0.6.1 21:26:29 INFO - functools32 == 3.2.3-2 21:26:29 INFO - jsonschema == 2.5.1 21:26:29 INFO - manifestparser == 1.1 21:26:29 INFO - mozInstall == 1.12 21:26:29 INFO - mozcrash == 0.17 21:26:29 INFO - mozdebug == 0.1 21:26:29 INFO - mozdevice == 0.48 21:26:29 INFO - mozfile == 1.2 21:26:29 INFO - mozhttpd == 0.7 21:26:29 INFO - mozinfo == 0.9 21:26:29 INFO - mozleak == 0.1 21:26:29 INFO - mozlog == 3.4 21:26:29 INFO - moznetwork == 0.27 21:26:29 INFO - mozprocess == 0.23 21:26:29 INFO - mozprofile == 0.28 21:26:29 INFO - mozrunner == 6.12 21:26:29 INFO - mozscreenshot == 0.1 21:26:29 INFO - mozsystemmonitor == 0.3 21:26:29 INFO - moztest == 0.7 21:26:29 INFO - mozversion == 1.4 21:26:29 INFO - psutil == 3.1.1 21:26:29 INFO - requests == 1.2.3 21:26:29 INFO - wsgiref == 0.1.2 21:26:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:26:29 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')]} 21:26:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:26:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:29 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')]} 21:26:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:26:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:29 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 0x7f2cacc98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170b7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179a790>, '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 0x179b690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179bb20>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1476851152.95006-443706985', '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 21:26:29 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 21:26:29 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 21:26:29 INFO - Using env: {'DISPLAY': ':0', 21:26:29 INFO - 'HOME': '/home/cltbld', 21:26:29 INFO - 'LANG': 'en_US.UTF-8', 21:26:29 INFO - 'LANGUAGE': 'en_US:en', 21:26:29 INFO - 'LOGNAME': 'cltbld', 21:26:29 INFO - 'MAIL': '/var/mail/cltbld', 21:26:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:26:29 INFO - 'MOZ_NO_REMOTE': '1', 21:26:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:26:29 INFO - 'NO_EM_RESTART': '1', 21:26:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:26:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:26:29 INFO - 'PWD': '/builds/slave/test', 21:26:29 INFO - 'SHELL': '/bin/bash', 21:26:29 INFO - 'SHLVL': '1', 21:26:29 INFO - 'TERM': 'linux', 21:26:29 INFO - 'TMOUT': '86400', 21:26:29 INFO - 'USER': 'cltbld', 21:26:29 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1476851152.95006-443706985', 21:26:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:26:29 INFO - '_': '/tools/buildbot/bin/python'} 21:26:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:26:30 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)) 21:26:30 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)) 21:26:30 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)) 21:26:30 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)) 21:26:30 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)) 21:26:30 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)) 21:26:30 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)) 21:26:30 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)) 21:26:30 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)) 21:26:30 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)) 21:26:30 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)) 21:26:30 INFO - Cleaning up... 21:26:30 INFO - Return code: 0 21:26:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:26:30 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')]} 21:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:26:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:30 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')]} 21:26:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:26:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:26:30 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 0x7f2cacc98f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x163f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x170b7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179a790>, '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 0x179b690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179bb20>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1476851152.95006-443706985', '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 21:26:30 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 21:26:30 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 21:26:30 INFO - Using env: {'DISPLAY': ':0', 21:26:30 INFO - 'HOME': '/home/cltbld', 21:26:30 INFO - 'LANG': 'en_US.UTF-8', 21:26:30 INFO - 'LANGUAGE': 'en_US:en', 21:26:30 INFO - 'LOGNAME': 'cltbld', 21:26:30 INFO - 'MAIL': '/var/mail/cltbld', 21:26:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:26:30 INFO - 'MOZ_NO_REMOTE': '1', 21:26:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:26:30 INFO - 'NO_EM_RESTART': '1', 21:26:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:26:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:26:30 INFO - 'PWD': '/builds/slave/test', 21:26:30 INFO - 'SHELL': '/bin/bash', 21:26:30 INFO - 'SHLVL': '1', 21:26:30 INFO - 'TERM': 'linux', 21:26:30 INFO - 'TMOUT': '86400', 21:26:30 INFO - 'USER': 'cltbld', 21:26:30 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1476851152.95006-443706985', 21:26:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:26:30 INFO - '_': '/tools/buildbot/bin/python'} 21:26:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:26:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:26:30 INFO - Cleaning up... 21:26:30 INFO - Return code: 0 21:26:30 INFO - Running post-action listener: _resource_record_post_action 21:26:30 INFO - Running post-action listener: _start_resource_monitoring 21:26:30 INFO - Starting resource monitoring. 21:26:30 INFO - [mozharness: 2016-10-19 04:26:30.354531Z] Finished create-virtualenv step (success) 21:26:30 INFO - [mozharness: 2016-10-19 04:26:30.354996Z] Running install step. 21:26:30 INFO - Running pre-action listener: _resource_record_pre_action 21:26:30 INFO - Running main action method: install 21:26:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:26:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:26:30 INFO - Reading from file tmpfile_stdout 21:26:30 INFO - Detecting whether we're running mozinstall >=1.0... 21:26:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:26:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:26:30 INFO - Reading from file tmpfile_stdout 21:26:30 INFO - Output received: 21:26:30 INFO - Usage: mozinstall [options] installer 21:26:30 INFO - Options: 21:26:30 INFO - -h, --help show this help message and exit 21:26:30 INFO - -d DEST, --destination=DEST 21:26:30 INFO - Directory to install application into. [default: 21:26:30 INFO - "/builds/slave/test"] 21:26:30 INFO - --app=APP Application being installed. [default: firefox] 21:26:30 INFO - mkdir: /builds/slave/test/build/application 21:26:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:26:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:26:47 INFO - Reading from file tmpfile_stdout 21:26:47 INFO - Output received: 21:26:47 INFO - /builds/slave/test/build/application/firefox/firefox 21:26:47 INFO - Running post-action listener: _resource_record_post_action 21:26:47 INFO - [mozharness: 2016-10-19 04:26:47.607404Z] Finished install step (success) 21:26:47 INFO - [mozharness: 2016-10-19 04:26:47.607738Z] Running run-tests step. 21:26:47 INFO - Running pre-action listener: _resource_record_pre_action 21:26:47 INFO - Running main action method: run_tests 21:26:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:26:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:26:47 INFO - Python 2.7.3 21:26:47 INFO - Return code: 0 21:26:47 INFO - grabbing minidump binary from tooltool 21:26:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:26:47 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x179a790>, '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 0x179b690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x179bb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:26:47 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 21:26:47 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 21:26:47 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 21:26:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:26:47 INFO - Return code: 0 21:26:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:26:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:26:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:26:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:26:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:26:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dZ7YqQnzQyS6U6iKAiGnRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 21:26:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dZ7YqQnzQyS6U6iKAiGnRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 21:26:47 INFO - Using env: {'DISPLAY': ':0', 21:26:47 INFO - 'HOME': '/home/cltbld', 21:26:47 INFO - 'LANG': 'en_US.UTF-8', 21:26:47 INFO - 'LANGUAGE': 'en_US:en', 21:26:47 INFO - 'LOGNAME': 'cltbld', 21:26:47 INFO - 'MAIL': '/var/mail/cltbld', 21:26:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:26:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:26:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:26:47 INFO - 'MOZ_NO_REMOTE': '1', 21:26:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:26:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:26:47 INFO - 'NO_EM_RESTART': '1', 21:26:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:26:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:26:47 INFO - 'PWD': '/builds/slave/test', 21:26:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:26:47 INFO - 'SHELL': '/bin/bash', 21:26:47 INFO - 'SHLVL': '1', 21:26:47 INFO - 'TERM': 'linux', 21:26:47 INFO - 'TMOUT': '86400', 21:26:47 INFO - 'USER': 'cltbld', 21:26:47 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1476851152.95006-443706985', 21:26:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:26:47 INFO - '_': '/tools/buildbot/bin/python'} 21:26:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dZ7YqQnzQyS6U6iKAiGnRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 21:26:47 INFO - mozversion application_buildid: 20161018183007 21:26:47 INFO - mozversion application_changeset: 12a9cca092f816fabb67cc8a139e0cbd5b1cea37 21:26:47 INFO - mozversion application_display_name: Nightly 21:26:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:26:47 INFO - mozversion application_name: Firefox 21:26:47 INFO - mozversion application_remotingname: firefox 21:26:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:26:47 INFO - mozversion application_vendor: Mozilla 21:26:47 INFO - mozversion application_version: 52.0a1 21:26:47 INFO - mozversion platform_buildid: 20161018183007 21:26:47 INFO - mozversion platform_changeset: 12a9cca092f816fabb67cc8a139e0cbd5b1cea37 21:26:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:26:47 INFO - mozversion platform_version: 52.0a1 21:26:47 INFO - using testdate: 1476851207 21:26:47 INFO - actual date: 1476851207 21:26:47 INFO - starting webserver on 'localhost:47317' 21:26:47 INFO - SUITE-START | Running 2 tests 21:26:47 INFO - TEST-START | dromaeo_css 21:26:47 INFO - operating with platform_type : linux_ 21:26:47 INFO - Initialising browser for dromaeo_css test... 21:26:47 INFO - TEST-INFO | started process 3020 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeHNDC3/profile http://localhost:47317/getInfo.html) 21:26:51 INFO - PROCESS | 3020 | __metrics Screen width/height:1600/1200 21:26:51 INFO - PROCESS | 3020 | colorDepth:24 21:26:51 INFO - PROCESS | 3020 | Browser inner width/height: 1024/697 21:26:51 INFO - PROCESS | 3020 | __metrics 21:26:52 INFO - PROCESS | 3020 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:26:52 INFO - PROCESS | 3020 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:26:53 INFO - PROCESS | 3020 | console.error: PushService: 21:26:53 INFO - PROCESS | 3020 | stateChangeProcessEnqueue: Error transitioning state 21:26:53 INFO - PROCESS | 3020 | UnknownError 21:26:53 INFO - TEST-INFO | 3020: exit 0 21:26:53 INFO - Browser initialized. 21:26:53 INFO - Running cycle 1/1 for dromaeo_css test... 21:26:53 INFO - TEST-INFO | started process 3106 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeHNDC3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:27:05 INFO - PROCESS | 3106 | RSS: Main: 171970560 21:27:05 INFO - PROCESS | 3106 | 21:27:57 INFO - PROCESS | 3106 | 1476851277419 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] 21:30:06 INFO - PROCESS | 3106 | Cycle 1(1): loaded http://localhost:47317/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47317/tests/dromaeo/cssquery-ext.html) 21:30:09 INFO - PROCESS | 3106 | RSS: Main: 384221184 21:30:09 INFO - PROCESS | 3106 | 21:33:12 INFO - PROCESS | 3106 | Cycle 1(1): loaded http://localhost:47317/tests/dromaeo/cssquery-ext.html (next: http://localhost:47317/tests/dromaeo/cssquery-jquery.html) 21:33:12 INFO - PROCESS | 3106 | RSS: Main: 277360640 21:33:12 INFO - PROCESS | 3106 | 21:36:14 INFO - PROCESS | 3106 | Cycle 1(1): loaded http://localhost:47317/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47317/tests/dromaeo/cssquery-mootools.html) 21:36:15 INFO - PROCESS | 3106 | RSS: Main: 253599744 21:36:15 INFO - PROCESS | 3106 | 21:39:17 INFO - PROCESS | 3106 | Cycle 1(1): loaded http://localhost:47317/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47317/tests/dromaeo/cssquery-prototype.html) 21:39:18 INFO - PROCESS | 3106 | RSS: Main: 217694208 21:39:18 INFO - PROCESS | 3106 | 21:42:20 INFO - PROCESS | 3106 | Cycle 1(1): loaded http://localhost:47317/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47317/tests/dromaeo/cssquery-yui.html) 21:42:21 INFO - PROCESS | 3106 | RSS: Main: 218144768 21:42:21 INFO - PROCESS | 3106 | 21:45:24 INFO - PROCESS | 3106 | Cycle 1(1): loaded http://localhost:47317/tests/dromaeo/cssquery-yui.html (next: http://localhost:47317/tests/dromaeo/cssquery-dojo.html) 21:45:24 INFO - PROCESS | 3106 | RSS: Main: 309391360 21:45:24 INFO - PROCESS | 3106 | 21:45:24 INFO - PROCESS | 3106 | __start_tp_report 21:45:24 INFO - PROCESS | 3106 | _x_x_mozilla_page_load 21:45:24 INFO - PROCESS | 3106 | _x_x_mozilla_page_load_details 21:45:24 INFO - PROCESS | 3106 | |i|pagename|runs| 21:45:24 INFO - PROCESS | 3106 | |0;dojo.html;3031.393721255749;3053.694630536948;3080.845957702115;3090.35102628448;3091.0881290019443;5137.845864624058;5221.112410890149;5229.712365819878;5271.209318602207;5327.520523152915;5258.13240815265;5266.657667251636;5345.251664766935;5372.462753724625;5430.266913966613;4807.591354734852;4823.324734537167;4859.1010663027455;4873.512648735134;4908.435529914052;4882.218844984804;4895.31465594817;4934.876628084291;4936.629752768539;5002.274670172823;4727.125481785881;4862.246351815475;4866.270059491069;4894.36373271476;4979.377577802775;4773.284007398884;4828.517148285144;4840.951590484121;4883.975580122112;4889.046635906;4833.564979151894;4842.104210721028;4846.176150054499;4868.610511159099;4905.632077594195;5320.228566857822;5330.413654498002;5331.600129990266;5334.306540149794;5348.465153484659;5458.208559758813;5510.779568817243;5587.469190426903;5652.180433837112;5668.291463567054;5691.630044047124;5699.487046165865;5701.629394089371;5770.365259821417;5777.335606405233;5296.046711591912;5298.894022119536;5302.946970530284;5303.124984377611;5305.946940530545;5550.417206193372;5554.028045092093;5770.596058275964;5783.902417175546;5856.707164641751;5488.4785945335125;5491;5507.228987941691;5524.475174858382;5532.1425179096495;5502.174673798962;5523.558115350762;5635.549156067505;5639.238702775073;5642.85892852682;5439.401665816757;5621.0444224481935;5631.1271752878365;5635.633683810539;5636.267285252891;5491.670499770026;5561.555075593943;5600.355959064678;5618.016847051749;5686.914696279559;4305.289627211538;4322.762248076323;4326.286162783105;4328.718633288826;4385.6710746694125;3866.7099967501986;3885.825137868803;3891.163399868985;3917;3929.4302326162547;5240.3973543042275;5308.177232528964;5336.759845806948;5394.568434525228;5400.648957817729;5697.544196464273;5703.914441283384;5703.971480142573;5704.286964129484;5758.596898217084;5366;5390.110631745718;5408.783648654088;5415.972920135374;5419.458054194628;4805.471398146201;4858.854234372974;4913.11563918491;4940.925886111711;4973.651844370859;5924.11138329254;5933.436323549256;5950.702464876739;5990.610610310316;5992.8801423972145;5639.661620302795;5666.660000399825;5690;5706.115552089433;5707.771689132388;5743.224664670216;5804.361520232856;5893.116032595145;5900.43945825146;5901.350851406256;5491.725413729378;5534.833954981357;5548.278723765885;5552.639078459887;5553.250311208097;5652.236948011966;5660.179274005329;5664.150377443417;5668.03643380618;5668.489835914787;5531.170324451365;5558.44415558441;5573.331200255833;5573.5819813513335;5575.721213939206;5470.370907345706;5532.91700624499;5537;5537.363203231519;5542.61201715876;5453.618246722692;5457.154141108134;5476.780928762805;5477.041517734301;5478.096114141122;5510.6969116698965;5520.53075488588;5541.418151094238;5541.584381171348;5560.694161821139;5463.371712253142;5465.6447330923365;5474.644148130359;5476.2333273342565;5478.45215478449 21:45:24 INFO - PROCESS | 3106 | |1;ext.html;587.4125874125874;620.1442010026165;645.3159650770184;648.4747354642736;661.583202582373;37751.24497510048;41578;41587.58412415875;41591.79204103983;41640.791796041056;41364.58635413645;41651;41694;41904;41991.370129448085;7982.840343193133;8225.218604232588;8635.740927772176;8803.911960880405;8809.603567839462;10402.115820155295;10660.413677247749;10665.946670266676;11006.119510439146;11032.944835275812;10419.947900260488;10471.947640261787;10472.842907356358;10473.423961682105;10485;10645.78708425831;10682;10712.25014249003;10719.517621706964;10725.624603138853;10495;10589.788204235872;10662.147028237723;10663.573457061708;10664.946675266652;40843.18313633741;41191.588084119074;41203;41224.1755164898;41263.38104928428;3189.378071276102;3223.693749093832;3320.2529430877858;3620.6922411595046;3640.271945610862;30879.536806947915;31581.36837263265;31739.206519836956;31870.20324491883;31898.362032759214;4146.1914926589325;4156.9792151039055;4281.464816897887;4285.164392943378;4293.313069908831;213571;217230;217583;217678;219270;54941;55553.444465555636;55749.44250557443;55801.44198558044;55919;59266;59346.70326648339;59371.3131636301;59412.70293648504;59489.70255148697;13181.275029873448;13300.401481933337;13303.600891973256;13305.600831975056;13320.866791331962;8807.427517211361;8989.146031127033;10297.12474439666;10355.17158627308;10627.36235825853;16541.25564349607;16707.248173832206;16795.496135115965;16823.495295141165;17016.48950531486;6175.320714721377;6311.526635502356;6323.430891219812;6416.422521973045;6472.126262954535;805.4804651000072;967.72272510719;1025.9894004405655;1077.5258886090096;1115.3921112993437;30402.69597304043;30709.84645076805;30859.537106943415;30957.8452107738;31330.68669313278;981.8625392445064;1019.9541020654088;1076.208986394999;1089.0144419300545;1091.5524634899652;15502.84497155014;16265.268062937197;16372;16403.261853216634;16725.6654866902;411695;412597;414150;415129;416020;55218;55312.72343638336;55322.17016744752;55330.17004744932;55388.16917746237;1175.6002958993813;1245.1097465312164;1261.426051146726;1276.6808297925518;1291.992246048084;28135.106898809103;31670.208244794063;31767.364652706354;31876.203094922814;32419.18952026218;48634.78413039702;49263.75368123136;49346.25980610222;49383;49408.75295623499;330623;332706;332814;333037;333319;26320.605190922535;26913.461730765666;27135.45729085368;28145;39919.60080399159;44759;45118;45255.77372113118;45869.31196032129;46521;37998.43002355022;38056.98169793181;38610.227795444494;39727.60272397239;39891.60108398879;38440.61559384482;38732.6126738729;38773.612263877;39422.40866386949;39641;38116.237675245786;38923.80538097292;39251.607483924796;39307;39362;32402.51396229011;34533.65466345405;34657;35256.47115293324;35580.441955804214;25635.35911602225;25803.183935328354;25982.87008564945;26010.309329893495;26641.86679066592 21:45:24 INFO - PROCESS | 3106 | |2;jquery.html;362.51242079403227;375.318796384562;385.79745633542393;387.9262940041392;411.9979400102999;14123.788143177848;14568.344424500896;17193.656126877457;19188.424347269603;20146.89926550369;17875.19561619727;18129.818701813012;18311.267549298012;18449.631007379845;18874.43376698698;5598.888022239553;5847.5614328925285;5849.385814489481;5850.063989761617;5861.677607731573;4861.003494283664;5789.681567513785;5823.970880145594;5825.592208545403;5834.737436815353;5552.555795536347;5781.913271300934;5788.450097240777;5790.623609465392;5794.971025144869;5709.343425506078;5713.400092990239;5747.3677895431465;5756.079027355603;5773.018586840247;4896.485868983741;4963.3299504566785;5118.4625614310335;5154.123798954187;5164.509371609691;22462.550748985093;22671.979760910635;22738;22796.316110516713;22994.19520316781;2189.868607883532;2318.2233951626226;2358.870262135582;2514.937126571832;2895.290653789835;13930.93034534831;14594.70810583793;14812.407503699838;14838.480653177196;15602.219889005504;2064.8451366147447;2117.6188286108495;2144.2709478777133;2147.881866497342;2165.805077543013;86306.56846715727;87707.56146219291;89500.55249723709;90177;90333;16979.660406791794;17052.744208836877;17099.23053462597;17193.57016074608;17410.60271315896;30844.0746777597;30892.69107308943;31003.844980774953;31091;31322.06033818989;8424.452410593292;8697.95651021741;8759.386842920934;8922.197002269826;8995.100489950952;6935.618540980194;7059.647017649097;7081.150261968597;7223.963880180566;7268.345848873627;8304.211099945496;8358.373122015873;8523.531205783742;8601.5699215039;8674.21932026108;3302.8678852846097;3355.1444381683004;3388.66216776475;3452.0796833430786;3531.8940431787087;715.4228660154472;892.8526793079199;896.1397058823602;896.4038914122036;899.2311573604604;18905.621887562447;19127.426177214707;19168.424947251606;19517.609647806963;19598;891.3448615267773;932.7108596335158;936.4287784451479;943.3632298198688;955.8136163448061;10210.4384258865;10629.89370106289;10742.78514429707;10783.245172837984;10803.83794243087;318374;321444;321667.3082980458;417889;440541;88639.55680221686;93135.068649314;93163.53418232866;93361;94598;448.52008351064046;462.5952291744791;462.9884252893637;463.2425983516907;464.24328344797766;9952.651657191964;10315.638952636622;10423.94788026055;10467;10634.08354994987;35337.46993795044;37477.6252237485;37860.62139378571;39981.80009099936;40039;47557.492710789855;49287.507124929725;50628.49371506238;53380;53740.46259537511;8002.1997800219515;8304.916950830415;8431.578421078799;8484.533350665773;8781.165789250012;12305.384730763604;13056.804147937599;13121.081524293208;13276;13380.665483362995;11224.15818813576;11262.267952583055;11431.085513159094;11571.479283432098;11705.473253703434;11281.71795705114;11445.942770286096;11574.131940104357;11634.767304653691;11640.476178571815;10831.783364332827;11724.88275117238;11747.823782643438;11794.52821887115;12022.939885300517;7808.219178082147;8110.270075693216;8292.33661307082;8313.916860831314;8351.373646976623;8361.790955226168;11002.614908478485;11140.721481963015;11201;11661.6501504955 21:45:24 INFO - PROCESS | 3106 | |3;mootools.html;1464.4654701034121;1489.873360764335;1635.4357746577434;1727.3263427263362;1790.6418716256744;8019.23817237363;8286;8578.742637720863;9283.44299342039;9298.581563829635;8541.316694664427;8880.333974951873;8938.1508756668;9017.36878418511;9092.136247056536;2247.4606094537276;2275.0217406515194;2291.2209848651455;2293.174457195408;2295.747467778543;1962.9018549072562;2021.6259991901472;2127.6595744680853;2220.311703371952;2271.159670921761;2239.2274665240548;2280.04238219948;2281.2015794471968;2284.4517315844246;2285.394370491821;2155.9892200539052;2157.4822042709716;2213.5904857601395;2214.490667146549;2219.4340443186884;2190.0144934779255;2201.218567408579;2202.449387653087;2233.6426171812595;2272.988635056814;9032.27741780656;9226.58480368385;9226.86159707605;9236.399634023766;9250.491222982733;5166.7674954626755;5266.368035835686;5304.787808487656;5307.124324486455;5313.335833020872;3279.2293810954407;3387.0854869185428;3488.9302213955834;3511.9297614047578;3523.6652518010746;990.5988074829705;1039.2569312941207;1040.8542804007445;1057.1499875218367;1068.2949253492657;12285.938570307091;12318.014558835272;12328.938355308255;12329.321887296195;12336.5065397384;4156.8129434174925;4377.102693947797;4448;4534.523874993144;4547.090222106724;10577.36535807854;10595.94702026485;10602.151827853753;10606.469676516142;10623.52194151265;5193.428722840485;5219.817306394258;5222.556082732935;5225.111731005738;5257.894842103136;4640.419947506562;4739.123262196505;4749.667523273338;4751.382320298409;4757.452892917289;3839.616038396138;3853.9229215415535;3872.361060425055;3947.440760899429;3983.48214732083;1080.8108580998294;1088.8257878739523;1177.1283658982088;1186.5024124218396;1212.7695737809788;798.8202654402713;827.557256867573;884.2704768565959;906.3021473465395;925.1026504290827;5912.645241285537;5960.403959604005;5993.130996005642;6034.1853849730605;6082.695865206722;883.0374891368311;893.2139717048956;902.8961669408102;925.3291363761354;926.6895589977298;4057.736247143926;4203.600657937491;4204.2432362175105;4309.806058727365;4322.438083049184;10789.190810689073;11258.099352051817;11263.155263355282;11285.322880627189;11324.94337528307;11073.390963497084;11178;11195.104391648649;11207.215494915277;11216.102711783038;7940.880886786703;8216.794580135544;8287.12985136564;8303.584820758937;8339.249467547828;6013.338532761481;6034;6049.727762250797;6245.313015568193;6277.654728989949;10317.793644127225;10442.530086146293;10449.022028721778;10464.581416743245;10575.735606609896;9702.563384647567;10039.397636141855;10053.145482633765;10370.896291037296;10508.474576271308;7837.804054898673;7979.680812767424;7984.121746607752;7993.240642138988;8005.3995950305125;8519.361047921308;8600.65597376123;8639.049704532623;8654.394192406722;8708.78228044304;6431.710573024132;7529.548227106391;7775.339096176888;7842.411819113475;7886.014248218973;7531;7714.15144334134;7729.188435214446;7740.109887363025;7862.095858976062;6746.561473504206;6825.1127353443735;6882.793516194522;6891.241963383924;6932;5097.745112744422;5214.582833373397;5273.525382715574;5322.441143679858;5392.433794451683;5372.328458942632;5373.408925018167;5406.459354064562;5496.801536846768;5568.832935011957 21:45:24 INFO - PROCESS | 3106 | |4;prototype.html;318.95056266278726;319.1415093398757;330.18938505967844;333.3399868260843;333.98664053437864;5302.734863256836;5311.73441327934;5326.573874090073;5331.760070796814;5348.304720386344;5249.790008399659;5255.84371438284;5262.763175657095;5274.466107707835;5282.577393808496;3876.341022026262;4177.227212965596;4178.435911151986;4178.477690288706;4185.769782661952;4105.404716316132;4148.875533733978;4157.066963861819;4158.8960275993195;4180.728252663583;4085.8978525536804;4088.4684990951137;4088.8364465421346;4091.8158682859194;4117.21772863155;3856.5179352580926;3960.2673505401594;3992.8802135935966;4094.34490481523;4096.201240758039;3605.1167463971497;3605.56733192016;3606.2607165531267;3607.2965771674535;3619.7104231661406;5159.555324509143;5161.574060191704;5168.198929165986;5171.3535808024;5185.662931909414;4290.721103128318;4358.259095953696;4625.722456652612;4675.298705194214;4677.368555245032;5461.5357694596005;5496.241202815101;5501.284832971728;5507.063799154113;5508.173773933902;3870.606581630611;3870.632289932452;3873.4964454620717;3880.72834901557;3880.8835734927716;5377.516023557899;5658.575606829504;5692.459216374438;5705.6291341063115;5719.428057194289;3920.09837737322;3920.5295364555864;3922.666573341298;3936.4488971544006;3964.663003644665;3992.5608183099835;3995.7202995790017;4004.6395824375945;4004.7196696231567;4006.338954072545;4491.977540112279;4615.484560914309;4617.145828021827;4621.376114224604;4633.401476490605;5501.5323697486165;5528.391876893619;5537.723113844291;5543.168524721244;5552.472515111058;1384.9307534623229;1404.192589261179;1404.3610157378369;1406.3882211238144;1407.5566196648024;837.5393533556642;893.6961433112773;893.7631527645179;909.4588719711761;914.7255823253131;4726.480087190406;4726.574608285271;4732.574068333866;4734.384530011076;4766.547178018082;4929.75351232437;4942.46783497117;4944.92044063649;4979.601631869442;4988.850334489971;4709.552592503706;4716.716996980193;4725.314829349793;4726.716397016121;4983.551480366785;2896.131160651796;2932.5894374787545;2948.7198716121934;2983.1796256029766;3026.728773914961;5911.852203694942;5919.230500035054;5921.911171332434;5927.3776253493625;5931.7627294907725;5582.27430434041;5757.395473475309;5816.970915145397;5821;5837.270341207349;5867.325257595346;5881.470667639847;5899.823005309848;5911.940880591139;5915.970420147958;5644.209810626598;5654.180143879033;5672.262605861211;5674.290713660793;5674.631148975303;5346.946530534645;5573.554115670656;5583.018028599951;5639.3232812062815;5648.4633959773755;5872.823815285548;5891.351951285441;5914.319853216935;5938.030984507746;5953.464188223081;4008.7995600219288;4015.9799201004976;4021.1756589899587;4034.1729945361717;4041.0705537727076;5396.406395296436;5639.687728031651;5648.03478173962;5652.3217213934595;5667.716614169358;5553.444655534414;5570.637908535932;5606.747696353756;5621.494065533958;5675.943240567542;5277.366715993951;5509.146082357241;5568.16477528374;5576.553875689854;5608.971955140199;5488.56091512686;5492.450754924475;5493.972530137324;5508.3114610673665;5537;5582.692951887523;5613.46672066153;5624.3250809903075;5624.57815663835;5626.324841019104;5232.241325007929;5458.536024437967;5466.617336786546;5476.972615136899;5514.558835293086 21:45:24 INFO - PROCESS | 3106 | |5;yui.html;720.5460559847295;734.8567029429263;742.4802638153294;744.162816831065;824.2622852546971;14828.851711482896;15654.608634784136;15664.608384790386;15692.058476491418;15699.60750981226;13900.652483687913;13979.301034948237;13983.930080349584;14010.719785604282;14123.152610843357;780.4887798491968;794.7575989323254;795.4233180943827;796.3549524884862;796.4424902568196;792.1761368177089;800.7877912353231;804.5574933786423;804.903411590607;805.017878188609;847.7626264645909;847.9533625650587;849.1126772522729;849.4054162086564;849.6558893648082;835.853725598018;838.7316058861167;839.1021606880671;839.1608391608391;839.8404303182376;626.0171530696808;626.3423405424286;627.1721327847243;627.5732501898752;627.8053803320985;13679.384427700777;13695.246761428118;13723.862761372358;13753.312334383341;13775.862241377557;12636.620901372973;12902.935485322514;13135.34323283832;13472.595822125351;14076.788848167285;11369.147313951487;11467.827982580267;11517.654470365902;11883.10876684252;12063.517459301618;3751.4185301278344;3764.190698999701;3794.6015668354976;3956.0703234739813;3990.700697447703;43399;49314.26028609538;50873.23690144651;64513;74462.25537744607;11744.649365322926;11774.529018839321;11963.46164422603;12018.939905300418;12039.63881083569;22020.11919523201;22248.666270005964;22253.44366390821;22256.10975560992;22259.77740222577;8416;8437.662493500191;8464.788380290542;8548.871766923501;8556.957215214008;4247.469066366704;4443.600075993176;4633.150821304132;4692.882677933011;4781.163296423112;3502.614712381636;3615.204654975901;3649.1789347396625;3656.323580137683;3659.1218107654504;613.1293563140351;618.9009758438629;627.5983370642792;631.1700114349708;633.5944995203074;666.6100331306241;688.8277930517371;695.7773512475959;695.8782213112685;707.2220557386834;9124.17882390588;9368.2973776967;9511.619535218513;9625;9760.316777825627;581.7556626216999;614.9269524679463;678.3792829560897;682.774684354162;704.7272151397528;4654.208784506642;4791.305260737243;4798.688085274516;4826.975865120722;4834.226523756182;118449;120623;122014.38992804979;122444.38777806054;124716;100482;104107.4794626022;105818;106824;106988;86038;91304.54347728219;91900;94529;94791.46357923668;8777.166169213915;8843.248323892542;9086.839749328665;9172.862407064033;9256.861147082935;49484.50515494799;49996.25005624846;50357.49642503528;51854.22218666648;53441.732791335795;45567.77216113898;45617.54382456133;59565;70746;78667;12906.35468226566;13268.601941941757;13308.46766129344;13322.481874258934;13537.526186583422;15347.259808034867;15477.303521341792;15685.29416176252;15747.921260393625;16308;14181.645458863612;14260;14436.206008669624;14853.554393368217;15284.77072843886;14222.644433889236;14739.705205895607;15071.09573425598;15245.466408675644;15304.464343747915;12673.366331683195;13883.791743123658;14495.565133046026;14562.781558276423;14635.546865331613;10957.380792811704;11421.1434142438;11542.94228528852;11564.659574256837;11765.882341176479;10881;11762.539625665031;11777.116716246488;11874;12090.45592948337 21:45:24 INFO - PROCESS | 3106 | __end_tp_report 21:45:24 INFO - PROCESS | 3106 | __start_cc_report 21:45:24 INFO - PROCESS | 3106 | _x_x_mozilla_cycle_collect,2597 21:45:24 INFO - PROCESS | 3106 | __end_cc_report 21:45:24 INFO - PROCESS | 3106 | __startTimestamp1476852324877__endTimestamp 21:45:24 INFO - PROCESS | 3106 | 21:45:24 INFO - PROCESS | 3106 | ------- Summary: start ------- 21:45:24 INFO - PROCESS | 3106 | Number of tests: 6 21:45:24 INFO - PROCESS | 3106 | 21:45:24 INFO - PROCESS | 3106 | [#0] dojo.html Cycles:165 Average:5265.05 Median:5474.64 stddev:584.49 (10.7%) stddev-sans-first:559.41 21:45:24 INFO - PROCESS | 3106 | Values: 3031.4 3053.7 3080.8 3090.4 3091.1 5137.8 5221.1 5229.7 5271.2 5327.5 5258.1 5266.7 5345.3 5372.5 5430.3 4807.6 4823.3 4859.1 4873.5 4908.4 4882.2 4895.3 4934.9 4936.6 5002.3 4727.1 4862.2 4866.3 4894.4 4979.4 4773.3 4828.5 4841.0 4884.0 4889.0 4833.6 4842.1 4846.2 4868.6 4905.6 5320.2 5330.4 5331.6 5334.3 5348.5 5458.2 5510.8 5587.5 5652.2 5668.3 5691.6 5699.5 5701.6 5770.4 5777.3 5296.0 5298.9 5302.9 5303.1 5305.9 5550.4 5554.0 5770.6 5783.9 5856.7 5488.5 5491.0 5507.2 5524.5 5532.1 5502.2 5523.6 5635.5 5639.2 5642.9 5439.4 5621.0 5631.1 5635.6 5636.3 5491.7 5561.6 5600.4 5618.0 5686.9 4305.3 4322.8 4326.3 4328.7 4385.7 3866.7 3885.8 3891.2 3917.0 3929.4 5240.4 5308.2 5336.8 5394.6 5400.6 5697.5 5703.9 5704.0 5704.3 5758.6 5366.0 5390.1 5408.8 5416.0 5419.5 4805.5 4858.9 4913.1 4940.9 4973.7 5924.1 5933.4 5950.7 5990.6 5992.9 5639.7 5666.7 5690.0 5706.1 5707.8 5743.2 5804.4 5893.1 5900.4 5901.4 5491.7 5534.8 5548.3 5552.6 5553.3 5652.2 5660.2 5664.2 5668.0 5668.5 5531.2 5558.4 5573.3 5573.6 5575.7 5470.4 5532.9 5537.0 5537.4 5542.6 5453.6 5457.2 5476.8 5477.0 5478.1 5510.7 5520.5 5541.4 5541.6 5560.7 5463.4 5465.6 5474.6 5476.2 5478.5 21:45:24 INFO - PROCESS | 3106 | 21:45:24 INFO - PROCESS | 3106 | [#1] ext.html Cycles:180 Average:49385.80 Median:35418.46 stddev:87188.87 (246.2%) stddev-sans-first:87356.47 21:45:24 INFO - PROCESS | 3106 | Values: 587.4 620.1 645.3 648.5 661.6 37751.2 41578.0 41587.6 41591.8 41640.8 41364.6 41651.0 41694.0 41904.0 41991.4 7982.8 8225.2 8635.7 8803.9 8809.6 10402.1 10660.4 10665.9 11006.1 11032.9 10419.9 10471.9 10472.8 10473.4 10485.0 10645.8 10682.0 10712.3 10719.5 10725.6 10495.0 10589.8 10662.1 10663.6 10664.9 40843.2 41191.6 41203.0 41224.2 41263.4 3189.4 3223.7 3320.3 3620.7 3640.3 30879.5 31581.4 31739.2 31870.2 31898.4 4146.2 4157.0 4281.5 4285.2 4293.3 213571.0 217230.0 217583.0 217678.0 219270.0 54941.0 55553.4 55749.4 55801.4 55919.0 59266.0 59346.7 59371.3 59412.7 59489.7 13181.3 13300.4 13303.6 13305.6 13320.9 8807.4 8989.1 10297.1 10355.2 10627.4 16541.3 16707.2 16795.5 16823.5 17016.5 6175.3 6311.5 6323.4 6416.4 6472.1 805.5 967.7 1026.0 1077.5 1115.4 30402.7 30709.8 30859.5 30957.8 31330.7 981.9 1020.0 1076.2 1089.0 1091.6 15502.8 16265.3 16372.0 16403.3 16725.7 411695.0 412597.0 414150.0 415129.0 416020.0 55218.0 55312.7 55322.2 55330.2 55388.2 1175.6 1245.1 1261.4 1276.7 1292.0 28135.1 31670.2 31767.4 31876.2 32419.2 48634.8 49263.8 49346.3 49383.0 49408.8 330623.0 332706.0 332814.0 333037.0 333319.0 26320.6 26913.5 27135.5 28145.0 39919.6 44759.0 45118.0 45255.8 45869.3 46521.0 37998.4 38057.0 38610.2 39727.6 39891.6 38440.6 38732.6 38773.6 39422.4 39641.0 38116.2 38923.8 39251.6 39307.0 39362.0 32402.5 34533.7 34657.0 35256.5 35580.4 25635.4 25803.2 25982.9 26010.3 26641.9 21:45:24 INFO - PROCESS | 3106 | 21:45:24 INFO - PROCESS | 3106 | [#2] jquery.html Cycles:180 Average:25931.63 Median:19123.21 stddev:61658.38 (322.4%) stddev-sans-first:61801.46 21:45:24 INFO - PROCESS | 3106 | Values: 362.5 375.3 385.8 387.9 412.0 14123.8 14568.3 17193.7 19188.4 20146.9 17875.2 18129.8 18311.3 18449.6 18874.4 5598.9 5847.6 5849.4 5850.1 5861.7 4861.0 5789.7 5824.0 5825.6 5834.7 5552.6 5781.9 5788.5 5790.6 5795.0 5709.3 5713.4 5747.4 5756.1 5773.0 4896.5 4963.3 5118.5 5154.1 5164.5 22462.6 22672.0 22738.0 22796.3 22994.2 2189.9 2318.2 2358.9 2514.9 2895.3 13930.9 14594.7 14812.4 14838.5 15602.2 2064.8 2117.6 2144.3 2147.9 2165.8 86306.6 87707.6 89500.6 90177.0 90333.0 16979.7 17052.7 17099.2 17193.6 17410.6 30844.1 30892.7 31003.8 31091.0 31322.1 8424.5 8698.0 8759.4 8922.2 8995.1 6935.6 7059.6 7081.2 7224.0 7268.3 8304.2 8358.4 8523.5 8601.6 8674.2 3302.9 3355.1 3388.7 3452.1 3531.9 715.4 892.9 896.1 896.4 899.2 18905.6 19127.4 19168.4 19517.6 19598.0 891.3 932.7 936.4 943.4 955.8 10210.4 10629.9 10742.8 10783.2 10803.8 318374.0 321444.0 321667.3 417889.0 440541.0 88639.6 93135.1 93163.5 93361.0 94598.0 448.5 462.6 463.0 463.2 464.2 9952.7 10315.6 10423.9 10467.0 10634.1 35337.5 37477.6 37860.6 39981.8 40039.0 47557.5 49287.5 50628.5 53380.0 53740.5 8002.2 8304.9 8431.6 8484.5 8781.2 12305.4 13056.8 13121.1 13276.0 13380.7 11224.2 11262.3 11431.1 11571.5 11705.5 11281.7 11445.9 11574.1 11634.8 11640.5 10831.8 11724.9 11747.8 11794.5 12022.9 7808.2 8110.3 8292.3 8313.9 8351.4 8361.8 11002.6 11140.7 11201.0 11661.7 21:45:24 INFO - PROCESS | 3106 | 21:45:24 INFO - PROCESS | 3106 | [#3] mootools.html Cycles:180 Average:5838.91 Median:4750.52 stddev:3385.95 (71.3%) stddev-sans-first:3379.49 21:45:24 INFO - PROCESS | 3106 | Values: 1464.5 1489.9 1635.4 1727.3 1790.6 8019.2 8286.0 8578.7 9283.4 9298.6 8541.3 8880.3 8938.2 9017.4 9092.1 2247.5 2275.0 2291.2 2293.2 2295.7 1962.9 2021.6 2127.7 2220.3 2271.2 2239.2 2280.0 2281.2 2284.5 2285.4 2156.0 2157.5 2213.6 2214.5 2219.4 2190.0 2201.2 2202.4 2233.6 2273.0 9032.3 9226.6 9226.9 9236.4 9250.5 5166.8 5266.4 5304.8 5307.1 5313.3 3279.2 3387.1 3488.9 3511.9 3523.7 990.6 1039.3 1040.9 1057.1 1068.3 12285.9 12318.0 12328.9 12329.3 12336.5 4156.8 4377.1 4448.0 4534.5 4547.1 10577.4 10595.9 10602.2 10606.5 10623.5 5193.4 5219.8 5222.6 5225.1 5257.9 4640.4 4739.1 4749.7 4751.4 4757.5 3839.6 3853.9 3872.4 3947.4 3983.5 1080.8 1088.8 1177.1 1186.5 1212.8 798.8 827.6 884.3 906.3 925.1 5912.6 5960.4 5993.1 6034.2 6082.7 883.0 893.2 902.9 925.3 926.7 4057.7 4203.6 4204.2 4309.8 4322.4 10789.2 11258.1 11263.2 11285.3 11324.9 11073.4 11178.0 11195.1 11207.2 11216.1 7940.9 8216.8 8287.1 8303.6 8339.2 6013.3 6034.0 6049.7 6245.3 6277.7 10317.8 10442.5 10449.0 10464.6 10575.7 9702.6 10039.4 10053.1 10370.9 10508.5 7837.8 7979.7 7984.1 7993.2 8005.4 8519.4 8600.7 8639.0 8654.4 8708.8 6431.7 7529.5 7775.3 7842.4 7886.0 7531.0 7714.2 7729.2 7740.1 7862.1 6746.6 6825.1 6882.8 6891.2 6932.0 5097.7 5214.6 5273.5 5322.4 5392.4 5372.3 5373.4 5406.5 5496.8 5568.8 21:45:24 INFO - PROCESS | 3106 | 21:45:24 INFO - PROCESS | 3106 | [#4] prototype.html Cycles:180 Average:4593.51 Median:5241.02 stddev:1367.24 (26.1%) stddev-sans-first:1332.90 21:45:24 INFO - PROCESS | 3106 | Values: 319.0 319.1 330.2 333.3 334.0 5302.7 5311.7 5326.6 5331.8 5348.3 5249.8 5255.8 5262.8 5274.5 5282.6 3876.3 4177.2 4178.4 4178.5 4185.8 4105.4 4148.9 4157.1 4158.9 4180.7 4085.9 4088.5 4088.8 4091.8 4117.2 3856.5 3960.3 3992.9 4094.3 4096.2 3605.1 3605.6 3606.3 3607.3 3619.7 5159.6 5161.6 5168.2 5171.4 5185.7 4290.7 4358.3 4625.7 4675.3 4677.4 5461.5 5496.2 5501.3 5507.1 5508.2 3870.6 3870.6 3873.5 3880.7 3880.9 5377.5 5658.6 5692.5 5705.6 5719.4 3920.1 3920.5 3922.7 3936.4 3964.7 3992.6 3995.7 4004.6 4004.7 4006.3 4492.0 4615.5 4617.1 4621.4 4633.4 5501.5 5528.4 5537.7 5543.2 5552.5 1384.9 1404.2 1404.4 1406.4 1407.6 837.5 893.7 893.8 909.5 914.7 4726.5 4726.6 4732.6 4734.4 4766.5 4929.8 4942.5 4944.9 4979.6 4988.9 4709.6 4716.7 4725.3 4726.7 4983.6 2896.1 2932.6 2948.7 2983.2 3026.7 5911.9 5919.2 5921.9 5927.4 5931.8 5582.3 5757.4 5817.0 5821.0 5837.3 5867.3 5881.5 5899.8 5911.9 5916.0 5644.2 5654.2 5672.3 5674.3 5674.6 5346.9 5573.6 5583.0 5639.3 5648.5 5872.8 5891.4 5914.3 5938.0 5953.5 4008.8 4016.0 4021.2 4034.2 4041.1 5396.4 5639.7 5648.0 5652.3 5667.7 5553.4 5570.6 5606.7 5621.5 5675.9 5277.4 5509.1 5568.2 5576.6 5609.0 5488.6 5492.5 5494.0 5508.3 5537.0 5582.7 5613.5 5624.3 5624.6 5626.3 5232.2 5458.5 5466.6 5477.0 5514.6 21:45:24 INFO - PROCESS | 3106 | 21:45:24 INFO - PROCESS | 3106 | [#5] yui.html Cycles:180 Average:20392.77 Median:23823.23 stddev:29979.08 (125.8%) stddev-sans-first:30026.78 21:45:24 INFO - PROCESS | 3106 | Values: 720.5 734.9 742.5 744.2 824.3 14828.9 15654.6 15664.6 15692.1 15699.6 13900.7 13979.3 13983.9 14010.7 14123.2 780.5 794.8 795.4 796.4 796.4 792.2 800.8 804.6 804.9 805.0 847.8 848.0 849.1 849.4 849.7 835.9 838.7 839.1 839.2 839.8 626.0 626.3 627.2 627.6 627.8 13679.4 13695.2 13723.9 13753.3 13775.9 12636.6 12902.9 13135.3 13472.6 14076.8 11369.1 11467.8 11517.7 11883.1 12063.5 3751.4 3764.2 3794.6 3956.1 3990.7 43399.0 49314.3 50873.2 64513.0 74462.3 11744.6 11774.5 11963.5 12018.9 12039.6 22020.1 22248.7 22253.4 22256.1 22259.8 8416.0 8437.7 8464.8 8548.9 8557.0 4247.5 4443.6 4633.2 4692.9 4781.2 3502.6 3615.2 3649.2 3656.3 3659.1 613.1 618.9 627.6 631.2 633.6 666.6 688.8 695.8 695.9 707.2 9124.2 9368.3 9511.6 9625.0 9760.3 581.8 614.9 678.4 682.8 704.7 4654.2 4791.3 4798.7 4827.0 4834.2 118449.0 120623.0 122014.4 122444.4 124716.0 100482.0 104107.5 105818.0 106824.0 106988.0 86038.0 91304.5 91900.0 94529.0 94791.5 8777.2 8843.2 9086.8 9172.9 9256.9 49484.5 49996.3 50357.5 51854.2 53441.7 45567.8 45617.5 59565.0 70746.0 78667.0 12906.4 13268.6 13308.5 13322.5 13537.5 15347.3 15477.3 15685.3 15747.9 16308.0 14181.6 14260.0 14436.2 14853.6 15284.8 14222.6 14739.7 15071.1 15245.5 15304.5 12673.4 13883.8 14495.6 14562.8 14635.5 10957.4 11421.1 11542.9 11564.7 11765.9 10881.0 11762.5 11777.1 11874.0 12090.5 21:45:24 INFO - PROCESS | 3106 | -------- Summary: end -------- 21:45:24 INFO - PROCESS | 3106 | 21:45:25 INFO - TEST-INFO | 3106: exit 0 21:45:25 INFO - TEST-OK | dromaeo_css | took 1117997ms 21:45:25 INFO - TEST-START | kraken 21:45:25 INFO - operating with platform_type : linux_ 21:45:25 INFO - Initialising browser for kraken test... 21:45:25 INFO - TEST-INFO | started process 3411 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVQkFXc/profile http://localhost:47317/getInfo.html) 21:45:29 INFO - PROCESS | 3411 | __metrics Screen width/height:1600/1200 21:45:29 INFO - PROCESS | 3411 | colorDepth:24 21:45:29 INFO - PROCESS | 3411 | Browser inner width/height: 1024/697 21:45:29 INFO - PROCESS | 3411 | __metrics 21:45:30 INFO - PROCESS | 3411 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:45:30 INFO - PROCESS | 3411 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:45:30 INFO - PROCESS | 3411 | console.error: PushService: 21:45:30 INFO - PROCESS | 3411 | stateChangeProcessEnqueue: Error transitioning state 21:45:30 INFO - PROCESS | 3411 | UnknownError 21:45:31 INFO - TEST-INFO | 3411: exit 0 21:45:31 INFO - Browser initialized. 21:45:31 INFO - Running cycle 1/1 for kraken test... 21:45:31 INFO - TEST-INFO | started process 3496 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVQkFXc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:45:43 INFO - PROCESS | 3496 | RSS: Main: 172208128 21:45:43 INFO - PROCESS | 3496 | 21:45:46 INFO - PROCESS | 3496 | Cycle 1(1): loaded http://localhost:47317/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47317/tests/kraken/driver.html?testName=audio-beat-detection) 21:45:47 INFO - PROCESS | 3496 | RSS: Main: 237338624 21:45:47 INFO - PROCESS | 3496 | 21:45:49 INFO - PROCESS | 3496 | Cycle 1(1): loaded http://localhost:47317/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47317/tests/kraken/driver.html?testName=audio-dft) 21:45:50 INFO - PROCESS | 3496 | RSS: Main: 215961600 21:45:50 INFO - PROCESS | 3496 | 21:45:53 INFO - PROCESS | 3496 | Cycle 1(1): loaded http://localhost:47317/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47317/tests/kraken/driver.html?testName=audio-fft) 21:45:54 INFO - PROCESS | 3496 | RSS: Main: 297578496 21:45:54 INFO - PROCESS | 3496 | 21:45:56 INFO - PROCESS | 3496 | Cycle 1(1): loaded http://localhost:47317/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47317/tests/kraken/driver.html?testName=audio-oscillator) 21:45:56 INFO - PROCESS | 3496 | RSS: Main: 209108992 21:45:56 INFO - PROCESS | 3496 | 21:45:59 INFO - PROCESS | 3496 | Cycle 1(1): loaded http://localhost:47317/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47317/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:45:59 INFO - PROCESS | 3496 | RSS: Main: 211607552 21:45:59 INFO - PROCESS | 3496 | 21:46:02 INFO - PROCESS | 3496 | Cycle 1(1): loaded http://localhost:47317/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47317/tests/kraken/driver.html?testName=imaging-darkroom) 21:46:03 INFO - PROCESS | 3496 | RSS: Main: 247828480 21:46:03 INFO - PROCESS | 3496 | 21:46:06 INFO - PROCESS | 3496 | Cycle 1(1): loaded http://localhost:47317/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47317/tests/kraken/driver.html?testName=imaging-desaturate) 21:46:07 INFO - PROCESS | 3496 | RSS: Main: 246239232 21:46:07 INFO - PROCESS | 3496 | 21:46:09 INFO - PROCESS | 3496 | Cycle 1(1): loaded http://localhost:47317/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47317/tests/kraken/driver.html?testName=json-parse-financial) 21:46:10 INFO - PROCESS | 3496 | RSS: Main: 246804480 21:46:10 INFO - PROCESS | 3496 | 21:46:11 INFO - PROCESS | 3496 | Cycle 1(1): loaded http://localhost:47317/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47317/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:46:12 INFO - PROCESS | 3496 | RSS: Main: 208936960 21:46:12 INFO - PROCESS | 3496 | 21:46:14 INFO - PROCESS | 3496 | Cycle 1(1): loaded http://localhost:47317/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47317/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:46:14 INFO - PROCESS | 3496 | RSS: Main: 216039424 21:46:14 INFO - PROCESS | 3496 | 21:46:16 INFO - PROCESS | 3496 | Cycle 1(1): loaded http://localhost:47317/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47317/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:46:17 INFO - PROCESS | 3496 | RSS: Main: 226127872 21:46:17 INFO - PROCESS | 3496 | 21:46:20 INFO - PROCESS | 3496 | Cycle 1(1): loaded http://localhost:47317/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47317/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:46:20 INFO - PROCESS | 3496 | RSS: Main: 233836544 21:46:20 INFO - PROCESS | 3496 | 21:46:23 INFO - PROCESS | 3496 | Cycle 1(1): loaded http://localhost:47317/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47317/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:46:24 INFO - PROCESS | 3496 | RSS: Main: 231370752 21:46:24 INFO - PROCESS | 3496 | 21:46:25 INFO - PROCESS | 3496 | Cycle 1(1): loaded http://localhost:47317/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47317/tests/kraken/driver.html?testName=ai-astar) 21:46:26 INFO - PROCESS | 3496 | RSS: Main: 282443776 21:46:26 INFO - PROCESS | 3496 | 21:46:26 INFO - PROCESS | 3496 | __start_tp_report 21:46:26 INFO - PROCESS | 3496 | _x_x_mozilla_page_load 21:46:26 INFO - PROCESS | 3496 | _x_x_mozilla_page_load_details 21:46:26 INFO - PROCESS | 3496 | |i|pagename|runs| 21:46:26 INFO - PROCESS | 3496 | |0;ai-astar;103;110;112;113;112;112;113;113;111;111 21:46:26 INFO - PROCESS | 3496 | |1;audio-beat-detection;155;121;122;148;121;121;121;119;158;123 21:46:26 INFO - PROCESS | 3496 | |2;audio-dft;162;163;162;159;160;161;163;163;163;163 21:46:26 INFO - PROCESS | 3496 | |3;audio-fft;75;75;77;110;76;76;78;75;103;76 21:46:26 INFO - PROCESS | 3496 | |4;audio-oscillator;83;83;120;82;82;83;106;83;82;116 21:46:26 INFO - PROCESS | 3496 | |5;imaging-gaussian-blur;117;117;117;117;117;117;119;117;118;118 21:46:26 INFO - PROCESS | 3496 | |6;imaging-darkroom;147;147;147;146;147;148;146;147;147;147 21:46:26 INFO - PROCESS | 3496 | |7;imaging-desaturate;85;85;85;85;86;85;85;85;86;85 21:46:26 INFO - PROCESS | 3496 | |8;json-parse-financial;57;52;54;52;53;54;55;53;55;54 21:46:26 INFO - PROCESS | 3496 | |9;json-stringify-tinderbox;59;60;58;59;60;59;60;59;59;60 21:46:26 INFO - PROCESS | 3496 | |10;stanford-crypto-aes;81;80;80;80;80;80;80;82;80;79 21:46:26 INFO - PROCESS | 3496 | |11;stanford-crypto-ccm;146;141;133;132;132;136;130;132;170;141 21:46:26 INFO - PROCESS | 3496 | |12;stanford-crypto-pbkdf2;168;168;168;167;166;172;172;170;172;167 21:46:26 INFO - PROCESS | 3496 | |13;stanford-crypto-sha256-iterative;65;66;70;66;67;68;65;66;67;70 21:46:26 INFO - PROCESS | 3496 | __end_tp_report 21:46:26 INFO - PROCESS | 3496 | __start_cc_report 21:46:26 INFO - PROCESS | 3496 | _x_x_mozilla_cycle_collect,1673 21:46:26 INFO - PROCESS | 3496 | __end_cc_report 21:46:26 INFO - PROCESS | 3496 | __startTimestamp1476852386177__endTimestamp 21:46:26 INFO - PROCESS | 3496 | 21:46:26 INFO - PROCESS | 3496 | ------- Summary: start ------- 21:46:26 INFO - PROCESS | 3496 | Number of tests: 14 21:46:26 INFO - PROCESS | 3496 | 21:46:26 INFO - PROCESS | 3496 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:2.98 (2.7%) stddev-sans-first:1.05 21:46:26 INFO - PROCESS | 3496 | Values: 103.0 110.0 112.0 113.0 112.0 112.0 113.0 113.0 111.0 111.0 21:46:26 INFO - PROCESS | 3496 | 21:46:26 INFO - PROCESS | 3496 | [#1] audio-beat-detection Cycles:10 Average:130.90 Median:122.50 stddev:15.93 (13.0%) stddev-sans-first:14.31 21:46:26 INFO - PROCESS | 3496 | Values: 155.0 121.0 122.0 148.0 121.0 121.0 121.0 119.0 158.0 123.0 21:46:26 INFO - PROCESS | 3496 | 21:46:26 INFO - PROCESS | 3496 | [#2] audio-dft Cycles:10 Average:161.90 Median:163.00 stddev:1.45 (0.9%) stddev-sans-first:1.54 21:46:26 INFO - PROCESS | 3496 | Values: 162.0 163.0 162.0 159.0 160.0 161.0 163.0 163.0 163.0 163.0 21:46:26 INFO - PROCESS | 3496 | 21:46:26 INFO - PROCESS | 3496 | [#3] audio-fft Cycles:10 Average:82.10 Median:76.00 stddev:13.00 (17.1%) stddev-sans-first:13.53 21:46:26 INFO - PROCESS | 3496 | Values: 75.0 75.0 77.0 110.0 76.0 76.0 78.0 75.0 103.0 76.0 21:46:26 INFO - PROCESS | 3496 | 21:46:26 INFO - PROCESS | 3496 | [#4] audio-oscillator Cycles:10 Average:92.00 Median:82.50 stddev:15.56 (18.9%) stddev-sans-first:16.16 21:46:26 INFO - PROCESS | 3496 | Values: 83.0 83.0 120.0 82.0 82.0 83.0 106.0 83.0 82.0 116.0 21:46:26 INFO - PROCESS | 3496 | 21:46:26 INFO - PROCESS | 3496 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 21:46:26 INFO - PROCESS | 3496 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 119.0 117.0 118.0 118.0 21:46:26 INFO - PROCESS | 3496 | 21:46:26 INFO - PROCESS | 3496 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 21:46:26 INFO - PROCESS | 3496 | Values: 147.0 147.0 147.0 146.0 147.0 148.0 146.0 147.0 147.0 147.0 21:46:26 INFO - PROCESS | 3496 | 21:46:26 INFO - PROCESS | 3496 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 21:46:26 INFO - PROCESS | 3496 | Values: 85.0 85.0 85.0 85.0 86.0 85.0 85.0 85.0 86.0 85.0 21:46:26 INFO - PROCESS | 3496 | 21:46:26 INFO - PROCESS | 3496 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:1.52 (2.8%) stddev-sans-first:1.13 21:46:26 INFO - PROCESS | 3496 | Values: 57.0 52.0 54.0 52.0 53.0 54.0 55.0 53.0 55.0 54.0 21:46:26 INFO - PROCESS | 3496 | 21:46:26 INFO - PROCESS | 3496 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.50 stddev:0.67 (1.1%) stddev-sans-first:0.71 21:46:26 INFO - PROCESS | 3496 | Values: 59.0 60.0 58.0 59.0 60.0 59.0 60.0 59.0 59.0 60.0 21:46:26 INFO - PROCESS | 3496 | 21:46:26 INFO - PROCESS | 3496 | [#10] stanford-crypto-aes Cycles:10 Average:80.20 Median:80.00 stddev:0.79 (1.0%) stddev-sans-first:0.78 21:46:26 INFO - PROCESS | 3496 | Values: 81.0 80.0 80.0 80.0 80.0 80.0 80.0 82.0 80.0 79.0 21:46:26 INFO - PROCESS | 3496 | 21:46:26 INFO - PROCESS | 3496 | [#11] stanford-crypto-ccm Cycles:10 Average:139.30 Median:138.50 stddev:11.97 (8.6%) stddev-sans-first:12.45 21:46:26 INFO - PROCESS | 3496 | Values: 146.0 141.0 133.0 132.0 132.0 136.0 130.0 132.0 170.0 141.0 21:46:26 INFO - PROCESS | 3496 | 21:46:26 INFO - PROCESS | 3496 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.00 Median:169.00 stddev:2.31 (1.4%) stddev-sans-first:2.42 21:46:26 INFO - PROCESS | 3496 | Values: 168.0 168.0 168.0 167.0 166.0 172.0 172.0 170.0 172.0 167.0 21:46:26 INFO - PROCESS | 3496 | 21:46:26 INFO - PROCESS | 3496 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:1.83 (2.7%) stddev-sans-first:1.79 21:46:26 INFO - PROCESS | 3496 | Values: 65.0 66.0 70.0 66.0 67.0 68.0 65.0 66.0 67.0 70.0 21:46:26 INFO - PROCESS | 3496 | -------- Summary: end -------- 21:46:26 INFO - PROCESS | 3496 | 21:46:27 INFO - TEST-INFO | 3496: exit 0 21:46:27 INFO - TEST-OK | kraken | took 61568ms 21:46:27 INFO - SUITE-END | took 1179s 21:46:27 INFO - Completed test suite (00:19:39) 21:46:27 INFO - javascript benchmark 21:46:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3031.393721255749, 3053.694630536948, 3080.845957702115, 3090.35102628448, 3091.0881290019443, 5137.845864624058, 5221.112410890149, 5229.712365819878, 5271.209318602207, 5327.520523152915, 5258.13240815265, 5266.657667251636, 5345.251664766935, 5372.462753724625, 5430.266913966613, 4807.591354734852, 4823.324734537167, 4859.1010663027455, 4873.512648735134, 4908.435529914052, 4882.218844984804, 4895.31465594817, 4934.876628084291, 4936.629752768539, 5002.274670172823, 4727.125481785881, 4862.246351815475, 4866.270059491069, 4894.36373271476, 4979.377577802775, 4773.284007398884, 4828.517148285144, 4840.951590484121, 4883.975580122112, 4889.046635906, 4833.564979151894, 4842.104210721028, 4846.176150054499, 4868.610511159099, 4905.632077594195, 5320.228566857822, 5330.413654498002, 5331.600129990266, 5334.306540149794, 5348.465153484659, 5458.208559758813, 5510.779568817243, 5587.469190426903, 5652.180433837112, 5668.291463567054, 5691.630044047124, 5699.487046165865, 5701.629394089371, 5770.365259821417, 5777.335606405233, 5296.046711591912, 5298.894022119536, 5302.946970530284, 5303.124984377611, 5305.946940530545, 5550.417206193372, 5554.028045092093, 5770.596058275964, 5783.902417175546, 5856.707164641751, 5488.4785945335125, 5491.0, 5507.228987941691, 5524.475174858382, 5532.1425179096495, 5502.174673798962, 5523.558115350762, 5635.549156067505, 5639.238702775073, 5642.85892852682, 5439.401665816757, 5621.0444224481935, 5631.1271752878365, 5635.633683810539, 5636.267285252891, 5491.670499770026, 5561.555075593943, 5600.355959064678, 5618.016847051749, 5686.914696279559, 4305.289627211538, 4322.762248076323, 4326.286162783105, 4328.718633288826, 4385.6710746694125, 3866.7099967501986, 3885.825137868803, 3891.163399868985, 3917.0, 3929.4302326162547, 5240.3973543042275, 5308.177232528964, 5336.759845806948, 5394.568434525228, 5400.648957817729, 5697.544196464273, 5703.914441283384, 5703.971480142573, 5704.286964129484, 5758.596898217084, 5366.0, 5390.110631745718, 5408.783648654088, 5415.972920135374, 5419.458054194628, 4805.471398146201, 4858.854234372974, 4913.11563918491, 4940.925886111711, 4973.651844370859, 5924.11138329254, 5933.436323549256, 5950.702464876739, 5990.610610310316, 5992.8801423972145, 5639.661620302795, 5666.660000399825, 5690.0, 5706.115552089433, 5707.771689132388, 5743.224664670216, 5804.361520232856, 5893.116032595145, 5900.43945825146, 5901.350851406256, 5491.725413729378, 5534.833954981357, 5548.278723765885, 5552.639078459887, 5553.250311208097, 5652.236948011966, 5660.179274005329, 5664.150377443417, 5668.03643380618, 5668.489835914787, 5531.170324451365, 5558.44415558441, 5573.331200255833, 5573.5819813513335, 5575.721213939206, 5470.370907345706, 5532.91700624499, 5537.0, 5537.363203231519, 5542.61201715876, 5453.618246722692, 5457.154141108134, 5476.780928762805, 5477.041517734301, 5478.096114141122, 5510.6969116698965, 5520.53075488588, 5541.418151094238, 5541.584381171348, 5560.694161821139, 5463.371712253142, 5465.6447330923365, 5474.644148130359, 5476.2333273342565, 5478.45215478449], "value": 5226.252534638603, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [587.4125874125874, 620.1442010026165, 645.3159650770184, 648.4747354642736, 661.583202582373, 37751.24497510048, 41578.0, 41587.58412415875, 41591.79204103983, 41640.791796041056, 41364.58635413645, 41651.0, 41694.0, 41904.0, 41991.370129448085, 7982.840343193133, 8225.218604232588, 8635.740927772176, 8803.911960880405, 8809.603567839462, 10402.115820155295, 10660.413677247749, 10665.946670266676, 11006.119510439146, 11032.944835275812, 10419.947900260488, 10471.947640261787, 10472.842907356358, 10473.423961682105, 10485.0, 10645.78708425831, 10682.0, 10712.25014249003, 10719.517621706964, 10725.624603138853, 10495.0, 10589.788204235872, 10662.147028237723, 10663.573457061708, 10664.946675266652, 40843.18313633741, 41191.588084119074, 41203.0, 41224.1755164898, 41263.38104928428, 3189.378071276102, 3223.693749093832, 3320.2529430877858, 3620.6922411595046, 3640.271945610862, 30879.536806947915, 31581.36837263265, 31739.206519836956, 31870.20324491883, 31898.362032759214, 4146.1914926589325, 4156.9792151039055, 4281.464816897887, 4285.164392943378, 4293.313069908831, 213571.0, 217230.0, 217583.0, 217678.0, 219270.0, 54941.0, 55553.444465555636, 55749.44250557443, 55801.44198558044, 55919.0, 59266.0, 59346.70326648339, 59371.3131636301, 59412.70293648504, 59489.70255148697, 13181.275029873448, 13300.401481933337, 13303.600891973256, 13305.600831975056, 13320.866791331962, 8807.427517211361, 8989.146031127033, 10297.12474439666, 10355.17158627308, 10627.36235825853, 16541.25564349607, 16707.248173832206, 16795.496135115965, 16823.495295141165, 17016.48950531486, 6175.320714721377, 6311.526635502356, 6323.430891219812, 6416.422521973045, 6472.126262954535, 805.4804651000072, 967.72272510719, 1025.9894004405655, 1077.5258886090096, 1115.3921112993437, 30402.69597304043, 30709.84645076805, 30859.537106943415, 30957.8452107738, 31330.68669313278, 981.8625392445064, 1019.9541020654088, 1076.208986394999, 1089.0144419300545, 1091.5524634899652, 15502.84497155014, 16265.268062937197, 16372.0, 16403.261853216634, 16725.6654866902, 411695.0, 412597.0, 414150.0, 415129.0, 416020.0, 55218.0, 55312.72343638336, 55322.17016744752, 55330.17004744932, 55388.16917746237, 1175.6002958993813, 1245.1097465312164, 1261.426051146726, 1276.6808297925518, 1291.992246048084, 28135.106898809103, 31670.208244794063, 31767.364652706354, 31876.203094922814, 32419.18952026218, 48634.78413039702, 49263.75368123136, 49346.25980610222, 49383.0, 49408.75295623499, 330623.0, 332706.0, 332814.0, 333037.0, 333319.0, 26320.605190922535, 26913.461730765666, 27135.45729085368, 28145.0, 39919.60080399159, 44759.0, 45118.0, 45255.77372113118, 45869.31196032129, 46521.0, 37998.43002355022, 38056.98169793181, 38610.227795444494, 39727.60272397239, 39891.60108398879, 38440.61559384482, 38732.6126738729, 38773.612263877, 39422.40866386949, 39641.0, 38116.237675245786, 38923.80538097292, 39251.607483924796, 39307.0, 39362.0, 32402.51396229011, 34533.65466345405, 34657.0, 35256.47115293324, 35580.441955804214, 25635.35911602225, 25803.183935328354, 25982.87008564945, 26010.309329893495, 26641.86679066592], "value": 19054.170826290738, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.51242079403227, 375.318796384562, 385.79745633542393, 387.9262940041392, 411.9979400102999, 14123.788143177848, 14568.344424500896, 17193.656126877457, 19188.424347269603, 20146.89926550369, 17875.19561619727, 18129.818701813012, 18311.267549298012, 18449.631007379845, 18874.43376698698, 5598.888022239553, 5847.5614328925285, 5849.385814489481, 5850.063989761617, 5861.677607731573, 4861.003494283664, 5789.681567513785, 5823.970880145594, 5825.592208545403, 5834.737436815353, 5552.555795536347, 5781.913271300934, 5788.450097240777, 5790.623609465392, 5794.971025144869, 5709.343425506078, 5713.400092990239, 5747.3677895431465, 5756.079027355603, 5773.018586840247, 4896.485868983741, 4963.3299504566785, 5118.4625614310335, 5154.123798954187, 5164.509371609691, 22462.550748985093, 22671.979760910635, 22738.0, 22796.316110516713, 22994.19520316781, 2189.868607883532, 2318.2233951626226, 2358.870262135582, 2514.937126571832, 2895.290653789835, 13930.93034534831, 14594.70810583793, 14812.407503699838, 14838.480653177196, 15602.219889005504, 2064.8451366147447, 2117.6188286108495, 2144.2709478777133, 2147.881866497342, 2165.805077543013, 86306.56846715727, 87707.56146219291, 89500.55249723709, 90177.0, 90333.0, 16979.660406791794, 17052.744208836877, 17099.23053462597, 17193.57016074608, 17410.60271315896, 30844.0746777597, 30892.69107308943, 31003.844980774953, 31091.0, 31322.06033818989, 8424.452410593292, 8697.95651021741, 8759.386842920934, 8922.197002269826, 8995.100489950952, 6935.618540980194, 7059.647017649097, 7081.150261968597, 7223.963880180566, 7268.345848873627, 8304.211099945496, 8358.373122015873, 8523.531205783742, 8601.5699215039, 8674.21932026108, 3302.8678852846097, 3355.1444381683004, 3388.66216776475, 3452.0796833430786, 3531.8940431787087, 715.4228660154472, 892.8526793079199, 896.1397058823602, 896.4038914122036, 899.2311573604604, 18905.621887562447, 19127.426177214707, 19168.424947251606, 19517.609647806963, 19598.0, 891.3448615267773, 932.7108596335158, 936.4287784451479, 943.3632298198688, 955.8136163448061, 10210.4384258865, 10629.89370106289, 10742.78514429707, 10783.245172837984, 10803.83794243087, 318374.0, 321444.0, 321667.3082980458, 417889.0, 440541.0, 88639.55680221686, 93135.068649314, 93163.53418232866, 93361.0, 94598.0, 448.52008351064046, 462.5952291744791, 462.9884252893637, 463.2425983516907, 464.24328344797766, 9952.651657191964, 10315.638952636622, 10423.94788026055, 10467.0, 10634.08354994987, 35337.46993795044, 37477.6252237485, 37860.62139378571, 39981.80009099936, 40039.0, 47557.492710789855, 49287.507124929725, 50628.49371506238, 53380.0, 53740.46259537511, 8002.1997800219515, 8304.916950830415, 8431.578421078799, 8484.533350665773, 8781.165789250012, 12305.384730763604, 13056.804147937599, 13121.081524293208, 13276.0, 13380.665483362995, 11224.15818813576, 11262.267952583055, 11431.085513159094, 11571.479283432098, 11705.473253703434, 11281.71795705114, 11445.942770286096, 11574.131940104357, 11634.767304653691, 11640.476178571815, 10831.783364332827, 11724.88275117238, 11747.823782643438, 11794.52821887115, 12022.939885300517, 7808.219178082147, 8110.270075693216, 8292.33661307082, 8313.916860831314, 8351.373646976623, 8361.790955226168, 11002.614908478485, 11140.721481963015, 11201.0, 11661.6501504955], "value": 9301.122860615757, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1464.4654701034121, 1489.873360764335, 1635.4357746577434, 1727.3263427263362, 1790.6418716256744, 8019.23817237363, 8286.0, 8578.742637720863, 9283.44299342039, 9298.581563829635, 8541.316694664427, 8880.333974951873, 8938.1508756668, 9017.36878418511, 9092.136247056536, 2247.4606094537276, 2275.0217406515194, 2291.2209848651455, 2293.174457195408, 2295.747467778543, 1962.9018549072562, 2021.6259991901472, 2127.6595744680853, 2220.311703371952, 2271.159670921761, 2239.2274665240548, 2280.04238219948, 2281.2015794471968, 2284.4517315844246, 2285.394370491821, 2155.9892200539052, 2157.4822042709716, 2213.5904857601395, 2214.490667146549, 2219.4340443186884, 2190.0144934779255, 2201.218567408579, 2202.449387653087, 2233.6426171812595, 2272.988635056814, 9032.27741780656, 9226.58480368385, 9226.86159707605, 9236.399634023766, 9250.491222982733, 5166.7674954626755, 5266.368035835686, 5304.787808487656, 5307.124324486455, 5313.335833020872, 3279.2293810954407, 3387.0854869185428, 3488.9302213955834, 3511.9297614047578, 3523.6652518010746, 990.5988074829705, 1039.2569312941207, 1040.8542804007445, 1057.1499875218367, 1068.2949253492657, 12285.938570307091, 12318.014558835272, 12328.938355308255, 12329.321887296195, 12336.5065397384, 4156.8129434174925, 4377.102693947797, 4448.0, 4534.523874993144, 4547.090222106724, 10577.36535807854, 10595.94702026485, 10602.151827853753, 10606.469676516142, 10623.52194151265, 5193.428722840485, 5219.817306394258, 5222.556082732935, 5225.111731005738, 5257.894842103136, 4640.419947506562, 4739.123262196505, 4749.667523273338, 4751.382320298409, 4757.452892917289, 3839.616038396138, 3853.9229215415535, 3872.361060425055, 3947.440760899429, 3983.48214732083, 1080.8108580998294, 1088.8257878739523, 1177.1283658982088, 1186.5024124218396, 1212.7695737809788, 798.8202654402713, 827.557256867573, 884.2704768565959, 906.3021473465395, 925.1026504290827, 5912.645241285537, 5960.403959604005, 5993.130996005642, 6034.1853849730605, 6082.695865206722, 883.0374891368311, 893.2139717048956, 902.8961669408102, 925.3291363761354, 926.6895589977298, 4057.736247143926, 4203.600657937491, 4204.2432362175105, 4309.806058727365, 4322.438083049184, 10789.190810689073, 11258.099352051817, 11263.155263355282, 11285.322880627189, 11324.94337528307, 11073.390963497084, 11178.0, 11195.104391648649, 11207.215494915277, 11216.102711783038, 7940.880886786703, 8216.794580135544, 8287.12985136564, 8303.584820758937, 8339.249467547828, 6013.338532761481, 6034.0, 6049.727762250797, 6245.313015568193, 6277.654728989949, 10317.793644127225, 10442.530086146293, 10449.022028721778, 10464.581416743245, 10575.735606609896, 9702.563384647567, 10039.397636141855, 10053.145482633765, 10370.896291037296, 10508.474576271308, 7837.804054898673, 7979.680812767424, 7984.121746607752, 7993.240642138988, 8005.3995950305125, 8519.361047921308, 8600.65597376123, 8639.049704532623, 8654.394192406722, 8708.78228044304, 6431.710573024132, 7529.548227106391, 7775.339096176888, 7842.411819113475, 7886.014248218973, 7531.0, 7714.15144334134, 7729.188435214446, 7740.109887363025, 7862.095858976062, 6746.561473504206, 6825.1127353443735, 6882.793516194522, 6891.241963383924, 6932.0, 5097.745112744422, 5214.582833373397, 5273.525382715574, 5322.441143679858, 5392.433794451683, 5372.328458942632, 5373.408925018167, 5406.459354064562, 5496.801536846768, 5568.832935011957], "value": 4607.734487370438, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.95056266278726, 319.1415093398757, 330.18938505967844, 333.3399868260843, 333.98664053437864, 5302.734863256836, 5311.73441327934, 5326.573874090073, 5331.760070796814, 5348.304720386344, 5249.790008399659, 5255.84371438284, 5262.763175657095, 5274.466107707835, 5282.577393808496, 3876.341022026262, 4177.227212965596, 4178.435911151986, 4178.477690288706, 4185.769782661952, 4105.404716316132, 4148.875533733978, 4157.066963861819, 4158.8960275993195, 4180.728252663583, 4085.8978525536804, 4088.4684990951137, 4088.8364465421346, 4091.8158682859194, 4117.21772863155, 3856.5179352580926, 3960.2673505401594, 3992.8802135935966, 4094.34490481523, 4096.201240758039, 3605.1167463971497, 3605.56733192016, 3606.2607165531267, 3607.2965771674535, 3619.7104231661406, 5159.555324509143, 5161.574060191704, 5168.198929165986, 5171.3535808024, 5185.662931909414, 4290.721103128318, 4358.259095953696, 4625.722456652612, 4675.298705194214, 4677.368555245032, 5461.5357694596005, 5496.241202815101, 5501.284832971728, 5507.063799154113, 5508.173773933902, 3870.606581630611, 3870.632289932452, 3873.4964454620717, 3880.72834901557, 3880.8835734927716, 5377.516023557899, 5658.575606829504, 5692.459216374438, 5705.6291341063115, 5719.428057194289, 3920.09837737322, 3920.5295364555864, 3922.666573341298, 3936.4488971544006, 3964.663003644665, 3992.5608183099835, 3995.7202995790017, 4004.6395824375945, 4004.7196696231567, 4006.338954072545, 4491.977540112279, 4615.484560914309, 4617.145828021827, 4621.376114224604, 4633.401476490605, 5501.5323697486165, 5528.391876893619, 5537.723113844291, 5543.168524721244, 5552.472515111058, 1384.9307534623229, 1404.192589261179, 1404.3610157378369, 1406.3882211238144, 1407.5566196648024, 837.5393533556642, 893.6961433112773, 893.7631527645179, 909.4588719711761, 914.7255823253131, 4726.480087190406, 4726.574608285271, 4732.574068333866, 4734.384530011076, 4766.547178018082, 4929.75351232437, 4942.46783497117, 4944.92044063649, 4979.601631869442, 4988.850334489971, 4709.552592503706, 4716.716996980193, 4725.314829349793, 4726.716397016121, 4983.551480366785, 2896.131160651796, 2932.5894374787545, 2948.7198716121934, 2983.1796256029766, 3026.728773914961, 5911.852203694942, 5919.230500035054, 5921.911171332434, 5927.3776253493625, 5931.7627294907725, 5582.27430434041, 5757.395473475309, 5816.970915145397, 5821.0, 5837.270341207349, 5867.325257595346, 5881.470667639847, 5899.823005309848, 5911.940880591139, 5915.970420147958, 5644.209810626598, 5654.180143879033, 5672.262605861211, 5674.290713660793, 5674.631148975303, 5346.946530534645, 5573.554115670656, 5583.018028599951, 5639.3232812062815, 5648.4633959773755, 5872.823815285548, 5891.351951285441, 5914.319853216935, 5938.030984507746, 5953.464188223081, 4008.7995600219288, 4015.9799201004976, 4021.1756589899587, 4034.1729945361717, 4041.0705537727076, 5396.406395296436, 5639.687728031651, 5648.03478173962, 5652.3217213934595, 5667.716614169358, 5553.444655534414, 5570.637908535932, 5606.747696353756, 5621.494065533958, 5675.943240567542, 5277.366715993951, 5509.146082357241, 5568.16477528374, 5576.553875689854, 5608.971955140199, 5488.56091512686, 5492.450754924475, 5493.972530137324, 5508.3114610673665, 5537.0, 5582.692951887523, 5613.46672066153, 5624.3250809903075, 5624.57815663835, 5626.324841019104, 5232.241325007929, 5458.536024437967, 5466.617336786546, 5476.972615136899, 5514.558835293086], "value": 4156.855134366837, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [720.5460559847295, 734.8567029429263, 742.4802638153294, 744.162816831065, 824.2622852546971, 14828.851711482896, 15654.608634784136, 15664.608384790386, 15692.058476491418, 15699.60750981226, 13900.652483687913, 13979.301034948237, 13983.930080349584, 14010.719785604282, 14123.152610843357, 780.4887798491968, 794.7575989323254, 795.4233180943827, 796.3549524884862, 796.4424902568196, 792.1761368177089, 800.7877912353231, 804.5574933786423, 804.903411590607, 805.017878188609, 847.7626264645909, 847.9533625650587, 849.1126772522729, 849.4054162086564, 849.6558893648082, 835.853725598018, 838.7316058861167, 839.1021606880671, 839.1608391608391, 839.8404303182376, 626.0171530696808, 626.3423405424286, 627.1721327847243, 627.5732501898752, 627.8053803320985, 13679.384427700777, 13695.246761428118, 13723.862761372358, 13753.312334383341, 13775.862241377557, 12636.620901372973, 12902.935485322514, 13135.34323283832, 13472.595822125351, 14076.788848167285, 11369.147313951487, 11467.827982580267, 11517.654470365902, 11883.10876684252, 12063.517459301618, 3751.4185301278344, 3764.190698999701, 3794.6015668354976, 3956.0703234739813, 3990.700697447703, 43399.0, 49314.26028609538, 50873.23690144651, 64513.0, 74462.25537744607, 11744.649365322926, 11774.529018839321, 11963.46164422603, 12018.939905300418, 12039.63881083569, 22020.11919523201, 22248.666270005964, 22253.44366390821, 22256.10975560992, 22259.77740222577, 8416.0, 8437.662493500191, 8464.788380290542, 8548.871766923501, 8556.957215214008, 4247.469066366704, 4443.600075993176, 4633.150821304132, 4692.882677933011, 4781.163296423112, 3502.614712381636, 3615.204654975901, 3649.1789347396625, 3656.323580137683, 3659.1218107654504, 613.1293563140351, 618.9009758438629, 627.5983370642792, 631.1700114349708, 633.5944995203074, 666.6100331306241, 688.8277930517371, 695.7773512475959, 695.8782213112685, 707.2220557386834, 9124.17882390588, 9368.2973776967, 9511.619535218513, 9625.0, 9760.316777825627, 581.7556626216999, 614.9269524679463, 678.3792829560897, 682.774684354162, 704.7272151397528, 4654.208784506642, 4791.305260737243, 4798.688085274516, 4826.975865120722, 4834.226523756182, 118449.0, 120623.0, 122014.38992804979, 122444.38777806054, 124716.0, 100482.0, 104107.4794626022, 105818.0, 106824.0, 106988.0, 86038.0, 91304.54347728219, 91900.0, 94529.0, 94791.46357923668, 8777.166169213915, 8843.248323892542, 9086.839749328665, 9172.862407064033, 9256.861147082935, 49484.50515494799, 49996.25005624846, 50357.49642503528, 51854.22218666648, 53441.732791335795, 45567.77216113898, 45617.54382456133, 59565.0, 70746.0, 78667.0, 12906.35468226566, 13268.601941941757, 13308.46766129344, 13322.481874258934, 13537.526186583422, 15347.259808034867, 15477.303521341792, 15685.29416176252, 15747.921260393625, 16308.0, 14181.645458863612, 14260.0, 14436.206008669624, 14853.554393368217, 15284.77072843886, 14222.644433889236, 14739.705205895607, 15071.09573425598, 15245.466408675644, 15304.464343747915, 12673.366331683195, 13883.791743123658, 14495.565133046026, 14562.781558276423, 14635.546865331613, 10957.380792811704, 11421.1434142438, 11542.94228528852, 11564.659574256837, 11765.882341176479, 10881.0, 11762.539625665031, 11777.116716246488, 11874.0, 12090.45592948337], "value": 7474.838449757807, "unit": "score"}], "name": "dromaeo_css", "value": 7141.165206310169, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 112.0, 113.0, 112.0, 112.0, 113.0, 113.0, 111.0, 111.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 121.0, 122.0, 148.0, 121.0, 121.0, 121.0, 119.0, 158.0, 123.0], "value": 130.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 159.0, 160.0, 161.0, 163.0, 163.0, 163.0, 163.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 110.0, 76.0, 76.0, 78.0, 75.0, 103.0, 76.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 120.0, 82.0, 82.0, 83.0, 106.0, 83.0, 82.0, 116.0], "value": 92.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 119.0, 117.0, 118.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 146.0, 147.0, 148.0, 146.0, 147.0, 147.0, 147.0], "value": 146.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 86.0, 85.0, 85.0, 85.0, 86.0, 85.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 52.0, 54.0, 52.0, 53.0, 54.0, 55.0, 53.0, 55.0, 54.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 58.0, 59.0, 60.0, 59.0, 60.0, 59.0, 59.0, 60.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 80.0, 80.0, 80.0, 80.0, 80.0, 82.0, 80.0, 79.0], "value": 80.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 141.0, 133.0, 132.0, 132.0, 136.0, 130.0, 132.0, 170.0, 141.0], "value": 139.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 168.0, 167.0, 166.0, 172.0, 172.0, 170.0, 172.0, 167.0], "value": 169.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 70.0, 66.0, 67.0, 68.0, 65.0, 66.0, 67.0, 70.0], "value": 67.0, "unit": "score"}], "name": "kraken", "value": 1496.1, "alertThreshold": 2.0}]} 21:46:27 INFO - Return code: 0 21:46:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:46:27 INFO - # TBPL SUCCESS # 21:46:27 INFO - Running post-action listener: _resource_record_post_action 21:46:27 INFO - [mozharness: 2016-10-19 04:46:27.954487Z] Finished run-tests step (success) 21:46:27 INFO - Running post-run listener: _resource_record_post_run 21:46:28 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 8192; Write bytes: 395333632; Read time: 180; Write time: 293084 21:46:28 INFO - TinderboxPrint: CPU usage
13.1% 21:46:28 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 180 21:46:28 INFO - TinderboxPrint: I/O write bytes / time
395,333,632 / 293,084 21:46:28 INFO - TinderboxPrint: CPU idle
8,301.8 (86.9%) 21:46:28 INFO - TinderboxPrint: CPU user
1,198.5 (12.5%) 21:46:28 INFO - TinderboxPrint: Swap in / out
0 / 0 21:46:28 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 107651072; Read time: 0; Write time: 97412 21:46:28 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287682560; Read time: 168; Write time: 195672 21:46:28 INFO - Running post-run listener: _upload_blobber_files 21:46:28 INFO - Blob upload gear active. 21:46:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:46:28 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 21:46:28 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:46:28 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:46:29 INFO - (blobuploader) - INFO - Open directory for files ... 21:46:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:46:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:46:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:46:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:46:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:46:29 INFO - (blobuploader) - INFO - Done attempting. 21:46:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:46:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:46:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:46:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:46:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:46:30 INFO - (blobuploader) - INFO - Done attempting. 21:46:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:46:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:46:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:46:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:46:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:46:33 INFO - (blobuploader) - INFO - Done attempting. 21:46:33 INFO - (blobuploader) - INFO - Iteration through files over. 21:46:33 INFO - Return code: 0 21:46:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:46:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:46:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2de43840686a866aa037b7e495c2ad83e71c71de3f499d953540e7cfb40b08eaceb32c099aad9cea0d89a0aff48480870067a517ae410b52289e987719e524cd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9fa96808e216ebdc49631c1d7bddbf7e9a6c4a2a1feddac811fe8003160322aeaa191d6760213d69dd56705b38a5d1f978845bc388404a3a306007638235c4f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82f2172246fc00caea3700eedf5e70e02b3922c6d70f0b8652e2adcb9de85f70ec47b7aae0b937d85618272fc000baae63ace4f54b72b352dced3adce126c0c3"} 21:46:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:46:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:46:33 INFO - Contents: 21:46:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2de43840686a866aa037b7e495c2ad83e71c71de3f499d953540e7cfb40b08eaceb32c099aad9cea0d89a0aff48480870067a517ae410b52289e987719e524cd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9fa96808e216ebdc49631c1d7bddbf7e9a6c4a2a1feddac811fe8003160322aeaa191d6760213d69dd56705b38a5d1f978845bc388404a3a306007638235c4f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82f2172246fc00caea3700eedf5e70e02b3922c6d70f0b8652e2adcb9de85f70ec47b7aae0b937d85618272fc000baae63ace4f54b72b352dced3adce126c0c3"} 21:46:33 INFO - Running post-run listener: copy_logs_to_upload_dir 21:46:33 INFO - Copying logs to upload dir... 21:46:33 INFO - mkdir: /builds/slave/test/build/upload/logs 21:46:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.019708 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-10-18 21:46:33.426084) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-18 21:46:33.429556) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1476851152.95006-443706985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2de43840686a866aa037b7e495c2ad83e71c71de3f499d953540e7cfb40b08eaceb32c099aad9cea0d89a0aff48480870067a517ae410b52289e987719e524cd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9fa96808e216ebdc49631c1d7bddbf7e9a6c4a2a1feddac811fe8003160322aeaa191d6760213d69dd56705b38a5d1f978845bc388404a3a306007638235c4f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82f2172246fc00caea3700eedf5e70e02b3922c6d70f0b8652e2adcb9de85f70ec47b7aae0b937d85618272fc000baae63ace4f54b72b352dced3adce126c0c3"} build_url:https://queue.taskcluster.net/v1/task/dZ7YqQnzQyS6U6iKAiGnRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011408 build_url: 'https://queue.taskcluster.net/v1/task/dZ7YqQnzQyS6U6iKAiGnRg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2de43840686a866aa037b7e495c2ad83e71c71de3f499d953540e7cfb40b08eaceb32c099aad9cea0d89a0aff48480870067a517ae410b52289e987719e524cd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9fa96808e216ebdc49631c1d7bddbf7e9a6c4a2a1feddac811fe8003160322aeaa191d6760213d69dd56705b38a5d1f978845bc388404a3a306007638235c4f5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/82f2172246fc00caea3700eedf5e70e02b3922c6d70f0b8652e2adcb9de85f70ec47b7aae0b937d85618272fc000baae63ace4f54b72b352dced3adce126c0c3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-18 21:46:33.454975) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 21:46:33.455377) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1476851152.95006-443706985 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004449 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 21:46:33.538071) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-18 21:46:33.538396) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-18 21:46:33.538675) ========= ========= Total master_lag: 0.16 =========