builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-004 starttime: 1476894282.25 results: success (0) buildid: 20161019080022 builduid: 6bbf0919cb204ba69eba80c88c34cd4c revision: 8b2d92343bcb398075c909c587ec020286528059 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 09:24:42.247112) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-19 09:24:42.248209) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 09:24:42.248908) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-19 09:24:42.265893) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 09:24:42.266525) ========= 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=c6927cf182745ad25b1d38b9000001fe-1476894281.687842-338006364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-19 09:24:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 57.2K=0.2s 2016-10-19 09:24:42 (57.2 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.321611 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 09:24:42.606679) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 09:24:42.607399) ========= 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=c6927cf182745ad25b1d38b9000001fe-1476894281.687842-338006364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016434 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 09:24:42.662007) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 09:24:42.662825) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8b2d92343bcb398075c909c587ec020286528059 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 8b2d92343bcb398075c909c587ec020286528059 --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=c6927cf182745ad25b1d38b9000001fe-1476894281.687842-338006364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-19 09:24:42,864 truncating revision to first 12 chars 2016-10-19 09:24:42,865 Setting DEBUG logging. 2016-10-19 09:24:42,865 attempt 1/10 2016-10-19 09:24:42,865 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8b2d92343bcb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-19 09:24:43,180 unpacking tar archive at: mozilla-central-8b2d92343bcb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.629769 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 09:24:43.309990) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 09:24:43.310714) ========= script_repo_revision: 8b2d92343bcb398075c909c587ec020286528059 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-19 09:24:43.311766) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 09:24:43.312463) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-19 09:24:43.406505) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-19 09:24:43.406896) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=c6927cf182745ad25b1d38b9000001fe-1476894281.687842-338006364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:24:43 INFO - MultiFileLogger online at 20161019 09:24:43 in /builds/slave/test 09:24:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 09:24:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:24:43 INFO - {'append_to_log': False, 09:24:43 INFO - 'base_work_dir': '/builds/slave/test', 09:24:43 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 09:24:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:24:43 INFO - 'branch': 'Firefox-Non-PGO', 09:24:43 INFO - 'buildbot_json_path': 'buildprops.json', 09:24:43 INFO - 'config_files': ('talos/linux_config.py',), 09:24:43 INFO - 'default_actions': ('clobber', 09:24:43 INFO - 'read-buildbot-config', 09:24:43 INFO - 'download-and-extract', 09:24:43 INFO - 'populate-webroot', 09:24:43 INFO - 'create-virtualenv', 09:24:43 INFO - 'install', 09:24:43 INFO - 'run-tests'), 09:24:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:24:43 INFO - 'download_minidump_stackwalk': True, 09:24:43 INFO - 'download_symbols': 'ondemand', 09:24:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:24:43 INFO - 'tooltool.py': '/tools/tooltool.py', 09:24:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:24:43 INFO - '/tools/misc-python/virtualenv.py')}, 09:24:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:24:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:24:43 INFO - 'installer_path': 'installer.exe', 09:24:43 INFO - 'log_level': 'info', 09:24:43 INFO - 'log_name': 'talos', 09:24:43 INFO - 'log_to_console': True, 09:24:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:24:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:24:43 INFO - 'opt_config_files': (), 09:24:43 INFO - 'pip_index': False, 09:24:43 INFO - 'sps_profile': False, 09:24:43 INFO - 'sps_profile_interval': 0, 09:24:43 INFO - 'suite': 'dromaeojs', 09:24:43 INFO - 'system_bits': '32', 09:24:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:24:43 INFO - 'title': 'talos-linux64-ix-004', 09:24:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:24:43 INFO - 'use_talos_json': True, 09:24:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:24:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:24:43 INFO - 'work_dir': 'build'} 09:24:43 INFO - [mozharness: 2016-10-19 16:24:43.715646Z] Running clobber step. 09:24:43 INFO - Running pre-action listener: _resource_record_pre_action 09:24:43 INFO - Running main action method: clobber 09:24:43 INFO - rmtree: /builds/slave/test/build 09:24:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:24:44 INFO - Running post-action listener: _resource_record_post_action 09:24:44 INFO - [mozharness: 2016-10-19 16:24:44.175130Z] Finished clobber step (success) 09:24:44 INFO - [mozharness: 2016-10-19 16:24:44.175228Z] Running read-buildbot-config step. 09:24:44 INFO - Running pre-action listener: _resource_record_pre_action 09:24:44 INFO - Running main action method: read_buildbot_config 09:24:44 INFO - Using buildbot properties: 09:24:44 INFO - { 09:24:44 INFO - "project": "", 09:24:44 INFO - "product": "firefox", 09:24:44 INFO - "script_repo_revision": "production", 09:24:44 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 09:24:44 INFO - "repository": "", 09:24:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 09:24:44 INFO - "buildid": "20161019080022", 09:24:44 INFO - "pgo_build": "False", 09:24:44 INFO - "basedir": "/builds/slave/test", 09:24:44 INFO - "buildnumber": 259, 09:24:44 INFO - "slavename": "talos-linux64-ix-004", 09:24:44 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:24:44 INFO - "platform": "ubuntu64_hw", 09:24:44 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 09:24:44 INFO - "branch": "mozilla-central", 09:24:44 INFO - "repo_path": "mozilla-central", 09:24:44 INFO - "revision": "8b2d92343bcb398075c909c587ec020286528059", 09:24:44 INFO - "stage_platform": "linux64", 09:24:44 INFO - "builduid": "6bbf0919cb204ba69eba80c88c34cd4c", 09:24:44 INFO - "slavebuilddir": "test" 09:24:44 INFO - } 09:24:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/GOrq3dInTfOkx2b6oiqK5Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 09:24:44 INFO - Running post-action listener: _resource_record_post_action 09:24:44 INFO - [mozharness: 2016-10-19 16:24:44.177666Z] Finished read-buildbot-config step (success) 09:24:44 INFO - [mozharness: 2016-10-19 16:24:44.177751Z] Running download-and-extract step. 09:24:44 INFO - Running pre-action listener: _resource_record_pre_action 09:24:44 INFO - Running main action method: download_and_extract 09:24:44 INFO - mkdir: /builds/slave/test/build/tests 09:24:44 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')]} 09:24:44 INFO - trying https://queue.taskcluster.net/v1/task/GOrq3dInTfOkx2b6oiqK5Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:24:44 INFO - Downloading https://queue.taskcluster.net/v1/task/GOrq3dInTfOkx2b6oiqK5Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:24:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GOrq3dInTfOkx2b6oiqK5Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 09:24:44 INFO - Downloaded 1361 bytes. 09:24:44 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 09:24:44 INFO - Using the following test package requirements: 09:24:44 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:24:44 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:24:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:24:44 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:24:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:24:44 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:24:44 INFO - u'jsshell-linux-x86_64.zip'], 09:24:44 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:24:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:24:44 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 09:24:44 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:24:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:24:44 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:24:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:24:44 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:24:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:24:44 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 09:24:44 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:24:44 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:24:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GOrq3dInTfOkx2b6oiqK5Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:24:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GOrq3dInTfOkx2b6oiqK5Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:24:44 INFO - Fetch https://queue.taskcluster.net/v1/task/GOrq3dInTfOkx2b6oiqK5Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:24:45 INFO - Http code: 200 09:24:45 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 09:24:45 INFO - x-amz-cf-id: fBApOxDoTJo6YIucQD0pHCw570njnICC49HkjPjcUevJ0catEYDlpQ== 09:24:45 INFO - x-amz-version-id: QieNDYaGKVz.QtCX8Jq6KuzseXA6RVTr 09:24:45 INFO - Expected file size: 20541625 09:24:45 INFO - Obtained file size: 20541625 09:24:49 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 09:24:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GOrq3dInTfOkx2b6oiqK5Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 09:24:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GOrq3dInTfOkx2b6oiqK5Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 09:24:49 INFO - Fetch https://queue.taskcluster.net/v1/task/GOrq3dInTfOkx2b6oiqK5Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 09:24:50 INFO - Http code: 200 09:24:50 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 09:24:50 INFO - x-amz-cf-id: C-Fs8tPe_Rzmo7LDqLl8AVmpGf4UkukvUXgkWLz8VwlzZpdNsiMwXg== 09:24:50 INFO - x-amz-version-id: QieNDYaGKVz.QtCX8Jq6KuzseXA6RVTr 09:24:50 INFO - Expected file size: 20541625 09:24:50 INFO - Obtained file size: 20541625 09:24:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GOrq3dInTfOkx2b6oiqK5Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 09:24:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GOrq3dInTfOkx2b6oiqK5Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 09:24:54 INFO - Fetch https://queue.taskcluster.net/v1/task/GOrq3dInTfOkx2b6oiqK5Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 09:24:55 INFO - Http code: 200 09:24:55 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 09:24:55 INFO - x-amz-cf-id: RTdf7FNHTh4ThDaCBA-CDPgqYx2uUysGO16Hsoc2FnhH3bS97ZlqxQ== 09:24:55 INFO - x-amz-version-id: RiGFYu5qdWIPuDd5Ne6.DuTmUzpK3EBA 09:24:55 INFO - Expected file size: 14409028 09:24:55 INFO - Obtained file size: 14409028 09:24:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:24:55 INFO - trying https://queue.taskcluster.net/v1/task/GOrq3dInTfOkx2b6oiqK5Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:24:55 INFO - Downloading https://queue.taskcluster.net/v1/task/GOrq3dInTfOkx2b6oiqK5Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:24:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GOrq3dInTfOkx2b6oiqK5Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 09:24:57 INFO - Downloaded 55598718 bytes. 09:24:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GOrq3dInTfOkx2b6oiqK5Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:24:57 INFO - mkdir: /builds/slave/test/properties 09:24:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:24:57 INFO - Writing to file /builds/slave/test/properties/build_url 09:24:57 INFO - Contents: 09:24:57 INFO - build_url:https://queue.taskcluster.net/v1/task/GOrq3dInTfOkx2b6oiqK5Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 09:24:58 INFO - Running post-action listener: _resource_record_post_action 09:24:58 INFO - Running post-action listener: set_extra_try_arguments 09:24:58 INFO - [mozharness: 2016-10-19 16:24:58.241960Z] Finished download-and-extract step (success) 09:24:58 INFO - [mozharness: 2016-10-19 16:24:58.242185Z] Running populate-webroot step. 09:24:58 INFO - Running pre-action listener: _resource_record_pre_action 09:24:58 INFO - Running main action method: populate_webroot 09:24:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:24:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:24:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:24:58 INFO - '--tppagecycles', 09:24:58 INFO - '7'], 09:24:58 INFO - 'tests': ['tsvgm']}}, 09:24:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:24:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:24:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:24:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:24:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:24:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:24:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:58 INFO - 'talos_options': ['--disable-e10s'], 09:24:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:24:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:24:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:58 INFO - 'talos_options': ['--disable-e10s'], 09:24:58 INFO - 'tests': ['damp', 'tps']}, 09:24:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:58 INFO - 'tests': ['damp', 'tps']}, 09:24:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:24:58 INFO - 'tests': ['dromaeo_dom']}, 09:24:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:24:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:24:58 INFO - 'tests': ['basic_compositor_video']}, 09:24:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:24:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:24:58 INFO - 'tests': ['a11yr', 09:24:58 INFO - 'ts_paint', 09:24:58 INFO - 'tpaint', 09:24:58 INFO - 'sessionrestore', 09:24:58 INFO - 'sessionrestore_no_auto_restore', 09:24:58 INFO - 'tabpaint']}, 09:24:58 INFO - 'other-e10s': {'tests': ['a11yr', 09:24:58 INFO - 'ts_paint', 09:24:58 INFO - 'tpaint', 09:24:58 INFO - 'sessionrestore', 09:24:58 INFO - 'sessionrestore_no_auto_restore', 09:24:58 INFO - 'tabpaint']}, 09:24:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:24:58 INFO - 'ts_paint', 09:24:58 INFO - 'tpaint', 09:24:58 INFO - 'sessionrestore', 09:24:58 INFO - 'sessionrestore_no_auto_restore', 09:24:58 INFO - 'tabpaint']}, 09:24:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:24:58 INFO - 'ts_paint', 09:24:58 INFO - 'tpaint', 09:24:58 INFO - 'sessionrestore', 09:24:58 INFO - 'sessionrestore_no_auto_restore', 09:24:58 INFO - 'tabpaint']}, 09:24:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:24:58 INFO - 'tests': ['a11yr', 09:24:58 INFO - 'ts_paint', 09:24:58 INFO - 'tpaint', 09:24:58 INFO - 'sessionrestore', 09:24:58 INFO - 'sessionrestore_no_auto_restore', 09:24:58 INFO - 'tabpaint']}, 09:24:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:24:58 INFO - 'tests': ['a11yr', 09:24:58 INFO - 'ts_paint', 09:24:58 INFO - 'tpaint', 09:24:58 INFO - 'sessionrestore', 09:24:58 INFO - 'sessionrestore_no_auto_restore', 09:24:58 INFO - 'tabpaint']}, 09:24:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:24:58 INFO - 'tests': ['tsvgx', 09:24:58 INFO - 'tsvgr_opacity', 09:24:58 INFO - 'tart', 09:24:58 INFO - 'tscrollx', 09:24:58 INFO - 'cart']}, 09:24:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:24:58 INFO - 'tsvgr_opacity', 09:24:58 INFO - 'tart', 09:24:58 INFO - 'tscrollx', 09:24:58 INFO - 'cart']}, 09:24:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:58 INFO - 'talos_options': ['--disable-e10s'], 09:24:58 INFO - 'tests': ['tp5o']}, 09:24:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:58 INFO - 'tests': ['tp5o']}, 09:24:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:58 INFO - 'talos_options': ['--disable-e10s', 09:24:58 INFO - '--xperf_path', 09:24:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:24:58 INFO - 'tests': ['tp5n']}, 09:24:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:58 INFO - 'talos_options': ['--xperf_path', 09:24:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:24:58 INFO - 'tests': ['tp5n']}}, 09:24:58 INFO - 'talos.zip': {'path': '', 09:24:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:24:58 INFO - Running post-action listener: _resource_record_post_action 09:24:58 INFO - [mozharness: 2016-10-19 16:24:58.260584Z] Finished populate-webroot step (success) 09:24:58 INFO - [mozharness: 2016-10-19 16:24:58.260670Z] Running create-virtualenv step. 09:24:58 INFO - Running pre-action listener: _resource_record_pre_action 09:24:58 INFO - Running main action method: create_virtualenv 09:24:58 INFO - Creating virtualenv /builds/slave/test/build/venv 09:24:58 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 09:24:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:24:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:24:58 INFO - Using real prefix '/usr' 09:24:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:24:58 INFO - Installing distribute.............................................................................................................................................................................................done. 09:25:00 INFO - Installing pip.................done. 09:25:00 INFO - Return code: 0 09:25:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:25:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:25:01 INFO - Reading from file tmpfile_stdout 09:25:01 INFO - Output received: 09:25:01 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) 09:25:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:25:01 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')]} 09:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:01 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')]} 09:25:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:01 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 0x7f23d4dd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa6f60>, '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 0x1aa7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa81d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1476894281.687842-338006364', '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 09:25:01 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 09:25:01 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 09:25:01 INFO - Using env: {'DISPLAY': ':0', 09:25:01 INFO - 'HOME': '/home/cltbld', 09:25:01 INFO - 'LANG': 'en_US.UTF-8', 09:25:01 INFO - 'LANGUAGE': 'en_US:en', 09:25:01 INFO - 'LOGNAME': 'cltbld', 09:25:01 INFO - 'MAIL': '/var/mail/cltbld', 09:25:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:01 INFO - 'MOZ_NO_REMOTE': '1', 09:25:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:01 INFO - 'NO_EM_RESTART': '1', 09:25:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:01 INFO - 'PWD': '/builds/slave/test', 09:25:01 INFO - 'SHELL': '/bin/bash', 09:25:01 INFO - 'SHLVL': '1', 09:25:01 INFO - 'TERM': 'linux', 09:25:01 INFO - 'TMOUT': '86400', 09:25:01 INFO - 'USER': 'cltbld', 09:25:01 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1476894281.687842-338006364', 09:25:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:01 INFO - '_': '/tools/buildbot/bin/python'} 09:25:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:01 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 09:25:01 INFO - Cleaning up... 09:25:01 INFO - Return code: 0 09:25:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:25:01 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')]} 09:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:01 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')]} 09:25:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:01 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 0x7f23d4dd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa6f60>, '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 0x1aa7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa81d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1476894281.687842-338006364', '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 09:25:01 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 09:25:01 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 09:25:01 INFO - Using env: {'DISPLAY': ':0', 09:25:01 INFO - 'HOME': '/home/cltbld', 09:25:01 INFO - 'LANG': 'en_US.UTF-8', 09:25:01 INFO - 'LANGUAGE': 'en_US:en', 09:25:01 INFO - 'LOGNAME': 'cltbld', 09:25:01 INFO - 'MAIL': '/var/mail/cltbld', 09:25:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:01 INFO - 'MOZ_NO_REMOTE': '1', 09:25:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:01 INFO - 'NO_EM_RESTART': '1', 09:25:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:01 INFO - 'PWD': '/builds/slave/test', 09:25:01 INFO - 'SHELL': '/bin/bash', 09:25:01 INFO - 'SHLVL': '1', 09:25:01 INFO - 'TERM': 'linux', 09:25:01 INFO - 'TMOUT': '86400', 09:25:01 INFO - 'USER': 'cltbld', 09:25:01 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1476894281.687842-338006364', 09:25:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:01 INFO - '_': '/tools/buildbot/bin/python'} 09:25:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:01 INFO - Downloading/unpacking psutil>=3.1.1 09:25:01 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 09:25:01 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 09:25:01 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 09:25:01 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 09:25:01 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 09:25:01 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 09:25:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:25:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:25:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:25:03 INFO - Installing collected packages: psutil 09:25:03 INFO - Running setup.py install for psutil 09:25:03 INFO - building 'psutil._psutil_linux' extension 09:25:03 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 09:25:03 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 09:25:03 INFO - building 'psutil._psutil_posix' extension 09:25:03 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 09:25:03 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 09:25:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:25:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:25:04 INFO - Successfully installed psutil 09:25:04 INFO - Cleaning up... 09:25:04 INFO - Return code: 0 09:25:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:25:04 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')]} 09:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:04 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')]} 09:25:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:04 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 0x7f23d4dd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa6f60>, '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 0x1aa7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa81d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1476894281.687842-338006364', '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 09:25:04 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 09:25:04 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 09:25:04 INFO - Using env: {'DISPLAY': ':0', 09:25:04 INFO - 'HOME': '/home/cltbld', 09:25:04 INFO - 'LANG': 'en_US.UTF-8', 09:25:04 INFO - 'LANGUAGE': 'en_US:en', 09:25:04 INFO - 'LOGNAME': 'cltbld', 09:25:04 INFO - 'MAIL': '/var/mail/cltbld', 09:25:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:04 INFO - 'MOZ_NO_REMOTE': '1', 09:25:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:04 INFO - 'NO_EM_RESTART': '1', 09:25:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:04 INFO - 'PWD': '/builds/slave/test', 09:25:04 INFO - 'SHELL': '/bin/bash', 09:25:04 INFO - 'SHLVL': '1', 09:25:04 INFO - 'TERM': 'linux', 09:25:04 INFO - 'TMOUT': '86400', 09:25:04 INFO - 'USER': 'cltbld', 09:25:04 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1476894281.687842-338006364', 09:25:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:04 INFO - '_': '/tools/buildbot/bin/python'} 09:25:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:25:04 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 09:25:04 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 09:25:04 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 09:25:04 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 09:25:04 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 09:25:04 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 09:25:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:25:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:25:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:25:06 INFO - Installing collected packages: mozsystemmonitor 09:25:06 INFO - Running setup.py install for mozsystemmonitor 09:25:06 INFO - Successfully installed mozsystemmonitor 09:25:06 INFO - Cleaning up... 09:25:06 INFO - Return code: 0 09:25:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:06 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 0x7f23d4dd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa6f60>, '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 0x1aa7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa81d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1476894281.687842-338006364', '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 09:25:06 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 09:25:06 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 09:25:06 INFO - Using env: {'DISPLAY': ':0', 09:25:06 INFO - 'HOME': '/home/cltbld', 09:25:06 INFO - 'LANG': 'en_US.UTF-8', 09:25:06 INFO - 'LANGUAGE': 'en_US:en', 09:25:06 INFO - 'LOGNAME': 'cltbld', 09:25:06 INFO - 'MAIL': '/var/mail/cltbld', 09:25:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:06 INFO - 'MOZ_NO_REMOTE': '1', 09:25:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:06 INFO - 'NO_EM_RESTART': '1', 09:25:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:06 INFO - 'PWD': '/builds/slave/test', 09:25:06 INFO - 'SHELL': '/bin/bash', 09:25:06 INFO - 'SHLVL': '1', 09:25:06 INFO - 'TERM': 'linux', 09:25:06 INFO - 'TMOUT': '86400', 09:25:06 INFO - 'USER': 'cltbld', 09:25:06 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1476894281.687842-338006364', 09:25:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:06 INFO - '_': '/tools/buildbot/bin/python'} 09:25:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:06 INFO - Downloading/unpacking jsonschema==2.5.1 09:25:06 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 09:25:06 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 09:25:06 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 09:25:06 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 09:25:06 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 09:25:06 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 09:25:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:25:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:08 INFO - Downloading functools32-3.2.3-2.tar.gz 09:25:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:25:09 INFO - warning: no files found matching '*.txt' 09:25:09 INFO - no previously-included directories found matching 'build' 09:25:09 INFO - no previously-included directories found matching 'dist' 09:25:09 INFO - no previously-included directories found matching '.git*' 09:25:09 INFO - Installing collected packages: jsonschema, functools32 09:25:09 INFO - Running setup.py install for functools32 09:25:09 INFO - warning: no files found matching '*.txt' 09:25:09 INFO - no previously-included directories found matching 'build' 09:25:09 INFO - no previously-included directories found matching 'dist' 09:25:09 INFO - no previously-included directories found matching '.git*' 09:25:09 INFO - Successfully installed jsonschema functools32 09:25:09 INFO - Cleaning up... 09:25:09 INFO - Return code: 0 09:25:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:25:09 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')]} 09:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:09 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')]} 09:25:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:09 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 0x7f23d4dd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa6f60>, '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 0x1aa7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa81d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1476894281.687842-338006364', '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 09:25:09 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 09:25:09 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 09:25:09 INFO - Using env: {'DISPLAY': ':0', 09:25:09 INFO - 'HOME': '/home/cltbld', 09:25:09 INFO - 'LANG': 'en_US.UTF-8', 09:25:09 INFO - 'LANGUAGE': 'en_US:en', 09:25:09 INFO - 'LOGNAME': 'cltbld', 09:25:09 INFO - 'MAIL': '/var/mail/cltbld', 09:25:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:09 INFO - 'MOZ_NO_REMOTE': '1', 09:25:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:09 INFO - 'NO_EM_RESTART': '1', 09:25:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:09 INFO - 'PWD': '/builds/slave/test', 09:25:09 INFO - 'SHELL': '/bin/bash', 09:25:09 INFO - 'SHLVL': '1', 09:25:09 INFO - 'TERM': 'linux', 09:25:09 INFO - 'TMOUT': '86400', 09:25:09 INFO - 'USER': 'cltbld', 09:25:09 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1476894281.687842-338006364', 09:25:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:09 INFO - '_': '/tools/buildbot/bin/python'} 09:25:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:25:09 INFO - Cleaning up... 09:25:09 INFO - Return code: 0 09:25:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:25:09 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')]} 09:25:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:09 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')]} 09:25:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:09 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 0x7f23d4dd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa6f60>, '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 0x1aa7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa81d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1476894281.687842-338006364', '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 09:25:09 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 09:25:09 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 09:25:09 INFO - Using env: {'DISPLAY': ':0', 09:25:09 INFO - 'HOME': '/home/cltbld', 09:25:09 INFO - 'LANG': 'en_US.UTF-8', 09:25:09 INFO - 'LANGUAGE': 'en_US:en', 09:25:09 INFO - 'LOGNAME': 'cltbld', 09:25:09 INFO - 'MAIL': '/var/mail/cltbld', 09:25:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:09 INFO - 'MOZ_NO_REMOTE': '1', 09:25:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:09 INFO - 'NO_EM_RESTART': '1', 09:25:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:09 INFO - 'PWD': '/builds/slave/test', 09:25:09 INFO - 'SHELL': '/bin/bash', 09:25:09 INFO - 'SHLVL': '1', 09:25:09 INFO - 'TERM': 'linux', 09:25:09 INFO - 'TMOUT': '86400', 09:25:09 INFO - 'USER': 'cltbld', 09:25:09 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1476894281.687842-338006364', 09:25:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:09 INFO - '_': '/tools/buildbot/bin/python'} 09:25:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:09 INFO - Downloading/unpacking blobuploader==1.2.4 09:25:09 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 09:25:09 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 09:25:09 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 09:25:09 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 09:25:09 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 09:25:09 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 09:25:11 INFO - Downloading blobuploader-1.2.4.tar.gz 09:25:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:25:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:25:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:25:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:12 INFO - Downloading docopt-0.6.1.tar.gz 09:25:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:25:12 INFO - Installing collected packages: blobuploader, requests, docopt 09:25:12 INFO - Running setup.py install for blobuploader 09:25:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:25:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:25:12 INFO - Running setup.py install for requests 09:25:12 INFO - Running setup.py install for docopt 09:25:12 INFO - Successfully installed blobuploader requests docopt 09:25:12 INFO - Cleaning up... 09:25:13 INFO - Return code: 0 09:25:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:25: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')]} 09:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25: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')]} 09:25:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:13 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 0x7f23d4dd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa6f60>, '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 0x1aa7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa81d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1476894281.687842-338006364', '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 09:25:13 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 09:25:13 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 09:25:13 INFO - Using env: {'DISPLAY': ':0', 09:25:13 INFO - 'HOME': '/home/cltbld', 09:25:13 INFO - 'LANG': 'en_US.UTF-8', 09:25:13 INFO - 'LANGUAGE': 'en_US:en', 09:25:13 INFO - 'LOGNAME': 'cltbld', 09:25:13 INFO - 'MAIL': '/var/mail/cltbld', 09:25:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:13 INFO - 'MOZ_NO_REMOTE': '1', 09:25:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:13 INFO - 'NO_EM_RESTART': '1', 09:25:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:13 INFO - 'PWD': '/builds/slave/test', 09:25:13 INFO - 'SHELL': '/bin/bash', 09:25:13 INFO - 'SHLVL': '1', 09:25:13 INFO - 'TERM': 'linux', 09:25:13 INFO - 'TMOUT': '86400', 09:25:13 INFO - 'USER': 'cltbld', 09:25:13 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1476894281.687842-338006364', 09:25:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:13 INFO - '_': '/tools/buildbot/bin/python'} 09:25:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:25:13 INFO - Running setup.py (path:/tmp/pip-TWs01n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:25:13 INFO - Running setup.py (path:/tmp/pip-rKmP6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:25:13 INFO - Running setup.py (path:/tmp/pip-qQC57F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:25:13 INFO - Running setup.py (path:/tmp/pip-r8KrtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:25:13 INFO - Running setup.py (path:/tmp/pip-U1q9VX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:25:13 INFO - Running setup.py (path:/tmp/pip-l_eLuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:25:13 INFO - Running setup.py (path:/tmp/pip-P8psqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:25:13 INFO - Running setup.py (path:/tmp/pip-H9m3Mf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:25:13 INFO - Running setup.py (path:/tmp/pip-BBjJgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:25:13 INFO - Running setup.py (path:/tmp/pip-H6oCKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:25:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:25:13 INFO - Running setup.py (path:/tmp/pip-hsT0dL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:25:14 INFO - Running setup.py (path:/tmp/pip-f90RFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:25:14 INFO - Running setup.py (path:/tmp/pip-jIxMEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:25:14 INFO - Running setup.py (path:/tmp/pip-MvIU0r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:14 INFO - Running setup.py (path:/tmp/pip-jpCZxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:25:14 INFO - Running setup.py (path:/tmp/pip-ZHQxBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:25:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:25:14 INFO - Running setup.py (path:/tmp/pip-64eLUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:25:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:25:14 INFO - Running setup.py install for manifestparser 09:25:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:25:14 INFO - Running setup.py install for mozcrash 09:25:14 INFO - Running setup.py install for mozdebug 09:25:14 INFO - Running setup.py install for mozdevice 09:25:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:25:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:25:14 INFO - Running setup.py install for mozfile 09:25:14 INFO - Running setup.py install for mozhttpd 09:25:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:25:15 INFO - Running setup.py install for mozinfo 09:25:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:25:15 INFO - Running setup.py install for mozInstall 09:25:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:25:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:25:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:25:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:25:15 INFO - Running setup.py install for mozleak 09:25:15 INFO - Running setup.py install for mozlog 09:25:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:25:15 INFO - Running setup.py install for moznetwork 09:25:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:25:15 INFO - Running setup.py install for mozprocess 09:25:15 INFO - Running setup.py install for mozprofile 09:25:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:25:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:25:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:25:15 INFO - Running setup.py install for mozrunner 09:25:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:25:15 INFO - Running setup.py install for mozscreenshot 09:25:16 INFO - Running setup.py install for moztest 09:25:16 INFO - Running setup.py install for mozversion 09:25:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:25:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:25:16 INFO - Cleaning up... 09:25:16 INFO - Return code: 0 09:25:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:25: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')]} 09:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25: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')]} 09:25:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:16 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 0x7f23d4dd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa6f60>, '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 0x1aa7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa81d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1476894281.687842-338006364', '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 09:25:16 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 09:25:16 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 09:25:16 INFO - Using env: {'DISPLAY': ':0', 09:25:16 INFO - 'HOME': '/home/cltbld', 09:25:16 INFO - 'LANG': 'en_US.UTF-8', 09:25:16 INFO - 'LANGUAGE': 'en_US:en', 09:25:16 INFO - 'LOGNAME': 'cltbld', 09:25:16 INFO - 'MAIL': '/var/mail/cltbld', 09:25:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:16 INFO - 'MOZ_NO_REMOTE': '1', 09:25:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:16 INFO - 'NO_EM_RESTART': '1', 09:25:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:16 INFO - 'PWD': '/builds/slave/test', 09:25:16 INFO - 'SHELL': '/bin/bash', 09:25:16 INFO - 'SHLVL': '1', 09:25:16 INFO - 'TERM': 'linux', 09:25:16 INFO - 'TMOUT': '86400', 09:25:16 INFO - 'USER': 'cltbld', 09:25:16 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1476894281.687842-338006364', 09:25:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:16 INFO - '_': '/tools/buildbot/bin/python'} 09:25:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:25:16 INFO - Running setup.py (path:/tmp/pip-5gtbMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:25:16 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)) 09:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:25:16 INFO - Running setup.py (path:/tmp/pip-LfagiI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:25:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:25:16 INFO - Running setup.py (path:/tmp/pip-6lo1uh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:25:16 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)) 09:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:25:16 INFO - Running setup.py (path:/tmp/pip-qCAs4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:25:16 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)) 09:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:25:16 INFO - Running setup.py (path:/tmp/pip-w39ITN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:25:16 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)) 09:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:25:16 INFO - Running setup.py (path:/tmp/pip-4IWhce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:25:16 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)) 09:25:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:25:16 INFO - Running setup.py (path:/tmp/pip-1_kqYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:25:17 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)) 09:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:25:17 INFO - Running setup.py (path:/tmp/pip-26pTnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:25:17 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)) 09:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:25:17 INFO - Running setup.py (path:/tmp/pip-u0Kin0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:25:17 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)) 09:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:25:17 INFO - Running setup.py (path:/tmp/pip-ErvDfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:25:17 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)) 09:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:25:17 INFO - Running setup.py (path:/tmp/pip-wJIg2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:25:17 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)) 09:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:25:17 INFO - Running setup.py (path:/tmp/pip-xGGUgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:25:17 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)) 09:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:25:17 INFO - Running setup.py (path:/tmp/pip-jFRkU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:25:17 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)) 09:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:25:17 INFO - Running setup.py (path:/tmp/pip-OTLY6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:25:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:17 INFO - Running setup.py (path:/tmp/pip-QJ3Bsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:17 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)) 09:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:25:17 INFO - Running setup.py (path:/tmp/pip-DOuQKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:25:17 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)) 09:25:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:25:17 INFO - Running setup.py (path:/tmp/pip-r87HEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:25:17 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)) 09:25:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:25:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:25:17 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)) 09:25:17 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)) 09:25:17 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)) 09:25:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:25:17 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 09:25:17 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 09:25:17 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 09:25:17 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 09:25:17 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 09:25:17 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 09:25:19 INFO - Downloading blessings-1.6.tar.gz 09:25:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:25:19 INFO - Installing collected packages: blessings 09:25:19 INFO - Running setup.py install for blessings 09:25:19 INFO - Successfully installed blessings 09:25:19 INFO - Cleaning up... 09:25:19 INFO - Return code: 0 09:25:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:25:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:25:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:25:20 INFO - Reading from file tmpfile_stdout 09:25:20 INFO - Current package versions: 09:25:20 INFO - argparse == 1.2.1 09:25:20 INFO - blessings == 1.6 09:25:20 INFO - blobuploader == 1.2.4 09:25:20 INFO - docopt == 0.6.1 09:25:20 INFO - functools32 == 3.2.3-2 09:25:20 INFO - jsonschema == 2.5.1 09:25:20 INFO - manifestparser == 1.1 09:25:20 INFO - mozInstall == 1.12 09:25:20 INFO - mozcrash == 0.17 09:25:20 INFO - mozdebug == 0.1 09:25:20 INFO - mozdevice == 0.48 09:25:20 INFO - mozfile == 1.2 09:25:20 INFO - mozhttpd == 0.7 09:25:20 INFO - mozinfo == 0.9 09:25:20 INFO - mozleak == 0.1 09:25:20 INFO - mozlog == 3.4 09:25:20 INFO - moznetwork == 0.27 09:25:20 INFO - mozprocess == 0.23 09:25:20 INFO - mozprofile == 0.28 09:25:20 INFO - mozrunner == 6.12 09:25:20 INFO - mozscreenshot == 0.1 09:25:20 INFO - mozsystemmonitor == 0.3 09:25:20 INFO - moztest == 0.7 09:25:20 INFO - mozversion == 1.4 09:25:20 INFO - psutil == 3.1.1 09:25:20 INFO - requests == 1.2.3 09:25:20 INFO - wsgiref == 0.1.2 09:25:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:25:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:20 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 0x7f23d4dd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa6f60>, '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 0x1aa7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa81d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1476894281.687842-338006364', '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 09:25:20 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 09:25:20 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 09:25:20 INFO - Using env: {'DISPLAY': ':0', 09:25:20 INFO - 'HOME': '/home/cltbld', 09:25:20 INFO - 'LANG': 'en_US.UTF-8', 09:25:20 INFO - 'LANGUAGE': 'en_US:en', 09:25:20 INFO - 'LOGNAME': 'cltbld', 09:25:20 INFO - 'MAIL': '/var/mail/cltbld', 09:25:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:20 INFO - 'MOZ_NO_REMOTE': '1', 09:25:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:20 INFO - 'NO_EM_RESTART': '1', 09:25:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:20 INFO - 'PWD': '/builds/slave/test', 09:25:20 INFO - 'SHELL': '/bin/bash', 09:25:20 INFO - 'SHLVL': '1', 09:25:20 INFO - 'TERM': 'linux', 09:25:20 INFO - 'TMOUT': '86400', 09:25:20 INFO - 'USER': 'cltbld', 09:25:20 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1476894281.687842-338006364', 09:25:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:20 INFO - '_': '/tools/buildbot/bin/python'} 09:25:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:20 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)) 09:25:20 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)) 09:25:20 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)) 09:25:20 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)) 09:25:20 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)) 09:25:20 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)) 09:25:20 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)) 09:25:20 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)) 09:25:20 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)) 09:25:20 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)) 09:25:20 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)) 09:25:20 INFO - Cleaning up... 09:25:20 INFO - Return code: 0 09:25:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:25:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:20 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 0x7f23d4dd2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19dc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa9ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aa6f60>, '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 0x1aa7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa81d0>, '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': 'c6927cf182745ad25b1d38b9000001fe-1476894281.687842-338006364', '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 09:25:20 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 09:25:20 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 09:25:20 INFO - Using env: {'DISPLAY': ':0', 09:25:20 INFO - 'HOME': '/home/cltbld', 09:25:20 INFO - 'LANG': 'en_US.UTF-8', 09:25:20 INFO - 'LANGUAGE': 'en_US:en', 09:25:20 INFO - 'LOGNAME': 'cltbld', 09:25:20 INFO - 'MAIL': '/var/mail/cltbld', 09:25:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:20 INFO - 'MOZ_NO_REMOTE': '1', 09:25:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:20 INFO - 'NO_EM_RESTART': '1', 09:25:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:20 INFO - 'PWD': '/builds/slave/test', 09:25:20 INFO - 'SHELL': '/bin/bash', 09:25:20 INFO - 'SHLVL': '1', 09:25:20 INFO - 'TERM': 'linux', 09:25:20 INFO - 'TMOUT': '86400', 09:25:20 INFO - 'USER': 'cltbld', 09:25:20 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1476894281.687842-338006364', 09:25:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:20 INFO - '_': '/tools/buildbot/bin/python'} 09:25:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:25:20 INFO - Cleaning up... 09:25:20 INFO - Return code: 0 09:25:20 INFO - Running post-action listener: _resource_record_post_action 09:25:20 INFO - Running post-action listener: _start_resource_monitoring 09:25:20 INFO - Starting resource monitoring. 09:25:20 INFO - [mozharness: 2016-10-19 16:25:20.617246Z] Finished create-virtualenv step (success) 09:25:20 INFO - [mozharness: 2016-10-19 16:25:20.617744Z] Running install step. 09:25:20 INFO - Running pre-action listener: _resource_record_pre_action 09:25:20 INFO - Running main action method: install 09:25:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:25:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:25:20 INFO - Reading from file tmpfile_stdout 09:25:20 INFO - Detecting whether we're running mozinstall >=1.0... 09:25:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:25:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:25:20 INFO - Reading from file tmpfile_stdout 09:25:20 INFO - Output received: 09:25:20 INFO - Usage: mozinstall [options] installer 09:25:20 INFO - Options: 09:25:20 INFO - -h, --help show this help message and exit 09:25:20 INFO - -d DEST, --destination=DEST 09:25:20 INFO - Directory to install application into. [default: 09:25:20 INFO - "/builds/slave/test"] 09:25:20 INFO - --app=APP Application being installed. [default: firefox] 09:25:20 INFO - mkdir: /builds/slave/test/build/application 09:25:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:25:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 09:25:36 INFO - Reading from file tmpfile_stdout 09:25:36 INFO - Output received: 09:25:36 INFO - /builds/slave/test/build/application/firefox/firefox 09:25:36 INFO - Running post-action listener: _resource_record_post_action 09:25:36 INFO - [mozharness: 2016-10-19 16:25:36.976595Z] Finished install step (success) 09:25:36 INFO - [mozharness: 2016-10-19 16:25:36.976838Z] Running run-tests step. 09:25:36 INFO - Running pre-action listener: _resource_record_pre_action 09:25:36 INFO - Running main action method: run_tests 09:25:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:25:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:25:36 INFO - Python 2.7.3 09:25:36 INFO - Return code: 0 09:25:36 INFO - grabbing minidump binary from tooltool 09:25:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:25:36 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 0x1aa6f60>, '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 0x1aa7d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1aa81d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:25:36 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 09:25:36 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 09:25:36 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 09:25:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:25:37 INFO - Return code: 0 09:25:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:25:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:25:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:25:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:25:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:25:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GOrq3dInTfOkx2b6oiqK5Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 09:25:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GOrq3dInTfOkx2b6oiqK5Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-004 --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 09:25:37 INFO - Using env: {'DISPLAY': ':0', 09:25:37 INFO - 'HOME': '/home/cltbld', 09:25:37 INFO - 'LANG': 'en_US.UTF-8', 09:25:37 INFO - 'LANGUAGE': 'en_US:en', 09:25:37 INFO - 'LOGNAME': 'cltbld', 09:25:37 INFO - 'MAIL': '/var/mail/cltbld', 09:25:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:25:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:25:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:37 INFO - 'MOZ_NO_REMOTE': '1', 09:25:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:25:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:37 INFO - 'NO_EM_RESTART': '1', 09:25:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:37 INFO - 'PWD': '/builds/slave/test', 09:25:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:25:37 INFO - 'SHELL': '/bin/bash', 09:25:37 INFO - 'SHLVL': '1', 09:25:37 INFO - 'TERM': 'linux', 09:25:37 INFO - 'TMOUT': '86400', 09:25:37 INFO - 'USER': 'cltbld', 09:25:37 INFO - 'XDG_SESSION_COOKIE': 'c6927cf182745ad25b1d38b9000001fe-1476894281.687842-338006364', 09:25:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:37 INFO - '_': '/tools/buildbot/bin/python'} 09:25:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GOrq3dInTfOkx2b6oiqK5Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-004', '--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 09:25:37 INFO - mozversion application_buildid: 20161019080022 09:25:37 INFO - mozversion application_changeset: 8b2d92343bcb398075c909c587ec020286528059 09:25:37 INFO - mozversion application_display_name: Nightly 09:25:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:25:37 INFO - mozversion application_name: Firefox 09:25:37 INFO - mozversion application_remotingname: firefox 09:25:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:25:37 INFO - mozversion application_vendor: Mozilla 09:25:37 INFO - mozversion application_version: 52.0a1 09:25:37 INFO - mozversion platform_buildid: 20161019080022 09:25:37 INFO - mozversion platform_changeset: 8b2d92343bcb398075c909c587ec020286528059 09:25:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:25:37 INFO - mozversion platform_version: 52.0a1 09:25:37 INFO - using testdate: 1476894337 09:25:37 INFO - actual date: 1476894337 09:25:37 INFO - starting webserver on 'localhost:43848' 09:25:37 INFO - SUITE-START | Running 2 tests 09:25:37 INFO - TEST-START | dromaeo_css 09:25:37 INFO - operating with platform_type : linux_ 09:25:37 INFO - Initialising browser for dromaeo_css test... 09:25:37 INFO - TEST-INFO | started process 15795 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvJCuEF/profile http://localhost:43848/getInfo.html) 09:25:41 INFO - PROCESS | 15795 | __metrics Screen width/height:1600/1200 09:25:41 INFO - PROCESS | 15795 | colorDepth:24 09:25:41 INFO - PROCESS | 15795 | Browser inner width/height: 1024/697 09:25:41 INFO - PROCESS | 15795 | __metrics 09:25:42 INFO - PROCESS | 15795 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:25:42 INFO - PROCESS | 15795 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:25:42 INFO - PROCESS | 15795 | console.error: PushService: 09:25:42 INFO - PROCESS | 15795 | stateChangeProcessEnqueue: Error transitioning state 09:25:42 INFO - PROCESS | 15795 | UnknownError 09:25:43 INFO - TEST-INFO | 15795: exit 0 09:25:43 INFO - Browser initialized. 09:25:43 INFO - Running cycle 1/1 for dromaeo_css test... 09:25:43 INFO - TEST-INFO | started process 15877 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvJCuEF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:25:55 INFO - PROCESS | 15877 | RSS: Main: 173387776 09:25:55 INFO - PROCESS | 15877 | 09:26:47 INFO - PROCESS | 15877 | 1476894407372 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] 09:29:01 INFO - PROCESS | 15877 | Cycle 1(1): loaded http://localhost:43848/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43848/tests/dromaeo/cssquery-ext.html) 09:29:02 INFO - PROCESS | 15877 | RSS: Main: 293851136 09:29:02 INFO - PROCESS | 15877 | 09:32:05 INFO - PROCESS | 15877 | Cycle 1(1): loaded http://localhost:43848/tests/dromaeo/cssquery-ext.html (next: http://localhost:43848/tests/dromaeo/cssquery-jquery.html) 09:32:05 INFO - PROCESS | 15877 | RSS: Main: 276430848 09:32:05 INFO - PROCESS | 15877 | 09:35:07 INFO - PROCESS | 15877 | Cycle 1(1): loaded http://localhost:43848/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43848/tests/dromaeo/cssquery-mootools.html) 09:35:08 INFO - PROCESS | 15877 | RSS: Main: 219623424 09:35:08 INFO - PROCESS | 15877 | 09:38:10 INFO - PROCESS | 15877 | Cycle 1(1): loaded http://localhost:43848/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43848/tests/dromaeo/cssquery-prototype.html) 09:38:11 INFO - PROCESS | 15877 | RSS: Main: 231108608 09:38:11 INFO - PROCESS | 15877 | 09:41:14 INFO - PROCESS | 15877 | Cycle 1(1): loaded http://localhost:43848/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43848/tests/dromaeo/cssquery-yui.html) 09:41:15 INFO - PROCESS | 15877 | RSS: Main: 218750976 09:41:15 INFO - PROCESS | 15877 | 09:44:18 INFO - PROCESS | 15877 | Cycle 1(1): loaded http://localhost:43848/tests/dromaeo/cssquery-yui.html (next: http://localhost:43848/tests/dromaeo/cssquery-dojo.html) 09:44:18 INFO - PROCESS | 15877 | RSS: Main: 305385472 09:44:18 INFO - PROCESS | 15877 | 09:44:18 INFO - PROCESS | 15877 | __start_tp_report 09:44:18 INFO - PROCESS | 15877 | _x_x_mozilla_page_load 09:44:18 INFO - PROCESS | 15877 | _x_x_mozilla_page_load_details 09:44:18 INFO - PROCESS | 15877 | |i|pagename|runs| 09:44:18 INFO - PROCESS | 15877 | |0;dojo.html;2578.059008461911;2612.3469132716823;2649.337665583604;2649.8012649051316;2665.0405853892594;4453.755043472608;4475.373447717322;4613.1235065337605;4613.561711637398;4625.560571745687;4528.366028755977;4532.818687252506;4547.363369128317;4548.385967894334;4558.498565157838;4153.501579810427;4172.061286210609;4183.769892655902;4198.20234155511;4241.448611680493;4278.080212754257;4281.935770963438;4308.504521979981;4309.267424537836;4309.741415515079;4214.157168566284;4217.177650358181;4229.661627069842;4291.635211007053;4309.655227581786;4287.914241715148;4304.268274393361;4309;4310.482742070972;4364.716293440916;4081.265372232997;4104.753714777123;4120.278951183561;4222.535521092677;4267.4025636410925;4533.818647254139;4590.403247577793;4591.380163677894;4593.770311484446;4597.195490789132;4904.386951631046;4909.631777616693;4917.680350777224;4935.703857768545;4997.150484417658;4847.151748444044;4905.656604037718;4924.285978533128;4947.257911313296;4977.054359671651;4605.355250264965;4619.769011549442;4655.976720116446;4672.462666793294;4681.087187998308;5040.773165207501;5061.8734531637;5062.594992400599;5065.214891691794;5123.3339665843205;4854.538818812278;4858.975705121452;4862.756862156878;4863.708177509361;4920.72935988524;4856.635752318591;4898.926516102261;4908.239222920453;4963.205887058053;4972.577330926912;4850.1997170466475;4854.80580776765;4890.095332363524;4899.216125419915;4918.6556941014505;4781.760911954389;4792.209285467929;4806.639502037361;4849.442314133849;4871.8294859679745;4011.5787842276723;4047.3321901886447;4085.0400155963325;4091.5499295077516;4097.1191193893455;3580.6598373154507;3583.9820800895827;3600.261946301002;3629.6007439181667;3640.927181456356;4216.536181020086;4254.808533615995;4256.6807489438415;4263.253930562139;4319.265724826787;4918.43438004634;4925.162722337212;4964.67729597575;4973.204287314013;5030.798768049311;4319.352097185384;4326.524082350938;4327.17783621111;4335.913281734411;4385.210662080793;4231.899706076442;4364.694471387036;4367.868963931087;4368.191884501377;4412.029353542215;4598.356230127718;4671.369365135663;4678.789454474489;4704.294355846513;4719.268513380432;4924.975375123101;4957.801687932442;4965.602751779921;4968.105740966661;5018.1218286800395;4723.267893476516;4724.858254252378;4728.71627702339;4773.427188737373;4776.068666609977;4677.508861569486;4714.269288260325;4803.255495398219;4805.543473370024;4897.7795999180835;4897.706137631753;4901.044296362318;4903.828366007173;4942.8764280893265;4961.7271050092595;4771.880702982453;4773.307870358848;4783.7129772213775;4785.234362502122;4833.419989601271;4656.998745269783;4676.976615116902;4698.7415692137265;4780.95219047805;4835.685680430761;4641.605463535638;4671.392718946515;4694.554017368481;4732.077244937204;4734;4782.33047373361;4816.229403295456;4819.7108173509705;4869.147899117711;4870.756462176806;4727.858164255078;4733.573978341966;4737.028909073701;4737.66836321468;4805.7597120144555 09:44:18 INFO - PROCESS | 15877 | |1;ext.html;561.6798424897809;566.0914232656586;566.9631473954195;569.9430056994298;571.9761626688227;26667.73332266677;27218.591721124198;41176.38235426467;42292.57707422925;42372.364414533804;38754.224915501676;39160.80419597905;39175;39198.41202381966;39243.60756392435;7345.595992220412;7489.662965166581;7493.0259066321305;7498.2126876677985;7500.212477689845;7459.291367320096;7547.13207981081;7548.20743821899;7551.546907185559;7554.357879580215;7531.209223031585;7551.282628150317;7551.660175292098;7552.622368881562;7593.2027137150635;7534.547927124363;7609.885851712229;7613.162552119318;7617.961910190469;7621.771346859603;7531.849363012709;7598.848023039508;7599.696012159507;7600.239976002411;7605.277498637621;37360.81319593412;37615.435768463496;37712.245755085016;37720.62279377199;37766.43350349747;2866.498362786525;2917.766578673701;2932.6920673329205;2989.7309242168094;3031.348260124084;27376.726232737816;28191.57712634312;28350.432991340058;29070.563941540895;29638;3430.8627654893776;3474.4961980512685;3489.1277180704824;3503.649635036476;3570.321638888603;241704;242136.78931605406;242912;243521;243723;27391.17826465209;27814.860925695648;49505;49893.25160122601;49899.25151122736;32676.509852352232;32948.50577241343;32954;32978.505322420184;33012.50481242783;13455.86544134546;13623.046386752832;13624.455021799215;13651.931740341235;13654.112482688792;10449.216308776871;10528.420936848546;10536.683899483029;10538.947305263424;10540.789184216273;7538.434617403716;7644.923550764421;7661.080670319598;7665.770026899202;7711.113221979432;3021.259791351133;3075.969240307613;3116.158637167952;3126.03093041158;3135.5296705494357;841.6212704283097;841.7180244617999;882.9426087304305;968.5544649461186;975.2588033094758;25762.87118564395;25877.482450351265;26364.736352636228;26378.604320935203;27212.183634490997;737.7196665267164;903.8282726281985;932.3706498113746;978.848278516831;1005.3113617172261;13795.677838720123;14452.566423007327;14762.97359041394;14814.925925370304;14815.40738370453;367857;370047;370189;370309;372837;48665.513344866806;48742;49136.508634913196;49157.50842491529;49551;1057.1014637558014;1076.617800680747;1132.796096702585;1163.959261425863;1177.31127290536;26842.32894177661;27484.58773118445;28737.425251494435;28880.2779930495;29082.27294317659;40344.596554034084;40887.795561022;40921.38617920793;41046;41097.38353924753;282444;285681;286276;286542;287060;37800.43299350457;38223;38522.80738596289;39159;41680.58319416767;38422.80788596151;39514.2097158061;41913;42231.366529501465;43071.78464107659;36145.45781813222;36190.276194476486;36329;36618.633813662585;37033.44449833308;35603.46594801132;36116.63883361133;36149.638503614624;37225.81387093047;37593.43609845909;36089.81955090313;36190.63809361873;36377.636223637426;36739.44890826693;36954.6304536962;30471.542926855673;33157.83421082879;33301.50047749237;33401.33197336088;33936.660633394335;24802.627960580245;25016.749832501442;25281.62077568801;25604.23187304384;25854.612180816926 09:44:18 INFO - PROCESS | 15877 | |2;jquery.html;340.4365774642967;350.16660348370874;355.1795352735182;357.3460567162094;380.21675348781514;12160.817587736192;13024.934875325634;13191.868081319171;15350.072859564429;16937.407190748327;16296;16462.176891155425;16877.746833797504;17019.48941531753;17022.574435639115;4630.7453090080035;4878.585320247766;4976.726280054596;4983.476734942833;5022.723750193738;4946.604271658277;5009.6242781791325;5036.82371117011;5040.36995375578;5058.392992840846;5294.549963253128;5367.704776237305;5376.032314183445;5376.542993845528;5384.380796208447;5216.608754343401;5374.462553744634;5380.031594313042;5383.084875571162;5397.298351214356;5273.578113750929;5276.261323414725;5279.947200527984;5280.52475277223;5281.049411106038;10410.583576657;10605.416702081382;11181.72045698864;11899.821502677467;11989.520419183222;1775.644871025787;1888.9905550472297;1894.384325094336;1949.1034124302837;2362.2558893948353;8379.37154713399;8682.826343473094;9069.54652267384;9249.491277979709;9250.86123708145;1569.2467615544604;1676.5473322202936;1690.2816303071268;1719.7248440249625;1770.8333333333333;59011.40988590102;67394.9563026215;67512.662436688;68186.31813681849;68862.49100071982;9282.953585232166;9304.767380815398;9642.566084526214;9665.371750836313;9924.652637157666;13181;13213.537526186537;13326.133801302884;13340.466381344637;13353.065285429926;6860.245373008965;6967.54710943787;6991.30086991307;7119.96760469729;7399.112106547141;6592.604443733296;6696.497762667819;6704.6419827111795;6873.4157596603845;7141.143062832493;4114.691398145092;4139.482564679415;4151.169766046743;4188.350805625133;4245.681573881971;1738.2351765223261;1742.2247100040613;1764.967494016015;1798.9640207196044;1802.9549261268573;788.3259812860036;799.5202878273105;862.4480332587149;887.6183241206214;905.5336501701629;15643.530694078969;17731.73402398965;18247;18272.70591411044;18333.7249941251;758.6737702787855;775.9068911730628;836.7196989008629;870.9520976346362;917.2386918857333;7506.324430801144;8951.910480895238;9520.666776662922;9548.331616786758;9682.56428460721;344351;350369;358043;364578;368172;76072;76179.61910190413;76696;76813;77544;887.6360692116331;893.5828583681127;911.4258017448965;911.9452832830051;922.3220932614657;13619.523316683868;14765.261736912897;14972.925135374253;15184.848151518785;15661;36566.817165914;37237.44143837791;37267.25465490621;37690.24619507649;38144;52283;52352.214716778515;52454.47545524649;53152;53199.73400132974;7086.574805511686;7336.633168341668;7514.849703006019;7514.924850751422;7621.771346859603;10002.549885255035;10314.174866010851;10387.53256103462;10733.785324293627;11655.59205427806;9317.555778854288;9323.673671421468;9463.290253231173;9619.258511324238;9671;9271.907280927375;9356.578953946953;9437.622495100393;9529.380590261611;9561.426314421156;8828.512737468536;9026.548672566476;9264;9464.668736594185;9556.426614403159;7056;7152.392046675883;7243.275672432715;7281.708731650675;7289.1981881994;7322.487425880137;9229.400088994194;9392.248620110511;9441.339106262496;9487.525623718648 09:44:18 INFO - PROCESS | 15877 | |3;mootools.html;1226.6074856046068;1303.9804402933955;1376.5044583949782;1380.7790753479446;1626.9349226030959;6387.233531976163;6871.862562748748;7099.041629380032;7387.963060184705;7425.257474252572;7232.312930271616;7437.4421918356065;7463.925360746391;7466.664000119994;7486.550806951573;2103.9999999999964;2148.430665873545;2151.569686062786;2154.1598776477185;2157.5792720419527;2032.583320419318;2083.489545061462;2100;2116.47088227943;2121.2681624839483;2086.6035453263908;2112.5563631637297;2122.8089471947524;2124.118490826313;2128.8403369747252;2013.4463022668663;2029.4419034765558;2032.3496481126047;2037.7045328427444;2043.948901277465;2020.8484363672783;2030.5431277962489;2053.7022131790955;2055.7533096028424;2059.9485012874648;7377.299156580117;7379.335859772593;7399.001134846781;7401;7423.072115985502;4279.679024073207;4450.354698568722;4455.086707225044;4457.888552786207;4466.307722303049;2739.0960982875604;2843.5450327947638;2872.8563571821533;2876.1802886177547;2884.5817356483194;897.6095398501673;902.0997493059845;919.9448033118034;938.6620816506053;941.4821847983582;10135.493225338703;10298.382097074125;10344.482775861252;10352.689419317432;10363.585456581728;3820.9617903821163;4075.816588253536;4167.812448439828;4181.60274773896;4182.519010313792;8864.556772161366;8869.911300887037;8881.067487913806;8899.377043606886;8946.507942063248;4484.192845287815;4490.416245888079;4490.753008584559;4493.528179541101;4494.820207191741;3495.598006229265;3645.1251699592435;3883.4757307763657;4071.206114807584;4082.6325630692786;3385.8645654173556;3446.9827650862085;3537.3102245061964;3541.0793193769805;3582.1044738815294;1117.7149826794277;1123.2081382625229;1137.1698659978263;1143.7426579019655;1149.2472430557998;720.1322406500154;734.3317581001263;740.481662836017;742.4246209187814;753.574230559732;4541.977290113528;4612.60792832613;4642.51253618372;4655.138799322136;4704.764761761967;391.85305510433585;392.39766957719763;393.190028541206;396.08306769827755;414.5854145854146;3167.3506931079073;3217.935641287161;3255.283837555734;3271.574695289597;3345.2473193531746;8974.461532308082;9016.143466370684;9063.048379920014;9096.772580685403;9115.225205857576;9068.727938161866;9071.410358326688;9073.092690730875;9074.45553266806;9144.908550914539;6934.237233904267;6960;6998.4751143664425;7147.785566433015;7154;4758.976205118952;4874.715034694812;4996.88566659198;5105.391801582489;5203;8383.916160838313;8490.57547122629;8548.444351117407;8636.265917397091;8650.91349086501;8293.792655183668;8514.78713032179;8764.255038321558;8805.69180078694;8828.24959878392;5579.944200558105;5717.599768016199;5967.671778052249;6055.969720151371;6061.545384096122;6769.458443324621;6976.372126508639;7018.543794653331;7147.1780745214965;7151.177614574391;6352.269489008823;6441.516886233458;6557.704903279459;6833.521653484408;6839.179298484214;6443.742250309935;6583.144191255106;6667.766628167991;6689.76585819494;6798.626075565891;5820.214271073351;5915.497182739516;5922.703864806828;5935.0503919372695;5937.168796368598;3958.327084395717;3999.2001599679597;4079.204555111725;4257.127288905829;4310.935335970025;4091.693123015726;4096.242195193899;4157.147784704068;4184.7070705050355;4187.225363307798 09:44:18 INFO - PROCESS | 15877 | |4;prototype.html;262.51827895811186;273.5308945159052;276.6749069842934;281.35008131216887;288.8959974409213;4642.373279607252;4686.71879687219;4694.662021323923;4696.60078893294;4757.286407038946;4409.382686423895;4493.168763778704;4557;4616.97691511542;4668.953310466894;3685.3366394049062;3687.483752274684;3688.409854423293;3704.8888533344043;3719.404895216766;3681.5950245472977;3684.8341824617955;3693.372126738461;3705.7776533407946;3729.1982223821874;3448.310337932411;3545.7517973741847;3555.1289933966214;3632;3672.59601443841;3647.6170002149656;3666.944995825065;3669.6513831185994;3675.871344502956;3684.428913518409;3230.916059141864;3258.853351599184;3259.967400326014;3265.4611989021782;3268.673132686736;4462.486814016364;4639.489656137822;4641.327007583882;4649.488556258809;4661.207594708908;4146.5853414658595;4153.688473364479;4154.750714957112;4159.854405095837;4164.604362585549;4816.820898207201;4847.733374664392;4847.951520484785;4877.975610121962;4932.408111026664;3550.804705741183;3569.6787289144104;3576.5886923003927;3579.534660494145;3586.1751797086554;4932;5055.281204390525;5057.696538207756;5097.923531147036;5175.120229560984;3590.281943611288;3598.208394153282;3606.4590311453494;3608.7473876828894;3609.2601016791496;3643.526341575578;3652.644044591224;3654.104744337601;3656.104254457675;3663.6885864701267;4036.2129384770274;4153.480814898137;4154.522229943595;4159.209750147463;4173.937390939138;4823.3729615149805;4841.201201801734;4849.345338379274;4870.975645121752;4884.462709101996;1243.7325974915436;1259.1311994723612;1261.3377976562194;1262.8105784132454;1264.9683757906125;786.4887822915151;807.5558442856405;856.1267507142679;892.8437523433373;896.7399454158221;4315.978420107879;4362.625772881595;4366.345048242789;4369.519352871182;4391.978040109779;4979.48535989323;4987.506246876562;5018.121828679967;5046.369203849519;5065.949340506621;4223.915521689611;4407.7796110195;4420.204363214588;4434.667399945017;4453.4433195850515;2682.28919336376;2682.69149047862;2684.852333121658;2685.23470810818;2690.5560582503667;4822.397200349957;4832.879178020507;4833.187554667;4836.177849765549;4840.177169881129;5000.824971125993;5130.307408499804;5159.097157997336;5190.584753219733;5196.558292545176;4757.643176761757;4772.451168115711;4786.210275304606;4797.928031079537;4803.18345881201;5000.549950504472;5003.44962054181;5026.195808670595;5040.168372218543;5053.823116190915;4742.241241401359;4911.877203069952;4930.802767889244;4954;4967.726775027264;4808.591269741971;4812.687175333592;4823.204171311694;4832.275158726219;4838.177509823409;3536.41649127891;3540.150363912591;3546.858125674944;3552.3605750965075;3555.1645363339076;4826.686265392738;5074.8835256243565;5084.9745751272485;5087.720175390389;5124.437046700792;4918.901621967469;4921.655484116078;4922;4939.43196532389;4955.207166853286;4917.385326834145;4940.555350018516;4940.7776650051555;4951.158303088556;4993.650444468853;4724.196886529229;4784.712917224978;4805.159097158054;4902.034269267185;4908.214685650279;4682.578567928903;4812;4825.3485779419325;4917.139500587455;4943.184374578298;4812.614990800657;4830.565249127595;4832.855014349575;4844.588210002189;4851.708897466164 09:44:18 INFO - PROCESS | 15877 | |5;yui.html;597.7758340622266;602.9668368239745;618.1191801682601;685.2564967010794;694.2918223412116;12731.618051458448;13857.307134643253;13902.791458128137;14022.15867047978;14054.227017514033;12777.872221277785;13049.086563940527;13059.73880522389;13071.477140914376;13095.934520327384;627.9497640188774;645.7029766307504;759.631578684339;775.3835700618022;788.5741699482302;800.131856935226;802.2458888644685;802.3019972623796;802.6067227058728;802.666893239305;835.6239692138531;836.6151570277649;836.7155167243136;836.8995720513547;837.3928901546391;657.4149007383432;665.7237246542679;668.9264180940093;671.9227288861795;832.2426591801462;484.42837451806855;586.5893874288015;589.9764009439617;595.2143171014263;602.2592211579781;12794.296313702742;12824;12856.678583035498;12894.613161605073;12926.547570834975;11421.885781142248;11761.941190293994;11886.702832429259;12033;12518.06114541404;11311.490982905707;11416.14378921576;11484.655460336204;11509.884901150965;11650.883491165065;4036.878893633166;4048.210598933209;4052.736572122832;4095.0990782027907;4115.259253334399;61122.388776112115;61675.38324616741;61710.382896170915;62075;62927.37072629261;9805.362651427635;9918.206543476505;9952.203823694232;9999.450030248407;10000;19060.71408928867;19205.32781352646;19390.321338753078;19478.61042779165;19501.80498195028;6407.135036769976;6440.6135631862235;6513.967430162914;6544.312847151075;6755.527113102134;3441.7074548663645;3447.1382154461385;3466.809325487072;3467.878624248139;3573.9285214296087;2710.4850078485024;2789.623400840901;2806.5228911084755;2808.1154436352485;2809.620701205352;487.4345758919636;489.8652870460652;490.551145701679;495.26947752065416;500.6770632941732;505.63846849502784;507.60661982857295;540.9991515696009;555.7415801652251;569.9939606594364;7035.683394247271;7612.657430415534;7662.348700360531;8052.114267430578;8054.03351597812;533.8585274902154;543.4321134414546;568.0797108683959;590.5983930927011;609.7713357490941;3797.5063241778394;3878.146807702301;3963.6829053675638;3970.285348637215;4067.491563554556;69604.6519767398;96977.515112424;97742.51128744453;98070;101772;47614.523854761006;64558.67720661367;81040.59479702564;83847;86952.56523717467;72060;73696.26303737001;74228;74638.6268068667;75229.24770752332;6835.605087008028;7050.858982820418;7118.537295075804;7235.136957227354;7251.963740181476;30589.694103059574;37333;37344.253114937004;42688.57311426846;43367.78316108399;40081.79959100186;57095.71452142713;57214.7139264301;57864;58307.416925831894;11237.831432528683;11362.857015063431;11400.657980260605;11492.195546311677;11619.709507262387;12576.811347829607;12616.17994830333;12712.3008234548;12962.870371296167;13597.184168949894;10741.140708743438;10762.46187690628;10802.567897284021;10889.346639201673;11144.665660030212;11670.124740644316;11783.76432471363;11897.524099035942;11911.82132268034;11952.282863028246;10065.194784417083;10203.795924081625;10695.411752353695;10710.57157713714;10757.30077544957;8689;8899.555022248991;8921.687740929035;9005.504697241715;9400.623975040922;7460.216677248811;7890.329322007694;7903.170167132368;8039.316658084128;8417.158284171534 09:44:18 INFO - PROCESS | 15877 | __end_tp_report 09:44:18 INFO - PROCESS | 15877 | __start_cc_report 09:44:18 INFO - PROCESS | 15877 | _x_x_mozilla_cycle_collect,1219 09:44:18 INFO - PROCESS | 15877 | __end_cc_report 09:44:18 INFO - PROCESS | 15877 | __startTimestamp1476895458485__endTimestamp 09:44:18 INFO - PROCESS | 15877 | 09:44:18 INFO - PROCESS | 15877 | ------- Summary: start ------- 09:44:18 INFO - PROCESS | 15877 | Number of tests: 6 09:44:18 INFO - PROCESS | 15877 | 09:44:18 INFO - PROCESS | 15877 | [#0] dojo.html Cycles:165 Average:4547.26 Median:4681.09 stddev:472.49 (10.1%) stddev-sans-first:447.97 09:44:18 INFO - PROCESS | 15877 | Values: 2578.1 2612.3 2649.3 2649.8 2665.0 4453.8 4475.4 4613.1 4613.6 4625.6 4528.4 4532.8 4547.4 4548.4 4558.5 4153.5 4172.1 4183.8 4198.2 4241.4 4278.1 4281.9 4308.5 4309.3 4309.7 4214.2 4217.2 4229.7 4291.6 4309.7 4287.9 4304.3 4309.0 4310.5 4364.7 4081.3 4104.8 4120.3 4222.5 4267.4 4533.8 4590.4 4591.4 4593.8 4597.2 4904.4 4909.6 4917.7 4935.7 4997.2 4847.2 4905.7 4924.3 4947.3 4977.1 4605.4 4619.8 4656.0 4672.5 4681.1 5040.8 5061.9 5062.6 5065.2 5123.3 4854.5 4859.0 4862.8 4863.7 4920.7 4856.6 4898.9 4908.2 4963.2 4972.6 4850.2 4854.8 4890.1 4899.2 4918.7 4781.8 4792.2 4806.6 4849.4 4871.8 4011.6 4047.3 4085.0 4091.5 4097.1 3580.7 3584.0 3600.3 3629.6 3640.9 4216.5 4254.8 4256.7 4263.3 4319.3 4918.4 4925.2 4964.7 4973.2 5030.8 4319.4 4326.5 4327.2 4335.9 4385.2 4231.9 4364.7 4367.9 4368.2 4412.0 4598.4 4671.4 4678.8 4704.3 4719.3 4925.0 4957.8 4965.6 4968.1 5018.1 4723.3 4724.9 4728.7 4773.4 4776.1 4677.5 4714.3 4803.3 4805.5 4897.8 4897.7 4901.0 4903.8 4942.9 4961.7 4771.9 4773.3 4783.7 4785.2 4833.4 4657.0 4677.0 4698.7 4781.0 4835.7 4641.6 4671.4 4694.6 4732.1 4734.0 4782.3 4816.2 4819.7 4869.1 4870.8 4727.9 4733.6 4737.0 4737.7 4805.8 09:44:18 INFO - PROCESS | 15877 | 09:44:18 INFO - PROCESS | 15877 | [#1] ext.html Cycles:180 Average:44525.74 Median:202298.22 stddev:80083.58 (39.6%) stddev-sans-first:80240.20 09:44:18 INFO - PROCESS | 15877 | Values: 561.7 566.1 567.0 569.9 572.0 26667.7 27218.6 41176.4 42292.6 42372.4 38754.2 39160.8 39175.0 39198.4 39243.6 7345.6 7489.7 7493.0 7498.2 7500.2 7459.3 7547.1 7548.2 7551.5 7554.4 7531.2 7551.3 7551.7 7552.6 7593.2 7534.5 7609.9 7613.2 7618.0 7621.8 7531.8 7598.8 7599.7 7600.2 7605.3 37360.8 37615.4 37712.2 37720.6 37766.4 2866.5 2917.8 2932.7 2989.7 3031.3 27376.7 28191.6 28350.4 29070.6 29638.0 3430.9 3474.5 3489.1 3503.6 3570.3 241704.0 242136.8 242912.0 243521.0 243723.0 27391.2 27814.9 49505.0 49893.3 49899.3 32676.5 32948.5 32954.0 32978.5 33012.5 13455.9 13623.0 13624.5 13651.9 13654.1 10449.2 10528.4 10536.7 10538.9 10540.8 7538.4 7644.9 7661.1 7665.8 7711.1 3021.3 3076.0 3116.2 3126.0 3135.5 841.6 841.7 882.9 968.6 975.3 25762.9 25877.5 26364.7 26378.6 27212.2 737.7 903.8 932.4 978.8 1005.3 13795.7 14452.6 14763.0 14814.9 14815.4 367857.0 370047.0 370189.0 370309.0 372837.0 48665.5 48742.0 49136.5 49157.5 49551.0 1057.1 1076.6 1132.8 1164.0 1177.3 26842.3 27484.6 28737.4 28880.3 29082.3 40344.6 40887.8 40921.4 41046.0 41097.4 282444.0 285681.0 286276.0 286542.0 287060.0 37800.4 38223.0 38522.8 39159.0 41680.6 38422.8 39514.2 41913.0 42231.4 43071.8 36145.5 36190.3 36329.0 36618.6 37033.4 35603.5 36116.6 36149.6 37225.8 37593.4 36089.8 36190.6 36377.6 36739.4 36954.6 30471.5 33157.8 33301.5 33401.3 33936.7 24802.6 25016.7 25281.6 25604.2 25854.6 09:44:18 INFO - PROCESS | 15877 | 09:44:18 INFO - PROCESS | 15877 | [#2] jquery.html Cycles:180 Average:22779.98 Median:53175.87 stddev:59269.84 (111.5%) stddev-sans-first:59412.16 09:44:18 INFO - PROCESS | 15877 | Values: 340.4 350.2 355.2 357.3 380.2 12160.8 13024.9 13191.9 15350.1 16937.4 16296.0 16462.2 16877.7 17019.5 17022.6 4630.7 4878.6 4976.7 4983.5 5022.7 4946.6 5009.6 5036.8 5040.4 5058.4 5294.5 5367.7 5376.0 5376.5 5384.4 5216.6 5374.5 5380.0 5383.1 5397.3 5273.6 5276.3 5279.9 5280.5 5281.0 10410.6 10605.4 11181.7 11899.8 11989.5 1775.6 1889.0 1894.4 1949.1 2362.3 8379.4 8682.8 9069.5 9249.5 9250.9 1569.2 1676.5 1690.3 1719.7 1770.8 59011.4 67395.0 67512.7 68186.3 68862.5 9283.0 9304.8 9642.6 9665.4 9924.7 13181.0 13213.5 13326.1 13340.5 13353.1 6860.2 6967.5 6991.3 7120.0 7399.1 6592.6 6696.5 6704.6 6873.4 7141.1 4114.7 4139.5 4151.2 4188.4 4245.7 1738.2 1742.2 1765.0 1799.0 1803.0 788.3 799.5 862.4 887.6 905.5 15643.5 17731.7 18247.0 18272.7 18333.7 758.7 775.9 836.7 871.0 917.2 7506.3 8951.9 9520.7 9548.3 9682.6 344351.0 350369.0 358043.0 364578.0 368172.0 76072.0 76179.6 76696.0 76813.0 77544.0 887.6 893.6 911.4 911.9 922.3 13619.5 14765.3 14972.9 15184.8 15661.0 36566.8 37237.4 37267.3 37690.2 38144.0 52283.0 52352.2 52454.5 53152.0 53199.7 7086.6 7336.6 7514.8 7514.9 7621.8 10002.5 10314.2 10387.5 10733.8 11655.6 9317.6 9323.7 9463.3 9619.3 9671.0 9271.9 9356.6 9437.6 9529.4 9561.4 8828.5 9026.5 9264.0 9464.7 9556.4 7056.0 7152.4 7243.3 7281.7 7289.2 7322.5 9229.4 9392.2 9441.3 9487.5 09:44:18 INFO - PROCESS | 15877 | 09:44:18 INFO - PROCESS | 15877 | [#3] mootools.html Cycles:180 Average:4854.05 Median:4577.29 stddev:2764.38 (60.4%) stddev-sans-first:2758.69 09:44:18 INFO - PROCESS | 15877 | Values: 1226.6 1304.0 1376.5 1380.8 1626.9 6387.2 6871.9 7099.0 7388.0 7425.3 7232.3 7437.4 7463.9 7466.7 7486.6 2104.0 2148.4 2151.6 2154.2 2157.6 2032.6 2083.5 2100.0 2116.5 2121.3 2086.6 2112.6 2122.8 2124.1 2128.8 2013.4 2029.4 2032.3 2037.7 2043.9 2020.8 2030.5 2053.7 2055.8 2059.9 7377.3 7379.3 7399.0 7401.0 7423.1 4279.7 4450.4 4455.1 4457.9 4466.3 2739.1 2843.5 2872.9 2876.2 2884.6 897.6 902.1 919.9 938.7 941.5 10135.5 10298.4 10344.5 10352.7 10363.6 3821.0 4075.8 4167.8 4181.6 4182.5 8864.6 8869.9 8881.1 8899.4 8946.5 4484.2 4490.4 4490.8 4493.5 4494.8 3495.6 3645.1 3883.5 4071.2 4082.6 3385.9 3447.0 3537.3 3541.1 3582.1 1117.7 1123.2 1137.2 1143.7 1149.2 720.1 734.3 740.5 742.4 753.6 4542.0 4612.6 4642.5 4655.1 4704.8 391.9 392.4 393.2 396.1 414.6 3167.4 3217.9 3255.3 3271.6 3345.2 8974.5 9016.1 9063.0 9096.8 9115.2 9068.7 9071.4 9073.1 9074.5 9144.9 6934.2 6960.0 6998.5 7147.8 7154.0 4759.0 4874.7 4996.9 5105.4 5203.0 8383.9 8490.6 8548.4 8636.3 8650.9 8293.8 8514.8 8764.3 8805.7 8828.2 5579.9 5717.6 5967.7 6056.0 6061.5 6769.5 6976.4 7018.5 7147.2 7151.2 6352.3 6441.5 6557.7 6833.5 6839.2 6443.7 6583.1 6667.8 6689.8 6798.6 5820.2 5915.5 5922.7 5935.1 5937.2 3958.3 3999.2 4079.2 4257.1 4310.9 4091.7 4096.2 4157.1 4184.7 4187.2 09:44:18 INFO - PROCESS | 15877 | 09:44:18 INFO - PROCESS | 15877 | [#4] prototype.html Cycles:180 Average:4081.94 Median:4675.77 stddev:1179.09 (25.2%) stddev-sans-first:1147.02 09:44:18 INFO - PROCESS | 15877 | Values: 262.5 273.5 276.7 281.4 288.9 4642.4 4686.7 4694.7 4696.6 4757.3 4409.4 4493.2 4557.0 4617.0 4669.0 3685.3 3687.5 3688.4 3704.9 3719.4 3681.6 3684.8 3693.4 3705.8 3729.2 3448.3 3545.8 3555.1 3632.0 3672.6 3647.6 3666.9 3669.7 3675.9 3684.4 3230.9 3258.9 3260.0 3265.5 3268.7 4462.5 4639.5 4641.3 4649.5 4661.2 4146.6 4153.7 4154.8 4159.9 4164.6 4816.8 4847.7 4848.0 4878.0 4932.4 3550.8 3569.7 3576.6 3579.5 3586.2 4932.0 5055.3 5057.7 5097.9 5175.1 3590.3 3598.2 3606.5 3608.7 3609.3 3643.5 3652.6 3654.1 3656.1 3663.7 4036.2 4153.5 4154.5 4159.2 4173.9 4823.4 4841.2 4849.3 4871.0 4884.5 1243.7 1259.1 1261.3 1262.8 1265.0 786.5 807.6 856.1 892.8 896.7 4316.0 4362.6 4366.3 4369.5 4392.0 4979.5 4987.5 5018.1 5046.4 5065.9 4223.9 4407.8 4420.2 4434.7 4453.4 2682.3 2682.7 2684.9 2685.2 2690.6 4822.4 4832.9 4833.2 4836.2 4840.2 5000.8 5130.3 5159.1 5190.6 5196.6 4757.6 4772.5 4786.2 4797.9 4803.2 5000.5 5003.4 5026.2 5040.2 5053.8 4742.2 4911.9 4930.8 4954.0 4967.7 4808.6 4812.7 4823.2 4832.3 4838.2 3536.4 3540.2 3546.9 3552.4 3555.2 4826.7 5074.9 5085.0 5087.7 5124.4 4918.9 4921.7 4922.0 4939.4 4955.2 4917.4 4940.6 4940.8 4951.2 4993.7 4724.2 4784.7 4805.2 4902.0 4908.2 4682.6 4812.0 4825.3 4917.1 4943.2 4812.6 4830.6 4832.9 4844.6 4851.7 09:44:18 INFO - PROCESS | 15877 | 09:44:18 INFO - PROCESS | 15877 | [#5] yui.html Cycles:180 Average:16722.77 Median:506.62 stddev:23790.07 (4695.8%) stddev-sans-first:23826.00 09:44:18 INFO - PROCESS | 15877 | Values: 597.8 603.0 618.1 685.3 694.3 12731.6 13857.3 13902.8 14022.2 14054.2 12777.9 13049.1 13059.7 13071.5 13095.9 627.9 645.7 759.6 775.4 788.6 800.1 802.2 802.3 802.6 802.7 835.6 836.6 836.7 836.9 837.4 657.4 665.7 668.9 671.9 832.2 484.4 586.6 590.0 595.2 602.3 12794.3 12824.0 12856.7 12894.6 12926.5 11421.9 11761.9 11886.7 12033.0 12518.1 11311.5 11416.1 11484.7 11509.9 11650.9 4036.9 4048.2 4052.7 4095.1 4115.3 61122.4 61675.4 61710.4 62075.0 62927.4 9805.4 9918.2 9952.2 9999.5 10000.0 19060.7 19205.3 19390.3 19478.6 19501.8 6407.1 6440.6 6514.0 6544.3 6755.5 3441.7 3447.1 3466.8 3467.9 3573.9 2710.5 2789.6 2806.5 2808.1 2809.6 487.4 489.9 490.6 495.3 500.7 505.6 507.6 541.0 555.7 570.0 7035.7 7612.7 7662.3 8052.1 8054.0 533.9 543.4 568.1 590.6 609.8 3797.5 3878.1 3963.7 3970.3 4067.5 69604.7 96977.5 97742.5 98070.0 101772.0 47614.5 64558.7 81040.6 83847.0 86952.6 72060.0 73696.3 74228.0 74638.6 75229.2 6835.6 7050.9 7118.5 7235.1 7252.0 30589.7 37333.0 37344.3 42688.6 43367.8 40081.8 57095.7 57214.7 57864.0 58307.4 11237.8 11362.9 11400.7 11492.2 11619.7 12576.8 12616.2 12712.3 12962.9 13597.2 10741.1 10762.5 10802.6 10889.3 11144.7 11670.1 11783.8 11897.5 11911.8 11952.3 10065.2 10203.8 10695.4 10710.6 10757.3 8689.0 8899.6 8921.7 9005.5 9400.6 7460.2 7890.3 7903.2 8039.3 8417.2 09:44:18 INFO - PROCESS | 15877 | -------- Summary: end -------- 09:44:18 INFO - PROCESS | 15877 | 09:44:19 INFO - TEST-INFO | 15877: exit 0 09:44:19 INFO - TEST-OK | dromaeo_css | took 1122246ms 09:44:19 INFO - TEST-START | kraken 09:44:19 INFO - operating with platform_type : linux_ 09:44:19 INFO - Initialising browser for kraken test... 09:44:19 INFO - TEST-INFO | started process 16185 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMhXcdn/profile http://localhost:43848/getInfo.html) 09:44:23 INFO - PROCESS | 16185 | __metrics Screen width/height:1600/1200 09:44:23 INFO - PROCESS | 16185 | colorDepth:24 09:44:23 INFO - PROCESS | 16185 | Browser inner width/height: 1024/697 09:44:23 INFO - PROCESS | 16185 | __metrics 09:44:24 INFO - PROCESS | 16185 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:44:24 INFO - PROCESS | 16185 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:44:24 INFO - PROCESS | 16185 | console.error: PushService: 09:44:24 INFO - PROCESS | 16185 | stateChangeProcessEnqueue: Error transitioning state 09:44:24 INFO - PROCESS | 16185 | UnknownError 09:44:25 INFO - TEST-INFO | 16185: exit 0 09:44:25 INFO - Browser initialized. 09:44:25 INFO - Running cycle 1/1 for kraken test... 09:44:25 INFO - TEST-INFO | started process 16266 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMhXcdn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:44:37 INFO - PROCESS | 16266 | RSS: Main: 172969984 09:44:37 INFO - PROCESS | 16266 | 09:44:40 INFO - PROCESS | 16266 | Cycle 1(1): loaded http://localhost:43848/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43848/tests/kraken/driver.html?testName=audio-beat-detection) 09:44:41 INFO - PROCESS | 16266 | RSS: Main: 238977024 09:44:41 INFO - PROCESS | 16266 | 09:44:44 INFO - PROCESS | 16266 | Cycle 1(1): loaded http://localhost:43848/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43848/tests/kraken/driver.html?testName=audio-dft) 09:44:44 INFO - PROCESS | 16266 | RSS: Main: 217059328 09:44:44 INFO - PROCESS | 16266 | 09:44:48 INFO - PROCESS | 16266 | Cycle 1(1): loaded http://localhost:43848/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43848/tests/kraken/driver.html?testName=audio-fft) 09:44:48 INFO - PROCESS | 16266 | RSS: Main: 298729472 09:44:48 INFO - PROCESS | 16266 | 09:44:51 INFO - PROCESS | 16266 | Cycle 1(1): loaded http://localhost:43848/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43848/tests/kraken/driver.html?testName=audio-oscillator) 09:44:51 INFO - PROCESS | 16266 | RSS: Main: 209960960 09:44:51 INFO - PROCESS | 16266 | 09:44:53 INFO - PROCESS | 16266 | Cycle 1(1): loaded http://localhost:43848/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43848/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:44:54 INFO - PROCESS | 16266 | RSS: Main: 212647936 09:44:54 INFO - PROCESS | 16266 | 09:44:57 INFO - PROCESS | 16266 | Cycle 1(1): loaded http://localhost:43848/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43848/tests/kraken/driver.html?testName=imaging-darkroom) 09:44:58 INFO - PROCESS | 16266 | RSS: Main: 249274368 09:44:58 INFO - PROCESS | 16266 | 09:45:01 INFO - PROCESS | 16266 | Cycle 1(1): loaded http://localhost:43848/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43848/tests/kraken/driver.html?testName=imaging-desaturate) 09:45:02 INFO - PROCESS | 16266 | RSS: Main: 248528896 09:45:02 INFO - PROCESS | 16266 | 09:45:05 INFO - PROCESS | 16266 | Cycle 1(1): loaded http://localhost:43848/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43848/tests/kraken/driver.html?testName=json-parse-financial) 09:45:05 INFO - PROCESS | 16266 | RSS: Main: 247889920 09:45:05 INFO - PROCESS | 16266 | 09:45:07 INFO - PROCESS | 16266 | Cycle 1(1): loaded http://localhost:43848/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43848/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:45:07 INFO - PROCESS | 16266 | RSS: Main: 210292736 09:45:07 INFO - PROCESS | 16266 | 09:45:09 INFO - PROCESS | 16266 | Cycle 1(1): loaded http://localhost:43848/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43848/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:45:10 INFO - PROCESS | 16266 | RSS: Main: 218107904 09:45:10 INFO - PROCESS | 16266 | 09:45:12 INFO - PROCESS | 16266 | Cycle 1(1): loaded http://localhost:43848/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43848/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:45:13 INFO - PROCESS | 16266 | RSS: Main: 226914304 09:45:13 INFO - PROCESS | 16266 | 09:45:16 INFO - PROCESS | 16266 | Cycle 1(1): loaded http://localhost:43848/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43848/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:45:16 INFO - PROCESS | 16266 | RSS: Main: 234930176 09:45:16 INFO - PROCESS | 16266 | 09:45:19 INFO - PROCESS | 16266 | Cycle 1(1): loaded http://localhost:43848/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43848/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:45:20 INFO - PROCESS | 16266 | RSS: Main: 232312832 09:45:20 INFO - PROCESS | 16266 | 09:45:22 INFO - PROCESS | 16266 | Cycle 1(1): loaded http://localhost:43848/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43848/tests/kraken/driver.html?testName=ai-astar) 09:45:22 INFO - PROCESS | 16266 | RSS: Main: 282767360 09:45:22 INFO - PROCESS | 16266 | 09:45:22 INFO - PROCESS | 16266 | __start_tp_report 09:45:22 INFO - PROCESS | 16266 | _x_x_mozilla_page_load 09:45:22 INFO - PROCESS | 16266 | _x_x_mozilla_page_load_details 09:45:22 INFO - PROCESS | 16266 | |i|pagename|runs| 09:45:22 INFO - PROCESS | 16266 | |0;ai-astar;105;113;113;114;114;114;114;113;115;113 09:45:22 INFO - PROCESS | 16266 | |1;audio-beat-detection;166;132;130;161;126;130;129;126;163;127 09:45:22 INFO - PROCESS | 16266 | |2;audio-dft;163;161;162;162;162;161;161;162;162;161 09:45:22 INFO - PROCESS | 16266 | |3;audio-fft;77;77;75;113;76;76;77;76;100;75 09:45:22 INFO - PROCESS | 16266 | |4;audio-oscillator;84;84;121;83;84;84;116;83;84;112 09:45:22 INFO - PROCESS | 16266 | |5;imaging-gaussian-blur;117;118;117;116;116;117;117;117;117;116 09:45:22 INFO - PROCESS | 16266 | |6;imaging-darkroom;147;146;147;146;147;147;147;146;146;146 09:45:22 INFO - PROCESS | 16266 | |7;imaging-desaturate;85;85;84;84;84;84;85;84;84;84 09:45:22 INFO - PROCESS | 16266 | |8;json-parse-financial;65;65;64;65;69;67;66;66;66;65 09:45:22 INFO - PROCESS | 16266 | |9;json-stringify-tinderbox;67;68;66;66;67;65;66;66;69;68 09:45:22 INFO - PROCESS | 16266 | |10;stanford-crypto-aes;83;86;89;82;92;82;84;83;83;83 09:45:22 INFO - PROCESS | 16266 | |11;stanford-crypto-ccm;159;142;145;140;149;137;139;142;188;138 09:45:22 INFO - PROCESS | 16266 | |12;stanford-crypto-pbkdf2;181;177;178;182;179;177;178;180;179;178 09:45:22 INFO - PROCESS | 16266 | |13;stanford-crypto-sha256-iterative;70;72;70;72;75;70;73;73;73;70 09:45:22 INFO - PROCESS | 16266 | __end_tp_report 09:45:22 INFO - PROCESS | 16266 | __start_cc_report 09:45:22 INFO - PROCESS | 16266 | _x_x_mozilla_cycle_collect,1960 09:45:22 INFO - PROCESS | 16266 | __end_cc_report 09:45:22 INFO - PROCESS | 16266 | __startTimestamp1476895522580__endTimestamp 09:45:22 INFO - PROCESS | 16266 | 09:45:22 INFO - PROCESS | 16266 | ------- Summary: start ------- 09:45:22 INFO - PROCESS | 16266 | Number of tests: 14 09:45:22 INFO - PROCESS | 16266 | 09:45:22 INFO - PROCESS | 16266 | [#0] ai-astar Cycles:10 Average:112.80 Median:114.00 stddev:2.82 (2.5%) stddev-sans-first:0.71 09:45:22 INFO - PROCESS | 16266 | Values: 105.0 113.0 113.0 114.0 114.0 114.0 114.0 113.0 115.0 113.0 09:45:22 INFO - PROCESS | 16266 | 09:45:22 INFO - PROCESS | 16266 | [#1] audio-beat-detection Cycles:10 Average:139.00 Median:131.00 stddev:16.94 (12.9%) stddev-sans-first:14.88 09:45:22 INFO - PROCESS | 16266 | Values: 166.0 132.0 130.0 161.0 126.0 130.0 129.0 126.0 163.0 127.0 09:45:22 INFO - PROCESS | 16266 | 09:45:22 INFO - PROCESS | 16266 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.67 (0.4%) stddev-sans-first:0.53 09:45:22 INFO - PROCESS | 16266 | Values: 163.0 161.0 162.0 162.0 162.0 161.0 161.0 162.0 162.0 161.0 09:45:22 INFO - PROCESS | 16266 | 09:45:22 INFO - PROCESS | 16266 | [#3] audio-fft Cycles:10 Average:82.20 Median:76.00 stddev:13.19 (17.4%) stddev-sans-first:13.85 09:45:22 INFO - PROCESS | 16266 | Values: 77.0 77.0 75.0 113.0 76.0 76.0 77.0 76.0 100.0 75.0 09:45:22 INFO - PROCESS | 16266 | 09:45:22 INFO - PROCESS | 16266 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:84.00 stddev:15.90 (18.9%) stddev-sans-first:16.49 09:45:22 INFO - PROCESS | 16266 | Values: 84.0 84.0 121.0 83.0 84.0 84.0 116.0 83.0 84.0 112.0 09:45:22 INFO - PROCESS | 16266 | 09:45:22 INFO - PROCESS | 16266 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 09:45:22 INFO - PROCESS | 16266 | Values: 117.0 118.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 116.0 09:45:22 INFO - PROCESS | 16266 | 09:45:22 INFO - PROCESS | 16266 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 09:45:22 INFO - PROCESS | 16266 | Values: 147.0 146.0 147.0 146.0 147.0 147.0 147.0 146.0 146.0 146.0 09:45:22 INFO - PROCESS | 16266 | 09:45:22 INFO - PROCESS | 16266 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.00 stddev:0.48 (0.6%) stddev-sans-first:0.44 09:45:22 INFO - PROCESS | 16266 | Values: 85.0 85.0 84.0 84.0 84.0 84.0 85.0 84.0 84.0 84.0 09:45:22 INFO - PROCESS | 16266 | 09:45:22 INFO - PROCESS | 16266 | [#8] json-parse-financial Cycles:10 Average:65.80 Median:66.00 stddev:1.40 (2.1%) stddev-sans-first:1.45 09:45:22 INFO - PROCESS | 16266 | Values: 65.0 65.0 64.0 65.0 69.0 67.0 66.0 66.0 66.0 65.0 09:45:22 INFO - PROCESS | 16266 | 09:45:22 INFO - PROCESS | 16266 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:1.23 (1.8%) stddev-sans-first:1.30 09:45:22 INFO - PROCESS | 16266 | Values: 67.0 68.0 66.0 66.0 67.0 65.0 66.0 66.0 69.0 68.0 09:45:22 INFO - PROCESS | 16266 | 09:45:22 INFO - PROCESS | 16266 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:83.50 stddev:3.33 (4.0%) stddev-sans-first:3.48 09:45:22 INFO - PROCESS | 16266 | Values: 83.0 86.0 89.0 82.0 92.0 82.0 84.0 83.0 83.0 83.0 09:45:22 INFO - PROCESS | 16266 | 09:45:22 INFO - PROCESS | 16266 | [#11] stanford-crypto-ccm Cycles:10 Average:147.90 Median:143.50 stddev:15.52 (10.8%) stddev-sans-first:15.94 09:45:22 INFO - PROCESS | 16266 | Values: 159.0 142.0 145.0 140.0 149.0 137.0 139.0 142.0 188.0 138.0 09:45:22 INFO - PROCESS | 16266 | 09:45:22 INFO - PROCESS | 16266 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.90 Median:179.00 stddev:1.66 (0.9%) stddev-sans-first:1.58 09:45:22 INFO - PROCESS | 16266 | Values: 181.0 177.0 178.0 182.0 179.0 177.0 178.0 180.0 179.0 178.0 09:45:22 INFO - PROCESS | 16266 | 09:45:22 INFO - PROCESS | 16266 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:72.50 stddev:1.75 (2.4%) stddev-sans-first:1.73 09:45:22 INFO - PROCESS | 16266 | Values: 70.0 72.0 70.0 72.0 75.0 70.0 73.0 73.0 73.0 70.0 09:45:22 INFO - PROCESS | 16266 | -------- Summary: end -------- 09:45:22 INFO - PROCESS | 16266 | 09:45:23 INFO - TEST-INFO | 16266: exit 0 09:45:23 INFO - TEST-OK | kraken | took 64424ms 09:45:23 INFO - SUITE-END | took 1186s 09:45:24 INFO - Completed test suite (00:19:46) 09:45:24 INFO - javascript benchmark 09:45:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2578.059008461911, 2612.3469132716823, 2649.337665583604, 2649.8012649051316, 2665.0405853892594, 4453.755043472608, 4475.373447717322, 4613.1235065337605, 4613.561711637398, 4625.560571745687, 4528.366028755977, 4532.818687252506, 4547.363369128317, 4548.385967894334, 4558.498565157838, 4153.501579810427, 4172.061286210609, 4183.769892655902, 4198.20234155511, 4241.448611680493, 4278.080212754257, 4281.935770963438, 4308.504521979981, 4309.267424537836, 4309.741415515079, 4214.157168566284, 4217.177650358181, 4229.661627069842, 4291.635211007053, 4309.655227581786, 4287.914241715148, 4304.268274393361, 4309.0, 4310.482742070972, 4364.716293440916, 4081.265372232997, 4104.753714777123, 4120.278951183561, 4222.535521092677, 4267.4025636410925, 4533.818647254139, 4590.403247577793, 4591.380163677894, 4593.770311484446, 4597.195490789132, 4904.386951631046, 4909.631777616693, 4917.680350777224, 4935.703857768545, 4997.150484417658, 4847.151748444044, 4905.656604037718, 4924.285978533128, 4947.257911313296, 4977.054359671651, 4605.355250264965, 4619.769011549442, 4655.976720116446, 4672.462666793294, 4681.087187998308, 5040.773165207501, 5061.8734531637, 5062.594992400599, 5065.214891691794, 5123.3339665843205, 4854.538818812278, 4858.975705121452, 4862.756862156878, 4863.708177509361, 4920.72935988524, 4856.635752318591, 4898.926516102261, 4908.239222920453, 4963.205887058053, 4972.577330926912, 4850.1997170466475, 4854.80580776765, 4890.095332363524, 4899.216125419915, 4918.6556941014505, 4781.760911954389, 4792.209285467929, 4806.639502037361, 4849.442314133849, 4871.8294859679745, 4011.5787842276723, 4047.3321901886447, 4085.0400155963325, 4091.5499295077516, 4097.1191193893455, 3580.6598373154507, 3583.9820800895827, 3600.261946301002, 3629.6007439181667, 3640.927181456356, 4216.536181020086, 4254.808533615995, 4256.6807489438415, 4263.253930562139, 4319.265724826787, 4918.43438004634, 4925.162722337212, 4964.67729597575, 4973.204287314013, 5030.798768049311, 4319.352097185384, 4326.524082350938, 4327.17783621111, 4335.913281734411, 4385.210662080793, 4231.899706076442, 4364.694471387036, 4367.868963931087, 4368.191884501377, 4412.029353542215, 4598.356230127718, 4671.369365135663, 4678.789454474489, 4704.294355846513, 4719.268513380432, 4924.975375123101, 4957.801687932442, 4965.602751779921, 4968.105740966661, 5018.1218286800395, 4723.267893476516, 4724.858254252378, 4728.71627702339, 4773.427188737373, 4776.068666609977, 4677.508861569486, 4714.269288260325, 4803.255495398219, 4805.543473370024, 4897.7795999180835, 4897.706137631753, 4901.044296362318, 4903.828366007173, 4942.8764280893265, 4961.7271050092595, 4771.880702982453, 4773.307870358848, 4783.7129772213775, 4785.234362502122, 4833.419989601271, 4656.998745269783, 4676.976615116902, 4698.7415692137265, 4780.95219047805, 4835.685680430761, 4641.605463535638, 4671.392718946515, 4694.554017368481, 4732.077244937204, 4734.0, 4782.33047373361, 4816.229403295456, 4819.7108173509705, 4869.147899117711, 4870.756462176806, 4727.858164255078, 4733.573978341966, 4737.028909073701, 4737.66836321468, 4805.7597120144555], "value": 4517.7117790958155, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.6798424897809, 566.0914232656586, 566.9631473954195, 569.9430056994298, 571.9761626688227, 26667.73332266677, 27218.591721124198, 41176.38235426467, 42292.57707422925, 42372.364414533804, 38754.224915501676, 39160.80419597905, 39175.0, 39198.41202381966, 39243.60756392435, 7345.595992220412, 7489.662965166581, 7493.0259066321305, 7498.2126876677985, 7500.212477689845, 7459.291367320096, 7547.13207981081, 7548.20743821899, 7551.546907185559, 7554.357879580215, 7531.209223031585, 7551.282628150317, 7551.660175292098, 7552.622368881562, 7593.2027137150635, 7534.547927124363, 7609.885851712229, 7613.162552119318, 7617.961910190469, 7621.771346859603, 7531.849363012709, 7598.848023039508, 7599.696012159507, 7600.239976002411, 7605.277498637621, 37360.81319593412, 37615.435768463496, 37712.245755085016, 37720.62279377199, 37766.43350349747, 2866.498362786525, 2917.766578673701, 2932.6920673329205, 2989.7309242168094, 3031.348260124084, 27376.726232737816, 28191.57712634312, 28350.432991340058, 29070.563941540895, 29638.0, 3430.8627654893776, 3474.4961980512685, 3489.1277180704824, 3503.649635036476, 3570.321638888603, 241704.0, 242136.78931605406, 242912.0, 243521.0, 243723.0, 27391.17826465209, 27814.860925695648, 49505.0, 49893.25160122601, 49899.25151122736, 32676.509852352232, 32948.50577241343, 32954.0, 32978.505322420184, 33012.50481242783, 13455.86544134546, 13623.046386752832, 13624.455021799215, 13651.931740341235, 13654.112482688792, 10449.216308776871, 10528.420936848546, 10536.683899483029, 10538.947305263424, 10540.789184216273, 7538.434617403716, 7644.923550764421, 7661.080670319598, 7665.770026899202, 7711.113221979432, 3021.259791351133, 3075.969240307613, 3116.158637167952, 3126.03093041158, 3135.5296705494357, 841.6212704283097, 841.7180244617999, 882.9426087304305, 968.5544649461186, 975.2588033094758, 25762.87118564395, 25877.482450351265, 26364.736352636228, 26378.604320935203, 27212.183634490997, 737.7196665267164, 903.8282726281985, 932.3706498113746, 978.848278516831, 1005.3113617172261, 13795.677838720123, 14452.566423007327, 14762.97359041394, 14814.925925370304, 14815.40738370453, 367857.0, 370047.0, 370189.0, 370309.0, 372837.0, 48665.513344866806, 48742.0, 49136.508634913196, 49157.50842491529, 49551.0, 1057.1014637558014, 1076.617800680747, 1132.796096702585, 1163.959261425863, 1177.31127290536, 26842.32894177661, 27484.58773118445, 28737.425251494435, 28880.2779930495, 29082.27294317659, 40344.596554034084, 40887.795561022, 40921.38617920793, 41046.0, 41097.38353924753, 282444.0, 285681.0, 286276.0, 286542.0, 287060.0, 37800.43299350457, 38223.0, 38522.80738596289, 39159.0, 41680.58319416767, 38422.80788596151, 39514.2097158061, 41913.0, 42231.366529501465, 43071.78464107659, 36145.45781813222, 36190.276194476486, 36329.0, 36618.633813662585, 37033.44449833308, 35603.46594801132, 36116.63883361133, 36149.638503614624, 37225.81387093047, 37593.43609845909, 36089.81955090313, 36190.63809361873, 36377.636223637426, 36739.44890826693, 36954.6304536962, 30471.542926855673, 33157.83421082879, 33301.50047749237, 33401.33197336088, 33936.660633394335, 24802.627960580245, 25016.749832501442, 25281.62077568801, 25604.23187304384, 25854.612180816926], "value": 16172.427693139944, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.4365774642967, 350.16660348370874, 355.1795352735182, 357.3460567162094, 380.21675348781514, 12160.817587736192, 13024.934875325634, 13191.868081319171, 15350.072859564429, 16937.407190748327, 16296.0, 16462.176891155425, 16877.746833797504, 17019.48941531753, 17022.574435639115, 4630.7453090080035, 4878.585320247766, 4976.726280054596, 4983.476734942833, 5022.723750193738, 4946.604271658277, 5009.6242781791325, 5036.82371117011, 5040.36995375578, 5058.392992840846, 5294.549963253128, 5367.704776237305, 5376.032314183445, 5376.542993845528, 5384.380796208447, 5216.608754343401, 5374.462553744634, 5380.031594313042, 5383.084875571162, 5397.298351214356, 5273.578113750929, 5276.261323414725, 5279.947200527984, 5280.52475277223, 5281.049411106038, 10410.583576657, 10605.416702081382, 11181.72045698864, 11899.821502677467, 11989.520419183222, 1775.644871025787, 1888.9905550472297, 1894.384325094336, 1949.1034124302837, 2362.2558893948353, 8379.37154713399, 8682.826343473094, 9069.54652267384, 9249.491277979709, 9250.86123708145, 1569.2467615544604, 1676.5473322202936, 1690.2816303071268, 1719.7248440249625, 1770.8333333333333, 59011.40988590102, 67394.9563026215, 67512.662436688, 68186.31813681849, 68862.49100071982, 9282.953585232166, 9304.767380815398, 9642.566084526214, 9665.371750836313, 9924.652637157666, 13181.0, 13213.537526186537, 13326.133801302884, 13340.466381344637, 13353.065285429926, 6860.245373008965, 6967.54710943787, 6991.30086991307, 7119.96760469729, 7399.112106547141, 6592.604443733296, 6696.497762667819, 6704.6419827111795, 6873.4157596603845, 7141.143062832493, 4114.691398145092, 4139.482564679415, 4151.169766046743, 4188.350805625133, 4245.681573881971, 1738.2351765223261, 1742.2247100040613, 1764.967494016015, 1798.9640207196044, 1802.9549261268573, 788.3259812860036, 799.5202878273105, 862.4480332587149, 887.6183241206214, 905.5336501701629, 15643.530694078969, 17731.73402398965, 18247.0, 18272.70591411044, 18333.7249941251, 758.6737702787855, 775.9068911730628, 836.7196989008629, 870.9520976346362, 917.2386918857333, 7506.324430801144, 8951.910480895238, 9520.666776662922, 9548.331616786758, 9682.56428460721, 344351.0, 350369.0, 358043.0, 364578.0, 368172.0, 76072.0, 76179.61910190413, 76696.0, 76813.0, 77544.0, 887.6360692116331, 893.5828583681127, 911.4258017448965, 911.9452832830051, 922.3220932614657, 13619.523316683868, 14765.261736912897, 14972.925135374253, 15184.848151518785, 15661.0, 36566.817165914, 37237.44143837791, 37267.25465490621, 37690.24619507649, 38144.0, 52283.0, 52352.214716778515, 52454.47545524649, 53152.0, 53199.73400132974, 7086.574805511686, 7336.633168341668, 7514.849703006019, 7514.924850751422, 7621.771346859603, 10002.549885255035, 10314.174866010851, 10387.53256103462, 10733.785324293627, 11655.59205427806, 9317.555778854288, 9323.673671421468, 9463.290253231173, 9619.258511324238, 9671.0, 9271.907280927375, 9356.578953946953, 9437.622495100393, 9529.380590261611, 9561.426314421156, 8828.512737468536, 9026.548672566476, 9264.0, 9464.668736594185, 9556.426614403159, 7056.0, 7152.392046675883, 7243.275672432715, 7281.708731650675, 7289.1981881994, 7322.487425880137, 9229.400088994194, 9392.248620110511, 9441.339106262496, 9487.525623718648], "value": 7758.289545468487, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1226.6074856046068, 1303.9804402933955, 1376.5044583949782, 1380.7790753479446, 1626.9349226030959, 6387.233531976163, 6871.862562748748, 7099.041629380032, 7387.963060184705, 7425.257474252572, 7232.312930271616, 7437.4421918356065, 7463.925360746391, 7466.664000119994, 7486.550806951573, 2103.9999999999964, 2148.430665873545, 2151.569686062786, 2154.1598776477185, 2157.5792720419527, 2032.583320419318, 2083.489545061462, 2100.0, 2116.47088227943, 2121.2681624839483, 2086.6035453263908, 2112.5563631637297, 2122.8089471947524, 2124.118490826313, 2128.8403369747252, 2013.4463022668663, 2029.4419034765558, 2032.3496481126047, 2037.7045328427444, 2043.948901277465, 2020.8484363672783, 2030.5431277962489, 2053.7022131790955, 2055.7533096028424, 2059.9485012874648, 7377.299156580117, 7379.335859772593, 7399.001134846781, 7401.0, 7423.072115985502, 4279.679024073207, 4450.354698568722, 4455.086707225044, 4457.888552786207, 4466.307722303049, 2739.0960982875604, 2843.5450327947638, 2872.8563571821533, 2876.1802886177547, 2884.5817356483194, 897.6095398501673, 902.0997493059845, 919.9448033118034, 938.6620816506053, 941.4821847983582, 10135.493225338703, 10298.382097074125, 10344.482775861252, 10352.689419317432, 10363.585456581728, 3820.9617903821163, 4075.816588253536, 4167.812448439828, 4181.60274773896, 4182.519010313792, 8864.556772161366, 8869.911300887037, 8881.067487913806, 8899.377043606886, 8946.507942063248, 4484.192845287815, 4490.416245888079, 4490.753008584559, 4493.528179541101, 4494.820207191741, 3495.598006229265, 3645.1251699592435, 3883.4757307763657, 4071.206114807584, 4082.6325630692786, 3385.8645654173556, 3446.9827650862085, 3537.3102245061964, 3541.0793193769805, 3582.1044738815294, 1117.7149826794277, 1123.2081382625229, 1137.1698659978263, 1143.7426579019655, 1149.2472430557998, 720.1322406500154, 734.3317581001263, 740.481662836017, 742.4246209187814, 753.574230559732, 4541.977290113528, 4612.60792832613, 4642.51253618372, 4655.138799322136, 4704.764761761967, 391.85305510433585, 392.39766957719763, 393.190028541206, 396.08306769827755, 414.5854145854146, 3167.3506931079073, 3217.935641287161, 3255.283837555734, 3271.574695289597, 3345.2473193531746, 8974.461532308082, 9016.143466370684, 9063.048379920014, 9096.772580685403, 9115.225205857576, 9068.727938161866, 9071.410358326688, 9073.092690730875, 9074.45553266806, 9144.908550914539, 6934.237233904267, 6960.0, 6998.4751143664425, 7147.785566433015, 7154.0, 4758.976205118952, 4874.715034694812, 4996.88566659198, 5105.391801582489, 5203.0, 8383.916160838313, 8490.57547122629, 8548.444351117407, 8636.265917397091, 8650.91349086501, 8293.792655183668, 8514.78713032179, 8764.255038321558, 8805.69180078694, 8828.24959878392, 5579.944200558105, 5717.599768016199, 5967.671778052249, 6055.969720151371, 6061.545384096122, 6769.458443324621, 6976.372126508639, 7018.543794653331, 7147.1780745214965, 7151.177614574391, 6352.269489008823, 6441.516886233458, 6557.704903279459, 6833.521653484408, 6839.179298484214, 6443.742250309935, 6583.144191255106, 6667.766628167991, 6689.76585819494, 6798.626075565891, 5820.214271073351, 5915.497182739516, 5922.703864806828, 5935.0503919372695, 5937.168796368598, 3958.327084395717, 3999.2001599679597, 4079.204555111725, 4257.127288905829, 4310.935335970025, 4091.693123015726, 4096.242195193899, 4157.147784704068, 4184.7070705050355, 4187.225363307798], "value": 3838.49825390299, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [262.51827895811186, 273.5308945159052, 276.6749069842934, 281.35008131216887, 288.8959974409213, 4642.373279607252, 4686.71879687219, 4694.662021323923, 4696.60078893294, 4757.286407038946, 4409.382686423895, 4493.168763778704, 4557.0, 4616.97691511542, 4668.953310466894, 3685.3366394049062, 3687.483752274684, 3688.409854423293, 3704.8888533344043, 3719.404895216766, 3681.5950245472977, 3684.8341824617955, 3693.372126738461, 3705.7776533407946, 3729.1982223821874, 3448.310337932411, 3545.7517973741847, 3555.1289933966214, 3632.0, 3672.59601443841, 3647.6170002149656, 3666.944995825065, 3669.6513831185994, 3675.871344502956, 3684.428913518409, 3230.916059141864, 3258.853351599184, 3259.967400326014, 3265.4611989021782, 3268.673132686736, 4462.486814016364, 4639.489656137822, 4641.327007583882, 4649.488556258809, 4661.207594708908, 4146.5853414658595, 4153.688473364479, 4154.750714957112, 4159.854405095837, 4164.604362585549, 4816.820898207201, 4847.733374664392, 4847.951520484785, 4877.975610121962, 4932.408111026664, 3550.804705741183, 3569.6787289144104, 3576.5886923003927, 3579.534660494145, 3586.1751797086554, 4932.0, 5055.281204390525, 5057.696538207756, 5097.923531147036, 5175.120229560984, 3590.281943611288, 3598.208394153282, 3606.4590311453494, 3608.7473876828894, 3609.2601016791496, 3643.526341575578, 3652.644044591224, 3654.104744337601, 3656.104254457675, 3663.6885864701267, 4036.2129384770274, 4153.480814898137, 4154.522229943595, 4159.209750147463, 4173.937390939138, 4823.3729615149805, 4841.201201801734, 4849.345338379274, 4870.975645121752, 4884.462709101996, 1243.7325974915436, 1259.1311994723612, 1261.3377976562194, 1262.8105784132454, 1264.9683757906125, 786.4887822915151, 807.5558442856405, 856.1267507142679, 892.8437523433373, 896.7399454158221, 4315.978420107879, 4362.625772881595, 4366.345048242789, 4369.519352871182, 4391.978040109779, 4979.48535989323, 4987.506246876562, 5018.121828679967, 5046.369203849519, 5065.949340506621, 4223.915521689611, 4407.7796110195, 4420.204363214588, 4434.667399945017, 4453.4433195850515, 2682.28919336376, 2682.69149047862, 2684.852333121658, 2685.23470810818, 2690.5560582503667, 4822.397200349957, 4832.879178020507, 4833.187554667, 4836.177849765549, 4840.177169881129, 5000.824971125993, 5130.307408499804, 5159.097157997336, 5190.584753219733, 5196.558292545176, 4757.643176761757, 4772.451168115711, 4786.210275304606, 4797.928031079537, 4803.18345881201, 5000.549950504472, 5003.44962054181, 5026.195808670595, 5040.168372218543, 5053.823116190915, 4742.241241401359, 4911.877203069952, 4930.802767889244, 4954.0, 4967.726775027264, 4808.591269741971, 4812.687175333592, 4823.204171311694, 4832.275158726219, 4838.177509823409, 3536.41649127891, 3540.150363912591, 3546.858125674944, 3552.3605750965075, 3555.1645363339076, 4826.686265392738, 5074.8835256243565, 5084.9745751272485, 5087.720175390389, 5124.437046700792, 4918.901621967469, 4921.655484116078, 4922.0, 4939.43196532389, 4955.207166853286, 4917.385326834145, 4940.555350018516, 4940.7776650051555, 4951.158303088556, 4993.650444468853, 4724.196886529229, 4784.712917224978, 4805.159097158054, 4902.034269267185, 4908.214685650279, 4682.578567928903, 4812.0, 4825.3485779419325, 4917.139500587455, 4943.184374578298, 4812.614990800657, 4830.565249127595, 4832.855014349575, 4844.588210002189, 4851.708897466164], "value": 3703.229831488962, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.7758340622266, 602.9668368239745, 618.1191801682601, 685.2564967010794, 694.2918223412116, 12731.618051458448, 13857.307134643253, 13902.791458128137, 14022.15867047978, 14054.227017514033, 12777.872221277785, 13049.086563940527, 13059.73880522389, 13071.477140914376, 13095.934520327384, 627.9497640188774, 645.7029766307504, 759.631578684339, 775.3835700618022, 788.5741699482302, 800.131856935226, 802.2458888644685, 802.3019972623796, 802.6067227058728, 802.666893239305, 835.6239692138531, 836.6151570277649, 836.7155167243136, 836.8995720513547, 837.3928901546391, 657.4149007383432, 665.7237246542679, 668.9264180940093, 671.9227288861795, 832.2426591801462, 484.42837451806855, 586.5893874288015, 589.9764009439617, 595.2143171014263, 602.2592211579781, 12794.296313702742, 12824.0, 12856.678583035498, 12894.613161605073, 12926.547570834975, 11421.885781142248, 11761.941190293994, 11886.702832429259, 12033.0, 12518.06114541404, 11311.490982905707, 11416.14378921576, 11484.655460336204, 11509.884901150965, 11650.883491165065, 4036.878893633166, 4048.210598933209, 4052.736572122832, 4095.0990782027907, 4115.259253334399, 61122.388776112115, 61675.38324616741, 61710.382896170915, 62075.0, 62927.37072629261, 9805.362651427635, 9918.206543476505, 9952.203823694232, 9999.450030248407, 10000.0, 19060.71408928867, 19205.32781352646, 19390.321338753078, 19478.61042779165, 19501.80498195028, 6407.135036769976, 6440.6135631862235, 6513.967430162914, 6544.312847151075, 6755.527113102134, 3441.7074548663645, 3447.1382154461385, 3466.809325487072, 3467.878624248139, 3573.9285214296087, 2710.4850078485024, 2789.623400840901, 2806.5228911084755, 2808.1154436352485, 2809.620701205352, 487.4345758919636, 489.8652870460652, 490.551145701679, 495.26947752065416, 500.6770632941732, 505.63846849502784, 507.60661982857295, 540.9991515696009, 555.7415801652251, 569.9939606594364, 7035.683394247271, 7612.657430415534, 7662.348700360531, 8052.114267430578, 8054.03351597812, 533.8585274902154, 543.4321134414546, 568.0797108683959, 590.5983930927011, 609.7713357490941, 3797.5063241778394, 3878.146807702301, 3963.6829053675638, 3970.285348637215, 4067.491563554556, 69604.6519767398, 96977.515112424, 97742.51128744453, 98070.0, 101772.0, 47614.523854761006, 64558.67720661367, 81040.59479702564, 83847.0, 86952.56523717467, 72060.0, 73696.26303737001, 74228.0, 74638.6268068667, 75229.24770752332, 6835.605087008028, 7050.858982820418, 7118.537295075804, 7235.136957227354, 7251.963740181476, 30589.694103059574, 37333.0, 37344.253114937004, 42688.57311426846, 43367.78316108399, 40081.79959100186, 57095.71452142713, 57214.7139264301, 57864.0, 58307.416925831894, 11237.831432528683, 11362.857015063431, 11400.657980260605, 11492.195546311677, 11619.709507262387, 12576.811347829607, 12616.17994830333, 12712.3008234548, 12962.870371296167, 13597.184168949894, 10741.140708743438, 10762.46187690628, 10802.567897284021, 10889.346639201673, 11144.665660030212, 11670.124740644316, 11783.76432471363, 11897.524099035942, 11911.82132268034, 11952.282863028246, 10065.194784417083, 10203.795924081625, 10695.411752353695, 10710.57157713714, 10757.30077544957, 8689.0, 8899.555022248991, 8921.687740929035, 9005.504697241715, 9400.623975040922, 7460.216677248811, 7890.329322007694, 7903.170167132368, 8039.316658084128, 8417.158284171534], "value": 6291.325935495955, "unit": "score"}], "name": "dromaeo_css", "value": 6083.670243577149, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 113.0, 114.0, 114.0, 114.0, 114.0, 113.0, 115.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 132.0, 130.0, 161.0, 126.0, 130.0, 129.0, 126.0, 163.0, 127.0], "value": 139.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 162.0, 162.0, 161.0, 161.0, 162.0, 162.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 75.0, 113.0, 76.0, 76.0, 77.0, 76.0, 100.0, 75.0], "value": 82.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 121.0, 83.0, 84.0, 84.0, 116.0, 83.0, 84.0, 112.0], "value": 93.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 84.0, 84.0, 84.0, 85.0, 84.0, 84.0, 84.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 65.0, 69.0, 67.0, 66.0, 66.0, 66.0, 65.0], "value": 65.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 66.0, 66.0, 67.0, 65.0, 66.0, 66.0, 69.0, 68.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 89.0, 82.0, 92.0, 82.0, 84.0, 83.0, 83.0, 83.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 142.0, 145.0, 140.0, 149.0, 137.0, 139.0, 142.0, 188.0, 138.0], "value": 147.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 177.0, 178.0, 182.0, 179.0, 177.0, 178.0, 180.0, 179.0, 178.0], "value": 178.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 70.0, 72.0, 75.0, 70.0, 73.0, 73.0, 73.0, 70.0], "value": 71.8, "unit": "score"}], "name": "kraken", "value": 1552.7, "alertThreshold": 2.0}]} 09:45:24 INFO - Return code: 0 09:45:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:45:24 INFO - # TBPL SUCCESS # 09:45:24 INFO - Running post-action listener: _resource_record_post_action 09:45:24 INFO - [mozharness: 2016-10-19 16:45:24.369388Z] Finished run-tests step (success) 09:45:24 INFO - Running post-run listener: _resource_record_post_run 09:45:24 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 0; Write bytes: 390823936; Read time: 0; Write time: 311116 09:45:24 INFO - TinderboxPrint: CPU usage
13.0% 09:45:24 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:45:24 INFO - TinderboxPrint: I/O write bytes / time
390,823,936 / 311,116 09:45:24 INFO - TinderboxPrint: CPU idle
8,348.2 (87.0%) 09:45:24 INFO - TinderboxPrint: CPU user
1,200.0 (12.5%) 09:45:24 INFO - TinderboxPrint: Swap in / out
0 / 0 09:45:24 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99676160; Read time: 0; Write time: 109252 09:45:24 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 291147776; Read time: 0; Write time: 201864 09:45:25 INFO - Running post-run listener: _upload_blobber_files 09:45:25 INFO - Blob upload gear active. 09:45:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:45:25 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:45:25 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:45:25 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:45:25 INFO - (blobuploader) - INFO - Open directory for files ... 09:45:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:45:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:45:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:45:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:45:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:45:26 INFO - (blobuploader) - INFO - Done attempting. 09:45:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:45:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:45:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:45:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:45:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:45:27 INFO - (blobuploader) - INFO - Done attempting. 09:45:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:45:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:45:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:45:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:45:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:45:30 INFO - (blobuploader) - INFO - Done attempting. 09:45:30 INFO - (blobuploader) - INFO - Iteration through files over. 09:45:30 INFO - Return code: 0 09:45:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:45:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:45:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8673958fd5798ddc251ec8b8a4d274790ec0984db70caa474690f5bca804662536533c7d2653f82a1d56ee25bee0224657208f67c043f44ab733dce5379f3d8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/54ce19ac5e26c16fed1f8f552b99de12a06a0d47fe9e3cd00ec7bc025d228913834570844a8ae2df9fb5b82c5525eedd2bd2f8ded99d8f8bd8760d65f25018a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4dfc385287f7f38f2ceb561be4b4ac2cea909341740441c498583e7f78273cc1ea83097343f56257e1d8f90bfddff6ab658fc1b386c1bfbe83c88ea6b2b2890d"} 09:45:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:45:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:45:30 INFO - Contents: 09:45:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8673958fd5798ddc251ec8b8a4d274790ec0984db70caa474690f5bca804662536533c7d2653f82a1d56ee25bee0224657208f67c043f44ab733dce5379f3d8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/54ce19ac5e26c16fed1f8f552b99de12a06a0d47fe9e3cd00ec7bc025d228913834570844a8ae2df9fb5b82c5525eedd2bd2f8ded99d8f8bd8760d65f25018a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4dfc385287f7f38f2ceb561be4b4ac2cea909341740441c498583e7f78273cc1ea83097343f56257e1d8f90bfddff6ab658fc1b386c1bfbe83c88ea6b2b2890d"} 09:45:30 INFO - Running post-run listener: copy_logs_to_upload_dir 09:45:30 INFO - Copying logs to upload dir... 09:45:30 INFO - mkdir: /builds/slave/test/build/upload/logs 09:45:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.408895 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-19 09:45:30.833576) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 09:45:30.837743) ========= 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=c6927cf182745ad25b1d38b9000001fe-1476894281.687842-338006364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8673958fd5798ddc251ec8b8a4d274790ec0984db70caa474690f5bca804662536533c7d2653f82a1d56ee25bee0224657208f67c043f44ab733dce5379f3d8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/54ce19ac5e26c16fed1f8f552b99de12a06a0d47fe9e3cd00ec7bc025d228913834570844a8ae2df9fb5b82c5525eedd2bd2f8ded99d8f8bd8760d65f25018a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4dfc385287f7f38f2ceb561be4b4ac2cea909341740441c498583e7f78273cc1ea83097343f56257e1d8f90bfddff6ab658fc1b386c1bfbe83c88ea6b2b2890d"} build_url:https://queue.taskcluster.net/v1/task/GOrq3dInTfOkx2b6oiqK5Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011412 build_url: 'https://queue.taskcluster.net/v1/task/GOrq3dInTfOkx2b6oiqK5Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8673958fd5798ddc251ec8b8a4d274790ec0984db70caa474690f5bca804662536533c7d2653f82a1d56ee25bee0224657208f67c043f44ab733dce5379f3d8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/54ce19ac5e26c16fed1f8f552b99de12a06a0d47fe9e3cd00ec7bc025d228913834570844a8ae2df9fb5b82c5525eedd2bd2f8ded99d8f8bd8760d65f25018a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/4dfc385287f7f38f2ceb561be4b4ac2cea909341740441c498583e7f78273cc1ea83097343f56257e1d8f90bfddff6ab658fc1b386c1bfbe83c88ea6b2b2890d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-19 09:45:30.864881) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 09:45:30.865302) ========= 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=c6927cf182745ad25b1d38b9000001fe-1476894281.687842-338006364 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004405 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-19 09:45:30.947548) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 09:45:30.947914) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-19 09:45:30.948246) ========= ========= Total master_lag: 0.19 =========