builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-067 starttime: 1476158743.58 results: success (0) buildid: 20161010201346 builduid: c7939a680f7c47f09fb04416d5b3de6d revision: 2976adccde9b75596c469428228177ed3d0f0b61 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-10 21:05:43.583811) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-10 21:05:43.584268) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-10 21:05:43.584543) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-10 21:05:43.602180) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 21:05:43.602540) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1476158366.299240-795935530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-10 21:05:44-- 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% 43.4M=0s 2016-10-10 21:05:44 (43.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.101751 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 21:05:43.718025) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 21:05:43.718306) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1476158366.299240-795935530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017212 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 21:05:43.767315) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 21:05:43.767667) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2976adccde9b75596c469428228177ed3d0f0b61 --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 2976adccde9b75596c469428228177ed3d0f0b61 --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=e0e61f6f900f4dc42e3e8956000001ad-1476158366.299240-795935530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-10 21:05:44,565 truncating revision to first 12 chars 2016-10-10 21:05:44,565 Setting DEBUG logging. 2016-10-10 21:05:44,565 attempt 1/10 2016-10-10 21:05:44,565 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2976adccde9b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-10 21:05:44,990 unpacking tar archive at: fx-team-2976adccde9b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.728795 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 21:05:44.509358) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-10 21:05:44.509660) ========= script_repo_revision: 2976adccde9b75596c469428228177ed3d0f0b61 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-10 21:05:44.510086) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-10 21:05:44.510493) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-10 21:05:44.520940) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-10 21:05:44.521227) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] 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=e0e61f6f900f4dc42e3e8956000001ad-1476158366.299240-795935530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:05:45 INFO - MultiFileLogger online at 20161010 21:05:45 in /builds/slave/test 21:05:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 21:05:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:05:45 INFO - {'append_to_log': False, 21:05:45 INFO - 'base_work_dir': '/builds/slave/test', 21:05:45 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 21:05:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:05:45 INFO - 'branch': 'Fx-Team-Non-PGO', 21:05:45 INFO - 'buildbot_json_path': 'buildprops.json', 21:05:45 INFO - 'config_files': ('talos/linux_config.py',), 21:05:45 INFO - 'default_actions': ('clobber', 21:05:45 INFO - 'read-buildbot-config', 21:05:45 INFO - 'download-and-extract', 21:05:45 INFO - 'populate-webroot', 21:05:45 INFO - 'create-virtualenv', 21:05:45 INFO - 'install', 21:05:45 INFO - 'run-tests'), 21:05:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:05:45 INFO - 'download_minidump_stackwalk': True, 21:05:45 INFO - 'download_symbols': 'ondemand', 21:05:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:05:45 INFO - 'tooltool.py': '/tools/tooltool.py', 21:05:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:05:45 INFO - '/tools/misc-python/virtualenv.py')}, 21:05:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:05:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:05:45 INFO - 'installer_path': 'installer.exe', 21:05:45 INFO - 'log_level': 'info', 21:05:45 INFO - 'log_name': 'talos', 21:05:45 INFO - 'log_to_console': True, 21:05:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:05:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:05:45 INFO - 'opt_config_files': (), 21:05:45 INFO - 'pip_index': False, 21:05:45 INFO - 'sps_profile': False, 21:05:45 INFO - 'sps_profile_interval': 0, 21:05:45 INFO - 'suite': 'dromaeojs', 21:05:45 INFO - 'system_bits': '32', 21:05:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:05:45 INFO - 'title': 'talos-linux64-ix-067', 21:05:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:05:45 INFO - 'use_talos_json': True, 21:05:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:05:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:05:45 INFO - 'work_dir': 'build'} 21:05:45 INFO - [mozharness: 2016-10-11 04:05:45.420538Z] Running clobber step. 21:05:45 INFO - Running pre-action listener: _resource_record_pre_action 21:05:45 INFO - Running main action method: clobber 21:05:45 INFO - rmtree: /builds/slave/test/build 21:05:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:05:45 INFO - Running post-action listener: _resource_record_post_action 21:05:45 INFO - [mozharness: 2016-10-11 04:05:45.878524Z] Finished clobber step (success) 21:05:45 INFO - [mozharness: 2016-10-11 04:05:45.878624Z] Running read-buildbot-config step. 21:05:45 INFO - Running pre-action listener: _resource_record_pre_action 21:05:45 INFO - Running main action method: read_buildbot_config 21:05:45 INFO - Using buildbot properties: 21:05:45 INFO - { 21:05:45 INFO - "project": "", 21:05:45 INFO - "product": "firefox", 21:05:45 INFO - "script_repo_revision": "production", 21:05:45 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 21:05:45 INFO - "repository": "", 21:05:45 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 21:05:45 INFO - "buildid": "20161010201346", 21:05:45 INFO - "pgo_build": "False", 21:05:45 INFO - "basedir": "/builds/slave/test", 21:05:45 INFO - "buildnumber": 3379, 21:05:45 INFO - "slavename": "talos-linux64-ix-067", 21:05:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:05:45 INFO - "platform": "ubuntu64_hw", 21:05:45 INFO - "scheduler": "tests-fx-team-linux64-talos", 21:05:45 INFO - "branch": "fx-team", 21:05:45 INFO - "repo_path": "integration/fx-team", 21:05:45 INFO - "revision": "2976adccde9b75596c469428228177ed3d0f0b61", 21:05:45 INFO - "stage_platform": "linux64", 21:05:45 INFO - "builduid": "c7939a680f7c47f09fb04416d5b3de6d", 21:05:45 INFO - "slavebuilddir": "test" 21:05:45 INFO - } 21:05:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/WswIRlIvQFeZ3puPW5AEFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 21:05:45 INFO - Running post-action listener: _resource_record_post_action 21:05:45 INFO - [mozharness: 2016-10-11 04:05:45.881045Z] Finished read-buildbot-config step (success) 21:05:45 INFO - [mozharness: 2016-10-11 04:05:45.881132Z] Running download-and-extract step. 21:05:45 INFO - Running pre-action listener: _resource_record_pre_action 21:05:45 INFO - Running main action method: download_and_extract 21:05:45 INFO - mkdir: /builds/slave/test/build/tests 21:05:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:05:45 INFO - trying https://queue.taskcluster.net/v1/task/WswIRlIvQFeZ3puPW5AEFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:05:45 INFO - Downloading https://queue.taskcluster.net/v1/task/WswIRlIvQFeZ3puPW5AEFg/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:05:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WswIRlIvQFeZ3puPW5AEFg/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:05:46 INFO - Downloaded 1361 bytes. 21:05:46 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:05:46 INFO - Using the following test package requirements: 21:05:46 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:05:46 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:05:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:05:46 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:05:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:05:46 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:05:46 INFO - u'jsshell-linux-x86_64.zip'], 21:05:46 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:05:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:05:46 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:05:46 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:05:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:05:46 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:05:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:05:46 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:05:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:05:46 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:05:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:05:46 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:05:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WswIRlIvQFeZ3puPW5AEFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:05:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WswIRlIvQFeZ3puPW5AEFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:05:46 INFO - Fetch https://queue.taskcluster.net/v1/task/WswIRlIvQFeZ3puPW5AEFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:05:47 INFO - Http code: 200 21:05:47 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 21:05:47 INFO - x-amz-cf-id: yxMWzze2bb52oBfXWxhP_M3NbCcKkre_ChcD4jg5iSTW51pekjt5lw== 21:05:47 INFO - x-amz-version-id: 4Of16SVWvVuPwjQ6E3VTl9MzGLsUTbIP 21:05:48 INFO - Expected file size: 20528825 21:05:48 INFO - Obtained file size: 20528825 21:05:52 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:05:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WswIRlIvQFeZ3puPW5AEFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:05:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WswIRlIvQFeZ3puPW5AEFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:05:52 INFO - Fetch https://queue.taskcluster.net/v1/task/WswIRlIvQFeZ3puPW5AEFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:05:52 INFO - Http code: 200 21:05:52 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 21:05:52 INFO - x-amz-cf-id: Gd8LQwyq9Od583T_BE4lWq6nEoUnhEzuMHytYOcCNdirP9XnfqrV7A== 21:05:52 INFO - x-amz-version-id: 4Of16SVWvVuPwjQ6E3VTl9MzGLsUTbIP 21:05:53 INFO - Expected file size: 20528825 21:05:53 INFO - Obtained file size: 20528825 21:05:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WswIRlIvQFeZ3puPW5AEFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 21:05:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WswIRlIvQFeZ3puPW5AEFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:05:57 INFO - Fetch https://queue.taskcluster.net/v1/task/WswIRlIvQFeZ3puPW5AEFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:05:58 INFO - Http code: 200 21:05:58 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 21:05:58 INFO - x-amz-cf-id: gR3bJJc5aqo_WUu2tt3KWqxVz6QMri0pgeCA-rh2lOwhJe_Nz-VKVw== 21:05:58 INFO - x-amz-version-id: o.PwvFKYUBudBXh3udYi1otkZN_f6.2w 21:05:59 INFO - Expected file size: 14409006 21:05:59 INFO - Obtained file size: 14409006 21:05:59 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:05:59 INFO - trying https://queue.taskcluster.net/v1/task/WswIRlIvQFeZ3puPW5AEFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:05:59 INFO - Downloading https://queue.taskcluster.net/v1/task/WswIRlIvQFeZ3puPW5AEFg/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:05:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WswIRlIvQFeZ3puPW5AEFg/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:06:01 INFO - Downloaded 55871558 bytes. 21:06:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WswIRlIvQFeZ3puPW5AEFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:06:01 INFO - mkdir: /builds/slave/test/properties 21:06:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:06:01 INFO - Writing to file /builds/slave/test/properties/build_url 21:06:01 INFO - Contents: 21:06:01 INFO - build_url:https://queue.taskcluster.net/v1/task/WswIRlIvQFeZ3puPW5AEFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:06:02 INFO - Running post-action listener: _resource_record_post_action 21:06:02 INFO - Running post-action listener: set_extra_try_arguments 21:06:02 INFO - [mozharness: 2016-10-11 04:06:02.626937Z] Finished download-and-extract step (success) 21:06:02 INFO - [mozharness: 2016-10-11 04:06:02.627162Z] Running populate-webroot step. 21:06:02 INFO - Running pre-action listener: _resource_record_pre_action 21:06:02 INFO - Running main action method: populate_webroot 21:06:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:06:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:06:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:06:02 INFO - '--tppagecycles', 21:06:02 INFO - '7'], 21:06:02 INFO - 'tests': ['tsvgm']}}, 21:06:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:06:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:06:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:06:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:06:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:06:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:06:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:06:02 INFO - 'talos_options': ['--disable-e10s'], 21:06:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:06:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:06:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:06:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:06:02 INFO - 'talos_options': ['--disable-e10s'], 21:06:02 INFO - 'tests': ['damp', 'tps']}, 21:06:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:06:02 INFO - 'tests': ['damp', 'tps']}, 21:06:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:06:02 INFO - 'tests': ['dromaeo_dom']}, 21:06:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:06:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:06:02 INFO - 'tests': ['basic_compositor_video']}, 21:06:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:06:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:06:02 INFO - 'tests': ['a11yr', 21:06:02 INFO - 'ts_paint', 21:06:02 INFO - 'tpaint', 21:06:02 INFO - 'sessionrestore', 21:06:02 INFO - 'sessionrestore_no_auto_restore', 21:06:02 INFO - 'tabpaint']}, 21:06:02 INFO - 'other-e10s': {'tests': ['a11yr', 21:06:02 INFO - 'ts_paint', 21:06:02 INFO - 'tpaint', 21:06:02 INFO - 'sessionrestore', 21:06:02 INFO - 'sessionrestore_no_auto_restore', 21:06:02 INFO - 'tabpaint']}, 21:06:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:06:02 INFO - 'ts_paint', 21:06:02 INFO - 'tpaint', 21:06:02 INFO - 'sessionrestore', 21:06:02 INFO - 'sessionrestore_no_auto_restore', 21:06:02 INFO - 'tabpaint']}, 21:06:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:06:02 INFO - 'ts_paint', 21:06:02 INFO - 'tpaint', 21:06:02 INFO - 'sessionrestore', 21:06:02 INFO - 'sessionrestore_no_auto_restore', 21:06:02 INFO - 'tabpaint']}, 21:06:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:06:02 INFO - 'tests': ['a11yr', 21:06:02 INFO - 'ts_paint', 21:06:02 INFO - 'tpaint', 21:06:02 INFO - 'sessionrestore', 21:06:02 INFO - 'sessionrestore_no_auto_restore', 21:06:02 INFO - 'tabpaint']}, 21:06:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:06:02 INFO - 'tests': ['a11yr', 21:06:02 INFO - 'ts_paint', 21:06:02 INFO - 'tpaint', 21:06:02 INFO - 'sessionrestore', 21:06:02 INFO - 'sessionrestore_no_auto_restore', 21:06:02 INFO - 'tabpaint']}, 21:06:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:06:02 INFO - 'tests': ['tsvgx', 21:06:02 INFO - 'tsvgr_opacity', 21:06:02 INFO - 'tart', 21:06:02 INFO - 'tscrollx', 21:06:02 INFO - 'cart']}, 21:06:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:06:02 INFO - 'tsvgr_opacity', 21:06:02 INFO - 'tart', 21:06:02 INFO - 'tscrollx', 21:06:02 INFO - 'cart']}, 21:06:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:06:02 INFO - 'talos_options': ['--disable-e10s'], 21:06:02 INFO - 'tests': ['tp5o']}, 21:06:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:06:02 INFO - 'tests': ['tp5o']}, 21:06:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:06:02 INFO - 'talos_options': ['--disable-e10s', 21:06:02 INFO - '--xperf_path', 21:06:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:06:02 INFO - 'tests': ['tp5n']}, 21:06:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:06:02 INFO - 'talos_options': ['--xperf_path', 21:06:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:06:02 INFO - 'tests': ['tp5n']}}, 21:06:02 INFO - 'talos.zip': {'path': '', 21:06:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:06:02 INFO - Running post-action listener: _resource_record_post_action 21:06:02 INFO - [mozharness: 2016-10-11 04:06:02.646162Z] Finished populate-webroot step (success) 21:06:02 INFO - [mozharness: 2016-10-11 04:06:02.646249Z] Running create-virtualenv step. 21:06:02 INFO - Running pre-action listener: _resource_record_pre_action 21:06:02 INFO - Running main action method: create_virtualenv 21:06:02 INFO - Creating virtualenv /builds/slave/test/build/venv 21:06:02 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:06:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:06:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:06:02 INFO - Using real prefix '/usr' 21:06:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:06:03 INFO - Installing distribute.............................................................................................................................................................................................done. 21:06:05 INFO - Installing pip.................done. 21:06:05 INFO - Return code: 0 21:06:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:06:05 INFO - Reading from file tmpfile_stdout 21:06:05 INFO - Output received: 21:06:05 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:06:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:06:05 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:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:06:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:05 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:06:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:06:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:05 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 0x7fce92520f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c66ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c63f60>, '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 0x2c64d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c651d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1476158366.299240-795935530', '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:06:05 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:06:05 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:06:05 INFO - Using env: {'DISPLAY': ':0', 21:06:05 INFO - 'HOME': '/home/cltbld', 21:06:05 INFO - 'LANG': 'en_US.UTF-8', 21:06:05 INFO - 'LANGUAGE': 'en_US:en', 21:06:05 INFO - 'LOGNAME': 'cltbld', 21:06:05 INFO - 'MAIL': '/var/mail/cltbld', 21:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:06:05 INFO - 'MOZ_NO_REMOTE': '1', 21:06:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:06:05 INFO - 'NO_EM_RESTART': '1', 21:06:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:06:05 INFO - 'PWD': '/builds/slave/test', 21:06:05 INFO - 'SHELL': '/bin/bash', 21:06:05 INFO - 'SHLVL': '1', 21:06:05 INFO - 'TERM': 'linux', 21:06:05 INFO - 'TMOUT': '86400', 21:06:05 INFO - 'USER': 'cltbld', 21:06:05 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1476158366.299240-795935530', 21:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:06:05 INFO - '_': '/tools/buildbot/bin/python'} 21:06:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:06:05 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:06:05 INFO - Cleaning up... 21:06:05 INFO - Return code: 0 21:06:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:06:05 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:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:06:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:05 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:06:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:06:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:05 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 0x7fce92520f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c66ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c63f60>, '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 0x2c64d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c651d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1476158366.299240-795935530', '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:06:05 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:06:05 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:06:05 INFO - Using env: {'DISPLAY': ':0', 21:06:05 INFO - 'HOME': '/home/cltbld', 21:06:05 INFO - 'LANG': 'en_US.UTF-8', 21:06:05 INFO - 'LANGUAGE': 'en_US:en', 21:06:05 INFO - 'LOGNAME': 'cltbld', 21:06:05 INFO - 'MAIL': '/var/mail/cltbld', 21:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:06:05 INFO - 'MOZ_NO_REMOTE': '1', 21:06:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:06:05 INFO - 'NO_EM_RESTART': '1', 21:06:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:06:05 INFO - 'PWD': '/builds/slave/test', 21:06:05 INFO - 'SHELL': '/bin/bash', 21:06:05 INFO - 'SHLVL': '1', 21:06:05 INFO - 'TERM': 'linux', 21:06:05 INFO - 'TMOUT': '86400', 21:06:05 INFO - 'USER': 'cltbld', 21:06:05 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1476158366.299240-795935530', 21:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:06:05 INFO - '_': '/tools/buildbot/bin/python'} 21:06:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:06:05 INFO - Downloading/unpacking psutil>=3.1.1 21:06:05 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:06:05 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:06:05 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:06:05 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:06:05 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:06:05 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:06:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:06:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:06:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:06:07 INFO - Installing collected packages: psutil 21:06:07 INFO - Running setup.py install for psutil 21:06:07 INFO - building 'psutil._psutil_linux' extension 21:06:07 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:06:08 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:06:08 INFO - building 'psutil._psutil_posix' extension 21:06:08 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:06:08 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:06:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:06:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:06:08 INFO - Successfully installed psutil 21:06:08 INFO - Cleaning up... 21:06:08 INFO - Return code: 0 21:06:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:06:08 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:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:06:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:08 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:06:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:06:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:08 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 0x7fce92520f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c66ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c63f60>, '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 0x2c64d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c651d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1476158366.299240-795935530', '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:06:08 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:06:08 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:06:08 INFO - Using env: {'DISPLAY': ':0', 21:06:08 INFO - 'HOME': '/home/cltbld', 21:06:08 INFO - 'LANG': 'en_US.UTF-8', 21:06:08 INFO - 'LANGUAGE': 'en_US:en', 21:06:08 INFO - 'LOGNAME': 'cltbld', 21:06:08 INFO - 'MAIL': '/var/mail/cltbld', 21:06:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:06:08 INFO - 'MOZ_NO_REMOTE': '1', 21:06:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:06:08 INFO - 'NO_EM_RESTART': '1', 21:06:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:06:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:06:08 INFO - 'PWD': '/builds/slave/test', 21:06:08 INFO - 'SHELL': '/bin/bash', 21:06:08 INFO - 'SHLVL': '1', 21:06:08 INFO - 'TERM': 'linux', 21:06:08 INFO - 'TMOUT': '86400', 21:06:08 INFO - 'USER': 'cltbld', 21:06:08 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1476158366.299240-795935530', 21:06:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:06:08 INFO - '_': '/tools/buildbot/bin/python'} 21:06:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:06:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:06:08 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:06:08 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:06:08 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:06:08 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:06:08 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:06:08 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:06:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:06:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:06:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:06:10 INFO - Installing collected packages: mozsystemmonitor 21:06:10 INFO - Running setup.py install for mozsystemmonitor 21:06:10 INFO - Successfully installed mozsystemmonitor 21:06:10 INFO - Cleaning up... 21:06:10 INFO - Return code: 0 21:06:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:06:10 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:06:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:06:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:10 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:06:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:06:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:10 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 0x7fce92520f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c66ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c63f60>, '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 0x2c64d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c651d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1476158366.299240-795935530', '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:06:10 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:06:10 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:06:10 INFO - Using env: {'DISPLAY': ':0', 21:06:10 INFO - 'HOME': '/home/cltbld', 21:06:10 INFO - 'LANG': 'en_US.UTF-8', 21:06:10 INFO - 'LANGUAGE': 'en_US:en', 21:06:10 INFO - 'LOGNAME': 'cltbld', 21:06:10 INFO - 'MAIL': '/var/mail/cltbld', 21:06:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:06:10 INFO - 'MOZ_NO_REMOTE': '1', 21:06:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:06:10 INFO - 'NO_EM_RESTART': '1', 21:06:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:06:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:06:10 INFO - 'PWD': '/builds/slave/test', 21:06:10 INFO - 'SHELL': '/bin/bash', 21:06:10 INFO - 'SHLVL': '1', 21:06:10 INFO - 'TERM': 'linux', 21:06:10 INFO - 'TMOUT': '86400', 21:06:10 INFO - 'USER': 'cltbld', 21:06:10 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1476158366.299240-795935530', 21:06:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:06:10 INFO - '_': '/tools/buildbot/bin/python'} 21:06:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:06:11 INFO - Downloading/unpacking jsonschema==2.5.1 21:06: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:06: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:06: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:06: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:06: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:06: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:06:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:06:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:06:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:06:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:06:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:06:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:06:13 INFO - Downloading functools32-3.2.3-2.tar.gz 21:06:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:06:13 INFO - warning: no files found matching '*.txt' 21:06:13 INFO - no previously-included directories found matching 'build' 21:06:13 INFO - no previously-included directories found matching 'dist' 21:06:13 INFO - no previously-included directories found matching '.git*' 21:06:13 INFO - Installing collected packages: jsonschema, functools32 21:06:13 INFO - Running setup.py install for functools32 21:06:13 INFO - warning: no files found matching '*.txt' 21:06:13 INFO - no previously-included directories found matching 'build' 21:06:13 INFO - no previously-included directories found matching 'dist' 21:06:13 INFO - no previously-included directories found matching '.git*' 21:06:13 INFO - Successfully installed jsonschema functools32 21:06:13 INFO - Cleaning up... 21:06:13 INFO - Return code: 0 21:06:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:06:13 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:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:06:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:13 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:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:06:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:13 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 0x7fce92520f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c66ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c63f60>, '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 0x2c64d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c651d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1476158366.299240-795935530', '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:06:13 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:06:13 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:06:13 INFO - Using env: {'DISPLAY': ':0', 21:06:13 INFO - 'HOME': '/home/cltbld', 21:06:13 INFO - 'LANG': 'en_US.UTF-8', 21:06:13 INFO - 'LANGUAGE': 'en_US:en', 21:06:13 INFO - 'LOGNAME': 'cltbld', 21:06:13 INFO - 'MAIL': '/var/mail/cltbld', 21:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:06:13 INFO - 'MOZ_NO_REMOTE': '1', 21:06:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:06:13 INFO - 'NO_EM_RESTART': '1', 21:06:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:06:13 INFO - 'PWD': '/builds/slave/test', 21:06:13 INFO - 'SHELL': '/bin/bash', 21:06:13 INFO - 'SHLVL': '1', 21:06:13 INFO - 'TERM': 'linux', 21:06:13 INFO - 'TMOUT': '86400', 21:06:13 INFO - 'USER': 'cltbld', 21:06:13 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1476158366.299240-795935530', 21:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:06:13 INFO - '_': '/tools/buildbot/bin/python'} 21:06:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:06:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:06:13 INFO - Cleaning up... 21:06:13 INFO - Return code: 0 21:06:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:06:13 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:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:06:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:13 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:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:06:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:13 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 0x7fce92520f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c66ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c63f60>, '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 0x2c64d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c651d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1476158366.299240-795935530', '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:06:13 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:06:13 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:06:13 INFO - Using env: {'DISPLAY': ':0', 21:06:13 INFO - 'HOME': '/home/cltbld', 21:06:13 INFO - 'LANG': 'en_US.UTF-8', 21:06:13 INFO - 'LANGUAGE': 'en_US:en', 21:06:13 INFO - 'LOGNAME': 'cltbld', 21:06:13 INFO - 'MAIL': '/var/mail/cltbld', 21:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:06:13 INFO - 'MOZ_NO_REMOTE': '1', 21:06:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:06:13 INFO - 'NO_EM_RESTART': '1', 21:06:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:06:13 INFO - 'PWD': '/builds/slave/test', 21:06:13 INFO - 'SHELL': '/bin/bash', 21:06:13 INFO - 'SHLVL': '1', 21:06:13 INFO - 'TERM': 'linux', 21:06:13 INFO - 'TMOUT': '86400', 21:06:13 INFO - 'USER': 'cltbld', 21:06:13 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1476158366.299240-795935530', 21:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:06:13 INFO - '_': '/tools/buildbot/bin/python'} 21:06:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:06:13 INFO - Downloading/unpacking blobuploader==1.2.4 21:06:13 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:06:13 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:06:13 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:06:13 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:06:13 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:06:13 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:06:15 INFO - Downloading blobuploader-1.2.4.tar.gz 21:06:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:06:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:06: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:06: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:06: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:06: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:06: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:06: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:06:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:06:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:06: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:06: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:06: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:06: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:06: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:06: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:06:16 INFO - Downloading docopt-0.6.1.tar.gz 21:06:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:06:16 INFO - Installing collected packages: blobuploader, requests, docopt 21:06:16 INFO - Running setup.py install for blobuploader 21:06:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:06:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:06:16 INFO - Running setup.py install for requests 21:06:17 INFO - Running setup.py install for docopt 21:06:17 INFO - Successfully installed blobuploader requests docopt 21:06:17 INFO - Cleaning up... 21:06:17 INFO - Return code: 0 21:06:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:06:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:06:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:06:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:06:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:06:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:17 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 0x7fce92520f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c66ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c63f60>, '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 0x2c64d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c651d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1476158366.299240-795935530', '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:06:17 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:06:17 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:06:17 INFO - Using env: {'DISPLAY': ':0', 21:06:17 INFO - 'HOME': '/home/cltbld', 21:06:17 INFO - 'LANG': 'en_US.UTF-8', 21:06:17 INFO - 'LANGUAGE': 'en_US:en', 21:06:17 INFO - 'LOGNAME': 'cltbld', 21:06:17 INFO - 'MAIL': '/var/mail/cltbld', 21:06:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:06:17 INFO - 'MOZ_NO_REMOTE': '1', 21:06:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:06:17 INFO - 'NO_EM_RESTART': '1', 21:06:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:06:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:06:17 INFO - 'PWD': '/builds/slave/test', 21:06:17 INFO - 'SHELL': '/bin/bash', 21:06:17 INFO - 'SHLVL': '1', 21:06:17 INFO - 'TERM': 'linux', 21:06:17 INFO - 'TMOUT': '86400', 21:06:17 INFO - 'USER': 'cltbld', 21:06:17 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1476158366.299240-795935530', 21:06:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:06:17 INFO - '_': '/tools/buildbot/bin/python'} 21:06:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:06:17 INFO - Running setup.py (path:/tmp/pip-xOHzcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:06:17 INFO - Running setup.py (path:/tmp/pip-Uan0YG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:06:17 INFO - Running setup.py (path:/tmp/pip-7XkCLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:06:17 INFO - Running setup.py (path:/tmp/pip-I5dwgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:06:17 INFO - Running setup.py (path:/tmp/pip-mB9v9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:06:17 INFO - Running setup.py (path:/tmp/pip-XQk1eI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:06:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:06:17 INFO - Running setup.py (path:/tmp/pip-m1HCzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:06:18 INFO - Running setup.py (path:/tmp/pip-MPyWEW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:06:18 INFO - Running setup.py (path:/tmp/pip-ehzBfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:06:18 INFO - Running setup.py (path:/tmp/pip-XrTyRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:06:18 INFO - Running setup.py (path:/tmp/pip-6fhCvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:06:18 INFO - Running setup.py (path:/tmp/pip-erNLxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:06:18 INFO - Running setup.py (path:/tmp/pip-W8n59b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:06:18 INFO - Running setup.py (path:/tmp/pip-rcZuy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:06:18 INFO - Running setup.py (path:/tmp/pip-JZE0hp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:06:18 INFO - Running setup.py (path:/tmp/pip-QA0QEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:06:18 INFO - Running setup.py (path:/tmp/pip-7gx67I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:06:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:06:18 INFO - Running setup.py install for manifestparser 21:06:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:06:18 INFO - Running setup.py install for mozcrash 21:06:19 INFO - Running setup.py install for mozdebug 21:06:19 INFO - Running setup.py install for mozdevice 21:06:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:06:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:06:19 INFO - Running setup.py install for mozfile 21:06:19 INFO - Running setup.py install for mozhttpd 21:06:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:06:19 INFO - Running setup.py install for mozinfo 21:06:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:06:19 INFO - Running setup.py install for mozInstall 21:06:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:06:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:06:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:06:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:06:19 INFO - Running setup.py install for mozleak 21:06:19 INFO - Running setup.py install for mozlog 21:06:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:06:19 INFO - Running setup.py install for moznetwork 21:06:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:06:19 INFO - Running setup.py install for mozprocess 21:06:20 INFO - Running setup.py install for mozprofile 21:06:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:06:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:06:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:06:20 INFO - Running setup.py install for mozrunner 21:06:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:06:20 INFO - Running setup.py install for mozscreenshot 21:06:20 INFO - Running setup.py install for moztest 21:06:20 INFO - Running setup.py install for mozversion 21:06:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:06:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:06:20 INFO - Cleaning up... 21:06:20 INFO - Return code: 0 21:06:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:06:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:06:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:06:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:06:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:20 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 0x7fce92520f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c66ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c63f60>, '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 0x2c64d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c651d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1476158366.299240-795935530', '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:06:20 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:06:20 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:06:20 INFO - Using env: {'DISPLAY': ':0', 21:06:20 INFO - 'HOME': '/home/cltbld', 21:06:20 INFO - 'LANG': 'en_US.UTF-8', 21:06:20 INFO - 'LANGUAGE': 'en_US:en', 21:06:20 INFO - 'LOGNAME': 'cltbld', 21:06:20 INFO - 'MAIL': '/var/mail/cltbld', 21:06:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:06:20 INFO - 'MOZ_NO_REMOTE': '1', 21:06:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:06:20 INFO - 'NO_EM_RESTART': '1', 21:06:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:06:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:06:20 INFO - 'PWD': '/builds/slave/test', 21:06:20 INFO - 'SHELL': '/bin/bash', 21:06:20 INFO - 'SHLVL': '1', 21:06:20 INFO - 'TERM': 'linux', 21:06:20 INFO - 'TMOUT': '86400', 21:06:20 INFO - 'USER': 'cltbld', 21:06:20 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1476158366.299240-795935530', 21:06:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:06:20 INFO - '_': '/tools/buildbot/bin/python'} 21:06:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:06:20 INFO - Running setup.py (path:/tmp/pip-Zhgc1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:06:20 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:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:06:20 INFO - Running setup.py (path:/tmp/pip-Jbz39g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:06:20 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:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:06:20 INFO - Running setup.py (path:/tmp/pip-YDXkls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:06:21 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:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:06:21 INFO - Running setup.py (path:/tmp/pip-_qrdJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:06:21 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:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:06:21 INFO - Running setup.py (path:/tmp/pip-eRKJou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:06:21 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:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:06:21 INFO - Running setup.py (path:/tmp/pip-2VYVGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:06:21 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:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:06:21 INFO - Running setup.py (path:/tmp/pip-n_XHVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:06:21 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:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:06:21 INFO - Running setup.py (path:/tmp/pip-Ra5_d9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:06:21 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:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:06:21 INFO - Running setup.py (path:/tmp/pip-3IqrJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:06:21 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:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:06:21 INFO - Running setup.py (path:/tmp/pip-8U22nX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:06:21 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:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:06:21 INFO - Running setup.py (path:/tmp/pip-hIQ5xv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:06:21 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:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:06:21 INFO - Running setup.py (path:/tmp/pip-PPI8OR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:06:21 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:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:06:21 INFO - Running setup.py (path:/tmp/pip-Y0vEVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:06:21 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:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:06:21 INFO - Running setup.py (path:/tmp/pip-CnP7G5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:06:21 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:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:06:21 INFO - Running setup.py (path:/tmp/pip-cyZm0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:06:21 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:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:06:21 INFO - Running setup.py (path:/tmp/pip-aQ0z_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:06:21 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:06:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:06:21 INFO - Running setup.py (path:/tmp/pip-wqmx81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:06:22 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:06:22 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:06:22 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:06:22 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:06:22 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:06:22 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:06:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:06:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:06:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:06:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:06:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:06:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:06:23 INFO - Downloading blessings-1.6.tar.gz 21:06:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:06:24 INFO - Installing collected packages: blessings 21:06:24 INFO - Running setup.py install for blessings 21:06:24 INFO - Successfully installed blessings 21:06:24 INFO - Cleaning up... 21:06:24 INFO - Return code: 0 21:06:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:06:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:06:24 INFO - Reading from file tmpfile_stdout 21:06:24 INFO - Current package versions: 21:06:24 INFO - argparse == 1.2.1 21:06:24 INFO - blessings == 1.6 21:06:24 INFO - blobuploader == 1.2.4 21:06:24 INFO - docopt == 0.6.1 21:06:24 INFO - functools32 == 3.2.3-2 21:06:24 INFO - jsonschema == 2.5.1 21:06:24 INFO - manifestparser == 1.1 21:06:24 INFO - mozInstall == 1.12 21:06:24 INFO - mozcrash == 0.17 21:06:24 INFO - mozdebug == 0.1 21:06:24 INFO - mozdevice == 0.48 21:06:24 INFO - mozfile == 1.2 21:06:24 INFO - mozhttpd == 0.7 21:06:24 INFO - mozinfo == 0.9 21:06:24 INFO - mozleak == 0.1 21:06:24 INFO - mozlog == 3.4 21:06:24 INFO - moznetwork == 0.27 21:06:24 INFO - mozprocess == 0.23 21:06:24 INFO - mozprofile == 0.28 21:06:24 INFO - mozrunner == 6.12 21:06:24 INFO - mozscreenshot == 0.1 21:06:24 INFO - mozsystemmonitor == 0.3 21:06:24 INFO - moztest == 0.7 21:06:24 INFO - mozversion == 1.4 21:06:24 INFO - psutil == 3.1.1 21:06:24 INFO - requests == 1.2.3 21:06:24 INFO - wsgiref == 0.1.2 21:06:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:06:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:06:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:06:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:06:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:06:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:24 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 0x7fce92520f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c66ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c63f60>, '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 0x2c64d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c651d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1476158366.299240-795935530', '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:06:24 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:06:24 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:06:24 INFO - Using env: {'DISPLAY': ':0', 21:06:24 INFO - 'HOME': '/home/cltbld', 21:06:24 INFO - 'LANG': 'en_US.UTF-8', 21:06:24 INFO - 'LANGUAGE': 'en_US:en', 21:06:24 INFO - 'LOGNAME': 'cltbld', 21:06:24 INFO - 'MAIL': '/var/mail/cltbld', 21:06:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:06:24 INFO - 'MOZ_NO_REMOTE': '1', 21:06:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:06:24 INFO - 'NO_EM_RESTART': '1', 21:06:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:06:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:06:24 INFO - 'PWD': '/builds/slave/test', 21:06:24 INFO - 'SHELL': '/bin/bash', 21:06:24 INFO - 'SHLVL': '1', 21:06:24 INFO - 'TERM': 'linux', 21:06:24 INFO - 'TMOUT': '86400', 21:06:24 INFO - 'USER': 'cltbld', 21:06:24 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1476158366.299240-795935530', 21:06:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:06:24 INFO - '_': '/tools/buildbot/bin/python'} 21:06:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:06:24 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:06:24 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:06:24 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:06:24 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:06:24 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:06:24 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:06:24 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:06:24 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:06:24 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:06:24 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:06:24 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:06:24 INFO - Cleaning up... 21:06:24 INFO - Return code: 0 21:06:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:06:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:06:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:06:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:06:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:06:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:06:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fce92520f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b998a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c66ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c63f60>, '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 0x2c64d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c651d0>, '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': 'e0e61f6f900f4dc42e3e8956000001ad-1476158366.299240-795935530', '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:06:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:06:24 INFO - Using env: {'DISPLAY': ':0', 21:06:24 INFO - 'HOME': '/home/cltbld', 21:06:24 INFO - 'LANG': 'en_US.UTF-8', 21:06:24 INFO - 'LANGUAGE': 'en_US:en', 21:06:24 INFO - 'LOGNAME': 'cltbld', 21:06:24 INFO - 'MAIL': '/var/mail/cltbld', 21:06:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:06:24 INFO - 'MOZ_NO_REMOTE': '1', 21:06:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:06:24 INFO - 'NO_EM_RESTART': '1', 21:06:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:06:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:06:24 INFO - 'PWD': '/builds/slave/test', 21:06:24 INFO - 'SHELL': '/bin/bash', 21:06:24 INFO - 'SHLVL': '1', 21:06:24 INFO - 'TERM': 'linux', 21:06:24 INFO - 'TMOUT': '86400', 21:06:24 INFO - 'USER': 'cltbld', 21:06:24 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1476158366.299240-795935530', 21:06:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:06:24 INFO - '_': '/tools/buildbot/bin/python'} 21:06:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:06:24 INFO - Cleaning up... 21:06:24 INFO - Return code: 0 21:06:24 INFO - Running post-action listener: _resource_record_post_action 21:06:24 INFO - Running post-action listener: _start_resource_monitoring 21:06:24 INFO - Starting resource monitoring. 21:06:24 INFO - [mozharness: 2016-10-11 04:06:24.947084Z] Finished create-virtualenv step (success) 21:06:24 INFO - [mozharness: 2016-10-11 04:06:24.947585Z] Running install step. 21:06:24 INFO - Running pre-action listener: _resource_record_pre_action 21:06:24 INFO - Running main action method: install 21:06:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:06:25 INFO - Reading from file tmpfile_stdout 21:06:25 INFO - Detecting whether we're running mozinstall >=1.0... 21:06:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:06:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:06:25 INFO - Reading from file tmpfile_stdout 21:06:25 INFO - Output received: 21:06:25 INFO - Usage: mozinstall [options] installer 21:06:25 INFO - Options: 21:06:25 INFO - -h, --help show this help message and exit 21:06:25 INFO - -d DEST, --destination=DEST 21:06:25 INFO - Directory to install application into. [default: 21:06:25 INFO - "/builds/slave/test"] 21:06:25 INFO - --app=APP Application being installed. [default: firefox] 21:06:25 INFO - mkdir: /builds/slave/test/build/application 21:06:25 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:06:25 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:06:41 INFO - Reading from file tmpfile_stdout 21:06:41 INFO - Output received: 21:06:41 INFO - /builds/slave/test/build/application/firefox/firefox 21:06:41 INFO - Running post-action listener: _resource_record_post_action 21:06:41 INFO - [mozharness: 2016-10-11 04:06:41.410284Z] Finished install step (success) 21:06:41 INFO - [mozharness: 2016-10-11 04:06:41.410615Z] Running run-tests step. 21:06:41 INFO - Running pre-action listener: _resource_record_pre_action 21:06:41 INFO - Running main action method: run_tests 21:06:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:06:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:06:41 INFO - Python 2.7.3 21:06:41 INFO - Return code: 0 21:06:41 INFO - grabbing minidump binary from tooltool 21:06:41 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:06:41 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 0x2c63f60>, '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 0x2c64d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c651d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:06:41 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:06:41 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:06:41 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:06:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:06:41 INFO - Return code: 0 21:06:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:06:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:06:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:06:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:06:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:06:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WswIRlIvQFeZ3puPW5AEFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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:06:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WswIRlIvQFeZ3puPW5AEFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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:06:41 INFO - Using env: {'DISPLAY': ':0', 21:06:41 INFO - 'HOME': '/home/cltbld', 21:06:41 INFO - 'LANG': 'en_US.UTF-8', 21:06:41 INFO - 'LANGUAGE': 'en_US:en', 21:06:41 INFO - 'LOGNAME': 'cltbld', 21:06:41 INFO - 'MAIL': '/var/mail/cltbld', 21:06:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:06:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:06:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:06:41 INFO - 'MOZ_NO_REMOTE': '1', 21:06:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:06:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:06:41 INFO - 'NO_EM_RESTART': '1', 21:06:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:06:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:06:41 INFO - 'PWD': '/builds/slave/test', 21:06:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:06:41 INFO - 'SHELL': '/bin/bash', 21:06:41 INFO - 'SHLVL': '1', 21:06:41 INFO - 'TERM': 'linux', 21:06:41 INFO - 'TMOUT': '86400', 21:06:41 INFO - 'USER': 'cltbld', 21:06:41 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1476158366.299240-795935530', 21:06:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:06:41 INFO - '_': '/tools/buildbot/bin/python'} 21:06:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WswIRlIvQFeZ3puPW5AEFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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:06:41 INFO - mozversion application_buildid: 20161010201346 21:06:41 INFO - mozversion application_changeset: 2976adccde9b75596c469428228177ed3d0f0b61 21:06:41 INFO - mozversion application_display_name: Nightly 21:06:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:06:41 INFO - mozversion application_name: Firefox 21:06:41 INFO - mozversion application_remotingname: firefox 21:06:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:06:41 INFO - mozversion application_vendor: Mozilla 21:06:41 INFO - mozversion application_version: 52.0a1 21:06:41 INFO - mozversion platform_buildid: 20161010201346 21:06:41 INFO - mozversion platform_changeset: 2976adccde9b75596c469428228177ed3d0f0b61 21:06:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:06:41 INFO - mozversion platform_version: 52.0a1 21:06:41 INFO - using testdate: 1476158801 21:06:41 INFO - actual date: 1476158801 21:06:41 INFO - starting webserver on 'localhost:33180' 21:06:41 INFO - SUITE-START | Running 2 tests 21:06:41 INFO - TEST-START | dromaeo_css 21:06:41 INFO - operating with platform_type : linux_ 21:06:41 INFO - Initialising browser for dromaeo_css test... 21:06:41 INFO - TEST-INFO | started process 8648 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4_qehQ/profile http://localhost:33180/getInfo.html) 21:06:46 INFO - PROCESS | 8648 | __metrics Screen width/height:1600/1200 21:06:46 INFO - PROCESS | 8648 | colorDepth:24 21:06:46 INFO - PROCESS | 8648 | Browser inner width/height: 1024/697 21:06:46 INFO - PROCESS | 8648 | __metrics 21:06:46 INFO - PROCESS | 8648 | 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:06:46 INFO - PROCESS | 8648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:06:47 INFO - TEST-INFO | 8648: exit 0 21:06:47 INFO - Browser initialized. 21:06:47 INFO - Running cycle 1/1 for dromaeo_css test... 21:06:47 INFO - TEST-INFO | started process 8732 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4_qehQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:07:00 INFO - PROCESS | 8732 | RSS: Main: 174673920 21:07:00 INFO - PROCESS | 8732 | 21:07:50 INFO - PROCESS | 8732 | 1476158870781 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:10:05 INFO - PROCESS | 8732 | Cycle 1(1): loaded http://localhost:33180/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33180/tests/dromaeo/cssquery-ext.html) 21:10:06 INFO - PROCESS | 8732 | RSS: Main: 299999232 21:10:06 INFO - PROCESS | 8732 | 21:13:09 INFO - PROCESS | 8732 | Cycle 1(1): loaded http://localhost:33180/tests/dromaeo/cssquery-ext.html (next: http://localhost:33180/tests/dromaeo/cssquery-jquery.html) 21:13:09 INFO - PROCESS | 8732 | RSS: Main: 277655552 21:13:09 INFO - PROCESS | 8732 | 21:16:11 INFO - PROCESS | 8732 | Cycle 1(1): loaded http://localhost:33180/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33180/tests/dromaeo/cssquery-mootools.html) 21:16:12 INFO - PROCESS | 8732 | RSS: Main: 259252224 21:16:12 INFO - PROCESS | 8732 | 21:19:14 INFO - PROCESS | 8732 | Cycle 1(1): loaded http://localhost:33180/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33180/tests/dromaeo/cssquery-prototype.html) 21:19:15 INFO - PROCESS | 8732 | RSS: Main: 219414528 21:19:15 INFO - PROCESS | 8732 | 21:22:18 INFO - PROCESS | 8732 | Cycle 1(1): loaded http://localhost:33180/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33180/tests/dromaeo/cssquery-yui.html) 21:22:19 INFO - PROCESS | 8732 | RSS: Main: 222572544 21:22:19 INFO - PROCESS | 8732 | 21:25:22 INFO - PROCESS | 8732 | Cycle 1(1): loaded http://localhost:33180/tests/dromaeo/cssquery-yui.html (next: http://localhost:33180/tests/dromaeo/cssquery-dojo.html) 21:25:22 INFO - PROCESS | 8732 | RSS: Main: 309358592 21:25:22 INFO - PROCESS | 8732 | 21:25:22 INFO - PROCESS | 8732 | __start_tp_report 21:25:22 INFO - PROCESS | 8732 | _x_x_mozilla_page_load 21:25:22 INFO - PROCESS | 8732 | _x_x_mozilla_page_load_details 21:25:22 INFO - PROCESS | 8732 | |i|pagename|runs| 21:25:22 INFO - PROCESS | 8732 | |0;dojo.html;2569.1650213680555;2584.1988983415154;2616.4113074558227;2627.4745050989795;2641.1548304542553;4556.84051058213;4617.492075871652;4712.293156026598;4743.359646447733;4751.976240118799;4614.492405835355;4661.976690116545;4689.554492323224;4726.763661816913;4778.546038126373;4249.617534421902;4256.4679415073115;4306.870793876173;4325.4593175853015;4335.219660461115;4298.634616057639;4376.671749618776;4405.933910991338;4417.22698527758;4464.486584042828;4214.662826973835;4342.50061242958;4357.782110894458;4359.912801743947;4458.71018383804;4247.68142389322;4269.444972153631;4271.508776490681;4296.0978194579175;4314.741115533078;4262.957370426287;4270.636995855356;4275.508316543606;4322.178786030644;4332.3068309070395;4654.418197725285;4660.04469083837;4666.580007799281;4677.555632214968;4687.156311863863;4830.589399901012;4849.199882019462;4852.951470485285;4940.7035577865445;4961.280614310941;4953.653244272902;4971.776270067856;5000.974995125038;5044.571211447032;5058.215976523645;4651.2557990721325;4656.371389862393;4661.254199328159;4667.323238130452;4715.834945776881;4973.079980203674;5035.748212589429;5089.338386009869;5164.664296820694;5166.61250406221;4853.3447984522345;4869.026194761062;4898.755062246873;4979.053979743837;5076.36545431821;4988.825391111293;5001.9499805002215;5003.54968052877;5004.874878128076;5062.417821950449;4795.400574928134;4824.49342818999;4944.1100601891285;4959.156943319645;5024.497550244946;4906.141425250638;4969.378827646544;5001.299818025479;5013.949860501421;5020.3724534433195;4311.6335111515245;4323.113761678911;4325.3728209409455;4329.675274354436;4382.583654552813;3719.1445967427644;3765.548134223911;3770.698344132463;3796.6583007529457;3832.3485007548225;4253.04306531028;4321.2653848845775;4341.6526677865695;4363.258246098171;4414.271645178574;5114.9232761507865;5117.974410127926;5124.5131712487255;5138.075146473596;5187.662801917863;4323.7621930793475;4331.003869110059;4358.389825424443;4369.104333611602;4423.159599676115;4402.229609818269;4435.512093669694;4464.17412778637;4550.317452382169;4557.95442045582;4701.03628756111;4707.882302942454;4719.952800472089;4768.690035147704;4772.546608072227;5020.774065167003;5021.54806067441;5025.773840177128;5029.497050295087;5082.33929589151;4631.328457373729;4652.232381656989;4725.692829966041;4739.47865734762;4810.855674329776;4932.950670493393;4954.727489988085;4960.23116416956;4965.900681986413;5035.395752509576;4972.602191824718;5015.473375295687;5019.422766381913;5026.371703537058;5051.570616497639;4648.511906249795;4777.4505931818285;4789.736564488847;4796.784144713426;4849.612031037579;4678.391809064799;4772.403449568804;4794.808207671794;4798.088363210979;4875.975620121877;4635.513271106485;4668.416447944007;4686.062787442457;4692;4744.122337367598;4748.287756836502;4780.426348838162;4786.904261914672;4861.878453038561;4888.9755551222015;4751.192297309535;4764.213904705684;4765.904681906273;4773.37946067009;4841.661083724246 21:25:22 INFO - PROCESS | 8732 | |1;ext.html;545.5226676657925;554.9611527193098;559.583110582616;567.1096378685463;582.0919365789368;29689.55465668014;30504.542431863512;38213.235735285314;39377.40933885987;39428;38750.41874371887;39253.60746392535;39344.60655393445;39391.60608393915;39545.80227098868;7401.777946661608;7546.396288296951;7550.4337174711845;7551.660175292098;7559.924400756005;7475.626218689071;7559.811004724871;7567.432442566802;7568.545887246755;7570.2051284615145;7557.811054723621;7597.544147351176;7608;7609.505382150142;7623.885641715378;7523.699052037912;7567.205443428444;7569.88043347858;7574.128975167871;7574.242575742437;7457.216992215847;7609.162992070867;7612.961935190288;7614.31471167592;7616.961915190444;37902.05244868873;38155.236895261936;38270.80864595659;38290;38301.42547861784;2967.896123635662;3105.0840002199407;3248.31785325082;3285.375778602058;3654.1230104774663;28556.71443285582;28664;28709;28779.712202877912;29202.561961570595;3402.438597631388;3412.3175364927115;3482.8780992665133;3527.576690797095;3533.134382076382;232088;233821;234583;235631;235668;30897.845510772302;32013.519797203062;32049;44973.37832770903;45024;32468.188295292333;32682.346353072804;32683.346333073205;32713.182170445452;32715.182120447178;11515.76968460626;11654.941725291319;11669.474873630706;11672.182947193614;11673.533058677727;9108.49903255314;9149.039350868195;9186;9192.264618830612;9208.815823683488;7739.458237923292;7762.611869406507;7811.921880781233;7871.685132594746;7884.684612615546;3072.446959547303;3082.660907300195;3120.188750924776;3139.1210461070937;3174.365126974614;822.8560001999626;877.4998250996998;937.3438592984937;960.279790157382;991.5984026469291;26724.19827405181;26989.460210795674;27754.95180015712;27755.583666245024;27758.583621245696;906.0667512462174;932.7668082979255;948.1561410344799;954.9188318992964;964.9469279189711;14099.436022558983;14740.336684849208;14993;15276.38894444232;15357.232138393036;350058;356382;356660;356683;359292;47747.28379074317;48288.758556206994;48380;48452.27321590179;48505.75747121242;1033.6950599573145;1098.6594155811565;1121.0695123047688;1156.4217891054473;1177.2583272538245;25264.873675631505;28599.71400286054;28616.14151575456;28940.855295723388;29635.555466667585;40291.395629065;40828.38757418701;40837.795811020755;40844.79577602093;40888.79555602322;224552;224574;224783;225774;226528;21576.460588485414;22012.889935550218;22349;22689.659655104857;24908.501829962937;40372.596274036885;40383.79808100941;40522.1895562093;41074.58925410708;41990.58009419867;34659.30681386308;35172.64827351796;35233.82383088171;35470;35670.28659426745;33942.15144621305;34326.656733433345;34502.82748586241;34819.47770783491;34987.82506087453;34322.82838585791;34622.65377346194;34950.77672281458;35280.823595881855;35604.465933010506;29869.428725680315;31983.36033279275;32062;32089.35821283608;32134.839325803223;24231.636525452486;24719.50560988806;24880.50238995246;24903.772708891764;25185.49629007373 21:25:22 INFO - PROCESS | 8732 | |2;jquery.html;338.1477239484946;359.18465084258736;363.91448009717715;368.36089384917153;389.1205874723125;12408.317542535167;12722.809157862628;13017.153884997468;13405.530806421777;17554;13604.455821767118;13863.861361386384;17448.38930637428;17549.912250438763;17706.46880593581;4957.256411538271;4982.526659967315;4989.675671081386;5071.847844564669;5075.517825806561;5043.495650434964;5124.641275110744;5125.282460455521;5125.359330083739;5150.7424628768595;3670.6145854685274;3850.0952276215066;5665.773369065253;5898.380670029649;5922.496587790043;5874.794382196603;5886.3230728465915;6024.09638554216;6028.547858910577;6047.334793172748;5147.742612869341;5163.096458119851;5169.043726910533;5170.870728231825;5172.146595811687;20549.794502054938;20866.686999695015;21115.577688446145;21150.471238219016;21234.150633974623;1977.1165221901879;2013.9697904531445;2362.492064206204;2401.939951501209;2467.8842092185364;8999.910000900038;9540.475273859935;13196.802047969288;13300.467981280737;13885.305734713224;1695.1863105709328;1755.727862181364;1768.938087166943;1776.7246076858107;1789.8926064436175;69578;70253.2974670257;72272;72818;73188.53622927565;10100.848487272697;10196.235282353853;10327.9483602583;10418.114460270961;10424.270301078852;13664.65838354049;13712.65718357049;13789.793153102712;13789.793153102712;13795.10331828448;6607.933920660732;6613.173353330833;6706.631135287606;6745.460363171032;6879.793606191823;6092.878142437126;6177.81466556004;6315.873682526324;6356.872862542816;6369.777057803048;4277.871663850089;4278.657707383464;4295.269804133305;4332.263515202423;4417.271150260171;1770.4069136839303;1794.7756530433696;1804.179098510201;1830.2678928428736;1836.8897866128075;765.1468612497137;808.5997431271559;825.5995842016617;828.5857071464268;835.9289460395813;16029.759553606706;16682.416115435903;16864.662706746043;17349.2192851322;17648.735268970977;806.6894245715324;823.5511646152861;847.8812966184739;868.748063061705;918.8392031394479;8754.649814007496;9636.22910167185;9666.903330966741;9760.755981100387;9885.060919212663;317774;318182;322374;341923;342445.165515899;71645;73319;75168;75490.62254688691;75575.62212188904;850.2220468271586;864.6541383446546;872.3152325424638;894.0612357025227;896.7309807057857;14533.92733036328;14786.704265914837;15041.097534147548;15041.247937603295;15587;25805.483890322463;35724.46413303854;36770;37018.44472332971;37029.44455833219;46873.76563117163;47157;47191;47623;47725.522744773494;6751.324867513209;6901.930980690129;6967.756128535477;7243.963780181065;7474.887876681963;11083.390413527011;11411.828822567502;11608.825867611824;11799.465785926435;12048.096392770402;10092.444915529717;10223.335483193569;10267.84598231042;10333.328333658288;10750.73123171927;10064.345817521838;10072.647457338959;10117.89882101199;10332.225083118647;10730.624428144978;9510.762230944281;9731.708048758548;9974.750631234278;10056.54745536438;10087.092161705481;6769.356911093439;7270.200277969313;7270.2366251544945;7307.525010874276;7656.961715191388;8186.590670466572;9834;9861.704148875546;9957.651482198089;10633.361998280128 21:25:22 INFO - PROCESS | 8732 | |3;mootools.html;1235.1539195650985;1340.705044890124;1397.8811800996914;1412.675084730512;1687.2829047654752;6645.335466453353;7128.643567821608;7346.559206447617;7356.926430735698;7559.848803023936;7335.8532829343385;7420.146683131442;7423.22056184101;7431.888521672179;7436.96281518593;2130.275706259871;2139.53999890024;2159.5788821179876;2160.5354848707525;2161.7081693971268;2088.425682937197;2100.12844669462;2104.452842261008;2117.6505876530355;2142.3182801500825;2055.198472595689;2082.271205078218;2092.9476763080893;2096.8951552422395;2134.6264403729365;2118.66101423773;2119.1629306423874;2120.6182887080317;2123.681447782837;2124.946876328089;2048.8463365247667;2092.686097085434;2095.863768855035;2099.233779670409;2099.349201747463;7407.296306850841;7748.418868584822;7773.455858089936;7849.68601255949;7857.842843143162;4389.670774691911;4493.326001099828;4500.122476117159;4503.459584849807;4514.367988481616;2906.433245517125;3073.1395209341194;3126.7811253212285;3150.8109513429267;3151.16494129056;898;903.5708038681639;910.8952470465915;922.2299380017694;934.4159900062461;10572;10671.359718416843;10676.252662313642;10676.51955661997;10679.893201067967;3903.6877049835944;3925.528936527635;4061.329880569732;4085.9795701021303;4087.4890638670167;8404.243618074403;8479.533625650525;8479.915200848036;8484.448510846774;8487.915120848713;4361.5856493633055;4364.890877728082;4366.345048242789;4372;4373.846915358011;3402.268512269874;3541.5218945442552;3819.1216020315483;3968.305546529346;3972.8410863565714;3341.732661387083;3348.9330213395597;3457.533233013511;3467.323871844966;3470.583529976419;1013.6654903881702;1031.9484025798681;1043.7025447747355;1046.6707281752133;1049.8530205771199;727.0221552012534;746.305935479998;778.3034184404926;863.7322430046705;866.6013633728555;5109.795608175706;5268.631195816256;5297.073012222845;5310;5560.332760068737;405.7281621313727;416.79368712487513;424.0860944664253;426.7013090836427;429.32381499138984;3763.7929913855;3821.102041020358;3890.435886796399;3923.4507168996365;3984.5495020562726;8836.160564746338;9239.260859131253;9259.907400925904;9260.907390926004;9264.11990860867;8803.779905502413;9156.816863662689;9162.450252984841;9174.357794954423;9221.262299016063;7184.922261660793;7386.187519372865;7389.889151662622;7391.6673749681395;7393.55638661682;5468.207109969112;5561.555075593862;5704.458076482728;5735.369109398046;5759.56803239767;8659.48043117415;8842.823143537222;8912.376133670581;8943.955280223558;9023.503707296162;8971.192592666692;9078.90921090807;9144.771380715536;9170.633174672937;9182.586783594621;5844.386339434298;6796.830079248059;6933.861322773415;6940.861182776417;6941;6809.148856392951;7164.247753985756;7249.855002899807;7378.557286562824;7381.594012329158;6648.468122550281;6732.528722989344;6758.357955994173;6864.107666003388;6867.931320686929;6684.799456016327;6762.560433571802;6821.795346139624;6841.521093523605;6843.3840954314355;6271.62370257786;6359.745610175726;6368.9044664330995;6371;6377.904331435125;4483.103379324083;4526.162659907927;4591.586757191869;4593.150267200445;4599.701019433726;4198.769067701306;4448.7108337957925;4545.386372839756;4627.6066534344955;4679.508651591534 21:25:22 INFO - PROCESS | 8732 | |4;prototype.html;286.08738125380034;290.5728578988886;292.5611582626061;303.18141019248037;304.73183598433377;4840.854774356766;4861.2465067914445;4861.854144375666;4875.878103047426;4881.8291359802415;4795.098965126101;4802.1836287831065;4818.783154758035;4819.566239038486;4829.589484893788;3772.8679496217705;3791.620837916214;3800.4869342638804;3806.6574008339244;3817.503724515809;3537.4530338156487;3823.961760382402;3825.5791862895057;3826.2833388294207;3828.464015037897;3735.6264373562562;3738.8409593026113;3746.0406279039526;3750.8874733757893;3758.3422900992355;3674.842424636258;3718.2935242303874;3718.7025037997164;3724.776513409204;3727.1800203955086;3094.6228928126993;3167.857446414917;3275.623303320101;3285.1255151742225;3289.243474000993;4616.746078965655;4646.303054541812;4651.232546629802;4670.719756814602;4712.505186955389;4303.591158839905;4323;4332.241857674894;4357.19391912494;4412.867613971586;4645.442546894395;4816;5083.593992025315;5085.923711144335;5090.898182036339;3675.191457879289;3689.5756987946193;3700.093477098101;3703.981480092609;3716.8141592920247;5260.000599886048;5268.341457317835;5297.841064768063;5301.575873930076;5312.814051508218;3639.3085313790293;3808.352580061396;3813.237352529505;3820.8853734388013;3825.1202223488754;3892.6691231245095;3899.5905429930017;3907.980460097738;3912.7261091723876;3931.2088417223517;4363.759993200404;4365.716228445141;4371.322445021026;4372.672049596293;4377.124575084932;4928.518997518252;5043.672161309503;5094.872628184251;5102.260172275073;5112.488751124932;1303.69363199648;1332.4403750424844;1338.8661133886533;1345.3407830163148;1345.5626921250632;857.4191683034112;862.5767483652024;882.2412725056446;885.9025507194203;889.0798024045082;3920.09837737322;3949.111449923744;3952.7430717003303;3958.84243087518;3968.7420317679257;4534.7052441591195;4573.085382923428;4582.931256031162;4586.4496260448295;4588.701734387254;3957.584453632385;3976.900577485586;3979.7612143271494;3979.7811120388656;3981.900452488711;2328.8355822088956;2408;2426.313711970199;2437.9024839006597;2438.975610243875;4343.457067866517;4645.256758918556;4731.503192164842;4765.594924431392;4854.902901941941;5319.994203275137;5351.25082488452;5362.410134885159;5376.112941364631;5396.946030539723;4829.830955916526;4869.514797986648;4910.582600478928;4943.703377797272;4944.159492886218;4983.601311894967;5155.639105262596;5176.327077479904;5178;5200.2199670048285;5069.087564238325;5074.695518268915;5080.415752188545;5101.3113229715;5125.641205115755;4693.2021556336185;4859.639300995726;4883.194272944925;4885.193942999365;4887.36464259644;3744.5319335083113;3780.4518344840394;3780.8109594520715;3782.2813665403487;3800.56293526248;5158.690478571298;5165.509276618715;5174.818881339135;5177.023211653239;5203.687778733288;4984.476629953802;4989.650724449254;4997.9750101249265;5006.299118123538;5017.197248440232;4767.880802979953;4951.257311403174;4975.726335051607;4990.5508504234795;4999.950000500094;4805.159097158054;4867.926981095357;4884.804607815648;4892.657513973988;4897.510248975216;4958.73459310048;5046;5061.60872215609;5063.645544811828;5063.670861393997;4844.95155048445;4851;4858.441279252931;4865.781039853145;4870.829520966749 21:25:22 INFO - PROCESS | 8732 | |5;yui.html;671.4661843834151;685.2222727204621;714.1929619529931;742.0501757750078;758.3894964553534;12977.416016279267;13967;14032.298385080756;14046.929765351171;14079.296035198238;13262.137961032526;13413.798793018113;13430;13470.730585388286;13480.3259837008;620.7020630097555;636.0364048466577;636.805774238857;744.5011842065829;758.3819187362296;765.674588299973;789.9131095579481;791.2443616346404;791.8970533830623;792.3542313014874;836.2390224895346;837.4556538250125;839.3285371702644;839.4795226959294;839.8572242718752;653.650297091054;667.2693400726197;800.2277801921174;835.3651225068961;836.7155167243136;597.2593983460521;600.141797229961;600.9819705408845;601.0953514960001;601.1763883479617;13545.45818167272;13550.59348219555;13559;13560.050796444253;13588;12664.11351205416;12688.746225075447;12709.809352859715;13003.934980325037;13582.59252222435;11634.127440442;11710.765784684343;11727.53089876404;12099.879001209963;12203.877961220363;3998.7400818946676;4064.7764372959477;4074.6740260779065;4080;4204.684648651363;63642.36357636411;64053.67973160104;64731.232252130045;65095.34904650987;66442.3355766441;10294;10404.375737455777;10596;10691.30506517074;11006.724831879266;19728.802711972985;19834.60330793376;19872.50318742043;19957.600847982958;20347.59304813925;6714.563553369016;6759.256481787;6763.154605674291;6824.454043676494;6824.863502729918;3516.9648303516637;3583.068402215443;3616.511770910946;3642.1623026704005;3654.1778099927838;2729.6860861001237;2803.5794630805544;2819.5911592818925;2821.1254511101624;2827.3214428537003;482.92031814750874;485.8178183181307;494.8218641289133;496.3076508271014;500.6970782676501;439.8966242932908;498.71573203273783;555.1369998810369;559.3204256827973;568.7838621323871;6930.757423490154;7761.4178936578855;7998.160193179749;8038.226811749937;8186.549739764251;514.1824499046534;522.6654940837867;524.3969435149609;557.8159207461528;572.3589579670712;3653.50677658518;3706.6664000240107;3737.6449237322413;3793.2223894101644;3941.5664276929515;53048;53167.20249196265;53630;57531.712341438026;94334;82773.72262773795;83803.58098209593;84578;85394;86741.56629216814;41812.79093604512;63046;64321.67839160774;70530.2946970534;70966.64516677383;7103.360697537247;7209.747658831916;7291.489595728248;7354.926450735424;7502.887456688263;44417;44710.93789037152;46348.768256159856;46745.53254467412;46994;57125;62295.377046228954;65513;66974.665126676;68193;9043.23132533742;9345.626174952926;9495.905040949501;10595.417252051211;10673.679789606324;12296.323702196107;12913.354332283161;12917.612471625866;13248.138870973356;13861.930690346888;11742.823857641972;12114.273143611412;12152.331621760888;12166;12820.679483013;11844.407779611158;11935.343556104497;12281.808831494018;12304.323262220663;12545.623631291075;11895.940520297689;12445.813312800134;12468.438920248429;12482.75034499323;12756.170848894792;9758.784444300989;10046.949765251127;10138.341007834468;10361.844572331573;10623.575056997634;9951.203903687832;10570.788584228427;10790.190735694698;11031.117510599293;11041.282316649393 21:25:22 INFO - PROCESS | 8732 | __end_tp_report 21:25:22 INFO - PROCESS | 8732 | __start_cc_report 21:25:22 INFO - PROCESS | 8732 | _x_x_mozilla_cycle_collect,1159 21:25:22 INFO - PROCESS | 8732 | __end_cc_report 21:25:22 INFO - PROCESS | 8732 | __startTimestamp1476159922305__endTimestamp 21:25:22 INFO - PROCESS | 8732 | 21:25:22 INFO - PROCESS | 8732 | ------- Summary: start ------- 21:25:22 INFO - PROCESS | 8732 | Number of tests: 6 21:25:22 INFO - PROCESS | 8732 | 21:25:22 INFO - PROCESS | 8732 | [#0] dojo.html Cycles:165 Average:4620.47 Median:4725.69 stddev:472.42 (10.0%) stddev-sans-first:445.62 21:25:22 INFO - PROCESS | 8732 | Values: 2569.2 2584.2 2616.4 2627.5 2641.2 4556.8 4617.5 4712.3 4743.4 4752.0 4614.5 4662.0 4689.6 4726.8 4778.5 4249.6 4256.5 4306.9 4325.5 4335.2 4298.6 4376.7 4405.9 4417.2 4464.5 4214.7 4342.5 4357.8 4359.9 4458.7 4247.7 4269.4 4271.5 4296.1 4314.7 4263.0 4270.6 4275.5 4322.2 4332.3 4654.4 4660.0 4666.6 4677.6 4687.2 4830.6 4849.2 4853.0 4940.7 4961.3 4953.7 4971.8 5001.0 5044.6 5058.2 4651.3 4656.4 4661.3 4667.3 4715.8 4973.1 5035.7 5089.3 5164.7 5166.6 4853.3 4869.0 4898.8 4979.1 5076.4 4988.8 5001.9 5003.5 5004.9 5062.4 4795.4 4824.5 4944.1 4959.2 5024.5 4906.1 4969.4 5001.3 5013.9 5020.4 4311.6 4323.1 4325.4 4329.7 4382.6 3719.1 3765.5 3770.7 3796.7 3832.3 4253.0 4321.3 4341.7 4363.3 4414.3 5114.9 5118.0 5124.5 5138.1 5187.7 4323.8 4331.0 4358.4 4369.1 4423.2 4402.2 4435.5 4464.2 4550.3 4558.0 4701.0 4707.9 4720.0 4768.7 4772.5 5020.8 5021.5 5025.8 5029.5 5082.3 4631.3 4652.2 4725.7 4739.5 4810.9 4933.0 4954.7 4960.2 4965.9 5035.4 4972.6 5015.5 5019.4 5026.4 5051.6 4648.5 4777.5 4789.7 4796.8 4849.6 4678.4 4772.4 4794.8 4798.1 4876.0 4635.5 4668.4 4686.1 4692.0 4744.1 4748.3 4780.4 4786.9 4861.9 4889.0 4751.2 4764.2 4765.9 4773.4 4841.7 21:25:22 INFO - PROCESS | 8732 | 21:25:22 INFO - PROCESS | 8732 | [#1] ext.html Cycles:180 Average:41409.86 Median:19406.98 stddev:73222.85 (377.3%) stddev-sans-first:73363.98 21:25:22 INFO - PROCESS | 8732 | Values: 545.5 555.0 559.6 567.1 582.1 29689.6 30504.5 38213.2 39377.4 39428.0 38750.4 39253.6 39344.6 39391.6 39545.8 7401.8 7546.4 7550.4 7551.7 7559.9 7475.6 7559.8 7567.4 7568.5 7570.2 7557.8 7597.5 7608.0 7609.5 7623.9 7523.7 7567.2 7569.9 7574.1 7574.2 7457.2 7609.2 7613.0 7614.3 7617.0 37902.1 38155.2 38270.8 38290.0 38301.4 2967.9 3105.1 3248.3 3285.4 3654.1 28556.7 28664.0 28709.0 28779.7 29202.6 3402.4 3412.3 3482.9 3527.6 3533.1 232088.0 233821.0 234583.0 235631.0 235668.0 30897.8 32013.5 32049.0 44973.4 45024.0 32468.2 32682.3 32683.3 32713.2 32715.2 11515.8 11654.9 11669.5 11672.2 11673.5 9108.5 9149.0 9186.0 9192.3 9208.8 7739.5 7762.6 7811.9 7871.7 7884.7 3072.4 3082.7 3120.2 3139.1 3174.4 822.9 877.5 937.3 960.3 991.6 26724.2 26989.5 27755.0 27755.6 27758.6 906.1 932.8 948.2 954.9 964.9 14099.4 14740.3 14993.0 15276.4 15357.2 350058.0 356382.0 356660.0 356683.0 359292.0 47747.3 48288.8 48380.0 48452.3 48505.8 1033.7 1098.7 1121.1 1156.4 1177.3 25264.9 28599.7 28616.1 28940.9 29635.6 40291.4 40828.4 40837.8 40844.8 40888.8 224552.0 224574.0 224783.0 225774.0 226528.0 21576.5 22012.9 22349.0 22689.7 24908.5 40372.6 40383.8 40522.2 41074.6 41990.6 34659.3 35172.6 35233.8 35470.0 35670.3 33942.2 34326.7 34502.8 34819.5 34987.8 34322.8 34622.7 34950.8 35280.8 35604.5 29869.4 31983.4 32062.0 32089.4 32134.8 24231.6 24719.5 24880.5 24903.8 25185.5 21:25:22 INFO - PROCESS | 8732 | 21:25:22 INFO - PROCESS | 8732 | [#2] jquery.html Cycles:180 Average:22296.09 Median:4313.77 stddev:54694.40 (1267.9%) stddev-sans-first:54822.98 21:25:22 INFO - PROCESS | 8732 | Values: 338.1 359.2 363.9 368.4 389.1 12408.3 12722.8 13017.2 13405.5 17554.0 13604.5 13863.9 17448.4 17549.9 17706.5 4957.3 4982.5 4989.7 5071.8 5075.5 5043.5 5124.6 5125.3 5125.4 5150.7 3670.6 3850.1 5665.8 5898.4 5922.5 5874.8 5886.3 6024.1 6028.5 6047.3 5147.7 5163.1 5169.0 5170.9 5172.1 20549.8 20866.7 21115.6 21150.5 21234.2 1977.1 2014.0 2362.5 2401.9 2467.9 8999.9 9540.5 13196.8 13300.5 13885.3 1695.2 1755.7 1768.9 1776.7 1789.9 69578.0 70253.3 72272.0 72818.0 73188.5 10100.8 10196.2 10327.9 10418.1 10424.3 13664.7 13712.7 13789.8 13789.8 13795.1 6607.9 6613.2 6706.6 6745.5 6879.8 6092.9 6177.8 6315.9 6356.9 6369.8 4277.9 4278.7 4295.3 4332.3 4417.3 1770.4 1794.8 1804.2 1830.3 1836.9 765.1 808.6 825.6 828.6 835.9 16029.8 16682.4 16864.7 17349.2 17648.7 806.7 823.6 847.9 868.7 918.8 8754.6 9636.2 9666.9 9760.8 9885.1 317774.0 318182.0 322374.0 341923.0 342445.2 71645.0 73319.0 75168.0 75490.6 75575.6 850.2 864.7 872.3 894.1 896.7 14533.9 14786.7 15041.1 15041.2 15587.0 25805.5 35724.5 36770.0 37018.4 37029.4 46873.8 47157.0 47191.0 47623.0 47725.5 6751.3 6901.9 6967.8 7244.0 7474.9 11083.4 11411.8 11608.8 11799.5 12048.1 10092.4 10223.3 10267.8 10333.3 10750.7 10064.3 10072.6 10117.9 10332.2 10730.6 9510.8 9731.7 9974.8 10056.5 10087.1 6769.4 7270.2 7270.2 7307.5 7657.0 8186.6 9834.0 9861.7 9957.7 10633.4 21:25:22 INFO - PROCESS | 8732 | 21:25:22 INFO - PROCESS | 8732 | [#3] mootools.html Cycles:180 Average:5028.23 Median:5189.21 stddev:2833.76 (54.6%) stddev-sans-first:2827.37 21:25:22 INFO - PROCESS | 8732 | Values: 1235.2 1340.7 1397.9 1412.7 1687.3 6645.3 7128.6 7346.6 7356.9 7559.8 7335.9 7420.1 7423.2 7431.9 7437.0 2130.3 2139.5 2159.6 2160.5 2161.7 2088.4 2100.1 2104.5 2117.7 2142.3 2055.2 2082.3 2092.9 2096.9 2134.6 2118.7 2119.2 2120.6 2123.7 2124.9 2048.8 2092.7 2095.9 2099.2 2099.3 7407.3 7748.4 7773.5 7849.7 7857.8 4389.7 4493.3 4500.1 4503.5 4514.4 2906.4 3073.1 3126.8 3150.8 3151.2 898.0 903.6 910.9 922.2 934.4 10572.0 10671.4 10676.3 10676.5 10679.9 3903.7 3925.5 4061.3 4086.0 4087.5 8404.2 8479.5 8479.9 8484.4 8487.9 4361.6 4364.9 4366.3 4372.0 4373.8 3402.3 3541.5 3819.1 3968.3 3972.8 3341.7 3348.9 3457.5 3467.3 3470.6 1013.7 1031.9 1043.7 1046.7 1049.9 727.0 746.3 778.3 863.7 866.6 5109.8 5268.6 5297.1 5310.0 5560.3 405.7 416.8 424.1 426.7 429.3 3763.8 3821.1 3890.4 3923.5 3984.5 8836.2 9239.3 9259.9 9260.9 9264.1 8803.8 9156.8 9162.5 9174.4 9221.3 7184.9 7386.2 7389.9 7391.7 7393.6 5468.2 5561.6 5704.5 5735.4 5759.6 8659.5 8842.8 8912.4 8944.0 9023.5 8971.2 9078.9 9144.8 9170.6 9182.6 5844.4 6796.8 6933.9 6940.9 6941.0 6809.1 7164.2 7249.9 7378.6 7381.6 6648.5 6732.5 6758.4 6864.1 6867.9 6684.8 6762.6 6821.8 6841.5 6843.4 6271.6 6359.7 6368.9 6371.0 6377.9 4483.1 4526.2 4591.6 4593.2 4599.7 4198.8 4448.7 4545.4 4627.6 4679.5 21:25:22 INFO - PROCESS | 8732 | 21:25:22 INFO - PROCESS | 8732 | [#4] prototype.html Cycles:180 Average:4140.08 Median:4660.98 stddev:1203.21 (25.8%) stddev-sans-first:1171.30 21:25:22 INFO - PROCESS | 8732 | Values: 286.1 290.6 292.6 303.2 304.7 4840.9 4861.2 4861.9 4875.9 4881.8 4795.1 4802.2 4818.8 4819.6 4829.6 3772.9 3791.6 3800.5 3806.7 3817.5 3537.5 3824.0 3825.6 3826.3 3828.5 3735.6 3738.8 3746.0 3750.9 3758.3 3674.8 3718.3 3718.7 3724.8 3727.2 3094.6 3167.9 3275.6 3285.1 3289.2 4616.7 4646.3 4651.2 4670.7 4712.5 4303.6 4323.0 4332.2 4357.2 4412.9 4645.4 4816.0 5083.6 5085.9 5090.9 3675.2 3689.6 3700.1 3704.0 3716.8 5260.0 5268.3 5297.8 5301.6 5312.8 3639.3 3808.4 3813.2 3820.9 3825.1 3892.7 3899.6 3908.0 3912.7 3931.2 4363.8 4365.7 4371.3 4372.7 4377.1 4928.5 5043.7 5094.9 5102.3 5112.5 1303.7 1332.4 1338.9 1345.3 1345.6 857.4 862.6 882.2 885.9 889.1 3920.1 3949.1 3952.7 3958.8 3968.7 4534.7 4573.1 4582.9 4586.4 4588.7 3957.6 3976.9 3979.8 3979.8 3981.9 2328.8 2408.0 2426.3 2437.9 2439.0 4343.5 4645.3 4731.5 4765.6 4854.9 5320.0 5351.3 5362.4 5376.1 5396.9 4829.8 4869.5 4910.6 4943.7 4944.2 4983.6 5155.6 5176.3 5178.0 5200.2 5069.1 5074.7 5080.4 5101.3 5125.6 4693.2 4859.6 4883.2 4885.2 4887.4 3744.5 3780.5 3780.8 3782.3 3800.6 5158.7 5165.5 5174.8 5177.0 5203.7 4984.5 4989.7 4998.0 5006.3 5017.2 4767.9 4951.3 4975.7 4990.6 5000.0 4805.2 4867.9 4884.8 4892.7 4897.5 4958.7 5046.0 5061.6 5063.6 5063.7 4845.0 4851.0 4858.4 4865.8 4870.8 21:25:22 INFO - PROCESS | 8732 | 21:25:22 INFO - PROCESS | 8732 | [#5] yui.html Cycles:180 Average:16736.32 Median:46869.77 stddev:22514.49 (48.0%) stddev-sans-first:22545.34 21:25:22 INFO - PROCESS | 8732 | Values: 671.5 685.2 714.2 742.1 758.4 12977.4 13967.0 14032.3 14046.9 14079.3 13262.1 13413.8 13430.0 13470.7 13480.3 620.7 636.0 636.8 744.5 758.4 765.7 789.9 791.2 791.9 792.4 836.2 837.5 839.3 839.5 839.9 653.7 667.3 800.2 835.4 836.7 597.3 600.1 601.0 601.1 601.2 13545.5 13550.6 13559.0 13560.1 13588.0 12664.1 12688.7 12709.8 13003.9 13582.6 11634.1 11710.8 11727.5 12099.9 12203.9 3998.7 4064.8 4074.7 4080.0 4204.7 63642.4 64053.7 64731.2 65095.3 66442.3 10294.0 10404.4 10596.0 10691.3 11006.7 19728.8 19834.6 19872.5 19957.6 20347.6 6714.6 6759.3 6763.2 6824.5 6824.9 3517.0 3583.1 3616.5 3642.2 3654.2 2729.7 2803.6 2819.6 2821.1 2827.3 482.9 485.8 494.8 496.3 500.7 439.9 498.7 555.1 559.3 568.8 6930.8 7761.4 7998.2 8038.2 8186.5 514.2 522.7 524.4 557.8 572.4 3653.5 3706.7 3737.6 3793.2 3941.6 53048.0 53167.2 53630.0 57531.7 94334.0 82773.7 83803.6 84578.0 85394.0 86741.6 41812.8 63046.0 64321.7 70530.3 70966.6 7103.4 7209.7 7291.5 7354.9 7502.9 44417.0 44710.9 46348.8 46745.5 46994.0 57125.0 62295.4 65513.0 66974.7 68193.0 9043.2 9345.6 9495.9 10595.4 10673.7 12296.3 12913.4 12917.6 13248.1 13861.9 11742.8 12114.3 12152.3 12166.0 12820.7 11844.4 11935.3 12281.8 12304.3 12545.6 11895.9 12445.8 12468.4 12482.8 12756.2 9758.8 10046.9 10138.3 10361.8 10623.6 9951.2 10570.8 10790.2 11031.1 11041.3 21:25:22 INFO - PROCESS | 8732 | -------- Summary: end -------- 21:25:22 INFO - PROCESS | 8732 | 21:25:23 INFO - TEST-INFO | 8732: exit 0 21:25:23 INFO - TEST-OK | dromaeo_css | took 1121608ms 21:25:23 INFO - TEST-START | kraken 21:25:23 INFO - operating with platform_type : linux_ 21:25:23 INFO - Initialising browser for kraken test... 21:25:23 INFO - TEST-INFO | started process 9042 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDKXUyA/profile http://localhost:33180/getInfo.html) 21:25:27 INFO - PROCESS | 9042 | __metrics Screen width/height:1600/1200 21:25:27 INFO - PROCESS | 9042 | colorDepth:24 21:25:27 INFO - PROCESS | 9042 | Browser inner width/height: 1024/697 21:25:27 INFO - PROCESS | 9042 | __metrics 21:25:28 INFO - PROCESS | 9042 | 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:25:28 INFO - PROCESS | 9042 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:25:28 INFO - PROCESS | 9042 | console.error: PushService: 21:25:28 INFO - PROCESS | 9042 | stateChangeProcessEnqueue: Error transitioning state 21:25:28 INFO - PROCESS | 9042 | UnknownError 21:25:29 INFO - TEST-INFO | 9042: exit 0 21:25:29 INFO - Browser initialized. 21:25:29 INFO - Running cycle 1/1 for kraken test... 21:25:29 INFO - TEST-INFO | started process 9125 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDKXUyA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:25:41 INFO - PROCESS | 9125 | RSS: Main: 174759936 21:25:41 INFO - PROCESS | 9125 | 21:25:44 INFO - PROCESS | 9125 | Cycle 1(1): loaded http://localhost:33180/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33180/tests/kraken/driver.html?testName=audio-beat-detection) 21:25:45 INFO - PROCESS | 9125 | RSS: Main: 233865216 21:25:45 INFO - PROCESS | 9125 | 21:25:48 INFO - PROCESS | 9125 | Cycle 1(1): loaded http://localhost:33180/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33180/tests/kraken/driver.html?testName=audio-dft) 21:25:48 INFO - PROCESS | 9125 | RSS: Main: 218218496 21:25:48 INFO - PROCESS | 9125 | 21:25:51 INFO - PROCESS | 9125 | Cycle 1(1): loaded http://localhost:33180/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33180/tests/kraken/driver.html?testName=audio-fft) 21:25:52 INFO - PROCESS | 9125 | RSS: Main: 300507136 21:25:52 INFO - PROCESS | 9125 | 21:25:54 INFO - PROCESS | 9125 | Cycle 1(1): loaded http://localhost:33180/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33180/tests/kraken/driver.html?testName=audio-oscillator) 21:25:55 INFO - PROCESS | 9125 | RSS: Main: 211677184 21:25:55 INFO - PROCESS | 9125 | 21:25:57 INFO - PROCESS | 9125 | Cycle 1(1): loaded http://localhost:33180/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33180/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:25:58 INFO - PROCESS | 9125 | RSS: Main: 214564864 21:25:58 INFO - PROCESS | 9125 | 21:26:01 INFO - PROCESS | 9125 | Cycle 1(1): loaded http://localhost:33180/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33180/tests/kraken/driver.html?testName=imaging-darkroom) 21:26:02 INFO - PROCESS | 9125 | RSS: Main: 250290176 21:26:02 INFO - PROCESS | 9125 | 21:26:05 INFO - PROCESS | 9125 | Cycle 1(1): loaded http://localhost:33180/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33180/tests/kraken/driver.html?testName=imaging-desaturate) 21:26:06 INFO - PROCESS | 9125 | RSS: Main: 249778176 21:26:06 INFO - PROCESS | 9125 | 21:26:08 INFO - PROCESS | 9125 | Cycle 1(1): loaded http://localhost:33180/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33180/tests/kraken/driver.html?testName=json-parse-financial) 21:26:09 INFO - PROCESS | 9125 | RSS: Main: 248725504 21:26:09 INFO - PROCESS | 9125 | 21:26:11 INFO - PROCESS | 9125 | Cycle 1(1): loaded http://localhost:33180/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33180/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:26:11 INFO - PROCESS | 9125 | RSS: Main: 211574784 21:26:11 INFO - PROCESS | 9125 | 21:26:13 INFO - PROCESS | 9125 | Cycle 1(1): loaded http://localhost:33180/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33180/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:26:14 INFO - PROCESS | 9125 | RSS: Main: 219684864 21:26:14 INFO - PROCESS | 9125 | 21:26:16 INFO - PROCESS | 9125 | Cycle 1(1): loaded http://localhost:33180/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33180/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:26:17 INFO - PROCESS | 9125 | RSS: Main: 227737600 21:26:17 INFO - PROCESS | 9125 | 21:26:20 INFO - PROCESS | 9125 | Cycle 1(1): loaded http://localhost:33180/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33180/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:26:20 INFO - PROCESS | 9125 | RSS: Main: 231493632 21:26:20 INFO - PROCESS | 9125 | 21:26:23 INFO - PROCESS | 9125 | Cycle 1(1): loaded http://localhost:33180/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33180/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:26:24 INFO - PROCESS | 9125 | RSS: Main: 232636416 21:26:24 INFO - PROCESS | 9125 | 21:26:26 INFO - PROCESS | 9125 | Cycle 1(1): loaded http://localhost:33180/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33180/tests/kraken/driver.html?testName=ai-astar) 21:26:26 INFO - PROCESS | 9125 | RSS: Main: 284004352 21:26:26 INFO - PROCESS | 9125 | 21:26:26 INFO - PROCESS | 9125 | __start_tp_report 21:26:26 INFO - PROCESS | 9125 | _x_x_mozilla_page_load 21:26:26 INFO - PROCESS | 9125 | _x_x_mozilla_page_load_details 21:26:26 INFO - PROCESS | 9125 | |i|pagename|runs| 21:26:26 INFO - PROCESS | 9125 | |0;ai-astar;111;115;115;114;116;113;114;115;113;114 21:26:26 INFO - PROCESS | 9125 | |1;audio-beat-detection;148;129;126;176;132;133;130;124;164;126 21:26:26 INFO - PROCESS | 9125 | |2;audio-dft;161;161;163;164;161;163;162;161;162;160 21:26:26 INFO - PROCESS | 9125 | |3;audio-fft;75;75;77;120;76;77;77;77;99;76 21:26:26 INFO - PROCESS | 9125 | |4;audio-oscillator;84;83;127;83;84;83;109;83;83;122 21:26:26 INFO - PROCESS | 9125 | |5;imaging-gaussian-blur;117;117;118;118;119;118;117;120;118;118 21:26:26 INFO - PROCESS | 9125 | |6;imaging-darkroom;148;148;148;149;148;147;148;149;148;147 21:26:26 INFO - PROCESS | 9125 | |7;imaging-desaturate;95;95;95;94;95;96;95;96;95;95 21:26:26 INFO - PROCESS | 9125 | |8;json-parse-financial;66;64;70;67;68;68;69;68;67;67 21:26:26 INFO - PROCESS | 9125 | |9;json-stringify-tinderbox;65;66;65;65;68;66;66;66;65;67 21:26:26 INFO - PROCESS | 9125 | |10;stanford-crypto-aes;83;83;83;84;84;84;83;83;83;83 21:26:26 INFO - PROCESS | 9125 | |11;stanford-crypto-ccm;143;147;139;139;142;144;146;151;194;153 21:26:26 INFO - PROCESS | 9125 | |12;stanford-crypto-pbkdf2;180;182;176;174;172;174;174;174;174;173 21:26:26 INFO - PROCESS | 9125 | |13;stanford-crypto-sha256-iterative;71;70;70;70;73;69;71;70;69;68 21:26:26 INFO - PROCESS | 9125 | __end_tp_report 21:26:26 INFO - PROCESS | 9125 | __start_cc_report 21:26:26 INFO - PROCESS | 9125 | _x_x_mozilla_cycle_collect,1947 21:26:26 INFO - PROCESS | 9125 | __end_cc_report 21:26:26 INFO - PROCESS | 9125 | __startTimestamp1476159986542__endTimestamp 21:26:26 INFO - PROCESS | 9125 | 21:26:26 INFO - PROCESS | 9125 | ------- Summary: start ------- 21:26:26 INFO - PROCESS | 9125 | Number of tests: 14 21:26:26 INFO - PROCESS | 9125 | 21:26:26 INFO - PROCESS | 9125 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.50 stddev:1.41 (1.2%) stddev-sans-first:1.00 21:26:26 INFO - PROCESS | 9125 | Values: 111.0 115.0 115.0 114.0 116.0 113.0 114.0 115.0 113.0 114.0 21:26:26 INFO - PROCESS | 9125 | 21:26:26 INFO - PROCESS | 9125 | [#1] audio-beat-detection Cycles:10 Average:138.80 Median:132.50 stddev:17.96 (13.6%) stddev-sans-first:18.74 21:26:26 INFO - PROCESS | 9125 | Values: 148.0 129.0 126.0 176.0 132.0 133.0 130.0 124.0 164.0 126.0 21:26:26 INFO - PROCESS | 9125 | 21:26:26 INFO - PROCESS | 9125 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.23 (0.8%) stddev-sans-first:1.27 21:26:26 INFO - PROCESS | 9125 | Values: 161.0 161.0 163.0 164.0 161.0 163.0 162.0 161.0 162.0 160.0 21:26:26 INFO - PROCESS | 9125 | 21:26:26 INFO - PROCESS | 9125 | [#3] audio-fft Cycles:10 Average:82.90 Median:77.00 stddev:14.89 (19.3%) stddev-sans-first:15.51 21:26:26 INFO - PROCESS | 9125 | Values: 75.0 75.0 77.0 120.0 76.0 77.0 77.0 77.0 99.0 76.0 21:26:26 INFO - PROCESS | 9125 | 21:26:26 INFO - PROCESS | 9125 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:83.00 stddev:17.96 (21.6%) stddev-sans-first:18.67 21:26:26 INFO - PROCESS | 9125 | Values: 84.0 83.0 127.0 83.0 84.0 83.0 109.0 83.0 83.0 122.0 21:26:26 INFO - PROCESS | 9125 | 21:26:26 INFO - PROCESS | 9125 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.94 (0.8%) stddev-sans-first:0.93 21:26:26 INFO - PROCESS | 9125 | Values: 117.0 117.0 118.0 118.0 119.0 118.0 117.0 120.0 118.0 118.0 21:26:26 INFO - PROCESS | 9125 | 21:26:26 INFO - PROCESS | 9125 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 21:26:26 INFO - PROCESS | 9125 | Values: 148.0 148.0 148.0 149.0 148.0 147.0 148.0 149.0 148.0 147.0 21:26:26 INFO - PROCESS | 9125 | 21:26:26 INFO - PROCESS | 9125 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 21:26:26 INFO - PROCESS | 9125 | Values: 95.0 95.0 95.0 94.0 95.0 96.0 95.0 96.0 95.0 95.0 21:26:26 INFO - PROCESS | 9125 | 21:26:26 INFO - PROCESS | 9125 | [#8] json-parse-financial Cycles:10 Average:67.40 Median:68.00 stddev:1.65 (2.4%) stddev-sans-first:1.67 21:26:26 INFO - PROCESS | 9125 | Values: 66.0 64.0 70.0 67.0 68.0 68.0 69.0 68.0 67.0 67.0 21:26:26 INFO - PROCESS | 9125 | 21:26:26 INFO - PROCESS | 9125 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.99 (1.5%) stddev-sans-first:1.00 21:26:26 INFO - PROCESS | 9125 | Values: 65.0 66.0 65.0 65.0 68.0 66.0 66.0 66.0 65.0 67.0 21:26:26 INFO - PROCESS | 9125 | 21:26:26 INFO - PROCESS | 9125 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 21:26:26 INFO - PROCESS | 9125 | Values: 83.0 83.0 83.0 84.0 84.0 84.0 83.0 83.0 83.0 83.0 21:26:26 INFO - PROCESS | 9125 | 21:26:26 INFO - PROCESS | 9125 | [#11] stanford-crypto-ccm Cycles:10 Average:149.80 Median:146.50 stddev:16.20 (11.1%) stddev-sans-first:16.99 21:26:26 INFO - PROCESS | 9125 | Values: 143.0 147.0 139.0 139.0 142.0 144.0 146.0 151.0 194.0 153.0 21:26:26 INFO - PROCESS | 9125 | 21:26:26 INFO - PROCESS | 9125 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.30 Median:174.00 stddev:3.20 (1.8%) stddev-sans-first:2.91 21:26:26 INFO - PROCESS | 9125 | Values: 180.0 182.0 176.0 174.0 172.0 174.0 174.0 174.0 174.0 173.0 21:26:26 INFO - PROCESS | 9125 | 21:26:26 INFO - PROCESS | 9125 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.00 stddev:1.37 (2.0%) stddev-sans-first:1.41 21:26:26 INFO - PROCESS | 9125 | Values: 71.0 70.0 70.0 70.0 73.0 69.0 71.0 70.0 69.0 68.0 21:26:26 INFO - PROCESS | 9125 | -------- Summary: end -------- 21:26:26 INFO - PROCESS | 9125 | 21:26:27 INFO - TEST-INFO | 9125: exit 0 21:26:27 INFO - TEST-OK | kraken | took 64573ms 21:26:27 INFO - SUITE-END | took 1186s 21:26:28 INFO - Completed test suite (00:19:46) 21:26:28 INFO - javascript benchmark 21:26:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2569.1650213680555, 2584.1988983415154, 2616.4113074558227, 2627.4745050989795, 2641.1548304542553, 4556.84051058213, 4617.492075871652, 4712.293156026598, 4743.359646447733, 4751.976240118799, 4614.492405835355, 4661.976690116545, 4689.554492323224, 4726.763661816913, 4778.546038126373, 4249.617534421902, 4256.4679415073115, 4306.870793876173, 4325.4593175853015, 4335.219660461115, 4298.634616057639, 4376.671749618776, 4405.933910991338, 4417.22698527758, 4464.486584042828, 4214.662826973835, 4342.50061242958, 4357.782110894458, 4359.912801743947, 4458.71018383804, 4247.68142389322, 4269.444972153631, 4271.508776490681, 4296.0978194579175, 4314.741115533078, 4262.957370426287, 4270.636995855356, 4275.508316543606, 4322.178786030644, 4332.3068309070395, 4654.418197725285, 4660.04469083837, 4666.580007799281, 4677.555632214968, 4687.156311863863, 4830.589399901012, 4849.199882019462, 4852.951470485285, 4940.7035577865445, 4961.280614310941, 4953.653244272902, 4971.776270067856, 5000.974995125038, 5044.571211447032, 5058.215976523645, 4651.2557990721325, 4656.371389862393, 4661.254199328159, 4667.323238130452, 4715.834945776881, 4973.079980203674, 5035.748212589429, 5089.338386009869, 5164.664296820694, 5166.61250406221, 4853.3447984522345, 4869.026194761062, 4898.755062246873, 4979.053979743837, 5076.36545431821, 4988.825391111293, 5001.9499805002215, 5003.54968052877, 5004.874878128076, 5062.417821950449, 4795.400574928134, 4824.49342818999, 4944.1100601891285, 4959.156943319645, 5024.497550244946, 4906.141425250638, 4969.378827646544, 5001.299818025479, 5013.949860501421, 5020.3724534433195, 4311.6335111515245, 4323.113761678911, 4325.3728209409455, 4329.675274354436, 4382.583654552813, 3719.1445967427644, 3765.548134223911, 3770.698344132463, 3796.6583007529457, 3832.3485007548225, 4253.04306531028, 4321.2653848845775, 4341.6526677865695, 4363.258246098171, 4414.271645178574, 5114.9232761507865, 5117.974410127926, 5124.5131712487255, 5138.075146473596, 5187.662801917863, 4323.7621930793475, 4331.003869110059, 4358.389825424443, 4369.104333611602, 4423.159599676115, 4402.229609818269, 4435.512093669694, 4464.17412778637, 4550.317452382169, 4557.95442045582, 4701.03628756111, 4707.882302942454, 4719.952800472089, 4768.690035147704, 4772.546608072227, 5020.774065167003, 5021.54806067441, 5025.773840177128, 5029.497050295087, 5082.33929589151, 4631.328457373729, 4652.232381656989, 4725.692829966041, 4739.47865734762, 4810.855674329776, 4932.950670493393, 4954.727489988085, 4960.23116416956, 4965.900681986413, 5035.395752509576, 4972.602191824718, 5015.473375295687, 5019.422766381913, 5026.371703537058, 5051.570616497639, 4648.511906249795, 4777.4505931818285, 4789.736564488847, 4796.784144713426, 4849.612031037579, 4678.391809064799, 4772.403449568804, 4794.808207671794, 4798.088363210979, 4875.975620121877, 4635.513271106485, 4668.416447944007, 4686.062787442457, 4692.0, 4744.122337367598, 4748.287756836502, 4780.426348838162, 4786.904261914672, 4861.878453038561, 4888.9755551222015, 4751.192297309535, 4764.213904705684, 4765.904681906273, 4773.37946067009, 4841.661083724246], "value": 4590.882852845746, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.5226676657925, 554.9611527193098, 559.583110582616, 567.1096378685463, 582.0919365789368, 29689.55465668014, 30504.542431863512, 38213.235735285314, 39377.40933885987, 39428.0, 38750.41874371887, 39253.60746392535, 39344.60655393445, 39391.60608393915, 39545.80227098868, 7401.777946661608, 7546.396288296951, 7550.4337174711845, 7551.660175292098, 7559.924400756005, 7475.626218689071, 7559.811004724871, 7567.432442566802, 7568.545887246755, 7570.2051284615145, 7557.811054723621, 7597.544147351176, 7608.0, 7609.505382150142, 7623.885641715378, 7523.699052037912, 7567.205443428444, 7569.88043347858, 7574.128975167871, 7574.242575742437, 7457.216992215847, 7609.162992070867, 7612.961935190288, 7614.31471167592, 7616.961915190444, 37902.05244868873, 38155.236895261936, 38270.80864595659, 38290.0, 38301.42547861784, 2967.896123635662, 3105.0840002199407, 3248.31785325082, 3285.375778602058, 3654.1230104774663, 28556.71443285582, 28664.0, 28709.0, 28779.712202877912, 29202.561961570595, 3402.438597631388, 3412.3175364927115, 3482.8780992665133, 3527.576690797095, 3533.134382076382, 232088.0, 233821.0, 234583.0, 235631.0, 235668.0, 30897.845510772302, 32013.519797203062, 32049.0, 44973.37832770903, 45024.0, 32468.188295292333, 32682.346353072804, 32683.346333073205, 32713.182170445452, 32715.182120447178, 11515.76968460626, 11654.941725291319, 11669.474873630706, 11672.182947193614, 11673.533058677727, 9108.49903255314, 9149.039350868195, 9186.0, 9192.264618830612, 9208.815823683488, 7739.458237923292, 7762.611869406507, 7811.921880781233, 7871.685132594746, 7884.684612615546, 3072.446959547303, 3082.660907300195, 3120.188750924776, 3139.1210461070937, 3174.365126974614, 822.8560001999626, 877.4998250996998, 937.3438592984937, 960.279790157382, 991.5984026469291, 26724.19827405181, 26989.460210795674, 27754.95180015712, 27755.583666245024, 27758.583621245696, 906.0667512462174, 932.7668082979255, 948.1561410344799, 954.9188318992964, 964.9469279189711, 14099.436022558983, 14740.336684849208, 14993.0, 15276.38894444232, 15357.232138393036, 350058.0, 356382.0, 356660.0, 356683.0, 359292.0, 47747.28379074317, 48288.758556206994, 48380.0, 48452.27321590179, 48505.75747121242, 1033.6950599573145, 1098.6594155811565, 1121.0695123047688, 1156.4217891054473, 1177.2583272538245, 25264.873675631505, 28599.71400286054, 28616.14151575456, 28940.855295723388, 29635.555466667585, 40291.395629065, 40828.38757418701, 40837.795811020755, 40844.79577602093, 40888.79555602322, 224552.0, 224574.0, 224783.0, 225774.0, 226528.0, 21576.460588485414, 22012.889935550218, 22349.0, 22689.659655104857, 24908.501829962937, 40372.596274036885, 40383.79808100941, 40522.1895562093, 41074.58925410708, 41990.58009419867, 34659.30681386308, 35172.64827351796, 35233.82383088171, 35470.0, 35670.28659426745, 33942.15144621305, 34326.656733433345, 34502.82748586241, 34819.47770783491, 34987.82506087453, 34322.82838585791, 34622.65377346194, 34950.77672281458, 35280.823595881855, 35604.465933010506, 29869.428725680315, 31983.36033279275, 32062.0, 32089.35821283608, 32134.839325803223, 24231.636525452486, 24719.50560988806, 24880.50238995246, 24903.772708891764, 25185.49629007373], "value": 15630.487404412417, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.1477239484946, 359.18465084258736, 363.91448009717715, 368.36089384917153, 389.1205874723125, 12408.317542535167, 12722.809157862628, 13017.153884997468, 13405.530806421777, 17554.0, 13604.455821767118, 13863.861361386384, 17448.38930637428, 17549.912250438763, 17706.46880593581, 4957.256411538271, 4982.526659967315, 4989.675671081386, 5071.847844564669, 5075.517825806561, 5043.495650434964, 5124.641275110744, 5125.282460455521, 5125.359330083739, 5150.7424628768595, 3670.6145854685274, 3850.0952276215066, 5665.773369065253, 5898.380670029649, 5922.496587790043, 5874.794382196603, 5886.3230728465915, 6024.09638554216, 6028.547858910577, 6047.334793172748, 5147.742612869341, 5163.096458119851, 5169.043726910533, 5170.870728231825, 5172.146595811687, 20549.794502054938, 20866.686999695015, 21115.577688446145, 21150.471238219016, 21234.150633974623, 1977.1165221901879, 2013.9697904531445, 2362.492064206204, 2401.939951501209, 2467.8842092185364, 8999.910000900038, 9540.475273859935, 13196.802047969288, 13300.467981280737, 13885.305734713224, 1695.1863105709328, 1755.727862181364, 1768.938087166943, 1776.7246076858107, 1789.8926064436175, 69578.0, 70253.2974670257, 72272.0, 72818.0, 73188.53622927565, 10100.848487272697, 10196.235282353853, 10327.9483602583, 10418.114460270961, 10424.270301078852, 13664.65838354049, 13712.65718357049, 13789.793153102712, 13789.793153102712, 13795.10331828448, 6607.933920660732, 6613.173353330833, 6706.631135287606, 6745.460363171032, 6879.793606191823, 6092.878142437126, 6177.81466556004, 6315.873682526324, 6356.872862542816, 6369.777057803048, 4277.871663850089, 4278.657707383464, 4295.269804133305, 4332.263515202423, 4417.271150260171, 1770.4069136839303, 1794.7756530433696, 1804.179098510201, 1830.2678928428736, 1836.8897866128075, 765.1468612497137, 808.5997431271559, 825.5995842016617, 828.5857071464268, 835.9289460395813, 16029.759553606706, 16682.416115435903, 16864.662706746043, 17349.2192851322, 17648.735268970977, 806.6894245715324, 823.5511646152861, 847.8812966184739, 868.748063061705, 918.8392031394479, 8754.649814007496, 9636.22910167185, 9666.903330966741, 9760.755981100387, 9885.060919212663, 317774.0, 318182.0, 322374.0, 341923.0, 342445.165515899, 71645.0, 73319.0, 75168.0, 75490.62254688691, 75575.62212188904, 850.2220468271586, 864.6541383446546, 872.3152325424638, 894.0612357025227, 896.7309807057857, 14533.92733036328, 14786.704265914837, 15041.097534147548, 15041.247937603295, 15587.0, 25805.483890322463, 35724.46413303854, 36770.0, 37018.44472332971, 37029.44455833219, 46873.76563117163, 47157.0, 47191.0, 47623.0, 47725.522744773494, 6751.324867513209, 6901.930980690129, 6967.756128535477, 7243.963780181065, 7474.887876681963, 11083.390413527011, 11411.828822567502, 11608.825867611824, 11799.465785926435, 12048.096392770402, 10092.444915529717, 10223.335483193569, 10267.84598231042, 10333.328333658288, 10750.73123171927, 10064.345817521838, 10072.647457338959, 10117.89882101199, 10332.225083118647, 10730.624428144978, 9510.762230944281, 9731.708048758548, 9974.750631234278, 10056.54745536438, 10087.092161705481, 6769.356911093439, 7270.200277969313, 7270.2366251544945, 7307.525010874276, 7656.961715191388, 8186.590670466572, 9834.0, 9861.704148875546, 9957.651482198089, 10633.361998280128], "value": 8027.566503655384, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1235.1539195650985, 1340.705044890124, 1397.8811800996914, 1412.675084730512, 1687.2829047654752, 6645.335466453353, 7128.643567821608, 7346.559206447617, 7356.926430735698, 7559.848803023936, 7335.8532829343385, 7420.146683131442, 7423.22056184101, 7431.888521672179, 7436.96281518593, 2130.275706259871, 2139.53999890024, 2159.5788821179876, 2160.5354848707525, 2161.7081693971268, 2088.425682937197, 2100.12844669462, 2104.452842261008, 2117.6505876530355, 2142.3182801500825, 2055.198472595689, 2082.271205078218, 2092.9476763080893, 2096.8951552422395, 2134.6264403729365, 2118.66101423773, 2119.1629306423874, 2120.6182887080317, 2123.681447782837, 2124.946876328089, 2048.8463365247667, 2092.686097085434, 2095.863768855035, 2099.233779670409, 2099.349201747463, 7407.296306850841, 7748.418868584822, 7773.455858089936, 7849.68601255949, 7857.842843143162, 4389.670774691911, 4493.326001099828, 4500.122476117159, 4503.459584849807, 4514.367988481616, 2906.433245517125, 3073.1395209341194, 3126.7811253212285, 3150.8109513429267, 3151.16494129056, 898.0, 903.5708038681639, 910.8952470465915, 922.2299380017694, 934.4159900062461, 10572.0, 10671.359718416843, 10676.252662313642, 10676.51955661997, 10679.893201067967, 3903.6877049835944, 3925.528936527635, 4061.329880569732, 4085.9795701021303, 4087.4890638670167, 8404.243618074403, 8479.533625650525, 8479.915200848036, 8484.448510846774, 8487.915120848713, 4361.5856493633055, 4364.890877728082, 4366.345048242789, 4372.0, 4373.846915358011, 3402.268512269874, 3541.5218945442552, 3819.1216020315483, 3968.305546529346, 3972.8410863565714, 3341.732661387083, 3348.9330213395597, 3457.533233013511, 3467.323871844966, 3470.583529976419, 1013.6654903881702, 1031.9484025798681, 1043.7025447747355, 1046.6707281752133, 1049.8530205771199, 727.0221552012534, 746.305935479998, 778.3034184404926, 863.7322430046705, 866.6013633728555, 5109.795608175706, 5268.631195816256, 5297.073012222845, 5310.0, 5560.332760068737, 405.7281621313727, 416.79368712487513, 424.0860944664253, 426.7013090836427, 429.32381499138984, 3763.7929913855, 3821.102041020358, 3890.435886796399, 3923.4507168996365, 3984.5495020562726, 8836.160564746338, 9239.260859131253, 9259.907400925904, 9260.907390926004, 9264.11990860867, 8803.779905502413, 9156.816863662689, 9162.450252984841, 9174.357794954423, 9221.262299016063, 7184.922261660793, 7386.187519372865, 7389.889151662622, 7391.6673749681395, 7393.55638661682, 5468.207109969112, 5561.555075593862, 5704.458076482728, 5735.369109398046, 5759.56803239767, 8659.48043117415, 8842.823143537222, 8912.376133670581, 8943.955280223558, 9023.503707296162, 8971.192592666692, 9078.90921090807, 9144.771380715536, 9170.633174672937, 9182.586783594621, 5844.386339434298, 6796.830079248059, 6933.861322773415, 6940.861182776417, 6941.0, 6809.148856392951, 7164.247753985756, 7249.855002899807, 7378.557286562824, 7381.594012329158, 6648.468122550281, 6732.528722989344, 6758.357955994173, 6864.107666003388, 6867.931320686929, 6684.799456016327, 6762.560433571802, 6821.795346139624, 6841.521093523605, 6843.3840954314355, 6271.62370257786, 6359.745610175726, 6368.9044664330995, 6371.0, 6377.904331435125, 4483.103379324083, 4526.162659907927, 4591.586757191869, 4593.150267200445, 4599.701019433726, 4198.769067701306, 4448.7108337957925, 4545.386372839756, 4627.6066534344955, 4679.508651591534], "value": 3970.99494258513, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.08738125380034, 290.5728578988886, 292.5611582626061, 303.18141019248037, 304.73183598433377, 4840.854774356766, 4861.2465067914445, 4861.854144375666, 4875.878103047426, 4881.8291359802415, 4795.098965126101, 4802.1836287831065, 4818.783154758035, 4819.566239038486, 4829.589484893788, 3772.8679496217705, 3791.620837916214, 3800.4869342638804, 3806.6574008339244, 3817.503724515809, 3537.4530338156487, 3823.961760382402, 3825.5791862895057, 3826.2833388294207, 3828.464015037897, 3735.6264373562562, 3738.8409593026113, 3746.0406279039526, 3750.8874733757893, 3758.3422900992355, 3674.842424636258, 3718.2935242303874, 3718.7025037997164, 3724.776513409204, 3727.1800203955086, 3094.6228928126993, 3167.857446414917, 3275.623303320101, 3285.1255151742225, 3289.243474000993, 4616.746078965655, 4646.303054541812, 4651.232546629802, 4670.719756814602, 4712.505186955389, 4303.591158839905, 4323.0, 4332.241857674894, 4357.19391912494, 4412.867613971586, 4645.442546894395, 4816.0, 5083.593992025315, 5085.923711144335, 5090.898182036339, 3675.191457879289, 3689.5756987946193, 3700.093477098101, 3703.981480092609, 3716.8141592920247, 5260.000599886048, 5268.341457317835, 5297.841064768063, 5301.575873930076, 5312.814051508218, 3639.3085313790293, 3808.352580061396, 3813.237352529505, 3820.8853734388013, 3825.1202223488754, 3892.6691231245095, 3899.5905429930017, 3907.980460097738, 3912.7261091723876, 3931.2088417223517, 4363.759993200404, 4365.716228445141, 4371.322445021026, 4372.672049596293, 4377.124575084932, 4928.518997518252, 5043.672161309503, 5094.872628184251, 5102.260172275073, 5112.488751124932, 1303.69363199648, 1332.4403750424844, 1338.8661133886533, 1345.3407830163148, 1345.5626921250632, 857.4191683034112, 862.5767483652024, 882.2412725056446, 885.9025507194203, 889.0798024045082, 3920.09837737322, 3949.111449923744, 3952.7430717003303, 3958.84243087518, 3968.7420317679257, 4534.7052441591195, 4573.085382923428, 4582.931256031162, 4586.4496260448295, 4588.701734387254, 3957.584453632385, 3976.900577485586, 3979.7612143271494, 3979.7811120388656, 3981.900452488711, 2328.8355822088956, 2408.0, 2426.313711970199, 2437.9024839006597, 2438.975610243875, 4343.457067866517, 4645.256758918556, 4731.503192164842, 4765.594924431392, 4854.902901941941, 5319.994203275137, 5351.25082488452, 5362.410134885159, 5376.112941364631, 5396.946030539723, 4829.830955916526, 4869.514797986648, 4910.582600478928, 4943.703377797272, 4944.159492886218, 4983.601311894967, 5155.639105262596, 5176.327077479904, 5178.0, 5200.2199670048285, 5069.087564238325, 5074.695518268915, 5080.415752188545, 5101.3113229715, 5125.641205115755, 4693.2021556336185, 4859.639300995726, 4883.194272944925, 4885.193942999365, 4887.36464259644, 3744.5319335083113, 3780.4518344840394, 3780.8109594520715, 3782.2813665403487, 3800.56293526248, 5158.690478571298, 5165.509276618715, 5174.818881339135, 5177.023211653239, 5203.687778733288, 4984.476629953802, 4989.650724449254, 4997.9750101249265, 5006.299118123538, 5017.197248440232, 4767.880802979953, 4951.257311403174, 4975.726335051607, 4990.5508504234795, 4999.950000500094, 4805.159097158054, 4867.926981095357, 4884.804607815648, 4892.657513973988, 4897.510248975216, 4958.73459310048, 5046.0, 5061.60872215609, 5063.645544811828, 5063.670861393997, 4844.95155048445, 4851.0, 4858.441279252931, 4865.781039853145, 4870.829520966749], "value": 3760.822038727042, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [671.4661843834151, 685.2222727204621, 714.1929619529931, 742.0501757750078, 758.3894964553534, 12977.416016279267, 13967.0, 14032.298385080756, 14046.929765351171, 14079.296035198238, 13262.137961032526, 13413.798793018113, 13430.0, 13470.730585388286, 13480.3259837008, 620.7020630097555, 636.0364048466577, 636.805774238857, 744.5011842065829, 758.3819187362296, 765.674588299973, 789.9131095579481, 791.2443616346404, 791.8970533830623, 792.3542313014874, 836.2390224895346, 837.4556538250125, 839.3285371702644, 839.4795226959294, 839.8572242718752, 653.650297091054, 667.2693400726197, 800.2277801921174, 835.3651225068961, 836.7155167243136, 597.2593983460521, 600.141797229961, 600.9819705408845, 601.0953514960001, 601.1763883479617, 13545.45818167272, 13550.59348219555, 13559.0, 13560.050796444253, 13588.0, 12664.11351205416, 12688.746225075447, 12709.809352859715, 13003.934980325037, 13582.59252222435, 11634.127440442, 11710.765784684343, 11727.53089876404, 12099.879001209963, 12203.877961220363, 3998.7400818946676, 4064.7764372959477, 4074.6740260779065, 4080.0, 4204.684648651363, 63642.36357636411, 64053.67973160104, 64731.232252130045, 65095.34904650987, 66442.3355766441, 10294.0, 10404.375737455777, 10596.0, 10691.30506517074, 11006.724831879266, 19728.802711972985, 19834.60330793376, 19872.50318742043, 19957.600847982958, 20347.59304813925, 6714.563553369016, 6759.256481787, 6763.154605674291, 6824.454043676494, 6824.863502729918, 3516.9648303516637, 3583.068402215443, 3616.511770910946, 3642.1623026704005, 3654.1778099927838, 2729.6860861001237, 2803.5794630805544, 2819.5911592818925, 2821.1254511101624, 2827.3214428537003, 482.92031814750874, 485.8178183181307, 494.8218641289133, 496.3076508271014, 500.6970782676501, 439.8966242932908, 498.71573203273783, 555.1369998810369, 559.3204256827973, 568.7838621323871, 6930.757423490154, 7761.4178936578855, 7998.160193179749, 8038.226811749937, 8186.549739764251, 514.1824499046534, 522.6654940837867, 524.3969435149609, 557.8159207461528, 572.3589579670712, 3653.50677658518, 3706.6664000240107, 3737.6449237322413, 3793.2223894101644, 3941.5664276929515, 53048.0, 53167.20249196265, 53630.0, 57531.712341438026, 94334.0, 82773.72262773795, 83803.58098209593, 84578.0, 85394.0, 86741.56629216814, 41812.79093604512, 63046.0, 64321.67839160774, 70530.2946970534, 70966.64516677383, 7103.360697537247, 7209.747658831916, 7291.489595728248, 7354.926450735424, 7502.887456688263, 44417.0, 44710.93789037152, 46348.768256159856, 46745.53254467412, 46994.0, 57125.0, 62295.377046228954, 65513.0, 66974.665126676, 68193.0, 9043.23132533742, 9345.626174952926, 9495.905040949501, 10595.417252051211, 10673.679789606324, 12296.323702196107, 12913.354332283161, 12917.612471625866, 13248.138870973356, 13861.930690346888, 11742.823857641972, 12114.273143611412, 12152.331621760888, 12166.0, 12820.679483013, 11844.407779611158, 11935.343556104497, 12281.808831494018, 12304.323262220663, 12545.623631291075, 11895.940520297689, 12445.813312800134, 12468.438920248429, 12482.75034499323, 12756.170848894792, 9758.784444300989, 10046.949765251127, 10138.341007834468, 10361.844572331573, 10623.575056997634, 9951.203903687832, 10570.788584228427, 10790.190735694698, 11031.117510599293, 11041.282316649393], "value": 6474.657748093215, "unit": "score"}], "name": "dromaeo_css", "value": 6179.922845222667, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 115.0, 115.0, 114.0, 116.0, 113.0, 114.0, 115.0, 113.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 129.0, 126.0, 176.0, 132.0, 133.0, 130.0, 124.0, 164.0, 126.0], "value": 138.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 163.0, 164.0, 161.0, 163.0, 162.0, 161.0, 162.0, 160.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 120.0, 76.0, 77.0, 77.0, 77.0, 99.0, 76.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 127.0, 83.0, 84.0, 83.0, 109.0, 83.0, 83.0, 122.0], "value": 94.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 119.0, 118.0, 117.0, 120.0, 118.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 149.0, 148.0, 147.0, 148.0, 149.0, 148.0, 147.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 70.0, 67.0, 68.0, 68.0, 69.0, 68.0, 67.0, 67.0], "value": 67.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 68.0, 66.0, 66.0, 66.0, 65.0, 67.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 84.0, 84.0, 84.0, 83.0, 83.0, 83.0, 83.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 147.0, 139.0, 139.0, 142.0, 144.0, 146.0, 151.0, 194.0, 153.0], "value": 149.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 182.0, 176.0, 174.0, 172.0, 174.0, 174.0, 174.0, 174.0, 173.0], "value": 175.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 70.0, 70.0, 73.0, 69.0, 71.0, 70.0, 69.0, 68.0], "value": 70.1, "unit": "score"}], "name": "kraken", "value": 1564.4999999999998, "alertThreshold": 2.0}]} 21:26:28 INFO - Return code: 0 21:26:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:26:28 INFO - # TBPL SUCCESS # 21:26:28 INFO - Running post-action listener: _resource_record_post_action 21:26:28 INFO - [mozharness: 2016-10-11 04:26:28.358090Z] Finished run-tests step (success) 21:26:28 INFO - Running post-run listener: _resource_record_post_run 21:26:28 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392998912; Read time: 152; Write time: 241064 21:26:28 INFO - TinderboxPrint: CPU usage
13.1% 21:26:28 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 152 21:26:28 INFO - TinderboxPrint: I/O write bytes / time
392,998,912 / 241,064 21:26:28 INFO - TinderboxPrint: CPU idle
8,344.9 (86.9%) 21:26:28 INFO - TinderboxPrint: CPU user
1,205.5 (12.6%) 21:26:28 INFO - TinderboxPrint: Swap in / out
0 / 0 21:26:28 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 100065280; Read time: 0; Write time: 102928 21:26:28 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292933632; Read time: 152; Write time: 138136 21:26:28 INFO - Running post-run listener: _upload_blobber_files 21:26:28 INFO - Blob upload gear active. 21:26:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:26: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:26: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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:26: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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:26:29 INFO - (blobuploader) - INFO - Open directory for files ... 21:26:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:26:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:26:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:26:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:26:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:26:32 INFO - (blobuploader) - INFO - Done attempting. 21:26:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:26:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:26:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:26:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:26:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:26:33 INFO - (blobuploader) - INFO - Done attempting. 21:26:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:26:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:26:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:26:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:26:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:26:34 INFO - (blobuploader) - INFO - Done attempting. 21:26:34 INFO - (blobuploader) - INFO - Iteration through files over. 21:26:34 INFO - Return code: 0 21:26:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:26:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:26:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7925f9886cd4e4f27de8b3c3511fd5941ee3fe562a62021731054564bf79cdc503996ef2e4960afdfd481abbd680f73d2f28bed2e837eef192136da1401713f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0e7a4f1744c6a5843ae1ef5ef538f16747510a614831417310ca0ac5a5f26897f5053d71f2ac257df5561cb8b36f80948ecef32e05955b5391bb2595622899f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f22262b6565d07a36182ac3a935218f344ba3aa325be962bcb6926058401542b2c0bc7c4abba2da99b91b674a863ec692d8dbb9b022f5c381bfdde0698133779"} 21:26:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:26:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:26:34 INFO - Contents: 21:26:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7925f9886cd4e4f27de8b3c3511fd5941ee3fe562a62021731054564bf79cdc503996ef2e4960afdfd481abbd680f73d2f28bed2e837eef192136da1401713f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0e7a4f1744c6a5843ae1ef5ef538f16747510a614831417310ca0ac5a5f26897f5053d71f2ac257df5561cb8b36f80948ecef32e05955b5391bb2595622899f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f22262b6565d07a36182ac3a935218f344ba3aa325be962bcb6926058401542b2c0bc7c4abba2da99b91b674a863ec692d8dbb9b022f5c381bfdde0698133779"} 21:26:34 INFO - Running post-run listener: copy_logs_to_upload_dir 21:26:34 INFO - Copying logs to upload dir... 21:26:34 INFO - mkdir: /builds/slave/test/build/upload/logs 21:26:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.810793 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-10 21:26:33.337538) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-10 21:26:33.341081) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1476158366.299240-795935530 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-Non-PGO/sha512/7925f9886cd4e4f27de8b3c3511fd5941ee3fe562a62021731054564bf79cdc503996ef2e4960afdfd481abbd680f73d2f28bed2e837eef192136da1401713f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0e7a4f1744c6a5843ae1ef5ef538f16747510a614831417310ca0ac5a5f26897f5053d71f2ac257df5561cb8b36f80948ecef32e05955b5391bb2595622899f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f22262b6565d07a36182ac3a935218f344ba3aa325be962bcb6926058401542b2c0bc7c4abba2da99b91b674a863ec692d8dbb9b022f5c381bfdde0698133779"} build_url:https://queue.taskcluster.net/v1/task/WswIRlIvQFeZ3puPW5AEFg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011266 build_url: 'https://queue.taskcluster.net/v1/task/WswIRlIvQFeZ3puPW5AEFg/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-Non-PGO/sha512/7925f9886cd4e4f27de8b3c3511fd5941ee3fe562a62021731054564bf79cdc503996ef2e4960afdfd481abbd680f73d2f28bed2e837eef192136da1401713f2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0e7a4f1744c6a5843ae1ef5ef538f16747510a614831417310ca0ac5a5f26897f5053d71f2ac257df5561cb8b36f80948ecef32e05955b5391bb2595622899f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f22262b6565d07a36182ac3a935218f344ba3aa325be962bcb6926058401542b2c0bc7c4abba2da99b91b674a863ec692d8dbb9b022f5c381bfdde0698133779"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-10 21:26:33.370188) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 21:26:33.370710) ========= 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=e0e61f6f900f4dc42e3e8956000001ad-1476158366.299240-795935530 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004426 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-10 21:26:33.455059) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-10 21:26:33.455720) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-10 21:26:33.456386) ========= ========= Total master_lag: 0.16 =========