builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1487083786.07 results: success (0) buildid: 20170214045345 builduid: f73a1c7b50104d3ca9694f387f6d708a revision: 35e191e72900ed4e51febc0d247c784499ccf244 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-14 06:49:46.073857) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-14 06:49:46.074404) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-14 06:49:46.074700) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-14 06:49:46.091345) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 06:49:46.091741) ========= 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=6dbc10da6d83fee962c624be000001a8-1487083786.123185-1408978583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-14 06:49:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 33.9M=0s 2017-02-14 06:49:46 (33.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.124375 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 06:49:46.230033) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 06:49:46.230360) ========= 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=6dbc10da6d83fee962c624be000001a8-1487083786.123185-1408978583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016098 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 06:49:46.280284) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 06:49:46.280651) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 35e191e72900ed4e51febc0d247c784499ccf244 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 35e191e72900ed4e51febc0d247c784499ccf244 --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=6dbc10da6d83fee962c624be000001a8-1487083786.123185-1408978583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-14 06:49:46,998 truncating revision to first 12 chars 2017-02-14 06:49:46,998 Setting DEBUG logging. 2017-02-14 06:49:46,998 attempt 1/10 2017-02-14 06:49:46,998 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/35e191e72900?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-14 06:49:47,316 unpacking tar archive at: mozilla-beta-35e191e72900/testing/mozharness/ program finished with exit code 0 elapsedTime=0.622072 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 06:49:46.916680) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-14 06:49:46.917099) ========= script_repo_revision: 35e191e72900ed4e51febc0d247c784499ccf244 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-14 06:49:46.917583) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-14 06:49:46.917857) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-14 06:49:46.928320) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-02-14 06:49:46.928665) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=6dbc10da6d83fee962c624be000001a8-1487083786.123185-1408978583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:49:47 INFO - MultiFileLogger online at 20170214 06:49:47 in /builds/slave/test 06:49:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 06:49:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:49:47 INFO - {'append_to_log': False, 06:49:47 INFO - 'base_work_dir': '/builds/slave/test', 06:49:47 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:49:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:49:47 INFO - 'branch': 'Mozilla-Beta', 06:49:47 INFO - 'buildbot_json_path': 'buildprops.json', 06:49:47 INFO - 'config_files': ('talos/linux_config.py',), 06:49:47 INFO - 'default_actions': ('clobber', 06:49:47 INFO - 'read-buildbot-config', 06:49:47 INFO - 'download-and-extract', 06:49:47 INFO - 'populate-webroot', 06:49:47 INFO - 'create-virtualenv', 06:49:47 INFO - 'install', 06:49:47 INFO - 'run-tests'), 06:49:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:49:47 INFO - 'download_minidump_stackwalk': True, 06:49:47 INFO - 'download_symbols': 'ondemand', 06:49:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:49:47 INFO - 'tooltool.py': '/tools/tooltool.py', 06:49:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:49:47 INFO - '/tools/misc-python/virtualenv.py')}, 06:49:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:49:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:49:47 INFO - 'installer_path': 'installer.exe', 06:49:47 INFO - 'log_level': 'info', 06:49:47 INFO - 'log_name': 'talos', 06:49:47 INFO - 'log_to_console': True, 06:49:47 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:49:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:49:47 INFO - 'opt_config_files': (), 06:49:47 INFO - 'pip_index': False, 06:49:47 INFO - 'sps_profile': False, 06:49:47 INFO - 'sps_profile_interval': 0, 06:49:47 INFO - 'suite': 'dromaeojs', 06:49:47 INFO - 'system_bits': '32', 06:49:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:49:47 INFO - 'title': 'talos-linux64-ix-050', 06:49:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:49:47 INFO - 'use_talos_json': True, 06:49:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:49:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:49:47 INFO - 'work_dir': 'build'} 06:49:47 INFO - [mozharness: 2017-02-14 14:49:47.745652Z] Running clobber step. 06:49:47 INFO - Running pre-action listener: _resource_record_pre_action 06:49:47 INFO - Running main action method: clobber 06:49:47 INFO - rmtree: /builds/slave/test/build 06:49:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:49:49 INFO - Running post-action listener: _resource_record_post_action 06:49:49 INFO - [mozharness: 2017-02-14 14:49:49.328534Z] Finished clobber step (success) 06:49:49 INFO - [mozharness: 2017-02-14 14:49:49.328631Z] Running read-buildbot-config step. 06:49:49 INFO - Running pre-action listener: _resource_record_pre_action 06:49:49 INFO - Running main action method: read_buildbot_config 06:49:49 INFO - Using buildbot properties: 06:49:49 INFO - { 06:49:49 INFO - "project": "", 06:49:49 INFO - "product": "firefox", 06:49:49 INFO - "script_repo_revision": "production", 06:49:49 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 06:49:49 INFO - "repository": "", 06:49:49 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 06:49:49 INFO - "buildid": "20170214045345", 06:49:49 INFO - "pgo_build": "True", 06:49:49 INFO - "basedir": "/builds/slave/test", 06:49:49 INFO - "buildnumber": 138, 06:49:49 INFO - "slavename": "talos-linux64-ix-050", 06:49:49 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:49:49 INFO - "platform": "ubuntu64_hw", 06:49:49 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 06:49:49 INFO - "branch": "mozilla-beta", 06:49:49 INFO - "repo_path": "releases/mozilla-beta", 06:49:49 INFO - "revision": "35e191e72900ed4e51febc0d247c784499ccf244", 06:49:49 INFO - "stage_platform": "linux64-pgo", 06:49:49 INFO - "builduid": "f73a1c7b50104d3ca9694f387f6d708a", 06:49:49 INFO - "slavebuilddir": "test" 06:49:49 INFO - } 06:49:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/NQd37SP0Q8qRX0Ql3tVkuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 06:49:49 INFO - Running post-action listener: _resource_record_post_action 06:49:49 INFO - [mozharness: 2017-02-14 14:49:49.331120Z] Finished read-buildbot-config step (success) 06:49:49 INFO - [mozharness: 2017-02-14 14:49:49.331207Z] Running download-and-extract step. 06:49:49 INFO - Running pre-action listener: _resource_record_pre_action 06:49:49 INFO - Running main action method: download_and_extract 06:49:49 INFO - mkdir: /builds/slave/test/build/tests 06:49:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:49:49 INFO - trying https://queue.taskcluster.net/v1/task/NQd37SP0Q8qRX0Ql3tVkuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 06:49:49 INFO - Downloading https://queue.taskcluster.net/v1/task/NQd37SP0Q8qRX0Ql3tVkuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 06:49:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NQd37SP0Q8qRX0Ql3tVkuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:49:49 INFO - Downloaded 1327 bytes. 06:49:49 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 06:49:49 INFO - Using the following test package requirements: 06:49:49 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 06:49:49 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 06:49:49 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 06:49:49 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 06:49:49 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 06:49:49 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 06:49:49 INFO - u'jsshell-linux-x86_64.zip'], 06:49:49 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 06:49:49 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 06:49:49 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 06:49:49 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 06:49:49 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 06:49:49 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 06:49:49 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 06:49:49 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 06:49:49 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 06:49:49 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 06:49:49 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 06:49:49 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:49:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NQd37SP0Q8qRX0Ql3tVkuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 06:49:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NQd37SP0Q8qRX0Ql3tVkuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:49:49 INFO - Fetch https://queue.taskcluster.net/v1/task/NQd37SP0Q8qRX0Ql3tVkuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 06:49:50 INFO - Http code: 200 06:49:50 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 06:49:50 INFO - x-amz-cf-id: mmHvGR7IohDdMviBSLm4NwRLH8SB2L48yFzDm3L_lpXoNvAq1yTkig== 06:49:50 INFO - x-amz-version-id: 2MndxJDQNxnetxJzA11Eoc3Zq4iY2DA5 06:49:50 INFO - Expected file size: 21958616 06:49:50 INFO - Obtained file size: 21958616 06:49:54 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:49:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NQd37SP0Q8qRX0Ql3tVkuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 06:49:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NQd37SP0Q8qRX0Ql3tVkuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:49:54 INFO - Fetch https://queue.taskcluster.net/v1/task/NQd37SP0Q8qRX0Ql3tVkuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 06:49:55 INFO - Http code: 200 06:49:55 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 06:49:55 INFO - x-amz-cf-id: BjBkQIqu1wlGhqJa8TNqsWs2t46aaODhQmVJnYXBzy51mCl20vSy2g== 06:49:55 INFO - x-amz-version-id: 2MndxJDQNxnetxJzA11Eoc3Zq4iY2DA5 06:49:55 INFO - Expected file size: 21958616 06:49:55 INFO - Obtained file size: 21958616 06:49:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NQd37SP0Q8qRX0Ql3tVkuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 06:49:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NQd37SP0Q8qRX0Ql3tVkuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:49:59 INFO - Fetch https://queue.taskcluster.net/v1/task/NQd37SP0Q8qRX0Ql3tVkuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 06:50:00 INFO - Http code: 200 06:50:00 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 06:50:00 INFO - x-amz-cf-id: rXp9mYEty7Yz7kBNLXAVgQ3DwT4Yrxiq5zphQF88hzZUImy7G66SRA== 06:50:00 INFO - x-amz-version-id: vneO6tY9gkR2muLxGfL40aAowQXUBshS 06:50:00 INFO - Expected file size: 14403005 06:50:00 INFO - Obtained file size: 14403005 06:50:00 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')]} 06:50:00 INFO - trying https://queue.taskcluster.net/v1/task/NQd37SP0Q8qRX0Ql3tVkuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 06:50:00 INFO - Downloading https://queue.taskcluster.net/v1/task/NQd37SP0Q8qRX0Ql3tVkuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 06:50:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NQd37SP0Q8qRX0Ql3tVkuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:50:01 INFO - Downloaded 57740131 bytes. 06:50:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NQd37SP0Q8qRX0Ql3tVkuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 06:50:01 INFO - mkdir: /builds/slave/test/properties 06:50:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:50:01 INFO - Writing to file /builds/slave/test/properties/build_url 06:50:01 INFO - Contents: 06:50:01 INFO - build_url:https://queue.taskcluster.net/v1/task/NQd37SP0Q8qRX0Ql3tVkuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 06:50:02 INFO - Running post-action listener: _resource_record_post_action 06:50:02 INFO - Running post-action listener: set_extra_try_arguments 06:50:02 INFO - [mozharness: 2017-02-14 14:50:02.471190Z] Finished download-and-extract step (success) 06:50:02 INFO - [mozharness: 2017-02-14 14:50:02.471415Z] Running populate-webroot step. 06:50:02 INFO - Running pre-action listener: _resource_record_pre_action 06:50:02 INFO - Running main action method: populate_webroot 06:50:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:50:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:50:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:50:02 INFO - '--tppagecycles', 06:50:02 INFO - '7'], 06:50:02 INFO - 'tests': ['tsvgm']}}, 06:50:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:50:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:50:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:50:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:50:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:50:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:50:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:02 INFO - 'talos_options': ['--disable-e10s'], 06:50:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:50:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:50:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:02 INFO - 'talos_options': ['--disable-e10s'], 06:50:02 INFO - 'tests': ['damp', 'tps']}, 06:50:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:02 INFO - 'tests': ['damp', 'tps']}, 06:50:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:50:02 INFO - 'tests': ['dromaeo_dom']}, 06:50:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:50:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:50:02 INFO - 'tests': ['basic_compositor_video']}, 06:50:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:50:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:50:02 INFO - 'tests': ['a11yr', 06:50:02 INFO - 'ts_paint', 06:50:02 INFO - 'tpaint', 06:50:02 INFO - 'sessionrestore', 06:50:02 INFO - 'sessionrestore_no_auto_restore', 06:50:02 INFO - 'tabpaint']}, 06:50:02 INFO - 'other-e10s': {'tests': ['a11yr', 06:50:02 INFO - 'ts_paint', 06:50:02 INFO - 'tpaint', 06:50:02 INFO - 'sessionrestore', 06:50:02 INFO - 'sessionrestore_no_auto_restore', 06:50:02 INFO - 'tabpaint']}, 06:50:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:50:02 INFO - 'ts_paint', 06:50:02 INFO - 'tpaint', 06:50:02 INFO - 'sessionrestore', 06:50:02 INFO - 'sessionrestore_no_auto_restore', 06:50:02 INFO - 'tabpaint']}, 06:50:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:50:02 INFO - 'ts_paint', 06:50:02 INFO - 'tpaint', 06:50:02 INFO - 'sessionrestore', 06:50:02 INFO - 'sessionrestore_no_auto_restore', 06:50:02 INFO - 'tabpaint']}, 06:50:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:50:02 INFO - 'tests': ['a11yr', 06:50:02 INFO - 'ts_paint', 06:50:02 INFO - 'tpaint', 06:50:02 INFO - 'sessionrestore', 06:50:02 INFO - 'sessionrestore_no_auto_restore', 06:50:02 INFO - 'tabpaint']}, 06:50:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:50:02 INFO - 'tests': ['a11yr', 06:50:02 INFO - 'ts_paint', 06:50:02 INFO - 'tpaint', 06:50:02 INFO - 'sessionrestore', 06:50:02 INFO - 'sessionrestore_no_auto_restore', 06:50:02 INFO - 'tabpaint']}, 06:50:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:50:02 INFO - 'tests': ['tsvgx', 06:50:02 INFO - 'tsvgr_opacity', 06:50:02 INFO - 'tart', 06:50:02 INFO - 'tscrollx', 06:50:02 INFO - 'cart']}, 06:50:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:50:02 INFO - 'tsvgr_opacity', 06:50:02 INFO - 'tart', 06:50:02 INFO - 'tscrollx', 06:50:02 INFO - 'cart']}, 06:50:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:02 INFO - 'talos_options': ['--disable-e10s'], 06:50:02 INFO - 'tests': ['tp5o']}, 06:50:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:02 INFO - 'tests': ['tp5o']}, 06:50:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:02 INFO - 'talos_options': ['--disable-e10s', 06:50:02 INFO - '--xperf_path', 06:50:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:50:02 INFO - 'tests': ['tp5n']}, 06:50:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:50:02 INFO - 'talos_options': ['--xperf_path', 06:50:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:50:02 INFO - 'tests': ['tp5n']}}, 06:50:02 INFO - 'talos.zip': {'path': '', 06:50:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:50:02 INFO - Running post-action listener: _resource_record_post_action 06:50:02 INFO - [mozharness: 2017-02-14 14:50:02.491023Z] Finished populate-webroot step (success) 06:50:02 INFO - [mozharness: 2017-02-14 14:50:02.491110Z] Running create-virtualenv step. 06:50:02 INFO - Running pre-action listener: _resource_record_pre_action 06:50:02 INFO - Running main action method: create_virtualenv 06:50:02 INFO - Creating virtualenv /builds/slave/test/build/venv 06:50:02 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:50:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:50:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:50:02 INFO - Using real prefix '/usr' 06:50:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:50:03 INFO - Installing distribute.............................................................................................................................................................................................done. 06:50:05 INFO - Installing pip.................done. 06:50:05 INFO - Return code: 0 06:50:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:50:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:50:05 INFO - Reading from file tmpfile_stdout 06:50:05 INFO - Output received: 06:50:05 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 06:50:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:50:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb1bc70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abff60>, '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 0x1ac0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac11d0>, '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': '6dbc10da6d83fee962c624be000001a8-1487083786.123185-1408978583', '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 06:50:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:50:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:50:05 INFO - Using env: {'DISPLAY': ':0', 06:50:05 INFO - 'HOME': '/home/cltbld', 06:50:05 INFO - 'LANG': 'en_US.UTF-8', 06:50:05 INFO - 'LANGUAGE': 'en_US:en', 06:50:05 INFO - 'LOGNAME': 'cltbld', 06:50:05 INFO - 'MAIL': '/var/mail/cltbld', 06:50:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:05 INFO - 'MOZ_NO_REMOTE': '1', 06:50:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:05 INFO - 'NO_EM_RESTART': '1', 06:50:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:05 INFO - 'PWD': '/builds/slave/test', 06:50:05 INFO - 'SHELL': '/bin/bash', 06:50:05 INFO - 'SHLVL': '1', 06:50:05 INFO - 'TERM': 'linux', 06:50:05 INFO - 'TMOUT': '86400', 06:50:05 INFO - 'USER': 'cltbld', 06:50:05 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1487083786.123185-1408978583', 06:50:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:05 INFO - '_': '/tools/buildbot/bin/python'} 06:50:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:05 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:50:05 INFO - Cleaning up... 06:50:05 INFO - Return code: 0 06:50:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:50:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb1bc70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abff60>, '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 0x1ac0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac11d0>, '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': '6dbc10da6d83fee962c624be000001a8-1487083786.123185-1408978583', '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 06:50:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:50:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:50:05 INFO - Using env: {'DISPLAY': ':0', 06:50:05 INFO - 'HOME': '/home/cltbld', 06:50:05 INFO - 'LANG': 'en_US.UTF-8', 06:50:05 INFO - 'LANGUAGE': 'en_US:en', 06:50:05 INFO - 'LOGNAME': 'cltbld', 06:50:05 INFO - 'MAIL': '/var/mail/cltbld', 06:50:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:05 INFO - 'MOZ_NO_REMOTE': '1', 06:50:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:05 INFO - 'NO_EM_RESTART': '1', 06:50:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:05 INFO - 'PWD': '/builds/slave/test', 06:50:05 INFO - 'SHELL': '/bin/bash', 06:50:05 INFO - 'SHLVL': '1', 06:50:05 INFO - 'TERM': 'linux', 06:50:05 INFO - 'TMOUT': '86400', 06:50:05 INFO - 'USER': 'cltbld', 06:50:05 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1487083786.123185-1408978583', 06:50:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:05 INFO - '_': '/tools/buildbot/bin/python'} 06:50:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:05 INFO - Downloading/unpacking psutil>=3.1.1 06:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:50:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:50:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:50:07 INFO - Installing collected packages: psutil 06:50:07 INFO - Running setup.py install for psutil 06:50:07 INFO - building 'psutil._psutil_linux' extension 06:50:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:50:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:50:08 INFO - building 'psutil._psutil_posix' extension 06:50:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:50:08 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:50:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:50:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:50:08 INFO - Successfully installed psutil 06:50:08 INFO - Cleaning up... 06:50:08 INFO - Return code: 0 06:50:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb1bc70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abff60>, '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 0x1ac0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac11d0>, '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': '6dbc10da6d83fee962c624be000001a8-1487083786.123185-1408978583', '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 06:50:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:50:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:50:08 INFO - Using env: {'DISPLAY': ':0', 06:50:08 INFO - 'HOME': '/home/cltbld', 06:50:08 INFO - 'LANG': 'en_US.UTF-8', 06:50:08 INFO - 'LANGUAGE': 'en_US:en', 06:50:08 INFO - 'LOGNAME': 'cltbld', 06:50:08 INFO - 'MAIL': '/var/mail/cltbld', 06:50:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:08 INFO - 'MOZ_NO_REMOTE': '1', 06:50:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:08 INFO - 'NO_EM_RESTART': '1', 06:50:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:08 INFO - 'PWD': '/builds/slave/test', 06:50:08 INFO - 'SHELL': '/bin/bash', 06:50:08 INFO - 'SHLVL': '1', 06:50:08 INFO - 'TERM': 'linux', 06:50:08 INFO - 'TMOUT': '86400', 06:50:08 INFO - 'USER': 'cltbld', 06:50:08 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1487083786.123185-1408978583', 06:50:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:08 INFO - '_': '/tools/buildbot/bin/python'} 06:50:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:50:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:50:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:50:10 INFO - Installing collected packages: mozsystemmonitor 06:50:10 INFO - Running setup.py install for mozsystemmonitor 06:50:10 INFO - Successfully installed mozsystemmonitor 06:50:10 INFO - Cleaning up... 06:50:10 INFO - Return code: 0 06:50:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:50:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb1bc70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abff60>, '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 0x1ac0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac11d0>, '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': '6dbc10da6d83fee962c624be000001a8-1487083786.123185-1408978583', '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 06:50:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:50:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:50:10 INFO - Using env: {'DISPLAY': ':0', 06:50:10 INFO - 'HOME': '/home/cltbld', 06:50:10 INFO - 'LANG': 'en_US.UTF-8', 06:50:10 INFO - 'LANGUAGE': 'en_US:en', 06:50:10 INFO - 'LOGNAME': 'cltbld', 06:50:10 INFO - 'MAIL': '/var/mail/cltbld', 06:50:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:10 INFO - 'MOZ_NO_REMOTE': '1', 06:50:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:10 INFO - 'NO_EM_RESTART': '1', 06:50:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:10 INFO - 'PWD': '/builds/slave/test', 06:50:10 INFO - 'SHELL': '/bin/bash', 06:50:10 INFO - 'SHLVL': '1', 06:50:10 INFO - 'TERM': 'linux', 06:50:10 INFO - 'TMOUT': '86400', 06:50:10 INFO - 'USER': 'cltbld', 06:50:10 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1487083786.123185-1408978583', 06:50:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:10 INFO - '_': '/tools/buildbot/bin/python'} 06:50:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:11 INFO - Downloading/unpacking jsonschema==2.5.1 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50: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 06:50:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:50:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:50:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:13 INFO - Downloading functools32-3.2.3-2.tar.gz 06:50:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:50:13 INFO - warning: no files found matching '*.txt' 06:50:13 INFO - no previously-included directories found matching 'build' 06:50:13 INFO - no previously-included directories found matching 'dist' 06:50:13 INFO - no previously-included directories found matching '.git*' 06:50:13 INFO - Installing collected packages: jsonschema, functools32 06:50:13 INFO - Running setup.py install for functools32 06:50:13 INFO - warning: no files found matching '*.txt' 06:50:13 INFO - no previously-included directories found matching 'build' 06:50:13 INFO - no previously-included directories found matching 'dist' 06:50:13 INFO - no previously-included directories found matching '.git*' 06:50:13 INFO - Successfully installed jsonschema functools32 06:50:13 INFO - Cleaning up... 06:50:13 INFO - Return code: 0 06:50:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:50: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')]} 06:50:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50: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')]} 06:50:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb1bc70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abff60>, '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 0x1ac0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac11d0>, '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': '6dbc10da6d83fee962c624be000001a8-1487083786.123185-1408978583', '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 06:50:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:50:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:50:13 INFO - Using env: {'DISPLAY': ':0', 06:50:13 INFO - 'HOME': '/home/cltbld', 06:50:13 INFO - 'LANG': 'en_US.UTF-8', 06:50:13 INFO - 'LANGUAGE': 'en_US:en', 06:50:13 INFO - 'LOGNAME': 'cltbld', 06:50:13 INFO - 'MAIL': '/var/mail/cltbld', 06:50:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:13 INFO - 'MOZ_NO_REMOTE': '1', 06:50:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:13 INFO - 'NO_EM_RESTART': '1', 06:50:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:13 INFO - 'PWD': '/builds/slave/test', 06:50:13 INFO - 'SHELL': '/bin/bash', 06:50:13 INFO - 'SHLVL': '1', 06:50:13 INFO - 'TERM': 'linux', 06:50:13 INFO - 'TMOUT': '86400', 06:50:13 INFO - 'USER': 'cltbld', 06:50:13 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1487083786.123185-1408978583', 06:50:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:13 INFO - '_': '/tools/buildbot/bin/python'} 06:50:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:50:13 INFO - Cleaning up... 06:50:13 INFO - Return code: 0 06:50:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:50: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')]} 06:50:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50: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')]} 06:50:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb1bc70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abff60>, '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 0x1ac0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac11d0>, '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': '6dbc10da6d83fee962c624be000001a8-1487083786.123185-1408978583', '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 06:50:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:50:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:50:13 INFO - Using env: {'DISPLAY': ':0', 06:50:13 INFO - 'HOME': '/home/cltbld', 06:50:13 INFO - 'LANG': 'en_US.UTF-8', 06:50:13 INFO - 'LANGUAGE': 'en_US:en', 06:50:13 INFO - 'LOGNAME': 'cltbld', 06:50:13 INFO - 'MAIL': '/var/mail/cltbld', 06:50:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:13 INFO - 'MOZ_NO_REMOTE': '1', 06:50:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:13 INFO - 'NO_EM_RESTART': '1', 06:50:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:13 INFO - 'PWD': '/builds/slave/test', 06:50:13 INFO - 'SHELL': '/bin/bash', 06:50:13 INFO - 'SHLVL': '1', 06:50:13 INFO - 'TERM': 'linux', 06:50:13 INFO - 'TMOUT': '86400', 06:50:13 INFO - 'USER': 'cltbld', 06:50:13 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1487083786.123185-1408978583', 06:50:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:13 INFO - '_': '/tools/buildbot/bin/python'} 06:50:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:13 INFO - Downloading/unpacking blobuploader==1.2.4 06:50:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:15 INFO - Downloading blobuploader-1.2.4.tar.gz 06:50:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:50:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:50:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:16 INFO - Downloading docopt-0.6.1.tar.gz 06:50:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:50:16 INFO - Installing collected packages: blobuploader, requests, docopt 06:50:16 INFO - Running setup.py install for blobuploader 06:50:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:50:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:50:16 INFO - Running setup.py install for requests 06:50:17 INFO - Running setup.py install for docopt 06:50:17 INFO - Successfully installed blobuploader requests docopt 06:50:17 INFO - Cleaning up... 06:50:17 INFO - Return code: 0 06:50:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:50:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb1bc70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abff60>, '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 0x1ac0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac11d0>, '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': '6dbc10da6d83fee962c624be000001a8-1487083786.123185-1408978583', '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 06:50:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:50:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:50:17 INFO - Using env: {'DISPLAY': ':0', 06:50:17 INFO - 'HOME': '/home/cltbld', 06:50:17 INFO - 'LANG': 'en_US.UTF-8', 06:50:17 INFO - 'LANGUAGE': 'en_US:en', 06:50:17 INFO - 'LOGNAME': 'cltbld', 06:50:17 INFO - 'MAIL': '/var/mail/cltbld', 06:50:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:17 INFO - 'MOZ_NO_REMOTE': '1', 06:50:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:17 INFO - 'NO_EM_RESTART': '1', 06:50:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:17 INFO - 'PWD': '/builds/slave/test', 06:50:17 INFO - 'SHELL': '/bin/bash', 06:50:17 INFO - 'SHLVL': '1', 06:50:17 INFO - 'TERM': 'linux', 06:50:17 INFO - 'TMOUT': '86400', 06:50:17 INFO - 'USER': 'cltbld', 06:50:17 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1487083786.123185-1408978583', 06:50:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:17 INFO - '_': '/tools/buildbot/bin/python'} 06:50:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:50:17 INFO - Running setup.py (path:/tmp/pip-sCY3yW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:50:17 INFO - Running setup.py (path:/tmp/pip-fe_PHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:50:17 INFO - Running setup.py (path:/tmp/pip-MtTIPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:50:17 INFO - Running setup.py (path:/tmp/pip-Kgc_fD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:50:17 INFO - Running setup.py (path:/tmp/pip-rnKOJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:50:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:50:17 INFO - Running setup.py (path:/tmp/pip-8A7v4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:50:18 INFO - Running setup.py (path:/tmp/pip-0TkPrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:50:18 INFO - Running setup.py (path:/tmp/pip-l24oHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:50:18 INFO - Running setup.py (path:/tmp/pip-c7lrza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:50:18 INFO - Running setup.py (path:/tmp/pip-IhTuM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:50:18 INFO - Running setup.py (path:/tmp/pip-vLrovV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:50:18 INFO - Running setup.py (path:/tmp/pip-s7G0bJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:50:18 INFO - Running setup.py (path:/tmp/pip-Bnu1mi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:50:18 INFO - Running setup.py (path:/tmp/pip-jihL0b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:50:18 INFO - Running setup.py (path:/tmp/pip-TVhILz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:50:18 INFO - Running setup.py (path:/tmp/pip-QabR2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:50:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:50:18 INFO - Running setup.py (path:/tmp/pip-AgDGEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:50:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:50:18 INFO - Running setup.py install for manifestparser 06:50:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:50:18 INFO - Running setup.py install for mozcrash 06:50:19 INFO - Running setup.py install for mozdebug 06:50:19 INFO - Running setup.py install for mozdevice 06:50:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:50:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:50:19 INFO - Running setup.py install for mozfile 06:50:19 INFO - Running setup.py install for mozhttpd 06:50:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:50:19 INFO - Running setup.py install for mozinfo 06:50:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:50:19 INFO - Running setup.py install for mozInstall 06:50:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:50:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:50:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:50:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:50:19 INFO - Running setup.py install for mozleak 06:50:19 INFO - Running setup.py install for mozlog 06:50:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:50:19 INFO - Running setup.py install for moznetwork 06:50:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:50:20 INFO - Running setup.py install for mozprocess 06:50:20 INFO - Running setup.py install for mozprofile 06:50:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:50:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:50:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:50:20 INFO - Running setup.py install for mozrunner 06:50:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:50:20 INFO - Running setup.py install for mozscreenshot 06:50:20 INFO - Running setup.py install for moztest 06:50:20 INFO - Running setup.py install for mozversion 06:50:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:50:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:50:20 INFO - Cleaning up... 06:50:20 INFO - Return code: 0 06:50:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:50: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')]} 06:50:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50: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')]} 06:50:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb1bc70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abff60>, '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 0x1ac0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac11d0>, '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': '6dbc10da6d83fee962c624be000001a8-1487083786.123185-1408978583', '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 06:50:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:50:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:50:20 INFO - Using env: {'DISPLAY': ':0', 06:50:20 INFO - 'HOME': '/home/cltbld', 06:50:20 INFO - 'LANG': 'en_US.UTF-8', 06:50:20 INFO - 'LANGUAGE': 'en_US:en', 06:50:20 INFO - 'LOGNAME': 'cltbld', 06:50:20 INFO - 'MAIL': '/var/mail/cltbld', 06:50:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:20 INFO - 'MOZ_NO_REMOTE': '1', 06:50:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:20 INFO - 'NO_EM_RESTART': '1', 06:50:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:20 INFO - 'PWD': '/builds/slave/test', 06:50:20 INFO - 'SHELL': '/bin/bash', 06:50:20 INFO - 'SHLVL': '1', 06:50:20 INFO - 'TERM': 'linux', 06:50:20 INFO - 'TMOUT': '86400', 06:50:20 INFO - 'USER': 'cltbld', 06:50:20 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1487083786.123185-1408978583', 06:50:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:20 INFO - '_': '/tools/buildbot/bin/python'} 06:50:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:50:20 INFO - Running setup.py (path:/tmp/pip-QbXlTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:50:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:50:21 INFO - Running setup.py (path:/tmp/pip-9vVrt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:50:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:50:21 INFO - Running setup.py (path:/tmp/pip-p9zSsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:50:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:50:21 INFO - Running setup.py (path:/tmp/pip-phnjN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:50:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:50:21 INFO - Running setup.py (path:/tmp/pip-igAAtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:50:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:50:21 INFO - Running setup.py (path:/tmp/pip-ep0Unt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:50:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:50:21 INFO - Running setup.py (path:/tmp/pip-Mplqm9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:50:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:50:21 INFO - Running setup.py (path:/tmp/pip-TnOhkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:50:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:50:21 INFO - Running setup.py (path:/tmp/pip-2JTsrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:50:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:50:21 INFO - Running setup.py (path:/tmp/pip-M7yNDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:50:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:50:21 INFO - Running setup.py (path:/tmp/pip-tZLTgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:50:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:50:21 INFO - Running setup.py (path:/tmp/pip-ScYeDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:50:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:50:21 INFO - Running setup.py (path:/tmp/pip-GT5ram-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:50:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:50:21 INFO - Running setup.py (path:/tmp/pip-1k9n4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:50:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:50:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:50:21 INFO - Running setup.py (path:/tmp/pip-BGR_dJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:50:22 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)) 06:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:50:22 INFO - Running setup.py (path:/tmp/pip-Fi_g1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:50:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 06:50:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:50:22 INFO - Running setup.py (path:/tmp/pip-mArTEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:50:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:50:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:50:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:50:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:50:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:50:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:50:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:50:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:50:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:50:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:50:24 INFO - Downloading blessings-1.6.tar.gz 06:50:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:50:24 INFO - Installing collected packages: blessings 06:50:24 INFO - Running setup.py install for blessings 06:50:24 INFO - Successfully installed blessings 06:50:24 INFO - Cleaning up... 06:50:24 INFO - Return code: 0 06:50:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:50:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:50:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:50:24 INFO - Reading from file tmpfile_stdout 06:50:24 INFO - Current package versions: 06:50:24 INFO - argparse == 1.2.1 06:50:24 INFO - blessings == 1.6 06:50:24 INFO - blobuploader == 1.2.4 06:50:24 INFO - docopt == 0.6.1 06:50:24 INFO - functools32 == 3.2.3-2 06:50:24 INFO - jsonschema == 2.5.1 06:50:24 INFO - manifestparser == 1.1 06:50:24 INFO - mozInstall == 1.12 06:50:24 INFO - mozcrash == 1.0 06:50:24 INFO - mozdebug == 0.1 06:50:24 INFO - mozdevice == 0.48 06:50:24 INFO - mozfile == 1.2 06:50:24 INFO - mozhttpd == 0.7 06:50:24 INFO - mozinfo == 0.9 06:50:24 INFO - mozleak == 0.1 06:50:24 INFO - mozlog == 3.4 06:50:24 INFO - moznetwork == 0.27 06:50:24 INFO - mozprocess == 0.23 06:50:24 INFO - mozprofile == 0.28 06:50:24 INFO - mozrunner == 6.13 06:50:24 INFO - mozscreenshot == 0.1 06:50:24 INFO - mozsystemmonitor == 0.3 06:50:24 INFO - moztest == 0.8 06:50:24 INFO - mozversion == 1.4 06:50:24 INFO - psutil == 3.1.1 06:50:24 INFO - requests == 1.2.3 06:50:24 INFO - wsgiref == 0.1.2 06:50:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:50:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb1bc70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abff60>, '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 0x1ac0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac11d0>, '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': '6dbc10da6d83fee962c624be000001a8-1487083786.123185-1408978583', '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 06:50:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:50:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:50:24 INFO - Using env: {'DISPLAY': ':0', 06:50:24 INFO - 'HOME': '/home/cltbld', 06:50:24 INFO - 'LANG': 'en_US.UTF-8', 06:50:24 INFO - 'LANGUAGE': 'en_US:en', 06:50:24 INFO - 'LOGNAME': 'cltbld', 06:50:24 INFO - 'MAIL': '/var/mail/cltbld', 06:50:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:24 INFO - 'MOZ_NO_REMOTE': '1', 06:50:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:24 INFO - 'NO_EM_RESTART': '1', 06:50:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:24 INFO - 'PWD': '/builds/slave/test', 06:50:24 INFO - 'SHELL': '/bin/bash', 06:50:24 INFO - 'SHLVL': '1', 06:50:24 INFO - 'TERM': 'linux', 06:50:24 INFO - 'TMOUT': '86400', 06:50:24 INFO - 'USER': 'cltbld', 06:50:24 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1487083786.123185-1408978583', 06:50:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:24 INFO - '_': '/tools/buildbot/bin/python'} 06:50:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:50:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:50:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:50:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:50:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:50:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:50:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:50:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:50:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:50:24 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:50:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:50:24 INFO - Cleaning up... 06:50:24 INFO - Return code: 0 06:50:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:50:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:50:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:50:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:50:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:50:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffb1bc70f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19f58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ac2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1abff60>, '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 0x1ac0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac11d0>, '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': '6dbc10da6d83fee962c624be000001a8-1487083786.123185-1408978583', '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 06:50:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:50:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:50:24 INFO - Using env: {'DISPLAY': ':0', 06:50:24 INFO - 'HOME': '/home/cltbld', 06:50:24 INFO - 'LANG': 'en_US.UTF-8', 06:50:24 INFO - 'LANGUAGE': 'en_US:en', 06:50:24 INFO - 'LOGNAME': 'cltbld', 06:50:24 INFO - 'MAIL': '/var/mail/cltbld', 06:50:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:24 INFO - 'MOZ_NO_REMOTE': '1', 06:50:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:24 INFO - 'NO_EM_RESTART': '1', 06:50:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:24 INFO - 'PWD': '/builds/slave/test', 06:50:24 INFO - 'SHELL': '/bin/bash', 06:50:24 INFO - 'SHLVL': '1', 06:50:24 INFO - 'TERM': 'linux', 06:50:24 INFO - 'TMOUT': '86400', 06:50:24 INFO - 'USER': 'cltbld', 06:50:24 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1487083786.123185-1408978583', 06:50:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:24 INFO - '_': '/tools/buildbot/bin/python'} 06:50:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:50:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:50:25 INFO - Cleaning up... 06:50:25 INFO - Return code: 0 06:50:25 INFO - Running post-action listener: _resource_record_post_action 06:50:25 INFO - Running post-action listener: _start_resource_monitoring 06:50:25 INFO - Starting resource monitoring. 06:50:25 INFO - [mozharness: 2017-02-14 14:50:25.178166Z] Finished create-virtualenv step (success) 06:50:25 INFO - [mozharness: 2017-02-14 14:50:25.178671Z] Running install step. 06:50:25 INFO - Running pre-action listener: _resource_record_pre_action 06:50:25 INFO - Running main action method: install 06:50:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:50:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:50:25 INFO - Reading from file tmpfile_stdout 06:50:25 INFO - Detecting whether we're running mozinstall >=1.0... 06:50:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:50:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:50:25 INFO - Reading from file tmpfile_stdout 06:50:25 INFO - Output received: 06:50:25 INFO - Usage: mozinstall [options] installer 06:50:25 INFO - Options: 06:50:25 INFO - -h, --help show this help message and exit 06:50:25 INFO - -d DEST, --destination=DEST 06:50:25 INFO - Directory to install application into. [default: 06:50:25 INFO - "/builds/slave/test"] 06:50:25 INFO - --app=APP Application being installed. [default: firefox] 06:50:25 INFO - mkdir: /builds/slave/test/build/application 06:50:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:50:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:50:39 INFO - Reading from file tmpfile_stdout 06:50:39 INFO - Output received: 06:50:39 INFO - /builds/slave/test/build/application/firefox/firefox 06:50:39 INFO - Running post-action listener: _resource_record_post_action 06:50:39 INFO - [mozharness: 2017-02-14 14:50:39.122565Z] Finished install step (success) 06:50:39 INFO - [mozharness: 2017-02-14 14:50:39.122805Z] Running run-tests step. 06:50:39 INFO - Running pre-action listener: _resource_record_pre_action 06:50:39 INFO - Running main action method: run_tests 06:50:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:50:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:50:39 INFO - Python 2.7.3 06:50:39 INFO - Return code: 0 06:50:39 INFO - grabbing minidump binary from tooltool 06:50:39 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')]} 06:50:39 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 0x1abff60>, '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 0x1ac0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ac11d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:50:39 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 06:50:39 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 06:50:39 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 06:50:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:50:39 INFO - Return code: 0 06:50:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:50:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:50:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:50:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:50:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:50:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NQd37SP0Q8qRX0Ql3tVkuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 06:50:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NQd37SP0Q8qRX0Ql3tVkuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 06:50:39 INFO - Using env: {'DISPLAY': ':0', 06:50:39 INFO - 'HOME': '/home/cltbld', 06:50:39 INFO - 'LANG': 'en_US.UTF-8', 06:50:39 INFO - 'LANGUAGE': 'en_US:en', 06:50:39 INFO - 'LOGNAME': 'cltbld', 06:50:39 INFO - 'MAIL': '/var/mail/cltbld', 06:50:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:50:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:50:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:50:39 INFO - 'MOZ_NO_REMOTE': '1', 06:50:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:50:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:50:39 INFO - 'NO_EM_RESTART': '1', 06:50:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:50:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:50:39 INFO - 'PWD': '/builds/slave/test', 06:50:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:50:39 INFO - 'SHELL': '/bin/bash', 06:50:39 INFO - 'SHLVL': '1', 06:50:39 INFO - 'TERM': 'linux', 06:50:39 INFO - 'TMOUT': '86400', 06:50:39 INFO - 'USER': 'cltbld', 06:50:39 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1487083786.123185-1408978583', 06:50:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:50:39 INFO - '_': '/tools/buildbot/bin/python'} 06:50:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NQd37SP0Q8qRX0Ql3tVkuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 06:50:39 INFO - mozversion application_buildid: 20170214045345 06:50:39 INFO - mozversion application_changeset: 35e191e72900ed4e51febc0d247c784499ccf244 06:50:39 INFO - mozversion application_display_name: Firefox 06:50:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:50:39 INFO - mozversion application_name: Firefox 06:50:39 INFO - mozversion application_remotingname: firefox 06:50:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:50:39 INFO - mozversion application_vendor: Mozilla 06:50:39 INFO - mozversion application_version: 52.0 06:50:39 INFO - mozversion platform_buildid: 20170214045345 06:50:39 INFO - mozversion platform_changeset: 35e191e72900ed4e51febc0d247c784499ccf244 06:50:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:50:39 INFO - mozversion platform_version: 52.0 06:50:39 INFO - using testdate: 1487083839 06:50:39 INFO - actual date: 1487083839 06:50:39 INFO - starting webserver on 'localhost:34582' 06:50:39 INFO - SUITE-START | Running 2 tests 06:50:39 INFO - TEST-START | dromaeo_css 06:50:39 INFO - operating with platform_type : linux_ 06:50:39 INFO - Initialising browser for dromaeo_css test... 06:50:39 INFO - TEST-INFO | started process 4688 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNb1pW7/profile http://localhost:34582/getInfo.html) 06:50:43 INFO - PROCESS | 4688 | __metrics Screen width/height:1600/1200 06:50:43 INFO - PROCESS | 4688 | colorDepth:24 06:50:43 INFO - PROCESS | 4688 | Browser inner width/height: 1024/697 06:50:43 INFO - PROCESS | 4688 | __metrics 06:50:44 INFO - PROCESS | 4688 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:50:44 INFO - PROCESS | 4688 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:50:44 INFO - PROCESS | 4688 | console.error: PushService: 06:50:44 INFO - PROCESS | 4688 | stateChangeProcessEnqueue: Error transitioning state 06:50:44 INFO - PROCESS | 4688 | UnknownError 06:50:45 INFO - TEST-INFO | 4688: exit 0 06:50:45 INFO - Browser initialized. 06:50:45 INFO - Running cycle 1/1 for dromaeo_css test... 06:50:45 INFO - TEST-INFO | started process 4782 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNb1pW7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:50:56 INFO - PROCESS | 4782 | RSS: Main: 141496320 06:50:56 INFO - PROCESS | 4782 | 06:53:58 INFO - PROCESS | 4782 | Cycle 1(1): loaded http://localhost:34582/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34582/tests/dromaeo/cssquery-ext.html) 06:53:59 INFO - PROCESS | 4782 | RSS: Main: 249565184 06:53:59 INFO - PROCESS | 4782 | 06:57:01 INFO - PROCESS | 4782 | Cycle 1(1): loaded http://localhost:34582/tests/dromaeo/cssquery-ext.html (next: http://localhost:34582/tests/dromaeo/cssquery-jquery.html) 06:57:02 INFO - PROCESS | 4782 | RSS: Main: 228827136 06:57:02 INFO - PROCESS | 4782 | 07:00:04 INFO - PROCESS | 4782 | Cycle 1(1): loaded http://localhost:34582/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34582/tests/dromaeo/cssquery-mootools.html) 07:00:04 INFO - PROCESS | 4782 | RSS: Main: 176095232 07:00:04 INFO - PROCESS | 4782 | 07:03:06 INFO - PROCESS | 4782 | Cycle 1(1): loaded http://localhost:34582/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34582/tests/dromaeo/cssquery-prototype.html) 07:03:07 INFO - PROCESS | 4782 | RSS: Main: 218468352 07:03:07 INFO - PROCESS | 4782 | 07:06:09 INFO - PROCESS | 4782 | Cycle 1(1): loaded http://localhost:34582/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34582/tests/dromaeo/cssquery-yui.html) 07:06:10 INFO - PROCESS | 4782 | RSS: Main: 176226304 07:06:10 INFO - PROCESS | 4782 | 07:09:12 INFO - PROCESS | 4782 | Cycle 1(1): loaded http://localhost:34582/tests/dromaeo/cssquery-yui.html (next: http://localhost:34582/tests/dromaeo/cssquery-dojo.html) 07:09:13 INFO - PROCESS | 4782 | RSS: Main: 263077888 07:09:13 INFO - PROCESS | 4782 | 07:09:13 INFO - PROCESS | 4782 | __start_tp_report 07:09:13 INFO - PROCESS | 4782 | _x_x_mozilla_page_load 07:09:13 INFO - PROCESS | 4782 | _x_x_mozilla_page_load_details 07:09:13 INFO - PROCESS | 4782 | |i|pagename|runs| 07:09:13 INFO - PROCESS | 4782 | |0;dojo.html;3147.464930961736;3173.368049840134;3188.378266238083;3196.6483686794463;3208.4545627243365;5524.06090964536;5600.85997850054;5627.2684551008415;5633.183188437674;5656.632318899274;5570.637908535952;5574.777008919638;5575.972120139404;5582.665040097587;5588.161775733642;5046.697198168122;5071.822486212984;5103.081445339837;5112.463191364909;5171.87070323243;5032.396112466491;5038.647294689373;5040.722760248185;5099.872503187413;5154.819581314655;5091.032703786287;5161.406438259611;5171.508706672879;5190.117679994391;5195.246689230059;5201.609879259052;5206.869828254286;5207.114790485589;5210.76551555181;5231.424543300234;4911.45973942866;4963.032208719301;4989.975050124763;5073.0614836255045;5076.44159142494;5431.266778984826;5465.098258787295;5471.562275017989;5473.124300112003;5510.201020851994;5949.167116603679;5986.910196347058;5993.0710739835395;5999.520038396961;6000.459958603747;5912.320083190445;5991.820245392645;6022.6687532185715;6047.03247480401;6058.1215723719815;5522.585806064521;5571.609987300891;5573.303337082824;5596.832095037074;5621.7751289948765;6156.569040167145;6161.938380616137;6169.691515424211;6170.938290617037;6175.814725558241;5740.712964351849;5786.247787787561;5884.7940322088525;5892.440218179266;5896.882062358729;5957.672328022;6000.5799594028;6021.6989150542295;6033;6034.909476357858;5974.671393073423;5979;5985.371535988746;5988.760449581968;5992.850178745479;5755.050416681201;5917.644941303535;5984.581079324493;5988.371221021817;6016.909746353808;4561.954380456219;4616.838410655678;4619.930701039487;4641.535846415399;4715.009847931904;4109.938350924679;4116.794160292034;4121.732087414309;4131.628153466142;4148.274052040942;5723.255976723;5733.512651424676;5736.13957906309;5742.483176514133;5756.194132821408;5745.540356771448;5820.621659592113;5926.614770039933;5971.790987315423;6021.217241758631;5692.800751973661;5693.259876216065;5705.486506214461;5707.229524014205;5728.77084916607;5201.1678131498775;5202.557782588522;5213.947860521346;5215.426303106655;5265.4997775211295;5972.731227094791;6025.578209525291;6143.542582966849;6191.133241346305;6261.686915654199;6053.061775424816;6067.696615169312;6083.482903953213;6096.573239873166;6109.20580324555;6267.937320626917;6298.212723409574;6303.49572034227;6305.558610897193;6309.7160627770945;5756.136579513107;5760.884782304247;5835.066389377679;5943.405659434195;5945.851353716192;5956.047032474783;6056.333803281724;6059.848503787441;6088.51291896656;6094.329623741296;5853.765849366148;5886.793962211302;5897.203877476486;5904.3210030847;5906.114082887601;5651.180578815966;5786.30564332266;5888.941110588839;5895.557833162444;5899.144624029577;5774.82675519735;5798.94201057984;5827.155062515996;5878.970605146947;5922.763089476372;5952.196453478899;5957.3446920837805;5964.8807023860145;5965.463108320272;5972.104184372379;5621.775128994795;5676.886462270814;5748.310202775527;5795.82612521625;5832.300123985149 07:09:13 INFO - PROCESS | 4782 | |1;ext.html;549.5054450994106;566.8979583674939;595.3956733915076;597.510041765752;602.7528713227578;33599.832000840026;35802.641973580256;43386.13227735443;44472.77763611185;44518;45222.547774522245;45675.54324456755;45687.086258274816;45695.543044569546;45745.54254457454;8948.821023579509;9077.228435582983;9080.545972701371;9087.818243635124;9088.318376121784;8535.231829135377;8683.652653893869;8690.08754080822;8997.325200609948;10750.354978701303;10817.459127043656;11115.44422778862;11120.110391168688;11128.221024528286;11130.610428635;10889.074428673572;10946.99999999996;10949.890501094967;10952.507137178845;10959.616413425492;10864.293820901616;10920;10929;10930.617428389969;10932.890671093266;42772;43006.13987720259;43125.78437107794;43158.56841431577;43196.13607727859;3689.631036896316;4097.959020409788;4212.241796476633;4243.91512169758;4340.761258130801;31898.521522177187;32225.51661725076;32467.83766081178;32524;32960.835195824104;3683.208110256281;3768.2651882882847;3776.282506323817;3788.2234142000825;3822.694184465236;315332;316588;316837;319863;319970;37530.624693753256;58774.41225587775;58953.115703264484;59029;59145;37870.62129378726;40277.59722402797;40287.194256114715;40297.59702402938;40300.19399611992;15785.921070394805;15878.603034923988;15908.681826363409;15912.602184945468;15916.204189790464;13461.259630720404;13485.662858428617;13528.391222395016;13542.526011589744;13545.39045742944;8716.346274029473;8849.60176792046;9016.368854180275;9268.073192680678;9388.2020028297;3599.1002249437643;3610.981945090258;3615.584207816082;3631.455281707765;3671.2473942841652;1039.7556574205055;1042.8227201375785;1042.9895701043044;1082.6427278997912;1087.4671411008708;31693.683063169534;32150.678493215237;32235.67764322327;32692.67307326896;32712.182195444828;1119.2892513254142;1152.590830255264;1155.4648006574164;1209.5464200924653;1212.775636507249;16791;16992.915035424743;17017.234224459928;17042.74435883463;17309.221085051202;158121;158375;158718;158799;158963;57014.14478782821;57805.710971444874;58527.70736146292;58689.41310586925;58824.41175588189;1410.971780564383;1432.4771458417601;1435.131745294103;1452.6368407898026;1461.9561413157621;30917.536236956912;33308.167295817795;33358.33283334271;33450.330993380485;33476;51788.48211517837;51895.481045189066;52466;52503;52585.7370713144;429061;434047;435671;437490;438702;29592.40815183641;29621.703782962755;29896.25259368533;30024.849875751355;30109.096727098222;46726.766366169315;47401;47452;47876.7606161967;48789.268160976906;41105.588944110175;41177.588224117375;41601.583984160985;41823.58176418197;43141.3528797062;40926.38610420906;41638.58361416347;41772.79113604534;42145.78927105345;42172;41636.58363416448;41889.162216754885;41910.79044604758;42061.36907946322;42685.78657106694;35040.82479587586;37668.43497347597;37764;37922.810385947894;38520;28523;28736.856315718287;28819.135425937257;28820.855895720386;28858.567121492775 07:09:13 INFO - PROCESS | 4782 | |2;jquery.html;387.78284160869896;405.39393606558184;413.75381647919494;413.81998830508724;427.13292017205066;15198.392064317428;19277.614447711054;19401.90299048506;19433.902830485844;19644.70532942007;19117.330893418733;19157.616847663037;19297.22811087555;19537.804621953812;19944.50138746532;4992.226204938241;5713.971430142843;5750.281214848144;5908.497777688902;5910.408959104098;5834.795782147626;5916.526677865761;5920.348761636238;5921.082232254007;5924.792632257871;5725.9449102988465;5735.483806457418;5795.768169273224;5801.796937107202;5890.793822216223;5813.476787089161;5849.415058494159;5858.88282234355;5858.970705146489;5859.0625499920025;5070.3915530136255;5276.525112739833;5284.788608455658;5310.7610157543;5321.3348331458565;22380.552388952292;22595.096196152135;23191.76808231913;23280.534389312288;23336.533269334686;2424.078850036992;2449.669294645218;2461.212412028152;2469.493753780471;2730.8361498310164;9836.852447213298;13909.359340104827;14237;14586.270686465634;14681.559553213421;1889.2820728123363;1968.9606207875763;2008.708737233093;2029.695545668147;2030.7766145723958;80729.19270807334;82460.58769706172;82671;83990;85016.57491712502;10275;10422.5830966762;10646.14830813533;11383.943080284545;11603.129765267639;14838.406463741545;14867.70264594702;14890.181040042686;14904.62738431548;15193.924030379778;6555.639439830855;6692;8092.231238032377;8586.957065214634;8822.911770882338;8367;8376.70681526156;8413;8597.140285971353;8644.654213831502;4433.7561434121435;4775.403074615673;4790.640701947298;4896.5837903777865;4975.114433628487;1995.1321175288797;2010.1858747207111;2010.9497262568261;2047.6076268137513;2064.587082583459;897.9012308646044;922.082527884759;942.3497786527412;987.9950600247097;1018.8930162332997;17912.10439478021;18740.818779398378;19186.712199317022;19284.80715192858;19456.513587160152;974.9268804839666;988.5156273426113;999.6551189839494;1010.4897027001317;1012.2003617142523;10076.143527800072;10378.844317335246;10598.470076496144;10697.518611662494;10741;362579;366529;371341;483212;506521;72239;74240.9167495793;97192;102562;103606;987.4618333008527;1042.61944390297;1043.660810236676;1051.9053285204368;1053.2521909444226;17119.400820971205;17468.30126794914;17624.206910688794;17793.555161121076;18159.364422245686;40090.79954600208;42108.789456053746;42949.570504294556;42991.57008429876;44209;56062.71968640131;58837.41162588319;60015;60862;61003.389966101546;8390.580470976549;8418.074011858813;8564.74305770828;8606.612702428281;8822.161894620001;13544.119632223874;13554.661133471347;13624.795628065389;13717.931410343284;13891;11304.321740695585;11438.82841757391;11524.711882203012;11699.718554881716;11849.466773995018;11355;11656.417179140839;11760.941195293968;11843.170978031456;11865.466054027762;11462.598809041643;11585.536578537101;11964.700882478008;12138.757224855277;12165.270083795001;8554.57227138653;8651;8664.263537599374;8717.91282087171;9197.86203206939;10966.945165274123;11879.346635935106;12044.578439754567;12078.698032549257;12160.574379896661 07:09:13 INFO - PROCESS | 4782 | |3;mootools.html;1478.7855760914672;1529.9770503442448;1641.8029836419623;1796.16478337573;1820.8270214329634;7921.84156316874;8397.412181147321;8401.159884011597;8409.95795021024;8410.537420441873;7218.061651985235;7390.445716571266;7402.592857392841;7596.240375962415;8275.462094963823;2258.9096436142577;2348.6847365475387;2349.753275906031;2358.3160883343894;2372.146027430124;2349.0721165139757;2351.329870986769;2352.4589344450787;2365.7989070928907;2369.6919400477914;2351.376885125443;2365.3495288795634;2366.8579885206855;2369.0642196332437;2371.205646108556;2259.67234750961;2289.8511596746325;2291.5302363015544;2292;2292.472731271817;2336.4392545788887;2342.0748804222408;2348.9060437582475;2349.5066036132434;2350.9059637614473;8201.589920503951;8324.791880202984;8337.374696897758;8347.373946953941;8349.457285276438;5048.091343558158;5144.794208231666;5153.613478989053;5167.896642067175;5196.740162991835;3049.450952220397;3082.1832214463184;3143.701348371901;3218.340240250743;3233.611966564027;976.5703090640095;1020.7907378987364;1053.210092430677;1058.4178701714027;1059.3485006720812;11429.485673144729;11443.313401195956;11450.599229027028;11451.083913287;11477.253978491372;4266.189424009428;4486.528914463999;4548.840790572381;4549.181147393501;4550.658700597469;9603.231741460666;9620;9651.227901767841;9668.564914578861;9673.37123086997;5159.509846564571;5166.354205724285;5168.121419358718;5168.9224661630105;5173.767180476888;4619.815207391666;4728.243481043017;4748.786304616231;4757.881052973634;4763.54746299101;3906.4726261954843;3953.1105501261986;3993.980030099831;4031.2139132869397;4062.289099407592;1299.1944994103717;1299.4996926183487;1311.5868501422021;1312.7046414556648;1314.572763851752;903.0698380667923;931.2270815223349;968.5351031504777;971.5919313888184;988.8071825994006;5358.115910874662;5467.1799230115;5497.945020549823;5634.97182514093;5655.1517272409465;905.6558507767138;922.6586163119555;922.916937475617;947.3179310896144;957.1051067252002;3696.4085746280466;4011.6991225658194;4017.7656986125867;4043.1509383029306;4112.938305925413;9956.452395118193;10052.497375131361;10117.544710488046;10151.94924025375;10161.288709790391;10115.949420252999;10133.543990520444;10138.188944884392;10138.949305253574;10139.087482126644;7718.845623087619;7836.882446763303;7844.940932974089;7845.725399610987;7848.725294614661;5125.923556053271;5355.357357117171;5448.291722076105;5485.807996720096;5489.533389661923;8978.416402933788;8996.235319997873;8997.820043599222;9019.909800902169;9042.005379408129;9093.727188184364;9124.31567632417;9137.40606860552;9189.816203675755;9206.125418085272;6365.713542890674;6549.410553050248;6556.082148499118;6692.899606506004;6822.079019332326;7925.28672419485;7992.040955085427;8126.065502467292;8144.796380090545;8151.79620509492;7110.57336559808;7151.678174482056;7184.1019872515935;7316.597587132546;7354.485186036926;6768.221654509597;6840.931590684029;6849.760258391132;6869.828254293483;6872.347127022925;6320.747170113144;6416.197975253093;6431.29255781873;6440.420362167428;6443.6455994920725;4855.368802055851;4912.778924948315;4938.950610493993;4941.50584941503;4946.0355230729665;4895.118878601744;4993.675411098267;5168.0697474454955;5176.06830770465;5182.818601348935 07:09:13 INFO - PROCESS | 4782 | |4;prototype.html;335.88076232937306;336.6058906030855;343.88307975288404;347.7009771596425;351.8223297234896;5257.500537448946;5394.298741163648;5413.702246376448;5436.429174936629;5446.809361672337;5257.526822585966;5300.250917197325;5318.601104917137;5347.171188465784;5373.81191658292;4292.549282325358;4298.548652391501;4299.871003869874;4304.268274393345;4369.104333611618;4199.664026877843;4235.301175306071;4330.870073897788;4335.43639326887;4385.407969924051;4224.704270701052;4260.403543503897;4271.124419493996;4286.635635970946;4292.12011537634;4274.273373526493;4284.729093580392;4288.378185163134;4290.957090429087;4299.871003869857;3780.621937806225;3837.7313588048846;3851.8844434667003;3858.765195137557;3860.3823388258024;5285.656432331886;5286.867828304285;5291.3385826771655;5311.937612477482;5374.435684253136;4912.263160525914;4918.360613120271;4935.235038569028;4938.185199442088;4952.579030782388;5435.87437223598;5577.721113944327;5581.888362232773;5641.26663533738;5685.829425117253;4188;4199.727017743837;4199.9370009449885;4202.2646036943415;4219.2194444027955;5885.470307672287;5899.174115623816;5902.793402230901;5904.17341572176;5905.114232865105;4159.168166366739;4318.740875547477;4326.394304797331;4342.240107981091;4344.695871288979;4336.284513055373;4340.218760623118;4351.782410879443;4354.911272181955;4358.803853826522;4872.6589138760655;4879.926801097987;4880.6583539152625;4882.194437917775;4895.335585900811;5545.833624991256;5648.9717551412805;5659.009673307155;5680.608250978454;5698.886022279531;1449.4999225267266;1452.9611327900602;1460.3136525832842;1463.3122432456728;1471.6247356923916;958.9136977672043;994.6568433890296;1010.141379827141;1019.4393083803878;1021.824901363438;5200.7919683213;5233.241180028951;5299.947000530023;5351;5352.384475785257;5518.724063796794;5585.972070139705;5620.229627667271;5620.285812827045;5672.546196304285;5036.420811606639;5256.789728410898;5261.579073674096;5301.932246423898;5332.440093790096;2941.9411611767646;2977.985110074436;2979.957015044717;2981.8807247710283;2998.2354499602898;5803.752193278466;5815.82552523425;5821.18503409523;5845.048250633403;5858.209141765892;5629.802956896489;5941.673207973517;5969.462748352669;6012.939870601325;6016.849578760566;6096.481799047042;6139.447449729546;6145.354737752472;6148.538859585459;6163.445289923929;5652.886942261214;5896.174535564938;5897.70511474416;5925.644461332334;5953.553483488669;5825.621334613236;5831.766729330949;5850.444207800252;5855.238818953509;5856.443637854397;5880.529557635465;6052.606580572248;6070.939290607037;6092.847678808065;6113.908291375544;3952.26883026641;4063.959360406358;4111;4133.318002529549;4214.620684138442;5847.181394604674;5848.766049357978;5894.528437725057;5924.11138329254;5926.881462370815;5550.639208451437;5741.425857414225;5749.798757043483;5763.7406316715005;5782.10377391505;5657.971710141423;5661.575381846295;5667.5465962722055;5669.489745922887;5703.230063941315;5606.439356064361;5629.155626655871;5633.0705433603;5633.492985631313;5649.971750141387;5517.779288828402;5659.660420374791;5717.342505611908;5733.197352370588;5741.540676745767;5587.720613969366;5591.580631452576;5600.971995139998;5627.718614069362;5634.74643641029 07:09:13 INFO - PROCESS | 4782 | |5;yui.html;722.7831650504849;763.8739607964686;777.8133248020476;807.919208079192;866.1122349591672;13975.161490310576;14913.925430372847;15142.924285378585;15149.166795826226;15152.848471515295;13570.253636050013;13615.863841361583;13718.108322959;13722.176669399843;13741.72516549671;714.6069661686078;731.042334541752;815.1318845429628;840.9032961209479;842.751388340441;843.3674743942044;843.6245870587591;844.273924424994;844.307667712476;844.4426678392263;872.9127087291283;873.2708188662443;873.8645509945968;873.9868901966476;874.1477059866643;862.5687156421789;864.8140649760269;866.164151593712;866.3848667446152;867.3624885708999;634.3497914637487;638.677467878723;638.8434833465831;639.8720255948829;641.9197600299963;13613.183209007393;13890.374933128034;13894.791578126336;13942.860571394258;14628;14065.578032659037;14762.261886905611;14876.851231487655;14884.702305953928;14902.466580681203;11979.820302695467;12109.978987432127;12146.33195174265;12275.38623068843;12308.015358771367;3754.530683664542;3849.172427928009;3855.5373355197275;3863.0728625130046;3895.590962948878;62806.371936280506;65684.67157664277;66058.3394166057;66124;67706;10963;11061.502232399562;11269.380184089954;11339.376334301527;11634.883651163549;21488.462788430414;21550.78449215519;21591.136354545957;21661.133554657954;21978.560428791334;7451.366633836076;7567.31894129531;7573.394128469709;7601.619919004028;7717.498362606412;4571.428571428572;4589.128065667513;4619.099275641285;4741.0991911537385;4797.95202047982;3384.2047118927035;3473.4095203815414;3512.7365447591533;3514.9648503514636;3517.050396393011;575.0482950716571;589.6579983609496;593.5103539579864;606.1756011823916;616.7872084130968;672.2235817630644;709.0888208651858;710.3500297227979;717.5802155738951;732.1543617122126;8188.26305632484;8936.553172341357;8997.280217582578;9152.31357648179;9171.082871771372;617.8331850400367;685.2975699907635;692.6155983429145;711.871863064643;714.5426926766874;4218.894527636772;4261.0838669685545;4347.695661303678;4362.0185458271635;4398.318260669601;86217;86872;88978.55510722534;89611;90343;48576;77997.22002780013;78177;81411.18588814154;81715;42392;62049;65980.34019659838;67145.66427167832;67872.32127678758;8272.17278272168;8650.524221167896;8727.65089396417;8756.605952732016;8770.780730481789;41400.58599413967;41742.37386439145;43115.7844210777;45880;49722.75138624429;54858.45141548533;55586;56336;57816.71091644515;58972.70513647404;12393.62819115428;12426.62720118398;12469.937650311691;12575.748485030432;12938.676533086747;14075.296235187994;14754.557363279118;14905.925470372578;14949.77575336349;15057.322420490886;13962.301884905512;14042.166448610413;14179.716405671623;14311;14623.34194961208;12308.569200078313;12503.812442813183;12541.030558115428;12688.17526860751;12740.68148296263;11637.76724465523;13138.671533211746;13228.735425291632;13702.45190192421;13717.382717777524;10224;10323.587056517656;10433.634822781167;10766.523152797614;11022.228444008842;10682.73293167677;11187.944060279646;11211.996079582537;11407.714807129556;11419.14356423255 07:09:13 INFO - PROCESS | 4782 | __end_tp_report 07:09:13 INFO - PROCESS | 4782 | __start_cc_report 07:09:13 INFO - PROCESS | 4782 | _x_x_mozilla_cycle_collect,1031 07:09:13 INFO - PROCESS | 4782 | __end_cc_report 07:09:13 INFO - PROCESS | 4782 | __startTimestamp1487084953114__endTimestamp 07:09:13 INFO - PROCESS | 4782 | 07:09:13 INFO - PROCESS | 4782 | ------- Summary: start ------- 07:09:13 INFO - PROCESS | 4782 | Number of tests: 6 07:09:13 INFO - PROCESS | 4782 | 07:09:13 INFO - PROCESS | 4782 | [#0] dojo.html Cycles:165 Average:5571.51 Median:5756.19 stddev:635.16 (11.0%) stddev-sans-first:607.98 07:09:13 INFO - PROCESS | 4782 | Values: 3147.5 3173.4 3188.4 3196.6 3208.5 5524.1 5600.9 5627.3 5633.2 5656.6 5570.6 5574.8 5576.0 5582.7 5588.2 5046.7 5071.8 5103.1 5112.5 5171.9 5032.4 5038.6 5040.7 5099.9 5154.8 5091.0 5161.4 5171.5 5190.1 5195.2 5201.6 5206.9 5207.1 5210.8 5231.4 4911.5 4963.0 4990.0 5073.1 5076.4 5431.3 5465.1 5471.6 5473.1 5510.2 5949.2 5986.9 5993.1 5999.5 6000.5 5912.3 5991.8 6022.7 6047.0 6058.1 5522.6 5571.6 5573.3 5596.8 5621.8 6156.6 6161.9 6169.7 6170.9 6175.8 5740.7 5786.2 5884.8 5892.4 5896.9 5957.7 6000.6 6021.7 6033.0 6034.9 5974.7 5979.0 5985.4 5988.8 5992.9 5755.1 5917.6 5984.6 5988.4 6016.9 4562.0 4616.8 4619.9 4641.5 4715.0 4109.9 4116.8 4121.7 4131.6 4148.3 5723.3 5733.5 5736.1 5742.5 5756.2 5745.5 5820.6 5926.6 5971.8 6021.2 5692.8 5693.3 5705.5 5707.2 5728.8 5201.2 5202.6 5213.9 5215.4 5265.5 5972.7 6025.6 6143.5 6191.1 6261.7 6053.1 6067.7 6083.5 6096.6 6109.2 6267.9 6298.2 6303.5 6305.6 6309.7 5756.1 5760.9 5835.1 5943.4 5945.9 5956.0 6056.3 6059.8 6088.5 6094.3 5853.8 5886.8 5897.2 5904.3 5906.1 5651.2 5786.3 5888.9 5895.6 5899.1 5774.8 5798.9 5827.2 5879.0 5922.8 5952.2 5957.3 5964.9 5965.5 5972.1 5621.8 5676.9 5748.3 5795.8 5832.3 07:09:13 INFO - PROCESS | 4782 | 07:09:13 INFO - PROCESS | 4782 | [#1] ext.html Cycles:180 Average:48176.54 Median:20610.13 stddev:85764.30 (416.1%) stddev-sans-first:85930.35 07:09:13 INFO - PROCESS | 4782 | Values: 549.5 566.9 595.4 597.5 602.8 33599.8 35802.6 43386.1 44472.8 44518.0 45222.5 45675.5 45687.1 45695.5 45745.5 8948.8 9077.2 9080.5 9087.8 9088.3 8535.2 8683.7 8690.1 8997.3 10750.4 10817.5 11115.4 11120.1 11128.2 11130.6 10889.1 10947.0 10949.9 10952.5 10959.6 10864.3 10920.0 10929.0 10930.6 10932.9 42772.0 43006.1 43125.8 43158.6 43196.1 3689.6 4098.0 4212.2 4243.9 4340.8 31898.5 32225.5 32467.8 32524.0 32960.8 3683.2 3768.3 3776.3 3788.2 3822.7 315332.0 316588.0 316837.0 319863.0 319970.0 37530.6 58774.4 58953.1 59029.0 59145.0 37870.6 40277.6 40287.2 40297.6 40300.2 15785.9 15878.6 15908.7 15912.6 15916.2 13461.3 13485.7 13528.4 13542.5 13545.4 8716.3 8849.6 9016.4 9268.1 9388.2 3599.1 3611.0 3615.6 3631.5 3671.2 1039.8 1042.8 1043.0 1082.6 1087.5 31693.7 32150.7 32235.7 32692.7 32712.2 1119.3 1152.6 1155.5 1209.5 1212.8 16791.0 16992.9 17017.2 17042.7 17309.2 158121.0 158375.0 158718.0 158799.0 158963.0 57014.1 57805.7 58527.7 58689.4 58824.4 1411.0 1432.5 1435.1 1452.6 1462.0 30917.5 33308.2 33358.3 33450.3 33476.0 51788.5 51895.5 52466.0 52503.0 52585.7 429061.0 434047.0 435671.0 437490.0 438702.0 29592.4 29621.7 29896.3 30024.8 30109.1 46726.8 47401.0 47452.0 47876.8 48789.3 41105.6 41177.6 41601.6 41823.6 43141.4 40926.4 41638.6 41772.8 42145.8 42172.0 41636.6 41889.2 41910.8 42061.4 42685.8 35040.8 37668.4 37764.0 37922.8 38520.0 28523.0 28736.9 28819.1 28820.9 28858.6 07:09:13 INFO - PROCESS | 4782 | 07:09:13 INFO - PROCESS | 4782 | [#2] jquery.html Cycles:180 Average:27149.08 Median:2465.35 stddev:70215.82 (2848.1%) stddev-sans-first:70384.04 07:09:13 INFO - PROCESS | 4782 | Values: 387.8 405.4 413.8 413.8 427.1 15198.4 19277.6 19401.9 19433.9 19644.7 19117.3 19157.6 19297.2 19537.8 19944.5 4992.2 5714.0 5750.3 5908.5 5910.4 5834.8 5916.5 5920.3 5921.1 5924.8 5725.9 5735.5 5795.8 5801.8 5890.8 5813.5 5849.4 5858.9 5859.0 5859.1 5070.4 5276.5 5284.8 5310.8 5321.3 22380.6 22595.1 23191.8 23280.5 23336.5 2424.1 2449.7 2461.2 2469.5 2730.8 9836.9 13909.4 14237.0 14586.3 14681.6 1889.3 1969.0 2008.7 2029.7 2030.8 80729.2 82460.6 82671.0 83990.0 85016.6 10275.0 10422.6 10646.1 11383.9 11603.1 14838.4 14867.7 14890.2 14904.6 15193.9 6555.6 6692.0 8092.2 8587.0 8822.9 8367.0 8376.7 8413.0 8597.1 8644.7 4433.8 4775.4 4790.6 4896.6 4975.1 1995.1 2010.2 2010.9 2047.6 2064.6 897.9 922.1 942.3 988.0 1018.9 17912.1 18740.8 19186.7 19284.8 19456.5 974.9 988.5 999.7 1010.5 1012.2 10076.1 10378.8 10598.5 10697.5 10741.0 362579.0 366529.0 371341.0 483212.0 506521.0 72239.0 74240.9 97192.0 102562.0 103606.0 987.5 1042.6 1043.7 1051.9 1053.3 17119.4 17468.3 17624.2 17793.6 18159.4 40090.8 42108.8 42949.6 42991.6 44209.0 56062.7 58837.4 60015.0 60862.0 61003.4 8390.6 8418.1 8564.7 8606.6 8822.2 13544.1 13554.7 13624.8 13717.9 13891.0 11304.3 11438.8 11524.7 11699.7 11849.5 11355.0 11656.4 11760.9 11843.2 11865.5 11462.6 11585.5 11964.7 12138.8 12165.3 8554.6 8651.0 8664.3 8717.9 9197.9 10966.9 11879.3 12044.6 12078.7 12160.6 07:09:13 INFO - PROCESS | 4782 | 07:09:13 INFO - PROCESS | 4782 | [#3] mootools.html Cycles:180 Average:5436.86 Median:5167.13 stddev:2972.00 (57.5%) stddev-sans-first:2965.45 07:09:13 INFO - PROCESS | 4782 | Values: 1478.8 1530.0 1641.8 1796.2 1820.8 7921.8 8397.4 8401.2 8410.0 8410.5 7218.1 7390.4 7402.6 7596.2 8275.5 2258.9 2348.7 2349.8 2358.3 2372.1 2349.1 2351.3 2352.5 2365.8 2369.7 2351.4 2365.3 2366.9 2369.1 2371.2 2259.7 2289.9 2291.5 2292.0 2292.5 2336.4 2342.1 2348.9 2349.5 2350.9 8201.6 8324.8 8337.4 8347.4 8349.5 5048.1 5144.8 5153.6 5167.9 5196.7 3049.5 3082.2 3143.7 3218.3 3233.6 976.6 1020.8 1053.2 1058.4 1059.3 11429.5 11443.3 11450.6 11451.1 11477.3 4266.2 4486.5 4548.8 4549.2 4550.7 9603.2 9620.0 9651.2 9668.6 9673.4 5159.5 5166.4 5168.1 5168.9 5173.8 4619.8 4728.2 4748.8 4757.9 4763.5 3906.5 3953.1 3994.0 4031.2 4062.3 1299.2 1299.5 1311.6 1312.7 1314.6 903.1 931.2 968.5 971.6 988.8 5358.1 5467.2 5497.9 5635.0 5655.2 905.7 922.7 922.9 947.3 957.1 3696.4 4011.7 4017.8 4043.2 4112.9 9956.5 10052.5 10117.5 10151.9 10161.3 10115.9 10133.5 10138.2 10138.9 10139.1 7718.8 7836.9 7844.9 7845.7 7848.7 5125.9 5355.4 5448.3 5485.8 5489.5 8978.4 8996.2 8997.8 9019.9 9042.0 9093.7 9124.3 9137.4 9189.8 9206.1 6365.7 6549.4 6556.1 6692.9 6822.1 7925.3 7992.0 8126.1 8144.8 8151.8 7110.6 7151.7 7184.1 7316.6 7354.5 6768.2 6840.9 6849.8 6869.8 6872.3 6320.7 6416.2 6431.3 6440.4 6443.6 4855.4 4912.8 4939.0 4941.5 4946.0 4895.1 4993.7 5168.1 5176.1 5182.8 07:09:13 INFO - PROCESS | 4782 | 07:09:13 INFO - PROCESS | 4782 | [#4] prototype.html Cycles:180 Average:4795.60 Median:5351.69 stddev:1392.68 (26.0%) stddev-sans-first:1355.76 07:09:13 INFO - PROCESS | 4782 | Values: 335.9 336.6 343.9 347.7 351.8 5257.5 5394.3 5413.7 5436.4 5446.8 5257.5 5300.3 5318.6 5347.2 5373.8 4292.5 4298.5 4299.9 4304.3 4369.1 4199.7 4235.3 4330.9 4335.4 4385.4 4224.7 4260.4 4271.1 4286.6 4292.1 4274.3 4284.7 4288.4 4291.0 4299.9 3780.6 3837.7 3851.9 3858.8 3860.4 5285.7 5286.9 5291.3 5311.9 5374.4 4912.3 4918.4 4935.2 4938.2 4952.6 5435.9 5577.7 5581.9 5641.3 5685.8 4188.0 4199.7 4199.9 4202.3 4219.2 5885.5 5899.2 5902.8 5904.2 5905.1 4159.2 4318.7 4326.4 4342.2 4344.7 4336.3 4340.2 4351.8 4354.9 4358.8 4872.7 4879.9 4880.7 4882.2 4895.3 5545.8 5649.0 5659.0 5680.6 5698.9 1449.5 1453.0 1460.3 1463.3 1471.6 958.9 994.7 1010.1 1019.4 1021.8 5200.8 5233.2 5299.9 5351.0 5352.4 5518.7 5586.0 5620.2 5620.3 5672.5 5036.4 5256.8 5261.6 5301.9 5332.4 2941.9 2978.0 2980.0 2981.9 2998.2 5803.8 5815.8 5821.2 5845.0 5858.2 5629.8 5941.7 5969.5 6012.9 6016.8 6096.5 6139.4 6145.4 6148.5 6163.4 5652.9 5896.2 5897.7 5925.6 5953.6 5825.6 5831.8 5850.4 5855.2 5856.4 5880.5 6052.6 6070.9 6092.8 6113.9 3952.3 4064.0 4111.0 4133.3 4214.6 5847.2 5848.8 5894.5 5924.1 5926.9 5550.6 5741.4 5749.8 5763.7 5782.1 5658.0 5661.6 5667.5 5669.5 5703.2 5606.4 5629.2 5633.1 5633.5 5650.0 5517.8 5659.7 5717.3 5733.2 5741.5 5587.7 5591.6 5601.0 5627.7 5634.7 07:09:13 INFO - PROCESS | 4782 | 07:09:13 INFO - PROCESS | 4782 | [#5] yui.html Cycles:180 Average:17479.00 Median:25234.56 stddev:22866.57 (90.6%) stddev-sans-first:22896.10 07:09:13 INFO - PROCESS | 4782 | Values: 722.8 763.9 777.8 807.9 866.1 13975.2 14913.9 15142.9 15149.2 15152.8 13570.3 13615.9 13718.1 13722.2 13741.7 714.6 731.0 815.1 840.9 842.8 843.4 843.6 844.3 844.3 844.4 872.9 873.3 873.9 874.0 874.1 862.6 864.8 866.2 866.4 867.4 634.3 638.7 638.8 639.9 641.9 13613.2 13890.4 13894.8 13942.9 14628.0 14065.6 14762.3 14876.9 14884.7 14902.5 11979.8 12110.0 12146.3 12275.4 12308.0 3754.5 3849.2 3855.5 3863.1 3895.6 62806.4 65684.7 66058.3 66124.0 67706.0 10963.0 11061.5 11269.4 11339.4 11634.9 21488.5 21550.8 21591.1 21661.1 21978.6 7451.4 7567.3 7573.4 7601.6 7717.5 4571.4 4589.1 4619.1 4741.1 4798.0 3384.2 3473.4 3512.7 3515.0 3517.1 575.0 589.7 593.5 606.2 616.8 672.2 709.1 710.4 717.6 732.2 8188.3 8936.6 8997.3 9152.3 9171.1 617.8 685.3 692.6 711.9 714.5 4218.9 4261.1 4347.7 4362.0 4398.3 86217.0 86872.0 88978.6 89611.0 90343.0 48576.0 77997.2 78177.0 81411.2 81715.0 42392.0 62049.0 65980.3 67145.7 67872.3 8272.2 8650.5 8727.7 8756.6 8770.8 41400.6 41742.4 43115.8 45880.0 49722.8 54858.5 55586.0 56336.0 57816.7 58972.7 12393.6 12426.6 12469.9 12575.7 12938.7 14075.3 14754.6 14905.9 14949.8 15057.3 13962.3 14042.2 14179.7 14311.0 14623.3 12308.6 12503.8 12541.0 12688.2 12740.7 11637.8 13138.7 13228.7 13702.5 13717.4 10224.0 10323.6 10433.6 10766.5 11022.2 10682.7 11187.9 11212.0 11407.7 11419.1 07:09:13 INFO - PROCESS | 4782 | -------- Summary: end -------- 07:09:13 INFO - PROCESS | 4782 | 07:09:13 INFO - TEST-INFO | 4782: exit 0 07:09:13 INFO - TEST-OK | dromaeo_css | took 1114449ms 07:09:13 INFO - TEST-START | kraken 07:09:13 INFO - operating with platform_type : linux_ 07:09:13 INFO - Initialising browser for kraken test... 07:09:13 INFO - TEST-INFO | started process 5085 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5XfLOF/profile http://localhost:34582/getInfo.html) 07:09:17 INFO - PROCESS | 5085 | __metrics Screen width/height:1600/1200 07:09:17 INFO - PROCESS | 5085 | colorDepth:24 07:09:17 INFO - PROCESS | 5085 | Browser inner width/height: 1024/697 07:09:17 INFO - PROCESS | 5085 | __metrics 07:09:18 INFO - PROCESS | 5085 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:09:18 INFO - PROCESS | 5085 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:09:18 INFO - PROCESS | 5085 | console.error: PushService: 07:09:18 INFO - PROCESS | 5085 | stateChangeProcessEnqueue: Error transitioning state 07:09:18 INFO - PROCESS | 5085 | UnknownError 07:09:19 INFO - TEST-INFO | 5085: exit 0 07:09:19 INFO - Browser initialized. 07:09:19 INFO - Running cycle 1/1 for kraken test... 07:09:19 INFO - TEST-INFO | started process 5179 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5XfLOF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:09:30 INFO - PROCESS | 5179 | RSS: Main: 141656064 07:09:30 INFO - PROCESS | 5179 | 07:09:33 INFO - PROCESS | 5179 | Cycle 1(1): loaded http://localhost:34582/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34582/tests/kraken/driver.html?testName=audio-beat-detection) 07:09:34 INFO - PROCESS | 5179 | RSS: Main: 183304192 07:09:34 INFO - PROCESS | 5179 | 07:09:36 INFO - PROCESS | 5179 | Cycle 1(1): loaded http://localhost:34582/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34582/tests/kraken/driver.html?testName=audio-dft) 07:09:37 INFO - PROCESS | 5179 | RSS: Main: 173445120 07:09:37 INFO - PROCESS | 5179 | 07:09:40 INFO - PROCESS | 5179 | Cycle 1(1): loaded http://localhost:34582/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34582/tests/kraken/driver.html?testName=audio-fft) 07:09:40 INFO - PROCESS | 5179 | RSS: Main: 264433664 07:09:40 INFO - PROCESS | 5179 | 07:09:42 INFO - PROCESS | 5179 | Cycle 1(1): loaded http://localhost:34582/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34582/tests/kraken/driver.html?testName=audio-oscillator) 07:09:43 INFO - PROCESS | 5179 | RSS: Main: 171098112 07:09:43 INFO - PROCESS | 5179 | 07:09:45 INFO - PROCESS | 5179 | Cycle 1(1): loaded http://localhost:34582/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34582/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:09:46 INFO - PROCESS | 5179 | RSS: Main: 174018560 07:09:46 INFO - PROCESS | 5179 | 07:09:49 INFO - PROCESS | 5179 | Cycle 1(1): loaded http://localhost:34582/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34582/tests/kraken/driver.html?testName=imaging-darkroom) 07:09:49 INFO - PROCESS | 5179 | RSS: Main: 212402176 07:09:49 INFO - PROCESS | 5179 | 07:09:52 INFO - PROCESS | 5179 | Cycle 1(1): loaded http://localhost:34582/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34582/tests/kraken/driver.html?testName=imaging-desaturate) 07:09:53 INFO - PROCESS | 5179 | RSS: Main: 210739200 07:09:53 INFO - PROCESS | 5179 | 07:09:56 INFO - PROCESS | 5179 | Cycle 1(1): loaded http://localhost:34582/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34582/tests/kraken/driver.html?testName=json-parse-financial) 07:09:56 INFO - PROCESS | 5179 | RSS: Main: 209649664 07:09:56 INFO - PROCESS | 5179 | 07:09:58 INFO - PROCESS | 5179 | Cycle 1(1): loaded http://localhost:34582/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34582/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:09:58 INFO - PROCESS | 5179 | RSS: Main: 171671552 07:09:58 INFO - PROCESS | 5179 | 07:10:00 INFO - PROCESS | 5179 | Cycle 1(1): loaded http://localhost:34582/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34582/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:10:01 INFO - PROCESS | 5179 | RSS: Main: 178176000 07:10:01 INFO - PROCESS | 5179 | 07:10:03 INFO - PROCESS | 5179 | Cycle 1(1): loaded http://localhost:34582/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34582/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:10:03 INFO - PROCESS | 5179 | RSS: Main: 188432384 07:10:03 INFO - PROCESS | 5179 | 07:10:06 INFO - PROCESS | 5179 | Cycle 1(1): loaded http://localhost:34582/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34582/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:10:07 INFO - PROCESS | 5179 | RSS: Main: 196698112 07:10:07 INFO - PROCESS | 5179 | 07:10:09 INFO - PROCESS | 5179 | Cycle 1(1): loaded http://localhost:34582/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34582/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:10:10 INFO - PROCESS | 5179 | RSS: Main: 192479232 07:10:10 INFO - PROCESS | 5179 | 07:10:11 INFO - PROCESS | 5179 | Cycle 1(1): loaded http://localhost:34582/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34582/tests/kraken/driver.html?testName=ai-astar) 07:10:12 INFO - PROCESS | 5179 | RSS: Main: 244576256 07:10:12 INFO - PROCESS | 5179 | 07:10:12 INFO - PROCESS | 5179 | __start_tp_report 07:10:12 INFO - PROCESS | 5179 | _x_x_mozilla_page_load 07:10:12 INFO - PROCESS | 5179 | _x_x_mozilla_page_load_details 07:10:12 INFO - PROCESS | 5179 | |i|pagename|runs| 07:10:12 INFO - PROCESS | 5179 | |0;ai-astar;103;112;110;111;111;110;110;111;112;109 07:10:12 INFO - PROCESS | 5179 | |1;audio-beat-detection;149;117;119;162;117;117;120;124;143;117 07:10:12 INFO - PROCESS | 5179 | |2;audio-dft;161;160;160;162;161;160;160;162;162;160 07:10:12 INFO - PROCESS | 5179 | |3;audio-fft;75;75;75;105;75;76;76;74;100;74 07:10:12 INFO - PROCESS | 5179 | |4;audio-oscillator;82;81;116;83;82;81;99;84;82;112 07:10:12 INFO - PROCESS | 5179 | |5;imaging-gaussian-blur;116;116;117;117;117;117;117;117;117;117 07:10:12 INFO - PROCESS | 5179 | |6;imaging-darkroom;145;145;146;146;146;146;145;145;147;145 07:10:12 INFO - PROCESS | 5179 | |7;imaging-desaturate;84;84;84;85;85;85;84;84;84;85 07:10:12 INFO - PROCESS | 5179 | |8;json-parse-financial;50;51;50;50;51;49;49;51;50;50 07:10:12 INFO - PROCESS | 5179 | |9;json-stringify-tinderbox;59;59;58;59;59;59;60;60;59;60 07:10:12 INFO - PROCESS | 5179 | |10;stanford-crypto-aes;82;77;75;75;74;76;75;75;76;74 07:10:12 INFO - PROCESS | 5179 | |11;stanford-crypto-ccm;128;132;129;123;130;129;127;120;172;122 07:10:12 INFO - PROCESS | 5179 | |12;stanford-crypto-pbkdf2;160;159;154;154;157;154;154;155;153;155 07:10:12 INFO - PROCESS | 5179 | |13;stanford-crypto-sha256-iterative;62;62;63;67;64;61;62;62;62;61 07:10:12 INFO - PROCESS | 5179 | __end_tp_report 07:10:12 INFO - PROCESS | 5179 | __start_cc_report 07:10:12 INFO - PROCESS | 5179 | _x_x_mozilla_cycle_collect,1570 07:10:12 INFO - PROCESS | 5179 | __end_cc_report 07:10:12 INFO - PROCESS | 5179 | __startTimestamp1487085012167__endTimestamp 07:10:12 INFO - PROCESS | 5179 | 07:10:12 INFO - PROCESS | 5179 | ------- Summary: start ------- 07:10:12 INFO - PROCESS | 5179 | Number of tests: 14 07:10:12 INFO - PROCESS | 5179 | 07:10:12 INFO - PROCESS | 5179 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.00 stddev:2.60 (2.3%) stddev-sans-first:1.00 07:10:12 INFO - PROCESS | 5179 | Values: 103.0 112.0 110.0 111.0 111.0 110.0 110.0 111.0 112.0 109.0 07:10:12 INFO - PROCESS | 5179 | 07:10:12 INFO - PROCESS | 5179 | [#1] audio-beat-detection Cycles:10 Average:128.50 Median:122.00 stddev:16.55 (13.6%) stddev-sans-first:15.80 07:10:12 INFO - PROCESS | 5179 | Values: 149.0 117.0 119.0 162.0 117.0 117.0 120.0 124.0 143.0 117.0 07:10:12 INFO - PROCESS | 5179 | 07:10:12 INFO - PROCESS | 5179 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 07:10:12 INFO - PROCESS | 5179 | Values: 161.0 160.0 160.0 162.0 161.0 160.0 160.0 162.0 162.0 160.0 07:10:12 INFO - PROCESS | 5179 | 07:10:12 INFO - PROCESS | 5179 | [#3] audio-fft Cycles:10 Average:80.50 Median:75.00 stddev:11.67 (15.6%) stddev-sans-first:12.21 07:10:12 INFO - PROCESS | 5179 | Values: 75.0 75.0 75.0 105.0 75.0 76.0 76.0 74.0 100.0 74.0 07:10:12 INFO - PROCESS | 5179 | 07:10:12 INFO - PROCESS | 5179 | [#4] audio-oscillator Cycles:10 Average:90.20 Median:82.00 stddev:13.66 (16.7%) stddev-sans-first:14.16 07:10:12 INFO - PROCESS | 5179 | Values: 82.0 81.0 116.0 83.0 82.0 81.0 99.0 84.0 82.0 112.0 07:10:12 INFO - PROCESS | 5179 | 07:10:12 INFO - PROCESS | 5179 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 07:10:12 INFO - PROCESS | 5179 | Values: 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 07:10:12 INFO - PROCESS | 5179 | 07:10:12 INFO - PROCESS | 5179 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 07:10:12 INFO - PROCESS | 5179 | Values: 145.0 145.0 146.0 146.0 146.0 146.0 145.0 145.0 147.0 145.0 07:10:12 INFO - PROCESS | 5179 | 07:10:12 INFO - PROCESS | 5179 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 07:10:12 INFO - PROCESS | 5179 | Values: 84.0 84.0 84.0 85.0 85.0 85.0 84.0 84.0 84.0 85.0 07:10:12 INFO - PROCESS | 5179 | 07:10:12 INFO - PROCESS | 5179 | [#8] json-parse-financial Cycles:10 Average:50.10 Median:50.00 stddev:0.74 (1.5%) stddev-sans-first:0.78 07:10:12 INFO - PROCESS | 5179 | Values: 50.0 51.0 50.0 50.0 51.0 49.0 49.0 51.0 50.0 50.0 07:10:12 INFO - PROCESS | 5179 | 07:10:12 INFO - PROCESS | 5179 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 07:10:12 INFO - PROCESS | 5179 | Values: 59.0 59.0 58.0 59.0 59.0 59.0 60.0 60.0 59.0 60.0 07:10:12 INFO - PROCESS | 5179 | 07:10:12 INFO - PROCESS | 5179 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:75.50 stddev:2.33 (3.1%) stddev-sans-first:0.97 07:10:12 INFO - PROCESS | 5179 | Values: 82.0 77.0 75.0 75.0 74.0 76.0 75.0 75.0 76.0 74.0 07:10:12 INFO - PROCESS | 5179 | 07:10:12 INFO - PROCESS | 5179 | [#11] stanford-crypto-ccm Cycles:10 Average:131.20 Median:129.00 stddev:14.84 (11.5%) stddev-sans-first:15.69 07:10:12 INFO - PROCESS | 5179 | Values: 128.0 132.0 129.0 123.0 130.0 129.0 127.0 120.0 172.0 122.0 07:10:12 INFO - PROCESS | 5179 | 07:10:12 INFO - PROCESS | 5179 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.50 Median:155.00 stddev:2.37 (1.5%) stddev-sans-first:1.87 07:10:12 INFO - PROCESS | 5179 | Values: 160.0 159.0 154.0 154.0 157.0 154.0 154.0 155.0 153.0 155.0 07:10:12 INFO - PROCESS | 5179 | 07:10:12 INFO - PROCESS | 5179 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.60 Median:62.00 stddev:1.78 (2.9%) stddev-sans-first:1.87 07:10:12 INFO - PROCESS | 5179 | Values: 62.0 62.0 63.0 67.0 64.0 61.0 62.0 62.0 62.0 61.0 07:10:12 INFO - PROCESS | 5179 | -------- Summary: end -------- 07:10:12 INFO - PROCESS | 5179 | 07:10:13 INFO - TEST-INFO | 5179: exit 0 07:10:13 INFO - TEST-OK | kraken | took 59362ms 07:10:13 INFO - SUITE-END | took 1173s 07:10:13 INFO - Completed test suite (00:19:33) 07:10:13 INFO - javascript benchmark 07:10:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3147.464930961736, 3173.368049840134, 3188.378266238083, 3196.6483686794463, 3208.4545627243365, 5524.06090964536, 5600.85997850054, 5627.2684551008415, 5633.183188437674, 5656.632318899274, 5570.637908535952, 5574.777008919638, 5575.972120139404, 5582.665040097587, 5588.161775733642, 5046.697198168122, 5071.822486212984, 5103.081445339837, 5112.463191364909, 5171.87070323243, 5032.396112466491, 5038.647294689373, 5040.722760248185, 5099.872503187413, 5154.819581314655, 5091.032703786287, 5161.406438259611, 5171.508706672879, 5190.117679994391, 5195.246689230059, 5201.609879259052, 5206.869828254286, 5207.114790485589, 5210.76551555181, 5231.424543300234, 4911.45973942866, 4963.032208719301, 4989.975050124763, 5073.0614836255045, 5076.44159142494, 5431.266778984826, 5465.098258787295, 5471.562275017989, 5473.124300112003, 5510.201020851994, 5949.167116603679, 5986.910196347058, 5993.0710739835395, 5999.520038396961, 6000.459958603747, 5912.320083190445, 5991.820245392645, 6022.6687532185715, 6047.03247480401, 6058.1215723719815, 5522.585806064521, 5571.609987300891, 5573.303337082824, 5596.832095037074, 5621.7751289948765, 6156.569040167145, 6161.938380616137, 6169.691515424211, 6170.938290617037, 6175.814725558241, 5740.712964351849, 5786.247787787561, 5884.7940322088525, 5892.440218179266, 5896.882062358729, 5957.672328022, 6000.5799594028, 6021.6989150542295, 6033.0, 6034.909476357858, 5974.671393073423, 5979.0, 5985.371535988746, 5988.760449581968, 5992.850178745479, 5755.050416681201, 5917.644941303535, 5984.581079324493, 5988.371221021817, 6016.909746353808, 4561.954380456219, 4616.838410655678, 4619.930701039487, 4641.535846415399, 4715.009847931904, 4109.938350924679, 4116.794160292034, 4121.732087414309, 4131.628153466142, 4148.274052040942, 5723.255976723, 5733.512651424676, 5736.13957906309, 5742.483176514133, 5756.194132821408, 5745.540356771448, 5820.621659592113, 5926.614770039933, 5971.790987315423, 6021.217241758631, 5692.800751973661, 5693.259876216065, 5705.486506214461, 5707.229524014205, 5728.77084916607, 5201.1678131498775, 5202.557782588522, 5213.947860521346, 5215.426303106655, 5265.4997775211295, 5972.731227094791, 6025.578209525291, 6143.542582966849, 6191.133241346305, 6261.686915654199, 6053.061775424816, 6067.696615169312, 6083.482903953213, 6096.573239873166, 6109.20580324555, 6267.937320626917, 6298.212723409574, 6303.49572034227, 6305.558610897193, 6309.7160627770945, 5756.136579513107, 5760.884782304247, 5835.066389377679, 5943.405659434195, 5945.851353716192, 5956.047032474783, 6056.333803281724, 6059.848503787441, 6088.51291896656, 6094.329623741296, 5853.765849366148, 5886.793962211302, 5897.203877476486, 5904.3210030847, 5906.114082887601, 5651.180578815966, 5786.30564332266, 5888.941110588839, 5895.557833162444, 5899.144624029577, 5774.82675519735, 5798.94201057984, 5827.155062515996, 5878.970605146947, 5922.763089476372, 5952.196453478899, 5957.3446920837805, 5964.8807023860145, 5965.463108320272, 5972.104184372379, 5621.775128994795, 5676.886462270814, 5748.310202775527, 5795.82612521625, 5832.300123985149], "value": 5528.052247593009, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.5054450994106, 566.8979583674939, 595.3956733915076, 597.510041765752, 602.7528713227578, 33599.832000840026, 35802.641973580256, 43386.13227735443, 44472.77763611185, 44518.0, 45222.547774522245, 45675.54324456755, 45687.086258274816, 45695.543044569546, 45745.54254457454, 8948.821023579509, 9077.228435582983, 9080.545972701371, 9087.818243635124, 9088.318376121784, 8535.231829135377, 8683.652653893869, 8690.08754080822, 8997.325200609948, 10750.354978701303, 10817.459127043656, 11115.44422778862, 11120.110391168688, 11128.221024528286, 11130.610428635, 10889.074428673572, 10946.99999999996, 10949.890501094967, 10952.507137178845, 10959.616413425492, 10864.293820901616, 10920.0, 10929.0, 10930.617428389969, 10932.890671093266, 42772.0, 43006.13987720259, 43125.78437107794, 43158.56841431577, 43196.13607727859, 3689.631036896316, 4097.959020409788, 4212.241796476633, 4243.91512169758, 4340.761258130801, 31898.521522177187, 32225.51661725076, 32467.83766081178, 32524.0, 32960.835195824104, 3683.208110256281, 3768.2651882882847, 3776.282506323817, 3788.2234142000825, 3822.694184465236, 315332.0, 316588.0, 316837.0, 319863.0, 319970.0, 37530.624693753256, 58774.41225587775, 58953.115703264484, 59029.0, 59145.0, 37870.62129378726, 40277.59722402797, 40287.194256114715, 40297.59702402938, 40300.19399611992, 15785.921070394805, 15878.603034923988, 15908.681826363409, 15912.602184945468, 15916.204189790464, 13461.259630720404, 13485.662858428617, 13528.391222395016, 13542.526011589744, 13545.39045742944, 8716.346274029473, 8849.60176792046, 9016.368854180275, 9268.073192680678, 9388.2020028297, 3599.1002249437643, 3610.981945090258, 3615.584207816082, 3631.455281707765, 3671.2473942841652, 1039.7556574205055, 1042.8227201375785, 1042.9895701043044, 1082.6427278997912, 1087.4671411008708, 31693.683063169534, 32150.678493215237, 32235.67764322327, 32692.67307326896, 32712.182195444828, 1119.2892513254142, 1152.590830255264, 1155.4648006574164, 1209.5464200924653, 1212.775636507249, 16791.0, 16992.915035424743, 17017.234224459928, 17042.74435883463, 17309.221085051202, 158121.0, 158375.0, 158718.0, 158799.0, 158963.0, 57014.14478782821, 57805.710971444874, 58527.70736146292, 58689.41310586925, 58824.41175588189, 1410.971780564383, 1432.4771458417601, 1435.131745294103, 1452.6368407898026, 1461.9561413157621, 30917.536236956912, 33308.167295817795, 33358.33283334271, 33450.330993380485, 33476.0, 51788.48211517837, 51895.481045189066, 52466.0, 52503.0, 52585.7370713144, 429061.0, 434047.0, 435671.0, 437490.0, 438702.0, 29592.40815183641, 29621.703782962755, 29896.25259368533, 30024.849875751355, 30109.096727098222, 46726.766366169315, 47401.0, 47452.0, 47876.7606161967, 48789.268160976906, 41105.588944110175, 41177.588224117375, 41601.583984160985, 41823.58176418197, 43141.3528797062, 40926.38610420906, 41638.58361416347, 41772.79113604534, 42145.78927105345, 42172.0, 41636.58363416448, 41889.162216754885, 41910.79044604758, 42061.36907946322, 42685.78657106694, 35040.82479587586, 37668.43497347597, 37764.0, 37922.810385947894, 38520.0, 28523.0, 28736.856315718287, 28819.135425937257, 28820.855895720386, 28858.567121492775], "value": 18924.3181164924, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.78284160869896, 405.39393606558184, 413.75381647919494, 413.81998830508724, 427.13292017205066, 15198.392064317428, 19277.614447711054, 19401.90299048506, 19433.902830485844, 19644.70532942007, 19117.330893418733, 19157.616847663037, 19297.22811087555, 19537.804621953812, 19944.50138746532, 4992.226204938241, 5713.971430142843, 5750.281214848144, 5908.497777688902, 5910.408959104098, 5834.795782147626, 5916.526677865761, 5920.348761636238, 5921.082232254007, 5924.792632257871, 5725.9449102988465, 5735.483806457418, 5795.768169273224, 5801.796937107202, 5890.793822216223, 5813.476787089161, 5849.415058494159, 5858.88282234355, 5858.970705146489, 5859.0625499920025, 5070.3915530136255, 5276.525112739833, 5284.788608455658, 5310.7610157543, 5321.3348331458565, 22380.552388952292, 22595.096196152135, 23191.76808231913, 23280.534389312288, 23336.533269334686, 2424.078850036992, 2449.669294645218, 2461.212412028152, 2469.493753780471, 2730.8361498310164, 9836.852447213298, 13909.359340104827, 14237.0, 14586.270686465634, 14681.559553213421, 1889.2820728123363, 1968.9606207875763, 2008.708737233093, 2029.695545668147, 2030.7766145723958, 80729.19270807334, 82460.58769706172, 82671.0, 83990.0, 85016.57491712502, 10275.0, 10422.5830966762, 10646.14830813533, 11383.943080284545, 11603.129765267639, 14838.406463741545, 14867.70264594702, 14890.181040042686, 14904.62738431548, 15193.924030379778, 6555.639439830855, 6692.0, 8092.231238032377, 8586.957065214634, 8822.911770882338, 8367.0, 8376.70681526156, 8413.0, 8597.140285971353, 8644.654213831502, 4433.7561434121435, 4775.403074615673, 4790.640701947298, 4896.5837903777865, 4975.114433628487, 1995.1321175288797, 2010.1858747207111, 2010.9497262568261, 2047.6076268137513, 2064.587082583459, 897.9012308646044, 922.082527884759, 942.3497786527412, 987.9950600247097, 1018.8930162332997, 17912.10439478021, 18740.818779398378, 19186.712199317022, 19284.80715192858, 19456.513587160152, 974.9268804839666, 988.5156273426113, 999.6551189839494, 1010.4897027001317, 1012.2003617142523, 10076.143527800072, 10378.844317335246, 10598.470076496144, 10697.518611662494, 10741.0, 362579.0, 366529.0, 371341.0, 483212.0, 506521.0, 72239.0, 74240.9167495793, 97192.0, 102562.0, 103606.0, 987.4618333008527, 1042.61944390297, 1043.660810236676, 1051.9053285204368, 1053.2521909444226, 17119.400820971205, 17468.30126794914, 17624.206910688794, 17793.555161121076, 18159.364422245686, 40090.79954600208, 42108.789456053746, 42949.570504294556, 42991.57008429876, 44209.0, 56062.71968640131, 58837.41162588319, 60015.0, 60862.0, 61003.389966101546, 8390.580470976549, 8418.074011858813, 8564.74305770828, 8606.612702428281, 8822.161894620001, 13544.119632223874, 13554.661133471347, 13624.795628065389, 13717.931410343284, 13891.0, 11304.321740695585, 11438.82841757391, 11524.711882203012, 11699.718554881716, 11849.466773995018, 11355.0, 11656.417179140839, 11760.941195293968, 11843.170978031456, 11865.466054027762, 11462.598809041643, 11585.536578537101, 11964.700882478008, 12138.757224855277, 12165.270083795001, 8554.57227138653, 8651.0, 8664.263537599374, 8717.91282087171, 9197.86203206939, 10966.945165274123, 11879.346635935106, 12044.578439754567, 12078.698032549257, 12160.574379896661], "value": 9301.703046379527, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1478.7855760914672, 1529.9770503442448, 1641.8029836419623, 1796.16478337573, 1820.8270214329634, 7921.84156316874, 8397.412181147321, 8401.159884011597, 8409.95795021024, 8410.537420441873, 7218.061651985235, 7390.445716571266, 7402.592857392841, 7596.240375962415, 8275.462094963823, 2258.9096436142577, 2348.6847365475387, 2349.753275906031, 2358.3160883343894, 2372.146027430124, 2349.0721165139757, 2351.329870986769, 2352.4589344450787, 2365.7989070928907, 2369.6919400477914, 2351.376885125443, 2365.3495288795634, 2366.8579885206855, 2369.0642196332437, 2371.205646108556, 2259.67234750961, 2289.8511596746325, 2291.5302363015544, 2292.0, 2292.472731271817, 2336.4392545788887, 2342.0748804222408, 2348.9060437582475, 2349.5066036132434, 2350.9059637614473, 8201.589920503951, 8324.791880202984, 8337.374696897758, 8347.373946953941, 8349.457285276438, 5048.091343558158, 5144.794208231666, 5153.613478989053, 5167.896642067175, 5196.740162991835, 3049.450952220397, 3082.1832214463184, 3143.701348371901, 3218.340240250743, 3233.611966564027, 976.5703090640095, 1020.7907378987364, 1053.210092430677, 1058.4178701714027, 1059.3485006720812, 11429.485673144729, 11443.313401195956, 11450.599229027028, 11451.083913287, 11477.253978491372, 4266.189424009428, 4486.528914463999, 4548.840790572381, 4549.181147393501, 4550.658700597469, 9603.231741460666, 9620.0, 9651.227901767841, 9668.564914578861, 9673.37123086997, 5159.509846564571, 5166.354205724285, 5168.121419358718, 5168.9224661630105, 5173.767180476888, 4619.815207391666, 4728.243481043017, 4748.786304616231, 4757.881052973634, 4763.54746299101, 3906.4726261954843, 3953.1105501261986, 3993.980030099831, 4031.2139132869397, 4062.289099407592, 1299.1944994103717, 1299.4996926183487, 1311.5868501422021, 1312.7046414556648, 1314.572763851752, 903.0698380667923, 931.2270815223349, 968.5351031504777, 971.5919313888184, 988.8071825994006, 5358.115910874662, 5467.1799230115, 5497.945020549823, 5634.97182514093, 5655.1517272409465, 905.6558507767138, 922.6586163119555, 922.916937475617, 947.3179310896144, 957.1051067252002, 3696.4085746280466, 4011.6991225658194, 4017.7656986125867, 4043.1509383029306, 4112.938305925413, 9956.452395118193, 10052.497375131361, 10117.544710488046, 10151.94924025375, 10161.288709790391, 10115.949420252999, 10133.543990520444, 10138.188944884392, 10138.949305253574, 10139.087482126644, 7718.845623087619, 7836.882446763303, 7844.940932974089, 7845.725399610987, 7848.725294614661, 5125.923556053271, 5355.357357117171, 5448.291722076105, 5485.807996720096, 5489.533389661923, 8978.416402933788, 8996.235319997873, 8997.820043599222, 9019.909800902169, 9042.005379408129, 9093.727188184364, 9124.31567632417, 9137.40606860552, 9189.816203675755, 9206.125418085272, 6365.713542890674, 6549.410553050248, 6556.082148499118, 6692.899606506004, 6822.079019332326, 7925.28672419485, 7992.040955085427, 8126.065502467292, 8144.796380090545, 8151.79620509492, 7110.57336559808, 7151.678174482056, 7184.1019872515935, 7316.597587132546, 7354.485186036926, 6768.221654509597, 6840.931590684029, 6849.760258391132, 6869.828254293483, 6872.347127022925, 6320.747170113144, 6416.197975253093, 6431.29255781873, 6440.420362167428, 6443.6455994920725, 4855.368802055851, 4912.778924948315, 4938.950610493993, 4941.50584941503, 4946.0355230729665, 4895.118878601744, 4993.675411098267, 5168.0697474454955, 5176.06830770465, 5182.818601348935], "value": 4429.540735340614, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.88076232937306, 336.6058906030855, 343.88307975288404, 347.7009771596425, 351.8223297234896, 5257.500537448946, 5394.298741163648, 5413.702246376448, 5436.429174936629, 5446.809361672337, 5257.526822585966, 5300.250917197325, 5318.601104917137, 5347.171188465784, 5373.81191658292, 4292.549282325358, 4298.548652391501, 4299.871003869874, 4304.268274393345, 4369.104333611618, 4199.664026877843, 4235.301175306071, 4330.870073897788, 4335.43639326887, 4385.407969924051, 4224.704270701052, 4260.403543503897, 4271.124419493996, 4286.635635970946, 4292.12011537634, 4274.273373526493, 4284.729093580392, 4288.378185163134, 4290.957090429087, 4299.871003869857, 3780.621937806225, 3837.7313588048846, 3851.8844434667003, 3858.765195137557, 3860.3823388258024, 5285.656432331886, 5286.867828304285, 5291.3385826771655, 5311.937612477482, 5374.435684253136, 4912.263160525914, 4918.360613120271, 4935.235038569028, 4938.185199442088, 4952.579030782388, 5435.87437223598, 5577.721113944327, 5581.888362232773, 5641.26663533738, 5685.829425117253, 4188.0, 4199.727017743837, 4199.9370009449885, 4202.2646036943415, 4219.2194444027955, 5885.470307672287, 5899.174115623816, 5902.793402230901, 5904.17341572176, 5905.114232865105, 4159.168166366739, 4318.740875547477, 4326.394304797331, 4342.240107981091, 4344.695871288979, 4336.284513055373, 4340.218760623118, 4351.782410879443, 4354.911272181955, 4358.803853826522, 4872.6589138760655, 4879.926801097987, 4880.6583539152625, 4882.194437917775, 4895.335585900811, 5545.833624991256, 5648.9717551412805, 5659.009673307155, 5680.608250978454, 5698.886022279531, 1449.4999225267266, 1452.9611327900602, 1460.3136525832842, 1463.3122432456728, 1471.6247356923916, 958.9136977672043, 994.6568433890296, 1010.141379827141, 1019.4393083803878, 1021.824901363438, 5200.7919683213, 5233.241180028951, 5299.947000530023, 5351.0, 5352.384475785257, 5518.724063796794, 5585.972070139705, 5620.229627667271, 5620.285812827045, 5672.546196304285, 5036.420811606639, 5256.789728410898, 5261.579073674096, 5301.932246423898, 5332.440093790096, 2941.9411611767646, 2977.985110074436, 2979.957015044717, 2981.8807247710283, 2998.2354499602898, 5803.752193278466, 5815.82552523425, 5821.18503409523, 5845.048250633403, 5858.209141765892, 5629.802956896489, 5941.673207973517, 5969.462748352669, 6012.939870601325, 6016.849578760566, 6096.481799047042, 6139.447449729546, 6145.354737752472, 6148.538859585459, 6163.445289923929, 5652.886942261214, 5896.174535564938, 5897.70511474416, 5925.644461332334, 5953.553483488669, 5825.621334613236, 5831.766729330949, 5850.444207800252, 5855.238818953509, 5856.443637854397, 5880.529557635465, 6052.606580572248, 6070.939290607037, 6092.847678808065, 6113.908291375544, 3952.26883026641, 4063.959360406358, 4111.0, 4133.318002529549, 4214.620684138442, 5847.181394604674, 5848.766049357978, 5894.528437725057, 5924.11138329254, 5926.881462370815, 5550.639208451437, 5741.425857414225, 5749.798757043483, 5763.7406316715005, 5782.10377391505, 5657.971710141423, 5661.575381846295, 5667.5465962722055, 5669.489745922887, 5703.230063941315, 5606.439356064361, 5629.155626655871, 5633.0705433603, 5633.492985631313, 5649.971750141387, 5517.779288828402, 5659.660420374791, 5717.342505611908, 5733.197352370588, 5741.540676745767, 5587.720613969366, 5591.580631452576, 5600.971995139998, 5627.718614069362, 5634.74643641029], "value": 4353.243106300749, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.7831650504849, 763.8739607964686, 777.8133248020476, 807.919208079192, 866.1122349591672, 13975.161490310576, 14913.925430372847, 15142.924285378585, 15149.166795826226, 15152.848471515295, 13570.253636050013, 13615.863841361583, 13718.108322959, 13722.176669399843, 13741.72516549671, 714.6069661686078, 731.042334541752, 815.1318845429628, 840.9032961209479, 842.751388340441, 843.3674743942044, 843.6245870587591, 844.273924424994, 844.307667712476, 844.4426678392263, 872.9127087291283, 873.2708188662443, 873.8645509945968, 873.9868901966476, 874.1477059866643, 862.5687156421789, 864.8140649760269, 866.164151593712, 866.3848667446152, 867.3624885708999, 634.3497914637487, 638.677467878723, 638.8434833465831, 639.8720255948829, 641.9197600299963, 13613.183209007393, 13890.374933128034, 13894.791578126336, 13942.860571394258, 14628.0, 14065.578032659037, 14762.261886905611, 14876.851231487655, 14884.702305953928, 14902.466580681203, 11979.820302695467, 12109.978987432127, 12146.33195174265, 12275.38623068843, 12308.015358771367, 3754.530683664542, 3849.172427928009, 3855.5373355197275, 3863.0728625130046, 3895.590962948878, 62806.371936280506, 65684.67157664277, 66058.3394166057, 66124.0, 67706.0, 10963.0, 11061.502232399562, 11269.380184089954, 11339.376334301527, 11634.883651163549, 21488.462788430414, 21550.78449215519, 21591.136354545957, 21661.133554657954, 21978.560428791334, 7451.366633836076, 7567.31894129531, 7573.394128469709, 7601.619919004028, 7717.498362606412, 4571.428571428572, 4589.128065667513, 4619.099275641285, 4741.0991911537385, 4797.95202047982, 3384.2047118927035, 3473.4095203815414, 3512.7365447591533, 3514.9648503514636, 3517.050396393011, 575.0482950716571, 589.6579983609496, 593.5103539579864, 606.1756011823916, 616.7872084130968, 672.2235817630644, 709.0888208651858, 710.3500297227979, 717.5802155738951, 732.1543617122126, 8188.26305632484, 8936.553172341357, 8997.280217582578, 9152.31357648179, 9171.082871771372, 617.8331850400367, 685.2975699907635, 692.6155983429145, 711.871863064643, 714.5426926766874, 4218.894527636772, 4261.0838669685545, 4347.695661303678, 4362.0185458271635, 4398.318260669601, 86217.0, 86872.0, 88978.55510722534, 89611.0, 90343.0, 48576.0, 77997.22002780013, 78177.0, 81411.18588814154, 81715.0, 42392.0, 62049.0, 65980.34019659838, 67145.66427167832, 67872.32127678758, 8272.17278272168, 8650.524221167896, 8727.65089396417, 8756.605952732016, 8770.780730481789, 41400.58599413967, 41742.37386439145, 43115.7844210777, 45880.0, 49722.75138624429, 54858.45141548533, 55586.0, 56336.0, 57816.71091644515, 58972.70513647404, 12393.62819115428, 12426.62720118398, 12469.937650311691, 12575.748485030432, 12938.676533086747, 14075.296235187994, 14754.557363279118, 14905.925470372578, 14949.77575336349, 15057.322420490886, 13962.301884905512, 14042.166448610413, 14179.716405671623, 14311.0, 14623.34194961208, 12308.569200078313, 12503.812442813183, 12541.030558115428, 12688.17526860751, 12740.68148296263, 11637.76724465523, 13138.671533211746, 13228.735425291632, 13702.45190192421, 13717.382717777524, 10224.0, 10323.587056517656, 10433.634822781167, 10766.523152797614, 11022.228444008842, 10682.73293167677, 11187.944060279646, 11211.996079582537, 11407.714807129556, 11419.14356423255], "value": 7117.123862155021, "unit": "score"}], "name": "dromaeo_css", "value": 7149.553570579791, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 110.0, 111.0, 111.0, 110.0, 110.0, 111.0, 112.0, 109.0], "value": 109.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 117.0, 119.0, 162.0, 117.0, 117.0, 120.0, 124.0, 143.0, 117.0], "value": 128.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 162.0, 161.0, 160.0, 160.0, 162.0, 162.0, 160.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 105.0, 75.0, 76.0, 76.0, 74.0, 100.0, 74.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 116.0, 83.0, 82.0, 81.0, 99.0, 84.0, 82.0, 112.0], "value": 90.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0, 147.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 85.0, 85.0, 85.0, 84.0, 84.0, 84.0, 85.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 50.0, 50.0, 51.0, 49.0, 49.0, 51.0, 50.0, 50.0], "value": 50.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 58.0, 59.0, 59.0, 59.0, 60.0, 60.0, 59.0, 60.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 77.0, 75.0, 75.0, 74.0, 76.0, 75.0, 75.0, 76.0, 74.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 132.0, 129.0, 123.0, 130.0, 129.0, 127.0, 120.0, 172.0, 122.0], "value": 131.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 159.0, 154.0, 154.0, 157.0, 154.0, 154.0, 155.0, 153.0, 155.0], "value": 155.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 67.0, 64.0, 61.0, 62.0, 62.0, 62.0, 61.0], "value": 62.6, "unit": "score"}], "name": "kraken", "value": 1451.2, "alertThreshold": 2.0}]} 07:10:13 INFO - Return code: 0 07:10:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:10:13 INFO - # TBPL SUCCESS # 07:10:13 INFO - Running post-action listener: _resource_record_post_action 07:10:13 INFO - [mozharness: 2017-02-14 15:10:13.465135Z] Finished run-tests step (success) 07:10:13 INFO - Running post-run listener: _resource_record_post_run 07:10:13 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 172032; Write bytes: 323162112; Read time: 408; Write time: 162740 07:10:13 INFO - TinderboxPrint: CPU usage
12.9% 07:10:13 INFO - TinderboxPrint: I/O read bytes / time
172,032 / 408 07:10:13 INFO - TinderboxPrint: I/O write bytes / time
323,162,112 / 162,740 07:10:13 INFO - TinderboxPrint: CPU idle
8,257.9 (87.1%) 07:10:13 INFO - TinderboxPrint: CPU user
1,185.3 (12.5%) 07:10:13 INFO - TinderboxPrint: Swap in / out
0 / 0 07:10:13 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 101109760; Read time: 0; Write time: 66976 07:10:13 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 172032; Write bytes: 222052352; Read time: 408; Write time: 95764 07:10:14 INFO - Running post-run listener: _upload_blobber_files 07:10:14 INFO - Blob upload gear active. 07:10:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:10:14 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 07:10:14 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:10:14 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:10:14 INFO - (blobuploader) - INFO - Open directory for files ... 07:10:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:10:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:10:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:10:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:10:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:10:15 INFO - (blobuploader) - INFO - Done attempting. 07:10:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:10:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:10:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:10:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:10:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:10:19 INFO - (blobuploader) - INFO - Done attempting. 07:10:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:10:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:10:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:10:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:10:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:10:20 INFO - (blobuploader) - INFO - Done attempting. 07:10:20 INFO - (blobuploader) - INFO - Iteration through files over. 07:10:20 INFO - Return code: 0 07:10:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:10:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:10:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a6915af28d04d06004f997f25e0baf914f3693b72535243939715b883de5c00339dff4e78856de80c5d771dfe33d6746a6bb53ecdeebd4e143ad31a8c0bee787", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4d5a06c150bc65319d7bbaa45c8b16a89acb5744c17dfb3529de7ab2f55284d417b4b73be60a2785cff27a4a19a17d9f7c1ca8707cf0865b2c57c5f859dd7e35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/edd66c48af79e41398d9e97cb9a5e3311416e9e8e5eb2e7857ccd0636f318266199f5c7c1268e73fd461e6cc89dbacf593fc9aa5223aac77f31ece6c48d53007"} 07:10:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:10:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:10:20 INFO - Contents: 07:10:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a6915af28d04d06004f997f25e0baf914f3693b72535243939715b883de5c00339dff4e78856de80c5d771dfe33d6746a6bb53ecdeebd4e143ad31a8c0bee787", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4d5a06c150bc65319d7bbaa45c8b16a89acb5744c17dfb3529de7ab2f55284d417b4b73be60a2785cff27a4a19a17d9f7c1ca8707cf0865b2c57c5f859dd7e35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/edd66c48af79e41398d9e97cb9a5e3311416e9e8e5eb2e7857ccd0636f318266199f5c7c1268e73fd461e6cc89dbacf593fc9aa5223aac77f31ece6c48d53007"} 07:10:20 INFO - Running post-run listener: copy_logs_to_upload_dir 07:10:20 INFO - Copying logs to upload dir... 07:10:20 INFO - mkdir: /builds/slave/test/build/upload/logs 07:10:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.894417 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-02-14 07:10:19.826739) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-14 07:10:19.829811) ========= 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=6dbc10da6d83fee962c624be000001a8-1487083786.123185-1408978583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a6915af28d04d06004f997f25e0baf914f3693b72535243939715b883de5c00339dff4e78856de80c5d771dfe33d6746a6bb53ecdeebd4e143ad31a8c0bee787", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4d5a06c150bc65319d7bbaa45c8b16a89acb5744c17dfb3529de7ab2f55284d417b4b73be60a2785cff27a4a19a17d9f7c1ca8707cf0865b2c57c5f859dd7e35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/edd66c48af79e41398d9e97cb9a5e3311416e9e8e5eb2e7857ccd0636f318266199f5c7c1268e73fd461e6cc89dbacf593fc9aa5223aac77f31ece6c48d53007"} build_url:https://queue.taskcluster.net/v1/task/NQd37SP0Q8qRX0Ql3tVkuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011372 build_url: 'https://queue.taskcluster.net/v1/task/NQd37SP0Q8qRX0Ql3tVkuQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a6915af28d04d06004f997f25e0baf914f3693b72535243939715b883de5c00339dff4e78856de80c5d771dfe33d6746a6bb53ecdeebd4e143ad31a8c0bee787", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4d5a06c150bc65319d7bbaa45c8b16a89acb5744c17dfb3529de7ab2f55284d417b4b73be60a2785cff27a4a19a17d9f7c1ca8707cf0865b2c57c5f859dd7e35", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/edd66c48af79e41398d9e97cb9a5e3311416e9e8e5eb2e7857ccd0636f318266199f5c7c1268e73fd461e6cc89dbacf593fc9aa5223aac77f31ece6c48d53007"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-14 07:10:19.854390) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 07:10:19.854717) ========= 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=6dbc10da6d83fee962c624be000001a8-1487083786.123185-1408978583 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 07:10:19.939341) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-14 07:10:19.939664) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-14 07:10:19.939954) ========= ========= Total master_lag: 0.16 =========