builder: larch_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-029 starttime: 1479919495.24 results: success (0) buildid: 20161123072135 builduid: 8b9c08e06601419c9bb0cdd423fd33f4 revision: 48fcc7fe4e16d0c7e233d5d94b4732b99b91c136 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 08:44:55.241481) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 08:44:55.241944) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 08:44:55.242230) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 08:44:55.260342) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 08:44:55.260662) ========= 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=c7c495d6f76fb52e1ad9f659000001da-1479919407.869859-850053679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-23 08:44:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.0M=0s 2016-11-23 08:44:55 (50.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.108861 ========= master_lag: 0.25 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 08:44:55.615610) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 08:44:55.615976) ========= 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=c7c495d6f76fb52e1ad9f659000001da-1479919407.869859-850053679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016915 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 08:44:55.648151) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 08:44:55.651592) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 48fcc7fe4e16d0c7e233d5d94b4732b99b91c136 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 48fcc7fe4e16d0c7e233d5d94b4732b99b91c136 --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=c7c495d6f76fb52e1ad9f659000001da-1479919407.869859-850053679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-23 08:44:55,891 truncating revision to first 12 chars 2016-11-23 08:44:55,891 Setting DEBUG logging. 2016-11-23 08:44:55,891 attempt 1/10 2016-11-23 08:44:55,891 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/48fcc7fe4e16?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-23 08:44:56,205 unpacking tar archive at: larch-48fcc7fe4e16/testing/mozharness/ program finished with exit code 0 elapsedTime=0.634149 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 08:44:56.299128) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 08:44:56.299473) ========= script_repo_revision: 48fcc7fe4e16d0c7e233d5d94b4732b99b91c136 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 08:44:56.299867) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 08:44:56.300158) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 08:44:56.309225) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-11-23 08:44:56.309549) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Larch-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch-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=c7c495d6f76fb52e1ad9f659000001da-1479919407.869859-850053679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:44:56 INFO - MultiFileLogger online at 20161123 08:44:56 in /builds/slave/test 08:44:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO 08:44:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:44:56 INFO - {'append_to_log': False, 08:44:56 INFO - 'base_work_dir': '/builds/slave/test', 08:44:56 INFO - 'blob_upload_branch': 'Larch-Non-PGO', 08:44:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:44:56 INFO - 'branch': 'Larch-Non-PGO', 08:44:56 INFO - 'buildbot_json_path': 'buildprops.json', 08:44:56 INFO - 'config_files': ('talos/linux_config.py',), 08:44:56 INFO - 'default_actions': ('clobber', 08:44:56 INFO - 'read-buildbot-config', 08:44:56 INFO - 'download-and-extract', 08:44:56 INFO - 'populate-webroot', 08:44:56 INFO - 'create-virtualenv', 08:44:56 INFO - 'install', 08:44:56 INFO - 'run-tests'), 08:44:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:44:56 INFO - 'download_minidump_stackwalk': True, 08:44:56 INFO - 'download_symbols': 'ondemand', 08:44:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:44:56 INFO - 'tooltool.py': '/tools/tooltool.py', 08:44:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:44:56 INFO - '/tools/misc-python/virtualenv.py')}, 08:44:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:44:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:44:56 INFO - 'installer_path': 'installer.exe', 08:44:56 INFO - 'log_level': 'info', 08:44:56 INFO - 'log_name': 'talos', 08:44:56 INFO - 'log_to_console': True, 08:44:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:44:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:44:56 INFO - 'opt_config_files': (), 08:44:56 INFO - 'pip_index': False, 08:44:56 INFO - 'sps_profile': False, 08:44:56 INFO - 'sps_profile_interval': 0, 08:44:56 INFO - 'suite': 'dromaeojs', 08:44:56 INFO - 'system_bits': '32', 08:44:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:44:56 INFO - 'title': 'talos-linux64-ix-029', 08:44:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:44:56 INFO - 'use_talos_json': True, 08:44:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:44:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:44:56 INFO - 'work_dir': 'build'} 08:44:56 INFO - [mozharness: 2016-11-23 16:44:56.651130Z] Running clobber step. 08:44:56 INFO - Running pre-action listener: _resource_record_pre_action 08:44:56 INFO - Running main action method: clobber 08:44:56 INFO - rmtree: /builds/slave/test/build 08:44:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:44:57 INFO - Running post-action listener: _resource_record_post_action 08:44:57 INFO - [mozharness: 2016-11-23 16:44:57.110219Z] Finished clobber step (success) 08:44:57 INFO - [mozharness: 2016-11-23 16:44:57.110317Z] Running read-buildbot-config step. 08:44:57 INFO - Running pre-action listener: _resource_record_pre_action 08:44:57 INFO - Running main action method: read_buildbot_config 08:44:57 INFO - Using buildbot properties: 08:44:57 INFO - { 08:44:57 INFO - "project": "", 08:44:57 INFO - "product": "firefox", 08:44:57 INFO - "script_repo_revision": "production", 08:44:57 INFO - "builddir": "larch_ubuntu64_hw_test-dromaeojs", 08:44:57 INFO - "repository": "", 08:44:57 INFO - "buildername": "Ubuntu HW 12.04 x64 larch talos dromaeojs", 08:44:57 INFO - "buildid": "20161123072135", 08:44:57 INFO - "pgo_build": "False", 08:44:57 INFO - "basedir": "/builds/slave/test", 08:44:57 INFO - "buildnumber": 5, 08:44:57 INFO - "slavename": "talos-linux64-ix-029", 08:44:57 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:44:57 INFO - "platform": "ubuntu64_hw", 08:44:57 INFO - "scheduler": "tests-larch-linux64-talos", 08:44:57 INFO - "branch": "larch", 08:44:57 INFO - "repo_path": "projects/larch", 08:44:57 INFO - "revision": "48fcc7fe4e16d0c7e233d5d94b4732b99b91c136", 08:44:57 INFO - "stage_platform": "linux64", 08:44:57 INFO - "builduid": "8b9c08e06601419c9bb0cdd423fd33f4", 08:44:57 INFO - "slavebuilddir": "test" 08:44:57 INFO - } 08:44:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/VAZjIBL9Qwq4oTKWZdt7mg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 08:44:57 INFO - Running post-action listener: _resource_record_post_action 08:44:57 INFO - [mozharness: 2016-11-23 16:44:57.113322Z] Finished read-buildbot-config step (success) 08:44:57 INFO - [mozharness: 2016-11-23 16:44:57.113410Z] Running download-and-extract step. 08:44:57 INFO - Running pre-action listener: _resource_record_pre_action 08:44:57 INFO - Running main action method: download_and_extract 08:44:57 INFO - mkdir: /builds/slave/test/build/tests 08:44:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:44:57 INFO - trying https://queue.taskcluster.net/v1/task/VAZjIBL9Qwq4oTKWZdt7mg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 08:44:57 INFO - Downloading https://queue.taskcluster.net/v1/task/VAZjIBL9Qwq4oTKWZdt7mg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 08:44:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VAZjIBL9Qwq4oTKWZdt7mg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:44:57 INFO - Downloaded 1361 bytes. 08:44:57 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 08:44:57 INFO - Using the following test package requirements: 08:44:57 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 08:44:57 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:57 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:44:57 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:57 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:44:57 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:57 INFO - u'jsshell-linux-x86_64.zip'], 08:44:57 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:57 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:44:57 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 08:44:57 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:57 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:44:57 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:57 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:44:57 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:57 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:44:57 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:57 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:44:57 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:44:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VAZjIBL9Qwq4oTKWZdt7mg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 08:44:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VAZjIBL9Qwq4oTKWZdt7mg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:44:57 INFO - Fetch https://queue.taskcluster.net/v1/task/VAZjIBL9Qwq4oTKWZdt7mg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:44:58 INFO - Http code: 200 08:44:58 INFO - via: 1.1 a75342fa94ff4a9431476624fe74f02e.cloudfront.net (CloudFront) 08:44:58 INFO - x-amz-cf-id: nWZ-BNqst4vB-ApUYWN815NFZWk8EnXHr-idHhHggRrWiK0J9Jb4EA== 08:44:58 INFO - x-amz-version-id: FjPa4oIfd5WoHZICk8dxp4sooBaa3FuX 08:44:58 INFO - Expected file size: 20353974 08:44:58 INFO - Obtained file size: 20353974 08:45:02 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:45:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VAZjIBL9Qwq4oTKWZdt7mg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 08:45:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VAZjIBL9Qwq4oTKWZdt7mg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:45:02 INFO - Fetch https://queue.taskcluster.net/v1/task/VAZjIBL9Qwq4oTKWZdt7mg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:45:02 INFO - Http code: 200 08:45:02 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 08:45:02 INFO - x-amz-cf-id: W1EOcAnAYvyjudRH61gMVKqBEj9mU7znFZtvTWfliXA_C9DXLBlHDg== 08:45:02 INFO - x-amz-version-id: FjPa4oIfd5WoHZICk8dxp4sooBaa3FuX 08:45:03 INFO - Expected file size: 20353974 08:45:03 INFO - Obtained file size: 20353974 08:45:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VAZjIBL9Qwq4oTKWZdt7mg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 08:45:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VAZjIBL9Qwq4oTKWZdt7mg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:45:07 INFO - Fetch https://queue.taskcluster.net/v1/task/VAZjIBL9Qwq4oTKWZdt7mg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 08:45:08 INFO - Http code: 200 08:45:08 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 08:45:08 INFO - x-amz-cf-id: 35m3K4fJPHb5kzkKLSWJLMn8Y5p6D2XU3C4hul2nmGfjwsaMbyA9Lg== 08:45:08 INFO - x-amz-version-id: 4qgw_TrarUlqszYAuDG4a9ntpzgZxLmM 08:45:08 INFO - Expected file size: 14409366 08:45:08 INFO - Obtained file size: 14409366 08:45:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:08 INFO - trying https://queue.taskcluster.net/v1/task/VAZjIBL9Qwq4oTKWZdt7mg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:45:08 INFO - Downloading https://queue.taskcluster.net/v1/task/VAZjIBL9Qwq4oTKWZdt7mg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:45:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VAZjIBL9Qwq4oTKWZdt7mg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:45:09 INFO - Downloaded 55745038 bytes. 08:45:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VAZjIBL9Qwq4oTKWZdt7mg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:45:09 INFO - mkdir: /builds/slave/test/properties 08:45:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:45:09 INFO - Writing to file /builds/slave/test/properties/build_url 08:45:09 INFO - Contents: 08:45:09 INFO - build_url:https://queue.taskcluster.net/v1/task/VAZjIBL9Qwq4oTKWZdt7mg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:45:10 INFO - Running post-action listener: _resource_record_post_action 08:45:10 INFO - Running post-action listener: set_extra_try_arguments 08:45:10 INFO - [mozharness: 2016-11-23 16:45:10.436183Z] Finished download-and-extract step (success) 08:45:10 INFO - [mozharness: 2016-11-23 16:45:10.436489Z] Running populate-webroot step. 08:45:10 INFO - Running pre-action listener: _resource_record_pre_action 08:45:10 INFO - Running main action method: populate_webroot 08:45:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:45:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:45:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:45:10 INFO - '--tppagecycles', 08:45:10 INFO - '7'], 08:45:10 INFO - 'tests': ['tsvgm']}}, 08:45:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:45:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:45:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:45:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:45:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:45:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:45:10 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:45:10 INFO - 'talos_options': ['--disable-e10s'], 08:45:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:45:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:45:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:45:10 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:45:10 INFO - 'talos_options': ['--disable-e10s'], 08:45:10 INFO - 'tests': ['damp', 'tps']}, 08:45:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:45:10 INFO - 'tests': ['damp', 'tps']}, 08:45:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:45:10 INFO - 'tests': ['dromaeo_dom']}, 08:45:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:45:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:45:10 INFO - 'tests': ['basic_compositor_video']}, 08:45:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:45:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:45:10 INFO - 'tests': ['a11yr', 08:45:10 INFO - 'ts_paint', 08:45:10 INFO - 'tpaint', 08:45:10 INFO - 'sessionrestore', 08:45:10 INFO - 'sessionrestore_no_auto_restore', 08:45:10 INFO - 'tabpaint']}, 08:45:10 INFO - 'other-e10s': {'tests': ['a11yr', 08:45:10 INFO - 'ts_paint', 08:45:10 INFO - 'tpaint', 08:45:10 INFO - 'sessionrestore', 08:45:10 INFO - 'sessionrestore_no_auto_restore', 08:45:10 INFO - 'tabpaint']}, 08:45:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:45:10 INFO - 'ts_paint', 08:45:10 INFO - 'tpaint', 08:45:10 INFO - 'sessionrestore', 08:45:10 INFO - 'sessionrestore_no_auto_restore', 08:45:10 INFO - 'tabpaint']}, 08:45:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:45:10 INFO - 'ts_paint', 08:45:10 INFO - 'tpaint', 08:45:10 INFO - 'sessionrestore', 08:45:10 INFO - 'sessionrestore_no_auto_restore', 08:45:10 INFO - 'tabpaint']}, 08:45:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:45:10 INFO - 'tests': ['a11yr', 08:45:10 INFO - 'ts_paint', 08:45:10 INFO - 'tpaint', 08:45:10 INFO - 'sessionrestore', 08:45:10 INFO - 'sessionrestore_no_auto_restore', 08:45:10 INFO - 'tabpaint']}, 08:45:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:45:10 INFO - 'tests': ['a11yr', 08:45:10 INFO - 'ts_paint', 08:45:10 INFO - 'tpaint', 08:45:10 INFO - 'sessionrestore', 08:45:10 INFO - 'sessionrestore_no_auto_restore', 08:45:10 INFO - 'tabpaint']}, 08:45:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:45:10 INFO - 'tests': ['tsvgx', 08:45:10 INFO - 'tsvgr_opacity', 08:45:10 INFO - 'tart', 08:45:10 INFO - 'tscrollx', 08:45:10 INFO - 'cart']}, 08:45:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:45:10 INFO - 'tsvgr_opacity', 08:45:10 INFO - 'tart', 08:45:10 INFO - 'tscrollx', 08:45:10 INFO - 'cart']}, 08:45:10 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:45:10 INFO - 'talos_options': ['--disable-e10s'], 08:45:10 INFO - 'tests': ['tp5o']}, 08:45:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:45:10 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:45:10 INFO - 'talos_options': ['--disable-e10s', 08:45:10 INFO - '--xperf_path', 08:45:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:45:10 INFO - 'tests': ['tp5n']}, 08:45:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:45:10 INFO - 'talos_options': ['--xperf_path', 08:45:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:45:10 INFO - 'tests': ['tp5n']}}, 08:45:10 INFO - 'talos.zip': {'path': '', 08:45:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:45:10 INFO - Running post-action listener: _resource_record_post_action 08:45:10 INFO - [mozharness: 2016-11-23 16:45:10.458153Z] Finished populate-webroot step (success) 08:45:10 INFO - [mozharness: 2016-11-23 16:45:10.458245Z] Running create-virtualenv step. 08:45:10 INFO - Running pre-action listener: _resource_record_pre_action 08:45:10 INFO - Running main action method: create_virtualenv 08:45:10 INFO - Creating virtualenv /builds/slave/test/build/venv 08:45:10 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:45:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:45:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:45:10 INFO - Using real prefix '/usr' 08:45:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:45:11 INFO - Installing distribute.............................................................................................................................................................................................done. 08:45:13 INFO - Installing pip.................done. 08:45:13 INFO - Return code: 0 08:45:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:45:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:45:13 INFO - Reading from file tmpfile_stdout 08:45:13 INFO - Output received: 08:45:13 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:45:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f47fd43de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1175b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1311130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139ffc0>, '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 0x13a0ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a1350>, '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': 'c7c495d6f76fb52e1ad9f659000001da-1479919407.869859-850053679', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:45:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:45:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:45:13 INFO - Using env: {'DISPLAY': ':0', 08:45:13 INFO - 'HOME': '/home/cltbld', 08:45:13 INFO - 'LANG': 'en_US.UTF-8', 08:45:13 INFO - 'LANGUAGE': 'en_US:en', 08:45:13 INFO - 'LOGNAME': 'cltbld', 08:45:13 INFO - 'MAIL': '/var/mail/cltbld', 08:45:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:13 INFO - 'MOZ_NO_REMOTE': '1', 08:45:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:13 INFO - 'NO_EM_RESTART': '1', 08:45:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:13 INFO - 'PWD': '/builds/slave/test', 08:45:13 INFO - 'SHELL': '/bin/bash', 08:45:13 INFO - 'SHLVL': '1', 08:45:13 INFO - 'TERM': 'linux', 08:45:13 INFO - 'TMOUT': '86400', 08:45:13 INFO - 'USER': 'cltbld', 08:45:13 INFO - 'XDG_SESSION_COOKIE': 'c7c495d6f76fb52e1ad9f659000001da-1479919407.869859-850053679', 08:45:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:13 INFO - '_': '/tools/buildbot/bin/python'} 08:45:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:13 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:45:13 INFO - Cleaning up... 08:45:13 INFO - Return code: 0 08:45:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f47fd43de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1175b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1311130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139ffc0>, '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 0x13a0ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a1350>, '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': 'c7c495d6f76fb52e1ad9f659000001da-1479919407.869859-850053679', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:45:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:45:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:45:13 INFO - Using env: {'DISPLAY': ':0', 08:45:13 INFO - 'HOME': '/home/cltbld', 08:45:13 INFO - 'LANG': 'en_US.UTF-8', 08:45:13 INFO - 'LANGUAGE': 'en_US:en', 08:45:13 INFO - 'LOGNAME': 'cltbld', 08:45:13 INFO - 'MAIL': '/var/mail/cltbld', 08:45:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:13 INFO - 'MOZ_NO_REMOTE': '1', 08:45:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:13 INFO - 'NO_EM_RESTART': '1', 08:45:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:13 INFO - 'PWD': '/builds/slave/test', 08:45:13 INFO - 'SHELL': '/bin/bash', 08:45:13 INFO - 'SHLVL': '1', 08:45:13 INFO - 'TERM': 'linux', 08:45:13 INFO - 'TMOUT': '86400', 08:45:13 INFO - 'USER': 'cltbld', 08:45:13 INFO - 'XDG_SESSION_COOKIE': 'c7c495d6f76fb52e1ad9f659000001da-1479919407.869859-850053679', 08:45:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:13 INFO - '_': '/tools/buildbot/bin/python'} 08:45:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:13 INFO - Downloading/unpacking psutil>=3.1.1 08:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:45:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:45:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:45:15 INFO - Installing collected packages: psutil 08:45:15 INFO - Running setup.py install for psutil 08:45:15 INFO - building 'psutil._psutil_linux' extension 08:45:15 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:45:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:45:16 INFO - building 'psutil._psutil_posix' extension 08:45:16 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:45:16 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:45:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:45:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:45:16 INFO - Successfully installed psutil 08:45:16 INFO - Cleaning up... 08:45:16 INFO - Return code: 0 08:45:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:45:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f47fd43de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1175b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1311130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139ffc0>, '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 0x13a0ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a1350>, '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': 'c7c495d6f76fb52e1ad9f659000001da-1479919407.869859-850053679', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:45:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:45:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:45:16 INFO - Using env: {'DISPLAY': ':0', 08:45:16 INFO - 'HOME': '/home/cltbld', 08:45:16 INFO - 'LANG': 'en_US.UTF-8', 08:45:16 INFO - 'LANGUAGE': 'en_US:en', 08:45:16 INFO - 'LOGNAME': 'cltbld', 08:45:16 INFO - 'MAIL': '/var/mail/cltbld', 08:45:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:16 INFO - 'MOZ_NO_REMOTE': '1', 08:45:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:16 INFO - 'NO_EM_RESTART': '1', 08:45:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:16 INFO - 'PWD': '/builds/slave/test', 08:45:16 INFO - 'SHELL': '/bin/bash', 08:45:16 INFO - 'SHLVL': '1', 08:45:16 INFO - 'TERM': 'linux', 08:45:16 INFO - 'TMOUT': '86400', 08:45:16 INFO - 'USER': 'cltbld', 08:45:16 INFO - 'XDG_SESSION_COOKIE': 'c7c495d6f76fb52e1ad9f659000001da-1479919407.869859-850053679', 08:45:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:16 INFO - '_': '/tools/buildbot/bin/python'} 08:45:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:16 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:18 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:45:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:45:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:45:18 INFO - Installing collected packages: mozsystemmonitor 08:45:18 INFO - Running setup.py install for mozsystemmonitor 08:45:18 INFO - Successfully installed mozsystemmonitor 08:45:18 INFO - Cleaning up... 08:45:18 INFO - Return code: 0 08:45:18 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:45:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:18 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 0x7f47fd43de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1175b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1311130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139ffc0>, '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 0x13a0ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a1350>, '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': 'c7c495d6f76fb52e1ad9f659000001da-1479919407.869859-850053679', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:45:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:45:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:45:18 INFO - Using env: {'DISPLAY': ':0', 08:45:18 INFO - 'HOME': '/home/cltbld', 08:45:18 INFO - 'LANG': 'en_US.UTF-8', 08:45:18 INFO - 'LANGUAGE': 'en_US:en', 08:45:18 INFO - 'LOGNAME': 'cltbld', 08:45:18 INFO - 'MAIL': '/var/mail/cltbld', 08:45:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:18 INFO - 'MOZ_NO_REMOTE': '1', 08:45:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:18 INFO - 'NO_EM_RESTART': '1', 08:45:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:18 INFO - 'PWD': '/builds/slave/test', 08:45:18 INFO - 'SHELL': '/bin/bash', 08:45:18 INFO - 'SHLVL': '1', 08:45:18 INFO - 'TERM': 'linux', 08:45:18 INFO - 'TMOUT': '86400', 08:45:18 INFO - 'USER': 'cltbld', 08:45:18 INFO - 'XDG_SESSION_COOKIE': 'c7c495d6f76fb52e1ad9f659000001da-1479919407.869859-850053679', 08:45:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:18 INFO - '_': '/tools/buildbot/bin/python'} 08:45:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:18 INFO - Downloading/unpacking jsonschema==2.5.1 08:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:45:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:21 INFO - Downloading functools32-3.2.3-2.tar.gz 08:45:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:45:21 INFO - warning: no files found matching '*.txt' 08:45:21 INFO - no previously-included directories found matching 'build' 08:45:21 INFO - no previously-included directories found matching 'dist' 08:45:21 INFO - no previously-included directories found matching '.git*' 08:45:21 INFO - Installing collected packages: jsonschema, functools32 08:45:21 INFO - Running setup.py install for functools32 08:45:21 INFO - warning: no files found matching '*.txt' 08:45:21 INFO - no previously-included directories found matching 'build' 08:45:21 INFO - no previously-included directories found matching 'dist' 08:45:21 INFO - no previously-included directories found matching '.git*' 08:45:21 INFO - Successfully installed jsonschema functools32 08:45:21 INFO - Cleaning up... 08:45:21 INFO - Return code: 0 08:45:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:45:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:21 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 0x7f47fd43de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1175b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1311130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139ffc0>, '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 0x13a0ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a1350>, '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': 'c7c495d6f76fb52e1ad9f659000001da-1479919407.869859-850053679', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:45:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:45:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:45:21 INFO - Using env: {'DISPLAY': ':0', 08:45:21 INFO - 'HOME': '/home/cltbld', 08:45:21 INFO - 'LANG': 'en_US.UTF-8', 08:45:21 INFO - 'LANGUAGE': 'en_US:en', 08:45:21 INFO - 'LOGNAME': 'cltbld', 08:45:21 INFO - 'MAIL': '/var/mail/cltbld', 08:45:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:21 INFO - 'MOZ_NO_REMOTE': '1', 08:45:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:21 INFO - 'NO_EM_RESTART': '1', 08:45:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:21 INFO - 'PWD': '/builds/slave/test', 08:45:21 INFO - 'SHELL': '/bin/bash', 08:45:21 INFO - 'SHLVL': '1', 08:45:21 INFO - 'TERM': 'linux', 08:45:21 INFO - 'TMOUT': '86400', 08:45:21 INFO - 'USER': 'cltbld', 08:45:21 INFO - 'XDG_SESSION_COOKIE': 'c7c495d6f76fb52e1ad9f659000001da-1479919407.869859-850053679', 08:45:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:21 INFO - '_': '/tools/buildbot/bin/python'} 08:45:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:45:21 INFO - Cleaning up... 08:45:21 INFO - Return code: 0 08:45:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:45:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:21 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 0x7f47fd43de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1175b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1311130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139ffc0>, '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 0x13a0ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a1350>, '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': 'c7c495d6f76fb52e1ad9f659000001da-1479919407.869859-850053679', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:45:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:45:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:45:21 INFO - Using env: {'DISPLAY': ':0', 08:45:21 INFO - 'HOME': '/home/cltbld', 08:45:21 INFO - 'LANG': 'en_US.UTF-8', 08:45:21 INFO - 'LANGUAGE': 'en_US:en', 08:45:21 INFO - 'LOGNAME': 'cltbld', 08:45:21 INFO - 'MAIL': '/var/mail/cltbld', 08:45:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:21 INFO - 'MOZ_NO_REMOTE': '1', 08:45:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:21 INFO - 'NO_EM_RESTART': '1', 08:45:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:21 INFO - 'PWD': '/builds/slave/test', 08:45:21 INFO - 'SHELL': '/bin/bash', 08:45:21 INFO - 'SHLVL': '1', 08:45:21 INFO - 'TERM': 'linux', 08:45:21 INFO - 'TMOUT': '86400', 08:45:21 INFO - 'USER': 'cltbld', 08:45:21 INFO - 'XDG_SESSION_COOKIE': 'c7c495d6f76fb52e1ad9f659000001da-1479919407.869859-850053679', 08:45:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:21 INFO - '_': '/tools/buildbot/bin/python'} 08:45:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:21 INFO - Downloading/unpacking blobuploader==1.2.4 08:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:23 INFO - Downloading blobuploader-1.2.4.tar.gz 08:45:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:45:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:45:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:24 INFO - Downloading docopt-0.6.1.tar.gz 08:45:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:45:24 INFO - Installing collected packages: blobuploader, requests, docopt 08:45:24 INFO - Running setup.py install for blobuploader 08:45:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:45:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:45:24 INFO - Running setup.py install for requests 08:45:25 INFO - Running setup.py install for docopt 08:45:25 INFO - Successfully installed blobuploader requests docopt 08:45:25 INFO - Cleaning up... 08:45:25 INFO - Return code: 0 08:45:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:25 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 0x7f47fd43de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1175b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1311130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139ffc0>, '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 0x13a0ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a1350>, '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': 'c7c495d6f76fb52e1ad9f659000001da-1479919407.869859-850053679', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:45:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:45:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:45:25 INFO - Using env: {'DISPLAY': ':0', 08:45:25 INFO - 'HOME': '/home/cltbld', 08:45:25 INFO - 'LANG': 'en_US.UTF-8', 08:45:25 INFO - 'LANGUAGE': 'en_US:en', 08:45:25 INFO - 'LOGNAME': 'cltbld', 08:45:25 INFO - 'MAIL': '/var/mail/cltbld', 08:45:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:25 INFO - 'MOZ_NO_REMOTE': '1', 08:45:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:25 INFO - 'NO_EM_RESTART': '1', 08:45:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:25 INFO - 'PWD': '/builds/slave/test', 08:45:25 INFO - 'SHELL': '/bin/bash', 08:45:25 INFO - 'SHLVL': '1', 08:45:25 INFO - 'TERM': 'linux', 08:45:25 INFO - 'TMOUT': '86400', 08:45:25 INFO - 'USER': 'cltbld', 08:45:25 INFO - 'XDG_SESSION_COOKIE': 'c7c495d6f76fb52e1ad9f659000001da-1479919407.869859-850053679', 08:45:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:25 INFO - '_': '/tools/buildbot/bin/python'} 08:45:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:45:25 INFO - Running setup.py (path:/tmp/pip-9BnUmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:45:25 INFO - Running setup.py (path:/tmp/pip-nX3ijh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:45:25 INFO - Running setup.py (path:/tmp/pip-jWYAhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:45:25 INFO - Running setup.py (path:/tmp/pip-4IhRiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:45:25 INFO - Running setup.py (path:/tmp/pip-J2dz4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:45:25 INFO - Running setup.py (path:/tmp/pip-hWw82G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:45:25 INFO - Running setup.py (path:/tmp/pip-9WFPav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:45:25 INFO - Running setup.py (path:/tmp/pip-H9OIAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:45:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:45:25 INFO - Running setup.py (path:/tmp/pip-x0YKgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:45:26 INFO - Running setup.py (path:/tmp/pip-FmKqF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:45:26 INFO - Running setup.py (path:/tmp/pip-Ke7T00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:45:26 INFO - Running setup.py (path:/tmp/pip-0OToI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:45:26 INFO - Running setup.py (path:/tmp/pip-4gquW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:45:26 INFO - Running setup.py (path:/tmp/pip-dUVr8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:26 INFO - Running setup.py (path:/tmp/pip-CPydyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:45:26 INFO - Running setup.py (path:/tmp/pip-uq33z1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:45:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:45:26 INFO - Running setup.py (path:/tmp/pip-31kqCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:45:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:45:26 INFO - Running setup.py install for manifestparser 08:45:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:45:26 INFO - Running setup.py install for mozcrash 08:45:26 INFO - Running setup.py install for mozdebug 08:45:26 INFO - Running setup.py install for mozdevice 08:45:27 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:45:27 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:45:27 INFO - Running setup.py install for mozfile 08:45:27 INFO - Running setup.py install for mozhttpd 08:45:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:45:27 INFO - Running setup.py install for mozinfo 08:45:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:45:27 INFO - Running setup.py install for mozInstall 08:45:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:45:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:45:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:45:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:45:27 INFO - Running setup.py install for mozleak 08:45:27 INFO - Running setup.py install for mozlog 08:45:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:45:27 INFO - Running setup.py install for moznetwork 08:45:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:45:27 INFO - Running setup.py install for mozprocess 08:45:27 INFO - Running setup.py install for mozprofile 08:45:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:45:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:45:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:45:27 INFO - Running setup.py install for mozrunner 08:45:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:45:28 INFO - Running setup.py install for mozscreenshot 08:45:28 INFO - Running setup.py install for moztest 08:45:28 INFO - Running setup.py install for mozversion 08:45:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:45:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:45:28 INFO - Cleaning up... 08:45:28 INFO - Return code: 0 08:45:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:28 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 0x7f47fd43de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1175b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1311130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139ffc0>, '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 0x13a0ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a1350>, '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': 'c7c495d6f76fb52e1ad9f659000001da-1479919407.869859-850053679', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:45:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:45:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:45:28 INFO - Using env: {'DISPLAY': ':0', 08:45:28 INFO - 'HOME': '/home/cltbld', 08:45:28 INFO - 'LANG': 'en_US.UTF-8', 08:45:28 INFO - 'LANGUAGE': 'en_US:en', 08:45:28 INFO - 'LOGNAME': 'cltbld', 08:45:28 INFO - 'MAIL': '/var/mail/cltbld', 08:45:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:28 INFO - 'MOZ_NO_REMOTE': '1', 08:45:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:28 INFO - 'NO_EM_RESTART': '1', 08:45:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:28 INFO - 'PWD': '/builds/slave/test', 08:45:28 INFO - 'SHELL': '/bin/bash', 08:45:28 INFO - 'SHLVL': '1', 08:45:28 INFO - 'TERM': 'linux', 08:45:28 INFO - 'TMOUT': '86400', 08:45:28 INFO - 'USER': 'cltbld', 08:45:28 INFO - 'XDG_SESSION_COOKIE': 'c7c495d6f76fb52e1ad9f659000001da-1479919407.869859-850053679', 08:45:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:28 INFO - '_': '/tools/buildbot/bin/python'} 08:45:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:45:28 INFO - Running setup.py (path:/tmp/pip-pW89a5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:45:28 INFO - Running setup.py (path:/tmp/pip-9wDFUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:45:28 INFO - Running setup.py (path:/tmp/pip-F16LCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:45:28 INFO - Running setup.py (path:/tmp/pip-6vEojI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:45:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:45:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:45:28 INFO - Running setup.py (path:/tmp/pip-YtDcdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:45:29 INFO - Running setup.py (path:/tmp/pip-7m4Oy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:45:29 INFO - Running setup.py (path:/tmp/pip-UqSDgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:45:29 INFO - Running setup.py (path:/tmp/pip-XwASDb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:45:29 INFO - Running setup.py (path:/tmp/pip-3UCVhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:45:29 INFO - Running setup.py (path:/tmp/pip-2x0QXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:45:29 INFO - Running setup.py (path:/tmp/pip-vpvPQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:45:29 INFO - Running setup.py (path:/tmp/pip-f97WzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:45:29 INFO - Running setup.py (path:/tmp/pip-M3APVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:45:29 INFO - Running setup.py (path:/tmp/pip-Tpgox0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:29 INFO - Running setup.py (path:/tmp/pip-JSap4C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:45:29 INFO - Running setup.py (path:/tmp/pip-fLjfgk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:45:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:45:29 INFO - Running setup.py (path:/tmp/pip-vGKkYF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:45:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:45:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:31 INFO - Downloading blessings-1.6.tar.gz 08:45:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:45:31 INFO - Installing collected packages: blessings 08:45:31 INFO - Running setup.py install for blessings 08:45:32 INFO - Successfully installed blessings 08:45:32 INFO - Cleaning up... 08:45:32 INFO - Return code: 0 08:45:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:45:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:45:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:45:32 INFO - Reading from file tmpfile_stdout 08:45:32 INFO - Current package versions: 08:45:32 INFO - argparse == 1.2.1 08:45:32 INFO - blessings == 1.6 08:45:32 INFO - blobuploader == 1.2.4 08:45:32 INFO - docopt == 0.6.1 08:45:32 INFO - functools32 == 3.2.3-2 08:45:32 INFO - jsonschema == 2.5.1 08:45:32 INFO - manifestparser == 1.1 08:45:32 INFO - mozInstall == 1.12 08:45:32 INFO - mozcrash == 1.0 08:45:32 INFO - mozdebug == 0.1 08:45:32 INFO - mozdevice == 0.48 08:45:32 INFO - mozfile == 1.2 08:45:32 INFO - mozhttpd == 0.7 08:45:32 INFO - mozinfo == 0.9 08:45:32 INFO - mozleak == 0.1 08:45:32 INFO - mozlog == 3.4 08:45:32 INFO - moznetwork == 0.27 08:45:32 INFO - mozprocess == 0.23 08:45:32 INFO - mozprofile == 0.28 08:45:32 INFO - mozrunner == 6.13 08:45:32 INFO - mozscreenshot == 0.1 08:45:32 INFO - mozsystemmonitor == 0.3 08:45:32 INFO - moztest == 0.7 08:45:32 INFO - mozversion == 1.4 08:45:32 INFO - psutil == 3.1.1 08:45:32 INFO - requests == 1.2.3 08:45:32 INFO - wsgiref == 0.1.2 08:45:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:32 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 0x7f47fd43de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1175b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1311130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139ffc0>, '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 0x13a0ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a1350>, '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': 'c7c495d6f76fb52e1ad9f659000001da-1479919407.869859-850053679', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:45:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:45:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:45:32 INFO - Using env: {'DISPLAY': ':0', 08:45:32 INFO - 'HOME': '/home/cltbld', 08:45:32 INFO - 'LANG': 'en_US.UTF-8', 08:45:32 INFO - 'LANGUAGE': 'en_US:en', 08:45:32 INFO - 'LOGNAME': 'cltbld', 08:45:32 INFO - 'MAIL': '/var/mail/cltbld', 08:45:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:32 INFO - 'MOZ_NO_REMOTE': '1', 08:45:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:32 INFO - 'NO_EM_RESTART': '1', 08:45:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:32 INFO - 'PWD': '/builds/slave/test', 08:45:32 INFO - 'SHELL': '/bin/bash', 08:45:32 INFO - 'SHLVL': '1', 08:45:32 INFO - 'TERM': 'linux', 08:45:32 INFO - 'TMOUT': '86400', 08:45:32 INFO - 'USER': 'cltbld', 08:45:32 INFO - 'XDG_SESSION_COOKIE': 'c7c495d6f76fb52e1ad9f659000001da-1479919407.869859-850053679', 08:45:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:32 INFO - '_': '/tools/buildbot/bin/python'} 08:45:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:45:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:45:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:45:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:45:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:45:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:45:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:45:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:45:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:45:32 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:45:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:45:32 INFO - Cleaning up... 08:45:32 INFO - Return code: 0 08:45:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:45:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:32 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 0x7f47fd43de30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1175b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1311130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x139ffc0>, '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 0x13a0ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a1350>, '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': 'c7c495d6f76fb52e1ad9f659000001da-1479919407.869859-850053679', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:45:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:45:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:45:32 INFO - Using env: {'DISPLAY': ':0', 08:45:32 INFO - 'HOME': '/home/cltbld', 08:45:32 INFO - 'LANG': 'en_US.UTF-8', 08:45:32 INFO - 'LANGUAGE': 'en_US:en', 08:45:32 INFO - 'LOGNAME': 'cltbld', 08:45:32 INFO - 'MAIL': '/var/mail/cltbld', 08:45:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:32 INFO - 'MOZ_NO_REMOTE': '1', 08:45:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:32 INFO - 'NO_EM_RESTART': '1', 08:45:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:32 INFO - 'PWD': '/builds/slave/test', 08:45:32 INFO - 'SHELL': '/bin/bash', 08:45:32 INFO - 'SHLVL': '1', 08:45:32 INFO - 'TERM': 'linux', 08:45:32 INFO - 'TMOUT': '86400', 08:45:32 INFO - 'USER': 'cltbld', 08:45:32 INFO - 'XDG_SESSION_COOKIE': 'c7c495d6f76fb52e1ad9f659000001da-1479919407.869859-850053679', 08:45:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:32 INFO - '_': '/tools/buildbot/bin/python'} 08:45:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:45:32 INFO - Cleaning up... 08:45:32 INFO - Return code: 0 08:45:32 INFO - Running post-action listener: _resource_record_post_action 08:45:32 INFO - Running post-action listener: _start_resource_monitoring 08:45:32 INFO - Starting resource monitoring. 08:45:32 INFO - [mozharness: 2016-11-23 16:45:32.772372Z] Finished create-virtualenv step (success) 08:45:32 INFO - [mozharness: 2016-11-23 16:45:32.772847Z] Running install step. 08:45:32 INFO - Running pre-action listener: _resource_record_pre_action 08:45:32 INFO - Running main action method: install 08:45:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:45:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:45:32 INFO - Reading from file tmpfile_stdout 08:45:32 INFO - Detecting whether we're running mozinstall >=1.0... 08:45:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:45:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:45:33 INFO - Reading from file tmpfile_stdout 08:45:33 INFO - Output received: 08:45:33 INFO - Usage: mozinstall [options] installer 08:45:33 INFO - Options: 08:45:33 INFO - -h, --help show this help message and exit 08:45:33 INFO - -d DEST, --destination=DEST 08:45:33 INFO - Directory to install application into. [default: 08:45:33 INFO - "/builds/slave/test"] 08:45:33 INFO - --app=APP Application being installed. [default: firefox] 08:45:33 INFO - mkdir: /builds/slave/test/build/application 08:45:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:45:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:45:49 INFO - Reading from file tmpfile_stdout 08:45:49 INFO - Output received: 08:45:49 INFO - /builds/slave/test/build/application/firefox/firefox 08:45:49 INFO - Running post-action listener: _resource_record_post_action 08:45:49 INFO - [mozharness: 2016-11-23 16:45:49.145230Z] Finished install step (success) 08:45:49 INFO - [mozharness: 2016-11-23 16:45:49.145483Z] Running run-tests step. 08:45:49 INFO - Running pre-action listener: _resource_record_pre_action 08:45:49 INFO - Running main action method: run_tests 08:45:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:45:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:45:49 INFO - Python 2.7.3 08:45:49 INFO - Return code: 0 08:45:49 INFO - grabbing minidump binary from tooltool 08:45:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:45:49 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 0x139ffc0>, '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 0x13a0ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13a1350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:45:49 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:45:49 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:45:49 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:45:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:45:49 INFO - Return code: 0 08:45:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:45:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:45:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:45:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:45:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:45:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VAZjIBL9Qwq4oTKWZdt7mg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:45:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VAZjIBL9Qwq4oTKWZdt7mg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:45:49 INFO - Using env: {'DISPLAY': ':0', 08:45:49 INFO - 'HOME': '/home/cltbld', 08:45:49 INFO - 'LANG': 'en_US.UTF-8', 08:45:49 INFO - 'LANGUAGE': 'en_US:en', 08:45:49 INFO - 'LOGNAME': 'cltbld', 08:45:49 INFO - 'MAIL': '/var/mail/cltbld', 08:45:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:45:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:45:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:49 INFO - 'MOZ_NO_REMOTE': '1', 08:45:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:45:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:49 INFO - 'NO_EM_RESTART': '1', 08:45:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:49 INFO - 'PWD': '/builds/slave/test', 08:45:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:45:49 INFO - 'SHELL': '/bin/bash', 08:45:49 INFO - 'SHLVL': '1', 08:45:49 INFO - 'TERM': 'linux', 08:45:49 INFO - 'TMOUT': '86400', 08:45:49 INFO - 'USER': 'cltbld', 08:45:49 INFO - 'XDG_SESSION_COOKIE': 'c7c495d6f76fb52e1ad9f659000001da-1479919407.869859-850053679', 08:45:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:49 INFO - '_': '/tools/buildbot/bin/python'} 08:45:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VAZjIBL9Qwq4oTKWZdt7mg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:45:49 INFO - mozversion application_buildid: 20161123072135 08:45:49 INFO - mozversion application_changeset: 48fcc7fe4e16d0c7e233d5d94b4732b99b91c136 08:45:49 INFO - mozversion application_display_name: Nightly 08:45:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:45:49 INFO - mozversion application_name: Firefox 08:45:49 INFO - mozversion application_remotingname: firefox 08:45:49 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 08:45:49 INFO - mozversion application_vendor: Mozilla 08:45:49 INFO - mozversion application_version: 53.0a1 08:45:49 INFO - mozversion platform_buildid: 20161123072135 08:45:49 INFO - mozversion platform_changeset: 48fcc7fe4e16d0c7e233d5d94b4732b99b91c136 08:45:49 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 08:45:49 INFO - mozversion platform_version: 53.0a1 08:45:49 INFO - using testdate: 1479919549 08:45:49 INFO - actual date: 1479919549 08:45:49 INFO - starting webserver on 'localhost:37039' 08:45:49 INFO - SUITE-START | Running 2 tests 08:45:49 INFO - TEST-START | dromaeo_css 08:45:49 INFO - operating with platform_type : linux_ 08:45:49 INFO - Initialising browser for dromaeo_css test... 08:45:49 INFO - TEST-INFO | started process 30818 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm21Hjz/profile http://localhost:37039/getInfo.html) 08:45:53 INFO - PROCESS | 30818 | __metrics Screen width/height:1600/1200 08:45:53 INFO - PROCESS | 30818 | colorDepth:24 08:45:53 INFO - PROCESS | 30818 | Browser inner width/height: 1024/697 08:45:53 INFO - PROCESS | 30818 | __metrics 08:45:54 INFO - PROCESS | 30818 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:45:54 INFO - PROCESS | 30818 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:45:55 INFO - PROCESS | 30818 | console.error: PushService: 08:45:55 INFO - PROCESS | 30818 | stateChangeProcessEnqueue: Error transitioning state 08:45:55 INFO - PROCESS | 30818 | UnknownError 08:45:55 INFO - TEST-INFO | 30818: exit 0 08:45:55 INFO - Browser initialized. 08:45:55 INFO - Running cycle 1/1 for dromaeo_css test... 08:45:55 INFO - TEST-INFO | started process 30902 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm21Hjz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:46:08 INFO - PROCESS | 30902 | RSS: Main: 175669248 08:46:08 INFO - PROCESS | 30902 | 08:46:59 INFO - PROCESS | 30902 | 1479919619950 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:49:12 INFO - PROCESS | 30902 | Cycle 1(1): loaded http://localhost:37039/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37039/tests/dromaeo/cssquery-ext.html) 08:49:14 INFO - PROCESS | 30902 | RSS: Main: 337080320 08:49:14 INFO - PROCESS | 30902 | 08:52:17 INFO - PROCESS | 30902 | Cycle 1(1): loaded http://localhost:37039/tests/dromaeo/cssquery-ext.html (next: http://localhost:37039/tests/dromaeo/cssquery-jquery.html) 08:52:17 INFO - PROCESS | 30902 | RSS: Main: 288137216 08:52:17 INFO - PROCESS | 30902 | 08:55:20 INFO - PROCESS | 30902 | Cycle 1(1): loaded http://localhost:37039/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37039/tests/dromaeo/cssquery-mootools.html) 08:55:20 INFO - PROCESS | 30902 | RSS: Main: 223850496 08:55:20 INFO - PROCESS | 30902 | 08:58:22 INFO - PROCESS | 30902 | Cycle 1(1): loaded http://localhost:37039/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37039/tests/dromaeo/cssquery-prototype.html) 08:58:23 INFO - PROCESS | 30902 | RSS: Main: 243720192 08:58:23 INFO - PROCESS | 30902 | 09:01:26 INFO - PROCESS | 30902 | Cycle 1(1): loaded http://localhost:37039/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37039/tests/dromaeo/cssquery-yui.html) 09:01:27 INFO - PROCESS | 30902 | RSS: Main: 220766208 09:01:27 INFO - PROCESS | 30902 | 09:04:30 INFO - PROCESS | 30902 | Cycle 1(1): loaded http://localhost:37039/tests/dromaeo/cssquery-yui.html (next: http://localhost:37039/tests/dromaeo/cssquery-dojo.html) 09:04:31 INFO - PROCESS | 30902 | RSS: Main: 310673408 09:04:31 INFO - PROCESS | 30902 | 09:04:31 INFO - PROCESS | 30902 | __start_tp_report 09:04:31 INFO - PROCESS | 30902 | _x_x_mozilla_page_load 09:04:31 INFO - PROCESS | 30902 | _x_x_mozilla_page_load_details 09:04:31 INFO - PROCESS | 30902 | |i|pagename|runs| 09:04:31 INFO - PROCESS | 30902 | |0;dojo.html;2586.4051268208314;2607.126612584784;2624.4751049790043;2633.683957925048;2647.9735202647967;4488.820447182117;4557.339185818055;4677.158111539921;4683.203855344591;4708.152532544145;4589.013362127142;4634.050019745952;4668.5331466853295;4687.859364219071;4729.456112547058;4192.706510544263;4210.936835947463;4253.191893540217;4300.56994300569;4305.806238719265;3939;4314.3528470729325;4362.5637436256275;4380.649548036149;4431.091626216634;4325.264705000126;4359.956400436018;4373.125374925012;4382.496012958519;4399.802008909591;4147.066909945238;4197.202531519001;4200.726952748061;4263.616274535276;4270.7864606769845;4208.726432781859;4240.448741663595;4240.660747140221;4243.766592837393;4244.8514301999285;4629.953700463019;4642;4642.512536183686;4687.601553867926;4695.295705644146;4944.233643785219;4990.975045124751;5007.774650140753;5015.1474249377325;5027.120253955543;4795.592374648124;4861.100696371147;5031.094403007457;5033.773480193364;5093.617978651616;4566.086782643484;4605.953940460586;4610.331501932268;4616.053708989649;4618.56123668251;5029.622778291643;5035.420926593415;5042.319286896222;5047.041062198171;5050;4834.709917404967;4883.267509873547;4885.6335774817035;4900.387451568554;4934.55588996992;4983.50164983506;4984.875378115504;4986.152354099811;5020.523050310215;5032.471590482946;4930.580900623416;4936.210206367035;4948.628852836052;4983.053219888209;4991.975040124848;4759.16714574948;4824.300476430898;4841.927371089437;4930.33440485537;4941.925871111936;4227.7040607157205;4272.786360681954;4277.144571085733;4297.8495752648505;4337.696361254745;3720.7581507201944;3726.9813650932115;3730.7948062856262;3767.3972164453558;3773.415120656303;4156.480439945007;4354.891127721832;4365.105153443536;4369.344598310216;4409.911801763947;4842.854714358575;4905.803767849317;4954.702717836942;4980.975095124501;5016.072026675004;4326.2212801696;4326.718763280377;4354.194474022316;4370.213361594943;4373.125374925028;4500.032493013952;4507.323901414814;4513.300438432048;4515.68390212682;4556.453225612948;4523.23105072132;4583.74789386587;4590.655700822518;4672.649551283599;4686.414198225222;4988.077205716954;5030.547250747304;5034.320366750442;5081.669691470191;5081.695098294114;4706.247000479907;4727.912580106526;4735.59747421473;4744.335792988915;4773.522647735199;4732.52674732524;4793.352897358952;4939.16034274167;4947.851564453073;5001.474845141353;4846.491118432655;4898.167311556973;4903.5586797188425;4936.605071594192;4940.283658869515;4777.689450185727;4801.159797035574;4810.59109975642;4830.2513110467935;4871.926921096116;4882.633802464758;4887.780049897834;4893.559579637849;4930.556249937523;4941.975290123526;4822.855314340575;4823.855284341475;4825.372701548777;4835.226363781778;4872.342233798392;4635.23518619424;4751.334813126096;4777.808887644455;4878.682885612424;4914.262860570943;4606.930896036495;4655.138799322136;4662.020975595027;4825.252085926687;4837.927431088466 09:04:31 INFO - PROCESS | 30902 | |1;ext.html;548.5721137512741;560.4199653358775;565.666256908424;579.4697851465909;586.7271718650826;26487.867560662195;36623.4506482403;37478.250434991285;37533.249335013286;42288.365674514906;37899.24201515968;38348;38351.808240958824;38352.61647383525;38374.232515349744;7344.41244700424;7488.5506869587725;7495.213002634727;7495.812604684872;7498;7552;7634.465587408884;7640.274173953493;7642.197569255204;7644.426667999895;7585.81035474112;7651.426143039266;7655;7656.234376562355;7657.272559106904;7585.089789225301;7631.580263085583;7643.656035478417;7644.044494438223;7648.311651951351;7482.289182527651;7561.09266887977;7580.204078571781;7583.27958843909;7586.279303466162;36248.63751362479;36545;36559.26881462356;36646.816765916265;36662;2924.4297362014418;2933.7359637632503;2955.852207389622;2991.5064014437594;3017.6227971503563;27549.17352479429;27934.580981285297;28088.297792555146;28877.56683649726;29627.851860740775;3397.405454045557;3473.774204676713;3499.2301693627614;3516.5604299462566;3569.464580312948;234672;234941;234979;235110;235786;50794.49205507972;51214.48785512172;51284.74357628263;51291.23063154056;51312.74343628332;31843.681563184535;32972.50541241883;33034.17414564607;34535.30929381398;52650.736746316026;15062.246887655792;15308.234588270541;15311.846881531043;15317.540473785804;15406.691866162613;11078.224524283383;11215.271007384494;11219.71950701239;11219.887801122048;11224.326540407601;17625.294988200585;17849.37527186542;17867.463976080737;17870.19584118718;17922.372716954844;6856.588604683735;6916.308369163044;6923;6978.546394484444;6983;817.5176645779019;870.0516437083609;874.1389731114847;878.9033206347297;908.52756566585;26670.466590668468;27089.72910270872;27296;27584.724152758616;27785.305367365978;789.5736302396641;867.0979007103526;907.1835348186685;950.496236994394;966.1256562810668;11616.792809366194;11854.762904741858;14397.51478582955;14458.855411445751;14573.41706331756;342829;346342;346577;346814;346989;47597.52402475931;48193.75903120532;48217.517824822;48228;48322;1043.4886905416442;1093.191038631423;1132.4394424759962;1165.3182888010608;1181.0433548825479;26481.205563833115;27844.443111137258;28541;28905.855470722512;29104.63430485444;40608.39087413632;41165;41209.38185927273;41211.38182927199;41243.7937810309;220191;222794;223020;223091;223270;23696;24982.125625603017;25048.74951250464;26192.34519137037;26508.7349126514;38879.41680874732;39305.606943930194;39527.80236098801;39685.60314396819;40340.394894076024;34024;34567.481487778205;34731.4790278141;34753.82623086868;35220.823895880356;34147.14632134217;34365;34369.82815085909;34651;34864.825675871456;33988.32023359568;34108.488372673935;34415.31169376648;34662;35495.29009419746;29634.25914352072;32504.83747581247;32574.348513029134;32715.34569308553;32809.835950820096;24112.51774964526;24504.264872053867;24620.87689561541;24977;25132.49735005326 09:04:31 INFO - PROCESS | 30902 | |2;jquery.html;328.55152716541926;336.89724633986634;339.4111217038438;341.53380635432643;349.06102584048904;12418.19281746686;12588.874111258896;13380.732385352312;13587.524436644719;16332.265048072835;15299.694006119871;15732.606684832885;15790.289436975336;16745.246463909123;16870.746938795928;4858.829940952068;4888.828890988816;5054;5109.642325037249;5119.948800511985;4892.902141957176;4956.2070068789;5061.595072394218;5066.79732810689;5068.5438310552045;5142.922856157161;5222.503862133091;5233.319668443097;5236.685798852062;5238.109521381374;5044.8234311798915;5131.820386286499;5217.295665085203;5226.581873450153;5244.160934250521;5067.113255180328;5071.087204303224;5075.061113693979;5076.492350764931;5077.64456488046;11172.162087843444;11294.20940534163;11317.094632429385;15403;19474.80525194744;1774.5386199588072;1795.7306404039368;1862.8230318119756;1945.6984167454068;2037.7554693436734;7945.48354356965;8407.95796021022;8678.739637810875;8908.8663670045;9001.369904106716;1618.765279034545;1651.3147043976735;1659.6265840185981;1697.73685078813;1719.3638353809172;59577.106343404885;61431.69284153595;62816.68591657058;63734.681326593534;68593.65703171502;9040.8643870342;9063.274938004944;9341.159295663423;9527.666531671359;9582.28132890036;12566.497340106476;12577.434015469325;12600.936995314965;12605.558805441766;12763.808542871864;6610.173728283965;6712.026756120335;6837.948615415356;7129.60787156701;7219.8917016244795;6779.966100169468;6833.214180369222;6879.105716256955;7014.579125252501;7145.8928116078305;3877.84488620452;3968.7023473239046;3987.322155233617;3990.6408423242046;4106.240345536025;1641.318852676126;1684.225256382078;1738.3307426640833;1738.3741852932933;1814.537292990279;818.3044412249541;849.3290300662532;859.8366310401004;933.823382538007;945.9621615135455;15504.829323894664;16161.272742726605;16311.755323670155;16405.83594164043;17012.48962531126;859.6948083430417;889.7197382824389;892.3084609427746;901.4591245252795;916.7845556294266;6780.559263647847;8921.598528066253;9071.410358326688;9299.070092990647;9529.428234305964;376511;383046;399895;400245;401410;72352;72488;72757.27242727611;75140.48033275346;78354;900.9189172974333;913.9040400757825;942.7454587261401;943.4292253186724;946.2713710442921;14950.32723527422;15052.948944758502;15635.32569846108;15637.218139093227;15782.76325855136;35178;35245.82377088098;35773.64226357703;36091.278174435836;36361.454578181874;44643;46530.30204547002;47623.28565071596;52969.470305296454;53040.73479632577;6716.966415167893;6904.965475172793;6968.65156742171;7158.749443769443;7364.77905662831;9121.315901307562;10910.254359302473;11187.776244475228;11431.428428578703;11468.483918223867;9656.855147172657;9663.323567350219;9724.465154416575;9908.653197138066;9917.355371900803;9044.819103618023;9610.51947402613;9660.130588247092;9815.411075335503;9985.750356241153;9442.244620430487;9537.809243815223;9542.236621070437;9742.171915387271;9975.401475911469;6769.526133170828;6803.659817009228;6850.075239842757;6855.971604259401;7036.824079398056;7236.240194779472;8378.371622128487;9473.52632368365;9557.808843822946;9805.21558275322 09:04:31 INFO - PROCESS | 30902 | |3;mootools.html;1221.4137214137209;1320.1616973222003;1346.5758286139865;1398.3357904995128;1644.9424270150548;6023.5482338824595;6609.834754131143;6857.657117144147;6884.173899132099;6887.5178737488395;6705.865882682343;6785.1518560179975;6787.287334829846;6788.72845086196;6802.625855577941;1939.1467754188182;1963.6072785442898;1966.5476940303738;1969.9704504432445;1972.763268407786;1944.805519448058;1987.2547794577033;1998.4104689116746;2012.30575451469;2014.7582290125206;1969.379645411698;1974.0919177178444;1992.1931617694784;1992.671209250472;1999.4601457606439;1962.0582120582128;1979.5546002149545;1983.0778687910047;1983.8016198380192;1984.9603007939832;1964.695472201811;1998.290606834582;2011.8088781565727;2017.6065667194903;2021.1309137071053;6552.705128269192;6640.203175618908;6640.867182656368;6641.734330626769;6699.363560461748;3924.7645141291614;4084.4894388201474;4084.7957602120073;4108.568600296986;4114.423980642712;2530.4053547416343;2734.753872151516;2781.8887244510197;2786.1362977476842;2800.957985630217;838.9119142490073;866.9306455483546;879.3932186791094;881.9064360193378;907.260582625165;8546.359023073232;8627.30981521483;8670.046294907619;8677.522736249504;8707.521086340248;3389.389909816257;3484.8780292689635;3612.187257866959;3617.2584620152807;3627.966029681528;7031.7890463286185;7036.577805331696;7041.4718896082995;7044.330788575077;7069.8939515907305;4073.042834933788;4075.612816782401;4078.857239996586;4081.6122468365456;4082.7142100053306;3354.9832250839077;3465.28961562879;3640.381135207021;3732.0296722851713;3775.5846856845724;2937.2510009947327;2947.985260073686;3038.2252525606273;3045.9847700761798;3047.7866549341775;925.4632313258294;925.726910561386;930.6184464369576;931.6785708930408;934.5140526926097;828.5360198288978;841.7516832534294;845.678642115992;852.6972924611673;882.6381183714647;4606.930896036562;4655.464621568495;4858.46556878743;4872.269159626085;4961.454240033593;357.9534660494171;363.5147078650032;367.31862395256945;371.2408125383597;372.3799873211127;3469.670381313771;3476.3221171871746;3499.807510586942;3500.6674365935196;3608.1520842601967;7717.922820771832;7992.720254791055;8010.158933311918;8051.63767630458;8080.757577272691;7941.880871786928;7966;7966.9601651992525;7978.880316795253;7983.361331093499;6226.844328891814;6336.429721325011;6420.261669907927;6440.677966101676;6455.548111632234;4755.1916174251155;4775.6179505638775;4845.709257444564;4883.438404583519;5020.322256495472;7388.889166662612;7420.925790742023;7427.962860185665;7494.925050749423;7517.473776835569;7285.890711639224;7482.588457634883;7543.396528277615;7598.544087354777;7612.7716168515035;5155.587552995827;5445.319335083114;5511.58663100261;5520.282363292907;5521.668699878021;5875.911861322169;6137.84655383619;6390.648514331757;6413.743450261937;6420.775272865428;5955.583109182489;5959.612625179349;6053.4551890330085;6139.26328840542;6211.720472578835;6053.541401084292;6115.4190351916495;6128.233970753656;6140.846478838065;6145.692715364304;5058.140116180185;5067.391912970467;5084.1102807009365;5085.110105731556;5089.847304580869;4192.392103145088;4263.573642635712;4314.525402205818;4391.978040109907;4479.328100784908;4244.575542445731;4266.786660667016;4266.829326827016;4315.978420107879;4414.536473670219 09:04:31 INFO - PROCESS | 30902 | |4;prototype.html;279.5108560019965;279.8628671950744;288.50377350956353;289.31721138114045;290.0443040182598;4505.864824055276;4630.958034442248;4671.766411679415;4712.293156026598;4757.0961517311725;4421;4559.498455169929;4585.701929374588;4605.194091034064;4605.930911036337;3642.763220390679;3645.125169959204;3652.579953305364;3656.6526180012856;3661.340958627446;3441.260129072249;3548.7515873888838;3557.768745031565;3635.2729454109153;3664.43201303797;3639.290338384016;3641.4173732202853;3645.325614761264;3648.5986541480415;3658.2317713280245;3626.746127771057;3631.2737452509473;3632.7275454340765;3633.909152271214;3634.5093412389388;3192.393445245396;3206.8075915445147;3207.1501052220947;3216.099492142204;3221.6617255188335;4347.69566130371;4483.50681425043;4500.617447516965;4519.412476378083;4564.977175114103;4091.6317531422314;4104.42538044674;4105.199486100211;4115.176964607091;4116.608922152391;4790.80836766529;4815.542523460265;4833.734144622044;4837.153498137847;4844.5155484451625;3391.932161356759;3458.9827050864837;3472.6006509251506;3478.026152677229;3480.460528618068;5017.49825017499;5030.471800460936;5036.143855544567;5040.445550989388;5048.545630893201;3542.6988705960284;3548.6983606393746;3552.946705799415;3557.3952428087287;3567.3935430976794;3575.4458059000895;3584.336897673939;3596.4065929121925;3603.8378272977257;3627.3108109459117;3826.043489127718;3974.0328537374185;4022.9798851006144;4141.7722025288895;4144.461220041375;4779.3070004849105;4781.163296423112;4794.760261986887;4815.638827087912;4821.927671084936;1094.9945250273697;1107.8172101603307;1145.4673576786834;1171.2738102376582;1171.9589814356457;777.8133248020434;798.1938242375243;803.8070862992839;803.8545073270566;806.4234072638092;4175.62419382257;4178.456800615901;4180.909545227386;4188.392683061;4189.476315460567;4779.139754844092;4780.450248221499;4782.282657601388;4806.327114204014;4807.206810876166;4164.375343698409;4187.869275295653;4201.39513501631;4220.324748040299;4253;2465.1988103866315;2565.1022142250436;2577.9355516112246;2580.7161212266637;2582.4447743734813;4531.682782205214;4546.52238022644;4589.623113066067;4592.977035114803;4612.423447069116;4916.557509824133;4917.631177661689;4919.2129259318335;4923.507649235119;4957.405111386584;4382.342648602735;4515.616172625364;4537.933585607379;4563.612092972068;4570.520095389937;4772.3557319761385;4795.256735206049;4796.760161991817;4812.278158276286;4814.735189564608;4731.597814185833;4736.123817093849;4736.668433209642;4749.24012158053;4752.6197904168275;4475.328700694791;4562.58936695699;4574.222382195101;4748.715077095385;4793.657775822775;3440.3291358184915;3459.6540345965204;3462.63642317553;3466.584009918826;3467.5145479633375;5007.899842003067;5012.674176178537;5015.84952451427;5034.924476132935;5042.420121686053;4680.695754775928;4788.592969597623;4791.526143546041;4834.951650483591;4880.926196236822;4871.366722326216;4872.317875497504;4883.291922671122;4886.438059623047;4887.780049897834;4783.6651434399255;4796.448408432935;4801.663883528119;4808.591269742111;4820.3492528509605;4690.530946905282;4856.648912250535;4888.095702295087;4888.169011268022;4928.334674818997;4800.783964721666;4805.183118869871;4807.831725889577;4829.95170048295;4839.733814640229 09:04:31 INFO - PROCESS | 30902 | |5;yui.html;618.8886000519907;626.2109741725425;680.3332733920757;720.4992530191515;728.9781306560803;12303.200291981015;13442.798358024613;13508;13512.391942362592;13535.729285414285;12497.750044999095;12573.497060117585;12590.055745819078;12600.873991260085;12604.747905041917;617.364114961588;633.5944995203074;754.7735679296203;759.7340930674247;781.8553567589986;770.3721467004374;771.1132197972321;773.4894969320221;773.7678696391089;774.0981756253985;828.7348048624442;831.4553967151495;832.4256263178418;832.7543374704477;833.1210572845646;661.7319985405918;675.6689222281046;805.1264378149715;820.2658620534588;828.9129641387658;604.5798170271663;605.1830029460193;605.6759633596005;606.0485038489574;606.2543072021394;12552.246865188026;12621.116521843383;12632.178908370926;12645.494180232872;12651.493940242379;10970.286931349438;10999;11118.666440006813;11194.888051119466;11385.487653055632;9378.155965963097;9474.020911217305;10306.845397319046;10410.323328983592;10507.94746026265;3986.202759448122;4000.3599424092295;4028.8589899353383;4084.2852500812537;4236.68224883135;42794;43225.56774432247;43740.3438948416;43851.56148438506;43894.34158487625;9519.143277105093;9566;9648.662296819577;9684.806303873884;9704.70885873425;16348.10085445312;16354.754678679592;16366.181690915644;16407.917960410123;16479.093649849372;5859.794907178229;5982.461578457873;6150.538709596709;6330.620162790247;6389.968050159812;3469.392856250146;3527.6825085741893;3562.59030211529;3601.8559257629927;3624.6919011883756;2632.3682316244344;2704.7971402144917;2714.8914043438435;2715.0361621624434;2717.15768111882;457.5653129526896;458.14098565190267;467.34804947099286;467.64926305271047;478.48084827961355;469.471844175296;528.7382745540905;570.6661602962314;586.3403670870271;590.8345663214307;7269.20038795732;7339;7608.505447146029;7666.731664391719;7875.921240787633;490.4213028626255;557.1420013179658;602.4487593851577;603.4237303375266;604.353341924137;3630.9273814523563;3644.6105122236577;3645.5078564394;3648.2703459308245;3666.981665091711;69694.65152674305;71332.2866771336;72613.63693181501;75419.39972172552;76386.61806690932;63085.68457157777;67224.59692538432;67883.66058169678;68027;69740.65129674319;56113.719431402584;56417.71791141018;56878.862422751314;56905.43094569084;57044.714776426685;7008.894866576903;7066.399356054587;7118.074650295428;7285.486507155023;7335.926640733738;30753;39822.60177398189;40014.59985400225;40603;41496.792516037225;42693.35959960665;43642;44855.551444485136;46762.29856552222;48486.5151348482;9793.46135962529;10316.27786054969;10812.080973117374;10839.945800270949;11029.889701103208;11490.195686302213;11953.880461195276;11976.940115299367;12288.201266917622;12606.369681516071;10793.67618971432;11214.719632009264;11552.942235289105;11638.88361116378;11959.641210763692;11196.216264861381;11269.830952535554;11459.885401145882;11462.82805757931;12016.519339226683;10832.458377080957;11414.543418263176;11480.253783504046;11826.822597661214;12216.328101954477;9135.680251191443;9553.283503737108;9661.082197191256;9699.951500242736;9756.60973561078;9155.771105722144;9450;9673.903260967581;9971.30200885931;10276.948615257175 09:04:31 INFO - PROCESS | 30902 | __end_tp_report 09:04:31 INFO - PROCESS | 30902 | __start_cc_report 09:04:31 INFO - PROCESS | 30902 | _x_x_mozilla_cycle_collect,1819 09:04:31 INFO - PROCESS | 30902 | __end_cc_report 09:04:31 INFO - PROCESS | 30902 | __startTimestamp1479920671074__endTimestamp 09:04:31 INFO - PROCESS | 30902 | 09:04:31 INFO - PROCESS | 30902 | ------- Summary: start ------- 09:04:31 INFO - PROCESS | 30902 | Number of tests: 6 09:04:31 INFO - PROCESS | 30902 | 09:04:31 INFO - PROCESS | 30902 | [#0] dojo.html Cycles:165 Average:4595.46 Median:4706.25 stddev:470.22 (10.0%) stddev-sans-first:444.47 09:04:31 INFO - PROCESS | 30902 | Values: 2586.4 2607.1 2624.5 2633.7 2648.0 4488.8 4557.3 4677.2 4683.2 4708.2 4589.0 4634.1 4668.5 4687.9 4729.5 4192.7 4210.9 4253.2 4300.6 4305.8 3939.0 4314.4 4362.6 4380.6 4431.1 4325.3 4360.0 4373.1 4382.5 4399.8 4147.1 4197.2 4200.7 4263.6 4270.8 4208.7 4240.4 4240.7 4243.8 4244.9 4630.0 4642.0 4642.5 4687.6 4695.3 4944.2 4991.0 5007.8 5015.1 5027.1 4795.6 4861.1 5031.1 5033.8 5093.6 4566.1 4606.0 4610.3 4616.1 4618.6 5029.6 5035.4 5042.3 5047.0 5050.0 4834.7 4883.3 4885.6 4900.4 4934.6 4983.5 4984.9 4986.2 5020.5 5032.5 4930.6 4936.2 4948.6 4983.1 4992.0 4759.2 4824.3 4841.9 4930.3 4941.9 4227.7 4272.8 4277.1 4297.8 4337.7 3720.8 3727.0 3730.8 3767.4 3773.4 4156.5 4354.9 4365.1 4369.3 4409.9 4842.9 4905.8 4954.7 4981.0 5016.1 4326.2 4326.7 4354.2 4370.2 4373.1 4500.0 4507.3 4513.3 4515.7 4556.5 4523.2 4583.7 4590.7 4672.6 4686.4 4988.1 5030.5 5034.3 5081.7 5081.7 4706.2 4727.9 4735.6 4744.3 4773.5 4732.5 4793.4 4939.2 4947.9 5001.5 4846.5 4898.2 4903.6 4936.6 4940.3 4777.7 4801.2 4810.6 4830.3 4871.9 4882.6 4887.8 4893.6 4930.6 4942.0 4822.9 4823.9 4825.4 4835.2 4872.3 4635.2 4751.3 4777.8 4878.7 4914.3 4606.9 4655.1 4662.0 4825.3 4837.9 09:04:31 INFO - PROCESS | 30902 | 09:04:31 INFO - PROCESS | 30902 | [#1] ext.html Cycles:180 Average:42035.79 Median:175231.39 stddev:71687.95 (40.9%) stddev-sans-first:71821.38 09:04:31 INFO - PROCESS | 30902 | Values: 548.6 560.4 565.7 579.5 586.7 26487.9 36623.5 37478.3 37533.2 42288.4 37899.2 38348.0 38351.8 38352.6 38374.2 7344.4 7488.6 7495.2 7495.8 7498.0 7552.0 7634.5 7640.3 7642.2 7644.4 7585.8 7651.4 7655.0 7656.2 7657.3 7585.1 7631.6 7643.7 7644.0 7648.3 7482.3 7561.1 7580.2 7583.3 7586.3 36248.6 36545.0 36559.3 36646.8 36662.0 2924.4 2933.7 2955.9 2991.5 3017.6 27549.2 27934.6 28088.3 28877.6 29627.9 3397.4 3473.8 3499.2 3516.6 3569.5 234672.0 234941.0 234979.0 235110.0 235786.0 50794.5 51214.5 51284.7 51291.2 51312.7 31843.7 32972.5 33034.2 34535.3 52650.7 15062.2 15308.2 15311.8 15317.5 15406.7 11078.2 11215.3 11219.7 11219.9 11224.3 17625.3 17849.4 17867.5 17870.2 17922.4 6856.6 6916.3 6923.0 6978.5 6983.0 817.5 870.1 874.1 878.9 908.5 26670.5 27089.7 27296.0 27584.7 27785.3 789.6 867.1 907.2 950.5 966.1 11616.8 11854.8 14397.5 14458.9 14573.4 342829.0 346342.0 346577.0 346814.0 346989.0 47597.5 48193.8 48217.5 48228.0 48322.0 1043.5 1093.2 1132.4 1165.3 1181.0 26481.2 27844.4 28541.0 28905.9 29104.6 40608.4 41165.0 41209.4 41211.4 41243.8 220191.0 222794.0 223020.0 223091.0 223270.0 23696.0 24982.1 25048.7 26192.3 26508.7 38879.4 39305.6 39527.8 39685.6 40340.4 34024.0 34567.5 34731.5 34753.8 35220.8 34147.1 34365.0 34369.8 34651.0 34864.8 33988.3 34108.5 34415.3 34662.0 35495.3 29634.3 32504.8 32574.3 32715.3 32809.8 24112.5 24504.3 24620.9 24977.0 25132.5 09:04:31 INFO - PROCESS | 30902 | 09:04:31 INFO - PROCESS | 30902 | [#2] jquery.html Cycles:180 Average:23417.66 Median:5219.90 stddev:64683.70 (1239.2%) stddev-sans-first:64841.92 09:04:31 INFO - PROCESS | 30902 | Values: 328.6 336.9 339.4 341.5 349.1 12418.2 12588.9 13380.7 13587.5 16332.3 15299.7 15732.6 15790.3 16745.2 16870.7 4858.8 4888.8 5054.0 5109.6 5119.9 4892.9 4956.2 5061.6 5066.8 5068.5 5142.9 5222.5 5233.3 5236.7 5238.1 5044.8 5131.8 5217.3 5226.6 5244.2 5067.1 5071.1 5075.1 5076.5 5077.6 11172.2 11294.2 11317.1 15403.0 19474.8 1774.5 1795.7 1862.8 1945.7 2037.8 7945.5 8408.0 8678.7 8908.9 9001.4 1618.8 1651.3 1659.6 1697.7 1719.4 59577.1 61431.7 62816.7 63734.7 68593.7 9040.9 9063.3 9341.2 9527.7 9582.3 12566.5 12577.4 12600.9 12605.6 12763.8 6610.2 6712.0 6837.9 7129.6 7219.9 6780.0 6833.2 6879.1 7014.6 7145.9 3877.8 3968.7 3987.3 3990.6 4106.2 1641.3 1684.2 1738.3 1738.4 1814.5 818.3 849.3 859.8 933.8 946.0 15504.8 16161.3 16311.8 16405.8 17012.5 859.7 889.7 892.3 901.5 916.8 6780.6 8921.6 9071.4 9299.1 9529.4 376511.0 383046.0 399895.0 400245.0 401410.0 72352.0 72488.0 72757.3 75140.5 78354.0 900.9 913.9 942.7 943.4 946.3 14950.3 15052.9 15635.3 15637.2 15782.8 35178.0 35245.8 35773.6 36091.3 36361.5 44643.0 46530.3 47623.3 52969.5 53040.7 6717.0 6905.0 6968.7 7158.7 7364.8 9121.3 10910.3 11187.8 11431.4 11468.5 9656.9 9663.3 9724.5 9908.7 9917.4 9044.8 9610.5 9660.1 9815.4 9985.8 9442.2 9537.8 9542.2 9742.2 9975.4 6769.5 6803.7 6850.1 6856.0 7036.8 7236.2 8378.4 9473.5 9557.8 9805.2 09:04:31 INFO - PROCESS | 30902 | 09:04:31 INFO - PROCESS | 30902 | [#3] mootools.html Cycles:180 Average:4419.04 Median:5062.77 stddev:2358.59 (46.6%) stddev-sans-first:2352.97 09:04:31 INFO - PROCESS | 30902 | Values: 1221.4 1320.2 1346.6 1398.3 1644.9 6023.5 6609.8 6857.7 6884.2 6887.5 6705.9 6785.2 6787.3 6788.7 6802.6 1939.1 1963.6 1966.5 1970.0 1972.8 1944.8 1987.3 1998.4 2012.3 2014.8 1969.4 1974.1 1992.2 1992.7 1999.5 1962.1 1979.6 1983.1 1983.8 1985.0 1964.7 1998.3 2011.8 2017.6 2021.1 6552.7 6640.2 6640.9 6641.7 6699.4 3924.8 4084.5 4084.8 4108.6 4114.4 2530.4 2734.8 2781.9 2786.1 2801.0 838.9 866.9 879.4 881.9 907.3 8546.4 8627.3 8670.0 8677.5 8707.5 3389.4 3484.9 3612.2 3617.3 3628.0 7031.8 7036.6 7041.5 7044.3 7069.9 4073.0 4075.6 4078.9 4081.6 4082.7 3355.0 3465.3 3640.4 3732.0 3775.6 2937.3 2948.0 3038.2 3046.0 3047.8 925.5 925.7 930.6 931.7 934.5 828.5 841.8 845.7 852.7 882.6 4606.9 4655.5 4858.5 4872.3 4961.5 358.0 363.5 367.3 371.2 372.4 3469.7 3476.3 3499.8 3500.7 3608.2 7717.9 7992.7 8010.2 8051.6 8080.8 7941.9 7966.0 7967.0 7978.9 7983.4 6226.8 6336.4 6420.3 6440.7 6455.5 4755.2 4775.6 4845.7 4883.4 5020.3 7388.9 7420.9 7428.0 7494.9 7517.5 7285.9 7482.6 7543.4 7598.5 7612.8 5155.6 5445.3 5511.6 5520.3 5521.7 5875.9 6137.8 6390.6 6413.7 6420.8 5955.6 5959.6 6053.5 6139.3 6211.7 6053.5 6115.4 6128.2 6140.8 6145.7 5058.1 5067.4 5084.1 5085.1 5089.8 4192.4 4263.6 4314.5 4392.0 4479.3 4244.6 4266.8 4266.8 4316.0 4414.5 09:04:31 INFO - PROCESS | 30902 | 09:04:31 INFO - PROCESS | 30902 | [#4] prototype.html Cycles:180 Average:3987.90 Median:4542.23 stddev:1159.63 (25.5%) stddev-sans-first:1128.98 09:04:31 INFO - PROCESS | 30902 | Values: 279.5 279.9 288.5 289.3 290.0 4505.9 4631.0 4671.8 4712.3 4757.1 4421.0 4559.5 4585.7 4605.2 4605.9 3642.8 3645.1 3652.6 3656.7 3661.3 3441.3 3548.8 3557.8 3635.3 3664.4 3639.3 3641.4 3645.3 3648.6 3658.2 3626.7 3631.3 3632.7 3633.9 3634.5 3192.4 3206.8 3207.2 3216.1 3221.7 4347.7 4483.5 4500.6 4519.4 4565.0 4091.6 4104.4 4105.2 4115.2 4116.6 4790.8 4815.5 4833.7 4837.2 4844.5 3391.9 3459.0 3472.6 3478.0 3480.5 5017.5 5030.5 5036.1 5040.4 5048.5 3542.7 3548.7 3552.9 3557.4 3567.4 3575.4 3584.3 3596.4 3603.8 3627.3 3826.0 3974.0 4023.0 4141.8 4144.5 4779.3 4781.2 4794.8 4815.6 4821.9 1095.0 1107.8 1145.5 1171.3 1172.0 777.8 798.2 803.8 803.9 806.4 4175.6 4178.5 4180.9 4188.4 4189.5 4779.1 4780.5 4782.3 4806.3 4807.2 4164.4 4187.9 4201.4 4220.3 4253.0 2465.2 2565.1 2577.9 2580.7 2582.4 4531.7 4546.5 4589.6 4593.0 4612.4 4916.6 4917.6 4919.2 4923.5 4957.4 4382.3 4515.6 4537.9 4563.6 4570.5 4772.4 4795.3 4796.8 4812.3 4814.7 4731.6 4736.1 4736.7 4749.2 4752.6 4475.3 4562.6 4574.2 4748.7 4793.7 3440.3 3459.7 3462.6 3466.6 3467.5 5007.9 5012.7 5015.8 5034.9 5042.4 4680.7 4788.6 4791.5 4835.0 4880.9 4871.4 4872.3 4883.3 4886.4 4887.8 4783.7 4796.4 4801.7 4808.6 4820.3 4690.5 4856.6 4888.1 4888.2 4928.3 4800.8 4805.2 4807.8 4830.0 4839.7 09:04:31 INFO - PROCESS | 30902 | 09:04:31 INFO - PROCESS | 30902 | [#5] yui.html Cycles:180 Average:14639.47 Median:23615.89 stddev:19006.06 (80.5%) stddev-sans-first:19030.21 09:04:31 INFO - PROCESS | 30902 | Values: 618.9 626.2 680.3 720.5 729.0 12303.2 13442.8 13508.0 13512.4 13535.7 12497.8 12573.5 12590.1 12600.9 12604.7 617.4 633.6 754.8 759.7 781.9 770.4 771.1 773.5 773.8 774.1 828.7 831.5 832.4 832.8 833.1 661.7 675.7 805.1 820.3 828.9 604.6 605.2 605.7 606.0 606.3 12552.2 12621.1 12632.2 12645.5 12651.5 10970.3 10999.0 11118.7 11194.9 11385.5 9378.2 9474.0 10306.8 10410.3 10507.9 3986.2 4000.4 4028.9 4084.3 4236.7 42794.0 43225.6 43740.3 43851.6 43894.3 9519.1 9566.0 9648.7 9684.8 9704.7 16348.1 16354.8 16366.2 16407.9 16479.1 5859.8 5982.5 6150.5 6330.6 6390.0 3469.4 3527.7 3562.6 3601.9 3624.7 2632.4 2704.8 2714.9 2715.0 2717.2 457.6 458.1 467.3 467.6 478.5 469.5 528.7 570.7 586.3 590.8 7269.2 7339.0 7608.5 7666.7 7875.9 490.4 557.1 602.4 603.4 604.4 3630.9 3644.6 3645.5 3648.3 3667.0 69694.7 71332.3 72613.6 75419.4 76386.6 63085.7 67224.6 67883.7 68027.0 69740.7 56113.7 56417.7 56878.9 56905.4 57044.7 7008.9 7066.4 7118.1 7285.5 7335.9 30753.0 39822.6 40014.6 40603.0 41496.8 42693.4 43642.0 44855.6 46762.3 48486.5 9793.5 10316.3 10812.1 10839.9 11029.9 11490.2 11953.9 11976.9 12288.2 12606.4 10793.7 11214.7 11552.9 11638.9 11959.6 11196.2 11269.8 11459.9 11462.8 12016.5 10832.5 11414.5 11480.3 11826.8 12216.3 9135.7 9553.3 9661.1 9700.0 9756.6 9155.8 9450.0 9673.9 9971.3 10276.9 09:04:31 INFO - PROCESS | 30902 | -------- Summary: end -------- 09:04:31 INFO - PROCESS | 30902 | 09:04:32 INFO - TEST-INFO | 30902: exit 0 09:04:32 INFO - TEST-OK | dromaeo_css | took 1122665ms 09:04:32 INFO - TEST-START | kraken 09:04:32 INFO - operating with platform_type : linux_ 09:04:32 INFO - Initialising browser for kraken test... 09:04:32 INFO - TEST-INFO | started process 31203 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3zXF2t/profile http://localhost:37039/getInfo.html) 09:04:36 INFO - PROCESS | 31203 | __metrics Screen width/height:1600/1200 09:04:36 INFO - PROCESS | 31203 | colorDepth:24 09:04:36 INFO - PROCESS | 31203 | Browser inner width/height: 1024/697 09:04:36 INFO - PROCESS | 31203 | __metrics 09:04:37 INFO - PROCESS | 31203 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:04:37 INFO - PROCESS | 31203 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:04:38 INFO - TEST-INFO | 31203: exit 0 09:04:38 INFO - Browser initialized. 09:04:38 INFO - Running cycle 1/1 for kraken test... 09:04:38 INFO - TEST-INFO | started process 31287 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3zXF2t/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:04:50 INFO - PROCESS | 31287 | RSS: Main: 176427008 09:04:50 INFO - PROCESS | 31287 | 09:04:53 INFO - PROCESS | 31287 | Cycle 1(1): loaded http://localhost:37039/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37039/tests/kraken/driver.html?testName=audio-beat-detection) 09:04:54 INFO - PROCESS | 31287 | RSS: Main: 237121536 09:04:54 INFO - PROCESS | 31287 | 09:04:57 INFO - PROCESS | 31287 | Cycle 1(1): loaded http://localhost:37039/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37039/tests/kraken/driver.html?testName=audio-dft) 09:04:58 INFO - PROCESS | 31287 | RSS: Main: 219631616 09:04:58 INFO - PROCESS | 31287 | 09:05:01 INFO - PROCESS | 31287 | Cycle 1(1): loaded http://localhost:37039/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37039/tests/kraken/driver.html?testName=audio-fft) 09:05:01 INFO - PROCESS | 31287 | RSS: Main: 300818432 09:05:01 INFO - PROCESS | 31287 | 09:05:04 INFO - PROCESS | 31287 | Cycle 1(1): loaded http://localhost:37039/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37039/tests/kraken/driver.html?testName=audio-oscillator) 09:05:04 INFO - PROCESS | 31287 | RSS: Main: 212082688 09:05:04 INFO - PROCESS | 31287 | 09:05:06 INFO - PROCESS | 31287 | Cycle 1(1): loaded http://localhost:37039/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37039/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:05:07 INFO - PROCESS | 31287 | RSS: Main: 216211456 09:05:07 INFO - PROCESS | 31287 | 09:05:10 INFO - PROCESS | 31287 | Cycle 1(1): loaded http://localhost:37039/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37039/tests/kraken/driver.html?testName=imaging-darkroom) 09:05:11 INFO - PROCESS | 31287 | RSS: Main: 254939136 09:05:11 INFO - PROCESS | 31287 | 09:05:14 INFO - PROCESS | 31287 | Cycle 1(1): loaded http://localhost:37039/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37039/tests/kraken/driver.html?testName=imaging-desaturate) 09:05:15 INFO - PROCESS | 31287 | RSS: Main: 254902272 09:05:15 INFO - PROCESS | 31287 | 09:05:18 INFO - PROCESS | 31287 | Cycle 1(1): loaded http://localhost:37039/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37039/tests/kraken/driver.html?testName=json-parse-financial) 09:05:18 INFO - PROCESS | 31287 | RSS: Main: 253124608 09:05:18 INFO - PROCESS | 31287 | 09:05:20 INFO - PROCESS | 31287 | Cycle 1(1): loaded http://localhost:37039/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37039/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:05:21 INFO - PROCESS | 31287 | RSS: Main: 215748608 09:05:21 INFO - PROCESS | 31287 | 09:05:23 INFO - PROCESS | 31287 | Cycle 1(1): loaded http://localhost:37039/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37039/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:05:23 INFO - PROCESS | 31287 | RSS: Main: 223006720 09:05:23 INFO - PROCESS | 31287 | 09:05:25 INFO - PROCESS | 31287 | Cycle 1(1): loaded http://localhost:37039/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37039/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:05:26 INFO - PROCESS | 31287 | RSS: Main: 231718912 09:05:26 INFO - PROCESS | 31287 | 09:05:29 INFO - PROCESS | 31287 | Cycle 1(1): loaded http://localhost:37039/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37039/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:05:30 INFO - PROCESS | 31287 | RSS: Main: 235462656 09:05:30 INFO - PROCESS | 31287 | 09:05:33 INFO - PROCESS | 31287 | Cycle 1(1): loaded http://localhost:37039/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37039/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:05:33 INFO - PROCESS | 31287 | RSS: Main: 237264896 09:05:33 INFO - PROCESS | 31287 | 09:05:35 INFO - PROCESS | 31287 | Cycle 1(1): loaded http://localhost:37039/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37039/tests/kraken/driver.html?testName=ai-astar) 09:05:36 INFO - PROCESS | 31287 | RSS: Main: 287453184 09:05:36 INFO - PROCESS | 31287 | 09:05:36 INFO - PROCESS | 31287 | __start_tp_report 09:05:36 INFO - PROCESS | 31287 | _x_x_mozilla_page_load 09:05:36 INFO - PROCESS | 31287 | _x_x_mozilla_page_load_details 09:05:36 INFO - PROCESS | 31287 | |i|pagename|runs| 09:05:36 INFO - PROCESS | 31287 | |0;ai-astar;109;119;117;119;117;116;119;117;116;118 09:05:36 INFO - PROCESS | 31287 | |1;audio-beat-detection;157;128;128;177;134;133;128;126;158;128 09:05:36 INFO - PROCESS | 31287 | |2;audio-dft;163;160;161;162;160;161;160;161;162;160 09:05:36 INFO - PROCESS | 31287 | |3;audio-fft;77;77;77;112;78;78;77;76;107;77 09:05:36 INFO - PROCESS | 31287 | |4;audio-oscillator;84;84;131;82;84;83;104;83;83;123 09:05:36 INFO - PROCESS | 31287 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;117;117 09:05:36 INFO - PROCESS | 31287 | |6;imaging-darkroom;146;147;146;146;146;147;147;146;146;146 09:05:36 INFO - PROCESS | 31287 | |7;imaging-desaturate;98;95;95;96;96;96;95;95;95;95 09:05:36 INFO - PROCESS | 31287 | |8;json-parse-financial;64;62;63;64;64;66;63;64;64;64 09:05:36 INFO - PROCESS | 31287 | |9;json-stringify-tinderbox;65;66;65;65;66;66;66;66;66;66 09:05:36 INFO - PROCESS | 31287 | |10;stanford-crypto-aes;92;84;93;85;84;84;84;84;85;84 09:05:36 INFO - PROCESS | 31287 | |11;stanford-crypto-ccm;147;146;148;140;139;148;142;149;228;154 09:05:36 INFO - PROCESS | 31287 | |12;stanford-crypto-pbkdf2;189;185;181;179;179;181;182;181;179;180 09:05:36 INFO - PROCESS | 31287 | |13;stanford-crypto-sha256-iterative;72;71;70;69;69;70;74;70;68;68 09:05:36 INFO - PROCESS | 31287 | __end_tp_report 09:05:36 INFO - PROCESS | 31287 | __start_cc_report 09:05:36 INFO - PROCESS | 31287 | _x_x_mozilla_cycle_collect,1965 09:05:36 INFO - PROCESS | 31287 | __end_cc_report 09:05:36 INFO - PROCESS | 31287 | __startTimestamp1479920736016__endTimestamp 09:05:36 INFO - PROCESS | 31287 | 09:05:36 INFO - PROCESS | 31287 | ------- Summary: start ------- 09:05:36 INFO - PROCESS | 31287 | Number of tests: 14 09:05:36 INFO - PROCESS | 31287 | 09:05:36 INFO - PROCESS | 31287 | [#0] ai-astar Cycles:10 Average:116.70 Median:117.50 stddev:2.95 (2.5%) stddev-sans-first:1.24 09:05:36 INFO - PROCESS | 31287 | Values: 109.0 119.0 117.0 119.0 117.0 116.0 119.0 117.0 116.0 118.0 09:05:36 INFO - PROCESS | 31287 | 09:05:36 INFO - PROCESS | 31287 | [#1] audio-beat-detection Cycles:10 Average:139.70 Median:133.50 stddev:17.76 (13.3%) stddev-sans-first:17.70 09:05:36 INFO - PROCESS | 31287 | Values: 157.0 128.0 128.0 177.0 134.0 133.0 128.0 126.0 158.0 128.0 09:05:36 INFO - PROCESS | 31287 | 09:05:36 INFO - PROCESS | 31287 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.05 (0.7%) stddev-sans-first:0.83 09:05:36 INFO - PROCESS | 31287 | Values: 163.0 160.0 161.0 162.0 160.0 161.0 160.0 161.0 162.0 160.0 09:05:36 INFO - PROCESS | 31287 | 09:05:36 INFO - PROCESS | 31287 | [#3] audio-fft Cycles:10 Average:83.60 Median:77.00 stddev:13.71 (17.8%) stddev-sans-first:14.34 09:05:36 INFO - PROCESS | 31287 | Values: 77.0 77.0 77.0 112.0 78.0 78.0 77.0 76.0 107.0 77.0 09:05:36 INFO - PROCESS | 31287 | 09:05:36 INFO - PROCESS | 31287 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:83.00 stddev:18.61 (22.4%) stddev-sans-first:19.38 09:05:36 INFO - PROCESS | 31287 | Values: 84.0 84.0 131.0 82.0 84.0 83.0 104.0 83.0 83.0 123.0 09:05:36 INFO - PROCESS | 31287 | 09:05:36 INFO - PROCESS | 31287 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:05:36 INFO - PROCESS | 31287 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 09:05:36 INFO - PROCESS | 31287 | 09:05:36 INFO - PROCESS | 31287 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 09:05:36 INFO - PROCESS | 31287 | Values: 146.0 147.0 146.0 146.0 146.0 147.0 147.0 146.0 146.0 146.0 09:05:36 INFO - PROCESS | 31287 | 09:05:36 INFO - PROCESS | 31287 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:95.50 stddev:0.97 (1.0%) stddev-sans-first:0.50 09:05:36 INFO - PROCESS | 31287 | Values: 98.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0 95.0 95.0 09:05:36 INFO - PROCESS | 31287 | 09:05:36 INFO - PROCESS | 31287 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.00 stddev:1.03 (1.6%) stddev-sans-first:1.09 09:05:36 INFO - PROCESS | 31287 | Values: 64.0 62.0 63.0 64.0 64.0 66.0 63.0 64.0 64.0 64.0 09:05:36 INFO - PROCESS | 31287 | 09:05:36 INFO - PROCESS | 31287 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 09:05:36 INFO - PROCESS | 31287 | Values: 65.0 66.0 65.0 65.0 66.0 66.0 66.0 66.0 66.0 66.0 09:05:36 INFO - PROCESS | 31287 | 09:05:36 INFO - PROCESS | 31287 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:84.50 stddev:3.51 (4.2%) stddev-sans-first:2.95 09:05:36 INFO - PROCESS | 31287 | Values: 92.0 84.0 93.0 85.0 84.0 84.0 84.0 84.0 85.0 84.0 09:05:36 INFO - PROCESS | 31287 | 09:05:36 INFO - PROCESS | 31287 | [#11] stanford-crypto-ccm Cycles:10 Average:154.10 Median:148.00 stddev:26.35 (17.8%) stddev-sans-first:27.83 09:05:36 INFO - PROCESS | 31287 | Values: 147.0 146.0 148.0 140.0 139.0 148.0 142.0 149.0 228.0 154.0 09:05:36 INFO - PROCESS | 31287 | 09:05:36 INFO - PROCESS | 31287 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.60 Median:181.00 stddev:3.17 (1.8%) stddev-sans-first:1.92 09:05:36 INFO - PROCESS | 31287 | Values: 189.0 185.0 181.0 179.0 179.0 181.0 182.0 181.0 179.0 180.0 09:05:36 INFO - PROCESS | 31287 | 09:05:36 INFO - PROCESS | 31287 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.00 stddev:1.85 (2.6%) stddev-sans-first:1.83 09:05:36 INFO - PROCESS | 31287 | Values: 72.0 71.0 70.0 69.0 69.0 70.0 74.0 70.0 68.0 68.0 09:05:36 INFO - PROCESS | 31287 | -------- Summary: end -------- 09:05:36 INFO - PROCESS | 31287 | 09:05:37 INFO - TEST-INFO | 31287: exit 0 09:05:37 INFO - TEST-OK | kraken | took 65301ms 09:05:37 INFO - SUITE-END | took 1187s 09:05:37 INFO - Completed test suite (00:19:48) 09:05:37 INFO - javascript benchmark 09:05:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2586.4051268208314, 2607.126612584784, 2624.4751049790043, 2633.683957925048, 2647.9735202647967, 4488.820447182117, 4557.339185818055, 4677.158111539921, 4683.203855344591, 4708.152532544145, 4589.013362127142, 4634.050019745952, 4668.5331466853295, 4687.859364219071, 4729.456112547058, 4192.706510544263, 4210.936835947463, 4253.191893540217, 4300.56994300569, 4305.806238719265, 3939.0, 4314.3528470729325, 4362.5637436256275, 4380.649548036149, 4431.091626216634, 4325.264705000126, 4359.956400436018, 4373.125374925012, 4382.496012958519, 4399.802008909591, 4147.066909945238, 4197.202531519001, 4200.726952748061, 4263.616274535276, 4270.7864606769845, 4208.726432781859, 4240.448741663595, 4240.660747140221, 4243.766592837393, 4244.8514301999285, 4629.953700463019, 4642.0, 4642.512536183686, 4687.601553867926, 4695.295705644146, 4944.233643785219, 4990.975045124751, 5007.774650140753, 5015.1474249377325, 5027.120253955543, 4795.592374648124, 4861.100696371147, 5031.094403007457, 5033.773480193364, 5093.617978651616, 4566.086782643484, 4605.953940460586, 4610.331501932268, 4616.053708989649, 4618.56123668251, 5029.622778291643, 5035.420926593415, 5042.319286896222, 5047.041062198171, 5050.0, 4834.709917404967, 4883.267509873547, 4885.6335774817035, 4900.387451568554, 4934.55588996992, 4983.50164983506, 4984.875378115504, 4986.152354099811, 5020.523050310215, 5032.471590482946, 4930.580900623416, 4936.210206367035, 4948.628852836052, 4983.053219888209, 4991.975040124848, 4759.16714574948, 4824.300476430898, 4841.927371089437, 4930.33440485537, 4941.925871111936, 4227.7040607157205, 4272.786360681954, 4277.144571085733, 4297.8495752648505, 4337.696361254745, 3720.7581507201944, 3726.9813650932115, 3730.7948062856262, 3767.3972164453558, 3773.415120656303, 4156.480439945007, 4354.891127721832, 4365.105153443536, 4369.344598310216, 4409.911801763947, 4842.854714358575, 4905.803767849317, 4954.702717836942, 4980.975095124501, 5016.072026675004, 4326.2212801696, 4326.718763280377, 4354.194474022316, 4370.213361594943, 4373.125374925028, 4500.032493013952, 4507.323901414814, 4513.300438432048, 4515.68390212682, 4556.453225612948, 4523.23105072132, 4583.74789386587, 4590.655700822518, 4672.649551283599, 4686.414198225222, 4988.077205716954, 5030.547250747304, 5034.320366750442, 5081.669691470191, 5081.695098294114, 4706.247000479907, 4727.912580106526, 4735.59747421473, 4744.335792988915, 4773.522647735199, 4732.52674732524, 4793.352897358952, 4939.16034274167, 4947.851564453073, 5001.474845141353, 4846.491118432655, 4898.167311556973, 4903.5586797188425, 4936.605071594192, 4940.283658869515, 4777.689450185727, 4801.159797035574, 4810.59109975642, 4830.2513110467935, 4871.926921096116, 4882.633802464758, 4887.780049897834, 4893.559579637849, 4930.556249937523, 4941.975290123526, 4822.855314340575, 4823.855284341475, 4825.372701548777, 4835.226363781778, 4872.342233798392, 4635.23518619424, 4751.334813126096, 4777.808887644455, 4878.682885612424, 4914.262860570943, 4606.930896036495, 4655.138799322136, 4662.020975595027, 4825.252085926687, 4837.927431088466], "value": 4566.330826675948, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.5721137512741, 560.4199653358775, 565.666256908424, 579.4697851465909, 586.7271718650826, 26487.867560662195, 36623.4506482403, 37478.250434991285, 37533.249335013286, 42288.365674514906, 37899.24201515968, 38348.0, 38351.808240958824, 38352.61647383525, 38374.232515349744, 7344.41244700424, 7488.5506869587725, 7495.213002634727, 7495.812604684872, 7498.0, 7552.0, 7634.465587408884, 7640.274173953493, 7642.197569255204, 7644.426667999895, 7585.81035474112, 7651.426143039266, 7655.0, 7656.234376562355, 7657.272559106904, 7585.089789225301, 7631.580263085583, 7643.656035478417, 7644.044494438223, 7648.311651951351, 7482.289182527651, 7561.09266887977, 7580.204078571781, 7583.27958843909, 7586.279303466162, 36248.63751362479, 36545.0, 36559.26881462356, 36646.816765916265, 36662.0, 2924.4297362014418, 2933.7359637632503, 2955.852207389622, 2991.5064014437594, 3017.6227971503563, 27549.17352479429, 27934.580981285297, 28088.297792555146, 28877.56683649726, 29627.851860740775, 3397.405454045557, 3473.774204676713, 3499.2301693627614, 3516.5604299462566, 3569.464580312948, 234672.0, 234941.0, 234979.0, 235110.0, 235786.0, 50794.49205507972, 51214.48785512172, 51284.74357628263, 51291.23063154056, 51312.74343628332, 31843.681563184535, 32972.50541241883, 33034.17414564607, 34535.30929381398, 52650.736746316026, 15062.246887655792, 15308.234588270541, 15311.846881531043, 15317.540473785804, 15406.691866162613, 11078.224524283383, 11215.271007384494, 11219.71950701239, 11219.887801122048, 11224.326540407601, 17625.294988200585, 17849.37527186542, 17867.463976080737, 17870.19584118718, 17922.372716954844, 6856.588604683735, 6916.308369163044, 6923.0, 6978.546394484444, 6983.0, 817.5176645779019, 870.0516437083609, 874.1389731114847, 878.9033206347297, 908.52756566585, 26670.466590668468, 27089.72910270872, 27296.0, 27584.724152758616, 27785.305367365978, 789.5736302396641, 867.0979007103526, 907.1835348186685, 950.496236994394, 966.1256562810668, 11616.792809366194, 11854.762904741858, 14397.51478582955, 14458.855411445751, 14573.41706331756, 342829.0, 346342.0, 346577.0, 346814.0, 346989.0, 47597.52402475931, 48193.75903120532, 48217.517824822, 48228.0, 48322.0, 1043.4886905416442, 1093.191038631423, 1132.4394424759962, 1165.3182888010608, 1181.0433548825479, 26481.205563833115, 27844.443111137258, 28541.0, 28905.855470722512, 29104.63430485444, 40608.39087413632, 41165.0, 41209.38185927273, 41211.38182927199, 41243.7937810309, 220191.0, 222794.0, 223020.0, 223091.0, 223270.0, 23696.0, 24982.125625603017, 25048.74951250464, 26192.34519137037, 26508.7349126514, 38879.41680874732, 39305.606943930194, 39527.80236098801, 39685.60314396819, 40340.394894076024, 34024.0, 34567.481487778205, 34731.4790278141, 34753.82623086868, 35220.823895880356, 34147.14632134217, 34365.0, 34369.82815085909, 34651.0, 34864.825675871456, 33988.32023359568, 34108.488372673935, 34415.31169376648, 34662.0, 35495.29009419746, 29634.25914352072, 32504.83747581247, 32574.348513029134, 32715.34569308553, 32809.835950820096, 24112.51774964526, 24504.264872053867, 24620.87689561541, 24977.0, 25132.49735005326], "value": 16628.829151569575, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [328.55152716541926, 336.89724633986634, 339.4111217038438, 341.53380635432643, 349.06102584048904, 12418.19281746686, 12588.874111258896, 13380.732385352312, 13587.524436644719, 16332.265048072835, 15299.694006119871, 15732.606684832885, 15790.289436975336, 16745.246463909123, 16870.746938795928, 4858.829940952068, 4888.828890988816, 5054.0, 5109.642325037249, 5119.948800511985, 4892.902141957176, 4956.2070068789, 5061.595072394218, 5066.79732810689, 5068.5438310552045, 5142.922856157161, 5222.503862133091, 5233.319668443097, 5236.685798852062, 5238.109521381374, 5044.8234311798915, 5131.820386286499, 5217.295665085203, 5226.581873450153, 5244.160934250521, 5067.113255180328, 5071.087204303224, 5075.061113693979, 5076.492350764931, 5077.64456488046, 11172.162087843444, 11294.20940534163, 11317.094632429385, 15403.0, 19474.80525194744, 1774.5386199588072, 1795.7306404039368, 1862.8230318119756, 1945.6984167454068, 2037.7554693436734, 7945.48354356965, 8407.95796021022, 8678.739637810875, 8908.8663670045, 9001.369904106716, 1618.765279034545, 1651.3147043976735, 1659.6265840185981, 1697.73685078813, 1719.3638353809172, 59577.106343404885, 61431.69284153595, 62816.68591657058, 63734.681326593534, 68593.65703171502, 9040.8643870342, 9063.274938004944, 9341.159295663423, 9527.666531671359, 9582.28132890036, 12566.497340106476, 12577.434015469325, 12600.936995314965, 12605.558805441766, 12763.808542871864, 6610.173728283965, 6712.026756120335, 6837.948615415356, 7129.60787156701, 7219.8917016244795, 6779.966100169468, 6833.214180369222, 6879.105716256955, 7014.579125252501, 7145.8928116078305, 3877.84488620452, 3968.7023473239046, 3987.322155233617, 3990.6408423242046, 4106.240345536025, 1641.318852676126, 1684.225256382078, 1738.3307426640833, 1738.3741852932933, 1814.537292990279, 818.3044412249541, 849.3290300662532, 859.8366310401004, 933.823382538007, 945.9621615135455, 15504.829323894664, 16161.272742726605, 16311.755323670155, 16405.83594164043, 17012.48962531126, 859.6948083430417, 889.7197382824389, 892.3084609427746, 901.4591245252795, 916.7845556294266, 6780.559263647847, 8921.598528066253, 9071.410358326688, 9299.070092990647, 9529.428234305964, 376511.0, 383046.0, 399895.0, 400245.0, 401410.0, 72352.0, 72488.0, 72757.27242727611, 75140.48033275346, 78354.0, 900.9189172974333, 913.9040400757825, 942.7454587261401, 943.4292253186724, 946.2713710442921, 14950.32723527422, 15052.948944758502, 15635.32569846108, 15637.218139093227, 15782.76325855136, 35178.0, 35245.82377088098, 35773.64226357703, 36091.278174435836, 36361.454578181874, 44643.0, 46530.30204547002, 47623.28565071596, 52969.470305296454, 53040.73479632577, 6716.966415167893, 6904.965475172793, 6968.65156742171, 7158.749443769443, 7364.77905662831, 9121.315901307562, 10910.254359302473, 11187.776244475228, 11431.428428578703, 11468.483918223867, 9656.855147172657, 9663.323567350219, 9724.465154416575, 9908.653197138066, 9917.355371900803, 9044.819103618023, 9610.51947402613, 9660.130588247092, 9815.411075335503, 9985.750356241153, 9442.244620430487, 9537.809243815223, 9542.236621070437, 9742.171915387271, 9975.401475911469, 6769.526133170828, 6803.659817009228, 6850.075239842757, 6855.971604259401, 7036.824079398056, 7236.240194779472, 8378.371622128487, 9473.52632368365, 9557.808843822946, 9805.21558275322], "value": 7694.485812323162, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1221.4137214137209, 1320.1616973222003, 1346.5758286139865, 1398.3357904995128, 1644.9424270150548, 6023.5482338824595, 6609.834754131143, 6857.657117144147, 6884.173899132099, 6887.5178737488395, 6705.865882682343, 6785.1518560179975, 6787.287334829846, 6788.72845086196, 6802.625855577941, 1939.1467754188182, 1963.6072785442898, 1966.5476940303738, 1969.9704504432445, 1972.763268407786, 1944.805519448058, 1987.2547794577033, 1998.4104689116746, 2012.30575451469, 2014.7582290125206, 1969.379645411698, 1974.0919177178444, 1992.1931617694784, 1992.671209250472, 1999.4601457606439, 1962.0582120582128, 1979.5546002149545, 1983.0778687910047, 1983.8016198380192, 1984.9603007939832, 1964.695472201811, 1998.290606834582, 2011.8088781565727, 2017.6065667194903, 2021.1309137071053, 6552.705128269192, 6640.203175618908, 6640.867182656368, 6641.734330626769, 6699.363560461748, 3924.7645141291614, 4084.4894388201474, 4084.7957602120073, 4108.568600296986, 4114.423980642712, 2530.4053547416343, 2734.753872151516, 2781.8887244510197, 2786.1362977476842, 2800.957985630217, 838.9119142490073, 866.9306455483546, 879.3932186791094, 881.9064360193378, 907.260582625165, 8546.359023073232, 8627.30981521483, 8670.046294907619, 8677.522736249504, 8707.521086340248, 3389.389909816257, 3484.8780292689635, 3612.187257866959, 3617.2584620152807, 3627.966029681528, 7031.7890463286185, 7036.577805331696, 7041.4718896082995, 7044.330788575077, 7069.8939515907305, 4073.042834933788, 4075.612816782401, 4078.857239996586, 4081.6122468365456, 4082.7142100053306, 3354.9832250839077, 3465.28961562879, 3640.381135207021, 3732.0296722851713, 3775.5846856845724, 2937.2510009947327, 2947.985260073686, 3038.2252525606273, 3045.9847700761798, 3047.7866549341775, 925.4632313258294, 925.726910561386, 930.6184464369576, 931.6785708930408, 934.5140526926097, 828.5360198288978, 841.7516832534294, 845.678642115992, 852.6972924611673, 882.6381183714647, 4606.930896036562, 4655.464621568495, 4858.46556878743, 4872.269159626085, 4961.454240033593, 357.9534660494171, 363.5147078650032, 367.31862395256945, 371.2408125383597, 372.3799873211127, 3469.670381313771, 3476.3221171871746, 3499.807510586942, 3500.6674365935196, 3608.1520842601967, 7717.922820771832, 7992.720254791055, 8010.158933311918, 8051.63767630458, 8080.757577272691, 7941.880871786928, 7966.0, 7966.9601651992525, 7978.880316795253, 7983.361331093499, 6226.844328891814, 6336.429721325011, 6420.261669907927, 6440.677966101676, 6455.548111632234, 4755.1916174251155, 4775.6179505638775, 4845.709257444564, 4883.438404583519, 5020.322256495472, 7388.889166662612, 7420.925790742023, 7427.962860185665, 7494.925050749423, 7517.473776835569, 7285.890711639224, 7482.588457634883, 7543.396528277615, 7598.544087354777, 7612.7716168515035, 5155.587552995827, 5445.319335083114, 5511.58663100261, 5520.282363292907, 5521.668699878021, 5875.911861322169, 6137.84655383619, 6390.648514331757, 6413.743450261937, 6420.775272865428, 5955.583109182489, 5959.612625179349, 6053.4551890330085, 6139.26328840542, 6211.720472578835, 6053.541401084292, 6115.4190351916495, 6128.233970753656, 6140.846478838065, 6145.692715364304, 5058.140116180185, 5067.391912970467, 5084.1102807009365, 5085.110105731556, 5089.847304580869, 4192.392103145088, 4263.573642635712, 4314.525402205818, 4391.978040109907, 4479.328100784908, 4244.575542445731, 4266.786660667016, 4266.829326827016, 4315.978420107879, 4414.536473670219], "value": 3565.467090984771, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.5108560019965, 279.8628671950744, 288.50377350956353, 289.31721138114045, 290.0443040182598, 4505.864824055276, 4630.958034442248, 4671.766411679415, 4712.293156026598, 4757.0961517311725, 4421.0, 4559.498455169929, 4585.701929374588, 4605.194091034064, 4605.930911036337, 3642.763220390679, 3645.125169959204, 3652.579953305364, 3656.6526180012856, 3661.340958627446, 3441.260129072249, 3548.7515873888838, 3557.768745031565, 3635.2729454109153, 3664.43201303797, 3639.290338384016, 3641.4173732202853, 3645.325614761264, 3648.5986541480415, 3658.2317713280245, 3626.746127771057, 3631.2737452509473, 3632.7275454340765, 3633.909152271214, 3634.5093412389388, 3192.393445245396, 3206.8075915445147, 3207.1501052220947, 3216.099492142204, 3221.6617255188335, 4347.69566130371, 4483.50681425043, 4500.617447516965, 4519.412476378083, 4564.977175114103, 4091.6317531422314, 4104.42538044674, 4105.199486100211, 4115.176964607091, 4116.608922152391, 4790.80836766529, 4815.542523460265, 4833.734144622044, 4837.153498137847, 4844.5155484451625, 3391.932161356759, 3458.9827050864837, 3472.6006509251506, 3478.026152677229, 3480.460528618068, 5017.49825017499, 5030.471800460936, 5036.143855544567, 5040.445550989388, 5048.545630893201, 3542.6988705960284, 3548.6983606393746, 3552.946705799415, 3557.3952428087287, 3567.3935430976794, 3575.4458059000895, 3584.336897673939, 3596.4065929121925, 3603.8378272977257, 3627.3108109459117, 3826.043489127718, 3974.0328537374185, 4022.9798851006144, 4141.7722025288895, 4144.461220041375, 4779.3070004849105, 4781.163296423112, 4794.760261986887, 4815.638827087912, 4821.927671084936, 1094.9945250273697, 1107.8172101603307, 1145.4673576786834, 1171.2738102376582, 1171.9589814356457, 777.8133248020434, 798.1938242375243, 803.8070862992839, 803.8545073270566, 806.4234072638092, 4175.62419382257, 4178.456800615901, 4180.909545227386, 4188.392683061, 4189.476315460567, 4779.139754844092, 4780.450248221499, 4782.282657601388, 4806.327114204014, 4807.206810876166, 4164.375343698409, 4187.869275295653, 4201.39513501631, 4220.324748040299, 4253.0, 2465.1988103866315, 2565.1022142250436, 2577.9355516112246, 2580.7161212266637, 2582.4447743734813, 4531.682782205214, 4546.52238022644, 4589.623113066067, 4592.977035114803, 4612.423447069116, 4916.557509824133, 4917.631177661689, 4919.2129259318335, 4923.507649235119, 4957.405111386584, 4382.342648602735, 4515.616172625364, 4537.933585607379, 4563.612092972068, 4570.520095389937, 4772.3557319761385, 4795.256735206049, 4796.760161991817, 4812.278158276286, 4814.735189564608, 4731.597814185833, 4736.123817093849, 4736.668433209642, 4749.24012158053, 4752.6197904168275, 4475.328700694791, 4562.58936695699, 4574.222382195101, 4748.715077095385, 4793.657775822775, 3440.3291358184915, 3459.6540345965204, 3462.63642317553, 3466.584009918826, 3467.5145479633375, 5007.899842003067, 5012.674176178537, 5015.84952451427, 5034.924476132935, 5042.420121686053, 4680.695754775928, 4788.592969597623, 4791.526143546041, 4834.951650483591, 4880.926196236822, 4871.366722326216, 4872.317875497504, 4883.291922671122, 4886.438059623047, 4887.780049897834, 4783.6651434399255, 4796.448408432935, 4801.663883528119, 4808.591269742111, 4820.3492528509605, 4690.530946905282, 4856.648912250535, 4888.095702295087, 4888.169011268022, 4928.334674818997, 4800.783964721666, 4805.183118869871, 4807.831725889577, 4829.95170048295, 4839.733814640229], "value": 3614.3045799161264, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.8886000519907, 626.2109741725425, 680.3332733920757, 720.4992530191515, 728.9781306560803, 12303.200291981015, 13442.798358024613, 13508.0, 13512.391942362592, 13535.729285414285, 12497.750044999095, 12573.497060117585, 12590.055745819078, 12600.873991260085, 12604.747905041917, 617.364114961588, 633.5944995203074, 754.7735679296203, 759.7340930674247, 781.8553567589986, 770.3721467004374, 771.1132197972321, 773.4894969320221, 773.7678696391089, 774.0981756253985, 828.7348048624442, 831.4553967151495, 832.4256263178418, 832.7543374704477, 833.1210572845646, 661.7319985405918, 675.6689222281046, 805.1264378149715, 820.2658620534588, 828.9129641387658, 604.5798170271663, 605.1830029460193, 605.6759633596005, 606.0485038489574, 606.2543072021394, 12552.246865188026, 12621.116521843383, 12632.178908370926, 12645.494180232872, 12651.493940242379, 10970.286931349438, 10999.0, 11118.666440006813, 11194.888051119466, 11385.487653055632, 9378.155965963097, 9474.020911217305, 10306.845397319046, 10410.323328983592, 10507.94746026265, 3986.202759448122, 4000.3599424092295, 4028.8589899353383, 4084.2852500812537, 4236.68224883135, 42794.0, 43225.56774432247, 43740.3438948416, 43851.56148438506, 43894.34158487625, 9519.143277105093, 9566.0, 9648.662296819577, 9684.806303873884, 9704.70885873425, 16348.10085445312, 16354.754678679592, 16366.181690915644, 16407.917960410123, 16479.093649849372, 5859.794907178229, 5982.461578457873, 6150.538709596709, 6330.620162790247, 6389.968050159812, 3469.392856250146, 3527.6825085741893, 3562.59030211529, 3601.8559257629927, 3624.6919011883756, 2632.3682316244344, 2704.7971402144917, 2714.8914043438435, 2715.0361621624434, 2717.15768111882, 457.5653129526896, 458.14098565190267, 467.34804947099286, 467.64926305271047, 478.48084827961355, 469.471844175296, 528.7382745540905, 570.6661602962314, 586.3403670870271, 590.8345663214307, 7269.20038795732, 7339.0, 7608.505447146029, 7666.731664391719, 7875.921240787633, 490.4213028626255, 557.1420013179658, 602.4487593851577, 603.4237303375266, 604.353341924137, 3630.9273814523563, 3644.6105122236577, 3645.5078564394, 3648.2703459308245, 3666.981665091711, 69694.65152674305, 71332.2866771336, 72613.63693181501, 75419.39972172552, 76386.61806690932, 63085.68457157777, 67224.59692538432, 67883.66058169678, 68027.0, 69740.65129674319, 56113.719431402584, 56417.71791141018, 56878.862422751314, 56905.43094569084, 57044.714776426685, 7008.894866576903, 7066.399356054587, 7118.074650295428, 7285.486507155023, 7335.926640733738, 30753.0, 39822.60177398189, 40014.59985400225, 40603.0, 41496.792516037225, 42693.35959960665, 43642.0, 44855.551444485136, 46762.29856552222, 48486.5151348482, 9793.46135962529, 10316.27786054969, 10812.080973117374, 10839.945800270949, 11029.889701103208, 11490.195686302213, 11953.880461195276, 11976.940115299367, 12288.201266917622, 12606.369681516071, 10793.67618971432, 11214.719632009264, 11552.942235289105, 11638.88361116378, 11959.641210763692, 11196.216264861381, 11269.830952535554, 11459.885401145882, 11462.82805757931, 12016.519339226683, 10832.458377080957, 11414.543418263176, 11480.253783504046, 11826.822597661214, 12216.328101954477, 9135.680251191443, 9553.283503737108, 9661.082197191256, 9699.951500242736, 9756.60973561078, 9155.771105722144, 9450.0, 9673.903260967581, 9971.30200885931, 10276.948615257175], "value": 6049.3314394438, "unit": "score"}], "name": "dromaeo_css", "value": 5976.1124935529315, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 119.0, 117.0, 119.0, 117.0, 116.0, 119.0, 117.0, 116.0, 118.0], "value": 116.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 128.0, 128.0, 177.0, 134.0, 133.0, 128.0, 126.0, 158.0, 128.0], "value": 139.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 161.0, 162.0, 160.0, 161.0, 160.0, 161.0, 162.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 112.0, 78.0, 78.0, 77.0, 76.0, 107.0, 77.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 131.0, 82.0, 84.0, 83.0, 104.0, 83.0, 83.0, 123.0], "value": 94.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 63.0, 64.0, 64.0, 66.0, 63.0, 64.0, 64.0, 64.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 66.0, 66.0, 66.0, 66.0, 66.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 84.0, 93.0, 85.0, 84.0, 84.0, 84.0, 84.0, 85.0, 84.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 148.0, 140.0, 139.0, 148.0, 142.0, 149.0, 228.0, 154.0], "value": 154.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 185.0, 181.0, 179.0, 179.0, 181.0, 182.0, 181.0, 179.0, 180.0], "value": 181.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 70.0, 69.0, 69.0, 70.0, 74.0, 70.0, 68.0, 68.0], "value": 70.1, "unit": "score"}], "name": "kraken", "value": 1575.0999999999997, "alertThreshold": 2.0}]} 09:05:37 INFO - Return code: 0 09:05:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:05:37 INFO - # TBPL SUCCESS # 09:05:37 INFO - Running post-action listener: _resource_record_post_action 09:05:37 INFO - [mozharness: 2016-11-23 17:05:37.834750Z] Finished run-tests step (success) 09:05:37 INFO - Running post-run listener: _resource_record_post_run 09:05:37 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 401387520; Read time: 8; Write time: 357684 09:05:37 INFO - TinderboxPrint: CPU usage
13.1% 09:05:37 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 09:05:37 INFO - TinderboxPrint: I/O write bytes / time
401,387,520 / 357,684 09:05:37 INFO - TinderboxPrint: CPU idle
8,349.7 (86.9%) 09:05:37 INFO - TinderboxPrint: CPU user
1,208.1 (12.6%) 09:05:37 INFO - TinderboxPrint: Swap in / out
0 / 0 09:05:37 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110428160; Read time: 0; Write time: 89028 09:05:37 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 290959360; Read time: 0; Write time: 268656 09:05:38 INFO - Running post-run listener: _upload_blobber_files 09:05:38 INFO - Blob upload gear active. 09:05:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:05:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:05:38 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', 'Larch-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:05:38 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 Larch-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:05:38 INFO - (blobuploader) - INFO - Open directory for files ... 09:05:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:05:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:05:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:39 INFO - (blobuploader) - INFO - Done attempting. 09:05:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:05:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:05:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:40 INFO - (blobuploader) - INFO - Done attempting. 09:05:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:05:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:05:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:05:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:05:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:05:45 INFO - (blobuploader) - INFO - Done attempting. 09:05:45 INFO - (blobuploader) - INFO - Iteration through files over. 09:05:45 INFO - Return code: 0 09:05:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:05:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:05:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/9eb513a4b6df642c81a671b1de39d6966c12671d45f21864bf229ae00f69a522f13aa84e718c864494aac144267c90e58ef1c327ea4a46d47f3a5b37d5075efb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/8b018fe9a0aeb1b37d5ce62111c128278f0a96df7c517ecec3cccaa9a5ea77eae3cd0e4fd1884145b60ac0c8eb882dc066b882980ebdfbf5033b28e90d7cfdc2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/91943f14a3eb57420b212ab57acd28ca054752fbfb13dcd373bae0121f52d8bb870c070f7e5f6ce7a9238280130bbf056bb30d04a71c2cdb2ed027429a9e79a0"} 09:05:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:05:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:05:45 INFO - Contents: 09:05:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/9eb513a4b6df642c81a671b1de39d6966c12671d45f21864bf229ae00f69a522f13aa84e718c864494aac144267c90e58ef1c327ea4a46d47f3a5b37d5075efb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/8b018fe9a0aeb1b37d5ce62111c128278f0a96df7c517ecec3cccaa9a5ea77eae3cd0e4fd1884145b60ac0c8eb882dc066b882980ebdfbf5033b28e90d7cfdc2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/91943f14a3eb57420b212ab57acd28ca054752fbfb13dcd373bae0121f52d8bb870c070f7e5f6ce7a9238280130bbf056bb30d04a71c2cdb2ed027429a9e79a0"} 09:05:45 INFO - Running post-run listener: copy_logs_to_upload_dir 09:05:45 INFO - Copying logs to upload dir... 09:05:45 INFO - mkdir: /builds/slave/test/build/upload/logs 09:05:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.611571 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-11-23 09:05:44.932534) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 09:05:44.935806) ========= 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=c7c495d6f76fb52e1ad9f659000001da-1479919407.869859-850053679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/9eb513a4b6df642c81a671b1de39d6966c12671d45f21864bf229ae00f69a522f13aa84e718c864494aac144267c90e58ef1c327ea4a46d47f3a5b37d5075efb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/8b018fe9a0aeb1b37d5ce62111c128278f0a96df7c517ecec3cccaa9a5ea77eae3cd0e4fd1884145b60ac0c8eb882dc066b882980ebdfbf5033b28e90d7cfdc2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/91943f14a3eb57420b212ab57acd28ca054752fbfb13dcd373bae0121f52d8bb870c070f7e5f6ce7a9238280130bbf056bb30d04a71c2cdb2ed027429a9e79a0"} build_url:https://queue.taskcluster.net/v1/task/VAZjIBL9Qwq4oTKWZdt7mg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011935 build_url: 'https://queue.taskcluster.net/v1/task/VAZjIBL9Qwq4oTKWZdt7mg/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/9eb513a4b6df642c81a671b1de39d6966c12671d45f21864bf229ae00f69a522f13aa84e718c864494aac144267c90e58ef1c327ea4a46d47f3a5b37d5075efb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/8b018fe9a0aeb1b37d5ce62111c128278f0a96df7c517ecec3cccaa9a5ea77eae3cd0e4fd1884145b60ac0c8eb882dc066b882980ebdfbf5033b28e90d7cfdc2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/91943f14a3eb57420b212ab57acd28ca054752fbfb13dcd373bae0121f52d8bb870c070f7e5f6ce7a9238280130bbf056bb30d04a71c2cdb2ed027429a9e79a0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 09:05:44.961462) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 09:05:44.961822) ========= 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=c7c495d6f76fb52e1ad9f659000001da-1479919407.869859-850053679 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 09:05:45.045352) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 09:05:45.045673) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 09:05:45.045998) ========= ========= Total master_lag: 0.38 =========