builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-064 starttime: 1475980044.03 results: success (0) buildid: 20161008171719 builduid: af0787e223ab47cb84442e656c23ce9a revision: ea311deedce9154009a9575e9cad1345669ff781 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-08 19:27:24.025551) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-08 19:27:24.026016) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-08 19:27:24.026285) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-08 19:27:24.041052) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 19:27:24.041381) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1475978253.592126-269373017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-08 19:27:25-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-10-08 19:27:25 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.123318 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 19:27:24.178008) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 19:27:24.178277) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1475978253.592126-269373017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021429 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 19:27:24.227266) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 19:27:24.227593) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ea311deedce9154009a9575e9cad1345669ff781 --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 ea311deedce9154009a9575e9cad1345669ff781 --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=a12cd81e0ef515edd9e0d800000001bb-1475978253.592126-269373017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-08 19:27:25,385 truncating revision to first 12 chars 2016-10-08 19:27:25,385 Setting DEBUG logging. 2016-10-08 19:27:25,385 attempt 1/10 2016-10-08 19:27:25,385 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ea311deedce9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-08 19:27:25,839 unpacking tar archive at: fx-team-ea311deedce9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.823557 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 19:27:25.064439) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-08 19:27:25.064795) ========= script_repo_revision: ea311deedce9154009a9575e9cad1345669ff781 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-08 19:27:25.065240) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-08 19:27:25.065537) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-08 19:27:25.075137) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-10-08 19:27:25.075438) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=a12cd81e0ef515edd9e0d800000001bb-1475978253.592126-269373017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:27:26 INFO - MultiFileLogger online at 20161008 19:27:26 in /builds/slave/test 19:27:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 19:27:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:27:26 INFO - {'append_to_log': False, 19:27:26 INFO - 'base_work_dir': '/builds/slave/test', 19:27:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 19:27:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:27:26 INFO - 'branch': 'Fx-Team-Non-PGO', 19:27:26 INFO - 'buildbot_json_path': 'buildprops.json', 19:27:26 INFO - 'config_files': ('talos/linux_config.py',), 19:27:26 INFO - 'default_actions': ('clobber', 19:27:26 INFO - 'read-buildbot-config', 19:27:26 INFO - 'download-and-extract', 19:27:26 INFO - 'populate-webroot', 19:27:26 INFO - 'create-virtualenv', 19:27:26 INFO - 'install', 19:27:26 INFO - 'run-tests'), 19:27:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:27:26 INFO - 'download_minidump_stackwalk': True, 19:27:26 INFO - 'download_symbols': 'ondemand', 19:27:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:27:26 INFO - 'tooltool.py': '/tools/tooltool.py', 19:27:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:27:26 INFO - '/tools/misc-python/virtualenv.py')}, 19:27:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:27:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:27:26 INFO - 'installer_path': 'installer.exe', 19:27:26 INFO - 'log_level': 'info', 19:27:26 INFO - 'log_name': 'talos', 19:27:26 INFO - 'log_to_console': True, 19:27:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:27:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:27:26 INFO - 'opt_config_files': (), 19:27:26 INFO - 'pip_index': False, 19:27:26 INFO - 'sps_profile': False, 19:27:26 INFO - 'sps_profile_interval': 0, 19:27:26 INFO - 'suite': 'dromaeojs-e10s', 19:27:26 INFO - 'system_bits': '32', 19:27:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:27:26 INFO - 'title': 'talos-linux64-ix-064', 19:27:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:27:26 INFO - 'use_talos_json': True, 19:27:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:27:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:27:26 INFO - 'work_dir': 'build'} 19:27:26 INFO - [mozharness: 2016-10-09 02:27:26.331162Z] Running clobber step. 19:27:26 INFO - Running pre-action listener: _resource_record_pre_action 19:27:26 INFO - Running main action method: clobber 19:27:26 INFO - rmtree: /builds/slave/test/build 19:27:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:27:27 INFO - Running post-action listener: _resource_record_post_action 19:27:27 INFO - [mozharness: 2016-10-09 02:27:27.297761Z] Finished clobber step (success) 19:27:27 INFO - [mozharness: 2016-10-09 02:27:27.297860Z] Running read-buildbot-config step. 19:27:27 INFO - Running pre-action listener: _resource_record_pre_action 19:27:27 INFO - Running main action method: read_buildbot_config 19:27:27 INFO - Using buildbot properties: 19:27:27 INFO - { 19:27:27 INFO - "project": "", 19:27:27 INFO - "product": "firefox", 19:27:27 INFO - "script_repo_revision": "production", 19:27:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 19:27:27 INFO - "repository": "", 19:27:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 19:27:27 INFO - "buildid": "20161008171719", 19:27:27 INFO - "pgo_build": "False", 19:27:27 INFO - "basedir": "/builds/slave/test", 19:27:27 INFO - "buildnumber": 1642, 19:27:27 INFO - "slavename": "talos-linux64-ix-064", 19:27:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:27:27 INFO - "platform": "ubuntu64_hw", 19:27:27 INFO - "scheduler": "tests-fx-team-linux64-talos-8-3600", 19:27:27 INFO - "branch": "fx-team", 19:27:27 INFO - "repo_path": "integration/fx-team", 19:27:27 INFO - "revision": "ea311deedce9154009a9575e9cad1345669ff781", 19:27:27 INFO - "stage_platform": "linux64", 19:27:27 INFO - "builduid": "af0787e223ab47cb84442e656c23ce9a", 19:27:27 INFO - "slavebuilddir": "test" 19:27:27 INFO - } 19:27:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 19:27:27 INFO - Running post-action listener: _resource_record_post_action 19:27:27 INFO - [mozharness: 2016-10-09 02:27:27.300559Z] Finished read-buildbot-config step (success) 19:27:27 INFO - [mozharness: 2016-10-09 02:27:27.300659Z] Running download-and-extract step. 19:27:27 INFO - Running pre-action listener: _resource_record_pre_action 19:27:27 INFO - Running main action method: download_and_extract 19:27:27 INFO - mkdir: /builds/slave/test/build/tests 19:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:27 INFO - trying https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 19:27:27 INFO - Downloading https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/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 19:27:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/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 19:27:27 INFO - Downloaded 1361 bytes. 19:27:27 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 19:27:27 INFO - Using the following test package requirements: 19:27:27 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 19:27:27 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:27:27 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:27:27 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:27:27 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:27:27 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:27:27 INFO - u'jsshell-linux-x86_64.zip'], 19:27:27 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:27:27 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:27:27 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 19:27:27 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:27:27 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:27:27 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:27:27 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:27:27 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:27:27 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:27:27 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:27:27 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:27:27 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:27:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 19:27:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:27:27 INFO - Fetch https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 19:27:28 INFO - Http code: 200 19:27:28 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 19:27:28 INFO - x-amz-cf-id: KjsY71cR7PHM1ILdpWWsV4fuwEs_jRPVbbaO2tcY-nZ2-7PahKLjcQ== 19:27:28 INFO - x-amz-version-id: _xSGXWAYlSdH7DOiY0QVh27l8QgFH22l 19:27:28 INFO - Expected file size: 20524999 19:27:28 INFO - Obtained file size: 20524999 19:27:32 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 19:27:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 19:27:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:27:32 INFO - Fetch https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 19:27:33 INFO - Http code: 200 19:27:33 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 19:27:33 INFO - x-amz-cf-id: hu6nCuR4jqfDJiSTjOfw4iBppWHAkt-HZwt1Akd2U1Z4kts6XBSo1g== 19:27:33 INFO - x-amz-version-id: _xSGXWAYlSdH7DOiY0QVh27l8QgFH22l 19:27:33 INFO - Expected file size: 20524999 19:27:33 INFO - Obtained file size: 20524999 19:27:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 19:27:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:27:37 INFO - Fetch https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 19:27:38 INFO - Http code: 200 19:27:38 INFO - via: 1.1 9552af4ceb2e0dd55964a80d1e549fd5.cloudfront.net (CloudFront) 19:27:38 INFO - x-amz-cf-id: ZtWtfrEsNOeGHx33OP3ZWt33kp7zpd2cPQas0iwZ26guyDlSPixfjQ== 19:27:38 INFO - x-amz-version-id: vx6_Z6R_sYVQ5EJYfdo.sd4aT68tKRFx 19:27:38 INFO - Expected file size: 14409006 19:27:38 INFO - Obtained file size: 14409006 19:27:38 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')]} 19:27:38 INFO - trying https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 19:27:38 INFO - Downloading https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/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 19:27:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/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 19:27:40 INFO - Downloaded 55833457 bytes. 19:27:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 19:27:40 INFO - mkdir: /builds/slave/test/properties 19:27:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:27:40 INFO - Writing to file /builds/slave/test/properties/build_url 19:27:40 INFO - Contents: 19:27:40 INFO - build_url:https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 19:27:40 INFO - Running post-action listener: _resource_record_post_action 19:27:40 INFO - Running post-action listener: set_extra_try_arguments 19:27:40 INFO - [mozharness: 2016-10-09 02:27:40.650359Z] Finished download-and-extract step (success) 19:27:40 INFO - [mozharness: 2016-10-09 02:27:40.650656Z] Running populate-webroot step. 19:27:40 INFO - Running pre-action listener: _resource_record_pre_action 19:27:40 INFO - Running main action method: populate_webroot 19:27:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:27:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:27:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:27:40 INFO - '--tppagecycles', 19:27:40 INFO - '7'], 19:27:40 INFO - 'tests': ['tsvgm']}}, 19:27:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:27:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:27:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:27:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:27:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:27:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:27:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:40 INFO - 'talos_options': ['--disable-e10s'], 19:27:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:27:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:27:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:40 INFO - 'talos_options': ['--disable-e10s'], 19:27:40 INFO - 'tests': ['damp', 'tps']}, 19:27:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:40 INFO - 'tests': ['damp', 'tps']}, 19:27:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:27:40 INFO - 'tests': ['dromaeo_dom']}, 19:27:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:27:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:27:40 INFO - 'tests': ['basic_compositor_video']}, 19:27:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:27:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:27:40 INFO - 'tests': ['a11yr', 19:27:40 INFO - 'ts_paint', 19:27:40 INFO - 'tpaint', 19:27:40 INFO - 'sessionrestore', 19:27:40 INFO - 'sessionrestore_no_auto_restore', 19:27:40 INFO - 'tabpaint']}, 19:27:40 INFO - 'other-e10s': {'tests': ['a11yr', 19:27:40 INFO - 'ts_paint', 19:27:40 INFO - 'tpaint', 19:27:40 INFO - 'sessionrestore', 19:27:40 INFO - 'sessionrestore_no_auto_restore', 19:27:40 INFO - 'tabpaint']}, 19:27:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:27:40 INFO - 'ts_paint', 19:27:40 INFO - 'tpaint', 19:27:40 INFO - 'sessionrestore', 19:27:40 INFO - 'sessionrestore_no_auto_restore', 19:27:40 INFO - 'tabpaint']}, 19:27:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:27:40 INFO - 'ts_paint', 19:27:40 INFO - 'tpaint', 19:27:40 INFO - 'sessionrestore', 19:27:40 INFO - 'sessionrestore_no_auto_restore', 19:27:40 INFO - 'tabpaint']}, 19:27:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:27:40 INFO - 'tests': ['a11yr', 19:27:40 INFO - 'ts_paint', 19:27:40 INFO - 'tpaint', 19:27:40 INFO - 'sessionrestore', 19:27:40 INFO - 'sessionrestore_no_auto_restore', 19:27:40 INFO - 'tabpaint']}, 19:27:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:27:40 INFO - 'tests': ['a11yr', 19:27:40 INFO - 'ts_paint', 19:27:40 INFO - 'tpaint', 19:27:40 INFO - 'sessionrestore', 19:27:40 INFO - 'sessionrestore_no_auto_restore', 19:27:40 INFO - 'tabpaint']}, 19:27:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:27:40 INFO - 'tests': ['tsvgx', 19:27:40 INFO - 'tsvgr_opacity', 19:27:40 INFO - 'tart', 19:27:40 INFO - 'tscrollx', 19:27:40 INFO - 'cart']}, 19:27:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:27:40 INFO - 'tsvgr_opacity', 19:27:40 INFO - 'tart', 19:27:40 INFO - 'tscrollx', 19:27:40 INFO - 'cart']}, 19:27:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:40 INFO - 'talos_options': ['--disable-e10s'], 19:27:40 INFO - 'tests': ['tp5o']}, 19:27:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:40 INFO - 'tests': ['tp5o']}, 19:27:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:40 INFO - 'talos_options': ['--disable-e10s', 19:27:40 INFO - '--xperf_path', 19:27:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:27:40 INFO - 'tests': ['tp5n']}, 19:27:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:40 INFO - 'talos_options': ['--xperf_path', 19:27:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:27:40 INFO - 'tests': ['tp5n']}}, 19:27:40 INFO - 'talos.zip': {'path': '', 19:27:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:27:40 INFO - Running post-action listener: _resource_record_post_action 19:27:40 INFO - [mozharness: 2016-10-09 02:27:40.667712Z] Finished populate-webroot step (success) 19:27:40 INFO - [mozharness: 2016-10-09 02:27:40.667805Z] Running create-virtualenv step. 19:27:40 INFO - Running pre-action listener: _resource_record_pre_action 19:27:40 INFO - Running main action method: create_virtualenv 19:27:40 INFO - Creating virtualenv /builds/slave/test/build/venv 19:27:40 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 19:27:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:27:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:27:40 INFO - Using real prefix '/usr' 19:27:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:27:41 INFO - Installing distribute.............................................................................................................................................................................................done. 19:27:43 INFO - Installing pip.................done. 19:27:43 INFO - Return code: 0 19:27:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:27:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:27:43 INFO - Reading from file tmpfile_stdout 19:27:43 INFO - Output received: 19:27:43 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) 19:27:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:27:43 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')]} 19:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:43 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')]} 19:27:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:43 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 0x7fae83c0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d09f60>, '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 0x1d0ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b1d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1475978253.592126-269373017', '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 19:27:43 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 19:27:43 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 19:27:43 INFO - Using env: {'DISPLAY': ':0', 19:27:43 INFO - 'HOME': '/home/cltbld', 19:27:43 INFO - 'LANG': 'en_US.UTF-8', 19:27:43 INFO - 'LANGUAGE': 'en_US:en', 19:27:43 INFO - 'LOGNAME': 'cltbld', 19:27:43 INFO - 'MAIL': '/var/mail/cltbld', 19:27:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:43 INFO - 'MOZ_NO_REMOTE': '1', 19:27:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:43 INFO - 'NO_EM_RESTART': '1', 19:27:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:43 INFO - 'PWD': '/builds/slave/test', 19:27:43 INFO - 'SHELL': '/bin/bash', 19:27:43 INFO - 'SHLVL': '1', 19:27:43 INFO - 'TERM': 'linux', 19:27:43 INFO - 'TMOUT': '86400', 19:27:43 INFO - 'USER': 'cltbld', 19:27:43 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1475978253.592126-269373017', 19:27:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:43 INFO - '_': '/tools/buildbot/bin/python'} 19:27:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:43 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 19:27:43 INFO - Cleaning up... 19:27:43 INFO - Return code: 0 19:27:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:27:43 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')]} 19:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:43 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')]} 19:27:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:43 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 0x7fae83c0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d09f60>, '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 0x1d0ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b1d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1475978253.592126-269373017', '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 19:27:43 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 19:27:43 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 19:27:43 INFO - Using env: {'DISPLAY': ':0', 19:27:43 INFO - 'HOME': '/home/cltbld', 19:27:43 INFO - 'LANG': 'en_US.UTF-8', 19:27:43 INFO - 'LANGUAGE': 'en_US:en', 19:27:43 INFO - 'LOGNAME': 'cltbld', 19:27:43 INFO - 'MAIL': '/var/mail/cltbld', 19:27:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:43 INFO - 'MOZ_NO_REMOTE': '1', 19:27:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:43 INFO - 'NO_EM_RESTART': '1', 19:27:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:43 INFO - 'PWD': '/builds/slave/test', 19:27:43 INFO - 'SHELL': '/bin/bash', 19:27:43 INFO - 'SHLVL': '1', 19:27:43 INFO - 'TERM': 'linux', 19:27:43 INFO - 'TMOUT': '86400', 19:27:43 INFO - 'USER': 'cltbld', 19:27:43 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1475978253.592126-269373017', 19:27:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:43 INFO - '_': '/tools/buildbot/bin/python'} 19:27:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:43 INFO - Downloading/unpacking psutil>=3.1.1 19:27:43 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 19:27:43 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 19:27:43 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 19:27:43 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 19:27:43 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 19:27:43 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 19:27:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:27:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:27:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:27:45 INFO - Installing collected packages: psutil 19:27:45 INFO - Running setup.py install for psutil 19:27:46 INFO - building 'psutil._psutil_linux' extension 19:27:46 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 19:27:46 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 19:27:46 INFO - building 'psutil._psutil_posix' extension 19:27:46 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 19:27:46 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 19:27:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:27:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:27:46 INFO - Successfully installed psutil 19:27:46 INFO - Cleaning up... 19:27:46 INFO - Return code: 0 19:27:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:27:46 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')]} 19:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:46 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')]} 19:27:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:46 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 0x7fae83c0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d09f60>, '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 0x1d0ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b1d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1475978253.592126-269373017', '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 19:27:46 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 19:27:46 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 19:27:46 INFO - Using env: {'DISPLAY': ':0', 19:27:46 INFO - 'HOME': '/home/cltbld', 19:27:46 INFO - 'LANG': 'en_US.UTF-8', 19:27:46 INFO - 'LANGUAGE': 'en_US:en', 19:27:46 INFO - 'LOGNAME': 'cltbld', 19:27:46 INFO - 'MAIL': '/var/mail/cltbld', 19:27:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:46 INFO - 'MOZ_NO_REMOTE': '1', 19:27:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:46 INFO - 'NO_EM_RESTART': '1', 19:27:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:46 INFO - 'PWD': '/builds/slave/test', 19:27:46 INFO - 'SHELL': '/bin/bash', 19:27:46 INFO - 'SHLVL': '1', 19:27:46 INFO - 'TERM': 'linux', 19:27:46 INFO - 'TMOUT': '86400', 19:27:46 INFO - 'USER': 'cltbld', 19:27:46 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1475978253.592126-269373017', 19:27:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:46 INFO - '_': '/tools/buildbot/bin/python'} 19:27:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:27:46 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 19:27:46 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 19:27:46 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 19:27:46 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 19:27:46 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 19:27:46 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 19:27:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:27:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:27:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:27:48 INFO - Installing collected packages: mozsystemmonitor 19:27:48 INFO - Running setup.py install for mozsystemmonitor 19:27:48 INFO - Successfully installed mozsystemmonitor 19:27:48 INFO - Cleaning up... 19:27:48 INFO - Return code: 0 19:27:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:27:48 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')]} 19:27:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:48 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')]} 19:27:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:48 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 0x7fae83c0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d09f60>, '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 0x1d0ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b1d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1475978253.592126-269373017', '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 19:27:48 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 19:27:48 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 19:27:48 INFO - Using env: {'DISPLAY': ':0', 19:27:48 INFO - 'HOME': '/home/cltbld', 19:27:48 INFO - 'LANG': 'en_US.UTF-8', 19:27:48 INFO - 'LANGUAGE': 'en_US:en', 19:27:48 INFO - 'LOGNAME': 'cltbld', 19:27:48 INFO - 'MAIL': '/var/mail/cltbld', 19:27:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:48 INFO - 'MOZ_NO_REMOTE': '1', 19:27:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:48 INFO - 'NO_EM_RESTART': '1', 19:27:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:48 INFO - 'PWD': '/builds/slave/test', 19:27:48 INFO - 'SHELL': '/bin/bash', 19:27:48 INFO - 'SHLVL': '1', 19:27:48 INFO - 'TERM': 'linux', 19:27:48 INFO - 'TMOUT': '86400', 19:27:48 INFO - 'USER': 'cltbld', 19:27:48 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1475978253.592126-269373017', 19:27:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:48 INFO - '_': '/tools/buildbot/bin/python'} 19:27:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:49 INFO - Downloading/unpacking jsonschema==2.5.1 19:27:49 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 19:27:49 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 19:27:49 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 19:27:49 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 19:27:49 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 19:27:49 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 19:27:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:27:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:27:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:27:51 INFO - Downloading functools32-3.2.3-2.tar.gz 19:27:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:27:51 INFO - warning: no files found matching '*.txt' 19:27:51 INFO - no previously-included directories found matching 'build' 19:27:51 INFO - no previously-included directories found matching 'dist' 19:27:51 INFO - no previously-included directories found matching '.git*' 19:27:51 INFO - Installing collected packages: jsonschema, functools32 19:27:51 INFO - Running setup.py install for functools32 19:27:51 INFO - warning: no files found matching '*.txt' 19:27:51 INFO - no previously-included directories found matching 'build' 19:27:51 INFO - no previously-included directories found matching 'dist' 19:27:51 INFO - no previously-included directories found matching '.git*' 19:27:51 INFO - Successfully installed jsonschema functools32 19:27:51 INFO - Cleaning up... 19:27:51 INFO - Return code: 0 19:27:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:27:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:51 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 0x7fae83c0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d09f60>, '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 0x1d0ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b1d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1475978253.592126-269373017', '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 19:27:51 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 19:27:51 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 19:27:51 INFO - Using env: {'DISPLAY': ':0', 19:27:51 INFO - 'HOME': '/home/cltbld', 19:27:51 INFO - 'LANG': 'en_US.UTF-8', 19:27:51 INFO - 'LANGUAGE': 'en_US:en', 19:27:51 INFO - 'LOGNAME': 'cltbld', 19:27:51 INFO - 'MAIL': '/var/mail/cltbld', 19:27:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:51 INFO - 'MOZ_NO_REMOTE': '1', 19:27:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:51 INFO - 'NO_EM_RESTART': '1', 19:27:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:51 INFO - 'PWD': '/builds/slave/test', 19:27:51 INFO - 'SHELL': '/bin/bash', 19:27:51 INFO - 'SHLVL': '1', 19:27:51 INFO - 'TERM': 'linux', 19:27:51 INFO - 'TMOUT': '86400', 19:27:51 INFO - 'USER': 'cltbld', 19:27:51 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1475978253.592126-269373017', 19:27:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:51 INFO - '_': '/tools/buildbot/bin/python'} 19:27:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:27:51 INFO - Cleaning up... 19:27:51 INFO - Return code: 0 19:27:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:27:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:51 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 0x7fae83c0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d09f60>, '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 0x1d0ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b1d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1475978253.592126-269373017', '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 19:27:51 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 19:27:51 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 19:27:51 INFO - Using env: {'DISPLAY': ':0', 19:27:51 INFO - 'HOME': '/home/cltbld', 19:27:51 INFO - 'LANG': 'en_US.UTF-8', 19:27:51 INFO - 'LANGUAGE': 'en_US:en', 19:27:51 INFO - 'LOGNAME': 'cltbld', 19:27:51 INFO - 'MAIL': '/var/mail/cltbld', 19:27:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:51 INFO - 'MOZ_NO_REMOTE': '1', 19:27:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:51 INFO - 'NO_EM_RESTART': '1', 19:27:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:51 INFO - 'PWD': '/builds/slave/test', 19:27:51 INFO - 'SHELL': '/bin/bash', 19:27:51 INFO - 'SHLVL': '1', 19:27:51 INFO - 'TERM': 'linux', 19:27:51 INFO - 'TMOUT': '86400', 19:27:51 INFO - 'USER': 'cltbld', 19:27:51 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1475978253.592126-269373017', 19:27:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:51 INFO - '_': '/tools/buildbot/bin/python'} 19:27:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:51 INFO - Downloading/unpacking blobuploader==1.2.4 19:27:51 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 19:27:51 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 19:27:51 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 19:27:51 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 19:27:51 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 19:27:51 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 19:27:53 INFO - Downloading blobuploader-1.2.4.tar.gz 19:27:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:27:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:27:53 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 19:27:53 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 19:27:53 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 19:27:53 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 19:27:53 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 19:27:53 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 19:27:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:27:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:27:54 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 19:27:54 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 19:27:54 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 19:27:54 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 19:27:54 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 19:27:54 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 19:27:54 INFO - Downloading docopt-0.6.1.tar.gz 19:27:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:27:54 INFO - Installing collected packages: blobuploader, requests, docopt 19:27:54 INFO - Running setup.py install for blobuploader 19:27:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:27:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:27:54 INFO - Running setup.py install for requests 19:27:55 INFO - Running setup.py install for docopt 19:27:55 INFO - Successfully installed blobuploader requests docopt 19:27:55 INFO - Cleaning up... 19:27:55 INFO - Return code: 0 19:27:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:55 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 0x7fae83c0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d09f60>, '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 0x1d0ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b1d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1475978253.592126-269373017', '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 19:27:55 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 19:27:55 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 19:27:55 INFO - Using env: {'DISPLAY': ':0', 19:27:55 INFO - 'HOME': '/home/cltbld', 19:27:55 INFO - 'LANG': 'en_US.UTF-8', 19:27:55 INFO - 'LANGUAGE': 'en_US:en', 19:27:55 INFO - 'LOGNAME': 'cltbld', 19:27:55 INFO - 'MAIL': '/var/mail/cltbld', 19:27:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:55 INFO - 'MOZ_NO_REMOTE': '1', 19:27:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:55 INFO - 'NO_EM_RESTART': '1', 19:27:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:55 INFO - 'PWD': '/builds/slave/test', 19:27:55 INFO - 'SHELL': '/bin/bash', 19:27:55 INFO - 'SHLVL': '1', 19:27:55 INFO - 'TERM': 'linux', 19:27:55 INFO - 'TMOUT': '86400', 19:27:55 INFO - 'USER': 'cltbld', 19:27:55 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1475978253.592126-269373017', 19:27:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:55 INFO - '_': '/tools/buildbot/bin/python'} 19:27:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:27:55 INFO - Running setup.py (path:/tmp/pip-QLxuGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:27:55 INFO - Running setup.py (path:/tmp/pip-fYhV6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:27:55 INFO - Running setup.py (path:/tmp/pip-Df_2HA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:27:55 INFO - Running setup.py (path:/tmp/pip-Kyfa6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:27:55 INFO - Running setup.py (path:/tmp/pip-8kSevb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:27:55 INFO - Running setup.py (path:/tmp/pip-ZHB4uK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:27:55 INFO - Running setup.py (path:/tmp/pip-JahxyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:27:55 INFO - Running setup.py (path:/tmp/pip-tOj8p_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:27:55 INFO - Running setup.py (path:/tmp/pip-PTX1_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:27:56 INFO - Running setup.py (path:/tmp/pip-bCpmiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:27:56 INFO - Running setup.py (path:/tmp/pip-AmRbOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:27:56 INFO - Running setup.py (path:/tmp/pip-UqYMei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:27:56 INFO - Running setup.py (path:/tmp/pip-SwkWgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:27:56 INFO - Running setup.py (path:/tmp/pip-NL1hj_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:56 INFO - Running setup.py (path:/tmp/pip-YGyQzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:27:56 INFO - Running setup.py (path:/tmp/pip-ENXd6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:27:56 INFO - Running setup.py (path:/tmp/pip-q8yWRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:27:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:27:56 INFO - Running setup.py install for manifestparser 19:27:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:27:56 INFO - Running setup.py install for mozcrash 19:27:56 INFO - Running setup.py install for mozdebug 19:27:56 INFO - Running setup.py install for mozdevice 19:27:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:27:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:27:57 INFO - Running setup.py install for mozfile 19:27:57 INFO - Running setup.py install for mozhttpd 19:27:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:27:57 INFO - Running setup.py install for mozinfo 19:27:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:27:57 INFO - Running setup.py install for mozInstall 19:27:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:27:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:27:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:27:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:27:57 INFO - Running setup.py install for mozleak 19:27:57 INFO - Running setup.py install for mozlog 19:27:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:27:57 INFO - Running setup.py install for moznetwork 19:27:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:27:57 INFO - Running setup.py install for mozprocess 19:27:57 INFO - Running setup.py install for mozprofile 19:27:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:27:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:27:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:27:58 INFO - Running setup.py install for mozrunner 19:27:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:27:58 INFO - Running setup.py install for mozscreenshot 19:27:58 INFO - Running setup.py install for moztest 19:27:58 INFO - Running setup.py install for mozversion 19:27:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:27:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:27:58 INFO - Cleaning up... 19:27:58 INFO - Return code: 0 19:27:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:27:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:58 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 0x7fae83c0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d09f60>, '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 0x1d0ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b1d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1475978253.592126-269373017', '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 19:27:58 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 19:27:58 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 19:27:58 INFO - Using env: {'DISPLAY': ':0', 19:27:58 INFO - 'HOME': '/home/cltbld', 19:27:58 INFO - 'LANG': 'en_US.UTF-8', 19:27:58 INFO - 'LANGUAGE': 'en_US:en', 19:27:58 INFO - 'LOGNAME': 'cltbld', 19:27:58 INFO - 'MAIL': '/var/mail/cltbld', 19:27:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:58 INFO - 'MOZ_NO_REMOTE': '1', 19:27:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:58 INFO - 'NO_EM_RESTART': '1', 19:27:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:58 INFO - 'PWD': '/builds/slave/test', 19:27:58 INFO - 'SHELL': '/bin/bash', 19:27:58 INFO - 'SHLVL': '1', 19:27:58 INFO - 'TERM': 'linux', 19:27:58 INFO - 'TMOUT': '86400', 19:27:58 INFO - 'USER': 'cltbld', 19:27:58 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1475978253.592126-269373017', 19:27:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:58 INFO - '_': '/tools/buildbot/bin/python'} 19:27:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:27:58 INFO - Running setup.py (path:/tmp/pip-NHTRFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:27:58 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)) 19:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:27:58 INFO - Running setup.py (path:/tmp/pip-SwJwvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:27:58 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)) 19:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:27:58 INFO - Running setup.py (path:/tmp/pip-OrrkT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:27:58 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)) 19:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:27:58 INFO - Running setup.py (path:/tmp/pip-geaHXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:27:58 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)) 19:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:27:58 INFO - Running setup.py (path:/tmp/pip-WJRLTc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:27:59 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)) 19:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:27:59 INFO - Running setup.py (path:/tmp/pip-5QgRdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:27:59 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)) 19:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:27:59 INFO - Running setup.py (path:/tmp/pip-JGGKl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:27:59 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)) 19:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:27:59 INFO - Running setup.py (path:/tmp/pip-KHe_JM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:27:59 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)) 19:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:27:59 INFO - Running setup.py (path:/tmp/pip-EGB1sE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:27:59 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)) 19:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:27:59 INFO - Running setup.py (path:/tmp/pip-zMWi6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:27:59 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)) 19:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:27:59 INFO - Running setup.py (path:/tmp/pip-ZREeGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:27:59 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)) 19:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:27:59 INFO - Running setup.py (path:/tmp/pip-LOMAvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:27:59 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)) 19:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:27:59 INFO - Running setup.py (path:/tmp/pip-pQDCeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:27:59 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)) 19:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:27:59 INFO - Running setup.py (path:/tmp/pip-mB5fD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:27:59 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)) 19:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:59 INFO - Running setup.py (path:/tmp/pip-gySFPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:59 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)) 19:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:27:59 INFO - Running setup.py (path:/tmp/pip-aDs8nq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:27:59 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)) 19:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:27:59 INFO - Running setup.py (path:/tmp/pip-hak3vS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:27:59 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)) 19:27:59 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)) 19:27:59 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)) 19:27:59 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)) 19:27:59 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)) 19:27:59 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)) 19:27:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:27:59 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 19:27:59 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 19:27:59 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 19:27:59 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 19:27:59 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 19:27:59 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 19:28:01 INFO - Downloading blessings-1.6.tar.gz 19:28:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:28:01 INFO - Installing collected packages: blessings 19:28:01 INFO - Running setup.py install for blessings 19:28:02 INFO - Successfully installed blessings 19:28:02 INFO - Cleaning up... 19:28:02 INFO - Return code: 0 19:28:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:28:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:28:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:28:02 INFO - Reading from file tmpfile_stdout 19:28:02 INFO - Current package versions: 19:28:02 INFO - argparse == 1.2.1 19:28:02 INFO - blessings == 1.6 19:28:02 INFO - blobuploader == 1.2.4 19:28:02 INFO - docopt == 0.6.1 19:28:02 INFO - functools32 == 3.2.3-2 19:28:02 INFO - jsonschema == 2.5.1 19:28:02 INFO - manifestparser == 1.1 19:28:02 INFO - mozInstall == 1.12 19:28:02 INFO - mozcrash == 0.17 19:28:02 INFO - mozdebug == 0.1 19:28:02 INFO - mozdevice == 0.48 19:28:02 INFO - mozfile == 1.2 19:28:02 INFO - mozhttpd == 0.7 19:28:02 INFO - mozinfo == 0.9 19:28:02 INFO - mozleak == 0.1 19:28:02 INFO - mozlog == 3.4 19:28:02 INFO - moznetwork == 0.27 19:28:02 INFO - mozprocess == 0.23 19:28:02 INFO - mozprofile == 0.28 19:28:02 INFO - mozrunner == 6.12 19:28:02 INFO - mozscreenshot == 0.1 19:28:02 INFO - mozsystemmonitor == 0.3 19:28:02 INFO - moztest == 0.7 19:28:02 INFO - mozversion == 1.4 19:28:02 INFO - psutil == 3.1.1 19:28:02 INFO - requests == 1.2.3 19:28:02 INFO - wsgiref == 0.1.2 19:28:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:28:02 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')]} 19:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:28:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:02 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')]} 19:28:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:28:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:02 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 0x7fae83c0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d09f60>, '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 0x1d0ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b1d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1475978253.592126-269373017', '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 19:28:02 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 19:28:02 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 19:28:02 INFO - Using env: {'DISPLAY': ':0', 19:28:02 INFO - 'HOME': '/home/cltbld', 19:28:02 INFO - 'LANG': 'en_US.UTF-8', 19:28:02 INFO - 'LANGUAGE': 'en_US:en', 19:28:02 INFO - 'LOGNAME': 'cltbld', 19:28:02 INFO - 'MAIL': '/var/mail/cltbld', 19:28:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:02 INFO - 'MOZ_NO_REMOTE': '1', 19:28:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:28:02 INFO - 'NO_EM_RESTART': '1', 19:28:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:28:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:02 INFO - 'PWD': '/builds/slave/test', 19:28:02 INFO - 'SHELL': '/bin/bash', 19:28:02 INFO - 'SHLVL': '1', 19:28:02 INFO - 'TERM': 'linux', 19:28:02 INFO - 'TMOUT': '86400', 19:28:02 INFO - 'USER': 'cltbld', 19:28:02 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1475978253.592126-269373017', 19:28:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:02 INFO - '_': '/tools/buildbot/bin/python'} 19:28:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:28:02 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)) 19:28:02 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)) 19:28:02 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)) 19:28:02 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)) 19:28:02 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)) 19:28:02 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)) 19:28:02 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)) 19:28:02 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)) 19:28:02 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)) 19:28:02 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)) 19:28:02 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)) 19:28:02 INFO - Cleaning up... 19:28:02 INFO - Return code: 0 19:28:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:28:02 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')]} 19:28:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:28:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:02 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')]} 19:28:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:28:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:02 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 0x7fae83c0ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0cca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d09f60>, '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 0x1d0ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b1d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1475978253.592126-269373017', '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 19:28:02 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 19:28:02 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 19:28:02 INFO - Using env: {'DISPLAY': ':0', 19:28:02 INFO - 'HOME': '/home/cltbld', 19:28:02 INFO - 'LANG': 'en_US.UTF-8', 19:28:02 INFO - 'LANGUAGE': 'en_US:en', 19:28:02 INFO - 'LOGNAME': 'cltbld', 19:28:02 INFO - 'MAIL': '/var/mail/cltbld', 19:28:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:02 INFO - 'MOZ_NO_REMOTE': '1', 19:28:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:28:02 INFO - 'NO_EM_RESTART': '1', 19:28:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:28:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:02 INFO - 'PWD': '/builds/slave/test', 19:28:02 INFO - 'SHELL': '/bin/bash', 19:28:02 INFO - 'SHLVL': '1', 19:28:02 INFO - 'TERM': 'linux', 19:28:02 INFO - 'TMOUT': '86400', 19:28:02 INFO - 'USER': 'cltbld', 19:28:02 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1475978253.592126-269373017', 19:28:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:02 INFO - '_': '/tools/buildbot/bin/python'} 19:28:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:28:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:28:02 INFO - Cleaning up... 19:28:02 INFO - Return code: 0 19:28:02 INFO - Running post-action listener: _resource_record_post_action 19:28:02 INFO - Running post-action listener: _start_resource_monitoring 19:28:02 INFO - Starting resource monitoring. 19:28:02 INFO - [mozharness: 2016-10-09 02:28:02.795636Z] Finished create-virtualenv step (success) 19:28:02 INFO - [mozharness: 2016-10-09 02:28:02.796154Z] Running install step. 19:28:02 INFO - Running pre-action listener: _resource_record_pre_action 19:28:02 INFO - Running main action method: install 19:28:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:28:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:28:03 INFO - Reading from file tmpfile_stdout 19:28:03 INFO - Detecting whether we're running mozinstall >=1.0... 19:28:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:28:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:28:03 INFO - Reading from file tmpfile_stdout 19:28:03 INFO - Output received: 19:28:03 INFO - Usage: mozinstall [options] installer 19:28:03 INFO - Options: 19:28:03 INFO - -h, --help show this help message and exit 19:28:03 INFO - -d DEST, --destination=DEST 19:28:03 INFO - Directory to install application into. [default: 19:28:03 INFO - "/builds/slave/test"] 19:28:03 INFO - --app=APP Application being installed. [default: firefox] 19:28:03 INFO - mkdir: /builds/slave/test/build/application 19:28:03 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'] 19:28:03 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 19:28:19 INFO - Reading from file tmpfile_stdout 19:28:19 INFO - Output received: 19:28:19 INFO - /builds/slave/test/build/application/firefox/firefox 19:28:19 INFO - Running post-action listener: _resource_record_post_action 19:28:19 INFO - [mozharness: 2016-10-09 02:28:19.223254Z] Finished install step (success) 19:28:19 INFO - [mozharness: 2016-10-09 02:28:19.223500Z] Running run-tests step. 19:28:19 INFO - Running pre-action listener: _resource_record_pre_action 19:28:19 INFO - Running main action method: run_tests 19:28:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:28:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:28:19 INFO - Python 2.7.3 19:28:19 INFO - Return code: 0 19:28:19 INFO - grabbing minidump binary from tooltool 19:28:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:28:19 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 0x1d09f60>, '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 0x1d0ad40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:28:19 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 19:28:19 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 19:28:19 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 19:28:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:28:19 INFO - Return code: 0 19:28:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:28:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:28:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:28:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:28:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:28:19 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:28:19 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:28:19 INFO - Using env: {'DISPLAY': ':0', 19:28:19 INFO - 'HOME': '/home/cltbld', 19:28:19 INFO - 'LANG': 'en_US.UTF-8', 19:28:19 INFO - 'LANGUAGE': 'en_US:en', 19:28:19 INFO - 'LOGNAME': 'cltbld', 19:28:19 INFO - 'MAIL': '/var/mail/cltbld', 19:28:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:28:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:28:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:19 INFO - 'MOZ_NO_REMOTE': '1', 19:28:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:28:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:28:19 INFO - 'NO_EM_RESTART': '1', 19:28:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:28:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:19 INFO - 'PWD': '/builds/slave/test', 19:28:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:28:19 INFO - 'SHELL': '/bin/bash', 19:28:19 INFO - 'SHLVL': '1', 19:28:19 INFO - 'TERM': 'linux', 19:28:19 INFO - 'TMOUT': '86400', 19:28:19 INFO - 'USER': 'cltbld', 19:28:19 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1475978253.592126-269373017', 19:28:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:19 INFO - '_': '/tools/buildbot/bin/python'} 19:28:19 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:28:19 INFO - mozversion application_buildid: 20161008171719 19:28:19 INFO - mozversion application_changeset: ea311deedce9154009a9575e9cad1345669ff781 19:28:19 INFO - mozversion application_display_name: Nightly 19:28:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:28:19 INFO - mozversion application_name: Firefox 19:28:19 INFO - mozversion application_remotingname: firefox 19:28:19 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:28:19 INFO - mozversion application_vendor: Mozilla 19:28:19 INFO - mozversion application_version: 52.0a1 19:28:19 INFO - mozversion platform_buildid: 20161008171719 19:28:19 INFO - mozversion platform_changeset: ea311deedce9154009a9575e9cad1345669ff781 19:28:19 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:28:19 INFO - mozversion platform_version: 52.0a1 19:28:19 INFO - using testdate: 1475980099 19:28:19 INFO - actual date: 1475980099 19:28:19 INFO - starting webserver on 'localhost:57107' 19:28:19 INFO - SUITE-START | Running 2 tests 19:28:19 INFO - TEST-START | dromaeo_css 19:28:19 INFO - operating with platform_type : linux_ 19:28:19 INFO - Initialising browser for dromaeo_css test... 19:28:19 INFO - TEST-INFO | started process 3880 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkJTi_4/profile http://localhost:57107/getInfo.html) 19:28:24 INFO - PROCESS | 3880 | __metrics Screen width/height:1600/1200 19:28:24 INFO - PROCESS | 3880 | colorDepth:24 19:28:24 INFO - PROCESS | 3880 | Browser inner width/height: 1024/697 19:28:24 INFO - PROCESS | 3880 | __metrics 19:28:25 ERROR - PROCESS | 3880 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 19:28:26 INFO - TEST-INFO | 3880: exit 0 19:28:26 INFO - Browser initialized. 19:28:26 INFO - Running cycle 1/1 for dromaeo_css test... 19:28:26 INFO - TEST-INFO | started process 4003 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkJTi_4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:28:38 INFO - PROCESS | 4003 | RSS: Main: 185692160 19:28:38 INFO - PROCESS | 4003 | 19:29:28 INFO - PROCESS | 4003 | 1475980168520 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] 19:31:42 INFO - PROCESS | 4003 | Cycle 1(1): loaded http://localhost:57107/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57107/tests/dromaeo/cssquery-ext.html) 19:31:43 INFO - PROCESS | 4003 | RSS: Main: 199602176 19:31:43 INFO - PROCESS | 4003 | 19:34:46 INFO - PROCESS | 4003 | Cycle 1(1): loaded http://localhost:57107/tests/dromaeo/cssquery-ext.html (next: http://localhost:57107/tests/dromaeo/cssquery-jquery.html) 19:34:46 INFO - PROCESS | 4003 | RSS: Main: 201011200 19:34:46 INFO - PROCESS | 4003 | 19:37:48 INFO - PROCESS | 4003 | Cycle 1(1): loaded http://localhost:57107/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57107/tests/dromaeo/cssquery-mootools.html) 19:37:49 INFO - PROCESS | 4003 | RSS: Main: 198037504 19:37:49 INFO - PROCESS | 4003 | 19:40:51 INFO - PROCESS | 4003 | Cycle 1(1): loaded http://localhost:57107/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57107/tests/dromaeo/cssquery-prototype.html) 19:40:52 INFO - PROCESS | 4003 | RSS: Main: 194416640 19:40:52 INFO - PROCESS | 4003 | 19:43:55 INFO - PROCESS | 4003 | Cycle 1(1): loaded http://localhost:57107/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57107/tests/dromaeo/cssquery-yui.html) 19:43:55 INFO - PROCESS | 4003 | RSS: Main: 197148672 19:43:55 INFO - PROCESS | 4003 | 19:46:58 INFO - PROCESS | 4003 | Cycle 1(1): loaded http://localhost:57107/tests/dromaeo/cssquery-yui.html (next: http://localhost:57107/tests/dromaeo/cssquery-dojo.html) 19:46:58 INFO - PROCESS | 4003 | RSS: Main: 198504448 19:46:58 INFO - PROCESS | 4003 | 19:46:58 INFO - PROCESS | 4003 | __start_tp_report 19:46:58 INFO - PROCESS | 4003 | _x_x_mozilla_page_load 19:46:58 INFO - PROCESS | 4003 | _x_x_mozilla_page_load_details 19:46:58 INFO - PROCESS | 4003 | |i|pagename|runs| 19:46:58 INFO - PROCESS | 4003 | |0;dojo.html;2641.471705658868;2649.456861343425;2651.151631477928;2656.588228824533;2669.813113082084;4623.8150473981;4743.549362810536;4761.4286285645685;4782.6173906087515;4827.58965487934;4676.134915040711;4778.187708089625;4789.521047895218;4811.975940120295;4847.03059388122;4410.536893626155;4445.22208613493;4470.575295346936;4519.096180763844;4576.588107070363;4477.7984990675495;4522.253828118373;4532.8413505527315;4559.498455169929;4567.474740404863;4364.388985542027;4430.379746835446;4441.444819397575;4449.57729015743;4456.17560751262;4460.375547423363;4468.597826195658;4475.485319188302;4513.052259025609;4516.322551617251;4404.339349097661;4419.11617676466;4428.180786554498;4454.821807127711;4491.595756381941;4664.277037059227;4713.198756211452;4727.692699974491;4739.73931433771;4763.666543341968;4959.082569724613;5014.122528557488;5020.472850350734;5072.391313042459;5116.820911268088;5096.898062038776;5105.438401775838;5107.412647545542;5112.974435127838;5175.249588809639;4699.201135806853;4751.786169622375;4758.5241475852135;4801.95198048015;4824.517548245148;5249.2126181073145;5258.2112683097075;5259.737013149327;5266.420693723688;5269.840635060281;5036.169032109734;5044.848654540369;5046.192609182586;5049.57078648319;5068.670536415121;4962.206047032458;5033.245013247969;5068.4424713281505;5087.847364579068;5202.24567437727;5054.16606259963;5059.645824792229;5072.873178170502;5079.238114282887;5135.075686376414;5025.874353141127;5028.748562571856;5031.924521132186;5033.79864805411;5056.898862022813;4173.353130264813;4201.495820501559;4217.7891105444605;4261.31818908973;4287.935680964725;3747.2130852521277;3752.099496120911;3781.9243615127543;3803.391457366808;3808.6953043756434;4342.717723347972;4426.778661066934;4431.047324825114;4442.511323754385;4488.4165058542185;5021.297018417425;5094.1849304111165;5095.159298715745;5146.176611742103;5171;4426.092651006536;4448.199324121624;4461.130079634505;4489.191945449785;4492.303692927601;4585.72485650862;4600.470945841204;4612.976935115303;4638.582527572535;4680.087382960358;4571.062932098978;4624;4794.808207671654;4802.087603355351;4811.27830825379;4945.381827271591;4947.554720075211;4967.9006419870675;4968.627352948471;4968.8757781055765;4668.696534725232;4677.415323084614;4697.741624210565;4746.2168742157155;4753.382060332273;4892.0705066037335;4961.925571116509;4974.626902982219;5085.847424577269;5087.364079490064;5098.923516147335;5140.537351638371;5177.301064356264;5180.352455943007;5185.248139019896;4941.728204948762;5021.84934451967;5028.296038554532;5042.420121686053;5074.873128171826;4784.856454306377;4878.0975519529;4892.951070489249;4918.901621967612;4949.901001980013;4860.586850117779;4865.58642515376;4920.409550853778;4927.704337739747;4965.47862474435;5017.949820501748;5021.698698078127;5021.974890125526;5029.27075574047;5030.320906677552;4704.29435584665;4763.428388593391;4862.562369386772;4920.040592084509;4954.083494553519 19:46:58 INFO - PROCESS | 4003 | |1;ext.html;518.8910328830946;540.1870185371016;542.4927692607415;543.8422857371362;551.4320250142355;36297.63702362976;38083;38272.42591361128;41846.79076604613;41929.16141677172;39287.80356098215;39430.211395772065;39735.40396894049;39748.60251397485;39907.21577331853;7586.848263034736;7752.961235193844;7764.650590723403;7796.220377962215;7802.21977802218;7628.199039100898;7651.349635281008;7696.345810606105;7721.22787721229;7741.496802707834;7747.728829490969;7786.260305271018;7791.688332466694;7794.06471223454;7811.140774514799;7657.425693073042;7722.034745656793;7735.574543400111;7764.262395072459;7775.8444831103625;7628.847423051508;7692.000039994765;7697.690692792196;7702.614869256515;7706.614669266514;36910;37203.255934881425;37252.62747372519;37289.25421491555;37348;3047.54286856971;3147.5436061771143;3187.378461200067;3295.917602059944;3364.5626068610923;28217.153485395473;28264.29339266535;28549.57175642367;28616.713832861613;28728.569071463735;3240.983795081033;3296.2089098616398;3309.470484722457;3415.112070861594;3454.3436747017986;238295;240481;240513;242230;242272.99999999822;48052.75973620179;48655.51344486581;48866.755666222154;48947.265791012454;49082.75458622684;50396.49603503918;50961;51002.23496647553;51010.48989510132;51023.48976510262;14392.784108238386;14543.636409089646;14610.26948652563;14650.780238296435;14667.559973200821;11090.778184436265;11152.832707509393;11170.050545703543;11193.10455163585;11194.328340299608;13968.301584920713;14444;14469.638259043608;14603.488877889224;14728.189949552663;5767.538596912237;5774.595778295479;5879.355309305601;5993.910091348634;6137.60105593135;779.2558107007794;881;892.723255790707;924.2051835421532;1012.1447376966598;27092.86453567759;27247.076589868193;27529.174124776287;27531.31171720723;27666.308342291602;945.3618807305179;963.8650588917557;971.2472833554052;1012.9493525323852;1068.503146037081;14515.92742036283;14556.199409032393;14568.344424500923;14627.78058329126;14645.048071875293;333605.65577376634;335528;336503.317483411;336629;337740;46590.5340946593;46597.06805863864;46802;46822.76588617035;46880.5311946883;1156.0924674130767;1178.988210117905;1182.917195796286;1184.7926612842891;1187.0681515010674;25018.249452516455;26304.21087367382;26896.32759181036;27135.86432067827;27196.72803272021;39742.60257397505;40088.59911400965;40179;40220;40236;251060;251804;252981;253148;253560;34065.82967085149;34342.65657343494;34478;34693.30613387668;34781.65218347885;39922.600773991886;40094;40333.39499907445;40410.39384409178;40414.79792601018;34687.82656086703;34944.65055349516;35097.29805403929;35225.471617925235;35385.46921796124;34429.483557746156;34477.48283775695;34592.65407345995;34913.65086349104;35198;28853.278668032628;33673.326533469684;34508;34672.82663586666;34756.13109672177;29735;32852.507212391356;33025.66974330226;33169.50245746364;33211.667883321825;23630.763692362856;24165.395865103514;24658.630120548565;26049.218523444328;26606.60090098611 19:46:58 INFO - PROCESS | 4003 | |2;jquery.html;349.20381530111325;357.28364628919013;357.7245520948869;368.98339574719137;376.955832344406;15311;15569;16708.58228544287;16861.325546978136;16868.662626747457;15370.154641494713;15841.287142078605;16269.430569930026;16313.673726525461;16513.17434128295;4445.488768791582;4996.650234483587;5021.799128034874;5055.266986286986;5081.339425874631;4887.853364399074;4948.752562371885;5044.924326135111;5045.899082018357;5050.065737838511;5009.02324046811;5020;5281.947180528203;5306.151015837467;5307.920381194285;5326.387465441485;5348;5379.085555455582;5386.569074474052;5391.78432862685;4997.150484417658;5121.436641969381;5159.664621799571;5171.120909445403;5181.119209734316;12011.819822702666;12228.571999980048;12283.324417157053;18042.819571804375;20122.496937576532;1776.9822301776946;1878.286251224526;1894.384325094336;1937.9515512112168;1951.834094102003;8706.956465217634;9143.45139291638;9471.857922131174;9641.228701703847;9680.225581953428;1676.362982066819;1710.5552556335317;1744.6859565278244;1755.5084576318523;1763.9911800440916;69125.65437172832;70335;70666.64666676633;71169.64415177943;71768;8228.547429891294;8731.476111433334;8795.824083518422;8927.598258078402;9022.684206052756;11631.88368116308;11660.358680272666;11682.70793230176;11699.941500292443;11712.941435292769;6467.935320646828;6783.62690052042;6790.558613690095;6982.162140543167;6984.720611175598;6455.580387274812;6748.460123190133;6763.051654532237;6904.171499420102;6925.6190909499455;3649.1789347397153;3671.284099600552;3732.701383889282;3766.227923275722;3787.299349620329;1764.7441121037377;1808.828161324672;1874.2221977879028;1877.5939789900124;1937.1476550317816;787.8463699578642;813.1665043330634;832.8500869843486;838.7819167016497;863.1670438027334;16109.516714498584;16172.75740863888;16231.67536649284;16745.079020653982;16880.662386752443;824.505296821914;848.6902280667636;863.4603372891943;888.6978427334737;947.725159703692;8171;9438.716838494856;9444;9607.471589062528;9724.659063721094;331114;346772;349195.7942313146;351940;352107;80570;80875;80914;81495.59252203701;84545.57727211325;894.2220268366563;912.0833562270009;929.702495201529;932.0818993291603;942.5193151492788;15406.383744650537;15573.532794016197;15885.920570397075;16056.277467513757;16319.67360652804;36582.81708591546;36901;38215.61784382121;38238;38842.6115738839;47348.289775654084;47885.76057119831;49608.255876162606;52291.47708522866;52690.73654631702;7008.159020917523;7168.641567921687;7280.927190728236;7381.077365329334;7383.741569045058;9550.904490955001;10291.382517049002;10543.894561054598;10680;10843.891561084289;5103.821366252163;8924.643014279616;9312.906870931203;9350.625974960925;9447.527623618655;9051.940375607759;9190.40262382943;9278.164965153168;9341.859872102059;9488.240940724863;9084.772880677772;9146.817063658822;9184.724458266262;9239.168474837297;9761.85357219628;6671.499637527302;6957.512974091967;6980.965095174694;7205.963970180115;7340.669669864762;8700.564971751513;10350;10516.15870730355;10682.252242342962;10726.463676816284 19:46:58 INFO - PROCESS | 4003 | |3;mootools.html;1324.1856258401083;1358.5245164192531;1403.8245219347582;1626.4795265515033;1627.5280168751062;6833.931660683392;7095.7161713531395;7213.855722885539;7839.568823714701;7851.097123830761;7410.666520006599;7720.7297744578955;7757.806054848632;7924.603769811515;7961.761147165595;2080.843936704746;2106.2628080171894;2131.435169680036;2131.957360852782;2132.4562236629636;2064.6180456615575;2114.9154033838704;2169.555241175563;2169.6853956176346;2173.652215645497;2120.045979309309;2128.138104067847;2135.882526461044;2144.603248399051;2159.255057005331;2074.1288658763356;2077.0549400022956;2084.8853313067775;2089.0494824854654;2092.4036649554805;2037.7147199391948;2090.9477263068393;2093.842961777873;2100.054975261123;2115.7038014677955;7812.218778122199;7823.3350165236025;7856.528608283521;7913.327367173797;7919.920800791976;4275.273203555403;4433.179861725591;4433.312836510314;4433.933490997638;4435.955640443586;2767.8892844286206;2823.2377258140186;2842.360468894503;2901.4487247423135;2923.444545536341;902.7156445719577;932.0539652252969;934.8504239321676;936.7073438654613;944.6882528765491;10590.523426445752;10594.788104237949;10622.57509699611;10625.84061239082;10646.78706425875;3757.887263382103;3849.4418309344987;3992.48097747291;4006.45912801768;4089.5092588889524;8954.641814327484;8958.641654333753;8974.551272436353;8999.505027223435;9012.053734357929;4467.441569803775;4483.461984561874;4489.034857505587;4492.932606010912;4510.977445112819;3436.1409647588102;3518.9296214075575;3905.062784931653;4104.897377565585;4107.322291821875;3441.1397150712323;3462.4286992646435;3589.964100358963;3621.8732344367822;3690.132818787583;1139.3733446604335;1141.406468636321;1149.804533229353;1159.7269352070036;1173.9354335511457;673.3872176319526;687.7867860963117;742.3430264216099;813.5484805932646;817.6606708216143;4748.19280722278;4869.756512174377;4880.511948805162;4993.550580447777;5007.273945277914;375.64313901793406;392.46232661254265;394.134873951679;394.4832269726667;401.65457706372496;3317.93364132716;3362.4620060790157;3427.503012063237;3432.708219801345;3480.599731030964;8947.507887066144;9085.13691199335;9210.81578368429;9215;9227.907720922705;9178.403403778733;9196.724098277062;9220.400673956305;9264.72205833826;9322.394044387092;6987.056747339044;7033.542819716702;7047.40097091753;7114.324139206767;7134.678939447737;4693.953060469352;4747;4750.192467280502;4859.878503037452;5013.273075403973;8305.127961563949;8397.748067557983;8449.535275559903;8452.535110568731;8511.531865747444;8564.357673174412;8585.527795971282;8590.785230369042;8630.82738345217;8710.91289087101;5741.282339707536;5992.790252341147;6468.708908099241;6485.540753330463;6505.837354065997;7305.3425191732995;7519.812004699927;7562.659680314289;7576.772696819105;7579.052618422697;6555.868882622416;6578.638174900427;6582.736690532325;6841.897371539331;6842;6220.844478888064;6305.464035557029;6368.554201205871;6378.2346118466085;6394.360563943755;5927.051671732502;6063.605865618721;6065.4541091302;6067.787627433018;6073.514118870391;4309.59058889405;4345.456817897762;4349.260625693576;4422.137683151755;4498.347739577677;4201.327787554099;4261.850835220753;4360.040791025969;4415.735055896656;4462.509123996423 19:46:58 INFO - PROCESS | 4003 | |4;prototype.html;271.57227366897143;276.2830454969355;280.2223828874872;282.38299315994544;286.1872282717083;5071.594272458195;5077.974610126954;5083.669561478506;5088.211327244278;5147.253648221011;4963;4964.4787297333805;4964.851054468363;4976.755811047238;5003.374578177728;3939.192465544571;3945.191235796662;3967.801609919507;3980.800959952005;3982.9800850995703;3982.17265741324;3987.8036589023177;3988.6809055275653;3992.7205095643317;4003.639672429481;3583.516225309589;3818.4081467372603;3843.634854688814;3852.4799152114524;3865.8982190075835;3794.392897136445;3819.0070581648692;3828.8277027533827;3832.9808350958347;3835.137094153821;3063.1729433053174;3134.8902788402297;3317.319949410365;3319.6514365991466;3324.1523411529906;4763.094762095155;4885.487023862479;4889.3643826302705;4894.559489645913;4899.55903968641;4354.521002689701;4364.516064538072;4384.9561504384865;4390.846320378771;4396.78016099197;5044.385796545107;5212.55693266069;5255.894882102375;5271.314729085195;5327;3495.580530336376;3501.2647344057777;3504.6320136385566;3504.9649503504893;3505.94741078884;5414.187871819219;5441.959265275522;5455.945440545584;5482.451754824526;5484.725763711798;3677.5841301099267;3685.1758379601733;3699.5190625218547;3702.9814850925573;3706.99911024022;3652.4886515887797;3703.851845926187;3704.870329538507;3715.8327875245136;3721.9069523262133;4259.403683484315;4261.2542805009;4264.978675106605;4268.935965960513;4274.508431530352;5210.557102646318;5235.439900867371;5237.240600112962;5237.895242095136;5315.202719592015;1230.1757822258928;1280.929548874802;1286.3182513267982;1288.7035981724257;1294.7086905446388;760.8820632801925;799.5762246009624;809.8176662073321;812.634314558451;820.8973878265217;4131.607497287753;4152.2525945330135;4176.160211056511;4176.705221381381;4209.726367786084;4685.765711714401;4760.571548560646;4767.284907263938;4792.4249090108715;4797.280407938767;4132.5329508024815;4141.855035073818;4152.8338866445;4180.372944058355;4205.317872850823;2355.3993731598334;2508.623706444048;2517.804043079559;2530.836135104459;2542.8601426921696;4476.574725401082;4833.32333473314;4861.246506791453;4982.177940639754;5062.139436295765;5509.614326997072;5534.833954981357;5549.417311182348;5554.583406244467;5605.8598535036135;5095.796168153232;5101.617378696613;5102.877366979259;5116.283720279164;5117.513836185556;5071.9602481490465;5392.110301800159;5401.29859094384;5437.972810136082;5442.591805614516;5346.385165705994;5346.492083252085;5366.865828354323;5371.731413429391;5389.353277606712;4892.092084087138;5078.669886457368;5105.387353517602;5117.002184573972;5123.641345105807;3710.925781484409;3720.9627903720616;3742.326381251401;3762.2129488493842;3770.792606406564;5473.28847249855;5506.201600767786;5534.833954981357;5571.832845014656;5595.832125036255;5100.214924776298;5286.784039670821;5370.919436208382;5405.459454054563;5415.404305526467;5250.97374513125;5251.658642188246;5294.8941021180135;5302.549283310807;5305.814296499604;5223.634345595772;5228.45101264377;5242.135047717084;5243.423223445494;5279.2081187820595;5156.9742151289;5317.6011799115995;5338.692020454858;5344.305240318889;5349;5184.040952423814;5209.791608335624;5216.243644671577;5222.597605101696;5261.73691315425 19:46:58 INFO - PROCESS | 4003 | |5;yui.html;651.3876955661677;710.360675392147;733.2447578993635;743.2047708951424;746.2947514598704;11512.942435287812;11539.65381038568;12345.382730863455;12767.553135640255;12872.09895307329;13313.800292995613;13800.30998450076;13854.653633659138;13911.026228164033;13950.162990220593;725.5211560370144;756.9318761311481;763.4350580570366;763.5342441110918;766.3409467857638;757.0234397627055;757.71964373182;758.6548120605139;761.0942977856333;762.7521055656933;791.6991543213571;794.7417089445925;798.2695833312512;798.6406117247233;798.6805277888861;784.7292684024003;785.4698078796789;791.89309443225;792.9286364227189;793.2503783924194;559.0719405786416;572.916927045576;580.8315588479336;581.1399129288676;581.7004242814953;12797.232166070065;12940;12941.094123411365;12990.415431305613;13010;11860.881391186063;12469.376531173404;12611.558595449207;12864.807027894589;13192.934035329761;12087.093467989847;12088.818667719992;12098.939505302505;12258.509659613605;12291.139620226588;4034.3545032794614;4046.4739583854207;4125.690573206992;4240.173166232586;4256.106217694288;64443.999999999534;64452;65101;65239.673801631165;65359;10042.949785251027;10058.245631577662;10129.290949633601;10166.745831354126;10238.999730788712;17682.469525914243;17993.370232041816;18019.909900450675;18065.367712130013;18681.719774203397;6088.512918966472;6223.222097237845;6225.470834978987;6277.1525844011385;6290.842728931813;3529.258855640293;3534.8939531814085;3635.909102272464;3674.1733110050027;3724.515812944354;2717.4836781011545;2795;2816.6760822505266;2817.7323154300307;2820.661520617539;474.8884012257117;477.83992362558234;481.3718097882297;482.5729229631731;483.83791429870683;458.7797857028578;505.98229061982653;533.9572834173257;534.1453674121375;537.3739593373676;7406.7037318506655;7777.455578109478;7786.532808031537;7827.647755850887;7877.606119693993;470.3438703009351;488.5920256585791;558.3076984539142;563.2733773432309;603.5865432178972;3679.9080022999638;3784.7480748954326;3857.8842634721004;3971.960280397159;4014.4580481634607;47600.72397292553;47813;90434;93710;94307.52846235862;82535;82803;83435.16564834274;83620.58189709134;84996;73773;73906.26093738993;74625.62687186638;76542;77257.61371193107;6961.930380696128;7289.599072051088;7317.5609463432365;7564.50830696003;7619.580923049286;43279.350809738506;44927.550724492336;45099;46327.598878106524;46861.53138468708;58563;58737.11894321503;65689.34310657023;65801.67099164473;66599;9134.5432728362;9156.313276504156;9370.156685898302;9399.624015039322;9721.270904682036;9791.46146961924;10184.592616295562;10227.43749093807;10358.430286334022;10562.577496900038;9212.631494740135;9240.722778316662;9380.108889655472;9395.342326037111;9708.2718796092;9394.95302523483;9514.096160864707;9712.3201375903;9888.950555247466;9911.504424778876;9121.863172052292;9238.491882946502;9389.624415023596;11293.378864162221;11820.172587918763;10276.280660353703;10397.16822654201;10742.8388574173;10815.459227038775;10848.728781780203;9690.079442452956;9997;10480.371177729361;10530.631427899987;10881.564737410416 19:46:58 INFO - PROCESS | 4003 | __end_tp_report 19:46:58 INFO - PROCESS | 4003 | __start_cc_report 19:46:58 INFO - PROCESS | 4003 | _x_x_mozilla_cycle_collect,335 19:46:58 INFO - PROCESS | 4003 | __end_cc_report 19:46:58 INFO - PROCESS | 4003 | __startTimestamp1475981218771__endTimestamp 19:46:58 INFO - PROCESS | 4003 | 19:46:58 INFO - PROCESS | 4003 | ------- Summary: start ------- 19:46:58 INFO - PROCESS | 4003 | Number of tests: 6 19:46:58 INFO - PROCESS | 4003 | 19:46:58 INFO - PROCESS | 4003 | [#0] dojo.html Cycles:165 Average:4713.52 Median:4802.09 stddev:484.33 (10.1%) stddev-sans-first:457.72 19:46:58 INFO - PROCESS | 4003 | Values: 2641.5 2649.5 2651.2 2656.6 2669.8 4623.8 4743.5 4761.4 4782.6 4827.6 4676.1 4778.2 4789.5 4812.0 4847.0 4410.5 4445.2 4470.6 4519.1 4576.6 4477.8 4522.3 4532.8 4559.5 4567.5 4364.4 4430.4 4441.4 4449.6 4456.2 4460.4 4468.6 4475.5 4513.1 4516.3 4404.3 4419.1 4428.2 4454.8 4491.6 4664.3 4713.2 4727.7 4739.7 4763.7 4959.1 5014.1 5020.5 5072.4 5116.8 5096.9 5105.4 5107.4 5113.0 5175.2 4699.2 4751.8 4758.5 4802.0 4824.5 5249.2 5258.2 5259.7 5266.4 5269.8 5036.2 5044.8 5046.2 5049.6 5068.7 4962.2 5033.2 5068.4 5087.8 5202.2 5054.2 5059.6 5072.9 5079.2 5135.1 5025.9 5028.7 5031.9 5033.8 5056.9 4173.4 4201.5 4217.8 4261.3 4287.9 3747.2 3752.1 3781.9 3803.4 3808.7 4342.7 4426.8 4431.0 4442.5 4488.4 5021.3 5094.2 5095.2 5146.2 5171.0 4426.1 4448.2 4461.1 4489.2 4492.3 4585.7 4600.5 4613.0 4638.6 4680.1 4571.1 4624.0 4794.8 4802.1 4811.3 4945.4 4947.6 4967.9 4968.6 4968.9 4668.7 4677.4 4697.7 4746.2 4753.4 4892.1 4961.9 4974.6 5085.8 5087.4 5098.9 5140.5 5177.3 5180.4 5185.2 4941.7 5021.8 5028.3 5042.4 5074.9 4784.9 4878.1 4893.0 4918.9 4949.9 4860.6 4865.6 4920.4 4927.7 4965.5 5017.9 5021.7 5022.0 5029.3 5030.3 4704.3 4763.4 4862.6 4920.0 4954.1 19:46:58 INFO - PROCESS | 4003 | 19:46:58 INFO - PROCESS | 4003 | [#1] ext.html Cycles:180 Average:43302.22 Median:34768.89 stddev:73195.13 (210.5%) stddev-sans-first:73329.98 19:46:58 INFO - PROCESS | 4003 | Values: 518.9 540.2 542.5 543.8 551.4 36297.6 38083.0 38272.4 41846.8 41929.2 39287.8 39430.2 39735.4 39748.6 39907.2 7586.8 7753.0 7764.7 7796.2 7802.2 7628.2 7651.3 7696.3 7721.2 7741.5 7747.7 7786.3 7791.7 7794.1 7811.1 7657.4 7722.0 7735.6 7764.3 7775.8 7628.8 7692.0 7697.7 7702.6 7706.6 36910.0 37203.3 37252.6 37289.3 37348.0 3047.5 3147.5 3187.4 3295.9 3364.6 28217.2 28264.3 28549.6 28616.7 28728.6 3241.0 3296.2 3309.5 3415.1 3454.3 238295.0 240481.0 240513.0 242230.0 242273.0 48052.8 48655.5 48866.8 48947.3 49082.8 50396.5 50961.0 51002.2 51010.5 51023.5 14392.8 14543.6 14610.3 14650.8 14667.6 11090.8 11152.8 11170.1 11193.1 11194.3 13968.3 14444.0 14469.6 14603.5 14728.2 5767.5 5774.6 5879.4 5993.9 6137.6 779.3 881.0 892.7 924.2 1012.1 27092.9 27247.1 27529.2 27531.3 27666.3 945.4 963.9 971.2 1012.9 1068.5 14515.9 14556.2 14568.3 14627.8 14645.0 333605.7 335528.0 336503.3 336629.0 337740.0 46590.5 46597.1 46802.0 46822.8 46880.5 1156.1 1179.0 1182.9 1184.8 1187.1 25018.2 26304.2 26896.3 27135.9 27196.7 39742.6 40088.6 40179.0 40220.0 40236.0 251060.0 251804.0 252981.0 253148.0 253560.0 34065.8 34342.7 34478.0 34693.3 34781.7 39922.6 40094.0 40333.4 40410.4 40414.8 34687.8 34944.7 35097.3 35225.5 35385.5 34429.5 34477.5 34592.7 34913.7 35198.0 28853.3 33673.3 34508.0 34672.8 34756.1 29735.0 32852.5 33025.7 33169.5 33211.7 23630.8 24165.4 24658.6 26049.2 26606.6 19:46:58 INFO - PROCESS | 4003 | 19:46:58 INFO - PROCESS | 4003 | [#2] jquery.html Cycles:180 Average:22721.40 Median:5140.55 stddev:57754.04 (1123.5%) stddev-sans-first:57891.63 19:46:58 INFO - PROCESS | 4003 | Values: 349.2 357.3 357.7 369.0 377.0 15311.0 15569.0 16708.6 16861.3 16868.7 15370.2 15841.3 16269.4 16313.7 16513.2 4445.5 4996.7 5021.8 5055.3 5081.3 4887.9 4948.8 5044.9 5045.9 5050.1 5009.0 5020.0 5281.9 5306.2 5307.9 5326.4 5348.0 5379.1 5386.6 5391.8 4997.2 5121.4 5159.7 5171.1 5181.1 12011.8 12228.6 12283.3 18042.8 20122.5 1777.0 1878.3 1894.4 1938.0 1951.8 8707.0 9143.5 9471.9 9641.2 9680.2 1676.4 1710.6 1744.7 1755.5 1764.0 69125.7 70335.0 70666.6 71169.6 71768.0 8228.5 8731.5 8795.8 8927.6 9022.7 11631.9 11660.4 11682.7 11699.9 11712.9 6467.9 6783.6 6790.6 6982.2 6984.7 6455.6 6748.5 6763.1 6904.2 6925.6 3649.2 3671.3 3732.7 3766.2 3787.3 1764.7 1808.8 1874.2 1877.6 1937.1 787.8 813.2 832.9 838.8 863.2 16109.5 16172.8 16231.7 16745.1 16880.7 824.5 848.7 863.5 888.7 947.7 8171.0 9438.7 9444.0 9607.5 9724.7 331114.0 346772.0 349195.8 351940.0 352107.0 80570.0 80875.0 80914.0 81495.6 84545.6 894.2 912.1 929.7 932.1 942.5 15406.4 15573.5 15885.9 16056.3 16319.7 36582.8 36901.0 38215.6 38238.0 38842.6 47348.3 47885.8 49608.3 52291.5 52690.7 7008.2 7168.6 7280.9 7381.1 7383.7 9550.9 10291.4 10543.9 10680.0 10843.9 5103.8 8924.6 9312.9 9350.6 9447.5 9051.9 9190.4 9278.2 9341.9 9488.2 9084.8 9146.8 9184.7 9239.2 9761.9 6671.5 6957.5 6981.0 7206.0 7340.7 8700.6 10350.0 10516.2 10682.3 10726.5 19:46:58 INFO - PROCESS | 4003 | 19:46:58 INFO - PROCESS | 4003 | [#3] mootools.html Cycles:180 Average:4944.83 Median:4720.48 stddev:2821.18 (59.8%) stddev-sans-first:2815.97 19:46:58 INFO - PROCESS | 4003 | Values: 1324.2 1358.5 1403.8 1626.5 1627.5 6833.9 7095.7 7213.9 7839.6 7851.1 7410.7 7720.7 7757.8 7924.6 7961.8 2080.8 2106.3 2131.4 2132.0 2132.5 2064.6 2114.9 2169.6 2169.7 2173.7 2120.0 2128.1 2135.9 2144.6 2159.3 2074.1 2077.1 2084.9 2089.0 2092.4 2037.7 2090.9 2093.8 2100.1 2115.7 7812.2 7823.3 7856.5 7913.3 7919.9 4275.3 4433.2 4433.3 4433.9 4436.0 2767.9 2823.2 2842.4 2901.4 2923.4 902.7 932.1 934.9 936.7 944.7 10590.5 10594.8 10622.6 10625.8 10646.8 3757.9 3849.4 3992.5 4006.5 4089.5 8954.6 8958.6 8974.6 8999.5 9012.1 4467.4 4483.5 4489.0 4492.9 4511.0 3436.1 3518.9 3905.1 4104.9 4107.3 3441.1 3462.4 3590.0 3621.9 3690.1 1139.4 1141.4 1149.8 1159.7 1173.9 673.4 687.8 742.3 813.5 817.7 4748.2 4869.8 4880.5 4993.6 5007.3 375.6 392.5 394.1 394.5 401.7 3317.9 3362.5 3427.5 3432.7 3480.6 8947.5 9085.1 9210.8 9215.0 9227.9 9178.4 9196.7 9220.4 9264.7 9322.4 6987.1 7033.5 7047.4 7114.3 7134.7 4694.0 4747.0 4750.2 4859.9 5013.3 8305.1 8397.7 8449.5 8452.5 8511.5 8564.4 8585.5 8590.8 8630.8 8710.9 5741.3 5992.8 6468.7 6485.5 6505.8 7305.3 7519.8 7562.7 7576.8 7579.1 6555.9 6578.6 6582.7 6841.9 6842.0 6220.8 6305.5 6368.6 6378.2 6394.4 5927.1 6063.6 6065.5 6067.8 6073.5 4309.6 4345.5 4349.3 4422.1 4498.3 4201.3 4261.9 4360.0 4415.7 4462.5 19:46:58 INFO - PROCESS | 4003 | 19:46:58 INFO - PROCESS | 4003 | [#4] prototype.html Cycles:180 Average:4279.37 Median:4890.73 stddev:1303.13 (26.6%) stddev-sans-first:1271.59 19:46:58 INFO - PROCESS | 4003 | Values: 271.6 276.3 280.2 282.4 286.2 5071.6 5078.0 5083.7 5088.2 5147.3 4963.0 4964.5 4964.9 4976.8 5003.4 3939.2 3945.2 3967.8 3980.8 3983.0 3982.2 3987.8 3988.7 3992.7 4003.6 3583.5 3818.4 3843.6 3852.5 3865.9 3794.4 3819.0 3828.8 3833.0 3835.1 3063.2 3134.9 3317.3 3319.7 3324.2 4763.1 4885.5 4889.4 4894.6 4899.6 4354.5 4364.5 4385.0 4390.8 4396.8 5044.4 5212.6 5255.9 5271.3 5327.0 3495.6 3501.3 3504.6 3505.0 3505.9 5414.2 5442.0 5455.9 5482.5 5484.7 3677.6 3685.2 3699.5 3703.0 3707.0 3652.5 3703.9 3704.9 3715.8 3721.9 4259.4 4261.3 4265.0 4268.9 4274.5 5210.6 5235.4 5237.2 5237.9 5315.2 1230.2 1280.9 1286.3 1288.7 1294.7 760.9 799.6 809.8 812.6 820.9 4131.6 4152.3 4176.2 4176.7 4209.7 4685.8 4760.6 4767.3 4792.4 4797.3 4132.5 4141.9 4152.8 4180.4 4205.3 2355.4 2508.6 2517.8 2530.8 2542.9 4476.6 4833.3 4861.2 4982.2 5062.1 5509.6 5534.8 5549.4 5554.6 5605.9 5095.8 5101.6 5102.9 5116.3 5117.5 5072.0 5392.1 5401.3 5438.0 5442.6 5346.4 5346.5 5366.9 5371.7 5389.4 4892.1 5078.7 5105.4 5117.0 5123.6 3710.9 3721.0 3742.3 3762.2 3770.8 5473.3 5506.2 5534.8 5571.8 5595.8 5100.2 5286.8 5370.9 5405.5 5415.4 5251.0 5251.7 5294.9 5302.5 5305.8 5223.6 5228.5 5242.1 5243.4 5279.2 5157.0 5317.6 5338.7 5344.3 5349.0 5184.0 5209.8 5216.2 5222.6 5261.7 19:46:58 INFO - PROCESS | 4003 | 19:46:58 INFO - PROCESS | 4003 | [#5] yui.html Cycles:180 Average:16946.16 Median:568.10 stddev:24094.63 (4241.3%) stddev-sans-first:24131.16 19:46:58 INFO - PROCESS | 4003 | Values: 651.4 710.4 733.2 743.2 746.3 11512.9 11539.7 12345.4 12767.6 12872.1 13313.8 13800.3 13854.7 13911.0 13950.2 725.5 756.9 763.4 763.5 766.3 757.0 757.7 758.7 761.1 762.8 791.7 794.7 798.3 798.6 798.7 784.7 785.5 791.9 792.9 793.3 559.1 572.9 580.8 581.1 581.7 12797.2 12940.0 12941.1 12990.4 13010.0 11860.9 12469.4 12611.6 12864.8 13192.9 12087.1 12088.8 12098.9 12258.5 12291.1 4034.4 4046.5 4125.7 4240.2 4256.1 64444.0 64452.0 65101.0 65239.7 65359.0 10042.9 10058.2 10129.3 10166.7 10239.0 17682.5 17993.4 18019.9 18065.4 18681.7 6088.5 6223.2 6225.5 6277.2 6290.8 3529.3 3534.9 3635.9 3674.2 3724.5 2717.5 2795.0 2816.7 2817.7 2820.7 474.9 477.8 481.4 482.6 483.8 458.8 506.0 534.0 534.1 537.4 7406.7 7777.5 7786.5 7827.6 7877.6 470.3 488.6 558.3 563.3 603.6 3679.9 3784.7 3857.9 3972.0 4014.5 47600.7 47813.0 90434.0 93710.0 94307.5 82535.0 82803.0 83435.2 83620.6 84996.0 73773.0 73906.3 74625.6 76542.0 77257.6 6961.9 7289.6 7317.6 7564.5 7619.6 43279.4 44927.6 45099.0 46327.6 46861.5 58563.0 58737.1 65689.3 65801.7 66599.0 9134.5 9156.3 9370.2 9399.6 9721.3 9791.5 10184.6 10227.4 10358.4 10562.6 9212.6 9240.7 9380.1 9395.3 9708.3 9395.0 9514.1 9712.3 9889.0 9911.5 9121.9 9238.5 9389.6 11293.4 11820.2 10276.3 10397.2 10742.8 10815.5 10848.7 9690.1 9997.0 10480.4 10530.6 10881.6 19:46:58 INFO - PROCESS | 4003 | -------- Summary: end -------- 19:46:58 INFO - PROCESS | 4003 | 19:46:59 INFO - TEST-INFO | 4003: exit 0 19:46:59 INFO - TEST-OK | dromaeo_css | took 1120350ms 19:46:59 INFO - TEST-START | kraken 19:46:59 INFO - operating with platform_type : linux_ 19:46:59 INFO - Initialising browser for kraken test... 19:46:59 INFO - TEST-INFO | started process 4366 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVK2qUF/profile http://localhost:57107/getInfo.html) 19:47:04 INFO - PROCESS | 4366 | __metrics Screen width/height:1600/1200 19:47:04 INFO - PROCESS | 4366 | colorDepth:24 19:47:04 INFO - PROCESS | 4366 | Browser inner width/height: 1024/697 19:47:04 INFO - PROCESS | 4366 | __metrics 19:47:05 ERROR - PROCESS | 4366 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 19:47:06 INFO - TEST-INFO | 4366: exit 0 19:47:06 INFO - Browser initialized. 19:47:06 INFO - Running cycle 1/1 for kraken test... 19:47:06 INFO - TEST-INFO | started process 4488 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVK2qUF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:47:18 INFO - PROCESS | 4488 | RSS: Main: 186032128 19:47:18 INFO - PROCESS | 4488 | 19:47:21 INFO - PROCESS | 4488 | Cycle 1(1): loaded http://localhost:57107/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57107/tests/kraken/driver.html?testName=audio-beat-detection) 19:47:22 INFO - PROCESS | 4488 | RSS: Main: 199602176 19:47:22 INFO - PROCESS | 4488 | 19:47:25 INFO - PROCESS | 4488 | Cycle 1(1): loaded http://localhost:57107/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57107/tests/kraken/driver.html?testName=audio-dft) 19:47:26 INFO - PROCESS | 4488 | RSS: Main: 197754880 19:47:26 INFO - PROCESS | 4488 | 19:47:29 INFO - PROCESS | 4488 | Cycle 1(1): loaded http://localhost:57107/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57107/tests/kraken/driver.html?testName=audio-fft) 19:47:29 INFO - PROCESS | 4488 | RSS: Main: 193708032 19:47:29 INFO - PROCESS | 4488 | 19:47:31 INFO - PROCESS | 4488 | Cycle 1(1): loaded http://localhost:57107/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57107/tests/kraken/driver.html?testName=audio-oscillator) 19:47:32 INFO - PROCESS | 4488 | RSS: Main: 194465792 19:47:32 INFO - PROCESS | 4488 | 19:47:34 INFO - PROCESS | 4488 | Cycle 1(1): loaded http://localhost:57107/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57107/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:47:35 INFO - PROCESS | 4488 | RSS: Main: 194088960 19:47:35 INFO - PROCESS | 4488 | 19:47:38 INFO - PROCESS | 4488 | Cycle 1(1): loaded http://localhost:57107/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57107/tests/kraken/driver.html?testName=imaging-darkroom) 19:47:39 INFO - PROCESS | 4488 | RSS: Main: 194469888 19:47:39 INFO - PROCESS | 4488 | 19:47:42 INFO - PROCESS | 4488 | Cycle 1(1): loaded http://localhost:57107/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57107/tests/kraken/driver.html?testName=imaging-desaturate) 19:47:43 INFO - PROCESS | 4488 | RSS: Main: 192446464 19:47:43 INFO - PROCESS | 4488 | 19:47:46 INFO - PROCESS | 4488 | Cycle 1(1): loaded http://localhost:57107/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57107/tests/kraken/driver.html?testName=json-parse-financial) 19:47:47 INFO - PROCESS | 4488 | RSS: Main: 193724416 19:47:47 INFO - PROCESS | 4488 | 19:47:48 INFO - PROCESS | 4488 | Cycle 1(1): loaded http://localhost:57107/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57107/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:47:49 INFO - PROCESS | 4488 | RSS: Main: 193724416 19:47:49 INFO - PROCESS | 4488 | 19:47:51 INFO - PROCESS | 4488 | Cycle 1(1): loaded http://localhost:57107/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57107/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:47:52 INFO - PROCESS | 4488 | RSS: Main: 193789952 19:47:52 INFO - PROCESS | 4488 | 19:47:54 INFO - PROCESS | 4488 | Cycle 1(1): loaded http://localhost:57107/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57107/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:47:54 INFO - PROCESS | 4488 | RSS: Main: 194379776 19:47:54 INFO - PROCESS | 4488 | 19:47:57 INFO - PROCESS | 4488 | Cycle 1(1): loaded http://localhost:57107/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57107/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:47:58 INFO - PROCESS | 4488 | RSS: Main: 194027520 19:47:58 INFO - PROCESS | 4488 | 19:48:01 INFO - PROCESS | 4488 | Cycle 1(1): loaded http://localhost:57107/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57107/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:48:02 INFO - PROCESS | 4488 | RSS: Main: 193990656 19:48:02 INFO - PROCESS | 4488 | 19:48:03 INFO - PROCESS | 4488 | Cycle 1(1): loaded http://localhost:57107/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57107/tests/kraken/driver.html?testName=ai-astar) 19:48:04 INFO - PROCESS | 4488 | RSS: Main: 196661248 19:48:04 INFO - PROCESS | 4488 | 19:48:04 INFO - PROCESS | 4488 | __start_tp_report 19:48:04 INFO - PROCESS | 4488 | _x_x_mozilla_page_load 19:48:04 INFO - PROCESS | 4488 | _x_x_mozilla_page_load_details 19:48:04 INFO - PROCESS | 4488 | |i|pagename|runs| 19:48:04 INFO - PROCESS | 4488 | |0;ai-astar;114;115;116;115;115;117;116;123;114;116 19:48:04 INFO - PROCESS | 4488 | |1;audio-beat-detection;159;130;130;173;134;133;128;130;173;132 19:48:04 INFO - PROCESS | 4488 | |2;audio-dft;169;170;162;164;164;164;164;163;164;164 19:48:04 INFO - PROCESS | 4488 | |3;audio-fft;75;76;76;102;76;77;77;77;106;76 19:48:04 INFO - PROCESS | 4488 | |4;audio-oscillator;85;83;116;83;85;82;102;83;84;114 19:48:04 INFO - PROCESS | 4488 | |5;imaging-gaussian-blur;117;118;117;118;117;117;120;118;119;118 19:48:04 INFO - PROCESS | 4488 | |6;imaging-darkroom;148;148;148;148;149;149;148;150;147;147 19:48:04 INFO - PROCESS | 4488 | |7;imaging-desaturate;97;97;96;96;95;96;95;98;96;96 19:48:04 INFO - PROCESS | 4488 | |8;json-parse-financial;64;66;66;65;66;65;68;66;66;68 19:48:04 INFO - PROCESS | 4488 | |9;json-stringify-tinderbox;67;70;66;67;66;67;67;66;67;68 19:48:04 INFO - PROCESS | 4488 | |10;stanford-crypto-aes;87;84;87;90;84;89;90;83;92;85 19:48:04 INFO - PROCESS | 4488 | |11;stanford-crypto-ccm;152;149;141;141;151;142;147;141;184;142 19:48:04 INFO - PROCESS | 4488 | |12;stanford-crypto-pbkdf2;180;180;188;179;182;175;175;173;174;172 19:48:04 INFO - PROCESS | 4488 | |13;stanford-crypto-sha256-iterative;72;70;74;71;73;70;71;70;73;71 19:48:04 INFO - PROCESS | 4488 | __end_tp_report 19:48:04 INFO - PROCESS | 4488 | __start_cc_report 19:48:04 INFO - PROCESS | 4488 | _x_x_mozilla_cycle_collect,860 19:48:04 INFO - PROCESS | 4488 | __end_cc_report 19:48:04 INFO - PROCESS | 4488 | __startTimestamp1475981284221__endTimestamp 19:48:04 INFO - PROCESS | 4488 | 19:48:04 INFO - PROCESS | 4488 | ------- Summary: start ------- 19:48:04 INFO - PROCESS | 4488 | Number of tests: 14 19:48:04 INFO - PROCESS | 4488 | 19:48:04 INFO - PROCESS | 4488 | [#0] ai-astar Cycles:10 Average:116.10 Median:116.00 stddev:2.60 (2.2%) stddev-sans-first:2.65 19:48:04 INFO - PROCESS | 4488 | Values: 114.0 115.0 116.0 115.0 115.0 117.0 116.0 123.0 114.0 116.0 19:48:04 INFO - PROCESS | 4488 | 19:48:04 INFO - PROCESS | 4488 | [#1] audio-beat-detection Cycles:10 Average:142.20 Median:133.50 stddev:18.51 (13.9%) stddev-sans-first:18.61 19:48:04 INFO - PROCESS | 4488 | Values: 159.0 130.0 130.0 173.0 134.0 133.0 128.0 130.0 173.0 132.0 19:48:04 INFO - PROCESS | 4488 | 19:48:04 INFO - PROCESS | 4488 | [#2] audio-dft Cycles:10 Average:164.80 Median:164.00 stddev:2.57 (1.6%) stddev-sans-first:2.24 19:48:04 INFO - PROCESS | 4488 | Values: 169.0 170.0 162.0 164.0 164.0 164.0 164.0 163.0 164.0 164.0 19:48:04 INFO - PROCESS | 4488 | 19:48:04 INFO - PROCESS | 4488 | [#3] audio-fft Cycles:10 Average:81.80 Median:76.00 stddev:11.75 (15.5%) stddev-sans-first:12.21 19:48:04 INFO - PROCESS | 4488 | Values: 75.0 76.0 76.0 102.0 76.0 77.0 77.0 77.0 106.0 76.0 19:48:04 INFO - PROCESS | 4488 | 19:48:04 INFO - PROCESS | 4488 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:83.00 stddev:13.60 (16.4%) stddev-sans-first:14.20 19:48:04 INFO - PROCESS | 4488 | Values: 85.0 83.0 116.0 83.0 85.0 82.0 102.0 83.0 84.0 114.0 19:48:04 INFO - PROCESS | 4488 | 19:48:04 INFO - PROCESS | 4488 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.99 (0.8%) stddev-sans-first:1.00 19:48:04 INFO - PROCESS | 4488 | Values: 117.0 118.0 117.0 118.0 117.0 117.0 120.0 118.0 119.0 118.0 19:48:04 INFO - PROCESS | 4488 | 19:48:04 INFO - PROCESS | 4488 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 19:48:04 INFO - PROCESS | 4488 | Values: 148.0 148.0 148.0 148.0 149.0 149.0 148.0 150.0 147.0 147.0 19:48:04 INFO - PROCESS | 4488 | 19:48:04 INFO - PROCESS | 4488 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.92 (1.0%) stddev-sans-first:0.93 19:48:04 INFO - PROCESS | 4488 | Values: 97.0 97.0 96.0 96.0 95.0 96.0 95.0 98.0 96.0 96.0 19:48:04 INFO - PROCESS | 4488 | 19:48:04 INFO - PROCESS | 4488 | [#8] json-parse-financial Cycles:10 Average:66.00 Median:66.00 stddev:1.25 (1.9%) stddev-sans-first:1.09 19:48:04 INFO - PROCESS | 4488 | Values: 64.0 66.0 66.0 65.0 66.0 65.0 68.0 66.0 66.0 68.0 19:48:04 INFO - PROCESS | 4488 | 19:48:04 INFO - PROCESS | 4488 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:1.20 (1.8%) stddev-sans-first:1.27 19:48:04 INFO - PROCESS | 4488 | Values: 67.0 70.0 66.0 67.0 66.0 67.0 67.0 66.0 67.0 68.0 19:48:04 INFO - PROCESS | 4488 | 19:48:04 INFO - PROCESS | 4488 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:88.00 stddev:3.07 (3.5%) stddev-sans-first:3.26 19:48:04 INFO - PROCESS | 4488 | Values: 87.0 84.0 87.0 90.0 84.0 89.0 90.0 83.0 92.0 85.0 19:48:04 INFO - PROCESS | 4488 | 19:48:04 INFO - PROCESS | 4488 | [#11] stanford-crypto-ccm Cycles:10 Average:149.00 Median:148.00 stddev:13.05 (8.8%) stddev-sans-first:13.79 19:48:04 INFO - PROCESS | 4488 | Values: 152.0 149.0 141.0 141.0 151.0 142.0 147.0 141.0 184.0 142.0 19:48:04 INFO - PROCESS | 4488 | 19:48:04 INFO - PROCESS | 4488 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.80 Median:179.50 stddev:4.94 (2.8%) stddev-sans-first:5.17 19:48:04 INFO - PROCESS | 4488 | Values: 180.0 180.0 188.0 179.0 182.0 175.0 175.0 173.0 174.0 172.0 19:48:04 INFO - PROCESS | 4488 | 19:48:04 INFO - PROCESS | 4488 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:71.50 stddev:1.43 (2.0%) stddev-sans-first:1.51 19:48:04 INFO - PROCESS | 4488 | Values: 72.0 70.0 74.0 71.0 73.0 70.0 71.0 70.0 73.0 71.0 19:48:04 INFO - PROCESS | 4488 | -------- Summary: end -------- 19:48:04 INFO - PROCESS | 4488 | 19:48:04 INFO - PROCESS | 4488 | 19:48:04 INFO - PROCESS | 4488 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 19:48:04 INFO - PROCESS | 4488 | 19:48:04 INFO - PROCESS | 4488 | 19:48:04 INFO - PROCESS | 4488 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 19:48:04 INFO - PROCESS | 4488 | 19:48:04 INFO - PROCESS | 4488 | 19:48:04 INFO - PROCESS | 4488 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 19:48:04 INFO - PROCESS | 4488 | 19:48:04 INFO - PROCESS | 4488 | 19:48:04 INFO - PROCESS | 4488 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 19:48:04 INFO - PROCESS | 4488 | 19:48:04 INFO - PROCESS | 4488 | 19:48:04 INFO - PROCESS | 4488 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000A,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 19:48:04 INFO - PROCESS | 4488 | 19:48:05 INFO - TEST-INFO | 4488: exit 0 19:48:05 INFO - TEST-OK | kraken | took 65626ms 19:48:05 INFO - SUITE-END | took 1185s 19:48:05 INFO - Completed test suite (00:19:46) 19:48:05 INFO - javascript benchmark 19:48:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6229.657055376085, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2641.471705658868, 2649.456861343425, 2651.151631477928, 2656.588228824533, 2669.813113082084, 4623.8150473981, 4743.549362810536, 4761.4286285645685, 4782.6173906087515, 4827.58965487934, 4676.134915040711, 4778.187708089625, 4789.521047895218, 4811.975940120295, 4847.03059388122, 4410.536893626155, 4445.22208613493, 4470.575295346936, 4519.096180763844, 4576.588107070363, 4477.7984990675495, 4522.253828118373, 4532.8413505527315, 4559.498455169929, 4567.474740404863, 4364.388985542027, 4430.379746835446, 4441.444819397575, 4449.57729015743, 4456.17560751262, 4460.375547423363, 4468.597826195658, 4475.485319188302, 4513.052259025609, 4516.322551617251, 4404.339349097661, 4419.11617676466, 4428.180786554498, 4454.821807127711, 4491.595756381941, 4664.277037059227, 4713.198756211452, 4727.692699974491, 4739.73931433771, 4763.666543341968, 4959.082569724613, 5014.122528557488, 5020.472850350734, 5072.391313042459, 5116.820911268088, 5096.898062038776, 5105.438401775838, 5107.412647545542, 5112.974435127838, 5175.249588809639, 4699.201135806853, 4751.786169622375, 4758.5241475852135, 4801.95198048015, 4824.517548245148, 5249.2126181073145, 5258.2112683097075, 5259.737013149327, 5266.420693723688, 5269.840635060281, 5036.169032109734, 5044.848654540369, 5046.192609182586, 5049.57078648319, 5068.670536415121, 4962.206047032458, 5033.245013247969, 5068.4424713281505, 5087.847364579068, 5202.24567437727, 5054.16606259963, 5059.645824792229, 5072.873178170502, 5079.238114282887, 5135.075686376414, 5025.874353141127, 5028.748562571856, 5031.924521132186, 5033.79864805411, 5056.898862022813, 4173.353130264813, 4201.495820501559, 4217.7891105444605, 4261.31818908973, 4287.935680964725, 3747.2130852521277, 3752.099496120911, 3781.9243615127543, 3803.391457366808, 3808.6953043756434, 4342.717723347972, 4426.778661066934, 4431.047324825114, 4442.511323754385, 4488.4165058542185, 5021.297018417425, 5094.1849304111165, 5095.159298715745, 5146.176611742103, 5171.0, 4426.092651006536, 4448.199324121624, 4461.130079634505, 4489.191945449785, 4492.303692927601, 4585.72485650862, 4600.470945841204, 4612.976935115303, 4638.582527572535, 4680.087382960358, 4571.062932098978, 4624.0, 4794.808207671654, 4802.087603355351, 4811.27830825379, 4945.381827271591, 4947.554720075211, 4967.9006419870675, 4968.627352948471, 4968.8757781055765, 4668.696534725232, 4677.415323084614, 4697.741624210565, 4746.2168742157155, 4753.382060332273, 4892.0705066037335, 4961.925571116509, 4974.626902982219, 5085.847424577269, 5087.364079490064, 5098.923516147335, 5140.537351638371, 5177.301064356264, 5180.352455943007, 5185.248139019896, 4941.728204948762, 5021.84934451967, 5028.296038554532, 5042.420121686053, 5074.873128171826, 4784.856454306377, 4878.0975519529, 4892.951070489249, 4918.901621967612, 4949.901001980013, 4860.586850117779, 4865.58642515376, 4920.409550853778, 4927.704337739747, 4965.47862474435, 5017.949820501748, 5021.698698078127, 5021.974890125526, 5029.27075574047, 5030.320906677552, 4704.29435584665, 4763.428388593391, 4862.562369386772, 4920.040592084509, 4954.083494553519], "value": 4682.874851451619, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [518.8910328830946, 540.1870185371016, 542.4927692607415, 543.8422857371362, 551.4320250142355, 36297.63702362976, 38083.0, 38272.42591361128, 41846.79076604613, 41929.16141677172, 39287.80356098215, 39430.211395772065, 39735.40396894049, 39748.60251397485, 39907.21577331853, 7586.848263034736, 7752.961235193844, 7764.650590723403, 7796.220377962215, 7802.21977802218, 7628.199039100898, 7651.349635281008, 7696.345810606105, 7721.22787721229, 7741.496802707834, 7747.728829490969, 7786.260305271018, 7791.688332466694, 7794.06471223454, 7811.140774514799, 7657.425693073042, 7722.034745656793, 7735.574543400111, 7764.262395072459, 7775.8444831103625, 7628.847423051508, 7692.000039994765, 7697.690692792196, 7702.614869256515, 7706.614669266514, 36910.0, 37203.255934881425, 37252.62747372519, 37289.25421491555, 37348.0, 3047.54286856971, 3147.5436061771143, 3187.378461200067, 3295.917602059944, 3364.5626068610923, 28217.153485395473, 28264.29339266535, 28549.57175642367, 28616.713832861613, 28728.569071463735, 3240.983795081033, 3296.2089098616398, 3309.470484722457, 3415.112070861594, 3454.3436747017986, 238295.0, 240481.0, 240513.0, 242230.0, 242272.99999999822, 48052.75973620179, 48655.51344486581, 48866.755666222154, 48947.265791012454, 49082.75458622684, 50396.49603503918, 50961.0, 51002.23496647553, 51010.48989510132, 51023.48976510262, 14392.784108238386, 14543.636409089646, 14610.26948652563, 14650.780238296435, 14667.559973200821, 11090.778184436265, 11152.832707509393, 11170.050545703543, 11193.10455163585, 11194.328340299608, 13968.301584920713, 14444.0, 14469.638259043608, 14603.488877889224, 14728.189949552663, 5767.538596912237, 5774.595778295479, 5879.355309305601, 5993.910091348634, 6137.60105593135, 779.2558107007794, 881.0, 892.723255790707, 924.2051835421532, 1012.1447376966598, 27092.86453567759, 27247.076589868193, 27529.174124776287, 27531.31171720723, 27666.308342291602, 945.3618807305179, 963.8650588917557, 971.2472833554052, 1012.9493525323852, 1068.503146037081, 14515.92742036283, 14556.199409032393, 14568.344424500923, 14627.78058329126, 14645.048071875293, 333605.65577376634, 335528.0, 336503.317483411, 336629.0, 337740.0, 46590.5340946593, 46597.06805863864, 46802.0, 46822.76588617035, 46880.5311946883, 1156.0924674130767, 1178.988210117905, 1182.917195796286, 1184.7926612842891, 1187.0681515010674, 25018.249452516455, 26304.21087367382, 26896.32759181036, 27135.86432067827, 27196.72803272021, 39742.60257397505, 40088.59911400965, 40179.0, 40220.0, 40236.0, 251060.0, 251804.0, 252981.0, 253148.0, 253560.0, 34065.82967085149, 34342.65657343494, 34478.0, 34693.30613387668, 34781.65218347885, 39922.600773991886, 40094.0, 40333.39499907445, 40410.39384409178, 40414.79792601018, 34687.82656086703, 34944.65055349516, 35097.29805403929, 35225.471617925235, 35385.46921796124, 34429.483557746156, 34477.48283775695, 34592.65407345995, 34913.65086349104, 35198.0, 28853.278668032628, 33673.326533469684, 34508.0, 34672.82663586666, 34756.13109672177, 29735.0, 32852.507212391356, 33025.66974330226, 33169.50245746364, 33211.667883321825, 23630.763692362856, 24165.395865103514, 24658.630120548565, 26049.218523444328, 26606.60090098611], "value": 16945.80438227739, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.20381530111325, 357.28364628919013, 357.7245520948869, 368.98339574719137, 376.955832344406, 15311.0, 15569.0, 16708.58228544287, 16861.325546978136, 16868.662626747457, 15370.154641494713, 15841.287142078605, 16269.430569930026, 16313.673726525461, 16513.17434128295, 4445.488768791582, 4996.650234483587, 5021.799128034874, 5055.266986286986, 5081.339425874631, 4887.853364399074, 4948.752562371885, 5044.924326135111, 5045.899082018357, 5050.065737838511, 5009.02324046811, 5020.0, 5281.947180528203, 5306.151015837467, 5307.920381194285, 5326.387465441485, 5348.0, 5379.085555455582, 5386.569074474052, 5391.78432862685, 4997.150484417658, 5121.436641969381, 5159.664621799571, 5171.120909445403, 5181.119209734316, 12011.819822702666, 12228.571999980048, 12283.324417157053, 18042.819571804375, 20122.496937576532, 1776.9822301776946, 1878.286251224526, 1894.384325094336, 1937.9515512112168, 1951.834094102003, 8706.956465217634, 9143.45139291638, 9471.857922131174, 9641.228701703847, 9680.225581953428, 1676.362982066819, 1710.5552556335317, 1744.6859565278244, 1755.5084576318523, 1763.9911800440916, 69125.65437172832, 70335.0, 70666.64666676633, 71169.64415177943, 71768.0, 8228.547429891294, 8731.476111433334, 8795.824083518422, 8927.598258078402, 9022.684206052756, 11631.88368116308, 11660.358680272666, 11682.70793230176, 11699.941500292443, 11712.941435292769, 6467.935320646828, 6783.62690052042, 6790.558613690095, 6982.162140543167, 6984.720611175598, 6455.580387274812, 6748.460123190133, 6763.051654532237, 6904.171499420102, 6925.6190909499455, 3649.1789347397153, 3671.284099600552, 3732.701383889282, 3766.227923275722, 3787.299349620329, 1764.7441121037377, 1808.828161324672, 1874.2221977879028, 1877.5939789900124, 1937.1476550317816, 787.8463699578642, 813.1665043330634, 832.8500869843486, 838.7819167016497, 863.1670438027334, 16109.516714498584, 16172.75740863888, 16231.67536649284, 16745.079020653982, 16880.662386752443, 824.505296821914, 848.6902280667636, 863.4603372891943, 888.6978427334737, 947.725159703692, 8171.0, 9438.716838494856, 9444.0, 9607.471589062528, 9724.659063721094, 331114.0, 346772.0, 349195.7942313146, 351940.0, 352107.0, 80570.0, 80875.0, 80914.0, 81495.59252203701, 84545.57727211325, 894.2220268366563, 912.0833562270009, 929.702495201529, 932.0818993291603, 942.5193151492788, 15406.383744650537, 15573.532794016197, 15885.920570397075, 16056.277467513757, 16319.67360652804, 36582.81708591546, 36901.0, 38215.61784382121, 38238.0, 38842.6115738839, 47348.289775654084, 47885.76057119831, 49608.255876162606, 52291.47708522866, 52690.73654631702, 7008.159020917523, 7168.641567921687, 7280.927190728236, 7381.077365329334, 7383.741569045058, 9550.904490955001, 10291.382517049002, 10543.894561054598, 10680.0, 10843.891561084289, 5103.821366252163, 8924.643014279616, 9312.906870931203, 9350.625974960925, 9447.527623618655, 9051.940375607759, 9190.40262382943, 9278.164965153168, 9341.859872102059, 9488.240940724863, 9084.772880677772, 9146.817063658822, 9184.724458266262, 9239.168474837297, 9761.85357219628, 6671.499637527302, 6957.512974091967, 6980.965095174694, 7205.963970180115, 7340.669669864762, 8700.564971751513, 10350.0, 10516.15870730355, 10682.252242342962, 10726.463676816284], "value": 7775.7950758718125, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1324.1856258401083, 1358.5245164192531, 1403.8245219347582, 1626.4795265515033, 1627.5280168751062, 6833.931660683392, 7095.7161713531395, 7213.855722885539, 7839.568823714701, 7851.097123830761, 7410.666520006599, 7720.7297744578955, 7757.806054848632, 7924.603769811515, 7961.761147165595, 2080.843936704746, 2106.2628080171894, 2131.435169680036, 2131.957360852782, 2132.4562236629636, 2064.6180456615575, 2114.9154033838704, 2169.555241175563, 2169.6853956176346, 2173.652215645497, 2120.045979309309, 2128.138104067847, 2135.882526461044, 2144.603248399051, 2159.255057005331, 2074.1288658763356, 2077.0549400022956, 2084.8853313067775, 2089.0494824854654, 2092.4036649554805, 2037.7147199391948, 2090.9477263068393, 2093.842961777873, 2100.054975261123, 2115.7038014677955, 7812.218778122199, 7823.3350165236025, 7856.528608283521, 7913.327367173797, 7919.920800791976, 4275.273203555403, 4433.179861725591, 4433.312836510314, 4433.933490997638, 4435.955640443586, 2767.8892844286206, 2823.2377258140186, 2842.360468894503, 2901.4487247423135, 2923.444545536341, 902.7156445719577, 932.0539652252969, 934.8504239321676, 936.7073438654613, 944.6882528765491, 10590.523426445752, 10594.788104237949, 10622.57509699611, 10625.84061239082, 10646.78706425875, 3757.887263382103, 3849.4418309344987, 3992.48097747291, 4006.45912801768, 4089.5092588889524, 8954.641814327484, 8958.641654333753, 8974.551272436353, 8999.505027223435, 9012.053734357929, 4467.441569803775, 4483.461984561874, 4489.034857505587, 4492.932606010912, 4510.977445112819, 3436.1409647588102, 3518.9296214075575, 3905.062784931653, 4104.897377565585, 4107.322291821875, 3441.1397150712323, 3462.4286992646435, 3589.964100358963, 3621.8732344367822, 3690.132818787583, 1139.3733446604335, 1141.406468636321, 1149.804533229353, 1159.7269352070036, 1173.9354335511457, 673.3872176319526, 687.7867860963117, 742.3430264216099, 813.5484805932646, 817.6606708216143, 4748.19280722278, 4869.756512174377, 4880.511948805162, 4993.550580447777, 5007.273945277914, 375.64313901793406, 392.46232661254265, 394.134873951679, 394.4832269726667, 401.65457706372496, 3317.93364132716, 3362.4620060790157, 3427.503012063237, 3432.708219801345, 3480.599731030964, 8947.507887066144, 9085.13691199335, 9210.81578368429, 9215.0, 9227.907720922705, 9178.403403778733, 9196.724098277062, 9220.400673956305, 9264.72205833826, 9322.394044387092, 6987.056747339044, 7033.542819716702, 7047.40097091753, 7114.324139206767, 7134.678939447737, 4693.953060469352, 4747.0, 4750.192467280502, 4859.878503037452, 5013.273075403973, 8305.127961563949, 8397.748067557983, 8449.535275559903, 8452.535110568731, 8511.531865747444, 8564.357673174412, 8585.527795971282, 8590.785230369042, 8630.82738345217, 8710.91289087101, 5741.282339707536, 5992.790252341147, 6468.708908099241, 6485.540753330463, 6505.837354065997, 7305.3425191732995, 7519.812004699927, 7562.659680314289, 7576.772696819105, 7579.052618422697, 6555.868882622416, 6578.638174900427, 6582.736690532325, 6841.897371539331, 6842.0, 6220.844478888064, 6305.464035557029, 6368.554201205871, 6378.2346118466085, 6394.360563943755, 5927.051671732502, 6063.605865618721, 6065.4541091302, 6067.787627433018, 6073.514118870391, 4309.59058889405, 4345.456817897762, 4349.260625693576, 4422.137683151755, 4498.347739577677, 4201.327787554099, 4261.850835220753, 4360.040791025969, 4415.735055896656, 4462.509123996423], "value": 3905.1182766364973, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [271.57227366897143, 276.2830454969355, 280.2223828874872, 282.38299315994544, 286.1872282717083, 5071.594272458195, 5077.974610126954, 5083.669561478506, 5088.211327244278, 5147.253648221011, 4963.0, 4964.4787297333805, 4964.851054468363, 4976.755811047238, 5003.374578177728, 3939.192465544571, 3945.191235796662, 3967.801609919507, 3980.800959952005, 3982.9800850995703, 3982.17265741324, 3987.8036589023177, 3988.6809055275653, 3992.7205095643317, 4003.639672429481, 3583.516225309589, 3818.4081467372603, 3843.634854688814, 3852.4799152114524, 3865.8982190075835, 3794.392897136445, 3819.0070581648692, 3828.8277027533827, 3832.9808350958347, 3835.137094153821, 3063.1729433053174, 3134.8902788402297, 3317.319949410365, 3319.6514365991466, 3324.1523411529906, 4763.094762095155, 4885.487023862479, 4889.3643826302705, 4894.559489645913, 4899.55903968641, 4354.521002689701, 4364.516064538072, 4384.9561504384865, 4390.846320378771, 4396.78016099197, 5044.385796545107, 5212.55693266069, 5255.894882102375, 5271.314729085195, 5327.0, 3495.580530336376, 3501.2647344057777, 3504.6320136385566, 3504.9649503504893, 3505.94741078884, 5414.187871819219, 5441.959265275522, 5455.945440545584, 5482.451754824526, 5484.725763711798, 3677.5841301099267, 3685.1758379601733, 3699.5190625218547, 3702.9814850925573, 3706.99911024022, 3652.4886515887797, 3703.851845926187, 3704.870329538507, 3715.8327875245136, 3721.9069523262133, 4259.403683484315, 4261.2542805009, 4264.978675106605, 4268.935965960513, 4274.508431530352, 5210.557102646318, 5235.439900867371, 5237.240600112962, 5237.895242095136, 5315.202719592015, 1230.1757822258928, 1280.929548874802, 1286.3182513267982, 1288.7035981724257, 1294.7086905446388, 760.8820632801925, 799.5762246009624, 809.8176662073321, 812.634314558451, 820.8973878265217, 4131.607497287753, 4152.2525945330135, 4176.160211056511, 4176.705221381381, 4209.726367786084, 4685.765711714401, 4760.571548560646, 4767.284907263938, 4792.4249090108715, 4797.280407938767, 4132.5329508024815, 4141.855035073818, 4152.8338866445, 4180.372944058355, 4205.317872850823, 2355.3993731598334, 2508.623706444048, 2517.804043079559, 2530.836135104459, 2542.8601426921696, 4476.574725401082, 4833.32333473314, 4861.246506791453, 4982.177940639754, 5062.139436295765, 5509.614326997072, 5534.833954981357, 5549.417311182348, 5554.583406244467, 5605.8598535036135, 5095.796168153232, 5101.617378696613, 5102.877366979259, 5116.283720279164, 5117.513836185556, 5071.9602481490465, 5392.110301800159, 5401.29859094384, 5437.972810136082, 5442.591805614516, 5346.385165705994, 5346.492083252085, 5366.865828354323, 5371.731413429391, 5389.353277606712, 4892.092084087138, 5078.669886457368, 5105.387353517602, 5117.002184573972, 5123.641345105807, 3710.925781484409, 3720.9627903720616, 3742.326381251401, 3762.2129488493842, 3770.792606406564, 5473.28847249855, 5506.201600767786, 5534.833954981357, 5571.832845014656, 5595.832125036255, 5100.214924776298, 5286.784039670821, 5370.919436208382, 5405.459454054563, 5415.404305526467, 5250.97374513125, 5251.658642188246, 5294.8941021180135, 5302.549283310807, 5305.814296499604, 5223.634345595772, 5228.45101264377, 5242.135047717084, 5243.423223445494, 5279.2081187820595, 5156.9742151289, 5317.6011799115995, 5338.692020454858, 5344.305240318889, 5349.0, 5184.040952423814, 5209.791608335624, 5216.243644671577, 5222.597605101696, 5261.73691315425], "value": 3851.704398570137, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [651.3876955661677, 710.360675392147, 733.2447578993635, 743.2047708951424, 746.2947514598704, 11512.942435287812, 11539.65381038568, 12345.382730863455, 12767.553135640255, 12872.09895307329, 13313.800292995613, 13800.30998450076, 13854.653633659138, 13911.026228164033, 13950.162990220593, 725.5211560370144, 756.9318761311481, 763.4350580570366, 763.5342441110918, 766.3409467857638, 757.0234397627055, 757.71964373182, 758.6548120605139, 761.0942977856333, 762.7521055656933, 791.6991543213571, 794.7417089445925, 798.2695833312512, 798.6406117247233, 798.6805277888861, 784.7292684024003, 785.4698078796789, 791.89309443225, 792.9286364227189, 793.2503783924194, 559.0719405786416, 572.916927045576, 580.8315588479336, 581.1399129288676, 581.7004242814953, 12797.232166070065, 12940.0, 12941.094123411365, 12990.415431305613, 13010.0, 11860.881391186063, 12469.376531173404, 12611.558595449207, 12864.807027894589, 13192.934035329761, 12087.093467989847, 12088.818667719992, 12098.939505302505, 12258.509659613605, 12291.139620226588, 4034.3545032794614, 4046.4739583854207, 4125.690573206992, 4240.173166232586, 4256.106217694288, 64443.999999999534, 64452.0, 65101.0, 65239.673801631165, 65359.0, 10042.949785251027, 10058.245631577662, 10129.290949633601, 10166.745831354126, 10238.999730788712, 17682.469525914243, 17993.370232041816, 18019.909900450675, 18065.367712130013, 18681.719774203397, 6088.512918966472, 6223.222097237845, 6225.470834978987, 6277.1525844011385, 6290.842728931813, 3529.258855640293, 3534.8939531814085, 3635.909102272464, 3674.1733110050027, 3724.515812944354, 2717.4836781011545, 2795.0, 2816.6760822505266, 2817.7323154300307, 2820.661520617539, 474.8884012257117, 477.83992362558234, 481.3718097882297, 482.5729229631731, 483.83791429870683, 458.7797857028578, 505.98229061982653, 533.9572834173257, 534.1453674121375, 537.3739593373676, 7406.7037318506655, 7777.455578109478, 7786.532808031537, 7827.647755850887, 7877.606119693993, 470.3438703009351, 488.5920256585791, 558.3076984539142, 563.2733773432309, 603.5865432178972, 3679.9080022999638, 3784.7480748954326, 3857.8842634721004, 3971.960280397159, 4014.4580481634607, 47600.72397292553, 47813.0, 90434.0, 93710.0, 94307.52846235862, 82535.0, 82803.0, 83435.16564834274, 83620.58189709134, 84996.0, 73773.0, 73906.26093738993, 74625.62687186638, 76542.0, 77257.61371193107, 6961.930380696128, 7289.599072051088, 7317.5609463432365, 7564.50830696003, 7619.580923049286, 43279.350809738506, 44927.550724492336, 45099.0, 46327.598878106524, 46861.53138468708, 58563.0, 58737.11894321503, 65689.34310657023, 65801.67099164473, 66599.0, 9134.5432728362, 9156.313276504156, 9370.156685898302, 9399.624015039322, 9721.270904682036, 9791.46146961924, 10184.592616295562, 10227.43749093807, 10358.430286334022, 10562.577496900038, 9212.631494740135, 9240.722778316662, 9380.108889655472, 9395.342326037111, 9708.2718796092, 9394.95302523483, 9514.096160864707, 9712.3201375903, 9888.950555247466, 9911.504424778876, 9121.863172052292, 9238.491882946502, 9389.624415023596, 11293.378864162221, 11820.172587918763, 10276.280660353703, 10397.16822654201, 10742.8388574173, 10815.459227038775, 10848.728781780203, 9690.079442452956, 9997.0, 10480.371177729361, 10530.631427899987, 10881.564737410416], "value": 6296.936156075856, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1577.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 116.0, 115.0, 115.0, 117.0, 116.0, 123.0, 114.0, 116.0], "value": 116.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 130.0, 130.0, 173.0, 134.0, 133.0, 128.0, 130.0, 173.0, 132.0], "value": 142.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 170.0, 162.0, 164.0, 164.0, 164.0, 164.0, 163.0, 164.0, 164.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 102.0, 76.0, 77.0, 77.0, 77.0, 106.0, 76.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 116.0, 83.0, 85.0, 82.0, 102.0, 83.0, 84.0, 114.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 120.0, 118.0, 119.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 149.0, 149.0, 148.0, 150.0, 147.0, 147.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 96.0, 96.0, 95.0, 96.0, 95.0, 98.0, 96.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 66.0, 65.0, 66.0, 65.0, 68.0, 66.0, 66.0, 68.0], "value": 66.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 66.0, 67.0, 66.0, 67.0, 67.0, 66.0, 67.0, 68.0], "value": 67.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 90.0, 84.0, 89.0, 90.0, 83.0, 92.0, 85.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 149.0, 141.0, 141.0, 151.0, 142.0, 147.0, 141.0, 184.0, 142.0], "value": 149.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 180.0, 188.0, 179.0, 182.0, 175.0, 175.0, 173.0, 174.0, 172.0], "value": 177.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 70.0, 74.0, 71.0, 73.0, 70.0, 71.0, 70.0, 73.0, 71.0], "value": 71.5, "unit": "score"}]}]} 19:48:05 INFO - Return code: 0 19:48:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:48:06 ERROR - # TBPL SUCCESS # 19:48:06 INFO - Running post-action listener: _resource_record_post_action 19:48:06 INFO - [mozharness: 2016-10-09 02:48:06.029231Z] Finished run-tests step (success) 19:48:06 INFO - Running post-run listener: _resource_record_post_run 19:48:06 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 8192; Write bytes: 407011328; Read time: 20; Write time: 325480 19:48:06 INFO - TinderboxPrint: CPU usage
13.4% 19:48:06 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 19:48:06 INFO - TinderboxPrint: I/O write bytes / time
407,011,328 / 325,480 19:48:06 INFO - TinderboxPrint: CPU idle
8,305.4 (86.6%) 19:48:06 INFO - TinderboxPrint: CPU user
1,225.3 (12.8%) 19:48:06 INFO - TinderboxPrint: Swap in / out
0 / 0 19:48:06 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 115560448; Read time: 0; Write time: 80700 19:48:06 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 291450880; Read time: 0; Write time: 244780 19:48:06 INFO - Running post-run listener: _upload_blobber_files 19:48:06 INFO - Blob upload gear active. 19:48:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:48:06 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 19:48:06 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'] 19:48:06 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 19:48:07 INFO - (blobuploader) - INFO - Open directory for files ... 19:48:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:48:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:48:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:48:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:48:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:48:07 INFO - (blobuploader) - INFO - Done attempting. 19:48:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:48:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:48:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:48:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:48:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:48:11 INFO - (blobuploader) - INFO - Done attempting. 19:48:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:48:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:48:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:48:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:48:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:48:11 INFO - (blobuploader) - INFO - Done attempting. 19:48:11 INFO - (blobuploader) - INFO - Iteration through files over. 19:48:11 INFO - Return code: 0 19:48:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:48:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:48:11 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e79878201dcaa3099ae5963ea61e70e27e447528da91c9227c727242f9bcdfa85f1f473961a1be007e6d4fadc816db14e767d9b75ee857ebb0958de4f8590fed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a10fff152389fa9e41e594970d54abf85a1db7025aae0cac421e3f3209a3b257c4e26fcadd4be581063b3c67ace13916c69fe7c21e47536c71ea452d7950490c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6c6e58483ef9de9a62f8d00a666934538d492ea5678f73c4aac4ea0f65e28ecc15fa1918441f4d06b8ddd8d30696c46ae1168375703b49758ece1d1d122e3c5a"} 19:48:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:48:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:48:11 INFO - Contents: 19:48:11 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e79878201dcaa3099ae5963ea61e70e27e447528da91c9227c727242f9bcdfa85f1f473961a1be007e6d4fadc816db14e767d9b75ee857ebb0958de4f8590fed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a10fff152389fa9e41e594970d54abf85a1db7025aae0cac421e3f3209a3b257c4e26fcadd4be581063b3c67ace13916c69fe7c21e47536c71ea452d7950490c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6c6e58483ef9de9a62f8d00a666934538d492ea5678f73c4aac4ea0f65e28ecc15fa1918441f4d06b8ddd8d30696c46ae1168375703b49758ece1d1d122e3c5a"} 19:48:11 INFO - Running post-run listener: copy_logs_to_upload_dir 19:48:11 INFO - Copying logs to upload dir... 19:48:11 INFO - mkdir: /builds/slave/test/build/upload/logs 19:48:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.819527 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-10-08 19:48:10.884317) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-08 19:48:10.888124) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1475978253.592126-269373017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e79878201dcaa3099ae5963ea61e70e27e447528da91c9227c727242f9bcdfa85f1f473961a1be007e6d4fadc816db14e767d9b75ee857ebb0958de4f8590fed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a10fff152389fa9e41e594970d54abf85a1db7025aae0cac421e3f3209a3b257c4e26fcadd4be581063b3c67ace13916c69fe7c21e47536c71ea452d7950490c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6c6e58483ef9de9a62f8d00a666934538d492ea5678f73c4aac4ea0f65e28ecc15fa1918441f4d06b8ddd8d30696c46ae1168375703b49758ece1d1d122e3c5a"} build_url:https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011362 build_url: 'https://queue.taskcluster.net/v1/task/YhIh3zTNSWa93QAi7Tcogw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e79878201dcaa3099ae5963ea61e70e27e447528da91c9227c727242f9bcdfa85f1f473961a1be007e6d4fadc816db14e767d9b75ee857ebb0958de4f8590fed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a10fff152389fa9e41e594970d54abf85a1db7025aae0cac421e3f3209a3b257c4e26fcadd4be581063b3c67ace13916c69fe7c21e47536c71ea452d7950490c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6c6e58483ef9de9a62f8d00a666934538d492ea5678f73c4aac4ea0f65e28ecc15fa1918441f4d06b8ddd8d30696c46ae1168375703b49758ece1d1d122e3c5a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-08 19:48:10.913293) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 19:48:10.913595) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1475978253.592126-269373017 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004373 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 19:48:10.997493) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-08 19:48:10.997814) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-08 19:48:10.998106) ========= ========= Total master_lag: 0.14 =========