builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-032 starttime: 1477563464.16 results: success (0) buildid: 20161026135410 builduid: bcb4e07cdf6849fc8eafb123f856941a revision: 45052ddb03a448606ca6ce33f4893a559edebf72 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-27 03:17:44.164809) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-27 03:17:44.165372) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-27 03:17:44.165906) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-27 03:17:44.246399) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 03:17:44.246647) ========= 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=745a4373a2a16df560f216e000000264-1477555582.684912-970778831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-27 03:17:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-10-27 03:17:44 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.104245 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 03:17:44.381840) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 03:17:44.382141) ========= 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=745a4373a2a16df560f216e000000264-1477555582.684912-970778831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019232 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-27 03:17:44.441691) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-27 03:17:44.442088) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 45052ddb03a448606ca6ce33f4893a559edebf72 --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 45052ddb03a448606ca6ce33f4893a559edebf72 --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=745a4373a2a16df560f216e000000264-1477555582.684912-970778831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-27 03:17:44,597 truncating revision to first 12 chars 2016-10-27 03:17:44,597 Setting DEBUG logging. 2016-10-27 03:17:44,597 attempt 1/10 2016-10-27 03:17:44,597 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/45052ddb03a4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-27 03:17:45,992 unpacking tar archive at: mozilla-central-45052ddb03a4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.744121 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-27 03:17:46.208769) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-27 03:17:46.209187) ========= script_repo_revision: 45052ddb03a448606ca6ce33f4893a559edebf72 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-27 03:17:46.209658) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-27 03:17:46.209927) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-27 03:17:46.219742) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-27 03:17:46.220144) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=745a4373a2a16df560f216e000000264-1477555582.684912-970778831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:17:46 INFO - MultiFileLogger online at 20161027 03:17:46 in /builds/slave/test 03:17:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 03:17:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:17:46 INFO - {'append_to_log': False, 03:17:46 INFO - 'base_work_dir': '/builds/slave/test', 03:17:46 INFO - 'blob_upload_branch': 'Firefox', 03:17:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:17:46 INFO - 'branch': 'Firefox', 03:17:46 INFO - 'buildbot_json_path': 'buildprops.json', 03:17:46 INFO - 'config_files': ('talos/linux_config.py',), 03:17:46 INFO - 'default_actions': ('clobber', 03:17:46 INFO - 'read-buildbot-config', 03:17:46 INFO - 'download-and-extract', 03:17:46 INFO - 'populate-webroot', 03:17:46 INFO - 'create-virtualenv', 03:17:46 INFO - 'install', 03:17:46 INFO - 'run-tests'), 03:17:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:17:46 INFO - 'download_minidump_stackwalk': True, 03:17:46 INFO - 'download_symbols': 'ondemand', 03:17:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:17:46 INFO - 'tooltool.py': '/tools/tooltool.py', 03:17:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:17:46 INFO - '/tools/misc-python/virtualenv.py')}, 03:17:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:17:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:17:46 INFO - 'installer_path': 'installer.exe', 03:17:46 INFO - 'log_level': 'info', 03:17:46 INFO - 'log_name': 'talos', 03:17:46 INFO - 'log_to_console': True, 03:17:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:17:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:17:46 INFO - 'opt_config_files': (), 03:17:46 INFO - 'pip_index': False, 03:17:46 INFO - 'sps_profile': False, 03:17:46 INFO - 'sps_profile_interval': 0, 03:17:46 INFO - 'suite': 'dromaeojs-e10s', 03:17:46 INFO - 'system_bits': '32', 03:17:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:17:46 INFO - 'title': 'talos-linux64-ix-032', 03:17:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:17:46 INFO - 'use_talos_json': True, 03:17:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:17:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:17:46 INFO - 'work_dir': 'build'} 03:17:46 INFO - [mozharness: 2016-10-27 10:17:46.462103Z] Running clobber step. 03:17:46 INFO - Running pre-action listener: _resource_record_pre_action 03:17:46 INFO - Running main action method: clobber 03:17:46 INFO - rmtree: /builds/slave/test/build 03:17:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:17:46 INFO - Running post-action listener: _resource_record_post_action 03:17:46 INFO - [mozharness: 2016-10-27 10:17:46.912497Z] Finished clobber step (success) 03:17:46 INFO - [mozharness: 2016-10-27 10:17:46.912597Z] Running read-buildbot-config step. 03:17:46 INFO - Running pre-action listener: _resource_record_pre_action 03:17:46 INFO - Running main action method: read_buildbot_config 03:17:46 INFO - Using buildbot properties: 03:17:46 INFO - { 03:17:46 INFO - "project": "", 03:17:46 INFO - "product": "firefox", 03:17:46 INFO - "script_repo_revision": "production", 03:17:46 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:17:46 INFO - "repository": "", 03:17:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 03:17:46 INFO - "buildid": "20161026135410", 03:17:46 INFO - "pgo_build": "True", 03:17:46 INFO - "basedir": "/builds/slave/test", 03:17:46 INFO - "buildnumber": 140, 03:17:46 INFO - "slavename": "talos-linux64-ix-032", 03:17:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 03:17:46 INFO - "platform": "ubuntu64_hw", 03:17:46 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 03:17:46 INFO - "branch": "mozilla-central", 03:17:46 INFO - "repo_path": "mozilla-central", 03:17:46 INFO - "revision": "45052ddb03a448606ca6ce33f4893a559edebf72", 03:17:46 INFO - "stage_platform": "linux64-pgo", 03:17:46 INFO - "builduid": "bcb4e07cdf6849fc8eafb123f856941a", 03:17:46 INFO - "slavebuilddir": "test" 03:17:46 INFO - } 03:17:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/cxpoRELQSQmBT6o-5fXcvA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 03:17:46 INFO - Running post-action listener: _resource_record_post_action 03:17:46 INFO - [mozharness: 2016-10-27 10:17:46.915224Z] Finished read-buildbot-config step (success) 03:17:46 INFO - [mozharness: 2016-10-27 10:17:46.915312Z] Running download-and-extract step. 03:17:46 INFO - Running pre-action listener: _resource_record_pre_action 03:17:46 INFO - Running main action method: download_and_extract 03:17:46 INFO - mkdir: /builds/slave/test/build/tests 03:17:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:46 INFO - trying https://queue.taskcluster.net/v1/task/cxpoRELQSQmBT6o-5fXcvA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:17:46 INFO - Downloading https://queue.taskcluster.net/v1/task/cxpoRELQSQmBT6o-5fXcvA/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 03:17:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cxpoRELQSQmBT6o-5fXcvA/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 03:17:47 INFO - Downloaded 1361 bytes. 03:17:47 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 03:17:47 INFO - Using the following test package requirements: 03:17:47 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:17:47 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:17:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:17:47 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:17:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:17:47 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:17:47 INFO - u'jsshell-linux-x86_64.zip'], 03:17:47 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:17:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:17:47 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 03:17:47 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:17:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:17:47 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:17:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:17:47 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:17:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:17:47 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 03:17:47 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:17:47 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:17:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cxpoRELQSQmBT6o-5fXcvA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:17:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cxpoRELQSQmBT6o-5fXcvA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:17:47 INFO - Fetch https://queue.taskcluster.net/v1/task/cxpoRELQSQmBT6o-5fXcvA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:17:48 INFO - Http code: 200 03:17:48 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 03:17:48 INFO - x-amz-cf-id: 8SMfL9dfUq8lJDUFCR1405DYEGmBVzSeUkxELUDze29aaJT4OVIGtw== 03:17:48 INFO - x-amz-version-id: OF9nwgCv54.eAUgqVctnqmm5tw1WEE4C 03:17:48 INFO - Expected file size: 22100311 03:17:48 INFO - Obtained file size: 22100311 03:17:52 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 03:17:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cxpoRELQSQmBT6o-5fXcvA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 03:17:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cxpoRELQSQmBT6o-5fXcvA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:17:52 INFO - Fetch https://queue.taskcluster.net/v1/task/cxpoRELQSQmBT6o-5fXcvA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 03:17:52 INFO - Http code: 200 03:17:52 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 03:17:52 INFO - x-amz-cf-id: _omPQGQp74i80lHjDvvgDc6noqcwQlxaSM3oy6B_gAqW7TWisKPSeQ== 03:17:52 INFO - x-amz-version-id: OF9nwgCv54.eAUgqVctnqmm5tw1WEE4C 03:17:53 INFO - Expected file size: 22100311 03:17:53 INFO - Obtained file size: 22100311 03:17:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cxpoRELQSQmBT6o-5fXcvA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 03:17:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cxpoRELQSQmBT6o-5fXcvA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:17:57 INFO - Fetch https://queue.taskcluster.net/v1/task/cxpoRELQSQmBT6o-5fXcvA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 03:17:58 INFO - Http code: 200 03:17:58 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 03:17:58 INFO - x-amz-cf-id: Qglqlg4NSBYjiWbg-YuPEEJGQ2osi5MPubtPKeycfWvaXT3o_hHncw== 03:17:58 INFO - x-amz-version-id: sWRHZv2Gb8B3GS_PPW3FN9_OqC6pqr.J 03:17:58 INFO - Expected file size: 14409006 03:17:58 INFO - Obtained file size: 14409006 03:17:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:17:58 INFO - trying https://queue.taskcluster.net/v1/task/cxpoRELQSQmBT6o-5fXcvA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:17:58 INFO - Downloading https://queue.taskcluster.net/v1/task/cxpoRELQSQmBT6o-5fXcvA/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 03:17:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cxpoRELQSQmBT6o-5fXcvA/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 03:18:00 INFO - Downloaded 59729492 bytes. 03:18:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cxpoRELQSQmBT6o-5fXcvA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:18:00 INFO - mkdir: /builds/slave/test/properties 03:18:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:18:00 INFO - Writing to file /builds/slave/test/properties/build_url 03:18:00 INFO - Contents: 03:18:00 INFO - build_url:https://queue.taskcluster.net/v1/task/cxpoRELQSQmBT6o-5fXcvA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 03:18:01 INFO - Running post-action listener: _resource_record_post_action 03:18:01 INFO - Running post-action listener: set_extra_try_arguments 03:18:01 INFO - [mozharness: 2016-10-27 10:18:01.364649Z] Finished download-and-extract step (success) 03:18:01 INFO - [mozharness: 2016-10-27 10:18:01.364877Z] Running populate-webroot step. 03:18:01 INFO - Running pre-action listener: _resource_record_pre_action 03:18:01 INFO - Running main action method: populate_webroot 03:18:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:18:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:18:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:18:01 INFO - '--tppagecycles', 03:18:01 INFO - '7'], 03:18:01 INFO - 'tests': ['tsvgm']}}, 03:18:01 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:18:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:18:01 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:18:01 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:18:01 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:18:01 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:18:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:01 INFO - 'talos_options': ['--disable-e10s'], 03:18:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:18:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:18:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:01 INFO - 'talos_options': ['--disable-e10s'], 03:18:01 INFO - 'tests': ['damp', 'tps']}, 03:18:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:01 INFO - 'tests': ['damp', 'tps']}, 03:18:01 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:18:01 INFO - 'tests': ['dromaeo_dom']}, 03:18:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:18:01 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:18:01 INFO - 'tests': ['basic_compositor_video']}, 03:18:01 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:18:01 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:18:01 INFO - 'tests': ['a11yr', 03:18:01 INFO - 'ts_paint', 03:18:01 INFO - 'tpaint', 03:18:01 INFO - 'sessionrestore', 03:18:01 INFO - 'sessionrestore_no_auto_restore', 03:18:01 INFO - 'tabpaint']}, 03:18:01 INFO - 'other-e10s': {'tests': ['a11yr', 03:18:01 INFO - 'ts_paint', 03:18:01 INFO - 'tpaint', 03:18:01 INFO - 'sessionrestore', 03:18:01 INFO - 'sessionrestore_no_auto_restore', 03:18:01 INFO - 'tabpaint']}, 03:18:01 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:18:01 INFO - 'ts_paint', 03:18:01 INFO - 'tpaint', 03:18:01 INFO - 'sessionrestore', 03:18:01 INFO - 'sessionrestore_no_auto_restore', 03:18:01 INFO - 'tabpaint']}, 03:18:01 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:18:01 INFO - 'ts_paint', 03:18:01 INFO - 'tpaint', 03:18:01 INFO - 'sessionrestore', 03:18:01 INFO - 'sessionrestore_no_auto_restore', 03:18:01 INFO - 'tabpaint']}, 03:18:01 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:18:01 INFO - 'tests': ['a11yr', 03:18:01 INFO - 'ts_paint', 03:18:01 INFO - 'tpaint', 03:18:01 INFO - 'sessionrestore', 03:18:01 INFO - 'sessionrestore_no_auto_restore', 03:18:01 INFO - 'tabpaint']}, 03:18:01 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:18:01 INFO - 'tests': ['a11yr', 03:18:01 INFO - 'ts_paint', 03:18:01 INFO - 'tpaint', 03:18:01 INFO - 'sessionrestore', 03:18:01 INFO - 'sessionrestore_no_auto_restore', 03:18:01 INFO - 'tabpaint']}, 03:18:01 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:18:01 INFO - 'tests': ['tsvgx', 03:18:01 INFO - 'tsvgr_opacity', 03:18:01 INFO - 'tart', 03:18:01 INFO - 'tscrollx', 03:18:01 INFO - 'cart']}, 03:18:01 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:18:01 INFO - 'tsvgr_opacity', 03:18:01 INFO - 'tart', 03:18:01 INFO - 'tscrollx', 03:18:01 INFO - 'cart']}, 03:18:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:01 INFO - 'talos_options': ['--disable-e10s'], 03:18:01 INFO - 'tests': ['tp5o']}, 03:18:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:01 INFO - 'tests': ['tp5o']}, 03:18:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:01 INFO - 'talos_options': ['--disable-e10s', 03:18:01 INFO - '--xperf_path', 03:18:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:18:01 INFO - 'tests': ['tp5n']}, 03:18:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:18:01 INFO - 'talos_options': ['--xperf_path', 03:18:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:18:01 INFO - 'tests': ['tp5n']}}, 03:18:01 INFO - 'talos.zip': {'path': '', 03:18:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:18:01 INFO - Running post-action listener: _resource_record_post_action 03:18:01 INFO - [mozharness: 2016-10-27 10:18:01.383621Z] Finished populate-webroot step (success) 03:18:01 INFO - [mozharness: 2016-10-27 10:18:01.383709Z] Running create-virtualenv step. 03:18:01 INFO - Running pre-action listener: _resource_record_pre_action 03:18:01 INFO - Running main action method: create_virtualenv 03:18:01 INFO - Creating virtualenv /builds/slave/test/build/venv 03:18:01 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 03:18:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:18:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:18:01 INFO - Using real prefix '/usr' 03:18:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:18:01 INFO - Installing distribute.............................................................................................................................................................................................done. 03:18:03 INFO - Installing pip.................done. 03:18:03 INFO - Return code: 0 03:18:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:18:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:18:04 INFO - Reading from file tmpfile_stdout 03:18:04 INFO - Output received: 03:18:04 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) 03:18:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff71f927f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12df930>, '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 0x12e0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e0cc0>, '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': '745a4373a2a16df560f216e000000264-1477555582.684912-970778831', '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 03:18:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:18:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:18:04 INFO - Using env: {'DISPLAY': ':0', 03:18:04 INFO - 'HOME': '/home/cltbld', 03:18:04 INFO - 'LANG': 'en_US.UTF-8', 03:18:04 INFO - 'LANGUAGE': 'en_US:en', 03:18:04 INFO - 'LOGNAME': 'cltbld', 03:18:04 INFO - 'MAIL': '/var/mail/cltbld', 03:18:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:04 INFO - 'MOZ_NO_REMOTE': '1', 03:18:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:04 INFO - 'NO_EM_RESTART': '1', 03:18:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:04 INFO - 'PWD': '/builds/slave/test', 03:18:04 INFO - 'SHELL': '/bin/bash', 03:18:04 INFO - 'SHLVL': '1', 03:18:04 INFO - 'TERM': 'linux', 03:18:04 INFO - 'TMOUT': '86400', 03:18:04 INFO - 'USER': 'cltbld', 03:18:04 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1477555582.684912-970778831', 03:18:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:04 INFO - '_': '/tools/buildbot/bin/python'} 03:18:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:04 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 03:18:04 INFO - Cleaning up... 03:18:04 INFO - Return code: 0 03:18:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff71f927f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12df930>, '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 0x12e0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e0cc0>, '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': '745a4373a2a16df560f216e000000264-1477555582.684912-970778831', '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 03:18:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:18:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:18:04 INFO - Using env: {'DISPLAY': ':0', 03:18:04 INFO - 'HOME': '/home/cltbld', 03:18:04 INFO - 'LANG': 'en_US.UTF-8', 03:18:04 INFO - 'LANGUAGE': 'en_US:en', 03:18:04 INFO - 'LOGNAME': 'cltbld', 03:18:04 INFO - 'MAIL': '/var/mail/cltbld', 03:18:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:04 INFO - 'MOZ_NO_REMOTE': '1', 03:18:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:04 INFO - 'NO_EM_RESTART': '1', 03:18:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:04 INFO - 'PWD': '/builds/slave/test', 03:18:04 INFO - 'SHELL': '/bin/bash', 03:18:04 INFO - 'SHLVL': '1', 03:18:04 INFO - 'TERM': 'linux', 03:18:04 INFO - 'TMOUT': '86400', 03:18:04 INFO - 'USER': 'cltbld', 03:18:04 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1477555582.684912-970778831', 03:18:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:04 INFO - '_': '/tools/buildbot/bin/python'} 03:18:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:04 INFO - Downloading/unpacking psutil>=3.1.1 03:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:18:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:18:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:18:06 INFO - Installing collected packages: psutil 03:18:06 INFO - Running setup.py install for psutil 03:18:06 INFO - building 'psutil._psutil_linux' extension 03:18:06 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 03:18:06 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 03:18:06 INFO - building 'psutil._psutil_posix' extension 03:18:06 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 03:18:07 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 03:18:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:18:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:18:07 INFO - Successfully installed psutil 03:18:07 INFO - Cleaning up... 03:18:07 INFO - Return code: 0 03:18:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:18: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')]} 03:18:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18: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')]} 03:18:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff71f927f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12df930>, '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 0x12e0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e0cc0>, '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': '745a4373a2a16df560f216e000000264-1477555582.684912-970778831', '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 03:18: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:18: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 mozsystemmonitor==0.3 03:18:07 INFO - Using env: {'DISPLAY': ':0', 03:18:07 INFO - 'HOME': '/home/cltbld', 03:18:07 INFO - 'LANG': 'en_US.UTF-8', 03:18:07 INFO - 'LANGUAGE': 'en_US:en', 03:18:07 INFO - 'LOGNAME': 'cltbld', 03:18:07 INFO - 'MAIL': '/var/mail/cltbld', 03:18:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:07 INFO - 'MOZ_NO_REMOTE': '1', 03:18:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:07 INFO - 'NO_EM_RESTART': '1', 03:18:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:07 INFO - 'PWD': '/builds/slave/test', 03:18:07 INFO - 'SHELL': '/bin/bash', 03:18:07 INFO - 'SHLVL': '1', 03:18:07 INFO - 'TERM': 'linux', 03:18:07 INFO - 'TMOUT': '86400', 03:18:07 INFO - 'USER': 'cltbld', 03:18:07 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1477555582.684912-970778831', 03:18:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:07 INFO - '_': '/tools/buildbot/bin/python'} 03:18:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:18:07 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 03:18:07 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 03:18:07 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 03:18:07 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 03:18:07 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 03:18:07 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 03:18:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:18:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:18:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:18:09 INFO - Installing collected packages: mozsystemmonitor 03:18:09 INFO - Running setup.py install for mozsystemmonitor 03:18:09 INFO - Successfully installed mozsystemmonitor 03:18:09 INFO - Cleaning up... 03:18:09 INFO - Return code: 0 03:18:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:18:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:18:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff71f927f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12df930>, '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 0x12e0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e0cc0>, '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': '745a4373a2a16df560f216e000000264-1477555582.684912-970778831', '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 03:18:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:18:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:18:09 INFO - Using env: {'DISPLAY': ':0', 03:18:09 INFO - 'HOME': '/home/cltbld', 03:18:09 INFO - 'LANG': 'en_US.UTF-8', 03:18:09 INFO - 'LANGUAGE': 'en_US:en', 03:18:09 INFO - 'LOGNAME': 'cltbld', 03:18:09 INFO - 'MAIL': '/var/mail/cltbld', 03:18:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:09 INFO - 'MOZ_NO_REMOTE': '1', 03:18:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:09 INFO - 'NO_EM_RESTART': '1', 03:18:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:09 INFO - 'PWD': '/builds/slave/test', 03:18:09 INFO - 'SHELL': '/bin/bash', 03:18:09 INFO - 'SHLVL': '1', 03:18:09 INFO - 'TERM': 'linux', 03:18:09 INFO - 'TMOUT': '86400', 03:18:09 INFO - 'USER': 'cltbld', 03:18:09 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1477555582.684912-970778831', 03:18:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:09 INFO - '_': '/tools/buildbot/bin/python'} 03:18:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:09 INFO - Downloading/unpacking jsonschema==2.5.1 03:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:18:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:18: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 03:18: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 03:18: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 03:18: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 03:18: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 03:18: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 03:18:11 INFO - Downloading functools32-3.2.3-2.tar.gz 03:18:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:18:11 INFO - warning: no files found matching '*.txt' 03:18:11 INFO - no previously-included directories found matching 'build' 03:18:11 INFO - no previously-included directories found matching 'dist' 03:18:11 INFO - no previously-included directories found matching '.git*' 03:18:11 INFO - Installing collected packages: jsonschema, functools32 03:18:11 INFO - Running setup.py install for functools32 03:18:12 INFO - warning: no files found matching '*.txt' 03:18:12 INFO - no previously-included directories found matching 'build' 03:18:12 INFO - no previously-included directories found matching 'dist' 03:18:12 INFO - no previously-included directories found matching '.git*' 03:18:12 INFO - Successfully installed jsonschema functools32 03:18:12 INFO - Cleaning up... 03:18:12 INFO - Return code: 0 03:18:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:18:12 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')]} 03:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:12 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')]} 03:18:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:12 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 0x7ff71f927f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12df930>, '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 0x12e0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e0cc0>, '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': '745a4373a2a16df560f216e000000264-1477555582.684912-970778831', '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 03:18:12 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 03:18:12 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 03:18:12 INFO - Using env: {'DISPLAY': ':0', 03:18:12 INFO - 'HOME': '/home/cltbld', 03:18:12 INFO - 'LANG': 'en_US.UTF-8', 03:18:12 INFO - 'LANGUAGE': 'en_US:en', 03:18:12 INFO - 'LOGNAME': 'cltbld', 03:18:12 INFO - 'MAIL': '/var/mail/cltbld', 03:18:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:12 INFO - 'MOZ_NO_REMOTE': '1', 03:18:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:12 INFO - 'NO_EM_RESTART': '1', 03:18:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:12 INFO - 'PWD': '/builds/slave/test', 03:18:12 INFO - 'SHELL': '/bin/bash', 03:18:12 INFO - 'SHLVL': '1', 03:18:12 INFO - 'TERM': 'linux', 03:18:12 INFO - 'TMOUT': '86400', 03:18:12 INFO - 'USER': 'cltbld', 03:18:12 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1477555582.684912-970778831', 03:18:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:12 INFO - '_': '/tools/buildbot/bin/python'} 03:18:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:18:12 INFO - Cleaning up... 03:18:12 INFO - Return code: 0 03:18:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:18:12 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')]} 03:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:12 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')]} 03:18:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:12 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 0x7ff71f927f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12df930>, '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 0x12e0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e0cc0>, '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': '745a4373a2a16df560f216e000000264-1477555582.684912-970778831', '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 03:18:12 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 03:18:12 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 03:18:12 INFO - Using env: {'DISPLAY': ':0', 03:18:12 INFO - 'HOME': '/home/cltbld', 03:18:12 INFO - 'LANG': 'en_US.UTF-8', 03:18:12 INFO - 'LANGUAGE': 'en_US:en', 03:18:12 INFO - 'LOGNAME': 'cltbld', 03:18:12 INFO - 'MAIL': '/var/mail/cltbld', 03:18:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:12 INFO - 'MOZ_NO_REMOTE': '1', 03:18:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:12 INFO - 'NO_EM_RESTART': '1', 03:18:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:12 INFO - 'PWD': '/builds/slave/test', 03:18:12 INFO - 'SHELL': '/bin/bash', 03:18:12 INFO - 'SHLVL': '1', 03:18:12 INFO - 'TERM': 'linux', 03:18:12 INFO - 'TMOUT': '86400', 03:18:12 INFO - 'USER': 'cltbld', 03:18:12 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1477555582.684912-970778831', 03:18:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:12 INFO - '_': '/tools/buildbot/bin/python'} 03:18:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:12 INFO - Downloading/unpacking blobuploader==1.2.4 03:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:14 INFO - Downloading blobuploader-1.2.4.tar.gz 03:18:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:18:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:18:14 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 03:18:14 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 03:18:14 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 03:18:14 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 03:18:14 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 03:18:14 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 03:18:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:18:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:18:14 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 03:18:14 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 03:18:14 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 03:18:14 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 03:18:14 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 03:18:14 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 03:18:15 INFO - Downloading docopt-0.6.1.tar.gz 03:18:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:18:15 INFO - Installing collected packages: blobuploader, requests, docopt 03:18:15 INFO - Running setup.py install for blobuploader 03:18:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:18:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:18:15 INFO - Running setup.py install for requests 03:18:15 INFO - Running setup.py install for docopt 03:18:15 INFO - Successfully installed blobuploader requests docopt 03:18:15 INFO - Cleaning up... 03:18:15 INFO - Return code: 0 03:18:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:18: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')]} 03:18:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18: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')]} 03:18:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:15 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 0x7ff71f927f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12df930>, '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 0x12e0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e0cc0>, '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': '745a4373a2a16df560f216e000000264-1477555582.684912-970778831', '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 03:18:15 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 03:18:15 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 03:18:15 INFO - Using env: {'DISPLAY': ':0', 03:18:15 INFO - 'HOME': '/home/cltbld', 03:18:15 INFO - 'LANG': 'en_US.UTF-8', 03:18:15 INFO - 'LANGUAGE': 'en_US:en', 03:18:15 INFO - 'LOGNAME': 'cltbld', 03:18:15 INFO - 'MAIL': '/var/mail/cltbld', 03:18:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:15 INFO - 'MOZ_NO_REMOTE': '1', 03:18:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:15 INFO - 'NO_EM_RESTART': '1', 03:18:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:15 INFO - 'PWD': '/builds/slave/test', 03:18:15 INFO - 'SHELL': '/bin/bash', 03:18:15 INFO - 'SHLVL': '1', 03:18:15 INFO - 'TERM': 'linux', 03:18:15 INFO - 'TMOUT': '86400', 03:18:15 INFO - 'USER': 'cltbld', 03:18:15 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1477555582.684912-970778831', 03:18:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:15 INFO - '_': '/tools/buildbot/bin/python'} 03:18:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:18:16 INFO - Running setup.py (path:/tmp/pip-UvpIlz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:18:16 INFO - Running setup.py (path:/tmp/pip-1WXJue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:18:16 INFO - Running setup.py (path:/tmp/pip-aCGJMr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:18:16 INFO - Running setup.py (path:/tmp/pip-u7a2bW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:18:16 INFO - Running setup.py (path:/tmp/pip-uAfrXl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:18:16 INFO - Running setup.py (path:/tmp/pip-NnHNrV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:18:16 INFO - Running setup.py (path:/tmp/pip-eDB7TL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:18:16 INFO - Running setup.py (path:/tmp/pip-q6_bNb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:18:16 INFO - Running setup.py (path:/tmp/pip-PKSKCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:18:16 INFO - Running setup.py (path:/tmp/pip-YlPjmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:18:16 INFO - Running setup.py (path:/tmp/pip-WK_GcP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:18:16 INFO - Running setup.py (path:/tmp/pip-MeSTwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:18:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:18:16 INFO - Running setup.py (path:/tmp/pip-Vm9u0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:18:17 INFO - Running setup.py (path:/tmp/pip-IVWiO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:18:17 INFO - Running setup.py (path:/tmp/pip-Qvw3TL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:18:17 INFO - Running setup.py (path:/tmp/pip-sq0dr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:18:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:18:17 INFO - Running setup.py (path:/tmp/pip-JGIWKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:18:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:18:17 INFO - Running setup.py install for manifestparser 03:18:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:18:17 INFO - Running setup.py install for mozcrash 03:18:17 INFO - Running setup.py install for mozdebug 03:18:17 INFO - Running setup.py install for mozdevice 03:18:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:18:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:18:17 INFO - Running setup.py install for mozfile 03:18:17 INFO - Running setup.py install for mozhttpd 03:18:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:18:17 INFO - Running setup.py install for mozinfo 03:18:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:18:18 INFO - Running setup.py install for mozInstall 03:18:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:18:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:18:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:18:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:18:18 INFO - Running setup.py install for mozleak 03:18:18 INFO - Running setup.py install for mozlog 03:18:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:18:18 INFO - Running setup.py install for moznetwork 03:18:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:18:18 INFO - Running setup.py install for mozprocess 03:18:18 INFO - Running setup.py install for mozprofile 03:18:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:18:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:18:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:18:18 INFO - Running setup.py install for mozrunner 03:18:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:18:18 INFO - Running setup.py install for mozscreenshot 03:18:18 INFO - Running setup.py install for moztest 03:18:18 INFO - Running setup.py install for mozversion 03:18:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:18:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:18:19 INFO - Cleaning up... 03:18:19 INFO - Return code: 0 03:18:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:18: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')]} 03:18:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18: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')]} 03:18:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:19 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 0x7ff71f927f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12df930>, '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 0x12e0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e0cc0>, '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': '745a4373a2a16df560f216e000000264-1477555582.684912-970778831', '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 03:18:19 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 03:18:19 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 03:18:19 INFO - Using env: {'DISPLAY': ':0', 03:18:19 INFO - 'HOME': '/home/cltbld', 03:18:19 INFO - 'LANG': 'en_US.UTF-8', 03:18:19 INFO - 'LANGUAGE': 'en_US:en', 03:18:19 INFO - 'LOGNAME': 'cltbld', 03:18:19 INFO - 'MAIL': '/var/mail/cltbld', 03:18:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:19 INFO - 'MOZ_NO_REMOTE': '1', 03:18:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:19 INFO - 'NO_EM_RESTART': '1', 03:18:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:19 INFO - 'PWD': '/builds/slave/test', 03:18:19 INFO - 'SHELL': '/bin/bash', 03:18:19 INFO - 'SHLVL': '1', 03:18:19 INFO - 'TERM': 'linux', 03:18:19 INFO - 'TMOUT': '86400', 03:18:19 INFO - 'USER': 'cltbld', 03:18:19 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1477555582.684912-970778831', 03:18:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:19 INFO - '_': '/tools/buildbot/bin/python'} 03:18:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:18:19 INFO - Running setup.py (path:/tmp/pip-VEYThu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:18:19 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)) 03:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:18:19 INFO - Running setup.py (path:/tmp/pip-obrQ20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:18:19 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)) 03:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:18:19 INFO - Running setup.py (path:/tmp/pip-TbbGEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:18:19 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)) 03:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:18:19 INFO - Running setup.py (path:/tmp/pip-DHjAmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:18:19 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)) 03:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:18:19 INFO - Running setup.py (path:/tmp/pip-IRD_CL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:18:19 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)) 03:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:18:19 INFO - Running setup.py (path:/tmp/pip-je7_5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:18:19 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)) 03:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:18:19 INFO - Running setup.py (path:/tmp/pip-XdflvY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:18:19 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)) 03:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:18:19 INFO - Running setup.py (path:/tmp/pip-HrjSha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:18:19 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)) 03:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:18:19 INFO - Running setup.py (path:/tmp/pip-KSqOZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:18:19 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)) 03:18:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:18:19 INFO - Running setup.py (path:/tmp/pip-1xag6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:18:20 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)) 03:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:18:20 INFO - Running setup.py (path:/tmp/pip-itnP4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:18:20 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)) 03:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:18:20 INFO - Running setup.py (path:/tmp/pip-_ucO03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:18:20 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)) 03:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:18:20 INFO - Running setup.py (path:/tmp/pip-926l5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:18:20 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)) 03:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:18:20 INFO - Running setup.py (path:/tmp/pip-dbaIqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:18:20 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)) 03:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:18:20 INFO - Running setup.py (path:/tmp/pip-ZeFuIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:18:20 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)) 03:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:18:20 INFO - Running setup.py (path:/tmp/pip-pZHPqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:18:20 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)) 03:18:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:18:20 INFO - Running setup.py (path:/tmp/pip-mgtsVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:18:20 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)) 03:18:20 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)) 03:18:20 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)) 03:18:20 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)) 03:18:20 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)) 03:18:20 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)) 03:18:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:18:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:18:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:18:22 INFO - Downloading blessings-1.6.tar.gz 03:18:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:18:22 INFO - Installing collected packages: blessings 03:18:22 INFO - Running setup.py install for blessings 03:18:22 INFO - Successfully installed blessings 03:18:22 INFO - Cleaning up... 03:18:22 INFO - Return code: 0 03:18:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:18:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:18:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:18:22 INFO - Reading from file tmpfile_stdout 03:18:22 INFO - Current package versions: 03:18:22 INFO - argparse == 1.2.1 03:18:22 INFO - blessings == 1.6 03:18:22 INFO - blobuploader == 1.2.4 03:18:22 INFO - docopt == 0.6.1 03:18:22 INFO - functools32 == 3.2.3-2 03:18:22 INFO - jsonschema == 2.5.1 03:18:22 INFO - manifestparser == 1.1 03:18:22 INFO - mozInstall == 1.12 03:18:22 INFO - mozcrash == 0.17 03:18:22 INFO - mozdebug == 0.1 03:18:22 INFO - mozdevice == 0.48 03:18:22 INFO - mozfile == 1.2 03:18:22 INFO - mozhttpd == 0.7 03:18:22 INFO - mozinfo == 0.9 03:18:22 INFO - mozleak == 0.1 03:18:22 INFO - mozlog == 3.4 03:18:22 INFO - moznetwork == 0.27 03:18:22 INFO - mozprocess == 0.23 03:18:22 INFO - mozprofile == 0.28 03:18:22 INFO - mozrunner == 6.12 03:18:22 INFO - mozscreenshot == 0.1 03:18:22 INFO - mozsystemmonitor == 0.3 03:18:22 INFO - moztest == 0.7 03:18:22 INFO - mozversion == 1.4 03:18:22 INFO - psutil == 3.1.1 03:18:22 INFO - requests == 1.2.3 03:18:22 INFO - wsgiref == 0.1.2 03:18:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:18:22 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')]} 03:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:22 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')]} 03:18:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:22 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 0x7ff71f927f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12df930>, '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 0x12e0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e0cc0>, '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': '745a4373a2a16df560f216e000000264-1477555582.684912-970778831', '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 03:18:22 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 03:18:22 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 03:18:22 INFO - Using env: {'DISPLAY': ':0', 03:18:22 INFO - 'HOME': '/home/cltbld', 03:18:22 INFO - 'LANG': 'en_US.UTF-8', 03:18:22 INFO - 'LANGUAGE': 'en_US:en', 03:18:22 INFO - 'LOGNAME': 'cltbld', 03:18:22 INFO - 'MAIL': '/var/mail/cltbld', 03:18:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:22 INFO - 'MOZ_NO_REMOTE': '1', 03:18:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:22 INFO - 'NO_EM_RESTART': '1', 03:18:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:22 INFO - 'PWD': '/builds/slave/test', 03:18:22 INFO - 'SHELL': '/bin/bash', 03:18:22 INFO - 'SHLVL': '1', 03:18:22 INFO - 'TERM': 'linux', 03:18:22 INFO - 'TMOUT': '86400', 03:18:22 INFO - 'USER': 'cltbld', 03:18:22 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1477555582.684912-970778831', 03:18:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:22 INFO - '_': '/tools/buildbot/bin/python'} 03:18:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:23 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)) 03:18:23 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)) 03:18:23 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)) 03:18:23 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)) 03:18:23 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)) 03:18:23 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)) 03:18:23 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)) 03:18:23 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)) 03:18:23 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)) 03:18:23 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)) 03:18:23 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)) 03:18:23 INFO - Cleaning up... 03:18:23 INFO - Return code: 0 03:18:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:18: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')]} 03:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:18:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18: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')]} 03:18:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:18:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:18:23 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 0x7ff71f927f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x12e2790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12df930>, '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 0x12e0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e0cc0>, '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': '745a4373a2a16df560f216e000000264-1477555582.684912-970778831', '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 03:18:23 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 03:18:23 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 03:18:23 INFO - Using env: {'DISPLAY': ':0', 03:18:23 INFO - 'HOME': '/home/cltbld', 03:18:23 INFO - 'LANG': 'en_US.UTF-8', 03:18:23 INFO - 'LANGUAGE': 'en_US:en', 03:18:23 INFO - 'LOGNAME': 'cltbld', 03:18:23 INFO - 'MAIL': '/var/mail/cltbld', 03:18:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:23 INFO - 'MOZ_NO_REMOTE': '1', 03:18:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:23 INFO - 'NO_EM_RESTART': '1', 03:18:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:23 INFO - 'PWD': '/builds/slave/test', 03:18:23 INFO - 'SHELL': '/bin/bash', 03:18:23 INFO - 'SHLVL': '1', 03:18:23 INFO - 'TERM': 'linux', 03:18:23 INFO - 'TMOUT': '86400', 03:18:23 INFO - 'USER': 'cltbld', 03:18:23 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1477555582.684912-970778831', 03:18:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:23 INFO - '_': '/tools/buildbot/bin/python'} 03:18:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:18:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:18:23 INFO - Cleaning up... 03:18:23 INFO - Return code: 0 03:18:23 INFO - Running post-action listener: _resource_record_post_action 03:18:23 INFO - Running post-action listener: _start_resource_monitoring 03:18:23 INFO - Starting resource monitoring. 03:18:23 INFO - [mozharness: 2016-10-27 10:18:23.432849Z] Finished create-virtualenv step (success) 03:18:23 INFO - [mozharness: 2016-10-27 10:18:23.433350Z] Running install step. 03:18:23 INFO - Running pre-action listener: _resource_record_pre_action 03:18:23 INFO - Running main action method: install 03:18:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:18:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:18:23 INFO - Reading from file tmpfile_stdout 03:18:23 INFO - Detecting whether we're running mozinstall >=1.0... 03:18:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:18:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:18:23 INFO - Reading from file tmpfile_stdout 03:18:23 INFO - Output received: 03:18:23 INFO - Usage: mozinstall [options] installer 03:18:23 INFO - Options: 03:18:23 INFO - -h, --help show this help message and exit 03:18:23 INFO - -d DEST, --destination=DEST 03:18:23 INFO - Directory to install application into. [default: 03:18:23 INFO - "/builds/slave/test"] 03:18:23 INFO - --app=APP Application being installed. [default: firefox] 03:18:23 INFO - mkdir: /builds/slave/test/build/application 03:18:23 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'] 03:18:23 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 03:18:41 INFO - Reading from file tmpfile_stdout 03:18:41 INFO - Output received: 03:18:41 INFO - /builds/slave/test/build/application/firefox/firefox 03:18:41 INFO - Running post-action listener: _resource_record_post_action 03:18:41 INFO - [mozharness: 2016-10-27 10:18:41.994563Z] Finished install step (success) 03:18:41 INFO - [mozharness: 2016-10-27 10:18:41.994808Z] Running run-tests step. 03:18:41 INFO - Running pre-action listener: _resource_record_pre_action 03:18:41 INFO - Running main action method: run_tests 03:18:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:18:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:18:42 INFO - Python 2.7.3 03:18:42 INFO - Return code: 0 03:18:42 INFO - grabbing minidump binary from tooltool 03:18:42 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')]} 03:18:42 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 0x12df930>, '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 0x12e0830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e0cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:18:42 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 03:18:42 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 03:18:42 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 03:18:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:18:42 INFO - Return code: 0 03:18:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:18:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:18:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:18:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:18:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:18:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cxpoRELQSQmBT6o-5fXcvA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:18:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cxpoRELQSQmBT6o-5fXcvA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:18:42 INFO - Using env: {'DISPLAY': ':0', 03:18:42 INFO - 'HOME': '/home/cltbld', 03:18:42 INFO - 'LANG': 'en_US.UTF-8', 03:18:42 INFO - 'LANGUAGE': 'en_US:en', 03:18:42 INFO - 'LOGNAME': 'cltbld', 03:18:42 INFO - 'MAIL': '/var/mail/cltbld', 03:18:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:18:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:18:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:18:42 INFO - 'MOZ_NO_REMOTE': '1', 03:18:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:18:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:18:42 INFO - 'NO_EM_RESTART': '1', 03:18:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:18:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:18:42 INFO - 'PWD': '/builds/slave/test', 03:18:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:18:42 INFO - 'SHELL': '/bin/bash', 03:18:42 INFO - 'SHLVL': '1', 03:18:42 INFO - 'TERM': 'linux', 03:18:42 INFO - 'TMOUT': '86400', 03:18:42 INFO - 'USER': 'cltbld', 03:18:42 INFO - 'XDG_SESSION_COOKIE': '745a4373a2a16df560f216e000000264-1477555582.684912-970778831', 03:18:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:18:42 INFO - '_': '/tools/buildbot/bin/python'} 03:18:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cxpoRELQSQmBT6o-5fXcvA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:18:42 INFO - mozversion application_buildid: 20161026135410 03:18:42 INFO - mozversion application_changeset: 45052ddb03a448606ca6ce33f4893a559edebf72 03:18:42 INFO - mozversion application_display_name: Nightly 03:18:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:18:42 INFO - mozversion application_name: Firefox 03:18:42 INFO - mozversion application_remotingname: firefox 03:18:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:18:42 INFO - mozversion application_vendor: Mozilla 03:18:42 INFO - mozversion application_version: 52.0a1 03:18:42 INFO - mozversion platform_buildid: 20161026135410 03:18:42 INFO - mozversion platform_changeset: 45052ddb03a448606ca6ce33f4893a559edebf72 03:18:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:18:42 INFO - mozversion platform_version: 52.0a1 03:18:42 INFO - using testdate: 1477563522 03:18:42 INFO - actual date: 1477563522 03:18:42 INFO - starting webserver on 'localhost:48636' 03:18:42 INFO - SUITE-START | Running 2 tests 03:18:42 INFO - TEST-START | dromaeo_css 03:18:42 INFO - operating with platform_type : linux_ 03:18:42 INFO - Initialising browser for dromaeo_css test... 03:18:42 INFO - TEST-INFO | started process 4948 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDjKdNq/profile http://localhost:48636/getInfo.html) 03:18:53 INFO - PROCESS | 4948 | __metrics Screen width/height:1600/1200 03:18:53 INFO - PROCESS | 4948 | colorDepth:24 03:18:53 INFO - PROCESS | 4948 | Browser inner width/height: 1024/697 03:18:53 INFO - PROCESS | 4948 | __metrics 03:18:54 ERROR - PROCESS | 4948 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 03:18:55 INFO - TEST-INFO | 4948: exit 0 03:18:55 INFO - Browser initialized. 03:18:55 INFO - Running cycle 1/1 for dromaeo_css test... 03:18:55 INFO - TEST-INFO | started process 5073 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDjKdNq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:19:07 INFO - PROCESS | 5073 | RSS: Main: 186101760 03:19:07 INFO - PROCESS | 5073 | 03:19:56 INFO - PROCESS | 5073 | 1477563596927 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] 03:22:07 INFO - PROCESS | 5073 | Cycle 1(1): loaded http://localhost:48636/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48636/tests/dromaeo/cssquery-ext.html) 03:22:08 INFO - PROCESS | 5073 | RSS: Main: 202141696 03:22:08 INFO - PROCESS | 5073 | 03:25:11 INFO - PROCESS | 5073 | Cycle 1(1): loaded http://localhost:48636/tests/dromaeo/cssquery-ext.html (next: http://localhost:48636/tests/dromaeo/cssquery-jquery.html) 03:25:11 INFO - PROCESS | 5073 | RSS: Main: 203169792 03:25:11 INFO - PROCESS | 5073 | 03:28:13 INFO - PROCESS | 5073 | Cycle 1(1): loaded http://localhost:48636/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48636/tests/dromaeo/cssquery-mootools.html) 03:28:14 INFO - PROCESS | 5073 | RSS: Main: 204443648 03:28:14 INFO - PROCESS | 5073 | 03:31:16 INFO - PROCESS | 5073 | Cycle 1(1): loaded http://localhost:48636/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48636/tests/dromaeo/cssquery-prototype.html) 03:31:16 INFO - PROCESS | 5073 | RSS: Main: 197750784 03:31:16 INFO - PROCESS | 5073 | 03:34:19 INFO - PROCESS | 5073 | Cycle 1(1): loaded http://localhost:48636/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48636/tests/dromaeo/cssquery-yui.html) 03:34:20 INFO - PROCESS | 5073 | RSS: Main: 200884224 03:34:20 INFO - PROCESS | 5073 | 03:37:22 INFO - PROCESS | 5073 | Cycle 1(1): loaded http://localhost:48636/tests/dromaeo/cssquery-yui.html (next: http://localhost:48636/tests/dromaeo/cssquery-dojo.html) 03:37:23 INFO - PROCESS | 5073 | RSS: Main: 198578176 03:37:23 INFO - PROCESS | 5073 | 03:37:23 INFO - PROCESS | 5073 | __start_tp_report 03:37:23 INFO - PROCESS | 5073 | _x_x_mozilla_page_load 03:37:23 INFO - PROCESS | 5073 | _x_x_mozilla_page_load_details 03:37:23 INFO - PROCESS | 5073 | |i|pagename|runs| 03:37:23 INFO - PROCESS | 5073 | |0;dojo.html;3064.2952121012154;3064.34116664917;3068.7084726950934;3096.9690303096963;3103.6120484939383;5129.384473863132;5215.139501982173;5250.224752771949;5307.230451584518;5356.223347614594;5169.1987741899975;5189.792408303663;5243.187305967572;5267.051930652481;5312.840614781563;4738.4313882334;4789.2816077588295;4826.227803551433;4827.806887724487;4865.927011094819;4773.06925149596;4842.685225460352;4874.902501949959;4877.219644856824;4894.608431325503;4823.20417131173;4827.155247831651;4872.926906096412;4887.755612219393;4934.1611925972675;4712.269598212282;4724.480307166209;4748.121597504472;4766.642501812344;4806.086843499724;4706.10583989041;4722;4731.976340118277;4740.5733483986605;4816.927746083811;5215.713135777531;5217.060929032773;5261.237120617489;5273.182656688219;5276.366835979668;5511;5571.832845014656;5595.860103497404;5613.607047506676;5629.6340737852315;5616;5646.887062258773;5655.4344565543115;5662.462066103713;5689.772409103631;5106.744662766847;5248.396434410053;5267.288915996368;5268.145724432335;5324.92012619811;5629.605927585111;5670.177824215466;5673.659580425187;5692.715364231772;5771.047777116729;5499.532539734168;5502.449755024466;5509.063459211943;5515.145152501288;5515.338159420815;5504.146857237135;5510.9448905511235;5551.056320425538;5551.444855514416;5629.943700563023;5283.286756287852;5418.701971391532;5552.139418390156;5605.887882242332;5609.635373700697;5608.495235428831;5620.213170156181;5636.60543761941;5648.915266271009;5669.603127781098;4294.441722576045;4313.654907607384;4328.11273688893;4351.5430879757805;4366.912661746811;3764.4541541476333;3811;3826.904327391782;3852.5376954765047;3923.489946306962;5363.329583802025;5385.434529374437;5410.188471729272;5464.508194262536;5491.7254137292975;5654.745536450787;5654.9151762723595;5655.321361436654;5665.858353541194;5684.289463817023;5283.894322113613;5359.5712343012465;5368.3826359968325;5371.301730775052;5475.260839786658;4867.488913664014;4902.093112774077;4904.828331008469;4927.310176575283;4938.802447902115;5762.366139724543;5803.448672376117;5803.709814509342;5811.6513009220425;5824.504917082011;5425.538829199562;5455.399906010256;5640.435956404327;5661.490465858093;5715.628484148517;5625.156226566048;5685.886282274414;5689.203511508309;5711.942880571307;5754.68349240779;5498.560115190855;5506.256655351636;5507.03626865289;5514.062609356339;5515.751791169488;5498.532624726943;5533.889322213614;5585.106382978704;5590.8043218487155;5642.435756424325;5422.5119739223655;5444.156155795858;5460.290162278879;5514.503694667499;5562.054450743464;5489.423610520837;5523.972380138073;5529.889402211853;5530.778768849201;5547.972260138835;5259.526642602184;5266.368035835571;5473.589480788877;5515.062439385234;5519.199716041071;5484;5537.972310138423;5562.2212890196215;5570.108782594765;5609.4390560943575;5391.16436952273;5410.404855465817;5416.4041955385665;5420.430854760351;5424.701641409761 03:37:23 INFO - PROCESS | 5073 | |1;ext.html;565.7341049706639;567.2172402085122;578.3378032153183;579.7767859374143;580.2833500626728;38993.61006389935;40682.796586017066;40841.387379189335;45486.31770523445;45708.085838283216;43191.136177276436;43430.78284608581;43447.78276108623;43546.56453435465;43662.78168609161;8667.003294621121;8792.780180495507;8804.559772011406;8843.204111629952;8868.15752503511;8730.825383492327;8778.824423511525;8786.077461866507;8823.558822058903;8826.07326230743;8843.646254149826;8879.644814207424;8884.511351875644;8892.066333035034;8938.553072346389;8772.12278772124;8797.428167169177;8820.514871682055;8828.514431706253;8845.778855528599;8787.340949428819;8799.076097009785;8862.86705699415;8866.379353445262;8869.645214191425;40773.184536309105;40822.38766418506;40953.1809363814;41105.79447102775;41302.38046429306;3229.1442767666585;3244.4160051190775;3411.9317613647836;3520.77114987525;3635.963640363589;30934.38131237385;31025;31165.844170779226;31233.37533249345;32576.02271931846;3872.825722842451;3921.901952451183;3959.208158368338;4101.815418306153;4232.238197124517;319242;321477;322898;323015;323977.9999999977;53975;54529.727351363785;54543.72728136334;54601.45398546043;54743.72628136834;57065.14402283969;57123.14315285274;57132;57231;57416.42583574111;13485.66285842842;13548.254845983565;13568.118072325464;13618.93190534041;13633;10257.640982565574;10278.280520363503;10294.691159265085;10338.948305258426;10378.636747713794;14994;14998.200215974153;15086.321115549827;15243.314050867737;15452.845471545366;5577.972110139423;5854.8536286592325;5918.803845923239;5992.250968628921;6157.507399408037;879.7404765594038;965.2953344058736;986.2405947420447;989.7426669066094;1016.7356487313203;31533.8423307882;31612.525812112835;31822.36355272928;31898;31937.52093718596;950.8906475755239;1014.5383850348074;1057.7258893379142;1075.2580719303812;1099.3294090604725;14754.336054877556;16261.105639189958;16282.10448425348;16361.83638163603;16715.832841671672;480829;481783;482729;483059;483396;54800.45199548033;55284;55472.44527554673;56120;56177;1275.5663074554695;1299.857015728269;1326.2374134872487;1334.5796074236584;1335.0321017262602;29049.7095029047;30479.238019049702;30855.2286192838;30935;31310.686893130776;47719;47782.76108619435;48038.759806200746;48205.27692084692;48547.75726121488;402703;405260;405706;405991;406088;25762.87118564395;26965.460690785683;27003.1899043029;28629.713702862704;38773.41839872348;45221;46310.30534542052;46557.76721116373;47019;47537.286940696606;38196.42705359366;39159.517667527136;39169;40176.598234017285;40644.39033414442;38792.80603596964;39468.21063578655;40413.79793101016;40574.91366881497;40897.38653920134;38996;39053.41419878761;39547.80226098851;39866;40165.1966960665;33109.17227069342;35098.29803403969;35222.47166292559;35349.09729988808;35398.823005884806;26839.463210736067;27082.458350833265;27233.31916702098;27416.177514674593;27499.86250068737 03:37:23 INFO - PROCESS | 5073 | |2;jquery.html;399.07215723443005;403.6568916421041;405.9228746538158;408.3874188716925;417.157342168819;14317.498887538939;17677.469675909728;18444.815551844476;19305.903470482644;19341.99999999998;18693.34573289935;18920.71618925717;19409.32067377642;19552.41342759716;20015.1993920243;5676.716164191795;5713.428657134295;5870.412958704138;5903.4686878180955;5916.2900451945825;5763.049096899028;5785.971070144644;5819.127130930373;5842.853928651796;5846.619969701956;5671.8014869479575;5841.85395365115;5858;5874.089516124986;5875.735591898353;5747.6551406915305;5797.217375654275;5832.883342333151;5836.824895253149;5849.473547380735;5136.768845401929;5209.843704688866;5215;5234.18870075139;5241.580673546107;22250.55498890013;22895.084196632113;22984.42538936523;23208.921279009894;23596.410089747722;2259.6836442898007;2300.5168914527967;2342.847714898526;2389.689340385756;2400.327908185711;14468.421263149461;14597.124172549575;14668.926655366762;14941;15448.845511544852;1893.1480833624923;1963.5091227193202;1969.3796454116907;1988.7514060742408;1993.2196629773628;80078.59960700218;80939.5953020237;81215;82019.17980820175;83419.5829020857;10487.423191724529;10551;10795.29830561011;10987.285826421257;11270.718232044264;12482.940314847949;15509;15557.766633500507;15594.766078508832;15606.3757449703;6814.727410903508;6883.27725588816;7078.3365909011345;7089.22018577956;7096.432285417154;6482.481401487964;6577.408033277028;6696.5647232929705;6722.630255336004;6744.662766861736;4093.4473846030405;4100.507939047334;4203.495580530294;4272;4316.158349121891;1980.6731889238115;2032.3191730770357;2043.8262747666317;2081.885496297718;2088.968665470019;853.7481442974338;898.8966268879032;916.6104405627582;962.0812124421161;1004.6734811186247;17754.201060952288;18717.438476845717;19324.71012934807;19621.411357659006;20134.69797953032;959.7264779537799;984.2962281968283;991.5389343955095;1020.6019652335596;1021.4075836015094;8929.910700892908;10866.402347870784;11007.889921100847;11186.496607652674;11189.832152517718;451395.91624502634;451758;452147;463853;468002;59080.704596477604;59837.700811496536;60747.08879366813;94591;97306.59254963897;1000.9549570269355;1001.7195185348114;1028.9639862604772;1033.18894667687;1034.6740776655329;17365.30538778435;17533.635620307636;18134.72797908006;18268.81731182671;18317.633647327246;38010.72822984287;43726.562734373525;43922.34116488192;44016.339754904344;44944.55055449534;48180;57015.714921425126;57105.714471427375;57557.424425755205;58941.410585893595;8163.469374490639;8359.205875441823;8359.958200209203;8503.447275927045;8582.527960962207;12128.272303661808;12834.294113823456;12975.416106275428;13010.739785204432;13348.26584537821;10416.1667066636;10706.357618542912;10747.677569672922;10843.403612801372;11409.087273018305;10946.124310055337;11341;11408.600698975495;11548.48031838586;12023.81964270554;11045.33727976324;11370.886291136983;11398.886011139783;11489;11735.295882247092;8379.622916968872;8510.574471276535;8589.269912057294;8712.390132690904;8807.427517211361;10862.131029517777;11388.430578470878;11428.14288928317;11567;11831.461909951651 03:37:23 INFO - PROCESS | 5073 | |3;mootools.html;1485.3093311610103;1489.1511838252197;1649.752537119432;1733.9739903901436;1745.397837745978;7667.84664306715;7941.364690824735;8369.832603347937;9321.254299656028;9338.953305233474;8786.912130878689;9041.3671043027;9049.502277374742;9369.71890843274;9375.624975001008;2333.4049817296564;2360.0205914545445;2370.3126093432884;2378.203301893868;2383.3922349800864;2271.636538153896;2299.793018628323;2305.101010605865;2318.084356679111;2328.511012687329;2230.3309007297826;2234.8994295256753;2248.651459023854;2270.6594010898334;2271.806896413807;2230.509287956647;2246.640537513998;2247.831412644058;2248.4378905273684;2252.650839119931;2207.3377986603955;2212.723409573803;2216.8115710164657;2220.877851718155;2226.743924448677;9136.6802161924;9237.445753254826;9281.58232879522;9309.906900930971;9310.162085412278;5183.144781111112;5235.895282094337;5287.286216360781;5293.655912365684;5314.5748340132695;3291.8683252670103;3366.192113892648;3502.877399291013;3505.6669616386403;3523.260115375774;1048.2871647279846;1050.2175878970215;1064.627380416848;1070.7002039428894;1085.5332207150923;12043.397830108459;12255.325957072357;12281.447334869952;12410.945069668998;12499.250044997238;4647.117047760915;4713.552212539803;4746.116746392637;4797.544233297831;4948.1835497142565;10620.415877126678;10695.304805187638;10755.677329680122;10768.676939691823;10781.9460902695;5378.058839703036;5445.074337362658;5460.426655201226;5462.8361149165585;5486.231927530149;4257.1698518788535;4401.867943961686;4831.492693267156;4940.654154209171;4982.2775697524385;3838.4242363645117;3982.761034337949;4049.6760259179196;4052.338541198095;4059.715819892579;1332.880380480401;1343.234356416833;1345.9730805383838;1350.46656570656;1356.0168877563885;728.2535401213693;740.6741033945046;756.9432292578078;918.1782304837134;938.3384713776771;5708.914366284509;5867.002609556385;5884.077997087301;5905.202797622266;6098.664573448415;438.88588966868207;450.1919055295752;454.46146316614914;459.31561972660495;461.82681494439584;3879.2629400414394;3923.352646813244;3982.7411218270718;4016.578259282792;4393.077453734688;11224.887751122384;11581.710457238469;11626.825597616042;11630.592929247605;11636.825447618123;11404.543818247177;11590.478428470571;11631.185816992729;11664.88335116638;11692.356920369291;8424.4945303282;8606.483610983361;8681.522516261666;8701.17338852808;8709.433886797338;5913.2608423947;5958.314793798769;5990.760369585168;6041.939580604314;6199.442050215503;10343.431111288952;10358.498017787228;10417.895821041693;10446.895531044896;10495.422751748727;10628.309159904582;10720.24958252946;10758.569657213624;10779.622713205;10820.404877731486;7103.751368702277;7402;7727.227277272228;8174.509529428254;8278.048024477263;8243.340532757245;8659.307255419426;8680.696175633822;8705.695300664447;8708.085651006553;7431.665575049027;7572.697092116254;7929.484583502054;8143.389245806469;8163.102058773411;7297.16082650502;7462.291082347168;7473.775786726407;7578.3179513841815;7710.4217183710325;6657.900131498128;6757.560758550679;6804.353586409283;6809.38715515606;6811.489138314745;4718.622510199107;4887.43794463627;4916.237983112624;4940.456549779449;4976.726280054631;4929.112759703288;5027.32131162303;5051.823186188466;5074.11203039474;5169.198774190007 03:37:23 INFO - PROCESS | 5073 | |4;prototype.html;334.57007745047616;337.59151426773604;342.71554609673973;345.32833638572987;348.99476507852404;5270.420253772087;5338.572914166867;5351.678899266047;5375.999999999995;5377.0321342158395;5249.238860365244;5307.548858347035;5312.432832314466;5325.227841962913;5330.387005494369;4025.9798701006525;4125.21620892031;4201.789910504463;4211.073563815956;4222.324428091506;4215.578442155791;4221.6833737469815;4227.873163805076;4256.553061928499;4261.062566235423;4234.470691163605;4236.555161708023;4240.3851441540955;4243.554426785189;4257.446531950842;3929.528456585214;4119.423280740699;4139.275626765304;4151.4395556599775;4244.580589064235;3663.7252206084386;3686.870959516431;3687.778733276012;3695.9630403695887;3703.407534760052;5184.507471790174;5205.505476979681;5243.134882744343;5246.239295302198;5250.238715386247;4565.840195593171;4718.976405117986;4750.596199323062;4774.689645173053;4786.904261914777;5498.257735205736;5529.944700553024;5531.889362212773;5533.667979921218;5535.723213839332;4010.578889216649;4014.9397759033636;4020.43713880057;4026.255142798592;4031.6169963853386;5682.914756278659;5798.188253644451;5833.591648584558;5855.970720146414;5949.167116603679;4119.887630339851;4140.3375459926265;4145.97927010363;4149.543550209535;4154.626083652486;4201.7899105045235;4220.388043733641;4220.451341325608;4220.915581688349;4223.282042052859;4704.9529504704515;4729.69256998294;4785.569298763058;4823.493533179036;4861.80552777892;5668.489835914705;5676.290463692038;5680.744366503434;5714.714264286769;5762.279715035621;1452.012631410651;1468.8689708924069;1469.1478942213491;1470.4632809024843;1470.9411623535152;905.5395142309491;947.6114792934864;961.1974001708652;965.3339195954769;998.2032341784758;5504.6421982571;5516.475934786189;5535.474129957647;5557.722113894289;5564;5760.8271751847515;5796.82609521715;5829.446202610745;5851;5854.941450585525;5380.91928621071;5437.864053398617;5492.340919089735;5493.7802487900035;5523.6685798852195;3069.9101818853987;3081.229692576856;3085.8148511089407;3089.3203495231014;3100.550420189105;5636.718164091779;5911.940880591139;5918.526517878559;5933.169356290123;5957.642541447527;5822.446867547661;5869.970650146722;5886.911696324559;5910.876933382644;5926.547995740985;5944.613600116065;5953.970230148821;5955.851103722268;5977.1333156692035;6005.369436209223;5573.219749235192;5756.56825738063;5812;5848.473637372486;5849.473547380756;5756.769729210952;5757.712114394348;5762.164486149569;5795.565332600157;5800.59395842287;5910.551914780906;5938.257717785277;5983.162357270073;6022.698865056642;6086.330503644507;4197.391378250198;4265.97867010663;4279.379489973999;4289.420928174656;4297.269464191158;5889.146073819186;5891.440313170242;5892.1161825726485;5898.908701889993;5912.674802885883;5523.585731070266;5649.5028817364255;5663.065594176915;5766.308043034863;5775.711214439345;5581.888362232651;5655.377908429987;5658.094704847204;5679.176519404746;5691.3170419549915;5433.804562996134;5635.830925072254;5670.858228544319;5673.574481913791;5680.68756218412;5395.271638328775;5622.70677744113;5624.831255062355;5701.831124619526;5712.629548566366;5559.388467268516;5596.216529685928;5626.690532020614;5630.408807075198;5642.407547207648 03:37:23 INFO - PROCESS | 5073 | |5;yui.html;673.7035704290113;675.2976904019816;723.3309189000173;736.2674139231466;806.0891192951964;15544.76682849758;16539.338426462957;16554.83445165548;16559.586010349733;16595;15174.317155727991;15325.08049517027;15327.92336038321;15351.616209594766;15353.616159596017;750.2534977697171;767.2557619109483;793.238491048594;795.6538905576064;798.656577671601;783.6669415498419;785.2775446589123;792.2473650032492;794.364508393286;795.2723258218723;818.8116733151379;822.2106777493614;825.6243409248777;826.8801023851538;829.6391069884589;817.5380909785952;819.6393586821779;827.3298628111219;827.6358402302998;827.871679889615;588.153059594183;593.6230493636572;597.1669521018156;598.8233471125985;601.2034054877262;14091.577252682333;14132.646683832883;14164.716705665829;14176.149431034171;14218;13503.189808611416;14010;14168.787468187882;14258.714825703428;15075.131367719883;11970.880291197063;12110.576129835501;12175.756484870253;12269.202501837352;12359.443825027805;3726.981365093184;3779.9622003779887;3838.1939792643298;3920.980395098035;4021.698372622036;63612.36387636111;75440.62279688621;75859.62070189614;77789.61105194494;79454;11266.493007814668;11430.428478576037;11612.593559225386;11775.88224117765;11788.764224715458;21261.36215913525;21301;21309.25417610376;21366.57266854654;21390.251341202984;7426.331630153312;7551.5846628434865;8100.392470564731;8101.594920253964;8255.545944972964;4103.569125241806;4171.853985110567;4186.162767446523;4369.519352871182;4418.690691651554;3369.3935091683243;3475.565554305712;3505.8422370993367;3516;3520.3487354839435;638.2468686949352;640.0814830717935;642.2966851297915;657.763205246111;661.6063442251852;589.345826132992;611.7247238742584;653.8496145886472;664.3987191591617;667.2693400726197;8533.317334613215;9367.437953722798;9491.477968711788;9557;9592.808143837225;618.1006635345561;648.3710800523485;649.8367921420698;662.6752891083335;712.2877122877123;5052.646314758005;5132.255822905658;5164.406093299319;5493.340799104053;5663.66018038919;98502;112495;116361;117008;119721.40139299248;96609;97208;97774.51112744391;100014;100478.4976075115;84305.57847210724;87264.56367718121;89581.55209223912;91175;93500.68982064712;10011.349262297927;10014.39913605186;10218.262320900561;10359.689209323733;10377.273590848568;49791.51459397807;50599.735006623654;51244.487555123975;51573;51777;65557;75765.24234757802;78580.60709696414;79372.20627793648;80152.59923700344;12185.573504927284;12550.560730374393;12875.227486350848;13217.206967581977;13444.596662100153;13726;13865.376058077612;13945.58163255104;14710.338034788247;15276;12476.438560264629;13367.933160334136;13708.383122759698;14063.859361406665;14390.640233993816;13538.918041601419;14039.649008774863;14358.263159995227;14588.343524541633;15021.324040418425;13057.934710326388;13134.146280491737;13144.539941102397;13302.733945321233;13535.187888726708;11258.943705281748;11513.884861151617;11973.161878668758;12047.397630118283;12061.336626485276;10508.527116279633;11232.269902456314;12255.571055013032;12257.387130643254;12460.501579937063 03:37:23 INFO - PROCESS | 5073 | __end_tp_report 03:37:23 INFO - PROCESS | 5073 | __start_cc_report 03:37:23 INFO - PROCESS | 5073 | _x_x_mozilla_cycle_collect,318 03:37:23 INFO - PROCESS | 5073 | __end_cc_report 03:37:23 INFO - PROCESS | 5073 | __startTimestamp1477564643054__endTimestamp 03:37:23 INFO - PROCESS | 5073 | 03:37:23 INFO - PROCESS | 5073 | ------- Summary: start ------- 03:37:23 INFO - PROCESS | 5073 | Number of tests: 6 03:37:23 INFO - PROCESS | 5073 | 03:37:23 INFO - PROCESS | 5073 | [#0] dojo.html Cycles:165 Average:5220.07 Median:5425.54 stddev:574.76 (10.6%) stddev-sans-first:551.08 03:37:23 INFO - PROCESS | 5073 | Values: 3064.3 3064.3 3068.7 3097.0 3103.6 5129.4 5215.1 5250.2 5307.2 5356.2 5169.2 5189.8 5243.2 5267.1 5312.8 4738.4 4789.3 4826.2 4827.8 4865.9 4773.1 4842.7 4874.9 4877.2 4894.6 4823.2 4827.2 4872.9 4887.8 4934.2 4712.3 4724.5 4748.1 4766.6 4806.1 4706.1 4722.0 4732.0 4740.6 4816.9 5215.7 5217.1 5261.2 5273.2 5276.4 5511.0 5571.8 5595.9 5613.6 5629.6 5616.0 5646.9 5655.4 5662.5 5689.8 5106.7 5248.4 5267.3 5268.1 5324.9 5629.6 5670.2 5673.7 5692.7 5771.0 5499.5 5502.4 5509.1 5515.1 5515.3 5504.1 5510.9 5551.1 5551.4 5629.9 5283.3 5418.7 5552.1 5605.9 5609.6 5608.5 5620.2 5636.6 5648.9 5669.6 4294.4 4313.7 4328.1 4351.5 4366.9 3764.5 3811.0 3826.9 3852.5 3923.5 5363.3 5385.4 5410.2 5464.5 5491.7 5654.7 5654.9 5655.3 5665.9 5684.3 5283.9 5359.6 5368.4 5371.3 5475.3 4867.5 4902.1 4904.8 4927.3 4938.8 5762.4 5803.4 5803.7 5811.7 5824.5 5425.5 5455.4 5640.4 5661.5 5715.6 5625.2 5685.9 5689.2 5711.9 5754.7 5498.6 5506.3 5507.0 5514.1 5515.8 5498.5 5533.9 5585.1 5590.8 5642.4 5422.5 5444.2 5460.3 5514.5 5562.1 5489.4 5524.0 5529.9 5530.8 5548.0 5259.5 5266.4 5473.6 5515.1 5519.2 5484.0 5538.0 5562.2 5570.1 5609.4 5391.2 5410.4 5416.4 5420.4 5424.7 03:37:23 INFO - PROCESS | 5073 | 03:37:23 INFO - PROCESS | 5073 | [#1] ext.html Cycles:180 Average:56080.01 Median:406039.50 stddev:108089.93 (26.6%) stddev-sans-first:108312.78 03:37:23 INFO - PROCESS | 5073 | Values: 565.7 567.2 578.3 579.8 580.3 38993.6 40682.8 40841.4 45486.3 45708.1 43191.1 43430.8 43447.8 43546.6 43662.8 8667.0 8792.8 8804.6 8843.2 8868.2 8730.8 8778.8 8786.1 8823.6 8826.1 8843.6 8879.6 8884.5 8892.1 8938.6 8772.1 8797.4 8820.5 8828.5 8845.8 8787.3 8799.1 8862.9 8866.4 8869.6 40773.2 40822.4 40953.2 41105.8 41302.4 3229.1 3244.4 3411.9 3520.8 3636.0 30934.4 31025.0 31165.8 31233.4 32576.0 3872.8 3921.9 3959.2 4101.8 4232.2 319242.0 321477.0 322898.0 323015.0 323978.0 53975.0 54529.7 54543.7 54601.5 54743.7 57065.1 57123.1 57132.0 57231.0 57416.4 13485.7 13548.3 13568.1 13618.9 13633.0 10257.6 10278.3 10294.7 10338.9 10378.6 14994.0 14998.2 15086.3 15243.3 15452.8 5578.0 5854.9 5918.8 5992.3 6157.5 879.7 965.3 986.2 989.7 1016.7 31533.8 31612.5 31822.4 31898.0 31937.5 950.9 1014.5 1057.7 1075.3 1099.3 14754.3 16261.1 16282.1 16361.8 16715.8 480829.0 481783.0 482729.0 483059.0 483396.0 54800.5 55284.0 55472.4 56120.0 56177.0 1275.6 1299.9 1326.2 1334.6 1335.0 29049.7 30479.2 30855.2 30935.0 31310.7 47719.0 47782.8 48038.8 48205.3 48547.8 402703.0 405260.0 405706.0 405991.0 406088.0 25762.9 26965.5 27003.2 28629.7 38773.4 45221.0 46310.3 46557.8 47019.0 47537.3 38196.4 39159.5 39169.0 40176.6 40644.4 38792.8 39468.2 40413.8 40574.9 40897.4 38996.0 39053.4 39547.8 39866.0 40165.2 33109.2 35098.3 35222.5 35349.1 35398.8 26839.5 27082.5 27233.3 27416.2 27499.9 03:37:23 INFO - PROCESS | 5073 | 03:37:23 INFO - PROCESS | 5073 | [#2] jquery.html Cycles:180 Average:27536.26 Median:2395.01 stddev:75329.57 (3145.3%) stddev-sans-first:75513.33 03:37:23 INFO - PROCESS | 5073 | Values: 399.1 403.7 405.9 408.4 417.2 14317.5 17677.5 18444.8 19305.9 19342.0 18693.3 18920.7 19409.3 19552.4 20015.2 5676.7 5713.4 5870.4 5903.5 5916.3 5763.0 5786.0 5819.1 5842.9 5846.6 5671.8 5841.9 5858.0 5874.1 5875.7 5747.7 5797.2 5832.9 5836.8 5849.5 5136.8 5209.8 5215.0 5234.2 5241.6 22250.6 22895.1 22984.4 23208.9 23596.4 2259.7 2300.5 2342.8 2389.7 2400.3 14468.4 14597.1 14668.9 14941.0 15448.8 1893.1 1963.5 1969.4 1988.8 1993.2 80078.6 80939.6 81215.0 82019.2 83419.6 10487.4 10551.0 10795.3 10987.3 11270.7 12482.9 15509.0 15557.8 15594.8 15606.4 6814.7 6883.3 7078.3 7089.2 7096.4 6482.5 6577.4 6696.6 6722.6 6744.7 4093.4 4100.5 4203.5 4272.0 4316.2 1980.7 2032.3 2043.8 2081.9 2089.0 853.7 898.9 916.6 962.1 1004.7 17754.2 18717.4 19324.7 19621.4 20134.7 959.7 984.3 991.5 1020.6 1021.4 8929.9 10866.4 11007.9 11186.5 11189.8 451395.9 451758.0 452147.0 463853.0 468002.0 59080.7 59837.7 60747.1 94591.0 97306.6 1001.0 1001.7 1029.0 1033.2 1034.7 17365.3 17533.6 18134.7 18268.8 18317.6 38010.7 43726.6 43922.3 44016.3 44944.6 48180.0 57015.7 57105.7 57557.4 58941.4 8163.5 8359.2 8360.0 8503.4 8582.5 12128.3 12834.3 12975.4 13010.7 13348.3 10416.2 10706.4 10747.7 10843.4 11409.1 10946.1 11341.0 11408.6 11548.5 12023.8 11045.3 11370.9 11398.9 11489.0 11735.3 8379.6 8510.6 8589.3 8712.4 8807.4 10862.1 11388.4 11428.1 11567.0 11831.5 03:37:23 INFO - PROCESS | 5073 | 03:37:23 INFO - PROCESS | 5073 | [#3] mootools.html Cycles:180 Average:5874.26 Median:460.57 stddev:3462.01 (751.7%) stddev-sans-first:3456.01 03:37:23 INFO - PROCESS | 5073 | Values: 1485.3 1489.2 1649.8 1734.0 1745.4 7667.8 7941.4 8369.8 9321.3 9339.0 8786.9 9041.4 9049.5 9369.7 9375.6 2333.4 2360.0 2370.3 2378.2 2383.4 2271.6 2299.8 2305.1 2318.1 2328.5 2230.3 2234.9 2248.7 2270.7 2271.8 2230.5 2246.6 2247.8 2248.4 2252.7 2207.3 2212.7 2216.8 2220.9 2226.7 9136.7 9237.4 9281.6 9309.9 9310.2 5183.1 5235.9 5287.3 5293.7 5314.6 3291.9 3366.2 3502.9 3505.7 3523.3 1048.3 1050.2 1064.6 1070.7 1085.5 12043.4 12255.3 12281.4 12410.9 12499.3 4647.1 4713.6 4746.1 4797.5 4948.2 10620.4 10695.3 10755.7 10768.7 10781.9 5378.1 5445.1 5460.4 5462.8 5486.2 4257.2 4401.9 4831.5 4940.7 4982.3 3838.4 3982.8 4049.7 4052.3 4059.7 1332.9 1343.2 1346.0 1350.5 1356.0 728.3 740.7 756.9 918.2 938.3 5708.9 5867.0 5884.1 5905.2 6098.7 438.9 450.2 454.5 459.3 461.8 3879.3 3923.4 3982.7 4016.6 4393.1 11224.9 11581.7 11626.8 11630.6 11636.8 11404.5 11590.5 11631.2 11664.9 11692.4 8424.5 8606.5 8681.5 8701.2 8709.4 5913.3 5958.3 5990.8 6041.9 6199.4 10343.4 10358.5 10417.9 10446.9 10495.4 10628.3 10720.2 10758.6 10779.6 10820.4 7103.8 7402.0 7727.2 8174.5 8278.0 8243.3 8659.3 8680.7 8705.7 8708.1 7431.7 7572.7 7929.5 8143.4 8163.1 7297.2 7462.3 7473.8 7578.3 7710.4 6657.9 6757.6 6804.4 6809.4 6811.5 4718.6 4887.4 4916.2 4940.5 4976.7 4929.1 5027.3 5051.8 5074.1 5169.2 03:37:23 INFO - PROCESS | 5073 | 03:37:23 INFO - PROCESS | 5073 | [#4] prototype.html Cycles:180 Average:4763.90 Median:5496.02 stddev:1398.27 (25.4%) stddev-sans-first:1362.10 03:37:23 INFO - PROCESS | 5073 | Values: 334.6 337.6 342.7 345.3 349.0 5270.4 5338.6 5351.7 5376.0 5377.0 5249.2 5307.5 5312.4 5325.2 5330.4 4026.0 4125.2 4201.8 4211.1 4222.3 4215.6 4221.7 4227.9 4256.6 4261.1 4234.5 4236.6 4240.4 4243.6 4257.4 3929.5 4119.4 4139.3 4151.4 4244.6 3663.7 3686.9 3687.8 3696.0 3703.4 5184.5 5205.5 5243.1 5246.2 5250.2 4565.8 4719.0 4750.6 4774.7 4786.9 5498.3 5529.9 5531.9 5533.7 5535.7 4010.6 4014.9 4020.4 4026.3 4031.6 5682.9 5798.2 5833.6 5856.0 5949.2 4119.9 4140.3 4146.0 4149.5 4154.6 4201.8 4220.4 4220.5 4220.9 4223.3 4705.0 4729.7 4785.6 4823.5 4861.8 5668.5 5676.3 5680.7 5714.7 5762.3 1452.0 1468.9 1469.1 1470.5 1470.9 905.5 947.6 961.2 965.3 998.2 5504.6 5516.5 5535.5 5557.7 5564.0 5760.8 5796.8 5829.4 5851.0 5854.9 5380.9 5437.9 5492.3 5493.8 5523.7 3069.9 3081.2 3085.8 3089.3 3100.6 5636.7 5911.9 5918.5 5933.2 5957.6 5822.4 5870.0 5886.9 5910.9 5926.5 5944.6 5954.0 5955.9 5977.1 6005.4 5573.2 5756.6 5812.0 5848.5 5849.5 5756.8 5757.7 5762.2 5795.6 5800.6 5910.6 5938.3 5983.2 6022.7 6086.3 4197.4 4266.0 4279.4 4289.4 4297.3 5889.1 5891.4 5892.1 5898.9 5912.7 5523.6 5649.5 5663.1 5766.3 5775.7 5581.9 5655.4 5658.1 5679.2 5691.3 5433.8 5635.8 5670.9 5673.6 5680.7 5395.3 5622.7 5624.8 5701.8 5712.6 5559.4 5596.2 5626.7 5630.4 5642.4 03:37:23 INFO - PROCESS | 5073 | 03:37:23 INFO - PROCESS | 5073 | [#5] yui.html Cycles:180 Average:20816.53 Median:4062.63 stddev:29887.68 (735.7%) stddev-sans-first:29933.25 03:37:23 INFO - PROCESS | 5073 | Values: 673.7 675.3 723.3 736.3 806.1 15544.8 16539.3 16554.8 16559.6 16595.0 15174.3 15325.1 15327.9 15351.6 15353.6 750.3 767.3 793.2 795.7 798.7 783.7 785.3 792.2 794.4 795.3 818.8 822.2 825.6 826.9 829.6 817.5 819.6 827.3 827.6 827.9 588.2 593.6 597.2 598.8 601.2 14091.6 14132.6 14164.7 14176.1 14218.0 13503.2 14010.0 14168.8 14258.7 15075.1 11970.9 12110.6 12175.8 12269.2 12359.4 3727.0 3780.0 3838.2 3921.0 4021.7 63612.4 75440.6 75859.6 77789.6 79454.0 11266.5 11430.4 11612.6 11775.9 11788.8 21261.4 21301.0 21309.3 21366.6 21390.3 7426.3 7551.6 8100.4 8101.6 8255.5 4103.6 4171.9 4186.2 4369.5 4418.7 3369.4 3475.6 3505.8 3516.0 3520.3 638.2 640.1 642.3 657.8 661.6 589.3 611.7 653.8 664.4 667.3 8533.3 9367.4 9491.5 9557.0 9592.8 618.1 648.4 649.8 662.7 712.3 5052.6 5132.3 5164.4 5493.3 5663.7 98502.0 112495.0 116361.0 117008.0 119721.4 96609.0 97208.0 97774.5 100014.0 100478.5 84305.6 87264.6 89581.6 91175.0 93500.7 10011.3 10014.4 10218.3 10359.7 10377.3 49791.5 50599.7 51244.5 51573.0 51777.0 65557.0 75765.2 78580.6 79372.2 80152.6 12185.6 12550.6 12875.2 13217.2 13444.6 13726.0 13865.4 13945.6 14710.3 15276.0 12476.4 13367.9 13708.4 14063.9 14390.6 13538.9 14039.6 14358.3 14588.3 15021.3 13057.9 13134.1 13144.5 13302.7 13535.2 11258.9 11513.9 11973.2 12047.4 12061.3 10508.5 11232.3 12255.6 12257.4 12460.5 03:37:23 INFO - PROCESS | 5073 | -------- Summary: end -------- 03:37:23 INFO - PROCESS | 5073 | 03:37:24 INFO - TEST-INFO | 5073: exit 0 03:37:24 INFO - TEST-OK | dromaeo_css | took 1121951ms 03:37:24 INFO - TEST-START | kraken 03:37:24 INFO - operating with platform_type : linux_ 03:37:24 INFO - Initialising browser for kraken test... 03:37:24 INFO - TEST-INFO | started process 5431 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe4ky3Y/profile http://localhost:48636/getInfo.html) 03:37:29 INFO - PROCESS | 5431 | __metrics Screen width/height:1600/1200 03:37:29 INFO - PROCESS | 5431 | colorDepth:24 03:37:29 INFO - PROCESS | 5431 | Browser inner width/height: 1024/697 03:37:29 INFO - PROCESS | 5431 | __metrics 03:37:30 ERROR - PROCESS | 5431 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 03:37:31 INFO - TEST-INFO | 5431: exit 0 03:37:31 INFO - Browser initialized. 03:37:31 INFO - Running cycle 1/1 for kraken test... 03:37:31 INFO - TEST-INFO | started process 5555 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe4ky3Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:37:43 INFO - PROCESS | 5555 | RSS: Main: 185372672 03:37:43 INFO - PROCESS | 5555 | 03:37:46 INFO - PROCESS | 5555 | Cycle 1(1): loaded http://localhost:48636/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48636/tests/kraken/driver.html?testName=audio-beat-detection) 03:37:47 INFO - PROCESS | 5555 | RSS: Main: 199450624 03:37:47 INFO - PROCESS | 5555 | 03:37:49 INFO - PROCESS | 5555 | Cycle 1(1): loaded http://localhost:48636/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48636/tests/kraken/driver.html?testName=audio-dft) 03:37:50 INFO - PROCESS | 5555 | RSS: Main: 196689920 03:37:50 INFO - PROCESS | 5555 | 03:37:53 INFO - PROCESS | 5555 | Cycle 1(1): loaded http://localhost:48636/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48636/tests/kraken/driver.html?testName=audio-fft) 03:37:53 INFO - PROCESS | 5555 | RSS: Main: 192536576 03:37:53 INFO - PROCESS | 5555 | 03:37:56 INFO - PROCESS | 5555 | Cycle 1(1): loaded http://localhost:48636/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48636/tests/kraken/driver.html?testName=audio-oscillator) 03:37:56 INFO - PROCESS | 5555 | RSS: Main: 193253376 03:37:56 INFO - PROCESS | 5555 | 03:37:58 INFO - PROCESS | 5555 | Cycle 1(1): loaded http://localhost:48636/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48636/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:37:59 INFO - PROCESS | 5555 | RSS: Main: 192888832 03:37:59 INFO - PROCESS | 5555 | 03:38:02 INFO - PROCESS | 5555 | Cycle 1(1): loaded http://localhost:48636/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48636/tests/kraken/driver.html?testName=imaging-darkroom) 03:38:03 INFO - PROCESS | 5555 | RSS: Main: 193470464 03:38:03 INFO - PROCESS | 5555 | 03:38:06 INFO - PROCESS | 5555 | Cycle 1(1): loaded http://localhost:48636/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48636/tests/kraken/driver.html?testName=imaging-desaturate) 03:38:07 INFO - PROCESS | 5555 | RSS: Main: 193679360 03:38:07 INFO - PROCESS | 5555 | 03:38:10 INFO - PROCESS | 5555 | Cycle 1(1): loaded http://localhost:48636/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48636/tests/kraken/driver.html?testName=json-parse-financial) 03:38:10 INFO - PROCESS | 5555 | RSS: Main: 193888256 03:38:10 INFO - PROCESS | 5555 | 03:38:12 INFO - PROCESS | 5555 | Cycle 1(1): loaded http://localhost:48636/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48636/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:38:12 INFO - PROCESS | 5555 | RSS: Main: 194297856 03:38:12 INFO - PROCESS | 5555 | 03:38:14 INFO - PROCESS | 5555 | Cycle 1(1): loaded http://localhost:48636/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48636/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:38:15 INFO - PROCESS | 5555 | RSS: Main: 193892352 03:38:15 INFO - PROCESS | 5555 | 03:38:17 INFO - PROCESS | 5555 | Cycle 1(1): loaded http://localhost:48636/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48636/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:38:18 INFO - PROCESS | 5555 | RSS: Main: 194711552 03:38:18 INFO - PROCESS | 5555 | 03:38:20 INFO - PROCESS | 5555 | Cycle 1(1): loaded http://localhost:48636/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48636/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:38:21 INFO - PROCESS | 5555 | RSS: Main: 194134016 03:38:21 INFO - PROCESS | 5555 | 03:38:24 INFO - PROCESS | 5555 | Cycle 1(1): loaded http://localhost:48636/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48636/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:38:24 INFO - PROCESS | 5555 | RSS: Main: 194449408 03:38:24 INFO - PROCESS | 5555 | 03:38:26 INFO - PROCESS | 5555 | Cycle 1(1): loaded http://localhost:48636/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48636/tests/kraken/driver.html?testName=ai-astar) 03:38:26 INFO - PROCESS | 5555 | RSS: Main: 195899392 03:38:26 INFO - PROCESS | 5555 | 03:38:26 INFO - PROCESS | 5555 | __start_tp_report 03:38:26 INFO - PROCESS | 5555 | _x_x_mozilla_page_load 03:38:26 INFO - PROCESS | 5555 | _x_x_mozilla_page_load_details 03:38:26 INFO - PROCESS | 5555 | |i|pagename|runs| 03:38:26 INFO - PROCESS | 5555 | |0;ai-astar;105;112;111;111;111;113;114;113;112;112 03:38:26 INFO - PROCESS | 5555 | |1;audio-beat-detection;150;132;124;164;129;124;123;129;164;124 03:38:26 INFO - PROCESS | 5555 | |2;audio-dft;162;163;165;174;165;161;163;163;164;164 03:38:26 INFO - PROCESS | 5555 | |3;audio-fft;76;75;76;109;76;76;74;75;120;76 03:38:26 INFO - PROCESS | 5555 | |4;audio-oscillator;85;83;119;83;84;83;108;82;83;114 03:38:26 INFO - PROCESS | 5555 | |5;imaging-gaussian-blur;119;117;117;117;117;117;118;118;118;119 03:38:26 INFO - PROCESS | 5555 | |6;imaging-darkroom;148;149;147;148;149;147;147;146;147;147 03:38:26 INFO - PROCESS | 5555 | |7;imaging-desaturate;97;97;96;96;95;97;95;97;96;97 03:38:26 INFO - PROCESS | 5555 | |8;json-parse-financial;54;55;55;52;57;54;53;53;56;53 03:38:26 INFO - PROCESS | 5555 | |9;json-stringify-tinderbox;61;61;60;61;63;61;62;62;62;61 03:38:26 INFO - PROCESS | 5555 | |10;stanford-crypto-aes;82;82;83;82;89;82;81;84;87;89 03:38:26 INFO - PROCESS | 5555 | |11;stanford-crypto-ccm;137;135;143;130;131;130;133;139;169;139 03:38:26 INFO - PROCESS | 5555 | |12;stanford-crypto-pbkdf2;164;171;163;168;164;165;166;166;166;171 03:38:26 INFO - PROCESS | 5555 | |13;stanford-crypto-sha256-iterative;67;68;69;67;66;67;65;68;67;70 03:38:26 INFO - PROCESS | 5555 | __end_tp_report 03:38:26 INFO - PROCESS | 5555 | __start_cc_report 03:38:26 INFO - PROCESS | 5555 | _x_x_mozilla_cycle_collect,785 03:38:26 INFO - PROCESS | 5555 | __end_cc_report 03:38:26 INFO - PROCESS | 5555 | __startTimestamp1477564706885__endTimestamp 03:38:26 INFO - PROCESS | 5555 | 03:38:26 INFO - PROCESS | 5555 | ------- Summary: start ------- 03:38:26 INFO - PROCESS | 5555 | Number of tests: 14 03:38:26 INFO - PROCESS | 5555 | 03:38:26 INFO - PROCESS | 5555 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.00 stddev:2.46 (2.2%) stddev-sans-first:1.05 03:38:26 INFO - PROCESS | 5555 | Values: 105.0 112.0 111.0 111.0 111.0 113.0 114.0 113.0 112.0 112.0 03:38:26 INFO - PROCESS | 5555 | 03:38:26 INFO - PROCESS | 5555 | [#1] audio-beat-detection Cycles:10 Average:136.30 Median:130.50 stddev:16.59 (12.7%) stddev-sans-first:16.84 03:38:26 INFO - PROCESS | 5555 | Values: 150.0 132.0 124.0 164.0 129.0 124.0 123.0 129.0 164.0 124.0 03:38:26 INFO - PROCESS | 5555 | 03:38:26 INFO - PROCESS | 5555 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.00 stddev:3.60 (2.2%) stddev-sans-first:3.71 03:38:26 INFO - PROCESS | 5555 | Values: 162.0 163.0 165.0 174.0 165.0 161.0 163.0 163.0 164.0 164.0 03:38:26 INFO - PROCESS | 5555 | 03:38:26 INFO - PROCESS | 5555 | [#3] audio-fft Cycles:10 Average:83.30 Median:76.00 stddev:16.66 (21.9%) stddev-sans-first:17.46 03:38:26 INFO - PROCESS | 5555 | Values: 76.0 75.0 76.0 109.0 76.0 76.0 74.0 75.0 120.0 76.0 03:38:26 INFO - PROCESS | 5555 | 03:38:26 INFO - PROCESS | 5555 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:83.00 stddev:14.92 (18.0%) stddev-sans-first:15.59 03:38:26 INFO - PROCESS | 5555 | Values: 85.0 83.0 119.0 83.0 84.0 83.0 108.0 82.0 83.0 114.0 03:38:26 INFO - PROCESS | 5555 | 03:38:26 INFO - PROCESS | 5555 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.73 03:38:26 INFO - PROCESS | 5555 | Values: 119.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 118.0 119.0 03:38:26 INFO - PROCESS | 5555 | 03:38:26 INFO - PROCESS | 5555 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:0.97 (0.7%) stddev-sans-first:1.01 03:38:26 INFO - PROCESS | 5555 | Values: 148.0 149.0 147.0 148.0 149.0 147.0 147.0 146.0 147.0 147.0 03:38:26 INFO - PROCESS | 5555 | 03:38:26 INFO - PROCESS | 5555 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:97.00 stddev:0.82 (0.8%) stddev-sans-first:0.83 03:38:26 INFO - PROCESS | 5555 | Values: 97.0 97.0 96.0 96.0 95.0 97.0 95.0 97.0 96.0 97.0 03:38:26 INFO - PROCESS | 5555 | 03:38:26 INFO - PROCESS | 5555 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:54.50 stddev:1.55 (2.8%) stddev-sans-first:1.64 03:38:26 INFO - PROCESS | 5555 | Values: 54.0 55.0 55.0 52.0 57.0 54.0 53.0 53.0 56.0 53.0 03:38:26 INFO - PROCESS | 5555 | 03:38:26 INFO - PROCESS | 5555 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.50 stddev:0.84 (1.4%) stddev-sans-first:0.88 03:38:26 INFO - PROCESS | 5555 | Values: 61.0 61.0 60.0 61.0 63.0 61.0 62.0 62.0 62.0 61.0 03:38:26 INFO - PROCESS | 5555 | 03:38:26 INFO - PROCESS | 5555 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:83.50 stddev:3.07 (3.7%) stddev-sans-first:3.16 03:38:26 INFO - PROCESS | 5555 | Values: 82.0 82.0 83.0 82.0 89.0 82.0 81.0 84.0 87.0 89.0 03:38:26 INFO - PROCESS | 5555 | 03:38:26 INFO - PROCESS | 5555 | [#11] stanford-crypto-ccm Cycles:10 Average:138.60 Median:138.00 stddev:11.53 (8.4%) stddev-sans-first:12.21 03:38:26 INFO - PROCESS | 5555 | Values: 137.0 135.0 143.0 130.0 131.0 130.0 133.0 139.0 169.0 139.0 03:38:26 INFO - PROCESS | 5555 | 03:38:26 INFO - PROCESS | 5555 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.40 Median:166.00 stddev:2.80 (1.7%) stddev-sans-first:2.83 03:38:26 INFO - PROCESS | 5555 | Values: 164.0 171.0 163.0 168.0 164.0 165.0 166.0 166.0 166.0 171.0 03:38:26 INFO - PROCESS | 5555 | 03:38:26 INFO - PROCESS | 5555 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.50 stddev:1.43 (2.1%) stddev-sans-first:1.51 03:38:26 INFO - PROCESS | 5555 | Values: 67.0 68.0 69.0 67.0 66.0 67.0 65.0 68.0 67.0 70.0 03:38:26 INFO - PROCESS | 5555 | -------- Summary: end -------- 03:38:26 INFO - PROCESS | 5555 | 03:38:27 INFO - TEST-INFO | 5555: exit 0 03:38:27 INFO - TEST-OK | kraken | took 63759ms 03:38:27 INFO - SUITE-END | took 1185s 03:38:28 INFO - Completed test suite (00:19:45) 03:38:28 INFO - javascript benchmark 03:38:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7134.469372011257, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3064.2952121012154, 3064.34116664917, 3068.7084726950934, 3096.9690303096963, 3103.6120484939383, 5129.384473863132, 5215.139501982173, 5250.224752771949, 5307.230451584518, 5356.223347614594, 5169.1987741899975, 5189.792408303663, 5243.187305967572, 5267.051930652481, 5312.840614781563, 4738.4313882334, 4789.2816077588295, 4826.227803551433, 4827.806887724487, 4865.927011094819, 4773.06925149596, 4842.685225460352, 4874.902501949959, 4877.219644856824, 4894.608431325503, 4823.20417131173, 4827.155247831651, 4872.926906096412, 4887.755612219393, 4934.1611925972675, 4712.269598212282, 4724.480307166209, 4748.121597504472, 4766.642501812344, 4806.086843499724, 4706.10583989041, 4722.0, 4731.976340118277, 4740.5733483986605, 4816.927746083811, 5215.713135777531, 5217.060929032773, 5261.237120617489, 5273.182656688219, 5276.366835979668, 5511.0, 5571.832845014656, 5595.860103497404, 5613.607047506676, 5629.6340737852315, 5616.0, 5646.887062258773, 5655.4344565543115, 5662.462066103713, 5689.772409103631, 5106.744662766847, 5248.396434410053, 5267.288915996368, 5268.145724432335, 5324.92012619811, 5629.605927585111, 5670.177824215466, 5673.659580425187, 5692.715364231772, 5771.047777116729, 5499.532539734168, 5502.449755024466, 5509.063459211943, 5515.145152501288, 5515.338159420815, 5504.146857237135, 5510.9448905511235, 5551.056320425538, 5551.444855514416, 5629.943700563023, 5283.286756287852, 5418.701971391532, 5552.139418390156, 5605.887882242332, 5609.635373700697, 5608.495235428831, 5620.213170156181, 5636.60543761941, 5648.915266271009, 5669.603127781098, 4294.441722576045, 4313.654907607384, 4328.11273688893, 4351.5430879757805, 4366.912661746811, 3764.4541541476333, 3811.0, 3826.904327391782, 3852.5376954765047, 3923.489946306962, 5363.329583802025, 5385.434529374437, 5410.188471729272, 5464.508194262536, 5491.7254137292975, 5654.745536450787, 5654.9151762723595, 5655.321361436654, 5665.858353541194, 5684.289463817023, 5283.894322113613, 5359.5712343012465, 5368.3826359968325, 5371.301730775052, 5475.260839786658, 4867.488913664014, 4902.093112774077, 4904.828331008469, 4927.310176575283, 4938.802447902115, 5762.366139724543, 5803.448672376117, 5803.709814509342, 5811.6513009220425, 5824.504917082011, 5425.538829199562, 5455.399906010256, 5640.435956404327, 5661.490465858093, 5715.628484148517, 5625.156226566048, 5685.886282274414, 5689.203511508309, 5711.942880571307, 5754.68349240779, 5498.560115190855, 5506.256655351636, 5507.03626865289, 5514.062609356339, 5515.751791169488, 5498.532624726943, 5533.889322213614, 5585.106382978704, 5590.8043218487155, 5642.435756424325, 5422.5119739223655, 5444.156155795858, 5460.290162278879, 5514.503694667499, 5562.054450743464, 5489.423610520837, 5523.972380138073, 5529.889402211853, 5530.778768849201, 5547.972260138835, 5259.526642602184, 5266.368035835571, 5473.589480788877, 5515.062439385234, 5519.199716041071, 5484.0, 5537.972310138423, 5562.2212890196215, 5570.108782594765, 5609.4390560943575, 5391.16436952273, 5410.404855465817, 5416.4041955385665, 5420.430854760351, 5424.701641409761], "value": 5182.380815744687, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [565.7341049706639, 567.2172402085122, 578.3378032153183, 579.7767859374143, 580.2833500626728, 38993.61006389935, 40682.796586017066, 40841.387379189335, 45486.31770523445, 45708.085838283216, 43191.136177276436, 43430.78284608581, 43447.78276108623, 43546.56453435465, 43662.78168609161, 8667.003294621121, 8792.780180495507, 8804.559772011406, 8843.204111629952, 8868.15752503511, 8730.825383492327, 8778.824423511525, 8786.077461866507, 8823.558822058903, 8826.07326230743, 8843.646254149826, 8879.644814207424, 8884.511351875644, 8892.066333035034, 8938.553072346389, 8772.12278772124, 8797.428167169177, 8820.514871682055, 8828.514431706253, 8845.778855528599, 8787.340949428819, 8799.076097009785, 8862.86705699415, 8866.379353445262, 8869.645214191425, 40773.184536309105, 40822.38766418506, 40953.1809363814, 41105.79447102775, 41302.38046429306, 3229.1442767666585, 3244.4160051190775, 3411.9317613647836, 3520.77114987525, 3635.963640363589, 30934.38131237385, 31025.0, 31165.844170779226, 31233.37533249345, 32576.02271931846, 3872.825722842451, 3921.901952451183, 3959.208158368338, 4101.815418306153, 4232.238197124517, 319242.0, 321477.0, 322898.0, 323015.0, 323977.9999999977, 53975.0, 54529.727351363785, 54543.72728136334, 54601.45398546043, 54743.72628136834, 57065.14402283969, 57123.14315285274, 57132.0, 57231.0, 57416.42583574111, 13485.66285842842, 13548.254845983565, 13568.118072325464, 13618.93190534041, 13633.0, 10257.640982565574, 10278.280520363503, 10294.691159265085, 10338.948305258426, 10378.636747713794, 14994.0, 14998.200215974153, 15086.321115549827, 15243.314050867737, 15452.845471545366, 5577.972110139423, 5854.8536286592325, 5918.803845923239, 5992.250968628921, 6157.507399408037, 879.7404765594038, 965.2953344058736, 986.2405947420447, 989.7426669066094, 1016.7356487313203, 31533.8423307882, 31612.525812112835, 31822.36355272928, 31898.0, 31937.52093718596, 950.8906475755239, 1014.5383850348074, 1057.7258893379142, 1075.2580719303812, 1099.3294090604725, 14754.336054877556, 16261.105639189958, 16282.10448425348, 16361.83638163603, 16715.832841671672, 480829.0, 481783.0, 482729.0, 483059.0, 483396.0, 54800.45199548033, 55284.0, 55472.44527554673, 56120.0, 56177.0, 1275.5663074554695, 1299.857015728269, 1326.2374134872487, 1334.5796074236584, 1335.0321017262602, 29049.7095029047, 30479.238019049702, 30855.2286192838, 30935.0, 31310.686893130776, 47719.0, 47782.76108619435, 48038.759806200746, 48205.27692084692, 48547.75726121488, 402703.0, 405260.0, 405706.0, 405991.0, 406088.0, 25762.87118564395, 26965.460690785683, 27003.1899043029, 28629.713702862704, 38773.41839872348, 45221.0, 46310.30534542052, 46557.76721116373, 47019.0, 47537.286940696606, 38196.42705359366, 39159.517667527136, 39169.0, 40176.598234017285, 40644.39033414442, 38792.80603596964, 39468.21063578655, 40413.79793101016, 40574.91366881497, 40897.38653920134, 38996.0, 39053.41419878761, 39547.80226098851, 39866.0, 40165.1966960665, 33109.17227069342, 35098.29803403969, 35222.47166292559, 35349.09729988808, 35398.823005884806, 26839.463210736067, 27082.458350833265, 27233.31916702098, 27416.177514674593, 27499.86250068737], "value": 19005.31612447541, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.07215723443005, 403.6568916421041, 405.9228746538158, 408.3874188716925, 417.157342168819, 14317.498887538939, 17677.469675909728, 18444.815551844476, 19305.903470482644, 19341.99999999998, 18693.34573289935, 18920.71618925717, 19409.32067377642, 19552.41342759716, 20015.1993920243, 5676.716164191795, 5713.428657134295, 5870.412958704138, 5903.4686878180955, 5916.2900451945825, 5763.049096899028, 5785.971070144644, 5819.127130930373, 5842.853928651796, 5846.619969701956, 5671.8014869479575, 5841.85395365115, 5858.0, 5874.089516124986, 5875.735591898353, 5747.6551406915305, 5797.217375654275, 5832.883342333151, 5836.824895253149, 5849.473547380735, 5136.768845401929, 5209.843704688866, 5215.0, 5234.18870075139, 5241.580673546107, 22250.55498890013, 22895.084196632113, 22984.42538936523, 23208.921279009894, 23596.410089747722, 2259.6836442898007, 2300.5168914527967, 2342.847714898526, 2389.689340385756, 2400.327908185711, 14468.421263149461, 14597.124172549575, 14668.926655366762, 14941.0, 15448.845511544852, 1893.1480833624923, 1963.5091227193202, 1969.3796454116907, 1988.7514060742408, 1993.2196629773628, 80078.59960700218, 80939.5953020237, 81215.0, 82019.17980820175, 83419.5829020857, 10487.423191724529, 10551.0, 10795.29830561011, 10987.285826421257, 11270.718232044264, 12482.940314847949, 15509.0, 15557.766633500507, 15594.766078508832, 15606.3757449703, 6814.727410903508, 6883.27725588816, 7078.3365909011345, 7089.22018577956, 7096.432285417154, 6482.481401487964, 6577.408033277028, 6696.5647232929705, 6722.630255336004, 6744.662766861736, 4093.4473846030405, 4100.507939047334, 4203.495580530294, 4272.0, 4316.158349121891, 1980.6731889238115, 2032.3191730770357, 2043.8262747666317, 2081.885496297718, 2088.968665470019, 853.7481442974338, 898.8966268879032, 916.6104405627582, 962.0812124421161, 1004.6734811186247, 17754.201060952288, 18717.438476845717, 19324.71012934807, 19621.411357659006, 20134.69797953032, 959.7264779537799, 984.2962281968283, 991.5389343955095, 1020.6019652335596, 1021.4075836015094, 8929.910700892908, 10866.402347870784, 11007.889921100847, 11186.496607652674, 11189.832152517718, 451395.91624502634, 451758.0, 452147.0, 463853.0, 468002.0, 59080.704596477604, 59837.700811496536, 60747.08879366813, 94591.0, 97306.59254963897, 1000.9549570269355, 1001.7195185348114, 1028.9639862604772, 1033.18894667687, 1034.6740776655329, 17365.30538778435, 17533.635620307636, 18134.72797908006, 18268.81731182671, 18317.633647327246, 38010.72822984287, 43726.562734373525, 43922.34116488192, 44016.339754904344, 44944.55055449534, 48180.0, 57015.714921425126, 57105.714471427375, 57557.424425755205, 58941.410585893595, 8163.469374490639, 8359.205875441823, 8359.958200209203, 8503.447275927045, 8582.527960962207, 12128.272303661808, 12834.294113823456, 12975.416106275428, 13010.739785204432, 13348.26584537821, 10416.1667066636, 10706.357618542912, 10747.677569672922, 10843.403612801372, 11409.087273018305, 10946.124310055337, 11341.0, 11408.600698975495, 11548.48031838586, 12023.81964270554, 11045.33727976324, 11370.886291136983, 11398.886011139783, 11489.0, 11735.295882247092, 8379.622916968872, 8510.574471276535, 8589.269912057294, 8712.390132690904, 8807.427517211361, 10862.131029517777, 11388.430578470878, 11428.14288928317, 11567.0, 11831.461909951651], "value": 9062.159352547045, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1485.3093311610103, 1489.1511838252197, 1649.752537119432, 1733.9739903901436, 1745.397837745978, 7667.84664306715, 7941.364690824735, 8369.832603347937, 9321.254299656028, 9338.953305233474, 8786.912130878689, 9041.3671043027, 9049.502277374742, 9369.71890843274, 9375.624975001008, 2333.4049817296564, 2360.0205914545445, 2370.3126093432884, 2378.203301893868, 2383.3922349800864, 2271.636538153896, 2299.793018628323, 2305.101010605865, 2318.084356679111, 2328.511012687329, 2230.3309007297826, 2234.8994295256753, 2248.651459023854, 2270.6594010898334, 2271.806896413807, 2230.509287956647, 2246.640537513998, 2247.831412644058, 2248.4378905273684, 2252.650839119931, 2207.3377986603955, 2212.723409573803, 2216.8115710164657, 2220.877851718155, 2226.743924448677, 9136.6802161924, 9237.445753254826, 9281.58232879522, 9309.906900930971, 9310.162085412278, 5183.144781111112, 5235.895282094337, 5287.286216360781, 5293.655912365684, 5314.5748340132695, 3291.8683252670103, 3366.192113892648, 3502.877399291013, 3505.6669616386403, 3523.260115375774, 1048.2871647279846, 1050.2175878970215, 1064.627380416848, 1070.7002039428894, 1085.5332207150923, 12043.397830108459, 12255.325957072357, 12281.447334869952, 12410.945069668998, 12499.250044997238, 4647.117047760915, 4713.552212539803, 4746.116746392637, 4797.544233297831, 4948.1835497142565, 10620.415877126678, 10695.304805187638, 10755.677329680122, 10768.676939691823, 10781.9460902695, 5378.058839703036, 5445.074337362658, 5460.426655201226, 5462.8361149165585, 5486.231927530149, 4257.1698518788535, 4401.867943961686, 4831.492693267156, 4940.654154209171, 4982.2775697524385, 3838.4242363645117, 3982.761034337949, 4049.6760259179196, 4052.338541198095, 4059.715819892579, 1332.880380480401, 1343.234356416833, 1345.9730805383838, 1350.46656570656, 1356.0168877563885, 728.2535401213693, 740.6741033945046, 756.9432292578078, 918.1782304837134, 938.3384713776771, 5708.914366284509, 5867.002609556385, 5884.077997087301, 5905.202797622266, 6098.664573448415, 438.88588966868207, 450.1919055295752, 454.46146316614914, 459.31561972660495, 461.82681494439584, 3879.2629400414394, 3923.352646813244, 3982.7411218270718, 4016.578259282792, 4393.077453734688, 11224.887751122384, 11581.710457238469, 11626.825597616042, 11630.592929247605, 11636.825447618123, 11404.543818247177, 11590.478428470571, 11631.185816992729, 11664.88335116638, 11692.356920369291, 8424.4945303282, 8606.483610983361, 8681.522516261666, 8701.17338852808, 8709.433886797338, 5913.2608423947, 5958.314793798769, 5990.760369585168, 6041.939580604314, 6199.442050215503, 10343.431111288952, 10358.498017787228, 10417.895821041693, 10446.895531044896, 10495.422751748727, 10628.309159904582, 10720.24958252946, 10758.569657213624, 10779.622713205, 10820.404877731486, 7103.751368702277, 7402.0, 7727.227277272228, 8174.509529428254, 8278.048024477263, 8243.340532757245, 8659.307255419426, 8680.696175633822, 8705.695300664447, 8708.085651006553, 7431.665575049027, 7572.697092116254, 7929.484583502054, 8143.389245806469, 8163.102058773411, 7297.16082650502, 7462.291082347168, 7473.775786726407, 7578.3179513841815, 7710.4217183710325, 6657.900131498128, 6757.560758550679, 6804.353586409283, 6809.38715515606, 6811.489138314745, 4718.622510199107, 4887.43794463627, 4916.237983112624, 4940.456549779449, 4976.726280054631, 4929.112759703288, 5027.32131162303, 5051.823186188466, 5074.11203039474, 5169.198774190007], "value": 4561.059944005787, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.57007745047616, 337.59151426773604, 342.71554609673973, 345.32833638572987, 348.99476507852404, 5270.420253772087, 5338.572914166867, 5351.678899266047, 5375.999999999995, 5377.0321342158395, 5249.238860365244, 5307.548858347035, 5312.432832314466, 5325.227841962913, 5330.387005494369, 4025.9798701006525, 4125.21620892031, 4201.789910504463, 4211.073563815956, 4222.324428091506, 4215.578442155791, 4221.6833737469815, 4227.873163805076, 4256.553061928499, 4261.062566235423, 4234.470691163605, 4236.555161708023, 4240.3851441540955, 4243.554426785189, 4257.446531950842, 3929.528456585214, 4119.423280740699, 4139.275626765304, 4151.4395556599775, 4244.580589064235, 3663.7252206084386, 3686.870959516431, 3687.778733276012, 3695.9630403695887, 3703.407534760052, 5184.507471790174, 5205.505476979681, 5243.134882744343, 5246.239295302198, 5250.238715386247, 4565.840195593171, 4718.976405117986, 4750.596199323062, 4774.689645173053, 4786.904261914777, 5498.257735205736, 5529.944700553024, 5531.889362212773, 5533.667979921218, 5535.723213839332, 4010.578889216649, 4014.9397759033636, 4020.43713880057, 4026.255142798592, 4031.6169963853386, 5682.914756278659, 5798.188253644451, 5833.591648584558, 5855.970720146414, 5949.167116603679, 4119.887630339851, 4140.3375459926265, 4145.97927010363, 4149.543550209535, 4154.626083652486, 4201.7899105045235, 4220.388043733641, 4220.451341325608, 4220.915581688349, 4223.282042052859, 4704.9529504704515, 4729.69256998294, 4785.569298763058, 4823.493533179036, 4861.80552777892, 5668.489835914705, 5676.290463692038, 5680.744366503434, 5714.714264286769, 5762.279715035621, 1452.012631410651, 1468.8689708924069, 1469.1478942213491, 1470.4632809024843, 1470.9411623535152, 905.5395142309491, 947.6114792934864, 961.1974001708652, 965.3339195954769, 998.2032341784758, 5504.6421982571, 5516.475934786189, 5535.474129957647, 5557.722113894289, 5564.0, 5760.8271751847515, 5796.82609521715, 5829.446202610745, 5851.0, 5854.941450585525, 5380.91928621071, 5437.864053398617, 5492.340919089735, 5493.7802487900035, 5523.6685798852195, 3069.9101818853987, 3081.229692576856, 3085.8148511089407, 3089.3203495231014, 3100.550420189105, 5636.718164091779, 5911.940880591139, 5918.526517878559, 5933.169356290123, 5957.642541447527, 5822.446867547661, 5869.970650146722, 5886.911696324559, 5910.876933382644, 5926.547995740985, 5944.613600116065, 5953.970230148821, 5955.851103722268, 5977.1333156692035, 6005.369436209223, 5573.219749235192, 5756.56825738063, 5812.0, 5848.473637372486, 5849.473547380756, 5756.769729210952, 5757.712114394348, 5762.164486149569, 5795.565332600157, 5800.59395842287, 5910.551914780906, 5938.257717785277, 5983.162357270073, 6022.698865056642, 6086.330503644507, 4197.391378250198, 4265.97867010663, 4279.379489973999, 4289.420928174656, 4297.269464191158, 5889.146073819186, 5891.440313170242, 5892.1161825726485, 5898.908701889993, 5912.674802885883, 5523.585731070266, 5649.5028817364255, 5663.065594176915, 5766.308043034863, 5775.711214439345, 5581.888362232651, 5655.377908429987, 5658.094704847204, 5679.176519404746, 5691.3170419549915, 5433.804562996134, 5635.830925072254, 5670.858228544319, 5673.574481913791, 5680.68756218412, 5395.271638328775, 5622.70677744113, 5624.831255062355, 5701.831124619526, 5712.629548566366, 5559.388467268516, 5596.216529685928, 5626.690532020614, 5630.408807075198, 5642.407547207648], "value": 4319.088824991323, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [673.7035704290113, 675.2976904019816, 723.3309189000173, 736.2674139231466, 806.0891192951964, 15544.76682849758, 16539.338426462957, 16554.83445165548, 16559.586010349733, 16595.0, 15174.317155727991, 15325.08049517027, 15327.92336038321, 15351.616209594766, 15353.616159596017, 750.2534977697171, 767.2557619109483, 793.238491048594, 795.6538905576064, 798.656577671601, 783.6669415498419, 785.2775446589123, 792.2473650032492, 794.364508393286, 795.2723258218723, 818.8116733151379, 822.2106777493614, 825.6243409248777, 826.8801023851538, 829.6391069884589, 817.5380909785952, 819.6393586821779, 827.3298628111219, 827.6358402302998, 827.871679889615, 588.153059594183, 593.6230493636572, 597.1669521018156, 598.8233471125985, 601.2034054877262, 14091.577252682333, 14132.646683832883, 14164.716705665829, 14176.149431034171, 14218.0, 13503.189808611416, 14010.0, 14168.787468187882, 14258.714825703428, 15075.131367719883, 11970.880291197063, 12110.576129835501, 12175.756484870253, 12269.202501837352, 12359.443825027805, 3726.981365093184, 3779.9622003779887, 3838.1939792643298, 3920.980395098035, 4021.698372622036, 63612.36387636111, 75440.62279688621, 75859.62070189614, 77789.61105194494, 79454.0, 11266.493007814668, 11430.428478576037, 11612.593559225386, 11775.88224117765, 11788.764224715458, 21261.36215913525, 21301.0, 21309.25417610376, 21366.57266854654, 21390.251341202984, 7426.331630153312, 7551.5846628434865, 8100.392470564731, 8101.594920253964, 8255.545944972964, 4103.569125241806, 4171.853985110567, 4186.162767446523, 4369.519352871182, 4418.690691651554, 3369.3935091683243, 3475.565554305712, 3505.8422370993367, 3516.0, 3520.3487354839435, 638.2468686949352, 640.0814830717935, 642.2966851297915, 657.763205246111, 661.6063442251852, 589.345826132992, 611.7247238742584, 653.8496145886472, 664.3987191591617, 667.2693400726197, 8533.317334613215, 9367.437953722798, 9491.477968711788, 9557.0, 9592.808143837225, 618.1006635345561, 648.3710800523485, 649.8367921420698, 662.6752891083335, 712.2877122877123, 5052.646314758005, 5132.255822905658, 5164.406093299319, 5493.340799104053, 5663.66018038919, 98502.0, 112495.0, 116361.0, 117008.0, 119721.40139299248, 96609.0, 97208.0, 97774.51112744391, 100014.0, 100478.4976075115, 84305.57847210724, 87264.56367718121, 89581.55209223912, 91175.0, 93500.68982064712, 10011.349262297927, 10014.39913605186, 10218.262320900561, 10359.689209323733, 10377.273590848568, 49791.51459397807, 50599.735006623654, 51244.487555123975, 51573.0, 51777.0, 65557.0, 75765.24234757802, 78580.60709696414, 79372.20627793648, 80152.59923700344, 12185.573504927284, 12550.560730374393, 12875.227486350848, 13217.206967581977, 13444.596662100153, 13726.0, 13865.376058077612, 13945.58163255104, 14710.338034788247, 15276.0, 12476.438560264629, 13367.933160334136, 13708.383122759698, 14063.859361406665, 14390.640233993816, 13538.918041601419, 14039.649008774863, 14358.263159995227, 14588.343524541633, 15021.324040418425, 13057.934710326388, 13134.146280491737, 13144.539941102397, 13302.733945321233, 13535.187888726708, 11258.943705281748, 11513.884861151617, 11973.161878668758, 12047.397630118283, 12061.336626485276, 10508.527116279633, 11232.269902456314, 12255.571055013032, 12257.387130643254, 12460.501579937063], "value": 7499.5123874035535, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1521.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 111.0, 111.0, 111.0, 113.0, 114.0, 113.0, 112.0, 112.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 132.0, 124.0, 164.0, 129.0, 124.0, 123.0, 129.0, 164.0, 124.0], "value": 136.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 165.0, 174.0, 165.0, 161.0, 163.0, 163.0, 164.0, 164.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 109.0, 76.0, 76.0, 74.0, 75.0, 120.0, 76.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 119.0, 83.0, 84.0, 83.0, 108.0, 82.0, 83.0, 114.0], "value": 92.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 119.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 147.0, 148.0, 149.0, 147.0, 147.0, 146.0, 147.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 96.0, 96.0, 95.0, 97.0, 95.0, 97.0, 96.0, 97.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 52.0, 57.0, 54.0, 53.0, 53.0, 56.0, 53.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 61.0, 63.0, 61.0, 62.0, 62.0, 62.0, 61.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 83.0, 82.0, 89.0, 82.0, 81.0, 84.0, 87.0, 89.0], "value": 84.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 135.0, 143.0, 130.0, 131.0, 130.0, 133.0, 139.0, 169.0, 139.0], "value": 138.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 171.0, 163.0, 168.0, 164.0, 165.0, 166.0, 166.0, 166.0, 171.0], "value": 166.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 69.0, 67.0, 66.0, 67.0, 65.0, 68.0, 67.0, 70.0], "value": 67.4, "unit": "score"}]}]} 03:38:28 INFO - Return code: 0 03:38:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:38:28 ERROR - # TBPL SUCCESS # 03:38:28 INFO - Running post-action listener: _resource_record_post_action 03:38:28 INFO - [mozharness: 2016-10-27 10:38:28.191965Z] Finished run-tests step (success) 03:38:28 INFO - Running post-run listener: _resource_record_post_run 03:38:28 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 737280; Write bytes: 403968000; Read time: 908; Write time: 602392 03:38:28 INFO - TinderboxPrint: CPU usage
13.4% 03:38:28 INFO - TinderboxPrint: I/O read bytes / time
737,280 / 908 03:38:28 INFO - TinderboxPrint: I/O write bytes / time
403,968,000 / 602,392 03:38:28 INFO - TinderboxPrint: CPU idle
8,315.8 (86.6%) 03:38:28 INFO - TinderboxPrint: CPU user
1,214.1 (12.6%) 03:38:28 INFO - TinderboxPrint: Swap in / out
0 / 0 03:38:28 INFO - install - Wall time: 19s; CPU: 13.0%; Read bytes: 0; Write bytes: 104005632; Read time: 0; Write time: 189908 03:38:28 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 733184; Write bytes: 288538624; Read time: 896; Write time: 405756 03:38:28 INFO - Running post-run listener: _upload_blobber_files 03:38:28 INFO - Blob upload gear active. 03:38:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:38:28 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 03:38:28 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'] 03:38:28 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 03:38:29 INFO - (blobuploader) - INFO - Open directory for files ... 03:38:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:38:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:38:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:38:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:38:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:38:32 INFO - (blobuploader) - INFO - Done attempting. 03:38:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:38:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:38:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:38:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:38:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:38:33 INFO - (blobuploader) - INFO - Done attempting. 03:38:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:38:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:38:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:38:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:38:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:38:33 INFO - (blobuploader) - INFO - Done attempting. 03:38:33 INFO - (blobuploader) - INFO - Iteration through files over. 03:38:33 INFO - Return code: 0 03:38:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:38:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:38:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cee164df228f5d92e0a973ef34b19116d34e0b81d7433a839c4a05ebb10b14decad9f4b02814595d70e54d42ae8ef9517e86165f406e39b05b7effbf30367772", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6549b0a69f041ddab61d7ce22d9d402575b5fe2f7ed9cdabaa6e5527e7b34f7e778a922eaff1fb2cf54c449516c16a4c73c1311b521b5f5167abf533d541af68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/22dc629a620082790ae1711a47e16f7f4682dd003aee3eeb8be7f0311348393c74119952088b1916febc7660eadd27fd100342483e5809b8d52850158ef16121"} 03:38:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:38:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:38:33 INFO - Contents: 03:38:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cee164df228f5d92e0a973ef34b19116d34e0b81d7433a839c4a05ebb10b14decad9f4b02814595d70e54d42ae8ef9517e86165f406e39b05b7effbf30367772", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6549b0a69f041ddab61d7ce22d9d402575b5fe2f7ed9cdabaa6e5527e7b34f7e778a922eaff1fb2cf54c449516c16a4c73c1311b521b5f5167abf533d541af68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/22dc629a620082790ae1711a47e16f7f4682dd003aee3eeb8be7f0311348393c74119952088b1916febc7660eadd27fd100342483e5809b8d52850158ef16121"} 03:38:33 INFO - Running post-run listener: copy_logs_to_upload_dir 03:38:33 INFO - Copying logs to upload dir... 03:38:33 INFO - mkdir: /builds/slave/test/build/upload/logs 03:38:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.663951 ========= master_lag: 0.56 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-27 03:38:34.441012) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-10-27 03:38:34.447722) ========= 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=745a4373a2a16df560f216e000000264-1477555582.684912-970778831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cee164df228f5d92e0a973ef34b19116d34e0b81d7433a839c4a05ebb10b14decad9f4b02814595d70e54d42ae8ef9517e86165f406e39b05b7effbf30367772", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6549b0a69f041ddab61d7ce22d9d402575b5fe2f7ed9cdabaa6e5527e7b34f7e778a922eaff1fb2cf54c449516c16a4c73c1311b521b5f5167abf533d541af68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/22dc629a620082790ae1711a47e16f7f4682dd003aee3eeb8be7f0311348393c74119952088b1916febc7660eadd27fd100342483e5809b8d52850158ef16121"} build_url:https://queue.taskcluster.net/v1/task/cxpoRELQSQmBT6o-5fXcvA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010330 build_url: 'https://queue.taskcluster.net/v1/task/cxpoRELQSQmBT6o-5fXcvA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cee164df228f5d92e0a973ef34b19116d34e0b81d7433a839c4a05ebb10b14decad9f4b02814595d70e54d42ae8ef9517e86165f406e39b05b7effbf30367772", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6549b0a69f041ddab61d7ce22d9d402575b5fe2f7ed9cdabaa6e5527e7b34f7e778a922eaff1fb2cf54c449516c16a4c73c1311b521b5f5167abf533d541af68", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/22dc629a620082790ae1711a47e16f7f4682dd003aee3eeb8be7f0311348393c74119952088b1916febc7660eadd27fd100342483e5809b8d52850158ef16121"}' ========= master_lag: 3.55 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 3 secs) (at 2016-10-27 03:38:38.003188) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-10-27 03:38:38.003555) ========= 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=745a4373a2a16df560f216e000000264-1477555582.684912-970778831 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004585 ========= master_lag: 3.24 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-10-27 03:38:41.243544) ========= ========= Started reboot skipped (results: 3, elapsed: 2 secs) (at 2016-10-27 03:38:41.243859) ========= ========= Finished reboot skipped (results: 3, elapsed: 2 secs) (at 2016-10-27 03:38:43.995399) ========= ========= Total master_lag: 7.43 =========