builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1478610648.54 results: success (0) buildid: 20161108030212 builduid: 5f4e42c5c6fb4ba2822ef60cdb11a2b3 revision: f13e90d496cf1bc6dfc4fd398da33e4afe785bde ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-08 05:10:48.540974) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-08 05:10:48.541485) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-08 05:10:48.541770) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-08 05:10:48.556410) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 05:10:48.556752) ========= 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=6d15e502d8e29d5d2676d664000001c3-1478610649.6616-312709495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-08 05:10:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 32.9M=0s 2016-11-08 05:10:49 (32.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.072990 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 05:10:48.643731) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 05:10:48.644086) ========= 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=6d15e502d8e29d5d2676d664000001c3-1478610649.6616-312709495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015030 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 05:10:48.694231) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-08 05:10:48.694592) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f13e90d496cf1bc6dfc4fd398da33e4afe785bde --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f13e90d496cf1bc6dfc4fd398da33e4afe785bde --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=6d15e502d8e29d5d2676d664000001c3-1478610649.6616-312709495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-08 05:10:49,856 truncating revision to first 12 chars 2016-11-08 05:10:49,856 Setting DEBUG logging. 2016-11-08 05:10:49,856 attempt 1/10 2016-11-08 05:10:49,856 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f13e90d496cf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-08 05:10:50,556 unpacking tar archive at: mozilla-central-f13e90d496cf/testing/mozharness/ program finished with exit code 0 elapsedTime=1.008015 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-08 05:10:49.716266) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-08 05:10:49.716607) ========= script_repo_revision: f13e90d496cf1bc6dfc4fd398da33e4afe785bde ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-08 05:10:49.717048) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-08 05:10:49.717344) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-08 05:10:49.727199) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-11-08 05:10:49.727617) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=6d15e502d8e29d5d2676d664000001c3-1478610649.6616-312709495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:10:50 INFO - MultiFileLogger online at 20161108 05:10:50 in /builds/slave/test 05:10:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:10:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:10:50 INFO - {'append_to_log': False, 05:10:50 INFO - 'base_work_dir': '/builds/slave/test', 05:10:50 INFO - 'blob_upload_branch': 'Firefox', 05:10:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:10:50 INFO - 'branch': 'Firefox', 05:10:50 INFO - 'buildbot_json_path': 'buildprops.json', 05:10:50 INFO - 'config_files': ('talos/linux_config.py',), 05:10:50 INFO - 'default_actions': ('clobber', 05:10:50 INFO - 'read-buildbot-config', 05:10:50 INFO - 'download-and-extract', 05:10:50 INFO - 'populate-webroot', 05:10:50 INFO - 'create-virtualenv', 05:10:50 INFO - 'install', 05:10:50 INFO - 'run-tests'), 05:10:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:10:50 INFO - 'download_minidump_stackwalk': True, 05:10:50 INFO - 'download_symbols': 'ondemand', 05:10:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:10:50 INFO - 'tooltool.py': '/tools/tooltool.py', 05:10:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:10:50 INFO - '/tools/misc-python/virtualenv.py')}, 05:10:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:10:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:10:50 INFO - 'installer_path': 'installer.exe', 05:10:50 INFO - 'log_level': 'info', 05:10:50 INFO - 'log_name': 'talos', 05:10:50 INFO - 'log_to_console': True, 05:10:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:10:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:10:50 INFO - 'opt_config_files': (), 05:10:50 INFO - 'pip_index': False, 05:10:50 INFO - 'sps_profile': False, 05:10:50 INFO - 'sps_profile_interval': 0, 05:10:50 INFO - 'suite': 'dromaeojs', 05:10:50 INFO - 'system_bits': '32', 05:10:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:10:50 INFO - 'title': 'talos-linux64-ix-023', 05:10:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:10:50 INFO - 'use_talos_json': True, 05:10:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:10:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:10:50 INFO - 'work_dir': 'build'} 05:10:50 INFO - [mozharness: 2016-11-08 13:10:50.990800Z] Running clobber step. 05:10:50 INFO - Running pre-action listener: _resource_record_pre_action 05:10:50 INFO - Running main action method: clobber 05:10:50 INFO - rmtree: /builds/slave/test/build 05:10:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:10:51 INFO - Running post-action listener: _resource_record_post_action 05:10:51 INFO - [mozharness: 2016-11-08 13:10:51.451928Z] Finished clobber step (success) 05:10:51 INFO - [mozharness: 2016-11-08 13:10:51.452028Z] Running read-buildbot-config step. 05:10:51 INFO - Running pre-action listener: _resource_record_pre_action 05:10:51 INFO - Running main action method: read_buildbot_config 05:10:51 INFO - Using buildbot properties: 05:10:51 INFO - { 05:10:51 INFO - "project": "", 05:10:51 INFO - "product": "firefox", 05:10:51 INFO - "script_repo_revision": "production", 05:10:51 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:10:51 INFO - "repository": "", 05:10:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:10:51 INFO - "buildid": "20161108030212", 05:10:51 INFO - "stage_platform": "linux64-pgo", 05:10:51 INFO - "basedir": "/builds/slave/test", 05:10:51 INFO - "nightly_build": "True", 05:10:51 INFO - "buildnumber": 56, 05:10:51 INFO - "slavename": "talos-linux64-ix-023", 05:10:51 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:10:51 INFO - "platform": "ubuntu64_hw", 05:10:51 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:10:51 INFO - "branch": "mozilla-central", 05:10:51 INFO - "repo_path": "mozilla-central", 05:10:51 INFO - "revision": "f13e90d496cf1bc6dfc4fd398da33e4afe785bde", 05:10:51 INFO - "pgo_build": "True", 05:10:51 INFO - "builduid": "5f4e42c5c6fb4ba2822ef60cdb11a2b3", 05:10:51 INFO - "slavebuilddir": "test" 05:10:51 INFO - } 05:10:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 05:10:51 INFO - Running post-action listener: _resource_record_post_action 05:10:51 INFO - [mozharness: 2016-11-08 13:10:51.454524Z] Finished read-buildbot-config step (success) 05:10:51 INFO - [mozharness: 2016-11-08 13:10:51.454613Z] Running download-and-extract step. 05:10:51 INFO - Running pre-action listener: _resource_record_pre_action 05:10:51 INFO - Running main action method: download_and_extract 05:10:51 INFO - mkdir: /builds/slave/test/build/tests 05:10:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:10:51 INFO - trying https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:10:51 INFO - Downloading https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:10:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:10:52 INFO - Downloaded 1361 bytes. 05:10:52 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:10:52 INFO - Using the following test package requirements: 05:10:52 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:10:52 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:10:52 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:10:52 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:52 INFO - u'jsshell-linux-x86_64.zip'], 05:10:52 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:10:52 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:10:52 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:10:52 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:10:52 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:10:52 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:10:52 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:10:52 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:10:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:10:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:10:52 INFO - Fetch https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:10:52 INFO - Http code: 200 05:10:52 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 05:10:52 INFO - x-amz-cf-id: 0ivxBzKSw6n48TSuCuoqwQZv9sUjD43JjBtV8PPOAv2PbZi7JV844A== 05:10:52 INFO - x-amz-version-id: qPkkD3nZI96_4EWsJvWOm7CXHXtI0chm 05:10:52 INFO - Expected file size: 21922909 05:10:52 INFO - Obtained file size: 21922909 05:10:56 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:10:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:10:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:10:56 INFO - Fetch https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:10:57 INFO - Http code: 200 05:10:57 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 05:10:57 INFO - x-amz-cf-id: 5_4DSKdkgL72AcwlVLOuhwsp6bP8SWDGaMltaPAI3-Wo5PX4FvmhPg== 05:10:57 INFO - x-amz-version-id: qPkkD3nZI96_4EWsJvWOm7CXHXtI0chm 05:10:57 INFO - Expected file size: 21922909 05:10:57 INFO - Obtained file size: 21922909 05:11:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 05:11:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:11:02 INFO - Fetch https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 05:11:02 INFO - Http code: 200 05:11:02 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 05:11:02 INFO - x-amz-cf-id: OjjBFpJjAizOLfNAn8lYk75Q5S73anU0D3RLj2HOGSO-JpwzYDsskA== 05:11:02 INFO - x-amz-version-id: o3wyiiU25zddtm4YAu8vkoSRJ80P6Ghq 05:11:02 INFO - Expected file size: 14409038 05:11:02 INFO - Obtained file size: 14409038 05:11:03 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')]} 05:11:03 INFO - trying https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:11:03 INFO - Downloading https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:11:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:11:04 INFO - Downloaded 59591326 bytes. 05:11:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:11:04 INFO - mkdir: /builds/slave/test/properties 05:11:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:11:04 INFO - Writing to file /builds/slave/test/properties/build_url 05:11:04 INFO - Contents: 05:11:04 INFO - build_url:https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:11:05 INFO - Running post-action listener: _resource_record_post_action 05:11:05 INFO - Running post-action listener: set_extra_try_arguments 05:11:05 INFO - [mozharness: 2016-11-08 13:11:05.126195Z] Finished download-and-extract step (success) 05:11:05 INFO - [mozharness: 2016-11-08 13:11:05.126421Z] Running populate-webroot step. 05:11:05 INFO - Running pre-action listener: _resource_record_pre_action 05:11:05 INFO - Running main action method: populate_webroot 05:11:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:11:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:11:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:11:05 INFO - '--tppagecycles', 05:11:05 INFO - '7'], 05:11:05 INFO - 'tests': ['tsvgm']}}, 05:11:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:11:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:11:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:11:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:11:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:11:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:11:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:05 INFO - 'talos_options': ['--disable-e10s'], 05:11:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:11:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:11:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:05 INFO - 'talos_options': ['--disable-e10s'], 05:11:05 INFO - 'tests': ['damp', 'tps']}, 05:11:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:05 INFO - 'tests': ['damp', 'tps']}, 05:11:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:11:05 INFO - 'tests': ['dromaeo_dom']}, 05:11:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:11:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:11:05 INFO - 'tests': ['basic_compositor_video']}, 05:11:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:11:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:11:05 INFO - 'tests': ['a11yr', 05:11:05 INFO - 'ts_paint', 05:11:05 INFO - 'tpaint', 05:11:05 INFO - 'sessionrestore', 05:11:05 INFO - 'sessionrestore_no_auto_restore', 05:11:05 INFO - 'tabpaint']}, 05:11:05 INFO - 'other-e10s': {'tests': ['a11yr', 05:11:05 INFO - 'ts_paint', 05:11:05 INFO - 'tpaint', 05:11:05 INFO - 'sessionrestore', 05:11:05 INFO - 'sessionrestore_no_auto_restore', 05:11:05 INFO - 'tabpaint']}, 05:11:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:11:05 INFO - 'ts_paint', 05:11:05 INFO - 'tpaint', 05:11:05 INFO - 'sessionrestore', 05:11:05 INFO - 'sessionrestore_no_auto_restore', 05:11:05 INFO - 'tabpaint']}, 05:11:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:11:05 INFO - 'ts_paint', 05:11:05 INFO - 'tpaint', 05:11:05 INFO - 'sessionrestore', 05:11:05 INFO - 'sessionrestore_no_auto_restore', 05:11:05 INFO - 'tabpaint']}, 05:11:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:11:05 INFO - 'tests': ['a11yr', 05:11:05 INFO - 'ts_paint', 05:11:05 INFO - 'tpaint', 05:11:05 INFO - 'sessionrestore', 05:11:05 INFO - 'sessionrestore_no_auto_restore', 05:11:05 INFO - 'tabpaint']}, 05:11:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:11:05 INFO - 'tests': ['a11yr', 05:11:05 INFO - 'ts_paint', 05:11:05 INFO - 'tpaint', 05:11:05 INFO - 'sessionrestore', 05:11:05 INFO - 'sessionrestore_no_auto_restore', 05:11:05 INFO - 'tabpaint']}, 05:11:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:11:05 INFO - 'tests': ['tsvgx', 05:11:05 INFO - 'tsvgr_opacity', 05:11:05 INFO - 'tart', 05:11:05 INFO - 'tscrollx', 05:11:05 INFO - 'cart']}, 05:11:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:11:05 INFO - 'tsvgr_opacity', 05:11:05 INFO - 'tart', 05:11:05 INFO - 'tscrollx', 05:11:05 INFO - 'cart']}, 05:11:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:05 INFO - 'talos_options': ['--disable-e10s'], 05:11:05 INFO - 'tests': ['tp5o']}, 05:11:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:05 INFO - 'tests': ['tp5o']}, 05:11:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:05 INFO - 'talos_options': ['--disable-e10s', 05:11:05 INFO - '--xperf_path', 05:11:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:11:05 INFO - 'tests': ['tp5n']}, 05:11:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:05 INFO - 'talos_options': ['--xperf_path', 05:11:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:11:05 INFO - 'tests': ['tp5n']}}, 05:11:05 INFO - 'talos.zip': {'path': '', 05:11:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:11:05 INFO - Running post-action listener: _resource_record_post_action 05:11:05 INFO - [mozharness: 2016-11-08 13:11:05.145103Z] Finished populate-webroot step (success) 05:11:05 INFO - [mozharness: 2016-11-08 13:11:05.145190Z] Running create-virtualenv step. 05:11:05 INFO - Running pre-action listener: _resource_record_pre_action 05:11:05 INFO - Running main action method: create_virtualenv 05:11:05 INFO - Creating virtualenv /builds/slave/test/build/venv 05:11:05 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 05:11:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:11:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:11:05 INFO - Using real prefix '/usr' 05:11:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:11:05 INFO - Installing distribute.............................................................................................................................................................................................done. 05:11:07 INFO - Installing pip.................done. 05:11:07 INFO - Return code: 0 05:11:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:11:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:11:07 INFO - Reading from file tmpfile_stdout 05:11:07 INFO - Output received: 05:11:07 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) 05:11:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:11:07 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')]} 05:11:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:07 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')]} 05:11:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:07 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 0x7f74a2214f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2989790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2986930>, '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 0x2987830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2987cc0>, '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': '6d15e502d8e29d5d2676d664000001c3-1478610649.6616-312709495', '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 05:11:07 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 05:11:07 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 05:11:07 INFO - Using env: {'DISPLAY': ':0', 05:11:07 INFO - 'HOME': '/home/cltbld', 05:11:07 INFO - 'LANG': 'en_US.UTF-8', 05:11:07 INFO - 'LANGUAGE': 'en_US:en', 05:11:07 INFO - 'LOGNAME': 'cltbld', 05:11:07 INFO - 'MAIL': '/var/mail/cltbld', 05:11:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:07 INFO - 'MOZ_NO_REMOTE': '1', 05:11:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:07 INFO - 'NO_EM_RESTART': '1', 05:11:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:07 INFO - 'PWD': '/builds/slave/test', 05:11:07 INFO - 'SHELL': '/bin/bash', 05:11:07 INFO - 'SHLVL': '1', 05:11:07 INFO - 'TERM': 'linux', 05:11:07 INFO - 'TMOUT': '86400', 05:11:07 INFO - 'USER': 'cltbld', 05:11:07 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1478610649.6616-312709495', 05:11:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:07 INFO - '_': '/tools/buildbot/bin/python'} 05:11:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:08 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 05:11:08 INFO - Cleaning up... 05:11:08 INFO - Return code: 0 05:11:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:11: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')]} 05:11:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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')]} 05:11:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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', '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 0x7f74a2214f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2989790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2986930>, '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 0x2987830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2987cc0>, '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': '6d15e502d8e29d5d2676d664000001c3-1478610649.6616-312709495', '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 05:11: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', 'psutil>=3.1.1'] in /builds/slave/test/build 05:11: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 psutil>=3.1.1 05:11:08 INFO - Using env: {'DISPLAY': ':0', 05:11:08 INFO - 'HOME': '/home/cltbld', 05:11:08 INFO - 'LANG': 'en_US.UTF-8', 05:11:08 INFO - 'LANGUAGE': 'en_US:en', 05:11:08 INFO - 'LOGNAME': 'cltbld', 05:11:08 INFO - 'MAIL': '/var/mail/cltbld', 05:11:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:08 INFO - 'MOZ_NO_REMOTE': '1', 05:11:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:08 INFO - 'NO_EM_RESTART': '1', 05:11:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:08 INFO - 'PWD': '/builds/slave/test', 05:11:08 INFO - 'SHELL': '/bin/bash', 05:11:08 INFO - 'SHLVL': '1', 05:11:08 INFO - 'TERM': 'linux', 05:11:08 INFO - 'TMOUT': '86400', 05:11:08 INFO - 'USER': 'cltbld', 05:11:08 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1478610649.6616-312709495', 05:11:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:08 INFO - '_': '/tools/buildbot/bin/python'} 05:11:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:08 INFO - Downloading/unpacking psutil>=3.1.1 05:11: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 05:11: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 05:11: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 05:11: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 05:11: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 05:11: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 05:11:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:11:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:11:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:11:10 INFO - Installing collected packages: psutil 05:11:10 INFO - Running setup.py install for psutil 05:11:10 INFO - building 'psutil._psutil_linux' extension 05:11:10 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 05:11:10 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 05:11:10 INFO - building 'psutil._psutil_posix' extension 05:11:10 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 05:11:10 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 05:11:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:11:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:11:10 INFO - Successfully installed psutil 05:11:10 INFO - Cleaning up... 05:11:11 INFO - Return code: 0 05:11:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:11:11 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')]} 05:11:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:11 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')]} 05:11:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:11 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 0x7f74a2214f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2989790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2986930>, '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 0x2987830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2987cc0>, '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': '6d15e502d8e29d5d2676d664000001c3-1478610649.6616-312709495', '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 05:11:11 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 05:11:11 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 05:11:11 INFO - Using env: {'DISPLAY': ':0', 05:11:11 INFO - 'HOME': '/home/cltbld', 05:11:11 INFO - 'LANG': 'en_US.UTF-8', 05:11:11 INFO - 'LANGUAGE': 'en_US:en', 05:11:11 INFO - 'LOGNAME': 'cltbld', 05:11:11 INFO - 'MAIL': '/var/mail/cltbld', 05:11:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:11 INFO - 'MOZ_NO_REMOTE': '1', 05:11:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:11 INFO - 'NO_EM_RESTART': '1', 05:11:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:11 INFO - 'PWD': '/builds/slave/test', 05:11:11 INFO - 'SHELL': '/bin/bash', 05:11:11 INFO - 'SHLVL': '1', 05:11:11 INFO - 'TERM': 'linux', 05:11:11 INFO - 'TMOUT': '86400', 05:11:11 INFO - 'USER': 'cltbld', 05:11:11 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1478610649.6616-312709495', 05:11:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:11 INFO - '_': '/tools/buildbot/bin/python'} 05:11:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:11: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 05:11: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 05:11: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 05:11: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 05:11: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 05:11: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 05:11:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:11:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:11:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:11:13 INFO - Installing collected packages: mozsystemmonitor 05:11:13 INFO - Running setup.py install for mozsystemmonitor 05:11:13 INFO - Successfully installed mozsystemmonitor 05:11:13 INFO - Cleaning up... 05:11:13 INFO - Return code: 0 05:11:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:11: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')]} 05:11:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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')]} 05:11:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11: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', '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 0x7f74a2214f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2989790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2986930>, '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 0x2987830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2987cc0>, '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': '6d15e502d8e29d5d2676d664000001c3-1478610649.6616-312709495', '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 05:11: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:11: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 jsonschema==2.5.1 05:11:13 INFO - Using env: {'DISPLAY': ':0', 05:11:13 INFO - 'HOME': '/home/cltbld', 05:11:13 INFO - 'LANG': 'en_US.UTF-8', 05:11:13 INFO - 'LANGUAGE': 'en_US:en', 05:11:13 INFO - 'LOGNAME': 'cltbld', 05:11:13 INFO - 'MAIL': '/var/mail/cltbld', 05:11:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:13 INFO - 'MOZ_NO_REMOTE': '1', 05:11:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:13 INFO - 'NO_EM_RESTART': '1', 05:11:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:13 INFO - 'PWD': '/builds/slave/test', 05:11:13 INFO - 'SHELL': '/bin/bash', 05:11:13 INFO - 'SHLVL': '1', 05:11:13 INFO - 'TERM': 'linux', 05:11:13 INFO - 'TMOUT': '86400', 05:11:13 INFO - 'USER': 'cltbld', 05:11:13 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1478610649.6616-312709495', 05:11:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:13 INFO - '_': '/tools/buildbot/bin/python'} 05:11:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:13 INFO - Downloading/unpacking jsonschema==2.5.1 05:11: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 05:11: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 05:11: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 05:11: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 05:11: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 05:11: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 05:11:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:11:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:11:15 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 05:11:15 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 05:11:15 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 05:11:15 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 05:11:15 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 05:11:15 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 05:11:15 INFO - Downloading functools32-3.2.3-2.tar.gz 05:11:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:11:15 INFO - warning: no files found matching '*.txt' 05:11:15 INFO - no previously-included directories found matching 'build' 05:11:15 INFO - no previously-included directories found matching 'dist' 05:11:15 INFO - no previously-included directories found matching '.git*' 05:11:15 INFO - Installing collected packages: jsonschema, functools32 05:11:15 INFO - Running setup.py install for functools32 05:11:15 INFO - warning: no files found matching '*.txt' 05:11:15 INFO - no previously-included directories found matching 'build' 05:11:15 INFO - no previously-included directories found matching 'dist' 05:11:15 INFO - no previously-included directories found matching '.git*' 05:11:15 INFO - Successfully installed jsonschema functools32 05:11:15 INFO - Cleaning up... 05:11:15 INFO - Return code: 0 05:11:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:11:15 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')]} 05:11:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:15 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')]} 05:11:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f74a2214f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2989790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2986930>, '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 0x2987830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2987cc0>, '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': '6d15e502d8e29d5d2676d664000001c3-1478610649.6616-312709495', '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 05:11:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:11:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:11:16 INFO - Using env: {'DISPLAY': ':0', 05:11:16 INFO - 'HOME': '/home/cltbld', 05:11:16 INFO - 'LANG': 'en_US.UTF-8', 05:11:16 INFO - 'LANGUAGE': 'en_US:en', 05:11:16 INFO - 'LOGNAME': 'cltbld', 05:11:16 INFO - 'MAIL': '/var/mail/cltbld', 05:11:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:16 INFO - 'MOZ_NO_REMOTE': '1', 05:11:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:16 INFO - 'NO_EM_RESTART': '1', 05:11:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:16 INFO - 'PWD': '/builds/slave/test', 05:11:16 INFO - 'SHELL': '/bin/bash', 05:11:16 INFO - 'SHLVL': '1', 05:11:16 INFO - 'TERM': 'linux', 05:11:16 INFO - 'TMOUT': '86400', 05:11:16 INFO - 'USER': 'cltbld', 05:11:16 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1478610649.6616-312709495', 05:11:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:16 INFO - '_': '/tools/buildbot/bin/python'} 05:11:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:11:16 INFO - Cleaning up... 05:11:16 INFO - Return code: 0 05:11:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:11:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f74a2214f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2989790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2986930>, '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 0x2987830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2987cc0>, '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': '6d15e502d8e29d5d2676d664000001c3-1478610649.6616-312709495', '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 05:11:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:11:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:11:16 INFO - Using env: {'DISPLAY': ':0', 05:11:16 INFO - 'HOME': '/home/cltbld', 05:11:16 INFO - 'LANG': 'en_US.UTF-8', 05:11:16 INFO - 'LANGUAGE': 'en_US:en', 05:11:16 INFO - 'LOGNAME': 'cltbld', 05:11:16 INFO - 'MAIL': '/var/mail/cltbld', 05:11:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:16 INFO - 'MOZ_NO_REMOTE': '1', 05:11:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:16 INFO - 'NO_EM_RESTART': '1', 05:11:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:16 INFO - 'PWD': '/builds/slave/test', 05:11:16 INFO - 'SHELL': '/bin/bash', 05:11:16 INFO - 'SHLVL': '1', 05:11:16 INFO - 'TERM': 'linux', 05:11:16 INFO - 'TMOUT': '86400', 05:11:16 INFO - 'USER': 'cltbld', 05:11:16 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1478610649.6616-312709495', 05:11:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:16 INFO - '_': '/tools/buildbot/bin/python'} 05:11:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:16 INFO - Downloading/unpacking blobuploader==1.2.4 05:11: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 05:11: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 05:11: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 05:11: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 05:11: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 05:11: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 05:11:18 INFO - Downloading blobuploader-1.2.4.tar.gz 05:11:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:11:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:11:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:19 INFO - Downloading docopt-0.6.1.tar.gz 05:11:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:11:19 INFO - Installing collected packages: blobuploader, requests, docopt 05:11:19 INFO - Running setup.py install for blobuploader 05:11:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:11:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:11:19 INFO - Running setup.py install for requests 05:11:19 INFO - Running setup.py install for docopt 05:11:19 INFO - Successfully installed blobuploader requests docopt 05:11:19 INFO - Cleaning up... 05:11:19 INFO - Return code: 0 05:11:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:19 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 0x7f74a2214f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2989790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2986930>, '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 0x2987830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2987cc0>, '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': '6d15e502d8e29d5d2676d664000001c3-1478610649.6616-312709495', '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 05:11:19 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 05:11:19 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 05:11:19 INFO - Using env: {'DISPLAY': ':0', 05:11:19 INFO - 'HOME': '/home/cltbld', 05:11:19 INFO - 'LANG': 'en_US.UTF-8', 05:11:19 INFO - 'LANGUAGE': 'en_US:en', 05:11:19 INFO - 'LOGNAME': 'cltbld', 05:11:19 INFO - 'MAIL': '/var/mail/cltbld', 05:11:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:19 INFO - 'MOZ_NO_REMOTE': '1', 05:11:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:19 INFO - 'NO_EM_RESTART': '1', 05:11:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:19 INFO - 'PWD': '/builds/slave/test', 05:11:19 INFO - 'SHELL': '/bin/bash', 05:11:19 INFO - 'SHLVL': '1', 05:11:19 INFO - 'TERM': 'linux', 05:11:19 INFO - 'TMOUT': '86400', 05:11:19 INFO - 'USER': 'cltbld', 05:11:19 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1478610649.6616-312709495', 05:11:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:19 INFO - '_': '/tools/buildbot/bin/python'} 05:11:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:11:20 INFO - Running setup.py (path:/tmp/pip-NrQEbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:11:20 INFO - Running setup.py (path:/tmp/pip-EBfE92-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:11:20 INFO - Running setup.py (path:/tmp/pip-A1GcOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:11:20 INFO - Running setup.py (path:/tmp/pip-F9NHhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:11:20 INFO - Running setup.py (path:/tmp/pip-a4d6UZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:11:20 INFO - Running setup.py (path:/tmp/pip-O6LJ9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:11:20 INFO - Running setup.py (path:/tmp/pip-y_CbvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:11:20 INFO - Running setup.py (path:/tmp/pip-vxy0jn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:11:20 INFO - Running setup.py (path:/tmp/pip-Ltqdz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:11:20 INFO - Running setup.py (path:/tmp/pip-pBRzY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:11:20 INFO - Running setup.py (path:/tmp/pip-WW1kBY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:11:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:11:20 INFO - Running setup.py (path:/tmp/pip-ReymMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:11:21 INFO - Running setup.py (path:/tmp/pip-ehRFAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:11:21 INFO - Running setup.py (path:/tmp/pip-nHItIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:21 INFO - Running setup.py (path:/tmp/pip-BiiD0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:11:21 INFO - Running setup.py (path:/tmp/pip-kuqC7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:11:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:11:21 INFO - Running setup.py (path:/tmp/pip-ffIUPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:11:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:11:21 INFO - Running setup.py install for manifestparser 05:11:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:11:21 INFO - Running setup.py install for mozcrash 05:11:21 INFO - Running setup.py install for mozdebug 05:11:21 INFO - Running setup.py install for mozdevice 05:11:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:11:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:11:21 INFO - Running setup.py install for mozfile 05:11:21 INFO - Running setup.py install for mozhttpd 05:11:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:11:22 INFO - Running setup.py install for mozinfo 05:11:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:11:22 INFO - Running setup.py install for mozInstall 05:11:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:11:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:11:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:11:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:11:22 INFO - Running setup.py install for mozleak 05:11:22 INFO - Running setup.py install for mozlog 05:11:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:11:22 INFO - Running setup.py install for moznetwork 05:11:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:11:22 INFO - Running setup.py install for mozprocess 05:11:22 INFO - Running setup.py install for mozprofile 05:11:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:11:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:11:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:11:22 INFO - Running setup.py install for mozrunner 05:11:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:11:22 INFO - Running setup.py install for mozscreenshot 05:11:22 INFO - Running setup.py install for moztest 05:11:23 INFO - Running setup.py install for mozversion 05:11:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:11:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:11:23 INFO - Cleaning up... 05:11:23 INFO - Return code: 0 05:11:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11:23 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')]} 05:11:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:23 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')]} 05:11:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:23 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 0x7f74a2214f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2989790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2986930>, '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 0x2987830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2987cc0>, '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': '6d15e502d8e29d5d2676d664000001c3-1478610649.6616-312709495', '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 05:11:23 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 05:11:23 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 05:11:23 INFO - Using env: {'DISPLAY': ':0', 05:11:23 INFO - 'HOME': '/home/cltbld', 05:11:23 INFO - 'LANG': 'en_US.UTF-8', 05:11:23 INFO - 'LANGUAGE': 'en_US:en', 05:11:23 INFO - 'LOGNAME': 'cltbld', 05:11:23 INFO - 'MAIL': '/var/mail/cltbld', 05:11:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:23 INFO - 'MOZ_NO_REMOTE': '1', 05:11:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:23 INFO - 'NO_EM_RESTART': '1', 05:11:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:23 INFO - 'PWD': '/builds/slave/test', 05:11:23 INFO - 'SHELL': '/bin/bash', 05:11:23 INFO - 'SHLVL': '1', 05:11:23 INFO - 'TERM': 'linux', 05:11:23 INFO - 'TMOUT': '86400', 05:11:23 INFO - 'USER': 'cltbld', 05:11:23 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1478610649.6616-312709495', 05:11:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:23 INFO - '_': '/tools/buildbot/bin/python'} 05:11:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:11:23 INFO - Running setup.py (path:/tmp/pip-9VOGFJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:11:23 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)) 05:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:11:23 INFO - Running setup.py (path:/tmp/pip-l3HbKM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:11:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:11:23 INFO - Running setup.py (path:/tmp/pip-dPtku_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:11:23 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)) 05:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:11:23 INFO - Running setup.py (path:/tmp/pip-RV1cCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:11:23 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)) 05:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:11:23 INFO - Running setup.py (path:/tmp/pip-N76p9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:11:23 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)) 05:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:11:23 INFO - Running setup.py (path:/tmp/pip-Cm6z9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:11:23 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)) 05:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:11:23 INFO - Running setup.py (path:/tmp/pip-pDuGD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:11:23 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)) 05:11:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:11:23 INFO - Running setup.py (path:/tmp/pip-1jc0VW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:11:24 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)) 05:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:11:24 INFO - Running setup.py (path:/tmp/pip-0WkQ_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:11:24 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)) 05:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:11:24 INFO - Running setup.py (path:/tmp/pip-gFZWgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:11:24 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)) 05:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:11:24 INFO - Running setup.py (path:/tmp/pip-ZPSY1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:11:24 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)) 05:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:11:24 INFO - Running setup.py (path:/tmp/pip-WldH35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:11:24 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)) 05:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:11:24 INFO - Running setup.py (path:/tmp/pip-Wownw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:11:24 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)) 05:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:11:24 INFO - Running setup.py (path:/tmp/pip-vtD4eK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:11:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:24 INFO - Running setup.py (path:/tmp/pip-cHmBSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:11:24 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)) 05:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:11:24 INFO - Running setup.py (path:/tmp/pip-HbIckv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:11:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:11:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:11:24 INFO - Running setup.py (path:/tmp/pip-_TuKiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:11:24 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)) 05:11:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:11:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:11:24 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)) 05:11:24 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)) 05:11:24 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)) 05:11:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:26 INFO - Downloading blessings-1.6.tar.gz 05:11:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:11:27 INFO - Installing collected packages: blessings 05:11:27 INFO - Running setup.py install for blessings 05:11:27 INFO - Successfully installed blessings 05:11:27 INFO - Cleaning up... 05:11:27 INFO - Return code: 0 05:11:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:11:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:11:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:11:27 INFO - Reading from file tmpfile_stdout 05:11:27 INFO - Current package versions: 05:11:27 INFO - argparse == 1.2.1 05:11:27 INFO - blessings == 1.6 05:11:27 INFO - blobuploader == 1.2.4 05:11:27 INFO - docopt == 0.6.1 05:11:27 INFO - functools32 == 3.2.3-2 05:11:27 INFO - jsonschema == 2.5.1 05:11:27 INFO - manifestparser == 1.1 05:11:27 INFO - mozInstall == 1.12 05:11:27 INFO - mozcrash == 0.17 05:11:27 INFO - mozdebug == 0.1 05:11:27 INFO - mozdevice == 0.48 05:11:27 INFO - mozfile == 1.2 05:11:27 INFO - mozhttpd == 0.7 05:11:27 INFO - mozinfo == 0.9 05:11:27 INFO - mozleak == 0.1 05:11:27 INFO - mozlog == 3.4 05:11:27 INFO - moznetwork == 0.27 05:11:27 INFO - mozprocess == 0.23 05:11:27 INFO - mozprofile == 0.28 05:11:27 INFO - mozrunner == 6.12 05:11:27 INFO - mozscreenshot == 0.1 05:11:27 INFO - mozsystemmonitor == 0.3 05:11:27 INFO - moztest == 0.7 05:11:27 INFO - mozversion == 1.4 05:11:27 INFO - psutil == 3.1.1 05:11:27 INFO - requests == 1.2.3 05:11:27 INFO - wsgiref == 0.1.2 05:11:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:27 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 0x7f74a2214f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2989790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2986930>, '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 0x2987830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2987cc0>, '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': '6d15e502d8e29d5d2676d664000001c3-1478610649.6616-312709495', '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 05:11:27 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 05:11:27 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 05:11:27 INFO - Using env: {'DISPLAY': ':0', 05:11:27 INFO - 'HOME': '/home/cltbld', 05:11:27 INFO - 'LANG': 'en_US.UTF-8', 05:11:27 INFO - 'LANGUAGE': 'en_US:en', 05:11:27 INFO - 'LOGNAME': 'cltbld', 05:11:27 INFO - 'MAIL': '/var/mail/cltbld', 05:11:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:27 INFO - 'MOZ_NO_REMOTE': '1', 05:11:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:27 INFO - 'NO_EM_RESTART': '1', 05:11:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:27 INFO - 'PWD': '/builds/slave/test', 05:11:27 INFO - 'SHELL': '/bin/bash', 05:11:27 INFO - 'SHLVL': '1', 05:11:27 INFO - 'TERM': 'linux', 05:11:27 INFO - 'TMOUT': '86400', 05:11:27 INFO - 'USER': 'cltbld', 05:11:27 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1478610649.6616-312709495', 05:11:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:27 INFO - '_': '/tools/buildbot/bin/python'} 05:11:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:27 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)) 05:11:27 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)) 05:11:27 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)) 05:11:27 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)) 05:11:27 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)) 05:11:27 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)) 05:11:27 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)) 05:11:27 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)) 05:11:27 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)) 05:11:27 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)) 05:11:27 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)) 05:11:27 INFO - Cleaning up... 05:11:27 INFO - Return code: 0 05:11:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:27 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 0x7f74a2214f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2989790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2986930>, '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 0x2987830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2987cc0>, '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': '6d15e502d8e29d5d2676d664000001c3-1478610649.6616-312709495', '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 05:11:27 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 05:11:27 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 05:11:27 INFO - Using env: {'DISPLAY': ':0', 05:11:27 INFO - 'HOME': '/home/cltbld', 05:11:27 INFO - 'LANG': 'en_US.UTF-8', 05:11:27 INFO - 'LANGUAGE': 'en_US:en', 05:11:27 INFO - 'LOGNAME': 'cltbld', 05:11:27 INFO - 'MAIL': '/var/mail/cltbld', 05:11:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:27 INFO - 'MOZ_NO_REMOTE': '1', 05:11:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:27 INFO - 'NO_EM_RESTART': '1', 05:11:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:27 INFO - 'PWD': '/builds/slave/test', 05:11:27 INFO - 'SHELL': '/bin/bash', 05:11:27 INFO - 'SHLVL': '1', 05:11:27 INFO - 'TERM': 'linux', 05:11:27 INFO - 'TMOUT': '86400', 05:11:27 INFO - 'USER': 'cltbld', 05:11:27 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1478610649.6616-312709495', 05:11:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:27 INFO - '_': '/tools/buildbot/bin/python'} 05:11:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:11:28 INFO - Cleaning up... 05:11:28 INFO - Return code: 0 05:11:28 INFO - Running post-action listener: _resource_record_post_action 05:11:28 INFO - Running post-action listener: _start_resource_monitoring 05:11:28 INFO - Starting resource monitoring. 05:11:28 INFO - [mozharness: 2016-11-08 13:11:28.191261Z] Finished create-virtualenv step (success) 05:11:28 INFO - [mozharness: 2016-11-08 13:11:28.191715Z] Running install step. 05:11:28 INFO - Running pre-action listener: _resource_record_pre_action 05:11:28 INFO - Running main action method: install 05:11:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:11:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:11:28 INFO - Reading from file tmpfile_stdout 05:11:28 INFO - Detecting whether we're running mozinstall >=1.0... 05:11:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:11:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:11:28 INFO - Reading from file tmpfile_stdout 05:11:28 INFO - Output received: 05:11:28 INFO - Usage: mozinstall [options] installer 05:11:28 INFO - Options: 05:11:28 INFO - -h, --help show this help message and exit 05:11:28 INFO - -d DEST, --destination=DEST 05:11:28 INFO - Directory to install application into. [default: 05:11:28 INFO - "/builds/slave/test"] 05:11:28 INFO - --app=APP Application being installed. [default: firefox] 05:11:28 INFO - mkdir: /builds/slave/test/build/application 05:11:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:11:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:11:45 INFO - Reading from file tmpfile_stdout 05:11:45 INFO - Output received: 05:11:45 INFO - /builds/slave/test/build/application/firefox/firefox 05:11:45 INFO - Running post-action listener: _resource_record_post_action 05:11:45 INFO - [mozharness: 2016-11-08 13:11:45.428012Z] Finished install step (success) 05:11:45 INFO - [mozharness: 2016-11-08 13:11:45.428256Z] Running run-tests step. 05:11:45 INFO - Running pre-action listener: _resource_record_pre_action 05:11:45 INFO - Running main action method: run_tests 05:11:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:11:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:11:45 INFO - Python 2.7.3 05:11:45 INFO - Return code: 0 05:11:45 INFO - grabbing minidump binary from tooltool 05:11:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:11:45 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 0x2986930>, '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 0x2987830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2987cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:11:45 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 05:11:45 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 05:11:45 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 05:11:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:11:45 INFO - Return code: 0 05:11:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:11:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:11:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:11:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:11:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:11:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 05:11:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 05:11:45 INFO - Using env: {'DISPLAY': ':0', 05:11:45 INFO - 'HOME': '/home/cltbld', 05:11:45 INFO - 'LANG': 'en_US.UTF-8', 05:11:45 INFO - 'LANGUAGE': 'en_US:en', 05:11:45 INFO - 'LOGNAME': 'cltbld', 05:11:45 INFO - 'MAIL': '/var/mail/cltbld', 05:11:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:11:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:11:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:45 INFO - 'MOZ_NO_REMOTE': '1', 05:11:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:11:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:45 INFO - 'NO_EM_RESTART': '1', 05:11:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:45 INFO - 'PWD': '/builds/slave/test', 05:11:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:11:45 INFO - 'SHELL': '/bin/bash', 05:11:45 INFO - 'SHLVL': '1', 05:11:45 INFO - 'TERM': 'linux', 05:11:45 INFO - 'TMOUT': '86400', 05:11:45 INFO - 'USER': 'cltbld', 05:11:45 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1478610649.6616-312709495', 05:11:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:45 INFO - '_': '/tools/buildbot/bin/python'} 05:11:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 05:11:45 INFO - mozversion application_buildid: 20161108030212 05:11:45 INFO - mozversion application_changeset: f13e90d496cf1bc6dfc4fd398da33e4afe785bde 05:11:45 INFO - mozversion application_display_name: Nightly 05:11:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:11:45 INFO - mozversion application_name: Firefox 05:11:45 INFO - mozversion application_remotingname: firefox 05:11:45 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:11:45 INFO - mozversion application_vendor: Mozilla 05:11:45 INFO - mozversion application_version: 52.0a1 05:11:45 INFO - mozversion platform_buildid: 20161108030212 05:11:45 INFO - mozversion platform_changeset: f13e90d496cf1bc6dfc4fd398da33e4afe785bde 05:11:45 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:11:45 INFO - mozversion platform_version: 52.0a1 05:11:45 INFO - using testdate: 1478610705 05:11:45 INFO - actual date: 1478610705 05:11:45 INFO - starting webserver on 'localhost:41606' 05:11:45 INFO - SUITE-START | Running 2 tests 05:11:45 INFO - TEST-START | dromaeo_css 05:11:45 INFO - operating with platform_type : linux_ 05:11:45 INFO - Initialising browser for dromaeo_css test... 05:11:45 INFO - TEST-INFO | started process 9306 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAc3nGN/profile http://localhost:41606/getInfo.html) 05:11:49 INFO - PROCESS | 9306 | __metrics Screen width/height:1600/1200 05:11:49 INFO - PROCESS | 9306 | colorDepth:24 05:11:49 INFO - PROCESS | 9306 | Browser inner width/height: 1024/697 05:11:49 INFO - PROCESS | 9306 | __metrics 05:11:50 INFO - PROCESS | 9306 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:11:50 INFO - PROCESS | 9306 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:11:50 INFO - PROCESS | 9306 | console.error: PushService: 05:11:50 INFO - PROCESS | 9306 | stateChangeProcessEnqueue: Error transitioning state 05:11:50 INFO - PROCESS | 9306 | UnknownError 05:11:51 INFO - TEST-INFO | 9306: exit 0 05:11:51 INFO - Browser initialized. 05:11:51 INFO - Running cycle 1/1 for dromaeo_css test... 05:11:51 INFO - TEST-INFO | started process 9388 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAc3nGN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:12:03 INFO - PROCESS | 9388 | RSS: Main: 172072960 05:12:03 INFO - PROCESS | 9388 | 05:12:55 INFO - PROCESS | 9388 | 1478610775170 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:15:05 INFO - PROCESS | 9388 | Cycle 1(1): loaded http://localhost:41606/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41606/tests/dromaeo/cssquery-ext.html) 05:15:07 INFO - PROCESS | 9388 | RSS: Main: 328941568 05:15:07 INFO - PROCESS | 9388 | 05:18:10 INFO - PROCESS | 9388 | Cycle 1(1): loaded http://localhost:41606/tests/dromaeo/cssquery-ext.html (next: http://localhost:41606/tests/dromaeo/cssquery-jquery.html) 05:18:10 INFO - PROCESS | 9388 | RSS: Main: 284303360 05:18:10 INFO - PROCESS | 9388 | 05:21:13 INFO - PROCESS | 9388 | Cycle 1(1): loaded http://localhost:41606/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41606/tests/dromaeo/cssquery-mootools.html) 05:21:13 INFO - PROCESS | 9388 | RSS: Main: 248127488 05:21:13 INFO - PROCESS | 9388 | 05:24:15 INFO - PROCESS | 9388 | Cycle 1(1): loaded http://localhost:41606/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41606/tests/dromaeo/cssquery-prototype.html) 05:24:16 INFO - PROCESS | 9388 | RSS: Main: 250961920 05:24:16 INFO - PROCESS | 9388 | 05:27:19 INFO - PROCESS | 9388 | Cycle 1(1): loaded http://localhost:41606/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41606/tests/dromaeo/cssquery-yui.html) 05:27:19 INFO - PROCESS | 9388 | RSS: Main: 216109056 05:27:19 INFO - PROCESS | 9388 | 05:30:22 INFO - PROCESS | 9388 | Cycle 1(1): loaded http://localhost:41606/tests/dromaeo/cssquery-yui.html (next: http://localhost:41606/tests/dromaeo/cssquery-dojo.html) 05:30:22 INFO - PROCESS | 9388 | RSS: Main: 312037376 05:30:22 INFO - PROCESS | 9388 | 05:30:22 INFO - PROCESS | 9388 | __start_tp_report 05:30:22 INFO - PROCESS | 9388 | _x_x_mozilla_page_load 05:30:22 INFO - PROCESS | 9388 | _x_x_mozilla_page_load_details 05:30:22 INFO - PROCESS | 9388 | |i|pagename|runs| 05:30:22 INFO - PROCESS | 9388 | |0;dojo.html;3098.473259545877;3125.4999200127986;3130.6556278809326;3158.0367987763725;3177.95233071504;5269.077911365505;5310.89378212436;5345.49217824307;5373.355197376315;5390.1914712793105;5326.201069839526;5339.466053394668;5403.729813509329;5421.728913554316;5442.91835622465;4845.515448455161;4869.975650121744;4924.359833221676;4925.408950925894;4938.777755001033;4860.149473842063;4925.039617274633;4926.0394223126505;5016.749162541876;5018.548330650241;4943.060818444484;4996.675216110959;5005.299258103868;5008.924866127011;5064.3922729272535;4810.326554282403;4842.370491836074;4846.830360937351;4875.171220892456;4961.107000739866;4842;4847.83032593861;4853.660243782937;4854.49027852074;4857.14999875024;5238.449962753894;5308.734563271821;5309.230161626542;5312.415634280226;5332.280142180794;5670.518005969498;5675;5683.5737319700775;5684.54523638108;5689.630174038674;5691.51622112121;5700.116481945263;5709.9714501427225;5712.8857422851725;5726.914096288559;5330.360356757214;5355.250264962909;5372.704501252469;5374.946250537484;5379.67721936685;5814.127880817827;5831.067029275296;5832.066869300891;5833.300003999547;5841.707914604252;5640.5487560995025;5641.182028605829;5642.858928526737;5646.096624540054;5651.0675738503505;5558.416366281563;5629.915551266734;5690.516306113944;5713.914291285634;5718.1136923776885;5653.208550802891;5662.405447428043;5717.371089180187;5734.598578099493;5769.94230057694;5740.512056475246;5743.770249190069;5744.195812586241;5748.827535173951;5791.913121303184;4351.151525452569;4450.265706158512;4451.888702782457;4465.017696106851;4498.910021799546;3911.726179167431;3925.528936527635;3931.8623848165175;3939.9015024624614;3952.3676211805973;5469.124940009579;5469.398366179717;5474.890502189934;5484.424135465799;5518.613697041249;5771.971140144273;5780.335261444988;5781.88436231273;5787.189793428924;5795.043817770105;5327.387350454747;5379.1662292344745;5435.320584926884;5458.8908221835345;5499.862503437446;5014.323066385991;5016.523430274118;5057.089723849743;5058.342415486037;5059.19052951526;5994.130851026577;6022.18700475439;6040.486558642477;6040.909386359121;6041.577089603774;5629.943700562942;5690.231818704588;5773.826785196451;5811.53507719373;5815.185873977731;5904.793332233351;5932.733027013881;5943.791967281124;5955.940440595538;5991.940080599313;5602.691851948182;5604.4675755804765;5612;5612.971935140298;5613.186088017296;5570.080936645408;5715.199872018004;5723.198752174782;5723.399043100581;5724.8282551523525;5413.431589683027;5506.91739623898;5533.280673512579;5550.888982220414;5599.8880022400135;5503.807366742145;5547.33431988164;5559.054960656617;5562.16567514876;5568.025595520687;5498.752556134904;5504.22940788298;5510.8071217507195;5514.6691198528215;5548.361938377138;5511.889762204813;5561.138023606348;5588.469095436089;5613.88772224545;5626.718664066699;5522.779088836402;5534.280543529316;5537.335519737658;5570.526505246938;5587.1339942309005 05:30:22 INFO - PROCESS | 9388 | |1;ext.html;544.1503833786792;587.4947545111204;595.7616953218712;607.3653032580952;619.5508256514025;30756;33664.78195879637;33712.32575348495;33736.15659608508;40021.39967900484;40112.79943600285;43177.56822431775;43219.567804321945;43237.35143972835;43281.783591082;8479.618417171227;8547.615357308905;8549.40154189207;8549.95725021374;8625.525596092213;7961.601919903982;8166.714165004226;8497.320214382866;8652.653893844239;8678.218960293572;9994.850077248848;10247.897521024806;10248.538815753309;10410.583576656925;10452.947735261314;10335.224858135633;10398.584056637725;10404.115650169744;10413.323133996304;10416.635417760417;10217.846732299022;10266.12737917278;10277.177825773995;10324.174066074771;10341.121004714609;40062.79968600138;40509.189816203514;40517.189656207;40543.59456405428;40572;3397.813120278384;3427.674370934757;3457.3085382923264;3563.1448452371505;3633.5821380541047;29258.561121583192;30834.383312333626;31180.376392472022;32449.35101297961;32548.511772323433;3943.802809859524;3964.226975739732;4108.137291168829;4178.247915375231;4207.747535147871;320907;322772;325095.3745231282;325269;328973;59497;59840.102398464056;59871.700641496514;59881.802363952476;59904.70047649821;36554.63445365566;37430.62569374272;37433.81283093567;61534;61576.69211654003;16291.348346066261;16515.091669958027;16520.586985325222;16522.58693532647;16525.25636346343;11628.88371116295;11804.17370784037;11805.23265987708;11813.23213991105;11820.349880756468;17134.314627414762;17569.648607028044;18608.255669773327;18901.43295701131;19120.521986950436;6838.281980391987;6905.962740991419;6938.236793952661;7006.894896576556;7140.964295178491;956.4500412262977;1023.2070145637191;1055.5039131608285;1096.7587130831205;1102.823548232295;30725.539116912816;31666;31668.208294792814;31990.520142197885;32455.18862028421;1038.1020417338948;1051.222095649214;1092.3445932440632;1106.391484683437;1137.9203455758184;17061.232244549024;17608.55978600545;18032.549186270448;18125.909370453326;18344.54138646518;504549;506230;507409;508859;509072;50246;51543.48456515387;55148.448515514334;56045.43954560402;56158.59603509945;1286.7233544787728;1311.8622544632676;1315.5329857900308;1325.0459669038278;1340.6313263852323;30323.848380757954;32153.356932860745;33116.172095696835;33210.50552725085;33475.163120922174;48900.51099489102;52986;58727.41272587219;58892.69965703107;59598.70200648969;453301;456476;456631;456856;459041;38869.41695874621;39405.802970984965;39460.802695986335;39835.402468962406;40364.56901163434;47012.294815578476;47185.52814471811;47235.527644723115;47739.522604774895;48338;39092.41361379639;39284.60715392924;40546.69477861838;40881;41228;39245.6075439242;39538.80230598828;40137.799311003255;40684.18631627291;41676.58323416727;39068.804655976535;40154.799226003684;40392.39411408772;40398.79800600978;40730.185396291316;32748;34506.482402763475;35235.47146792749;35739.82130089333;35934.460983085795;26469.33826654349;27710.584341235302;27796.166115016582;27820;27838.3040423991 05:30:22 INFO - PROCESS | 9388 | |2;jquery.html;371.89215127612994;394.3611349613626;404.3954288338934;407.3096102106929;412.16742180794796;13184.7363052739;15127.168005759693;16219;18502.907485462587;18926.905365473187;18519.537011574717;18599.814001859977;18602.255909763626;18728.531786705338;18956.715649265272;5398.109311963531;5598.804041858536;5643.181738647893;5643.943560564383;5645.435456454363;4599.425071866017;5513.062779327524;5537.058700020986;5543.805966791163;5545.251391062216;5510.504054635082;5511.118221084627;5514.696691681956;5516;5518.889622207574;5339.092354299759;5533.446655334455;5534.308211473566;5541.861453463655;5544.362398324184;4790.113828941622;4988.127077761414;4988.950110498921;4995.850124496271;4998.525140111684;19757.80242197574;20502.794972050237;22108;22444;22520.09919603214;2310.549442858643;2420.479596886678;2677.9957515931524;2855.271905664063;2856.902365237888;9845.753856153653;9854.260930430175;10115;10157;10178.694639160836;1801.1714611278828;1862.8602854785945;1866.7386565880788;1906.4185423445842;1925.1914196037699;81523.18476815215;83124.16875831225;84932.57533712292;85730;85791.57104214502;10922.453877306103;10950.616728414467;11083.390413527171;11102.777944441066;11209;15741.291641876143;15772.76340854888;15784.60538486547;15786.21068946548;15789.921050394903;7450.329470347695;7597.088349398107;7700.653470593837;7837.960810195913;7903.051633803981;7069.328413800681;7125.82185445368;7213.314735100157;7341.74303899361;7342.559446433231;4476.798544065525;4584.724916505021;4695.671303008757;4772.737499437564;4801.423829140525;1941.825235728791;1967.478618166187;2000.2599038355902;2018.8889611071238;2044.9182032718525;841.9621117049625;853.5433543054436;931.6832077803043;940.7036783413203;965.2229954886384;18036;19187;19510.122044508033;19582.510437239183;19770.20919163246;961.5384615384654;966.2608104799833;1016.7966406718538;1026.9281150319405;1035.570238351076;10216.846747298796;10747.462626868626;10856.185786065918;10888.945555272332;10899.476717162448;455931;460852;461202;472642;474458;89829.55085224532;91093.54453227691;91436.54281728549;91478;92538.53730731439;1000.3047881722279;1055.6358056470506;1082.767205050918;1084.35480888871;1085.8316960871077;16283.267252973881;16763;17054.744178837576;17093.230804613573;17294.394696185573;30082.84958575193;40490.39264410977;41677.374839376826;42201.36697949472;42452;53845.730771345894;57557.42442575688;57887;59114;59368.10947835699;7816.335611473089;8091.8381632365845;8425.915740842513;8454;8564.400491965502;11881.821772673244;12715.427805748579;12852.678683032998;12968.286744229157;13459.394327255493;10397.272190946562;10775.461226938465;10880.347179169275;11192.888071119185;11491.138164637518;10710.143188545053;10880.183986200907;10981.212304429071;11076.39079850616;11354.489047993025;10706.143508519455;11187;11288.153388495732;11375.829362559734;11470.419155690237;8267.29727973129;8280.958595206985;8474.06785253634;8509.702160424604;8598.65605375803;9026.684066057656;11081.390523521284;11375.374354410587;11454;11820 05:30:22 INFO - PROCESS | 9388 | |3;mootools.html;1437.5831009007388;1443.9422423103074;1573.7639354096884;1671.3231141387741;1761.0138322539372;7509.098908131032;7741.574213418274;8004.39967002475;8537.060923298432;8546.743597692064;8041.8793718094275;8276.420650554464;8290.08809031006;8465.44974576652;8481.363897707666;2267.353804165813;2304.2971893572453;2311.6070268054386;2313.9884300578474;2319.3042087373806;2066.5143691232624;2123.4691327168207;2266.3654176830514;2306.976930230693;2309.90760369585;2214.9667754983607;2277.430642339415;2278.5898538263104;2291.644795056769;2294.265834932822;2273.8408311418207;2278.7721227877246;2288.3249441414823;2310.4685922237813;2314.0975019742314;2248.87631180285;2277.749447560767;2295.6556516522487;2296.437372843647;2323.6398358254496;8316.875246871301;8517.148285171495;8517.318614510825;8525.57372131391;8530.488170709716;5135.794568217267;5232.136697444917;5258.526732594047;5280.260763493114;5287.444818294062;3223.7421006319673;3321.3025264694443;3357.362101200764;3419.6580341965855;3428.879989200366;1108.8780234174235;1119.8544189255426;1130.508228920414;1142.360278244186;1160.3618010094415;11586.30482171064;11591.188616796744;11642.825357619558;11656.475458604384;11667.766644667145;4212.094399704079;4400.515943246241;4466.9106617867465;4483.820647174077;4490.361018228323;9195.402298850553;9195.954020229856;9196.264298856075;9196.448213107235;9203.40177888435;5167.974160129251;5168.689878607295;5173.5602473789395;5178.067947769362;5179.870503237449;4728.621710263171;4749.050189962021;4763.952360476351;4789.8323558675975;4860.6111511079025;3491.5984661763714;3594.6944509716445;3598.676119149289;3604.062943634674;3669.9816500917323;1048.7902419516126;1086.4241951765578;1113.6325012745774;1115.5928086248462;1125.7523344864117;939.1313035442189;950.6530116507425;953.4517652349926;957.6025949230991;998.6904059741504;5544.112941929353;5584.329880414376;5834.620749651259;5856.267966504187;5922.959686818194;907.9591418386188;920.1442658327819;924.7040946897063;934.490702567089;953.6471505542855;4128.855490057834;4136.255474014706;4137.379393091001;4159.480064991876;4267.893302667396;9835.655752048788;10592.947035264928;10648.574057037631;10663.573457061786;10680.198985076151;10277.537510811882;10430.478476076165;10584;10595.205359598061;10598.682039538826;7933.444658873939;8025.959870200729;8028.357731381592;8034.076081250614;8042.758717238492;5794.7102644866745;5800.651960882361;5833.795817146549;5855.9121613176685;5959.28488581373;9525.714228573153;9644.373115747454;9707.805843882941;9831.262655300738;9844.852327214954;9174.311926605666;9535.284853635867;9547.713568592953;9809.656662016796;9812.950935245564;7487.3261406473675;7602.353799927068;7604.46768726206;7625.466217364953;7636.656350464354;8117.594120294079;8124.431289809657;8128.390370722102;8225.753227403187;8227.670893164206;6591.6374599397495;7389.371903388273;7529.88705169412;7545.50954187976;7553.546787192786;7275.708971641075;7417.517861338995;7428.591427471541;7450.888236676563;7503.474756766974;6520.18497687789;6642.90035649456;6687.966560167168;6827.6244806536115;6861.735627242898;5067.695938243717;5180.197069454241;5210.505002024802;5228.843134705965;5272.156454967187;5029;5093.668911520739;5205.297284866646;5257.00116977773;5271.367435907716 05:30:22 INFO - PROCESS | 9388 | |4;prototype.html;331.23154282065605;336.4767786092625;338.1444944290944;343.4761987968348;345.478327725135;5153.072446959555;5212.4266330703595;5253.842384728459;5302.522772950434;5310.256564081032;5062.7596238921515;5228.424873263938;5232.744141406064;5244.501772331622;5250.317458730369;4131.297679394495;4144.606262405066;4165.479599946028;4166.749995000309;4172.852465571969;3890.708196885231;4084.14233011068;4153.813078411464;4158.251514727348;4198.622124008839;4050.3519436890106;4065.7560546367163;4066.837326506951;4087.305158123126;4103.097318589906;4048.696347773899;4053.5338436079787;4075.4294398784045;4077.143799802045;4087;3616.969163788308;3621.8732344367822;3654.433562797744;3700.296943580711;3724.7578907370935;5097.145598464835;5099.439061703247;5103.387593488768;5108.850508635564;5117.5650069744115;4730.385049943486;4730.455997560291;4748.19280722278;4755.5719985201495;4774.7108280764;5415.783368665248;5433.864153396157;5472.26124473195;5490.670559766427;5560.026995275851;3976.8608098716404;3992;3999.7400168989216;4000.299947509174;4003.4195041718785;5640.9846227679;5693.231413759131;5699.715014249313;5718.885622287531;5735.7094653703;4002.2195671844293;4144.689148313828;4155.981784462826;4175;4175.770332631673;4122.196171746481;4159.916801664011;4163.937540936889;4186.727862688916;4192.4907033467925;4683.461401938753;4687.226607609706;4695.201815691341;4714.811407543729;4724.834630787975;5324.420997941767;5455.34535855692;5492.286002819608;5516.889662206733;5525.668459892419;1332.3871019331023;1349.7447373942327;1361.4622224221378;1398.7551079539219;1399.3632897031825;963.691618682015;987.4026214140341;1002.754325190333;1011.3931641015479;1013.4324778124274;5070.504201260637;5088.872778180576;5108.386993560796;5126.846194614168;5146.948530514647;5380.408155103014;5386.253010964437;5414.296141501658;5435.864103397446;5466.535344495683;5058.418281897555;5143.3570803649545;5167.276581278624;5210.873475914421;5326;2856.714628297354;2880.7983441159336;2887.6101726267107;2888.465633857743;2901.5357542793054;5677.2619559457835;5708.286464191976;5731.684757338387;5734.856628584319;5740.167675687002;5439.513920015953;5500.532454741392;5515.227868098469;5520.046774975369;5539.612227144061;5613.803516876889;5629.605927585194;5649.7288110175705;5657.886842263214;5661.745221465044;5337.786488540415;5387.919181212206;5431.864203394946;5442.836714898559;5443.863903402446;5601.383847776823;5636.408177141341;5637.46444087811;5648.548116150616;5665.461781130786;5869.73586188614;5896.17453556511;5918.704064796657;5926.4666180044005;5935.762569497172;3771.283456143324;3931.5871833457077;3978.527944660494;4033.233685599727;4042.9797851010558;5328.973355133199;5506.926149400829;5591.189277554813;5593.300837395325;5598.636088654224;5355.491228333302;5375.6774593524515;5377.623566350318;5400.756965936621;5419.756110975094;5487.68295609043;5489.752961116679;5501.889962200814;5502.80740174092;5523.613347065828;5231.4768523148905;5412.807812835807;5449.782008719765;5451.972740136274;5459.2902922619805;5503.697296648563;5526.889462210814;5545.334559852843;5547.362053363753;5576.470235327637;5320.52115309624;5460.6177567569885;5463.7814487420055;5481.5340696041285;5518.42056584069 05:30:22 INFO - PROCESS | 9388 | |5;yui.html;719.658162372873;751.5040073551457;779.4660657449648;805.6374631415857;821.0270829067554;14132.858671413283;14842.628934276636;15220.771688424682;15438.768418473732;15448.845511544881;12739.808902866442;13823.308834558256;13986.720265594682;14017.36921838517;14030.368633411495;774.8450309938007;780.6760194519268;785.5326080981806;786.5634572812087;787.2875048081495;763.8243204063069;766.4902839611651;768.9346405555507;769.0809482668213;769.1193583347092;824.6165533027171;827.7971896885272;828.2876726015621;829.5520418973747;829.9585020748968;819.3690858039276;825.4551995682821;825.942184047114;828.0518805967164;828.6809578312364;598.6168851934765;599.4215581963383;599.5683108162116;601.4556826072411;602.7890238416563;12299.877001229963;12570.245785252822;12572.811407828889;12611.117221794479;13520;11977.341246231454;12376.319302438362;12705.17416367933;12713.872861271362;12907.741845163138;12203.20679155852;12352.135350525466;12443.191192572454;12658.746825063447;13289.534866279633;4261.680373971964;4300.204462174508;4314.331278651814;4369.717766234535;4397.582229688174;62196.0670589937;65632;66080.33919660789;66804;66822;10449.738756531147;10471.633492827867;10557.947210264054;10624.203184761174;10690.786184276427;18101.45695629133;18167.36414225522;18211.089445527672;18213.54466138357;18218.08909554517;7593.772186834404;7871.685132594632;8050.194980501903;8081.353491720648;8228.465149765247;4333.826646934151;4435.733855968652;4478.216312145361;4584.747838868894;4727.7163370197895;3454.913627159341;3576.3562558739677;3576.8569257229938;3578.0875876651808;3584.0860580551794;600.8377738010713;607.7781609712512;617.8455386153462;620.3393386043939;648.4002297874447;655.7409823119937;684.7021545627568;687.4878215729213;693.8230751158422;716.233630015878;8309.335253179732;8367.62345694433;9608.27937904646;9622.566984485715;9868.50657467138;573.3234782956151;645.2772894358349;725.0155183116077;727.7671145233475;733.66618188724;4222.387753775747;4270.167317373144;4521.186186486399;4523.705959112647;4679.321498382716;49581.50418495841;50911.490885091414;51048.234276485884;51185.48814511882;90216.54891725631;44984;50483;70433;71197.28802711907;71221.52174021756;58545.70727146422;63095.684521577095;64809.35190648127;65989.67005165039;66260.66869665621;9470;9943.801123977624;9972.30193886421;10010.749731256778;10097.596096156072;41663.58336416597;43046.13907721765;43619.345709813744;44429.33355999598;44492.77753611211;37107.814460927526;37306.440403393426;41472;57723.42276577181;59025;12086.818697719717;12240.75518489643;12389.690257743268;12513.747525445508;12858.42137103814;13498.52755153565;13817.240051796845;14046.78929816033;14391.28043597795;14807.777883331542;13061.542846000344;13132.73734525285;13417.798733019208;13815.930920345334;14042.368093435616;11608.767824643628;12341.259524428562;12473.313967731861;12660.11379203447;12795.552155674506;12608.810867836806;12712.3008234548;12771.36143192818;12880.420381082686;13310.733785324433;10382.603579211003;10701.555290036056;10705.250632455653;11086.279391839505;11360.54557817711;10597.15222782191;10700.464976750976;10728.39413688928;10742;11143.665690029313 05:30:22 INFO - PROCESS | 9388 | __end_tp_report 05:30:22 INFO - PROCESS | 9388 | __start_cc_report 05:30:22 INFO - PROCESS | 9388 | _x_x_mozilla_cycle_collect,1392 05:30:22 INFO - PROCESS | 9388 | __end_cc_report 05:30:22 INFO - PROCESS | 9388 | __startTimestamp1478611822868__endTimestamp 05:30:22 INFO - PROCESS | 9388 | 05:30:22 INFO - PROCESS | 9388 | ------- Summary: start ------- 05:30:22 INFO - PROCESS | 9388 | Number of tests: 6 05:30:22 INFO - PROCESS | 9388 | 05:30:22 INFO - PROCESS | 9388 | [#0] dojo.html Cycles:165 Average:5330.96 Median:5518.61 stddev:587.43 (10.6%) stddev-sans-first:562.52 05:30:22 INFO - PROCESS | 9388 | Values: 3098.5 3125.5 3130.7 3158.0 3178.0 5269.1 5310.9 5345.5 5373.4 5390.2 5326.2 5339.5 5403.7 5421.7 5442.9 4845.5 4870.0 4924.4 4925.4 4938.8 4860.1 4925.0 4926.0 5016.7 5018.5 4943.1 4996.7 5005.3 5008.9 5064.4 4810.3 4842.4 4846.8 4875.2 4961.1 4842.0 4847.8 4853.7 4854.5 4857.1 5238.4 5308.7 5309.2 5312.4 5332.3 5670.5 5675.0 5683.6 5684.5 5689.6 5691.5 5700.1 5710.0 5712.9 5726.9 5330.4 5355.3 5372.7 5374.9 5379.7 5814.1 5831.1 5832.1 5833.3 5841.7 5640.5 5641.2 5642.9 5646.1 5651.1 5558.4 5629.9 5690.5 5713.9 5718.1 5653.2 5662.4 5717.4 5734.6 5769.9 5740.5 5743.8 5744.2 5748.8 5791.9 4351.2 4450.3 4451.9 4465.0 4498.9 3911.7 3925.5 3931.9 3939.9 3952.4 5469.1 5469.4 5474.9 5484.4 5518.6 5772.0 5780.3 5781.9 5787.2 5795.0 5327.4 5379.2 5435.3 5458.9 5499.9 5014.3 5016.5 5057.1 5058.3 5059.2 5994.1 6022.2 6040.5 6040.9 6041.6 5629.9 5690.2 5773.8 5811.5 5815.2 5904.8 5932.7 5943.8 5955.9 5991.9 5602.7 5604.5 5612.0 5613.0 5613.2 5570.1 5715.2 5723.2 5723.4 5724.8 5413.4 5506.9 5533.3 5550.9 5599.9 5503.8 5547.3 5559.1 5562.2 5568.0 5498.8 5504.2 5510.8 5514.7 5548.4 5511.9 5561.1 5588.5 5613.9 5626.7 5522.8 5534.3 5537.3 5570.5 5587.1 05:30:22 INFO - PROCESS | 9388 | 05:30:22 INFO - PROCESS | 9388 | [#1] ext.html Cycles:180 Average:58843.43 Median:38969.11 stddev:115581.47 (296.6%) stddev-sans-first:115822.82 05:30:22 INFO - PROCESS | 9388 | Values: 544.2 587.5 595.8 607.4 619.6 30756.0 33664.8 33712.3 33736.2 40021.4 40112.8 43177.6 43219.6 43237.4 43281.8 8479.6 8547.6 8549.4 8550.0 8625.5 7961.6 8166.7 8497.3 8652.7 8678.2 9994.9 10247.9 10248.5 10410.6 10452.9 10335.2 10398.6 10404.1 10413.3 10416.6 10217.8 10266.1 10277.2 10324.2 10341.1 40062.8 40509.2 40517.2 40543.6 40572.0 3397.8 3427.7 3457.3 3563.1 3633.6 29258.6 30834.4 31180.4 32449.4 32548.5 3943.8 3964.2 4108.1 4178.2 4207.7 320907.0 322772.0 325095.4 325269.0 328973.0 59497.0 59840.1 59871.7 59881.8 59904.7 36554.6 37430.6 37433.8 61534.0 61576.7 16291.3 16515.1 16520.6 16522.6 16525.3 11628.9 11804.2 11805.2 11813.2 11820.3 17134.3 17569.6 18608.3 18901.4 19120.5 6838.3 6906.0 6938.2 7006.9 7141.0 956.5 1023.2 1055.5 1096.8 1102.8 30725.5 31666.0 31668.2 31990.5 32455.2 1038.1 1051.2 1092.3 1106.4 1137.9 17061.2 17608.6 18032.5 18125.9 18344.5 504549.0 506230.0 507409.0 508859.0 509072.0 50246.0 51543.5 55148.4 56045.4 56158.6 1286.7 1311.9 1315.5 1325.0 1340.6 30323.8 32153.4 33116.2 33210.5 33475.2 48900.5 52986.0 58727.4 58892.7 59598.7 453301.0 456476.0 456631.0 456856.0 459041.0 38869.4 39405.8 39460.8 39835.4 40364.6 47012.3 47185.5 47235.5 47739.5 48338.0 39092.4 39284.6 40546.7 40881.0 41228.0 39245.6 39538.8 40137.8 40684.2 41676.6 39068.8 40154.8 40392.4 40398.8 40730.2 32748.0 34506.5 35235.5 35739.8 35934.5 26469.3 27710.6 27796.2 27820.0 27838.3 05:30:22 INFO - PROCESS | 9388 | 05:30:22 INFO - PROCESS | 9388 | [#2] jquery.html Cycles:180 Average:27988.92 Median:15227.37 stddev:76920.73 (505.1%) stddev-sans-first:77108.56 05:30:22 INFO - PROCESS | 9388 | Values: 371.9 394.4 404.4 407.3 412.2 13184.7 15127.2 16219.0 18502.9 18926.9 18519.5 18599.8 18602.3 18728.5 18956.7 5398.1 5598.8 5643.2 5643.9 5645.4 4599.4 5513.1 5537.1 5543.8 5545.3 5510.5 5511.1 5514.7 5516.0 5518.9 5339.1 5533.4 5534.3 5541.9 5544.4 4790.1 4988.1 4989.0 4995.9 4998.5 19757.8 20502.8 22108.0 22444.0 22520.1 2310.5 2420.5 2678.0 2855.3 2856.9 9845.8 9854.3 10115.0 10157.0 10178.7 1801.2 1862.9 1866.7 1906.4 1925.2 81523.2 83124.2 84932.6 85730.0 85791.6 10922.5 10950.6 11083.4 11102.8 11209.0 15741.3 15772.8 15784.6 15786.2 15789.9 7450.3 7597.1 7700.7 7838.0 7903.1 7069.3 7125.8 7213.3 7341.7 7342.6 4476.8 4584.7 4695.7 4772.7 4801.4 1941.8 1967.5 2000.3 2018.9 2044.9 842.0 853.5 931.7 940.7 965.2 18036.0 19187.0 19510.1 19582.5 19770.2 961.5 966.3 1016.8 1026.9 1035.6 10216.8 10747.5 10856.2 10888.9 10899.5 455931.0 460852.0 461202.0 472642.0 474458.0 89829.6 91093.5 91436.5 91478.0 92538.5 1000.3 1055.6 1082.8 1084.4 1085.8 16283.3 16763.0 17054.7 17093.2 17294.4 30082.8 40490.4 41677.4 42201.4 42452.0 53845.7 57557.4 57887.0 59114.0 59368.1 7816.3 8091.8 8425.9 8454.0 8564.4 11881.8 12715.4 12852.7 12968.3 13459.4 10397.3 10775.5 10880.3 11192.9 11491.1 10710.1 10880.2 10981.2 11076.4 11354.5 10706.1 11187.0 11288.2 11375.8 11470.4 8267.3 8281.0 8474.1 8509.7 8598.7 9026.7 11081.4 11375.4 11454.0 11820.0 05:30:22 INFO - PROCESS | 9388 | 05:30:22 INFO - PROCESS | 9388 | [#3] mootools.html Cycles:180 Average:5580.73 Median:5219.67 stddev:3104.96 (59.5%) stddev-sans-first:3098.06 05:30:22 INFO - PROCESS | 9388 | Values: 1437.6 1443.9 1573.8 1671.3 1761.0 7509.1 7741.6 8004.4 8537.1 8546.7 8041.9 8276.4 8290.1 8465.4 8481.4 2267.4 2304.3 2311.6 2314.0 2319.3 2066.5 2123.5 2266.4 2307.0 2309.9 2215.0 2277.4 2278.6 2291.6 2294.3 2273.8 2278.8 2288.3 2310.5 2314.1 2248.9 2277.7 2295.7 2296.4 2323.6 8316.9 8517.1 8517.3 8525.6 8530.5 5135.8 5232.1 5258.5 5280.3 5287.4 3223.7 3321.3 3357.4 3419.7 3428.9 1108.9 1119.9 1130.5 1142.4 1160.4 11586.3 11591.2 11642.8 11656.5 11667.8 4212.1 4400.5 4466.9 4483.8 4490.4 9195.4 9196.0 9196.3 9196.4 9203.4 5168.0 5168.7 5173.6 5178.1 5179.9 4728.6 4749.1 4764.0 4789.8 4860.6 3491.6 3594.7 3598.7 3604.1 3670.0 1048.8 1086.4 1113.6 1115.6 1125.8 939.1 950.7 953.5 957.6 998.7 5544.1 5584.3 5834.6 5856.3 5923.0 908.0 920.1 924.7 934.5 953.6 4128.9 4136.3 4137.4 4159.5 4267.9 9835.7 10592.9 10648.6 10663.6 10680.2 10277.5 10430.5 10584.0 10595.2 10598.7 7933.4 8026.0 8028.4 8034.1 8042.8 5794.7 5800.7 5833.8 5855.9 5959.3 9525.7 9644.4 9707.8 9831.3 9844.9 9174.3 9535.3 9547.7 9809.7 9813.0 7487.3 7602.4 7604.5 7625.5 7636.7 8117.6 8124.4 8128.4 8225.8 8227.7 6591.6 7389.4 7529.9 7545.5 7553.5 7275.7 7417.5 7428.6 7450.9 7503.5 6520.2 6642.9 6688.0 6827.6 6861.7 5067.7 5180.2 5210.5 5228.8 5272.2 5029.0 5093.7 5205.3 5257.0 5271.4 05:30:22 INFO - PROCESS | 9388 | 05:30:22 INFO - PROCESS | 9388 | [#4] prototype.html Cycles:180 Average:4607.07 Median:5229.95 stddev:1335.81 (25.5%) stddev-sans-first:1300.43 05:30:22 INFO - PROCESS | 9388 | Values: 331.2 336.5 338.1 343.5 345.5 5153.1 5212.4 5253.8 5302.5 5310.3 5062.8 5228.4 5232.7 5244.5 5250.3 4131.3 4144.6 4165.5 4166.7 4172.9 3890.7 4084.1 4153.8 4158.3 4198.6 4050.4 4065.8 4066.8 4087.3 4103.1 4048.7 4053.5 4075.4 4077.1 4087.0 3617.0 3621.9 3654.4 3700.3 3724.8 5097.1 5099.4 5103.4 5108.9 5117.6 4730.4 4730.5 4748.2 4755.6 4774.7 5415.8 5433.9 5472.3 5490.7 5560.0 3976.9 3992.0 3999.7 4000.3 4003.4 5641.0 5693.2 5699.7 5718.9 5735.7 4002.2 4144.7 4156.0 4175.0 4175.8 4122.2 4159.9 4163.9 4186.7 4192.5 4683.5 4687.2 4695.2 4714.8 4724.8 5324.4 5455.3 5492.3 5516.9 5525.7 1332.4 1349.7 1361.5 1398.8 1399.4 963.7 987.4 1002.8 1011.4 1013.4 5070.5 5088.9 5108.4 5126.8 5146.9 5380.4 5386.3 5414.3 5435.9 5466.5 5058.4 5143.4 5167.3 5210.9 5326.0 2856.7 2880.8 2887.6 2888.5 2901.5 5677.3 5708.3 5731.7 5734.9 5740.2 5439.5 5500.5 5515.2 5520.0 5539.6 5613.8 5629.6 5649.7 5657.9 5661.7 5337.8 5387.9 5431.9 5442.8 5443.9 5601.4 5636.4 5637.5 5648.5 5665.5 5869.7 5896.2 5918.7 5926.5 5935.8 3771.3 3931.6 3978.5 4033.2 4043.0 5329.0 5506.9 5591.2 5593.3 5598.6 5355.5 5375.7 5377.6 5400.8 5419.8 5487.7 5489.8 5501.9 5502.8 5523.6 5231.5 5412.8 5449.8 5452.0 5459.3 5503.7 5526.9 5545.3 5547.4 5576.5 5320.5 5460.6 5463.8 5481.5 5518.4 05:30:22 INFO - PROCESS | 9388 | 05:30:22 INFO - PROCESS | 9388 | [#5] yui.html Cycles:180 Average:15891.83 Median:4416.66 stddev:19623.43 (444.3%) stddev-sans-first:19645.40 05:30:22 INFO - PROCESS | 9388 | Values: 719.7 751.5 779.5 805.6 821.0 14132.9 14842.6 15220.8 15438.8 15448.8 12739.8 13823.3 13986.7 14017.4 14030.4 774.8 780.7 785.5 786.6 787.3 763.8 766.5 768.9 769.1 769.1 824.6 827.8 828.3 829.6 830.0 819.4 825.5 825.9 828.1 828.7 598.6 599.4 599.6 601.5 602.8 12299.9 12570.2 12572.8 12611.1 13520.0 11977.3 12376.3 12705.2 12713.9 12907.7 12203.2 12352.1 12443.2 12658.7 13289.5 4261.7 4300.2 4314.3 4369.7 4397.6 62196.1 65632.0 66080.3 66804.0 66822.0 10449.7 10471.6 10557.9 10624.2 10690.8 18101.5 18167.4 18211.1 18213.5 18218.1 7593.8 7871.7 8050.2 8081.4 8228.5 4333.8 4435.7 4478.2 4584.7 4727.7 3454.9 3576.4 3576.9 3578.1 3584.1 600.8 607.8 617.8 620.3 648.4 655.7 684.7 687.5 693.8 716.2 8309.3 8367.6 9608.3 9622.6 9868.5 573.3 645.3 725.0 727.8 733.7 4222.4 4270.2 4521.2 4523.7 4679.3 49581.5 50911.5 51048.2 51185.5 90216.5 44984.0 50483.0 70433.0 71197.3 71221.5 58545.7 63095.7 64809.4 65989.7 66260.7 9470.0 9943.8 9972.3 10010.7 10097.6 41663.6 43046.1 43619.3 44429.3 44492.8 37107.8 37306.4 41472.0 57723.4 59025.0 12086.8 12240.8 12389.7 12513.7 12858.4 13498.5 13817.2 14046.8 14391.3 14807.8 13061.5 13132.7 13417.8 13815.9 14042.4 11608.8 12341.3 12473.3 12660.1 12795.6 12608.8 12712.3 12771.4 12880.4 13310.7 10382.6 10701.6 10705.3 11086.3 11360.5 10597.2 10700.5 10728.4 10742.0 11143.7 05:30:22 INFO - PROCESS | 9388 | -------- Summary: end -------- 05:30:22 INFO - PROCESS | 9388 | 05:30:23 INFO - TEST-INFO | 9388: exit 0 05:30:23 INFO - TEST-OK | dromaeo_css | took 1118153ms 05:30:23 INFO - TEST-START | kraken 05:30:23 INFO - operating with platform_type : linux_ 05:30:23 INFO - Initialising browser for kraken test... 05:30:23 INFO - TEST-INFO | started process 9694 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpztwDV5/profile http://localhost:41606/getInfo.html) 05:30:27 INFO - PROCESS | 9694 | __metrics Screen width/height:1600/1200 05:30:27 INFO - PROCESS | 9694 | colorDepth:24 05:30:27 INFO - PROCESS | 9694 | Browser inner width/height: 1024/697 05:30:27 INFO - PROCESS | 9694 | __metrics 05:30:28 INFO - PROCESS | 9694 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:30:28 INFO - PROCESS | 9694 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:30:28 INFO - PROCESS | 9694 | console.error: PushService: 05:30:28 INFO - PROCESS | 9694 | stateChangeProcessEnqueue: Error transitioning state 05:30:28 INFO - PROCESS | 9694 | UnknownError 05:30:29 INFO - TEST-INFO | 9694: exit 0 05:30:29 INFO - Browser initialized. 05:30:29 INFO - Running cycle 1/1 for kraken test... 05:30:29 INFO - TEST-INFO | started process 9782 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpztwDV5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:30:41 INFO - PROCESS | 9782 | RSS: Main: 173395968 05:30:41 INFO - PROCESS | 9782 | 05:30:44 INFO - PROCESS | 9782 | Cycle 1(1): loaded http://localhost:41606/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41606/tests/kraken/driver.html?testName=audio-beat-detection) 05:30:45 INFO - PROCESS | 9782 | RSS: Main: 230158336 05:30:45 INFO - PROCESS | 9782 | 05:30:47 INFO - PROCESS | 9782 | Cycle 1(1): loaded http://localhost:41606/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41606/tests/kraken/driver.html?testName=audio-dft) 05:30:48 INFO - PROCESS | 9782 | RSS: Main: 217186304 05:30:48 INFO - PROCESS | 9782 | 05:30:51 INFO - PROCESS | 9782 | Cycle 1(1): loaded http://localhost:41606/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41606/tests/kraken/driver.html?testName=audio-fft) 05:30:52 INFO - PROCESS | 9782 | RSS: Main: 297668608 05:30:52 INFO - PROCESS | 9782 | 05:30:54 INFO - PROCESS | 9782 | Cycle 1(1): loaded http://localhost:41606/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41606/tests/kraken/driver.html?testName=audio-oscillator) 05:30:54 INFO - PROCESS | 9782 | RSS: Main: 209842176 05:30:54 INFO - PROCESS | 9782 | 05:30:56 INFO - PROCESS | 9782 | Cycle 1(1): loaded http://localhost:41606/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41606/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:30:57 INFO - PROCESS | 9782 | RSS: Main: 212881408 05:30:57 INFO - PROCESS | 9782 | 05:31:00 INFO - PROCESS | 9782 | Cycle 1(1): loaded http://localhost:41606/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41606/tests/kraken/driver.html?testName=imaging-darkroom) 05:31:01 INFO - PROCESS | 9782 | RSS: Main: 248786944 05:31:01 INFO - PROCESS | 9782 | 05:31:04 INFO - PROCESS | 9782 | Cycle 1(1): loaded http://localhost:41606/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41606/tests/kraken/driver.html?testName=imaging-desaturate) 05:31:04 INFO - PROCESS | 9782 | RSS: Main: 247345152 05:31:04 INFO - PROCESS | 9782 | 05:31:07 INFO - PROCESS | 9782 | Cycle 1(1): loaded http://localhost:41606/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41606/tests/kraken/driver.html?testName=json-parse-financial) 05:31:08 INFO - PROCESS | 9782 | RSS: Main: 247246848 05:31:08 INFO - PROCESS | 9782 | 05:31:09 INFO - PROCESS | 9782 | Cycle 1(1): loaded http://localhost:41606/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41606/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:31:10 INFO - PROCESS | 9782 | RSS: Main: 209547264 05:31:10 INFO - PROCESS | 9782 | 05:31:12 INFO - PROCESS | 9782 | Cycle 1(1): loaded http://localhost:41606/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41606/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:31:12 INFO - PROCESS | 9782 | RSS: Main: 217067520 05:31:12 INFO - PROCESS | 9782 | 05:31:14 INFO - PROCESS | 9782 | Cycle 1(1): loaded http://localhost:41606/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41606/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:31:15 INFO - PROCESS | 9782 | RSS: Main: 225910784 05:31:15 INFO - PROCESS | 9782 | 05:31:18 INFO - PROCESS | 9782 | Cycle 1(1): loaded http://localhost:41606/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41606/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:31:18 INFO - PROCESS | 9782 | RSS: Main: 234217472 05:31:18 INFO - PROCESS | 9782 | 05:31:21 INFO - PROCESS | 9782 | Cycle 1(1): loaded http://localhost:41606/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41606/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:31:22 INFO - PROCESS | 9782 | RSS: Main: 231247872 05:31:22 INFO - PROCESS | 9782 | 05:31:23 INFO - PROCESS | 9782 | Cycle 1(1): loaded http://localhost:41606/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41606/tests/kraken/driver.html?testName=ai-astar) 05:31:24 INFO - PROCESS | 9782 | RSS: Main: 282382336 05:31:24 INFO - PROCESS | 9782 | 05:31:24 INFO - PROCESS | 9782 | __start_tp_report 05:31:24 INFO - PROCESS | 9782 | _x_x_mozilla_page_load 05:31:24 INFO - PROCESS | 9782 | _x_x_mozilla_page_load_details 05:31:24 INFO - PROCESS | 9782 | |i|pagename|runs| 05:31:24 INFO - PROCESS | 9782 | |0;ai-astar;103;111;111;110;112;113;112;113;111;110 05:31:24 INFO - PROCESS | 9782 | |1;audio-beat-detection;148;122;126;160;124;124;129;122;161;128 05:31:24 INFO - PROCESS | 9782 | |2;audio-dft;160;161;161;162;162;162;161;161;161;163 05:31:24 INFO - PROCESS | 9782 | |3;audio-fft;74;75;75;110;76;76;75;76;104;76 05:31:24 INFO - PROCESS | 9782 | |4;audio-oscillator;84;82;122;82;83;82;103;82;82;113 05:31:24 INFO - PROCESS | 9782 | |5;imaging-gaussian-blur;118;117;117;117;117;117;117;117;117;116 05:31:24 INFO - PROCESS | 9782 | |6;imaging-darkroom;149;146;145;145;145;145;146;146;146;146 05:31:24 INFO - PROCESS | 9782 | |7;imaging-desaturate;84;84;85;85;85;84;85;85;84;85 05:31:24 INFO - PROCESS | 9782 | |8;json-parse-financial;51;51;49;50;51;54;51;53;50;52 05:31:24 INFO - PROCESS | 9782 | |9;json-stringify-tinderbox;63;64;62;62;63;65;65;63;62;63 05:31:24 INFO - PROCESS | 9782 | |10;stanford-crypto-aes;80;80;78;79;80;86;88;83;80;79 05:31:24 INFO - PROCESS | 9782 | |11;stanford-crypto-ccm;145;133;152;131;134;132;138;134;182;134 05:31:24 INFO - PROCESS | 9782 | |12;stanford-crypto-pbkdf2;166;165;167;167;165;164;169;168;172;169 05:31:24 INFO - PROCESS | 9782 | |13;stanford-crypto-sha256-iterative;68;66;65;64;65;68;65;65;64;63 05:31:24 INFO - PROCESS | 9782 | __end_tp_report 05:31:24 INFO - PROCESS | 9782 | __start_cc_report 05:31:24 INFO - PROCESS | 9782 | _x_x_mozilla_cycle_collect,1630 05:31:24 INFO - PROCESS | 9782 | __end_cc_report 05:31:24 INFO - PROCESS | 9782 | __startTimestamp1478611884039__endTimestamp 05:31:24 INFO - PROCESS | 9782 | 05:31:24 INFO - PROCESS | 9782 | ------- Summary: start ------- 05:31:24 INFO - PROCESS | 9782 | Number of tests: 14 05:31:24 INFO - PROCESS | 9782 | 05:31:24 INFO - PROCESS | 9782 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.50 stddev:2.88 (2.6%) stddev-sans-first:1.13 05:31:24 INFO - PROCESS | 9782 | Values: 103.0 111.0 111.0 110.0 112.0 113.0 112.0 113.0 111.0 110.0 05:31:24 INFO - PROCESS | 9782 | 05:31:24 INFO - PROCESS | 9782 | [#1] audio-beat-detection Cycles:10 Average:134.40 Median:128.50 stddev:15.68 (12.2%) stddev-sans-first:15.84 05:31:24 INFO - PROCESS | 9782 | Values: 148.0 122.0 126.0 160.0 124.0 124.0 129.0 122.0 161.0 128.0 05:31:24 INFO - PROCESS | 9782 | 05:31:24 INFO - PROCESS | 9782 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:0.84 (0.5%) stddev-sans-first:0.73 05:31:24 INFO - PROCESS | 9782 | Values: 160.0 161.0 161.0 162.0 162.0 162.0 161.0 161.0 161.0 163.0 05:31:24 INFO - PROCESS | 9782 | 05:31:24 INFO - PROCESS | 9782 | [#3] audio-fft Cycles:10 Average:81.70 Median:75.50 stddev:13.43 (17.8%) stddev-sans-first:13.95 05:31:24 INFO - PROCESS | 9782 | Values: 74.0 75.0 75.0 110.0 76.0 76.0 75.0 76.0 104.0 76.0 05:31:24 INFO - PROCESS | 9782 | 05:31:24 INFO - PROCESS | 9782 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:82.00 stddev:15.29 (18.6%) stddev-sans-first:15.98 05:31:24 INFO - PROCESS | 9782 | Values: 84.0 82.0 122.0 82.0 83.0 82.0 103.0 82.0 82.0 113.0 05:31:24 INFO - PROCESS | 9782 | 05:31:24 INFO - PROCESS | 9782 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 05:31:24 INFO - PROCESS | 9782 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 05:31:24 INFO - PROCESS | 9782 | 05:31:24 INFO - PROCESS | 9782 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:1.20 (0.8%) stddev-sans-first:0.53 05:31:24 INFO - PROCESS | 9782 | Values: 149.0 146.0 145.0 145.0 145.0 145.0 146.0 146.0 146.0 146.0 05:31:24 INFO - PROCESS | 9782 | 05:31:24 INFO - PROCESS | 9782 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:0.52 (0.6%) stddev-sans-first:0.50 05:31:24 INFO - PROCESS | 9782 | Values: 84.0 84.0 85.0 85.0 85.0 84.0 85.0 85.0 84.0 85.0 05:31:24 INFO - PROCESS | 9782 | 05:31:24 INFO - PROCESS | 9782 | [#8] json-parse-financial Cycles:10 Average:51.20 Median:51.00 stddev:1.48 (2.9%) stddev-sans-first:1.56 05:31:24 INFO - PROCESS | 9782 | Values: 51.0 51.0 49.0 50.0 51.0 54.0 51.0 53.0 50.0 52.0 05:31:24 INFO - PROCESS | 9782 | 05:31:24 INFO - PROCESS | 9782 | [#9] json-stringify-tinderbox Cycles:10 Average:63.20 Median:63.00 stddev:1.14 (1.8%) stddev-sans-first:1.20 05:31:24 INFO - PROCESS | 9782 | Values: 63.0 64.0 62.0 62.0 63.0 65.0 65.0 63.0 62.0 63.0 05:31:24 INFO - PROCESS | 9782 | 05:31:24 INFO - PROCESS | 9782 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:80.00 stddev:3.30 (4.1%) stddev-sans-first:3.47 05:31:24 INFO - PROCESS | 9782 | Values: 80.0 80.0 78.0 79.0 80.0 86.0 88.0 83.0 80.0 79.0 05:31:24 INFO - PROCESS | 9782 | 05:31:24 INFO - PROCESS | 9782 | [#11] stanford-crypto-ccm Cycles:10 Average:141.50 Median:136.00 stddev:15.69 (11.5%) stddev-sans-first:16.59 05:31:24 INFO - PROCESS | 9782 | Values: 145.0 133.0 152.0 131.0 134.0 132.0 138.0 134.0 182.0 134.0 05:31:24 INFO - PROCESS | 9782 | 05:31:24 INFO - PROCESS | 9782 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.20 Median:167.50 stddev:2.39 (1.4%) stddev-sans-first:2.50 05:31:24 INFO - PROCESS | 9782 | Values: 166.0 165.0 167.0 167.0 165.0 164.0 169.0 168.0 172.0 169.0 05:31:24 INFO - PROCESS | 9782 | 05:31:24 INFO - PROCESS | 9782 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.00 stddev:1.64 (2.5%) stddev-sans-first:1.41 05:31:24 INFO - PROCESS | 9782 | Values: 68.0 66.0 65.0 64.0 65.0 68.0 65.0 65.0 64.0 63.0 05:31:24 INFO - PROCESS | 9782 | -------- Summary: end -------- 05:31:24 INFO - PROCESS | 9782 | 05:31:25 INFO - TEST-INFO | 9782: exit 0 05:31:25 INFO - TEST-OK | kraken | took 61303ms 05:31:25 INFO - SUITE-END | took 1179s 05:31:25 INFO - Completed test suite (00:19:39) 05:31:25 INFO - javascript benchmark 05:31:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3098.473259545877, 3125.4999200127986, 3130.6556278809326, 3158.0367987763725, 3177.95233071504, 5269.077911365505, 5310.89378212436, 5345.49217824307, 5373.355197376315, 5390.1914712793105, 5326.201069839526, 5339.466053394668, 5403.729813509329, 5421.728913554316, 5442.91835622465, 4845.515448455161, 4869.975650121744, 4924.359833221676, 4925.408950925894, 4938.777755001033, 4860.149473842063, 4925.039617274633, 4926.0394223126505, 5016.749162541876, 5018.548330650241, 4943.060818444484, 4996.675216110959, 5005.299258103868, 5008.924866127011, 5064.3922729272535, 4810.326554282403, 4842.370491836074, 4846.830360937351, 4875.171220892456, 4961.107000739866, 4842.0, 4847.83032593861, 4853.660243782937, 4854.49027852074, 4857.14999875024, 5238.449962753894, 5308.734563271821, 5309.230161626542, 5312.415634280226, 5332.280142180794, 5670.518005969498, 5675.0, 5683.5737319700775, 5684.54523638108, 5689.630174038674, 5691.51622112121, 5700.116481945263, 5709.9714501427225, 5712.8857422851725, 5726.914096288559, 5330.360356757214, 5355.250264962909, 5372.704501252469, 5374.946250537484, 5379.67721936685, 5814.127880817827, 5831.067029275296, 5832.066869300891, 5833.300003999547, 5841.707914604252, 5640.5487560995025, 5641.182028605829, 5642.858928526737, 5646.096624540054, 5651.0675738503505, 5558.416366281563, 5629.915551266734, 5690.516306113944, 5713.914291285634, 5718.1136923776885, 5653.208550802891, 5662.405447428043, 5717.371089180187, 5734.598578099493, 5769.94230057694, 5740.512056475246, 5743.770249190069, 5744.195812586241, 5748.827535173951, 5791.913121303184, 4351.151525452569, 4450.265706158512, 4451.888702782457, 4465.017696106851, 4498.910021799546, 3911.726179167431, 3925.528936527635, 3931.8623848165175, 3939.9015024624614, 3952.3676211805973, 5469.124940009579, 5469.398366179717, 5474.890502189934, 5484.424135465799, 5518.613697041249, 5771.971140144273, 5780.335261444988, 5781.88436231273, 5787.189793428924, 5795.043817770105, 5327.387350454747, 5379.1662292344745, 5435.320584926884, 5458.8908221835345, 5499.862503437446, 5014.323066385991, 5016.523430274118, 5057.089723849743, 5058.342415486037, 5059.19052951526, 5994.130851026577, 6022.18700475439, 6040.486558642477, 6040.909386359121, 6041.577089603774, 5629.943700562942, 5690.231818704588, 5773.826785196451, 5811.53507719373, 5815.185873977731, 5904.793332233351, 5932.733027013881, 5943.791967281124, 5955.940440595538, 5991.940080599313, 5602.691851948182, 5604.4675755804765, 5612.0, 5612.971935140298, 5613.186088017296, 5570.080936645408, 5715.199872018004, 5723.198752174782, 5723.399043100581, 5724.8282551523525, 5413.431589683027, 5506.91739623898, 5533.280673512579, 5550.888982220414, 5599.8880022400135, 5503.807366742145, 5547.33431988164, 5559.054960656617, 5562.16567514876, 5568.025595520687, 5498.752556134904, 5504.22940788298, 5510.8071217507195, 5514.6691198528215, 5548.361938377138, 5511.889762204813, 5561.138023606348, 5588.469095436089, 5613.88772224545, 5626.718664066699, 5522.779088836402, 5534.280543529316, 5537.335519737658, 5570.526505246938, 5587.1339942309005], "value": 5292.353690644646, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.1503833786792, 587.4947545111204, 595.7616953218712, 607.3653032580952, 619.5508256514025, 30756.0, 33664.78195879637, 33712.32575348495, 33736.15659608508, 40021.39967900484, 40112.79943600285, 43177.56822431775, 43219.567804321945, 43237.35143972835, 43281.783591082, 8479.618417171227, 8547.615357308905, 8549.40154189207, 8549.95725021374, 8625.525596092213, 7961.601919903982, 8166.714165004226, 8497.320214382866, 8652.653893844239, 8678.218960293572, 9994.850077248848, 10247.897521024806, 10248.538815753309, 10410.583576656925, 10452.947735261314, 10335.224858135633, 10398.584056637725, 10404.115650169744, 10413.323133996304, 10416.635417760417, 10217.846732299022, 10266.12737917278, 10277.177825773995, 10324.174066074771, 10341.121004714609, 40062.79968600138, 40509.189816203514, 40517.189656207, 40543.59456405428, 40572.0, 3397.813120278384, 3427.674370934757, 3457.3085382923264, 3563.1448452371505, 3633.5821380541047, 29258.561121583192, 30834.383312333626, 31180.376392472022, 32449.35101297961, 32548.511772323433, 3943.802809859524, 3964.226975739732, 4108.137291168829, 4178.247915375231, 4207.747535147871, 320907.0, 322772.0, 325095.3745231282, 325269.0, 328973.0, 59497.0, 59840.102398464056, 59871.700641496514, 59881.802363952476, 59904.70047649821, 36554.63445365566, 37430.62569374272, 37433.81283093567, 61534.0, 61576.69211654003, 16291.348346066261, 16515.091669958027, 16520.586985325222, 16522.58693532647, 16525.25636346343, 11628.88371116295, 11804.17370784037, 11805.23265987708, 11813.23213991105, 11820.349880756468, 17134.314627414762, 17569.648607028044, 18608.255669773327, 18901.43295701131, 19120.521986950436, 6838.281980391987, 6905.962740991419, 6938.236793952661, 7006.894896576556, 7140.964295178491, 956.4500412262977, 1023.2070145637191, 1055.5039131608285, 1096.7587130831205, 1102.823548232295, 30725.539116912816, 31666.0, 31668.208294792814, 31990.520142197885, 32455.18862028421, 1038.1020417338948, 1051.222095649214, 1092.3445932440632, 1106.391484683437, 1137.9203455758184, 17061.232244549024, 17608.55978600545, 18032.549186270448, 18125.909370453326, 18344.54138646518, 504549.0, 506230.0, 507409.0, 508859.0, 509072.0, 50246.0, 51543.48456515387, 55148.448515514334, 56045.43954560402, 56158.59603509945, 1286.7233544787728, 1311.8622544632676, 1315.5329857900308, 1325.0459669038278, 1340.6313263852323, 30323.848380757954, 32153.356932860745, 33116.172095696835, 33210.50552725085, 33475.163120922174, 48900.51099489102, 52986.0, 58727.41272587219, 58892.69965703107, 59598.70200648969, 453301.0, 456476.0, 456631.0, 456856.0, 459041.0, 38869.41695874621, 39405.802970984965, 39460.802695986335, 39835.402468962406, 40364.56901163434, 47012.294815578476, 47185.52814471811, 47235.527644723115, 47739.522604774895, 48338.0, 39092.41361379639, 39284.60715392924, 40546.69477861838, 40881.0, 41228.0, 39245.6075439242, 39538.80230598828, 40137.799311003255, 40684.18631627291, 41676.58323416727, 39068.804655976535, 40154.799226003684, 40392.39411408772, 40398.79800600978, 40730.185396291316, 32748.0, 34506.482402763475, 35235.47146792749, 35739.82130089333, 35934.460983085795, 26469.33826654349, 27710.584341235302, 27796.166115016582, 27820.0, 27838.3040423991], "value": 19943.428147355775, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.89215127612994, 394.3611349613626, 404.3954288338934, 407.3096102106929, 412.16742180794796, 13184.7363052739, 15127.168005759693, 16219.0, 18502.907485462587, 18926.905365473187, 18519.537011574717, 18599.814001859977, 18602.255909763626, 18728.531786705338, 18956.715649265272, 5398.109311963531, 5598.804041858536, 5643.181738647893, 5643.943560564383, 5645.435456454363, 4599.425071866017, 5513.062779327524, 5537.058700020986, 5543.805966791163, 5545.251391062216, 5510.504054635082, 5511.118221084627, 5514.696691681956, 5516.0, 5518.889622207574, 5339.092354299759, 5533.446655334455, 5534.308211473566, 5541.861453463655, 5544.362398324184, 4790.113828941622, 4988.127077761414, 4988.950110498921, 4995.850124496271, 4998.525140111684, 19757.80242197574, 20502.794972050237, 22108.0, 22444.0, 22520.09919603214, 2310.549442858643, 2420.479596886678, 2677.9957515931524, 2855.271905664063, 2856.902365237888, 9845.753856153653, 9854.260930430175, 10115.0, 10157.0, 10178.694639160836, 1801.1714611278828, 1862.8602854785945, 1866.7386565880788, 1906.4185423445842, 1925.1914196037699, 81523.18476815215, 83124.16875831225, 84932.57533712292, 85730.0, 85791.57104214502, 10922.453877306103, 10950.616728414467, 11083.390413527171, 11102.777944441066, 11209.0, 15741.291641876143, 15772.76340854888, 15784.60538486547, 15786.21068946548, 15789.921050394903, 7450.329470347695, 7597.088349398107, 7700.653470593837, 7837.960810195913, 7903.051633803981, 7069.328413800681, 7125.82185445368, 7213.314735100157, 7341.74303899361, 7342.559446433231, 4476.798544065525, 4584.724916505021, 4695.671303008757, 4772.737499437564, 4801.423829140525, 1941.825235728791, 1967.478618166187, 2000.2599038355902, 2018.8889611071238, 2044.9182032718525, 841.9621117049625, 853.5433543054436, 931.6832077803043, 940.7036783413203, 965.2229954886384, 18036.0, 19187.0, 19510.122044508033, 19582.510437239183, 19770.20919163246, 961.5384615384654, 966.2608104799833, 1016.7966406718538, 1026.9281150319405, 1035.570238351076, 10216.846747298796, 10747.462626868626, 10856.185786065918, 10888.945555272332, 10899.476717162448, 455931.0, 460852.0, 461202.0, 472642.0, 474458.0, 89829.55085224532, 91093.54453227691, 91436.54281728549, 91478.0, 92538.53730731439, 1000.3047881722279, 1055.6358056470506, 1082.767205050918, 1084.35480888871, 1085.8316960871077, 16283.267252973881, 16763.0, 17054.744178837576, 17093.230804613573, 17294.394696185573, 30082.84958575193, 40490.39264410977, 41677.374839376826, 42201.36697949472, 42452.0, 53845.730771345894, 57557.42442575688, 57887.0, 59114.0, 59368.10947835699, 7816.335611473089, 8091.8381632365845, 8425.915740842513, 8454.0, 8564.400491965502, 11881.821772673244, 12715.427805748579, 12852.678683032998, 12968.286744229157, 13459.394327255493, 10397.272190946562, 10775.461226938465, 10880.347179169275, 11192.888071119185, 11491.138164637518, 10710.143188545053, 10880.183986200907, 10981.212304429071, 11076.39079850616, 11354.489047993025, 10706.143508519455, 11187.0, 11288.153388495732, 11375.829362559734, 11470.419155690237, 8267.29727973129, 8280.958595206985, 8474.06785253634, 8509.702160424604, 8598.65605375803, 9026.684066057656, 11081.390523521284, 11375.374354410587, 11454.0, 11820.0], "value": 8954.509265017787, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1437.5831009007388, 1443.9422423103074, 1573.7639354096884, 1671.3231141387741, 1761.0138322539372, 7509.098908131032, 7741.574213418274, 8004.39967002475, 8537.060923298432, 8546.743597692064, 8041.8793718094275, 8276.420650554464, 8290.08809031006, 8465.44974576652, 8481.363897707666, 2267.353804165813, 2304.2971893572453, 2311.6070268054386, 2313.9884300578474, 2319.3042087373806, 2066.5143691232624, 2123.4691327168207, 2266.3654176830514, 2306.976930230693, 2309.90760369585, 2214.9667754983607, 2277.430642339415, 2278.5898538263104, 2291.644795056769, 2294.265834932822, 2273.8408311418207, 2278.7721227877246, 2288.3249441414823, 2310.4685922237813, 2314.0975019742314, 2248.87631180285, 2277.749447560767, 2295.6556516522487, 2296.437372843647, 2323.6398358254496, 8316.875246871301, 8517.148285171495, 8517.318614510825, 8525.57372131391, 8530.488170709716, 5135.794568217267, 5232.136697444917, 5258.526732594047, 5280.260763493114, 5287.444818294062, 3223.7421006319673, 3321.3025264694443, 3357.362101200764, 3419.6580341965855, 3428.879989200366, 1108.8780234174235, 1119.8544189255426, 1130.508228920414, 1142.360278244186, 1160.3618010094415, 11586.30482171064, 11591.188616796744, 11642.825357619558, 11656.475458604384, 11667.766644667145, 4212.094399704079, 4400.515943246241, 4466.9106617867465, 4483.820647174077, 4490.361018228323, 9195.402298850553, 9195.954020229856, 9196.264298856075, 9196.448213107235, 9203.40177888435, 5167.974160129251, 5168.689878607295, 5173.5602473789395, 5178.067947769362, 5179.870503237449, 4728.621710263171, 4749.050189962021, 4763.952360476351, 4789.8323558675975, 4860.6111511079025, 3491.5984661763714, 3594.6944509716445, 3598.676119149289, 3604.062943634674, 3669.9816500917323, 1048.7902419516126, 1086.4241951765578, 1113.6325012745774, 1115.5928086248462, 1125.7523344864117, 939.1313035442189, 950.6530116507425, 953.4517652349926, 957.6025949230991, 998.6904059741504, 5544.112941929353, 5584.329880414376, 5834.620749651259, 5856.267966504187, 5922.959686818194, 907.9591418386188, 920.1442658327819, 924.7040946897063, 934.490702567089, 953.6471505542855, 4128.855490057834, 4136.255474014706, 4137.379393091001, 4159.480064991876, 4267.893302667396, 9835.655752048788, 10592.947035264928, 10648.574057037631, 10663.573457061786, 10680.198985076151, 10277.537510811882, 10430.478476076165, 10584.0, 10595.205359598061, 10598.682039538826, 7933.444658873939, 8025.959870200729, 8028.357731381592, 8034.076081250614, 8042.758717238492, 5794.7102644866745, 5800.651960882361, 5833.795817146549, 5855.9121613176685, 5959.28488581373, 9525.714228573153, 9644.373115747454, 9707.805843882941, 9831.262655300738, 9844.852327214954, 9174.311926605666, 9535.284853635867, 9547.713568592953, 9809.656662016796, 9812.950935245564, 7487.3261406473675, 7602.353799927068, 7604.46768726206, 7625.466217364953, 7636.656350464354, 8117.594120294079, 8124.431289809657, 8128.390370722102, 8225.753227403187, 8227.670893164206, 6591.6374599397495, 7389.371903388273, 7529.88705169412, 7545.50954187976, 7553.546787192786, 7275.708971641075, 7417.517861338995, 7428.591427471541, 7450.888236676563, 7503.474756766974, 6520.18497687789, 6642.90035649456, 6687.966560167168, 6827.6244806536115, 6861.735627242898, 5067.695938243717, 5180.197069454241, 5210.505002024802, 5228.843134705965, 5272.156454967187, 5029.0, 5093.668911520739, 5205.297284866646, 5257.00116977773, 5271.367435907716], "value": 4493.087463473239, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.23154282065605, 336.4767786092625, 338.1444944290944, 343.4761987968348, 345.478327725135, 5153.072446959555, 5212.4266330703595, 5253.842384728459, 5302.522772950434, 5310.256564081032, 5062.7596238921515, 5228.424873263938, 5232.744141406064, 5244.501772331622, 5250.317458730369, 4131.297679394495, 4144.606262405066, 4165.479599946028, 4166.749995000309, 4172.852465571969, 3890.708196885231, 4084.14233011068, 4153.813078411464, 4158.251514727348, 4198.622124008839, 4050.3519436890106, 4065.7560546367163, 4066.837326506951, 4087.305158123126, 4103.097318589906, 4048.696347773899, 4053.5338436079787, 4075.4294398784045, 4077.143799802045, 4087.0, 3616.969163788308, 3621.8732344367822, 3654.433562797744, 3700.296943580711, 3724.7578907370935, 5097.145598464835, 5099.439061703247, 5103.387593488768, 5108.850508635564, 5117.5650069744115, 4730.385049943486, 4730.455997560291, 4748.19280722278, 4755.5719985201495, 4774.7108280764, 5415.783368665248, 5433.864153396157, 5472.26124473195, 5490.670559766427, 5560.026995275851, 3976.8608098716404, 3992.0, 3999.7400168989216, 4000.299947509174, 4003.4195041718785, 5640.9846227679, 5693.231413759131, 5699.715014249313, 5718.885622287531, 5735.7094653703, 4002.2195671844293, 4144.689148313828, 4155.981784462826, 4175.0, 4175.770332631673, 4122.196171746481, 4159.916801664011, 4163.937540936889, 4186.727862688916, 4192.4907033467925, 4683.461401938753, 4687.226607609706, 4695.201815691341, 4714.811407543729, 4724.834630787975, 5324.420997941767, 5455.34535855692, 5492.286002819608, 5516.889662206733, 5525.668459892419, 1332.3871019331023, 1349.7447373942327, 1361.4622224221378, 1398.7551079539219, 1399.3632897031825, 963.691618682015, 987.4026214140341, 1002.754325190333, 1011.3931641015479, 1013.4324778124274, 5070.504201260637, 5088.872778180576, 5108.386993560796, 5126.846194614168, 5146.948530514647, 5380.408155103014, 5386.253010964437, 5414.296141501658, 5435.864103397446, 5466.535344495683, 5058.418281897555, 5143.3570803649545, 5167.276581278624, 5210.873475914421, 5326.0, 2856.714628297354, 2880.7983441159336, 2887.6101726267107, 2888.465633857743, 2901.5357542793054, 5677.2619559457835, 5708.286464191976, 5731.684757338387, 5734.856628584319, 5740.167675687002, 5439.513920015953, 5500.532454741392, 5515.227868098469, 5520.046774975369, 5539.612227144061, 5613.803516876889, 5629.605927585194, 5649.7288110175705, 5657.886842263214, 5661.745221465044, 5337.786488540415, 5387.919181212206, 5431.864203394946, 5442.836714898559, 5443.863903402446, 5601.383847776823, 5636.408177141341, 5637.46444087811, 5648.548116150616, 5665.461781130786, 5869.73586188614, 5896.17453556511, 5918.704064796657, 5926.4666180044005, 5935.762569497172, 3771.283456143324, 3931.5871833457077, 3978.527944660494, 4033.233685599727, 4042.9797851010558, 5328.973355133199, 5506.926149400829, 5591.189277554813, 5593.300837395325, 5598.636088654224, 5355.491228333302, 5375.6774593524515, 5377.623566350318, 5400.756965936621, 5419.756110975094, 5487.68295609043, 5489.752961116679, 5501.889962200814, 5502.80740174092, 5523.613347065828, 5231.4768523148905, 5412.807812835807, 5449.782008719765, 5451.972740136274, 5459.2902922619805, 5503.697296648563, 5526.889462210814, 5545.334559852843, 5547.362053363753, 5576.470235327637, 5320.52115309624, 5460.6177567569885, 5463.7814487420055, 5481.5340696041285, 5518.42056584069], "value": 4186.396875440059, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.658162372873, 751.5040073551457, 779.4660657449648, 805.6374631415857, 821.0270829067554, 14132.858671413283, 14842.628934276636, 15220.771688424682, 15438.768418473732, 15448.845511544881, 12739.808902866442, 13823.308834558256, 13986.720265594682, 14017.36921838517, 14030.368633411495, 774.8450309938007, 780.6760194519268, 785.5326080981806, 786.5634572812087, 787.2875048081495, 763.8243204063069, 766.4902839611651, 768.9346405555507, 769.0809482668213, 769.1193583347092, 824.6165533027171, 827.7971896885272, 828.2876726015621, 829.5520418973747, 829.9585020748968, 819.3690858039276, 825.4551995682821, 825.942184047114, 828.0518805967164, 828.6809578312364, 598.6168851934765, 599.4215581963383, 599.5683108162116, 601.4556826072411, 602.7890238416563, 12299.877001229963, 12570.245785252822, 12572.811407828889, 12611.117221794479, 13520.0, 11977.341246231454, 12376.319302438362, 12705.17416367933, 12713.872861271362, 12907.741845163138, 12203.20679155852, 12352.135350525466, 12443.191192572454, 12658.746825063447, 13289.534866279633, 4261.680373971964, 4300.204462174508, 4314.331278651814, 4369.717766234535, 4397.582229688174, 62196.0670589937, 65632.0, 66080.33919660789, 66804.0, 66822.0, 10449.738756531147, 10471.633492827867, 10557.947210264054, 10624.203184761174, 10690.786184276427, 18101.45695629133, 18167.36414225522, 18211.089445527672, 18213.54466138357, 18218.08909554517, 7593.772186834404, 7871.685132594632, 8050.194980501903, 8081.353491720648, 8228.465149765247, 4333.826646934151, 4435.733855968652, 4478.216312145361, 4584.747838868894, 4727.7163370197895, 3454.913627159341, 3576.3562558739677, 3576.8569257229938, 3578.0875876651808, 3584.0860580551794, 600.8377738010713, 607.7781609712512, 617.8455386153462, 620.3393386043939, 648.4002297874447, 655.7409823119937, 684.7021545627568, 687.4878215729213, 693.8230751158422, 716.233630015878, 8309.335253179732, 8367.62345694433, 9608.27937904646, 9622.566984485715, 9868.50657467138, 573.3234782956151, 645.2772894358349, 725.0155183116077, 727.7671145233475, 733.66618188724, 4222.387753775747, 4270.167317373144, 4521.186186486399, 4523.705959112647, 4679.321498382716, 49581.50418495841, 50911.490885091414, 51048.234276485884, 51185.48814511882, 90216.54891725631, 44984.0, 50483.0, 70433.0, 71197.28802711907, 71221.52174021756, 58545.70727146422, 63095.684521577095, 64809.35190648127, 65989.67005165039, 66260.66869665621, 9470.0, 9943.801123977624, 9972.30193886421, 10010.749731256778, 10097.596096156072, 41663.58336416597, 43046.13907721765, 43619.345709813744, 44429.33355999598, 44492.77753611211, 37107.814460927526, 37306.440403393426, 41472.0, 57723.42276577181, 59025.0, 12086.818697719717, 12240.75518489643, 12389.690257743268, 12513.747525445508, 12858.42137103814, 13498.52755153565, 13817.240051796845, 14046.78929816033, 14391.28043597795, 14807.777883331542, 13061.542846000344, 13132.73734525285, 13417.798733019208, 13815.930920345334, 14042.368093435616, 11608.767824643628, 12341.259524428562, 12473.313967731861, 12660.11379203447, 12795.552155674506, 12608.810867836806, 12712.3008234548, 12771.36143192818, 12880.420381082686, 13310.733785324433, 10382.603579211003, 10701.555290036056, 10705.250632455653, 11086.279391839505, 11360.54557817711, 10597.15222782191, 10700.464976750976, 10728.39413688928, 10742.0, 11143.665690029313], "value": 6866.751070834566, "unit": "score"}], "name": "dromaeo_css", "value": 7043.343038738194, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 111.0, 110.0, 112.0, 113.0, 112.0, 113.0, 111.0, 110.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 122.0, 126.0, 160.0, 124.0, 124.0, 129.0, 122.0, 161.0, 128.0], "value": 134.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 162.0, 162.0, 162.0, 161.0, 161.0, 161.0, 163.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 110.0, 76.0, 76.0, 75.0, 76.0, 104.0, 76.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 122.0, 82.0, 83.0, 82.0, 103.0, 82.0, 82.0, 113.0], "value": 91.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 146.0, 145.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 85.0, 85.0, 84.0, 85.0, 85.0, 84.0, 85.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 49.0, 50.0, 51.0, 54.0, 51.0, 53.0, 50.0, 52.0], "value": 51.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 62.0, 62.0, 63.0, 65.0, 65.0, 63.0, 62.0, 63.0], "value": 63.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 78.0, 79.0, 80.0, 86.0, 88.0, 83.0, 80.0, 79.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 133.0, 152.0, 131.0, 134.0, 132.0, 138.0, 134.0, 182.0, 134.0], "value": 141.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 165.0, 167.0, 167.0, 165.0, 164.0, 169.0, 168.0, 172.0, 169.0], "value": 167.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 65.0, 64.0, 65.0, 68.0, 65.0, 65.0, 64.0, 63.0], "value": 65.3, "unit": "score"}], "name": "kraken", "value": 1496.8, "alertThreshold": 2.0}]} 05:31:25 INFO - Return code: 0 05:31:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:31:25 INFO - # TBPL SUCCESS # 05:31:25 INFO - Running post-action listener: _resource_record_post_action 05:31:25 INFO - [mozharness: 2016-11-08 13:31:25.336637Z] Finished run-tests step (success) 05:31:25 INFO - Running post-run listener: _resource_record_post_run 05:31:25 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 403951616; Read time: 12; Write time: 263016 05:31:25 INFO - TinderboxPrint: CPU usage
13.1% 05:31:25 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 05:31:25 INFO - TinderboxPrint: I/O write bytes / time
403,951,616 / 263,016 05:31:25 INFO - TinderboxPrint: CPU idle
8,302.9 (86.9%) 05:31:25 INFO - TinderboxPrint: CPU user
1,198.3 (12.5%) 05:31:25 INFO - TinderboxPrint: Swap in / out
0 / 0 05:31:25 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103817216; Read time: 0; Write time: 71368 05:31:25 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 289009664; Read time: 0; Write time: 190040 05:31:25 INFO - Running post-run listener: _upload_blobber_files 05:31:25 INFO - Blob upload gear active. 05:31:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:31:25 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:31:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:31:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:31:26 INFO - (blobuploader) - INFO - Open directory for files ... 05:31:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:31:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:31:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:27 INFO - (blobuploader) - INFO - Done attempting. 05:31:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:31:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:31:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:28 INFO - (blobuploader) - INFO - Done attempting. 05:31:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:31:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:31:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:33 INFO - (blobuploader) - INFO - Done attempting. 05:31:33 INFO - (blobuploader) - INFO - Iteration through files over. 05:31:33 INFO - Return code: 0 05:31:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:31:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:31:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c16c88d7abda515b421c9df4dc51e7584c590b0dbddd87fa97cb9c7e8e70d601c682c791915f7d5d75d6564bb646e36aaf5054acde36491803ddd3881582cbec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0645c432860b9ffd9358eaf973bf6b333828a91f98ae4009b2feef9139cde7db869697849dad6314c455872b171a7896d4bcfff57702d59d7f3f66ab850b9ad9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cba6aee45912d484e952a9f7206e053abac9746f809649e0bbdd13a99e3e2b33ee596f5f3ecba03e2e0b1da81a44bf88745b07917a0c29b17104605d821ef571"} 05:31:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:31:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:31:33 INFO - Contents: 05:31:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c16c88d7abda515b421c9df4dc51e7584c590b0dbddd87fa97cb9c7e8e70d601c682c791915f7d5d75d6564bb646e36aaf5054acde36491803ddd3881582cbec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0645c432860b9ffd9358eaf973bf6b333828a91f98ae4009b2feef9139cde7db869697849dad6314c455872b171a7896d4bcfff57702d59d7f3f66ab850b9ad9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cba6aee45912d484e952a9f7206e053abac9746f809649e0bbdd13a99e3e2b33ee596f5f3ecba03e2e0b1da81a44bf88745b07917a0c29b17104605d821ef571"} 05:31:33 INFO - Running post-run listener: copy_logs_to_upload_dir 05:31:33 INFO - Copying logs to upload dir... 05:31:33 INFO - mkdir: /builds/slave/test/build/upload/logs 05:31:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.443842 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-11-08 05:31:32.180616) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-08 05:31:32.184556) ========= 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=6d15e502d8e29d5d2676d664000001c3-1478610649.6616-312709495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c16c88d7abda515b421c9df4dc51e7584c590b0dbddd87fa97cb9c7e8e70d601c682c791915f7d5d75d6564bb646e36aaf5054acde36491803ddd3881582cbec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0645c432860b9ffd9358eaf973bf6b333828a91f98ae4009b2feef9139cde7db869697849dad6314c455872b171a7896d4bcfff57702d59d7f3f66ab850b9ad9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cba6aee45912d484e952a9f7206e053abac9746f809649e0bbdd13a99e3e2b33ee596f5f3ecba03e2e0b1da81a44bf88745b07917a0c29b17104605d821ef571"} build_url:https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011338 build_url: 'https://queue.taskcluster.net/v1/task/eDvn-b29QnGnFZ5w2MsqJw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c16c88d7abda515b421c9df4dc51e7584c590b0dbddd87fa97cb9c7e8e70d601c682c791915f7d5d75d6564bb646e36aaf5054acde36491803ddd3881582cbec", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0645c432860b9ffd9358eaf973bf6b333828a91f98ae4009b2feef9139cde7db869697849dad6314c455872b171a7896d4bcfff57702d59d7f3f66ab850b9ad9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cba6aee45912d484e952a9f7206e053abac9746f809649e0bbdd13a99e3e2b33ee596f5f3ecba03e2e0b1da81a44bf88745b07917a0c29b17104605d821ef571"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-08 05:31:32.212764) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 05:31:32.213468) ========= 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=6d15e502d8e29d5d2676d664000001c3-1478610649.6616-312709495 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004407 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 05:31:32.295947) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-08 05:31:32.296275) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-08 05:31:32.296576) ========= ========= Total master_lag: 0.17 =========