builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-007 starttime: 1476221923.54 results: success (0) buildid: 20161011131646 builduid: 370549d2bec64c328a675d23d41e8ecb revision: 8fef52daf4b5be227469a5603da1211e50c895b6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 14:38:43.543708) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 14:38:43.544780) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 14:38:43.545322) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 14:38:43.562183) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 14:38:43.562526) ========= 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=923d835db2ba3686ebe126b700000192-1476221770.971008-777042118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-11 14:38:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-10-11 14:38:44 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.136950 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 14:38:43.716187) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 14:38:43.716510) ========= 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=923d835db2ba3686ebe126b700000192-1476221770.971008-777042118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020948 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 14:38:43.770948) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 14:38:43.771301) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 8fef52daf4b5be227469a5603da1211e50c895b6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 8fef52daf4b5be227469a5603da1211e50c895b6 --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=923d835db2ba3686ebe126b700000192-1476221770.971008-777042118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-11 14:38:44,236 truncating revision to first 12 chars 2016-10-11 14:38:44,236 Setting DEBUG logging. 2016-10-11 14:38:44,236 attempt 1/10 2016-10-11 14:38:44,236 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/8fef52daf4b5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-11 14:38:44,532 unpacking tar archive at: autoland-8fef52daf4b5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.631340 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 14:38:44.417111) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 14:38:44.417460) ========= script_repo_revision: 8fef52daf4b5be227469a5603da1211e50c895b6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 14:38:44.417917) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 14:38:44.418225) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 14:38:44.427920) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-11 14:38:44.428203) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=923d835db2ba3686ebe126b700000192-1476221770.971008-777042118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:38:44 INFO - MultiFileLogger online at 20161011 14:38:44 in /builds/slave/test 14:38:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 14:38:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:38:44 INFO - {'append_to_log': False, 14:38:44 INFO - 'base_work_dir': '/builds/slave/test', 14:38:44 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 14:38:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:38:44 INFO - 'branch': 'Autoland-Non-PGO', 14:38:44 INFO - 'buildbot_json_path': 'buildprops.json', 14:38:44 INFO - 'config_files': ('talos/linux_config.py',), 14:38:44 INFO - 'default_actions': ('clobber', 14:38:44 INFO - 'read-buildbot-config', 14:38:44 INFO - 'download-and-extract', 14:38:44 INFO - 'populate-webroot', 14:38:44 INFO - 'create-virtualenv', 14:38:44 INFO - 'install', 14:38:44 INFO - 'run-tests'), 14:38:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:38:44 INFO - 'download_minidump_stackwalk': True, 14:38:44 INFO - 'download_symbols': 'ondemand', 14:38:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:38:44 INFO - 'tooltool.py': '/tools/tooltool.py', 14:38:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:38:44 INFO - '/tools/misc-python/virtualenv.py')}, 14:38:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:38:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:38:44 INFO - 'installer_path': 'installer.exe', 14:38:44 INFO - 'log_level': 'info', 14:38:44 INFO - 'log_name': 'talos', 14:38:44 INFO - 'log_to_console': True, 14:38:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:38:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:38:44 INFO - 'opt_config_files': (), 14:38:44 INFO - 'pip_index': False, 14:38:44 INFO - 'sps_profile': False, 14:38:44 INFO - 'sps_profile_interval': 0, 14:38:44 INFO - 'suite': 'dromaeojs', 14:38:44 INFO - 'system_bits': '32', 14:38:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:38:44 INFO - 'title': 'talos-linux64-ix-007', 14:38:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:38:44 INFO - 'use_talos_json': True, 14:38:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:38:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:38:44 INFO - 'work_dir': 'build'} 14:38:44 INFO - [mozharness: 2016-10-11 21:38:44.987853Z] Running clobber step. 14:38:44 INFO - Running pre-action listener: _resource_record_pre_action 14:38:44 INFO - Running main action method: clobber 14:38:44 INFO - rmtree: /builds/slave/test/build 14:38:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:38:45 INFO - Running post-action listener: _resource_record_post_action 14:38:45 INFO - [mozharness: 2016-10-11 21:38:45.962908Z] Finished clobber step (success) 14:38:45 INFO - [mozharness: 2016-10-11 21:38:45.963006Z] Running read-buildbot-config step. 14:38:45 INFO - Running pre-action listener: _resource_record_pre_action 14:38:45 INFO - Running main action method: read_buildbot_config 14:38:45 INFO - Using buildbot properties: 14:38:45 INFO - { 14:38:45 INFO - "project": "", 14:38:45 INFO - "product": "firefox", 14:38:45 INFO - "script_repo_revision": "production", 14:38:45 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 14:38:45 INFO - "repository": "", 14:38:45 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 14:38:45 INFO - "buildid": "20161011131646", 14:38:45 INFO - "pgo_build": "False", 14:38:45 INFO - "basedir": "/builds/slave/test", 14:38:45 INFO - "buildnumber": 768, 14:38:45 INFO - "slavename": "talos-linux64-ix-007", 14:38:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:38:45 INFO - "platform": "ubuntu64_hw", 14:38:45 INFO - "scheduler": "tests-autoland-linux64-talos", 14:38:45 INFO - "branch": "autoland", 14:38:45 INFO - "repo_path": "integration/autoland", 14:38:45 INFO - "revision": "8fef52daf4b5be227469a5603da1211e50c895b6", 14:38:45 INFO - "stage_platform": "linux64", 14:38:45 INFO - "builduid": "370549d2bec64c328a675d23d41e8ecb", 14:38:45 INFO - "slavebuilddir": "test" 14:38:45 INFO - } 14:38:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/e82tohu8T4OvkLUPgnuRUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 14:38:45 INFO - Running post-action listener: _resource_record_post_action 14:38:45 INFO - [mozharness: 2016-10-11 21:38:45.965437Z] Finished read-buildbot-config step (success) 14:38:45 INFO - [mozharness: 2016-10-11 21:38:45.965523Z] Running download-and-extract step. 14:38:45 INFO - Running pre-action listener: _resource_record_pre_action 14:38:45 INFO - Running main action method: download_and_extract 14:38:45 INFO - mkdir: /builds/slave/test/build/tests 14:38:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:38:45 INFO - trying https://queue.taskcluster.net/v1/task/e82tohu8T4OvkLUPgnuRUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 14:38:45 INFO - Downloading https://queue.taskcluster.net/v1/task/e82tohu8T4OvkLUPgnuRUA/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 14:38:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e82tohu8T4OvkLUPgnuRUA/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 14:38:46 INFO - Downloaded 1361 bytes. 14:38:46 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 14:38:46 INFO - Using the following test package requirements: 14:38:46 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 14:38:46 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:38:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:38:46 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:38:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:38:46 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:38:46 INFO - u'jsshell-linux-x86_64.zip'], 14:38:46 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:38:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:38:46 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 14:38:46 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:38:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:38:46 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:38:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:38:46 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:38:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:38:46 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 14:38:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:38:46 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:38:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e82tohu8T4OvkLUPgnuRUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 14:38:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e82tohu8T4OvkLUPgnuRUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:38:46 INFO - Fetch https://queue.taskcluster.net/v1/task/e82tohu8T4OvkLUPgnuRUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 14:38:47 INFO - Http code: 200 14:38:47 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 14:38:47 INFO - x-amz-cf-id: BTIn-7enGV3iDC864_fz9PhW-JsrabJOzre9XZ1PKS2_sIovOumHsw== 14:38:47 INFO - x-amz-version-id: _ZbCR2hIENNjCv8aAfpcDLXXkvO5UOEw 14:38:47 INFO - Expected file size: 20528767 14:38:47 INFO - Obtained file size: 20528767 14:38:51 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 14:38:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e82tohu8T4OvkLUPgnuRUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 14:38:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e82tohu8T4OvkLUPgnuRUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:38:51 INFO - Fetch https://queue.taskcluster.net/v1/task/e82tohu8T4OvkLUPgnuRUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 14:38:52 INFO - Http code: 200 14:38:52 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 14:38:52 INFO - x-amz-cf-id: obdDbkqNwPFZqh0yI0ceQUfWwT9kxD-3QuJocC6VI886siha6puYcg== 14:38:52 INFO - x-amz-version-id: _ZbCR2hIENNjCv8aAfpcDLXXkvO5UOEw 14:38:53 INFO - Expected file size: 20528767 14:38:53 INFO - Obtained file size: 20528767 14:38:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/e82tohu8T4OvkLUPgnuRUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 14:38:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/e82tohu8T4OvkLUPgnuRUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:38:57 INFO - Fetch https://queue.taskcluster.net/v1/task/e82tohu8T4OvkLUPgnuRUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 14:38:58 INFO - Http code: 200 14:38:58 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 14:38:58 INFO - x-amz-cf-id: zxBq96jx5_Ib_1dvscHfyUBKzOYONt-itpuDLRBIB6BB8IjHRU33PA== 14:38:58 INFO - x-amz-version-id: OPuxvzo5qxZmalp_tmPVM68plv4wTtzq 14:38:59 INFO - Expected file size: 14409006 14:38:59 INFO - Obtained file size: 14409006 14:38:59 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')]} 14:38:59 INFO - trying https://queue.taskcluster.net/v1/task/e82tohu8T4OvkLUPgnuRUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 14:38:59 INFO - Downloading https://queue.taskcluster.net/v1/task/e82tohu8T4OvkLUPgnuRUA/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 14:38:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e82tohu8T4OvkLUPgnuRUA/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 14:39:01 INFO - Downloaded 55902276 bytes. 14:39:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/e82tohu8T4OvkLUPgnuRUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 14:39:01 INFO - mkdir: /builds/slave/test/properties 14:39:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:39:01 INFO - Writing to file /builds/slave/test/properties/build_url 14:39:01 INFO - Contents: 14:39:01 INFO - build_url:https://queue.taskcluster.net/v1/task/e82tohu8T4OvkLUPgnuRUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 14:39:02 INFO - Running post-action listener: _resource_record_post_action 14:39:02 INFO - Running post-action listener: set_extra_try_arguments 14:39:02 INFO - [mozharness: 2016-10-11 21:39:02.089317Z] Finished download-and-extract step (success) 14:39:02 INFO - [mozharness: 2016-10-11 21:39:02.089542Z] Running populate-webroot step. 14:39:02 INFO - Running pre-action listener: _resource_record_pre_action 14:39:02 INFO - Running main action method: populate_webroot 14:39:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:39:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:39:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:39:02 INFO - '--tppagecycles', 14:39:02 INFO - '7'], 14:39:02 INFO - 'tests': ['tsvgm']}}, 14:39:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:39:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:39:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:39:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:39:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:39:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:39:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:02 INFO - 'talos_options': ['--disable-e10s'], 14:39:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:39:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:39:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:02 INFO - 'talos_options': ['--disable-e10s'], 14:39:02 INFO - 'tests': ['damp', 'tps']}, 14:39:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:02 INFO - 'tests': ['damp', 'tps']}, 14:39:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:39:02 INFO - 'tests': ['dromaeo_dom']}, 14:39:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:39:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:39:02 INFO - 'tests': ['basic_compositor_video']}, 14:39:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:39:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:39:02 INFO - 'tests': ['a11yr', 14:39:02 INFO - 'ts_paint', 14:39:02 INFO - 'tpaint', 14:39:02 INFO - 'sessionrestore', 14:39:02 INFO - 'sessionrestore_no_auto_restore', 14:39:02 INFO - 'tabpaint']}, 14:39:02 INFO - 'other-e10s': {'tests': ['a11yr', 14:39:02 INFO - 'ts_paint', 14:39:02 INFO - 'tpaint', 14:39:02 INFO - 'sessionrestore', 14:39:02 INFO - 'sessionrestore_no_auto_restore', 14:39:02 INFO - 'tabpaint']}, 14:39:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:39:02 INFO - 'ts_paint', 14:39:02 INFO - 'tpaint', 14:39:02 INFO - 'sessionrestore', 14:39:02 INFO - 'sessionrestore_no_auto_restore', 14:39:02 INFO - 'tabpaint']}, 14:39:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:39:02 INFO - 'ts_paint', 14:39:02 INFO - 'tpaint', 14:39:02 INFO - 'sessionrestore', 14:39:02 INFO - 'sessionrestore_no_auto_restore', 14:39:02 INFO - 'tabpaint']}, 14:39:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:39:02 INFO - 'tests': ['a11yr', 14:39:02 INFO - 'ts_paint', 14:39:02 INFO - 'tpaint', 14:39:02 INFO - 'sessionrestore', 14:39:02 INFO - 'sessionrestore_no_auto_restore', 14:39:02 INFO - 'tabpaint']}, 14:39:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:39:02 INFO - 'tests': ['a11yr', 14:39:02 INFO - 'ts_paint', 14:39:02 INFO - 'tpaint', 14:39:02 INFO - 'sessionrestore', 14:39:02 INFO - 'sessionrestore_no_auto_restore', 14:39:02 INFO - 'tabpaint']}, 14:39:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:39:02 INFO - 'tests': ['tsvgx', 14:39:02 INFO - 'tsvgr_opacity', 14:39:02 INFO - 'tart', 14:39:02 INFO - 'tscrollx', 14:39:02 INFO - 'cart']}, 14:39:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:39:02 INFO - 'tsvgr_opacity', 14:39:02 INFO - 'tart', 14:39:02 INFO - 'tscrollx', 14:39:02 INFO - 'cart']}, 14:39:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:02 INFO - 'talos_options': ['--disable-e10s'], 14:39:02 INFO - 'tests': ['tp5o']}, 14:39:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:02 INFO - 'tests': ['tp5o']}, 14:39:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:02 INFO - 'talos_options': ['--disable-e10s', 14:39:02 INFO - '--xperf_path', 14:39:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:39:02 INFO - 'tests': ['tp5n']}, 14:39:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:02 INFO - 'talos_options': ['--xperf_path', 14:39:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:39:02 INFO - 'tests': ['tp5n']}}, 14:39:02 INFO - 'talos.zip': {'path': '', 14:39:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:39:02 INFO - Running post-action listener: _resource_record_post_action 14:39:02 INFO - [mozharness: 2016-10-11 21:39:02.107487Z] Finished populate-webroot step (success) 14:39:02 INFO - [mozharness: 2016-10-11 21:39:02.107575Z] Running create-virtualenv step. 14:39:02 INFO - Running pre-action listener: _resource_record_pre_action 14:39:02 INFO - Running main action method: create_virtualenv 14:39:02 INFO - Creating virtualenv /builds/slave/test/build/venv 14:39:02 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:39:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:39:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:39:02 INFO - Using real prefix '/usr' 14:39:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:39:02 INFO - Installing distribute.............................................................................................................................................................................................done. 14:39:04 INFO - Installing pip.................done. 14:39:04 INFO - Return code: 0 14:39:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:39:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:39:04 INFO - Reading from file tmpfile_stdout 14:39:04 INFO - Output received: 14:39: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) 14:39:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:39: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')]} 14:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39: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')]} 14:39:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39: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 0x7fd532588f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d7f60>, '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 0x26d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d91d0>, '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': '923d835db2ba3686ebe126b700000192-1476221770.971008-777042118', '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 14:39: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 14:39: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 14:39:04 INFO - Using env: {'DISPLAY': ':0', 14:39:04 INFO - 'HOME': '/home/cltbld', 14:39:04 INFO - 'LANG': 'en_US.UTF-8', 14:39:04 INFO - 'LANGUAGE': 'en_US:en', 14:39:04 INFO - 'LOGNAME': 'cltbld', 14:39:04 INFO - 'MAIL': '/var/mail/cltbld', 14:39:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:04 INFO - 'MOZ_NO_REMOTE': '1', 14:39:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:04 INFO - 'NO_EM_RESTART': '1', 14:39:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:04 INFO - 'PWD': '/builds/slave/test', 14:39:04 INFO - 'SHELL': '/bin/bash', 14:39:04 INFO - 'SHLVL': '1', 14:39:04 INFO - 'TERM': 'linux', 14:39:04 INFO - 'TMOUT': '86400', 14:39:04 INFO - 'USER': 'cltbld', 14:39:04 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476221770.971008-777042118', 14:39:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:04 INFO - '_': '/tools/buildbot/bin/python'} 14:39:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:05 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:39:05 INFO - Cleaning up... 14:39:05 INFO - Return code: 0 14:39:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd532588f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d7f60>, '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 0x26d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d91d0>, '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': '923d835db2ba3686ebe126b700000192-1476221770.971008-777042118', '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 14:39:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:39:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:39:05 INFO - Using env: {'DISPLAY': ':0', 14:39:05 INFO - 'HOME': '/home/cltbld', 14:39:05 INFO - 'LANG': 'en_US.UTF-8', 14:39:05 INFO - 'LANGUAGE': 'en_US:en', 14:39:05 INFO - 'LOGNAME': 'cltbld', 14:39:05 INFO - 'MAIL': '/var/mail/cltbld', 14:39:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:05 INFO - 'MOZ_NO_REMOTE': '1', 14:39:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:05 INFO - 'NO_EM_RESTART': '1', 14:39:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:05 INFO - 'PWD': '/builds/slave/test', 14:39:05 INFO - 'SHELL': '/bin/bash', 14:39:05 INFO - 'SHLVL': '1', 14:39:05 INFO - 'TERM': 'linux', 14:39:05 INFO - 'TMOUT': '86400', 14:39:05 INFO - 'USER': 'cltbld', 14:39:05 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476221770.971008-777042118', 14:39:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:05 INFO - '_': '/tools/buildbot/bin/python'} 14:39:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:05 INFO - Downloading/unpacking psutil>=3.1.1 14:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:39:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:39:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:39:07 INFO - Installing collected packages: psutil 14:39:07 INFO - Running setup.py install for psutil 14:39:07 INFO - building 'psutil._psutil_linux' extension 14:39:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:39: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_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:39:07 INFO - building 'psutil._psutil_posix' extension 14:39:07 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 14:39: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 14:39:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:39:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:39:07 INFO - Successfully installed psutil 14:39:07 INFO - Cleaning up... 14:39:07 INFO - Return code: 0 14:39:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:39: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')]} 14:39:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39: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')]} 14:39:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39: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 0x7fd532588f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d7f60>, '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 0x26d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d91d0>, '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': '923d835db2ba3686ebe126b700000192-1476221770.971008-777042118', '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 14:39: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 14:39: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 14:39:07 INFO - Using env: {'DISPLAY': ':0', 14:39:07 INFO - 'HOME': '/home/cltbld', 14:39:07 INFO - 'LANG': 'en_US.UTF-8', 14:39:07 INFO - 'LANGUAGE': 'en_US:en', 14:39:07 INFO - 'LOGNAME': 'cltbld', 14:39:07 INFO - 'MAIL': '/var/mail/cltbld', 14:39:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:07 INFO - 'MOZ_NO_REMOTE': '1', 14:39:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:07 INFO - 'NO_EM_RESTART': '1', 14:39:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:07 INFO - 'PWD': '/builds/slave/test', 14:39:07 INFO - 'SHELL': '/bin/bash', 14:39:07 INFO - 'SHLVL': '1', 14:39:07 INFO - 'TERM': 'linux', 14:39:07 INFO - 'TMOUT': '86400', 14:39:07 INFO - 'USER': 'cltbld', 14:39:07 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476221770.971008-777042118', 14:39:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:07 INFO - '_': '/tools/buildbot/bin/python'} 14:39:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:39:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:39:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:39:10 INFO - Installing collected packages: mozsystemmonitor 14:39:10 INFO - Running setup.py install for mozsystemmonitor 14:39:10 INFO - Successfully installed mozsystemmonitor 14:39:10 INFO - Cleaning up... 14:39:10 INFO - Return code: 0 14:39:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd532588f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d7f60>, '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 0x26d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d91d0>, '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': '923d835db2ba3686ebe126b700000192-1476221770.971008-777042118', '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 14:39:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:39:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:39:10 INFO - Using env: {'DISPLAY': ':0', 14:39:10 INFO - 'HOME': '/home/cltbld', 14:39:10 INFO - 'LANG': 'en_US.UTF-8', 14:39:10 INFO - 'LANGUAGE': 'en_US:en', 14:39:10 INFO - 'LOGNAME': 'cltbld', 14:39:10 INFO - 'MAIL': '/var/mail/cltbld', 14:39:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:10 INFO - 'MOZ_NO_REMOTE': '1', 14:39:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:10 INFO - 'NO_EM_RESTART': '1', 14:39:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:10 INFO - 'PWD': '/builds/slave/test', 14:39:10 INFO - 'SHELL': '/bin/bash', 14:39:10 INFO - 'SHLVL': '1', 14:39:10 INFO - 'TERM': 'linux', 14:39:10 INFO - 'TMOUT': '86400', 14:39:10 INFO - 'USER': 'cltbld', 14:39:10 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476221770.971008-777042118', 14:39:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:10 INFO - '_': '/tools/buildbot/bin/python'} 14:39:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:10 INFO - Downloading/unpacking jsonschema==2.5.1 14:39:10 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 14:39:10 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 14:39:10 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 14:39:10 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 14:39:10 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 14:39:10 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 14:39:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:39:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:39: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 14:39: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 14:39: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 14:39: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 14:39: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 14:39: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 14:39:12 INFO - Downloading functools32-3.2.3-2.tar.gz 14:39:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:39:12 INFO - warning: no files found matching '*.txt' 14:39:12 INFO - no previously-included directories found matching 'build' 14:39:12 INFO - no previously-included directories found matching 'dist' 14:39:12 INFO - no previously-included directories found matching '.git*' 14:39:12 INFO - Installing collected packages: jsonschema, functools32 14:39:12 INFO - Running setup.py install for functools32 14:39:12 INFO - warning: no files found matching '*.txt' 14:39:12 INFO - no previously-included directories found matching 'build' 14:39:12 INFO - no previously-included directories found matching 'dist' 14:39:12 INFO - no previously-included directories found matching '.git*' 14:39:12 INFO - Successfully installed jsonschema functools32 14:39:12 INFO - Cleaning up... 14:39:12 INFO - Return code: 0 14:39:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:39: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')]} 14:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39: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')]} 14:39:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39: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 0x7fd532588f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d7f60>, '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 0x26d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d91d0>, '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': '923d835db2ba3686ebe126b700000192-1476221770.971008-777042118', '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 14:39: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 14:39: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 14:39:12 INFO - Using env: {'DISPLAY': ':0', 14:39:12 INFO - 'HOME': '/home/cltbld', 14:39:12 INFO - 'LANG': 'en_US.UTF-8', 14:39:12 INFO - 'LANGUAGE': 'en_US:en', 14:39:12 INFO - 'LOGNAME': 'cltbld', 14:39:12 INFO - 'MAIL': '/var/mail/cltbld', 14:39:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:12 INFO - 'MOZ_NO_REMOTE': '1', 14:39:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:12 INFO - 'NO_EM_RESTART': '1', 14:39:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:12 INFO - 'PWD': '/builds/slave/test', 14:39:12 INFO - 'SHELL': '/bin/bash', 14:39:12 INFO - 'SHLVL': '1', 14:39:12 INFO - 'TERM': 'linux', 14:39:12 INFO - 'TMOUT': '86400', 14:39:12 INFO - 'USER': 'cltbld', 14:39:12 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476221770.971008-777042118', 14:39:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:12 INFO - '_': '/tools/buildbot/bin/python'} 14:39:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:39:13 INFO - Cleaning up... 14:39:13 INFO - Return code: 0 14:39:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd532588f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d7f60>, '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 0x26d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d91d0>, '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': '923d835db2ba3686ebe126b700000192-1476221770.971008-777042118', '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 14:39:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:39:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:39:13 INFO - Using env: {'DISPLAY': ':0', 14:39:13 INFO - 'HOME': '/home/cltbld', 14:39:13 INFO - 'LANG': 'en_US.UTF-8', 14:39:13 INFO - 'LANGUAGE': 'en_US:en', 14:39:13 INFO - 'LOGNAME': 'cltbld', 14:39:13 INFO - 'MAIL': '/var/mail/cltbld', 14:39:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:13 INFO - 'MOZ_NO_REMOTE': '1', 14:39:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:13 INFO - 'NO_EM_RESTART': '1', 14:39:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:13 INFO - 'PWD': '/builds/slave/test', 14:39:13 INFO - 'SHELL': '/bin/bash', 14:39:13 INFO - 'SHLVL': '1', 14:39:13 INFO - 'TERM': 'linux', 14:39:13 INFO - 'TMOUT': '86400', 14:39:13 INFO - 'USER': 'cltbld', 14:39:13 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476221770.971008-777042118', 14:39:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:13 INFO - '_': '/tools/buildbot/bin/python'} 14:39:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:13 INFO - Downloading/unpacking blobuploader==1.2.4 14:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:15 INFO - Downloading blobuploader-1.2.4.tar.gz 14:39:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:39:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:39:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:15 INFO - Downloading docopt-0.6.1.tar.gz 14:39:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:39:16 INFO - Installing collected packages: blobuploader, requests, docopt 14:39:16 INFO - Running setup.py install for blobuploader 14:39:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:39:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:39:16 INFO - Running setup.py install for requests 14:39:16 INFO - Running setup.py install for docopt 14:39:16 INFO - Successfully installed blobuploader requests docopt 14:39:16 INFO - Cleaning up... 14:39:16 INFO - Return code: 0 14:39:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:39:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:16 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 0x7fd532588f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d7f60>, '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 0x26d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d91d0>, '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': '923d835db2ba3686ebe126b700000192-1476221770.971008-777042118', '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 14:39:16 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 14:39:16 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 14:39:16 INFO - Using env: {'DISPLAY': ':0', 14:39:16 INFO - 'HOME': '/home/cltbld', 14:39:16 INFO - 'LANG': 'en_US.UTF-8', 14:39:16 INFO - 'LANGUAGE': 'en_US:en', 14:39:16 INFO - 'LOGNAME': 'cltbld', 14:39:16 INFO - 'MAIL': '/var/mail/cltbld', 14:39:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:16 INFO - 'MOZ_NO_REMOTE': '1', 14:39:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:16 INFO - 'NO_EM_RESTART': '1', 14:39:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:16 INFO - 'PWD': '/builds/slave/test', 14:39:16 INFO - 'SHELL': '/bin/bash', 14:39:16 INFO - 'SHLVL': '1', 14:39:16 INFO - 'TERM': 'linux', 14:39:16 INFO - 'TMOUT': '86400', 14:39:16 INFO - 'USER': 'cltbld', 14:39:16 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476221770.971008-777042118', 14:39:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:16 INFO - '_': '/tools/buildbot/bin/python'} 14:39:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:39:16 INFO - Running setup.py (path:/tmp/pip-ZjwwYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:39:16 INFO - Running setup.py (path:/tmp/pip-WC23q9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:39:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:39:16 INFO - Running setup.py (path:/tmp/pip-SmLy2I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:39:17 INFO - Running setup.py (path:/tmp/pip-QAK1uL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:39:17 INFO - Running setup.py (path:/tmp/pip-dCk0KX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:39:17 INFO - Running setup.py (path:/tmp/pip-61eVjt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:39:17 INFO - Running setup.py (path:/tmp/pip-gx22bs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:39:17 INFO - Running setup.py (path:/tmp/pip-BOss3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:39:17 INFO - Running setup.py (path:/tmp/pip-g3QH1o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:39:17 INFO - Running setup.py (path:/tmp/pip-dzKS40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:39:17 INFO - Running setup.py (path:/tmp/pip-x5TvLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:39:17 INFO - Running setup.py (path:/tmp/pip-HSnCiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:39:17 INFO - Running setup.py (path:/tmp/pip-EjOSS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:39:17 INFO - Running setup.py (path:/tmp/pip-6chvt3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:39:17 INFO - Running setup.py (path:/tmp/pip-zEKy7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:39:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:39:17 INFO - Running setup.py (path:/tmp/pip-i6yibx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:39:18 INFO - Running setup.py (path:/tmp/pip-z1Pnxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:39:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:39:18 INFO - Running setup.py install for manifestparser 14:39:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:39:18 INFO - Running setup.py install for mozcrash 14:39:18 INFO - Running setup.py install for mozdebug 14:39:18 INFO - Running setup.py install for mozdevice 14:39:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:39:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:39:18 INFO - Running setup.py install for mozfile 14:39:18 INFO - Running setup.py install for mozhttpd 14:39:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:39:18 INFO - Running setup.py install for mozinfo 14:39:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:39:18 INFO - Running setup.py install for mozInstall 14:39:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:39:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:39:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:39:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:39:18 INFO - Running setup.py install for mozleak 14:39:19 INFO - Running setup.py install for mozlog 14:39:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:39:19 INFO - Running setup.py install for moznetwork 14:39:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:39:19 INFO - Running setup.py install for mozprocess 14:39:19 INFO - Running setup.py install for mozprofile 14:39:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:39:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:39:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:39:19 INFO - Running setup.py install for mozrunner 14:39:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:39:19 INFO - Running setup.py install for mozscreenshot 14:39:19 INFO - Running setup.py install for moztest 14:39:19 INFO - Running setup.py install for mozversion 14:39:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:39:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:39:19 INFO - Cleaning up... 14:39:19 INFO - Return code: 0 14:39:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:39: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')]} 14:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39: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')]} 14:39:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39: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 0x7fd532588f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d7f60>, '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 0x26d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d91d0>, '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': '923d835db2ba3686ebe126b700000192-1476221770.971008-777042118', '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 14:39: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 14:39: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 14:39:19 INFO - Using env: {'DISPLAY': ':0', 14:39:19 INFO - 'HOME': '/home/cltbld', 14:39:19 INFO - 'LANG': 'en_US.UTF-8', 14:39:19 INFO - 'LANGUAGE': 'en_US:en', 14:39:19 INFO - 'LOGNAME': 'cltbld', 14:39:19 INFO - 'MAIL': '/var/mail/cltbld', 14:39:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:19 INFO - 'MOZ_NO_REMOTE': '1', 14:39:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:19 INFO - 'NO_EM_RESTART': '1', 14:39:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:19 INFO - 'PWD': '/builds/slave/test', 14:39:19 INFO - 'SHELL': '/bin/bash', 14:39:19 INFO - 'SHLVL': '1', 14:39:19 INFO - 'TERM': 'linux', 14:39:19 INFO - 'TMOUT': '86400', 14:39:19 INFO - 'USER': 'cltbld', 14:39:19 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476221770.971008-777042118', 14:39:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:19 INFO - '_': '/tools/buildbot/bin/python'} 14:39:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:39:20 INFO - Running setup.py (path:/tmp/pip-WXziUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:39:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:39:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:39:20 INFO - Running setup.py (path:/tmp/pip-E3HIlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:39:20 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)) 14:39:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:39:20 INFO - Running setup.py (path:/tmp/pip-NQfeqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:39:20 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)) 14:39:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:39:20 INFO - Running setup.py (path:/tmp/pip-Xu2n1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:39:20 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)) 14:39:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:39:20 INFO - Running setup.py (path:/tmp/pip-oAoTOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:39:20 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)) 14:39:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:39:20 INFO - Running setup.py (path:/tmp/pip-ryGaZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:39:20 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)) 14:39:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:39:20 INFO - Running setup.py (path:/tmp/pip-xhGZfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:39:20 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)) 14:39:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:39:20 INFO - Running setup.py (path:/tmp/pip-OrsyXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:39:20 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)) 14:39:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:39:20 INFO - Running setup.py (path:/tmp/pip-fm4EK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:39:20 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)) 14:39:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:39:20 INFO - Running setup.py (path:/tmp/pip-883P0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:39: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)) 14:39:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:39:20 INFO - Running setup.py (path:/tmp/pip-q1VvD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:39: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)) 14:39:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:39:20 INFO - Running setup.py (path:/tmp/pip-nWt9Zi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:39:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:39:21 INFO - Running setup.py (path:/tmp/pip-OYehYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:39:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:39:21 INFO - Running setup.py (path:/tmp/pip-2YF_X6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:39:21 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)) 14:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:39:21 INFO - Running setup.py (path:/tmp/pip-J1Chht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:39:21 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)) 14:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:39:21 INFO - Running setup.py (path:/tmp/pip-0q4OYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:39:21 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)) 14:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:39:21 INFO - Running setup.py (path:/tmp/pip-fghaas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:39:21 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)) 14:39:21 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)) 14:39:21 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)) 14:39:21 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)) 14:39:21 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)) 14:39:21 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)) 14:39:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:39:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:39:23 INFO - Downloading blessings-1.6.tar.gz 14:39:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:39:23 INFO - Installing collected packages: blessings 14:39:23 INFO - Running setup.py install for blessings 14:39:23 INFO - Successfully installed blessings 14:39:23 INFO - Cleaning up... 14:39:23 INFO - Return code: 0 14:39:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:39:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:39:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:39:23 INFO - Reading from file tmpfile_stdout 14:39:23 INFO - Current package versions: 14:39:23 INFO - argparse == 1.2.1 14:39:23 INFO - blessings == 1.6 14:39:23 INFO - blobuploader == 1.2.4 14:39:23 INFO - docopt == 0.6.1 14:39:23 INFO - functools32 == 3.2.3-2 14:39:23 INFO - jsonschema == 2.5.1 14:39:23 INFO - manifestparser == 1.1 14:39:23 INFO - mozInstall == 1.12 14:39:23 INFO - mozcrash == 0.17 14:39:23 INFO - mozdebug == 0.1 14:39:23 INFO - mozdevice == 0.48 14:39:23 INFO - mozfile == 1.2 14:39:23 INFO - mozhttpd == 0.7 14:39:23 INFO - mozinfo == 0.9 14:39:23 INFO - mozleak == 0.1 14:39:23 INFO - mozlog == 3.4 14:39:23 INFO - moznetwork == 0.27 14:39:23 INFO - mozprocess == 0.23 14:39:23 INFO - mozprofile == 0.28 14:39:23 INFO - mozrunner == 6.12 14:39:23 INFO - mozscreenshot == 0.1 14:39:23 INFO - mozsystemmonitor == 0.3 14:39:23 INFO - moztest == 0.7 14:39:23 INFO - mozversion == 1.4 14:39:23 INFO - psutil == 3.1.1 14:39:23 INFO - requests == 1.2.3 14:39:23 INFO - wsgiref == 0.1.2 14:39:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:39: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')]} 14:39:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39: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')]} 14:39:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39:23 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 0x7fd532588f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d7f60>, '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 0x26d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d91d0>, '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': '923d835db2ba3686ebe126b700000192-1476221770.971008-777042118', '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 14:39:23 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 14:39:23 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 14:39:23 INFO - Using env: {'DISPLAY': ':0', 14:39:23 INFO - 'HOME': '/home/cltbld', 14:39:23 INFO - 'LANG': 'en_US.UTF-8', 14:39:23 INFO - 'LANGUAGE': 'en_US:en', 14:39:23 INFO - 'LOGNAME': 'cltbld', 14:39:23 INFO - 'MAIL': '/var/mail/cltbld', 14:39:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:23 INFO - 'MOZ_NO_REMOTE': '1', 14:39:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:23 INFO - 'NO_EM_RESTART': '1', 14:39:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:23 INFO - 'PWD': '/builds/slave/test', 14:39:23 INFO - 'SHELL': '/bin/bash', 14:39:23 INFO - 'SHLVL': '1', 14:39:23 INFO - 'TERM': 'linux', 14:39:23 INFO - 'TMOUT': '86400', 14:39:23 INFO - 'USER': 'cltbld', 14:39:23 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476221770.971008-777042118', 14:39:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:23 INFO - '_': '/tools/buildbot/bin/python'} 14:39:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39: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)) 14:39: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)) 14:39: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)) 14:39: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)) 14:39: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)) 14:39: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)) 14:39: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)) 14:39: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)) 14:39: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)) 14:39: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)) 14:39: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)) 14:39:23 INFO - Cleaning up... 14:39:23 INFO - Return code: 0 14:39:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:39: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')]} 14:39:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39: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')]} 14:39:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39: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 0x7fd532588f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26daca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26d7f60>, '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 0x26d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d91d0>, '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': '923d835db2ba3686ebe126b700000192-1476221770.971008-777042118', '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 14:39: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 14:39: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 14:39:23 INFO - Using env: {'DISPLAY': ':0', 14:39:23 INFO - 'HOME': '/home/cltbld', 14:39:23 INFO - 'LANG': 'en_US.UTF-8', 14:39:23 INFO - 'LANGUAGE': 'en_US:en', 14:39:23 INFO - 'LOGNAME': 'cltbld', 14:39:23 INFO - 'MAIL': '/var/mail/cltbld', 14:39:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:23 INFO - 'MOZ_NO_REMOTE': '1', 14:39:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:23 INFO - 'NO_EM_RESTART': '1', 14:39:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:23 INFO - 'PWD': '/builds/slave/test', 14:39:23 INFO - 'SHELL': '/bin/bash', 14:39:23 INFO - 'SHLVL': '1', 14:39:23 INFO - 'TERM': 'linux', 14:39:23 INFO - 'TMOUT': '86400', 14:39:23 INFO - 'USER': 'cltbld', 14:39:23 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476221770.971008-777042118', 14:39:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:23 INFO - '_': '/tools/buildbot/bin/python'} 14:39:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:39:24 INFO - Cleaning up... 14:39:24 INFO - Return code: 0 14:39:24 INFO - Running post-action listener: _resource_record_post_action 14:39:24 INFO - Running post-action listener: _start_resource_monitoring 14:39:24 INFO - Starting resource monitoring. 14:39:24 INFO - [mozharness: 2016-10-11 21:39:24.238561Z] Finished create-virtualenv step (success) 14:39:24 INFO - [mozharness: 2016-10-11 21:39:24.239072Z] Running install step. 14:39:24 INFO - Running pre-action listener: _resource_record_pre_action 14:39:24 INFO - Running main action method: install 14:39:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:39:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:39:24 INFO - Reading from file tmpfile_stdout 14:39:24 INFO - Detecting whether we're running mozinstall >=1.0... 14:39:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:39:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:39:24 INFO - Reading from file tmpfile_stdout 14:39:24 INFO - Output received: 14:39:24 INFO - Usage: mozinstall [options] installer 14:39:24 INFO - Options: 14:39:24 INFO - -h, --help show this help message and exit 14:39:24 INFO - -d DEST, --destination=DEST 14:39:24 INFO - Directory to install application into. [default: 14:39:24 INFO - "/builds/slave/test"] 14:39:24 INFO - --app=APP Application being installed. [default: firefox] 14:39:24 INFO - mkdir: /builds/slave/test/build/application 14:39:24 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'] 14:39:24 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 14:39:40 INFO - Reading from file tmpfile_stdout 14:39:40 INFO - Output received: 14:39:40 INFO - /builds/slave/test/build/application/firefox/firefox 14:39:40 INFO - Running post-action listener: _resource_record_post_action 14:39:40 INFO - [mozharness: 2016-10-11 21:39:40.693841Z] Finished install step (success) 14:39:40 INFO - [mozharness: 2016-10-11 21:39:40.694083Z] Running run-tests step. 14:39:40 INFO - Running pre-action listener: _resource_record_pre_action 14:39:40 INFO - Running main action method: run_tests 14:39:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:39:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:39:40 INFO - Python 2.7.3 14:39:40 INFO - Return code: 0 14:39:40 INFO - grabbing minidump binary from tooltool 14:39:40 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')]} 14:39:40 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 0x26d7f60>, '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 0x26d8d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26d91d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:39:40 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 14:39:40 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 14:39:40 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 14:39:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:39:40 INFO - Return code: 0 14:39:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:39:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:39:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:39:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:39:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:39:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e82tohu8T4OvkLUPgnuRUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:39:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/e82tohu8T4OvkLUPgnuRUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:39:40 INFO - Using env: {'DISPLAY': ':0', 14:39:40 INFO - 'HOME': '/home/cltbld', 14:39:40 INFO - 'LANG': 'en_US.UTF-8', 14:39:40 INFO - 'LANGUAGE': 'en_US:en', 14:39:40 INFO - 'LOGNAME': 'cltbld', 14:39:40 INFO - 'MAIL': '/var/mail/cltbld', 14:39:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:39:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:39:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:40 INFO - 'MOZ_NO_REMOTE': '1', 14:39:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:39:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:40 INFO - 'NO_EM_RESTART': '1', 14:39:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:40 INFO - 'PWD': '/builds/slave/test', 14:39:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:39:40 INFO - 'SHELL': '/bin/bash', 14:39:40 INFO - 'SHLVL': '1', 14:39:40 INFO - 'TERM': 'linux', 14:39:40 INFO - 'TMOUT': '86400', 14:39:40 INFO - 'USER': 'cltbld', 14:39:40 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1476221770.971008-777042118', 14:39:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:40 INFO - '_': '/tools/buildbot/bin/python'} 14:39:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/e82tohu8T4OvkLUPgnuRUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:39:40 INFO - mozversion application_buildid: 20161011131646 14:39:40 INFO - mozversion application_changeset: 8fef52daf4b5be227469a5603da1211e50c895b6 14:39:40 INFO - mozversion application_display_name: Nightly 14:39:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:39:40 INFO - mozversion application_name: Firefox 14:39:40 INFO - mozversion application_remotingname: firefox 14:39:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 14:39:40 INFO - mozversion application_vendor: Mozilla 14:39:40 INFO - mozversion application_version: 52.0a1 14:39:40 INFO - mozversion platform_buildid: 20161011131646 14:39:40 INFO - mozversion platform_changeset: 8fef52daf4b5be227469a5603da1211e50c895b6 14:39:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 14:39:40 INFO - mozversion platform_version: 52.0a1 14:39:40 INFO - using testdate: 1476221980 14:39:40 INFO - actual date: 1476221980 14:39:40 INFO - starting webserver on 'localhost:35365' 14:39:40 INFO - SUITE-START | Running 2 tests 14:39:40 INFO - TEST-START | dromaeo_css 14:39:40 INFO - operating with platform_type : linux_ 14:39:40 INFO - Initialising browser for dromaeo_css test... 14:39:40 INFO - TEST-INFO | started process 30067 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoDRx7Y/profile http://localhost:35365/getInfo.html) 14:39:45 INFO - PROCESS | 30067 | __metrics Screen width/height:1600/1200 14:39:45 INFO - PROCESS | 30067 | colorDepth:24 14:39:45 INFO - PROCESS | 30067 | Browser inner width/height: 1024/697 14:39:45 INFO - PROCESS | 30067 | __metrics 14:39:45 INFO - PROCESS | 30067 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:39:45 INFO - PROCESS | 30067 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:39:46 INFO - PROCESS | 30067 | console.error: PushService: 14:39:46 INFO - PROCESS | 30067 | stateChangeProcessEnqueue: Error transitioning state 14:39:46 INFO - PROCESS | 30067 | UnknownError 14:39:46 INFO - TEST-INFO | 30067: exit 0 14:39:46 INFO - Browser initialized. 14:39:46 INFO - Running cycle 1/1 for dromaeo_css test... 14:39:46 INFO - TEST-INFO | started process 30150 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoDRx7Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:39:59 INFO - PROCESS | 30150 | RSS: Main: 174710784 14:39:59 INFO - PROCESS | 30150 | 14:40:50 INFO - PROCESS | 30150 | 1476222050660 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] 14:43:02 INFO - PROCESS | 30150 | Cycle 1(1): loaded http://localhost:35365/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35365/tests/dromaeo/cssquery-ext.html) 14:43:05 INFO - PROCESS | 30150 | RSS: Main: 428941312 14:43:05 INFO - PROCESS | 30150 | 14:46:08 INFO - PROCESS | 30150 | Cycle 1(1): loaded http://localhost:35365/tests/dromaeo/cssquery-ext.html (next: http://localhost:35365/tests/dromaeo/cssquery-jquery.html) 14:46:08 INFO - PROCESS | 30150 | RSS: Main: 282537984 14:46:08 INFO - PROCESS | 30150 | 14:49:10 INFO - PROCESS | 30150 | Cycle 1(1): loaded http://localhost:35365/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35365/tests/dromaeo/cssquery-mootools.html) 14:49:11 INFO - PROCESS | 30150 | RSS: Main: 258609152 14:49:11 INFO - PROCESS | 30150 | 14:52:13 INFO - PROCESS | 30150 | Cycle 1(1): loaded http://localhost:35365/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35365/tests/dromaeo/cssquery-prototype.html) 14:52:14 INFO - PROCESS | 30150 | RSS: Main: 220016640 14:52:14 INFO - PROCESS | 30150 | 14:55:17 INFO - PROCESS | 30150 | Cycle 1(1): loaded http://localhost:35365/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35365/tests/dromaeo/cssquery-yui.html) 14:55:18 INFO - PROCESS | 30150 | RSS: Main: 217219072 14:55:18 INFO - PROCESS | 30150 | 14:58:21 INFO - PROCESS | 30150 | Cycle 1(1): loaded http://localhost:35365/tests/dromaeo/cssquery-yui.html (next: http://localhost:35365/tests/dromaeo/cssquery-dojo.html) 14:58:21 INFO - PROCESS | 30150 | RSS: Main: 314494976 14:58:21 INFO - PROCESS | 30150 | 14:58:21 INFO - PROCESS | 30150 | __start_tp_report 14:58:21 INFO - PROCESS | 30150 | _x_x_mozilla_page_load 14:58:21 INFO - PROCESS | 30150 | _x_x_mozilla_page_load_details 14:58:21 INFO - PROCESS | 30150 | |i|pagename|runs| 14:58:21 INFO - PROCESS | 30150 | |0;dojo.html;2526.5957446808516;2546.4525127097672;2581.987090064549;2585.469978654376;2591.4557942831993;4399.05420334628;4491;4517.751523666201;4521.547845215477;4556.248219043858;4520.570545798152;4535.274356103024;4552.408186935702;4554.703944243622;4627.981843994316;4154.501459824825;4167.812448439828;4219.177260434217;4221.092465119998;4233.597808208216;3859.8456061757497;4224.957750422487;4250.53244143144;4288.335308027261;4334.959609693682;4135.193637240739;4235.4917409911;4249.490061192677;4305.05288836457;4339.1972485090355;4180.226658068236;4184.602462766033;4215.367694845798;4235.703500754948;4256.34026725858;4201.663866890672;4203.159368126357;4206.789660516993;4265.083007153446;4265.104328091104;4535.501094879561;4556.066006468666;4569.794359253841;4574;4622.1911165546235;4738.715677059387;4800.039992001579;4802.75986200692;4843.152448321565;4931.063098011402;4852.611791056707;4852.708837469728;4858.416989961192;4863.902721945577;4867.51324867514;4515.480719717241;4604.102200071021;4606.378138951232;4609.8156073757345;4612.0545288215835;4947.060058588857;4948.653594248368;4948.826791062295;4949.604031677457;5005.449400565934;4755.595774359218;4758.619310455155;4759.952400476021;4815.686980346266;4825.203841366206;4701.48283688794;4764.2615394613895;4765.237561990065;4773.236282194832;4779.617630589544;4727.149113159664;4763.976180119077;4827.951720482821;4832.081904438145;4842.443119041285;4739.549742774431;4748.287756836502;4749.097671442415;4756.857294281177;4807.831725889647;3995.2409042281874;4040;4067.1052368478886;4069.5726948670554;4126.525449573277;3539.805310707936;3570.839312230956;3583.4803953427127;3610.476480910306;3649.6897763689853;4240.448741663626;4247.532771395144;4253.447051883235;4253.936190957138;4298.914021719548;4895.118878601886;4895.412550493892;4902.90194196114;4909.042736666316;4948.975255123773;4155.771432571177;4195.014171669655;4196.202721482909;4203.369494575838;4292.59220374064;4354.390385346054;4363.934540981888;4365.105153443536;4366;4366.563343665608;4525.479569849444;4586.174488592085;4586.449626044896;4589.5181005994555;4594.494605593449;4827.468978412442;4850.490698476609;4853.466118726867;4869.172240719157;4874.366332376769;4504.369388285577;4554.908901822011;4563.201439747964;4566.2237419639405;4566.725996440225;4743.407074115736;4749.4063242094735;4799.328094066764;4800.183968725255;4806.6875653083835;4811.975940120277;4812.470628230822;4815.95184048155;4843.636727245541;4877.975610121926;4540.36434899121;4691.812327506998;4707.340972263954;4707.364505791675;4770.236762118045;4574.88562785933;4626.583607475343;4627.1439783640135;4629.213033784332;4631.374764406762;4575.0392417592675;4584.747838868894;4585.793639286173;4589.885252868705;4606.516315786794;4677.602403795579;4679.766011699469;4688.132695451352;4770.356001939694;4815.711057336571;4718.97640511809;4723.197056500472;4728.290756386569;4728.527147285244;4733.786979585996 14:58:21 INFO - PROCESS | 30150 | |1;ext.html;555.8693706978861;572.5791543215734;578.6672663218649;583.1864548954209;587.0226073587477;27582.310442238955;38780.22439551207;39529.80235098828;39595.80202098989;43410.34884476735;40142.7992860036;40613;40628.59371406285;40657.59342406575;40676;7641.2740789624895;7784.338331241851;7790.766277011699;7794.298513133816;7795.727149549767;7185.820354491128;7404.074490688664;9683.322167448281;9954.452505112216;9960.950195249014;9720.465374404404;9803.509824508781;9813.411195328303;9817.558209880537;9818;9841.901580984206;9918.851217231748;9921.404715717008;9924.007599240054;9929.553170107363;9671.226301895831;9740.707778766648;9746.610135594568;9750.366226195274;9752.073553012453;37958;37986.43020354697;38028.429573556416;38088.42867356992;38362.61637383619;3020.6073210482496;3220.9355812883846;3448.913777155566;3482.512448257246;3585.4801053847045;28078.578821317697;28295.858520707265;28322.57516137239;29832;29884.8505757472;3040.4375190589813;3125.796823206484;3154.0853152585723;3207.3905957867933;3243.0919342584116;249624;250634;250651;252233;252234.99999999817;31764.364712705617;32719.18202044968;52775.47224527706;53122.73438632859;53302.73348633232;33487.33025339479;33581;33755.15612109717;33813.32373352519;33902.83048584791;12183.45174467151;12244.938775306067;12336.568220112433;12345.814812777815;12350.691232719253;9107.590158442887;9249;10315.484225788681;10507.94746026265;10529.36823790575;7715.267049630276;7987;7995.40034497415;8011.799705007422;8086;3010.668826429091;3024.6691455759396;3048.8170709757487;3095.4892442746695;3099.9535006974916;873.4017198219113;894.7360528644066;894.7763059235191;917.5733284022962;922.5940586142076;26937.86531067332;27829.304267393072;27853.57355018742;27880.581791273147;28304;932.4498545857977;938.737153596994;977.2719324103447;982.2289502740315;1026.4764969865273;14433.494827680981;14451.097804391218;14537.273136343141;14560.126392416489;14703.485378011932;397653;402445;403616;404294;408060;48888.26667599989;49327.753361232964;49354.50645493571;49380.259296110584;49451.258231126565;1031.2626472072504;1085.1102096280974;1147.2256227046544;1157.774234024374;1182.7457096724245;25384.238472845846;28305.43389132247;29011.274718132216;29425.70574294315;29573;35841.82079089588;36067;36167.638323616426;36186.63813361938;36668.083297917765;290580;292366;292440;292555;292810;24728.629070564315;25152.49695006126;25623.359416014748;25639;26670.333241669112;40012.799936000134;40166.397504036875;40188.7990560057;40580.39129413002;41827.58172418358;34889.651103489654;34965.47551786776;35123.82438087793;35283.82358088193;35405.82297088498;34915;35290.64738849805;35401.822990885914;35407.29185416329;35721;34513.65486345205;34637;34740.13149671177;35296.64703353036;35469.82265088658;29382.706172937997;31620.209494762814;31710.207244818142;31864.36271274515;32168.83915580407;23854.403639909142;24187.15344962918;24296.635550467112;24427.389315266548;24643.753562464863 14:58:21 INFO - PROCESS | 30150 | |2;jquery.html;339.8759452799729;356.51157913658307;359.3944204016233;364.44422256059505;385.7087898636529;12018.879811201885;12996.805047924288;15395.692086158284;16190.19049047546;17426.47720568382;16182.514524564252;16266.674666506662;16541.172941352914;17362.91318543409;17468.388606398777;4583.197940360424;4888.120138375091;4888.926666100011;5114.309568208281;5115.2071428928575;4955;5090.414602320743;5096.898062038757;5098.668586541881;5100.668456550312;5087.982403519292;5094.949050509503;5101.311322971407;5102.209157580581;5158.252053452247;5365.222042803791;5518.061929471999;5530;5530.087535556629;5532.640378375433;5170.767315470813;5257.395399529027;5286.259923610698;5349.812756553541;5359.526130314195;12181.512739490498;12339.814902776465;12345.38273086342;12366.690832729164;14225.78661320081;1929.3054500379992;1972.0731256309655;1975.841932645385;1985.493699106733;2231.252530402301;8942;9079.319051071196;9263.305252106118;9545.379550329206;9554.474503902282;1637.2386840119402;1671.0809055019813;1681.974770378433;1684.1158391844258;1684.7388654758408;60939.39060609426;66904;70344.2965570343;71233;73450;9120.908790912139;9361.4383137012;9462.356992557914;9774.413535187769;10131.341462804894;13690.178589284675;13697.452101916011;13714.382852771649;13715.451381944611;13723.1079979801;7041.155061392666;7217;7361.963190184015;7377.11474623038;7535;6951.339622735832;7064.258252883374;7212.819679508054;7263.92736072643;7267.745628902963;4173.520045194841;4278.144371125787;4303.526612072669;4387.078713470207;4404.559544045634;1580.4231455518652;1629.6822119686547;1722.5788724302502;1735.895846249204;1766.1124062158208;636.8312397214742;800.4449123085766;810.3841080778651;816.1348970091722;892.3084609427746;16434.917825410797;16997.64724648081;17170.22733976974;17381;17571.56071098207;838.6100463284602;848.4781859156698;851.1786126388065;870.7083127152348;874.156439036333;9035.141661542142;9868.457234852152;9884.950575247078;9898.60405583783;9991.700248992542;337788;339267;374755;399535;399558;73809;74112.62943685355;76922;77173;77479;871.4335681806749;880.1550511509023;914.1178762494092;914.3964983111115;914.5518695839124;14477.565673029825;14777.92611036981;15161.772573411186;16066.919665401598;16893.32426702918;36426;36535.45196821997;37111.628883710815;37616;38159;44240.33639495474;45782.771086144356;47227.29159062548;47781;50120.74939625279;7307;7622.428317876071;7740.690372385042;7843.098043724816;7855.7250496232355;8598.054214036325;11010;11237.662870113909;11797.410129493663;11823.11326650522;10116.494175291058;10630.30902991303;10767.892321077003;10919.454027298762;11079.058280046287;10000.949900260368;10477.842832357368;10583.259171857895;10608.363498190134;10839.67480975572;10663.626773062906;10995.120390368911;11021.669349919515;11108.666739997812;11487.597934072268;7399.297066778648;7657.808554785952;7663.69345226207;7740.883886741816;8021.27808497238;8474.533900635524;9901.405915645084;10385.376877387382;10534.36793792375;10719.196060295664 14:58:21 INFO - PROCESS | 30150 | |3;mootools.html;1335.933203339833;1362.6797702539902;1398.7482253194428;1598.1210334316124;1661.368679901638;6533.31400202979;6763.763268285611;7095.290470952902;7658.846823063543;7679;7059.788206353817;7360.0431943847225;7364.668589913454;7552.395808335334;7555.6599953002105;2022.2921977307935;2050.190174880921;2056.609244243589;2060.4436802063433;2062.102985201442;1760.5246583422468;1825.516238196879;2025.2202901882733;2038.6636205026152;2050.528378472952;2105;2162.76209616942;2174.706414634028;2190.6823510590953;2194.5281764420647;2106.6418708819383;2111.9366419007456;2119.703241546177;2147.967780483294;2148.6562150055915;2131.3605918224625;2132.051237199447;2136.636771748791;2137.700721898935;2149.365937048559;7392.297731715478;7470.178280389153;7472.140703819022;7492.625368731596;7507.249275072503;4314.590113939202;4442.400275962736;4506.571875671806;4510.25580779171;4515.254982927813;2714.7149549297237;2872.540393537024;2899.3911278631513;2916.5916771651987;2928.5167947288674;924.089771574998;934.2759361494828;947.6020071569957;949.9192568631674;959.4866746290701;10051.145652619536;10072.798544029078;10082.89917100827;10094.242931780072;10102.9494852526;3846.5576458707046;3992.321305378093;3999.5200575931076;4026.1142548639255;4162.375643653476;8667.783305417415;8746.650133994695;8755.868661970075;8763.386562940534;8769.166929141722;4510.0528888933695;4533.252013417815;4537.77311134442;4541.364209010741;4562.384078149474;4033.153037862082;4118.135191609796;4132.380142978577;4170.937435938464;4173.749575025508;3544.4328907374697;3582.265635544707;3596.3166998270244;3686.2811751708696;3723.94414083789;1054.1672079057612;1097.9890201097887;1139.8347239650204;1160.2400427719856;1180.6044974933322;605.3129697792949;660.4155322539588;715.1311156944233;721.5995122706948;758.0865057605572;4623.491415944243;4652.744099074515;4727.645426592951;4795.712257264575;4837.443693975238;824.2169938558274;826.8181000179951;897.9595918183697;912.5574096563295;916.7478943290648;3308.3714094322004;3408.4205685033603;3417.4532074867902;3418.8632454701533;3529.682328590388;8499.872501912476;8825.205731484197;9297.163255307054;9306.255499560019;9311.860322095174;8773.166549177819;9055.909440905638;9073.31950103745;9079.636814527477;9084.909150908406;6630.204375474877;6655.334466553403;6783.966080169567;6796.422304104207;6921.411680007155;4890.315355850113;4950.579200767975;4987.725675087905;5061.468545802785;5204;8079.919200807916;8305.626246819029;8315.126911674188;8584.270337021424;8609.139086091342;8399.874001890099;8568.91431085706;8625.784355390915;8631.56842157902;8693.956530217309;6349.238091429058;6393.369690728834;6444.516661250331;6445.613263204223;6454.257760357431;7079.1505019395945;7142.214356420894;7155.499115061895;7197.964010179916;7208.603526805866;6470.579412338183;6599.868002640016;6603.7688680895935;6621.470282377302;6735.764248251484;6314.305426403;6326.557141000086;6456.6771661415805;6469.77355792545;6552.934470655423;5838;5898.1152827076285;5912;5925.703714814156;5981.0131328330335;4196.580341965779;4214.346776249687;4242.406063151223;4327.913441731211;4334.26317526015;4169.791510424406;4174.582541745801;4203.915921681488;4226.746395216297;4299.634531064769 14:58:21 INFO - PROCESS | 30150 | |4;prototype.html;295.3281285076451;298.55813396173664;303.7752063473029;307.1599176252949;308.71289700578467;4778.71327720337;4808.663393562452;4812.25410061441;4821.204501257297;4833.061055239981;4758.428988521374;4759.690620109691;4759.952400475994;4765.499622539635;4771.90456190876;3562.6081131075625;3673.540807399075;3711.4061750119986;3748.737588368815;3764.642358975893;3774.169682669808;3774.584795672474;3776.2636285924254;3776.8300426480873;3792.222594368148;3753.3994560870265;3768.679662228714;3779.546454425473;3779.9433008504893;3782.243551289739;3566.6789988900996;3648.2338708870902;3664.725145614063;3756.3614185588517;3771.623876957513;3295.2750394913082;3310.486874534451;3316.7512436567354;3322.6178989416285;3341.198112453018;4649.04694537619;4655.487896331435;4662.696924699883;4668.603168730662;4684.203685373494;4101.425800387948;4270.743755374657;4274.551172126913;4281.785910704452;4286.592773686495;4950.653454258203;4957.652964292501;4965;4988.950110498885;4991.7038162445315;3597.010822023938;3606.170580766412;3608.9639103608893;3611.693006094485;3622.710183185339;5033;5210.687358758487;5226;5236.973815130977;5266.210068489757;3561.5904171020147;3577.4276115821344;3579.982100089483;3580.3197392495345;3584.354816133121;3657.65252301031;3658.4695219193068;3667.9083022924106;3678.2459595782802;3687.2441149564274;4156.709030367906;4160.417541544186;4165.208610364021;4165.4584903962295;4177.728447650893;4708.576228139415;4937.259411088366;4948.925766113512;4960.950390496121;4966;1267.7971524556026;1283.3968035023524;1283.9422225999851;1287.8454585449806;1292.095533126815;784.5214419204281;828.9668413263522;836.6695155413578;839.5214727605329;843.3759018326394;4257.743965530176;4345.022369966732;4366.388705581221;4387.583179597933;4472.195004899084;5162.179986809809;5181.715005674649;5205.349331333583;5221.441493668151;5226.5818734501145;4492.146492166478;4516.570925762047;4525.977370113194;4526.547345265447;4531.184386810406;2666.719994400599;2746.6429364182527;2768.224897028835;2771.80597358187;2775.0287399410045;4870.683405578626;4878.07316609843;4883;4885.2427873679635;4913.287573301851;5078.263651770472;5288.68267903927;5297.337832770903;5306.92039619406;5313.229581710631;4837.685550439211;4842.539958703917;4845.8061677532505;4855.34452848875;4886.242632391985;5140.665856719302;5144.819931302386;5169.92245116316;5180.48195180479;5191.792328306826;4891.926621100615;4987.177115775857;5079.060373830853;5095.898082038264;5097.235414687826;4822.9148441600355;4836.0258441057795;4841.95158048415;4863.148948933993;4868.732219727949;3616.4504024662024;3623.9818800905828;3624.5831729350407;3632.891013269606;3633.8728144514816;4957.6281778866005;5129.897402052013;5149.613778966517;5154.433012368711;5172.327597412313;4939.431965324034;5028.818227716411;5032.547070763649;5038.924416133687;5045.291710592638;4977.352944117241;4996.975015125046;5005.149124648746;5010.799568017239;5014.6991180529285;4717.716936983792;4943.826966056171;4949.356583644103;4959.3386215618175;4968.701877887338;4776.426828780569;4971.527704868032;5015.673981191211;5048.242763585492;5056.572845034478;4833.226683730586;4840.685355451885;4844.660873738945;4868.123737727102;4868.537488938545 14:58:21 INFO - PROCESS | 30150 | |5;yui.html;599.2180204832691;604.4892066204059;608.9451949324559;613.3835495327196;619.5477301569857;12097.153199276043;12661.177023493477;12734.490620375174;12766.936165319172;12930.741385172314;13179.538716144936;13708.794368084487;13782.379792909318;13787.241701706402;13832.585022449342;599.8710277290381;746.481195569081;764.8623247815391;766.5094339622646;767.0948281028384;614.1340709599466;728.3081072980663;760.2891296637633;767.9193684663114;768.3776141325516;793.4009822583942;795.7453614843253;796.7888509544946;798.0981490915258;798.5488199167452;623.4918541388754;787.1027029186731;788.0189164490189;788.148799296761;788.2550989315099;470.9623230141615;543.2042058384446;573.9569532285095;575.712143928036;576.0926540698417;12050.638480845588;12101.757964840743;12105.09211809109;12371.75256494874;12458.626241212778;11667.474963626657;11670.766584668345;12574.81137782934;12724.745505089939;13028.54400095992;11339.546418143264;11400.144989125765;11446.31322120667;11446.771064578745;11521.36632485213;4049.9392509112386;4076.6249894019793;4111.568285330027;4147.709660323779;4184.456020717318;58991.41008589902;59111.11333330003;59134.40865591332;59196;59981.40018599802;9777.364471309342;10007.199424046059;10101.69694909154;10216.489175541343;10350.637727679496;18665.626687466174;18763.155657995423;18810.059497025366;18840.52898677544;18845.811541884406;6375.936240637627;6422.4862011039;6441.871162576722;6520.836979075466;6768.5938843668555;3591.6049234584175;3608.224231790125;3620.4388319810473;3663.8534458621357;3710.7588006779474;2642.128097727745;2766.681831589353;2766.958495622567;2769.2799872033415;3061.892833750853;549.9257600223999;550.1664977559001;553.7259056766926;555.3446932619547;561.6461629173594;497.93526841510374;522.7830450363133;584.9266595796676;591.5977135547782;607.696151924038;8130.878036829452;8261.586920653943;8324.417290789586;8335.624896879655;8602.408554417452;593.1221791748237;602.9969850150809;609.2749627942734;611.400827189357;618.4897459595761;3789.4694742736037;4172.937405938914;4187.267228235047;4192.350185721218;4217.957820421818;97027.51486242523;97765.5111724451;98267;99284.50357748165;101703.49148254211;73541;76955.61522192354;82928;86307;86685.56657216673;40428;55696;58538;60322.396776032554;69889;7852.396029564553;8734.475931444134;8802.779930501789;9125.361224714206;9148.313876459426;41642.58357416387;41846.790766045975;42063.7896810514;42689.5731042698;44225.55774442343;56154.43845561655;56460.71769641126;59768;60707.69646151741;60803.78392432215;11076.169287303646;11152.553897843994;11161.441927903736;11312.83030754523;11470.082393408675;12683.429245683781;12786.168899021533;12962.09265351454;12986.610401687965;13336.266065456364;11584.884151158381;12087.274763514217;12238.082143839425;12661.28348487034;12724.809127863275;11048.447577621248;11269.323840569592;11988.880111198776;12085.274883507018;12555.874441255835;11956.880431195925;12490.313032783284;12502.249865008129;12511.311877846805;12532.310722909962;9993.450360229966;10018.39889606626;10091.39451632875;10206.642767503101;10874.510647021061;9392.765180870532;10120.493975301059;10131.240156988402;10187.541560629641;10217.846732298873 14:58:21 INFO - PROCESS | 30150 | __end_tp_report 14:58:21 INFO - PROCESS | 30150 | __start_cc_report 14:58:21 INFO - PROCESS | 30150 | _x_x_mozilla_cycle_collect,2889 14:58:21 INFO - PROCESS | 30150 | __end_cc_report 14:58:21 INFO - PROCESS | 30150 | __startTimestamp1476223101307__endTimestamp 14:58:21 INFO - PROCESS | 30150 | 14:58:21 INFO - PROCESS | 30150 | ------- Summary: start ------- 14:58:21 INFO - PROCESS | 30150 | Number of tests: 6 14:58:21 INFO - PROCESS | 30150 | 14:58:21 INFO - PROCESS | 30150 | [#0] dojo.html Cycles:165 Average:4483.00 Median:4589.52 stddev:455.27 (9.9%) stddev-sans-first:430.02 14:58:21 INFO - PROCESS | 30150 | Values: 2526.6 2546.5 2582.0 2585.5 2591.5 4399.1 4491.0 4517.8 4521.5 4556.2 4520.6 4535.3 4552.4 4554.7 4628.0 4154.5 4167.8 4219.2 4221.1 4233.6 3859.8 4225.0 4250.5 4288.3 4335.0 4135.2 4235.5 4249.5 4305.1 4339.2 4180.2 4184.6 4215.4 4235.7 4256.3 4201.7 4203.2 4206.8 4265.1 4265.1 4535.5 4556.1 4569.8 4574.0 4622.2 4738.7 4800.0 4802.8 4843.2 4931.1 4852.6 4852.7 4858.4 4863.9 4867.5 4515.5 4604.1 4606.4 4609.8 4612.1 4947.1 4948.7 4948.8 4949.6 5005.4 4755.6 4758.6 4760.0 4815.7 4825.2 4701.5 4764.3 4765.2 4773.2 4779.6 4727.1 4764.0 4828.0 4832.1 4842.4 4739.5 4748.3 4749.1 4756.9 4807.8 3995.2 4040.0 4067.1 4069.6 4126.5 3539.8 3570.8 3583.5 3610.5 3649.7 4240.4 4247.5 4253.4 4253.9 4298.9 4895.1 4895.4 4902.9 4909.0 4949.0 4155.8 4195.0 4196.2 4203.4 4292.6 4354.4 4363.9 4365.1 4366.0 4366.6 4525.5 4586.2 4586.4 4589.5 4594.5 4827.5 4850.5 4853.5 4869.2 4874.4 4504.4 4554.9 4563.2 4566.2 4566.7 4743.4 4749.4 4799.3 4800.2 4806.7 4812.0 4812.5 4816.0 4843.6 4878.0 4540.4 4691.8 4707.3 4707.4 4770.2 4574.9 4626.6 4627.1 4629.2 4631.4 4575.0 4584.7 4585.8 4589.9 4606.5 4677.6 4679.8 4688.1 4770.4 4815.7 4719.0 4723.2 4728.3 4728.5 4733.8 14:58:21 INFO - PROCESS | 30150 | 14:58:21 INFO - PROCESS | 30150 | [#1] ext.html Cycles:180 Average:45633.26 Median:35349.24 stddev:84978.54 (240.4%) stddev-sans-first:85149.53 14:58:21 INFO - PROCESS | 30150 | Values: 555.9 572.6 578.7 583.2 587.0 27582.3 38780.2 39529.8 39595.8 43410.3 40142.8 40613.0 40628.6 40657.6 40676.0 7641.3 7784.3 7790.8 7794.3 7795.7 7185.8 7404.1 9683.3 9954.5 9961.0 9720.5 9803.5 9813.4 9817.6 9818.0 9841.9 9918.9 9921.4 9924.0 9929.6 9671.2 9740.7 9746.6 9750.4 9752.1 37958.0 37986.4 38028.4 38088.4 38362.6 3020.6 3220.9 3448.9 3482.5 3585.5 28078.6 28295.9 28322.6 29832.0 29884.9 3040.4 3125.8 3154.1 3207.4 3243.1 249624.0 250634.0 250651.0 252233.0 252235.0 31764.4 32719.2 52775.5 53122.7 53302.7 33487.3 33581.0 33755.2 33813.3 33902.8 12183.5 12244.9 12336.6 12345.8 12350.7 9107.6 9249.0 10315.5 10507.9 10529.4 7715.3 7987.0 7995.4 8011.8 8086.0 3010.7 3024.7 3048.8 3095.5 3100.0 873.4 894.7 894.8 917.6 922.6 26937.9 27829.3 27853.6 27880.6 28304.0 932.4 938.7 977.3 982.2 1026.5 14433.5 14451.1 14537.3 14560.1 14703.5 397653.0 402445.0 403616.0 404294.0 408060.0 48888.3 49327.8 49354.5 49380.3 49451.3 1031.3 1085.1 1147.2 1157.8 1182.7 25384.2 28305.4 29011.3 29425.7 29573.0 35841.8 36067.0 36167.6 36186.6 36668.1 290580.0 292366.0 292440.0 292555.0 292810.0 24728.6 25152.5 25623.4 25639.0 26670.3 40012.8 40166.4 40188.8 40580.4 41827.6 34889.7 34965.5 35123.8 35283.8 35405.8 34915.0 35290.6 35401.8 35407.3 35721.0 34513.7 34637.0 34740.1 35296.6 35469.8 29382.7 31620.2 31710.2 31864.4 32168.8 23854.4 24187.2 24296.6 24427.4 24643.8 14:58:21 INFO - PROCESS | 30150 | 14:58:21 INFO - PROCESS | 30150 | [#2] jquery.html Cycles:180 Average:23318.01 Median:25905.24 stddev:61387.07 (237.0%) stddev-sans-first:61535.03 14:58:21 INFO - PROCESS | 30150 | Values: 339.9 356.5 359.4 364.4 385.7 12018.9 12996.8 15395.7 16190.2 17426.5 16182.5 16266.7 16541.2 17362.9 17468.4 4583.2 4888.1 4888.9 5114.3 5115.2 4955.0 5090.4 5096.9 5098.7 5100.7 5088.0 5094.9 5101.3 5102.2 5158.3 5365.2 5518.1 5530.0 5530.1 5532.6 5170.8 5257.4 5286.3 5349.8 5359.5 12181.5 12339.8 12345.4 12366.7 14225.8 1929.3 1972.1 1975.8 1985.5 2231.3 8942.0 9079.3 9263.3 9545.4 9554.5 1637.2 1671.1 1682.0 1684.1 1684.7 60939.4 66904.0 70344.3 71233.0 73450.0 9120.9 9361.4 9462.4 9774.4 10131.3 13690.2 13697.5 13714.4 13715.5 13723.1 7041.2 7217.0 7362.0 7377.1 7535.0 6951.3 7064.3 7212.8 7263.9 7267.7 4173.5 4278.1 4303.5 4387.1 4404.6 1580.4 1629.7 1722.6 1735.9 1766.1 636.8 800.4 810.4 816.1 892.3 16434.9 16997.6 17170.2 17381.0 17571.6 838.6 848.5 851.2 870.7 874.2 9035.1 9868.5 9885.0 9898.6 9991.7 337788.0 339267.0 374755.0 399535.0 399558.0 73809.0 74112.6 76922.0 77173.0 77479.0 871.4 880.2 914.1 914.4 914.6 14477.6 14777.9 15161.8 16066.9 16893.3 36426.0 36535.5 37111.6 37616.0 38159.0 44240.3 45782.8 47227.3 47781.0 50120.7 7307.0 7622.4 7740.7 7843.1 7855.7 8598.1 11010.0 11237.7 11797.4 11823.1 10116.5 10630.3 10767.9 10919.5 11079.1 10000.9 10477.8 10583.3 10608.4 10839.7 10663.6 10995.1 11021.7 11108.7 11487.6 7399.3 7657.8 7663.7 7740.9 8021.3 8474.5 9901.4 10385.4 10534.4 10719.2 14:58:21 INFO - PROCESS | 30150 | 14:58:21 INFO - PROCESS | 30150 | [#3] mootools.html Cycles:180 Average:4886.08 Median:4920.45 stddev:2708.64 (55.0%) stddev-sans-first:2703.10 14:58:21 INFO - PROCESS | 30150 | Values: 1335.9 1362.7 1398.7 1598.1 1661.4 6533.3 6763.8 7095.3 7658.8 7679.0 7059.8 7360.0 7364.7 7552.4 7555.7 2022.3 2050.2 2056.6 2060.4 2062.1 1760.5 1825.5 2025.2 2038.7 2050.5 2105.0 2162.8 2174.7 2190.7 2194.5 2106.6 2111.9 2119.7 2148.0 2148.7 2131.4 2132.1 2136.6 2137.7 2149.4 7392.3 7470.2 7472.1 7492.6 7507.2 4314.6 4442.4 4506.6 4510.3 4515.3 2714.7 2872.5 2899.4 2916.6 2928.5 924.1 934.3 947.6 949.9 959.5 10051.1 10072.8 10082.9 10094.2 10102.9 3846.6 3992.3 3999.5 4026.1 4162.4 8667.8 8746.7 8755.9 8763.4 8769.2 4510.1 4533.3 4537.8 4541.4 4562.4 4033.2 4118.1 4132.4 4170.9 4173.7 3544.4 3582.3 3596.3 3686.3 3723.9 1054.2 1098.0 1139.8 1160.2 1180.6 605.3 660.4 715.1 721.6 758.1 4623.5 4652.7 4727.6 4795.7 4837.4 824.2 826.8 898.0 912.6 916.7 3308.4 3408.4 3417.5 3418.9 3529.7 8499.9 8825.2 9297.2 9306.3 9311.9 8773.2 9055.9 9073.3 9079.6 9084.9 6630.2 6655.3 6784.0 6796.4 6921.4 4890.3 4950.6 4987.7 5061.5 5204.0 8079.9 8305.6 8315.1 8584.3 8609.1 8399.9 8568.9 8625.8 8631.6 8694.0 6349.2 6393.4 6444.5 6445.6 6454.3 7079.2 7142.2 7155.5 7198.0 7208.6 6470.6 6599.9 6603.8 6621.5 6735.8 6314.3 6326.6 6456.7 6469.8 6552.9 5838.0 5898.1 5912.0 5925.7 5981.0 4196.6 4214.3 4242.4 4327.9 4334.3 4169.8 4174.6 4203.9 4226.7 4299.6 14:58:21 INFO - PROCESS | 30150 | 14:58:21 INFO - PROCESS | 30150 | [#4] prototype.html Cycles:180 Average:4155.12 Median:4768.70 stddev:1205.83 (25.3%) stddev-sans-first:1173.90 14:58:21 INFO - PROCESS | 30150 | Values: 295.3 298.6 303.8 307.2 308.7 4778.7 4808.7 4812.3 4821.2 4833.1 4758.4 4759.7 4760.0 4765.5 4771.9 3562.6 3673.5 3711.4 3748.7 3764.6 3774.2 3774.6 3776.3 3776.8 3792.2 3753.4 3768.7 3779.5 3779.9 3782.2 3566.7 3648.2 3664.7 3756.4 3771.6 3295.3 3310.5 3316.8 3322.6 3341.2 4649.0 4655.5 4662.7 4668.6 4684.2 4101.4 4270.7 4274.6 4281.8 4286.6 4950.7 4957.7 4965.0 4989.0 4991.7 3597.0 3606.2 3609.0 3611.7 3622.7 5033.0 5210.7 5226.0 5237.0 5266.2 3561.6 3577.4 3580.0 3580.3 3584.4 3657.7 3658.5 3667.9 3678.2 3687.2 4156.7 4160.4 4165.2 4165.5 4177.7 4708.6 4937.3 4948.9 4961.0 4966.0 1267.8 1283.4 1283.9 1287.8 1292.1 784.5 829.0 836.7 839.5 843.4 4257.7 4345.0 4366.4 4387.6 4472.2 5162.2 5181.7 5205.3 5221.4 5226.6 4492.1 4516.6 4526.0 4526.5 4531.2 2666.7 2746.6 2768.2 2771.8 2775.0 4870.7 4878.1 4883.0 4885.2 4913.3 5078.3 5288.7 5297.3 5306.9 5313.2 4837.7 4842.5 4845.8 4855.3 4886.2 5140.7 5144.8 5169.9 5180.5 5191.8 4891.9 4987.2 5079.1 5095.9 5097.2 4822.9 4836.0 4842.0 4863.1 4868.7 3616.5 3624.0 3624.6 3632.9 3633.9 4957.6 5129.9 5149.6 5154.4 5172.3 4939.4 5028.8 5032.5 5038.9 5045.3 4977.4 4997.0 5005.1 5010.8 5014.7 4717.7 4943.8 4949.4 4959.3 4968.7 4776.4 4971.5 5015.7 5048.2 5056.6 4833.2 4840.7 4844.7 4868.1 4868.5 14:58:21 INFO - PROCESS | 30150 | 14:58:21 INFO - PROCESS | 30150 | [#5] yui.html Cycles:180 Average:17049.45 Median:23140.87 stddev:23915.94 (103.3%) stddev-sans-first:23951.13 14:58:21 INFO - PROCESS | 30150 | Values: 599.2 604.5 608.9 613.4 619.5 12097.2 12661.2 12734.5 12766.9 12930.7 13179.5 13708.8 13782.4 13787.2 13832.6 599.9 746.5 764.9 766.5 767.1 614.1 728.3 760.3 767.9 768.4 793.4 795.7 796.8 798.1 798.5 623.5 787.1 788.0 788.1 788.3 471.0 543.2 574.0 575.7 576.1 12050.6 12101.8 12105.1 12371.8 12458.6 11667.5 11670.8 12574.8 12724.7 13028.5 11339.5 11400.1 11446.3 11446.8 11521.4 4049.9 4076.6 4111.6 4147.7 4184.5 58991.4 59111.1 59134.4 59196.0 59981.4 9777.4 10007.2 10101.7 10216.5 10350.6 18665.6 18763.2 18810.1 18840.5 18845.8 6375.9 6422.5 6441.9 6520.8 6768.6 3591.6 3608.2 3620.4 3663.9 3710.8 2642.1 2766.7 2767.0 2769.3 3061.9 549.9 550.2 553.7 555.3 561.6 497.9 522.8 584.9 591.6 607.7 8130.9 8261.6 8324.4 8335.6 8602.4 593.1 603.0 609.3 611.4 618.5 3789.5 4172.9 4187.3 4192.4 4218.0 97027.5 97765.5 98267.0 99284.5 101703.5 73541.0 76955.6 82928.0 86307.0 86685.6 40428.0 55696.0 58538.0 60322.4 69889.0 7852.4 8734.5 8802.8 9125.4 9148.3 41642.6 41846.8 42063.8 42689.6 44225.6 56154.4 56460.7 59768.0 60707.7 60803.8 11076.2 11152.6 11161.4 11312.8 11470.1 12683.4 12786.2 12962.1 12986.6 13336.3 11584.9 12087.3 12238.1 12661.3 12724.8 11048.4 11269.3 11988.9 12085.3 12555.9 11956.9 12490.3 12502.2 12511.3 12532.3 9993.5 10018.4 10091.4 10206.6 10874.5 9392.8 10120.5 10131.2 10187.5 10217.8 14:58:21 INFO - PROCESS | 30150 | -------- Summary: end -------- 14:58:21 INFO - PROCESS | 30150 | 14:58:22 INFO - TEST-INFO | 30150: exit 0 14:58:22 INFO - TEST-OK | dromaeo_css | took 1121352ms 14:58:22 INFO - TEST-START | kraken 14:58:22 INFO - operating with platform_type : linux_ 14:58:22 INFO - Initialising browser for kraken test... 14:58:22 INFO - TEST-INFO | started process 30456 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLHsxix/profile http://localhost:35365/getInfo.html) 14:58:26 INFO - PROCESS | 30456 | __metrics Screen width/height:1600/1200 14:58:26 INFO - PROCESS | 30456 | colorDepth:24 14:58:26 INFO - PROCESS | 30456 | Browser inner width/height: 1024/697 14:58:26 INFO - PROCESS | 30456 | __metrics 14:58:26 INFO - PROCESS | 30456 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:58:26 INFO - PROCESS | 30456 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:58:27 INFO - PROCESS | 30456 | console.error: PushService: 14:58:27 INFO - PROCESS | 30456 | stateChangeProcessEnqueue: Error transitioning state 14:58:27 INFO - PROCESS | 30456 | UnknownError 14:58:28 INFO - TEST-INFO | 30456: exit 0 14:58:28 INFO - Browser initialized. 14:58:28 INFO - Running cycle 1/1 for kraken test... 14:58:28 INFO - TEST-INFO | started process 30542 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLHsxix/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:58:40 INFO - PROCESS | 30542 | RSS: Main: 174026752 14:58:40 INFO - PROCESS | 30542 | 14:58:43 INFO - PROCESS | 30542 | Cycle 1(1): loaded http://localhost:35365/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35365/tests/kraken/driver.html?testName=audio-beat-detection) 14:58:44 INFO - PROCESS | 30542 | RSS: Main: 232570880 14:58:44 INFO - PROCESS | 30542 | 14:58:46 INFO - PROCESS | 30542 | Cycle 1(1): loaded http://localhost:35365/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35365/tests/kraken/driver.html?testName=audio-dft) 14:58:47 INFO - PROCESS | 30542 | RSS: Main: 217513984 14:58:47 INFO - PROCESS | 30542 | 14:58:50 INFO - PROCESS | 30542 | Cycle 1(1): loaded http://localhost:35365/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35365/tests/kraken/driver.html?testName=audio-fft) 14:58:51 INFO - PROCESS | 30542 | RSS: Main: 299786240 14:58:51 INFO - PROCESS | 30542 | 14:58:53 INFO - PROCESS | 30542 | Cycle 1(1): loaded http://localhost:35365/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35365/tests/kraken/driver.html?testName=audio-oscillator) 14:58:54 INFO - PROCESS | 30542 | RSS: Main: 210726912 14:58:54 INFO - PROCESS | 30542 | 14:58:56 INFO - PROCESS | 30542 | Cycle 1(1): loaded http://localhost:35365/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35365/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:58:57 INFO - PROCESS | 30542 | RSS: Main: 213430272 14:58:57 INFO - PROCESS | 30542 | 14:59:00 INFO - PROCESS | 30542 | Cycle 1(1): loaded http://localhost:35365/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35365/tests/kraken/driver.html?testName=imaging-darkroom) 14:59:00 INFO - PROCESS | 30542 | RSS: Main: 249778176 14:59:00 INFO - PROCESS | 30542 | 14:59:04 INFO - PROCESS | 30542 | Cycle 1(1): loaded http://localhost:35365/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35365/tests/kraken/driver.html?testName=imaging-desaturate) 14:59:04 INFO - PROCESS | 30542 | RSS: Main: 248586240 14:59:04 INFO - PROCESS | 30542 | 14:59:07 INFO - PROCESS | 30542 | Cycle 1(1): loaded http://localhost:35365/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35365/tests/kraken/driver.html?testName=json-parse-financial) 14:59:08 INFO - PROCESS | 30542 | RSS: Main: 248520704 14:59:08 INFO - PROCESS | 30542 | 14:59:10 INFO - PROCESS | 30542 | Cycle 1(1): loaded http://localhost:35365/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35365/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:59:10 INFO - PROCESS | 30542 | RSS: Main: 210870272 14:59:10 INFO - PROCESS | 30542 | 14:59:12 INFO - PROCESS | 30542 | Cycle 1(1): loaded http://localhost:35365/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35365/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:59:13 INFO - PROCESS | 30542 | RSS: Main: 218140672 14:59:13 INFO - PROCESS | 30542 | 14:59:15 INFO - PROCESS | 30542 | Cycle 1(1): loaded http://localhost:35365/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35365/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:59:16 INFO - PROCESS | 30542 | RSS: Main: 227532800 14:59:16 INFO - PROCESS | 30542 | 14:59:18 INFO - PROCESS | 30542 | Cycle 1(1): loaded http://localhost:35365/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35365/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:59:19 INFO - PROCESS | 30542 | RSS: Main: 235995136 14:59:19 INFO - PROCESS | 30542 | 14:59:22 INFO - PROCESS | 30542 | Cycle 1(1): loaded http://localhost:35365/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35365/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:59:23 INFO - PROCESS | 30542 | RSS: Main: 232333312 14:59:23 INFO - PROCESS | 30542 | 14:59:25 INFO - PROCESS | 30542 | Cycle 1(1): loaded http://localhost:35365/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35365/tests/kraken/driver.html?testName=ai-astar) 14:59:25 INFO - PROCESS | 30542 | RSS: Main: 282988544 14:59:25 INFO - PROCESS | 30542 | 14:59:25 INFO - PROCESS | 30542 | __start_tp_report 14:59:25 INFO - PROCESS | 30542 | _x_x_mozilla_page_load 14:59:25 INFO - PROCESS | 30542 | _x_x_mozilla_page_load_details 14:59:25 INFO - PROCESS | 30542 | |i|pagename|runs| 14:59:25 INFO - PROCESS | 30542 | |0;ai-astar;111;113;113;114;114;117;114;114;115;114 14:59:25 INFO - PROCESS | 30542 | |1;audio-beat-detection;153;131;130;165;133;127;132;135;181;125 14:59:25 INFO - PROCESS | 30542 | |2;audio-dft;160;160;162;161;161;162;164;161;161;160 14:59:25 INFO - PROCESS | 30542 | |3;audio-fft;75;76;76;114;76;76;76;76;108;76 14:59:25 INFO - PROCESS | 30542 | |4;audio-oscillator;85;84;120;84;83;83;114;83;83;120 14:59:25 INFO - PROCESS | 30542 | |5;imaging-gaussian-blur;118;118;118;117;118;117;118;117;117;117 14:59:25 INFO - PROCESS | 30542 | |6;imaging-darkroom;147;146;146;146;147;146;146;147;146;146 14:59:25 INFO - PROCESS | 30542 | |7;imaging-desaturate;96;95;94;95;95;95;94;95;94;95 14:59:25 INFO - PROCESS | 30542 | |8;json-parse-financial;73;64;64;64;64;67;67;66;65;65 14:59:25 INFO - PROCESS | 30542 | |9;json-stringify-tinderbox;65;66;66;66;66;65;66;65;66;67 14:59:25 INFO - PROCESS | 30542 | |10;stanford-crypto-aes;84;83;87;89;84;85;83;82;83;85 14:59:25 INFO - PROCESS | 30542 | |11;stanford-crypto-ccm;144;140;138;139;140;141;147;149;190;139 14:59:25 INFO - PROCESS | 30542 | |12;stanford-crypto-pbkdf2;181;176;173;175;176;178;176;176;174;177 14:59:25 INFO - PROCESS | 30542 | |13;stanford-crypto-sha256-iterative;71;71;71;74;70;74;69;74;69;69 14:59:25 INFO - PROCESS | 30542 | __end_tp_report 14:59:25 INFO - PROCESS | 30542 | __start_cc_report 14:59:25 INFO - PROCESS | 30542 | _x_x_mozilla_cycle_collect,1952 14:59:25 INFO - PROCESS | 30542 | __end_cc_report 14:59:25 INFO - PROCESS | 30542 | __startTimestamp1476223165414__endTimestamp 14:59:25 INFO - PROCESS | 30542 | 14:59:25 INFO - PROCESS | 30542 | ------- Summary: start ------- 14:59:25 INFO - PROCESS | 30542 | Number of tests: 14 14:59:25 INFO - PROCESS | 30542 | 14:59:25 INFO - PROCESS | 30542 | [#0] ai-astar Cycles:10 Average:113.90 Median:114.00 stddev:1.52 (1.3%) stddev-sans-first:1.20 14:59:25 INFO - PROCESS | 30542 | Values: 111.0 113.0 113.0 114.0 114.0 117.0 114.0 114.0 115.0 114.0 14:59:25 INFO - PROCESS | 30542 | 14:59:25 INFO - PROCESS | 30542 | [#1] audio-beat-detection Cycles:10 Average:141.20 Median:134.00 stddev:18.78 (14.0%) stddev-sans-first:19.43 14:59:25 INFO - PROCESS | 30542 | Values: 153.0 131.0 130.0 165.0 133.0 127.0 132.0 135.0 181.0 125.0 14:59:25 INFO - PROCESS | 30542 | 14:59:25 INFO - PROCESS | 30542 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.23 (0.8%) stddev-sans-first:1.22 14:59:25 INFO - PROCESS | 30542 | Values: 160.0 160.0 162.0 161.0 161.0 162.0 164.0 161.0 161.0 160.0 14:59:25 INFO - PROCESS | 30542 | 14:59:25 INFO - PROCESS | 30542 | [#3] audio-fft Cycles:10 Average:82.90 Median:76.00 stddev:14.88 (19.6%) stddev-sans-first:15.51 14:59:25 INFO - PROCESS | 30542 | Values: 75.0 76.0 76.0 114.0 76.0 76.0 76.0 76.0 108.0 76.0 14:59:25 INFO - PROCESS | 30542 | 14:59:25 INFO - PROCESS | 30542 | [#4] audio-oscillator Cycles:10 Average:93.90 Median:83.00 stddev:16.72 (20.1%) stddev-sans-first:17.42 14:59:25 INFO - PROCESS | 30542 | Values: 85.0 84.0 120.0 84.0 83.0 83.0 114.0 83.0 83.0 120.0 14:59:25 INFO - PROCESS | 30542 | 14:59:25 INFO - PROCESS | 30542 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 14:59:25 INFO - PROCESS | 30542 | Values: 118.0 118.0 118.0 117.0 118.0 117.0 118.0 117.0 117.0 117.0 14:59:25 INFO - PROCESS | 30542 | 14:59:25 INFO - PROCESS | 30542 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 14:59:25 INFO - PROCESS | 30542 | Values: 147.0 146.0 146.0 146.0 147.0 146.0 146.0 147.0 146.0 146.0 14:59:25 INFO - PROCESS | 30542 | 14:59:25 INFO - PROCESS | 30542 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 14:59:25 INFO - PROCESS | 30542 | Values: 96.0 95.0 94.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 14:59:25 INFO - PROCESS | 30542 | 14:59:25 INFO - PROCESS | 30542 | [#8] json-parse-financial Cycles:10 Average:65.90 Median:65.50 stddev:2.77 (4.2%) stddev-sans-first:1.27 14:59:25 INFO - PROCESS | 30542 | Values: 73.0 64.0 64.0 64.0 64.0 67.0 67.0 66.0 65.0 65.0 14:59:25 INFO - PROCESS | 30542 | 14:59:25 INFO - PROCESS | 30542 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 14:59:25 INFO - PROCESS | 30542 | Values: 65.0 66.0 66.0 66.0 66.0 65.0 66.0 65.0 66.0 67.0 14:59:25 INFO - PROCESS | 30542 | 14:59:25 INFO - PROCESS | 30542 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:84.50 stddev:2.12 (2.5%) stddev-sans-first:2.24 14:59:25 INFO - PROCESS | 30542 | Values: 84.0 83.0 87.0 89.0 84.0 85.0 83.0 82.0 83.0 85.0 14:59:25 INFO - PROCESS | 30542 | 14:59:25 INFO - PROCESS | 30542 | [#11] stanford-crypto-ccm Cycles:10 Average:146.70 Median:142.50 stddev:15.65 (11.0%) stddev-sans-first:16.57 14:59:25 INFO - PROCESS | 30542 | Values: 144.0 140.0 138.0 139.0 140.0 141.0 147.0 149.0 190.0 139.0 14:59:25 INFO - PROCESS | 30542 | 14:59:25 INFO - PROCESS | 30542 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.20 Median:176.00 stddev:2.20 (1.3%) stddev-sans-first:1.50 14:59:25 INFO - PROCESS | 30542 | Values: 181.0 176.0 173.0 175.0 176.0 178.0 176.0 176.0 174.0 177.0 14:59:25 INFO - PROCESS | 30542 | 14:59:25 INFO - PROCESS | 30542 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:71.00 stddev:2.10 (3.0%) stddev-sans-first:2.22 14:59:25 INFO - PROCESS | 30542 | Values: 71.0 71.0 71.0 74.0 70.0 74.0 69.0 74.0 69.0 69.0 14:59:25 INFO - PROCESS | 30542 | -------- Summary: end -------- 14:59:25 INFO - PROCESS | 30542 | 14:59:26 INFO - TEST-INFO | 30542: exit 0 14:59:26 INFO - TEST-OK | kraken | took 64393ms 14:59:26 INFO - SUITE-END | took 1185s 14:59:27 INFO - Completed test suite (00:19:46) 14:59:27 INFO - javascript benchmark 14:59:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2526.5957446808516, 2546.4525127097672, 2581.987090064549, 2585.469978654376, 2591.4557942831993, 4399.05420334628, 4491.0, 4517.751523666201, 4521.547845215477, 4556.248219043858, 4520.570545798152, 4535.274356103024, 4552.408186935702, 4554.703944243622, 4627.981843994316, 4154.501459824825, 4167.812448439828, 4219.177260434217, 4221.092465119998, 4233.597808208216, 3859.8456061757497, 4224.957750422487, 4250.53244143144, 4288.335308027261, 4334.959609693682, 4135.193637240739, 4235.4917409911, 4249.490061192677, 4305.05288836457, 4339.1972485090355, 4180.226658068236, 4184.602462766033, 4215.367694845798, 4235.703500754948, 4256.34026725858, 4201.663866890672, 4203.159368126357, 4206.789660516993, 4265.083007153446, 4265.104328091104, 4535.501094879561, 4556.066006468666, 4569.794359253841, 4574.0, 4622.1911165546235, 4738.715677059387, 4800.039992001579, 4802.75986200692, 4843.152448321565, 4931.063098011402, 4852.611791056707, 4852.708837469728, 4858.416989961192, 4863.902721945577, 4867.51324867514, 4515.480719717241, 4604.102200071021, 4606.378138951232, 4609.8156073757345, 4612.0545288215835, 4947.060058588857, 4948.653594248368, 4948.826791062295, 4949.604031677457, 5005.449400565934, 4755.595774359218, 4758.619310455155, 4759.952400476021, 4815.686980346266, 4825.203841366206, 4701.48283688794, 4764.2615394613895, 4765.237561990065, 4773.236282194832, 4779.617630589544, 4727.149113159664, 4763.976180119077, 4827.951720482821, 4832.081904438145, 4842.443119041285, 4739.549742774431, 4748.287756836502, 4749.097671442415, 4756.857294281177, 4807.831725889647, 3995.2409042281874, 4040.0, 4067.1052368478886, 4069.5726948670554, 4126.525449573277, 3539.805310707936, 3570.839312230956, 3583.4803953427127, 3610.476480910306, 3649.6897763689853, 4240.448741663626, 4247.532771395144, 4253.447051883235, 4253.936190957138, 4298.914021719548, 4895.118878601886, 4895.412550493892, 4902.90194196114, 4909.042736666316, 4948.975255123773, 4155.771432571177, 4195.014171669655, 4196.202721482909, 4203.369494575838, 4292.59220374064, 4354.390385346054, 4363.934540981888, 4365.105153443536, 4366.0, 4366.563343665608, 4525.479569849444, 4586.174488592085, 4586.449626044896, 4589.5181005994555, 4594.494605593449, 4827.468978412442, 4850.490698476609, 4853.466118726867, 4869.172240719157, 4874.366332376769, 4504.369388285577, 4554.908901822011, 4563.201439747964, 4566.2237419639405, 4566.725996440225, 4743.407074115736, 4749.4063242094735, 4799.328094066764, 4800.183968725255, 4806.6875653083835, 4811.975940120277, 4812.470628230822, 4815.95184048155, 4843.636727245541, 4877.975610121926, 4540.36434899121, 4691.812327506998, 4707.340972263954, 4707.364505791675, 4770.236762118045, 4574.88562785933, 4626.583607475343, 4627.1439783640135, 4629.213033784332, 4631.374764406762, 4575.0392417592675, 4584.747838868894, 4585.793639286173, 4589.885252868705, 4606.516315786794, 4677.602403795579, 4679.766011699469, 4688.132695451352, 4770.356001939694, 4815.711057336571, 4718.97640511809, 4723.197056500472, 4728.290756386569, 4728.527147285244, 4733.786979585996], "value": 4454.809924957109, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.8693706978861, 572.5791543215734, 578.6672663218649, 583.1864548954209, 587.0226073587477, 27582.310442238955, 38780.22439551207, 39529.80235098828, 39595.80202098989, 43410.34884476735, 40142.7992860036, 40613.0, 40628.59371406285, 40657.59342406575, 40676.0, 7641.2740789624895, 7784.338331241851, 7790.766277011699, 7794.298513133816, 7795.727149549767, 7185.820354491128, 7404.074490688664, 9683.322167448281, 9954.452505112216, 9960.950195249014, 9720.465374404404, 9803.509824508781, 9813.411195328303, 9817.558209880537, 9818.0, 9841.901580984206, 9918.851217231748, 9921.404715717008, 9924.007599240054, 9929.553170107363, 9671.226301895831, 9740.707778766648, 9746.610135594568, 9750.366226195274, 9752.073553012453, 37958.0, 37986.43020354697, 38028.429573556416, 38088.42867356992, 38362.61637383619, 3020.6073210482496, 3220.9355812883846, 3448.913777155566, 3482.512448257246, 3585.4801053847045, 28078.578821317697, 28295.858520707265, 28322.57516137239, 29832.0, 29884.8505757472, 3040.4375190589813, 3125.796823206484, 3154.0853152585723, 3207.3905957867933, 3243.0919342584116, 249624.0, 250634.0, 250651.0, 252233.0, 252234.99999999817, 31764.364712705617, 32719.18202044968, 52775.47224527706, 53122.73438632859, 53302.73348633232, 33487.33025339479, 33581.0, 33755.15612109717, 33813.32373352519, 33902.83048584791, 12183.45174467151, 12244.938775306067, 12336.568220112433, 12345.814812777815, 12350.691232719253, 9107.590158442887, 9249.0, 10315.484225788681, 10507.94746026265, 10529.36823790575, 7715.267049630276, 7987.0, 7995.40034497415, 8011.799705007422, 8086.0, 3010.668826429091, 3024.6691455759396, 3048.8170709757487, 3095.4892442746695, 3099.9535006974916, 873.4017198219113, 894.7360528644066, 894.7763059235191, 917.5733284022962, 922.5940586142076, 26937.86531067332, 27829.304267393072, 27853.57355018742, 27880.581791273147, 28304.0, 932.4498545857977, 938.737153596994, 977.2719324103447, 982.2289502740315, 1026.4764969865273, 14433.494827680981, 14451.097804391218, 14537.273136343141, 14560.126392416489, 14703.485378011932, 397653.0, 402445.0, 403616.0, 404294.0, 408060.0, 48888.26667599989, 49327.753361232964, 49354.50645493571, 49380.259296110584, 49451.258231126565, 1031.2626472072504, 1085.1102096280974, 1147.2256227046544, 1157.774234024374, 1182.7457096724245, 25384.238472845846, 28305.43389132247, 29011.274718132216, 29425.70574294315, 29573.0, 35841.82079089588, 36067.0, 36167.638323616426, 36186.63813361938, 36668.083297917765, 290580.0, 292366.0, 292440.0, 292555.0, 292810.0, 24728.629070564315, 25152.49695006126, 25623.359416014748, 25639.0, 26670.333241669112, 40012.799936000134, 40166.397504036875, 40188.7990560057, 40580.39129413002, 41827.58172418358, 34889.651103489654, 34965.47551786776, 35123.82438087793, 35283.82358088193, 35405.82297088498, 34915.0, 35290.64738849805, 35401.822990885914, 35407.29185416329, 35721.0, 34513.65486345205, 34637.0, 34740.13149671177, 35296.64703353036, 35469.82265088658, 29382.706172937997, 31620.209494762814, 31710.207244818142, 31864.36271274515, 32168.83915580407, 23854.403639909142, 24187.15344962918, 24296.635550467112, 24427.389315266548, 24643.753562464863], "value": 16450.282075633666, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.8759452799729, 356.51157913658307, 359.3944204016233, 364.44422256059505, 385.7087898636529, 12018.879811201885, 12996.805047924288, 15395.692086158284, 16190.19049047546, 17426.47720568382, 16182.514524564252, 16266.674666506662, 16541.172941352914, 17362.91318543409, 17468.388606398777, 4583.197940360424, 4888.120138375091, 4888.926666100011, 5114.309568208281, 5115.2071428928575, 4955.0, 5090.414602320743, 5096.898062038757, 5098.668586541881, 5100.668456550312, 5087.982403519292, 5094.949050509503, 5101.311322971407, 5102.209157580581, 5158.252053452247, 5365.222042803791, 5518.061929471999, 5530.0, 5530.087535556629, 5532.640378375433, 5170.767315470813, 5257.395399529027, 5286.259923610698, 5349.812756553541, 5359.526130314195, 12181.512739490498, 12339.814902776465, 12345.38273086342, 12366.690832729164, 14225.78661320081, 1929.3054500379992, 1972.0731256309655, 1975.841932645385, 1985.493699106733, 2231.252530402301, 8942.0, 9079.319051071196, 9263.305252106118, 9545.379550329206, 9554.474503902282, 1637.2386840119402, 1671.0809055019813, 1681.974770378433, 1684.1158391844258, 1684.7388654758408, 60939.39060609426, 66904.0, 70344.2965570343, 71233.0, 73450.0, 9120.908790912139, 9361.4383137012, 9462.356992557914, 9774.413535187769, 10131.341462804894, 13690.178589284675, 13697.452101916011, 13714.382852771649, 13715.451381944611, 13723.1079979801, 7041.155061392666, 7217.0, 7361.963190184015, 7377.11474623038, 7535.0, 6951.339622735832, 7064.258252883374, 7212.819679508054, 7263.92736072643, 7267.745628902963, 4173.520045194841, 4278.144371125787, 4303.526612072669, 4387.078713470207, 4404.559544045634, 1580.4231455518652, 1629.6822119686547, 1722.5788724302502, 1735.895846249204, 1766.1124062158208, 636.8312397214742, 800.4449123085766, 810.3841080778651, 816.1348970091722, 892.3084609427746, 16434.917825410797, 16997.64724648081, 17170.22733976974, 17381.0, 17571.56071098207, 838.6100463284602, 848.4781859156698, 851.1786126388065, 870.7083127152348, 874.156439036333, 9035.141661542142, 9868.457234852152, 9884.950575247078, 9898.60405583783, 9991.700248992542, 337788.0, 339267.0, 374755.0, 399535.0, 399558.0, 73809.0, 74112.62943685355, 76922.0, 77173.0, 77479.0, 871.4335681806749, 880.1550511509023, 914.1178762494092, 914.3964983111115, 914.5518695839124, 14477.565673029825, 14777.92611036981, 15161.772573411186, 16066.919665401598, 16893.32426702918, 36426.0, 36535.45196821997, 37111.628883710815, 37616.0, 38159.0, 44240.33639495474, 45782.771086144356, 47227.29159062548, 47781.0, 50120.74939625279, 7307.0, 7622.428317876071, 7740.690372385042, 7843.098043724816, 7855.7250496232355, 8598.054214036325, 11010.0, 11237.662870113909, 11797.410129493663, 11823.11326650522, 10116.494175291058, 10630.30902991303, 10767.892321077003, 10919.454027298762, 11079.058280046287, 10000.949900260368, 10477.842832357368, 10583.259171857895, 10608.363498190134, 10839.67480975572, 10663.626773062906, 10995.120390368911, 11021.669349919515, 11108.666739997812, 11487.597934072268, 7399.297066778648, 7657.808554785952, 7663.69345226207, 7740.883886741816, 8021.27808497238, 8474.533900635524, 9901.405915645084, 10385.376877387382, 10534.36793792375, 10719.196060295664], "value": 7966.949484656783, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1335.933203339833, 1362.6797702539902, 1398.7482253194428, 1598.1210334316124, 1661.368679901638, 6533.31400202979, 6763.763268285611, 7095.290470952902, 7658.846823063543, 7679.0, 7059.788206353817, 7360.0431943847225, 7364.668589913454, 7552.395808335334, 7555.6599953002105, 2022.2921977307935, 2050.190174880921, 2056.609244243589, 2060.4436802063433, 2062.102985201442, 1760.5246583422468, 1825.516238196879, 2025.2202901882733, 2038.6636205026152, 2050.528378472952, 2105.0, 2162.76209616942, 2174.706414634028, 2190.6823510590953, 2194.5281764420647, 2106.6418708819383, 2111.9366419007456, 2119.703241546177, 2147.967780483294, 2148.6562150055915, 2131.3605918224625, 2132.051237199447, 2136.636771748791, 2137.700721898935, 2149.365937048559, 7392.297731715478, 7470.178280389153, 7472.140703819022, 7492.625368731596, 7507.249275072503, 4314.590113939202, 4442.400275962736, 4506.571875671806, 4510.25580779171, 4515.254982927813, 2714.7149549297237, 2872.540393537024, 2899.3911278631513, 2916.5916771651987, 2928.5167947288674, 924.089771574998, 934.2759361494828, 947.6020071569957, 949.9192568631674, 959.4866746290701, 10051.145652619536, 10072.798544029078, 10082.89917100827, 10094.242931780072, 10102.9494852526, 3846.5576458707046, 3992.321305378093, 3999.5200575931076, 4026.1142548639255, 4162.375643653476, 8667.783305417415, 8746.650133994695, 8755.868661970075, 8763.386562940534, 8769.166929141722, 4510.0528888933695, 4533.252013417815, 4537.77311134442, 4541.364209010741, 4562.384078149474, 4033.153037862082, 4118.135191609796, 4132.380142978577, 4170.937435938464, 4173.749575025508, 3544.4328907374697, 3582.265635544707, 3596.3166998270244, 3686.2811751708696, 3723.94414083789, 1054.1672079057612, 1097.9890201097887, 1139.8347239650204, 1160.2400427719856, 1180.6044974933322, 605.3129697792949, 660.4155322539588, 715.1311156944233, 721.5995122706948, 758.0865057605572, 4623.491415944243, 4652.744099074515, 4727.645426592951, 4795.712257264575, 4837.443693975238, 824.2169938558274, 826.8181000179951, 897.9595918183697, 912.5574096563295, 916.7478943290648, 3308.3714094322004, 3408.4205685033603, 3417.4532074867902, 3418.8632454701533, 3529.682328590388, 8499.872501912476, 8825.205731484197, 9297.163255307054, 9306.255499560019, 9311.860322095174, 8773.166549177819, 9055.909440905638, 9073.31950103745, 9079.636814527477, 9084.909150908406, 6630.204375474877, 6655.334466553403, 6783.966080169567, 6796.422304104207, 6921.411680007155, 4890.315355850113, 4950.579200767975, 4987.725675087905, 5061.468545802785, 5204.0, 8079.919200807916, 8305.626246819029, 8315.126911674188, 8584.270337021424, 8609.139086091342, 8399.874001890099, 8568.91431085706, 8625.784355390915, 8631.56842157902, 8693.956530217309, 6349.238091429058, 6393.369690728834, 6444.516661250331, 6445.613263204223, 6454.257760357431, 7079.1505019395945, 7142.214356420894, 7155.499115061895, 7197.964010179916, 7208.603526805866, 6470.579412338183, 6599.868002640016, 6603.7688680895935, 6621.470282377302, 6735.764248251484, 6314.305426403, 6326.557141000086, 6456.6771661415805, 6469.77355792545, 6552.934470655423, 5838.0, 5898.1152827076285, 5912.0, 5925.703714814156, 5981.0131328330335, 4196.580341965779, 4214.346776249687, 4242.406063151223, 4327.913441731211, 4334.26317526015, 4169.791510424406, 4174.582541745801, 4203.915921681488, 4226.746395216297, 4299.634531064769], "value": 3949.3197456138037, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.3281285076451, 298.55813396173664, 303.7752063473029, 307.1599176252949, 308.71289700578467, 4778.71327720337, 4808.663393562452, 4812.25410061441, 4821.204501257297, 4833.061055239981, 4758.428988521374, 4759.690620109691, 4759.952400475994, 4765.499622539635, 4771.90456190876, 3562.6081131075625, 3673.540807399075, 3711.4061750119986, 3748.737588368815, 3764.642358975893, 3774.169682669808, 3774.584795672474, 3776.2636285924254, 3776.8300426480873, 3792.222594368148, 3753.3994560870265, 3768.679662228714, 3779.546454425473, 3779.9433008504893, 3782.243551289739, 3566.6789988900996, 3648.2338708870902, 3664.725145614063, 3756.3614185588517, 3771.623876957513, 3295.2750394913082, 3310.486874534451, 3316.7512436567354, 3322.6178989416285, 3341.198112453018, 4649.04694537619, 4655.487896331435, 4662.696924699883, 4668.603168730662, 4684.203685373494, 4101.425800387948, 4270.743755374657, 4274.551172126913, 4281.785910704452, 4286.592773686495, 4950.653454258203, 4957.652964292501, 4965.0, 4988.950110498885, 4991.7038162445315, 3597.010822023938, 3606.170580766412, 3608.9639103608893, 3611.693006094485, 3622.710183185339, 5033.0, 5210.687358758487, 5226.0, 5236.973815130977, 5266.210068489757, 3561.5904171020147, 3577.4276115821344, 3579.982100089483, 3580.3197392495345, 3584.354816133121, 3657.65252301031, 3658.4695219193068, 3667.9083022924106, 3678.2459595782802, 3687.2441149564274, 4156.709030367906, 4160.417541544186, 4165.208610364021, 4165.4584903962295, 4177.728447650893, 4708.576228139415, 4937.259411088366, 4948.925766113512, 4960.950390496121, 4966.0, 1267.7971524556026, 1283.3968035023524, 1283.9422225999851, 1287.8454585449806, 1292.095533126815, 784.5214419204281, 828.9668413263522, 836.6695155413578, 839.5214727605329, 843.3759018326394, 4257.743965530176, 4345.022369966732, 4366.388705581221, 4387.583179597933, 4472.195004899084, 5162.179986809809, 5181.715005674649, 5205.349331333583, 5221.441493668151, 5226.5818734501145, 4492.146492166478, 4516.570925762047, 4525.977370113194, 4526.547345265447, 4531.184386810406, 2666.719994400599, 2746.6429364182527, 2768.224897028835, 2771.80597358187, 2775.0287399410045, 4870.683405578626, 4878.07316609843, 4883.0, 4885.2427873679635, 4913.287573301851, 5078.263651770472, 5288.68267903927, 5297.337832770903, 5306.92039619406, 5313.229581710631, 4837.685550439211, 4842.539958703917, 4845.8061677532505, 4855.34452848875, 4886.242632391985, 5140.665856719302, 5144.819931302386, 5169.92245116316, 5180.48195180479, 5191.792328306826, 4891.926621100615, 4987.177115775857, 5079.060373830853, 5095.898082038264, 5097.235414687826, 4822.9148441600355, 4836.0258441057795, 4841.95158048415, 4863.148948933993, 4868.732219727949, 3616.4504024662024, 3623.9818800905828, 3624.5831729350407, 3632.891013269606, 3633.8728144514816, 4957.6281778866005, 5129.897402052013, 5149.613778966517, 5154.433012368711, 5172.327597412313, 4939.431965324034, 5028.818227716411, 5032.547070763649, 5038.924416133687, 5045.291710592638, 4977.352944117241, 4996.975015125046, 5005.149124648746, 5010.799568017239, 5014.6991180529285, 4717.716936983792, 4943.826966056171, 4949.356583644103, 4959.3386215618175, 4968.701877887338, 4776.426828780569, 4971.527704868032, 5015.673981191211, 5048.242763585492, 5056.572845034478, 4833.226683730586, 4840.685355451885, 4844.660873738945, 4868.123737727102, 4868.537488938545], "value": 3772.0949808623004, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.2180204832691, 604.4892066204059, 608.9451949324559, 613.3835495327196, 619.5477301569857, 12097.153199276043, 12661.177023493477, 12734.490620375174, 12766.936165319172, 12930.741385172314, 13179.538716144936, 13708.794368084487, 13782.379792909318, 13787.241701706402, 13832.585022449342, 599.8710277290381, 746.481195569081, 764.8623247815391, 766.5094339622646, 767.0948281028384, 614.1340709599466, 728.3081072980663, 760.2891296637633, 767.9193684663114, 768.3776141325516, 793.4009822583942, 795.7453614843253, 796.7888509544946, 798.0981490915258, 798.5488199167452, 623.4918541388754, 787.1027029186731, 788.0189164490189, 788.148799296761, 788.2550989315099, 470.9623230141615, 543.2042058384446, 573.9569532285095, 575.712143928036, 576.0926540698417, 12050.638480845588, 12101.757964840743, 12105.09211809109, 12371.75256494874, 12458.626241212778, 11667.474963626657, 11670.766584668345, 12574.81137782934, 12724.745505089939, 13028.54400095992, 11339.546418143264, 11400.144989125765, 11446.31322120667, 11446.771064578745, 11521.36632485213, 4049.9392509112386, 4076.6249894019793, 4111.568285330027, 4147.709660323779, 4184.456020717318, 58991.41008589902, 59111.11333330003, 59134.40865591332, 59196.0, 59981.40018599802, 9777.364471309342, 10007.199424046059, 10101.69694909154, 10216.489175541343, 10350.637727679496, 18665.626687466174, 18763.155657995423, 18810.059497025366, 18840.52898677544, 18845.811541884406, 6375.936240637627, 6422.4862011039, 6441.871162576722, 6520.836979075466, 6768.5938843668555, 3591.6049234584175, 3608.224231790125, 3620.4388319810473, 3663.8534458621357, 3710.7588006779474, 2642.128097727745, 2766.681831589353, 2766.958495622567, 2769.2799872033415, 3061.892833750853, 549.9257600223999, 550.1664977559001, 553.7259056766926, 555.3446932619547, 561.6461629173594, 497.93526841510374, 522.7830450363133, 584.9266595796676, 591.5977135547782, 607.696151924038, 8130.878036829452, 8261.586920653943, 8324.417290789586, 8335.624896879655, 8602.408554417452, 593.1221791748237, 602.9969850150809, 609.2749627942734, 611.400827189357, 618.4897459595761, 3789.4694742736037, 4172.937405938914, 4187.267228235047, 4192.350185721218, 4217.957820421818, 97027.51486242523, 97765.5111724451, 98267.0, 99284.50357748165, 101703.49148254211, 73541.0, 76955.61522192354, 82928.0, 86307.0, 86685.56657216673, 40428.0, 55696.0, 58538.0, 60322.396776032554, 69889.0, 7852.396029564553, 8734.475931444134, 8802.779930501789, 9125.361224714206, 9148.313876459426, 41642.58357416387, 41846.790766045975, 42063.7896810514, 42689.5731042698, 44225.55774442343, 56154.43845561655, 56460.71769641126, 59768.0, 60707.69646151741, 60803.78392432215, 11076.169287303646, 11152.553897843994, 11161.441927903736, 11312.83030754523, 11470.082393408675, 12683.429245683781, 12786.168899021533, 12962.09265351454, 12986.610401687965, 13336.266065456364, 11584.884151158381, 12087.274763514217, 12238.082143839425, 12661.28348487034, 12724.809127863275, 11048.447577621248, 11269.323840569592, 11988.880111198776, 12085.274883507018, 12555.874441255835, 11956.880431195925, 12490.313032783284, 12502.249865008129, 12511.311877846805, 12532.310722909962, 9993.450360229966, 10018.39889606626, 10091.39451632875, 10206.642767503101, 10874.510647021061, 9392.765180870532, 10120.493975301059, 10131.240156988402, 10187.541560629641, 10217.846732298873], "value": 6484.917542604854, "unit": "score"}], "name": "dromaeo_css", "value": 6192.874450829596, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 113.0, 114.0, 114.0, 117.0, 114.0, 114.0, 115.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 131.0, 130.0, 165.0, 133.0, 127.0, 132.0, 135.0, 181.0, 125.0], "value": 141.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 162.0, 161.0, 161.0, 162.0, 164.0, 161.0, 161.0, 160.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 114.0, 76.0, 76.0, 76.0, 76.0, 108.0, 76.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 120.0, 84.0, 83.0, 83.0, 114.0, 83.0, 83.0, 120.0], "value": 93.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 64.0, 64.0, 64.0, 64.0, 67.0, 67.0, 66.0, 65.0, 65.0], "value": 65.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 66.0, 65.0, 66.0, 65.0, 66.0, 67.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 87.0, 89.0, 84.0, 85.0, 83.0, 82.0, 83.0, 85.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 140.0, 138.0, 139.0, 140.0, 141.0, 147.0, 149.0, 190.0, 139.0], "value": 146.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 176.0, 173.0, 175.0, 176.0, 178.0, 176.0, 176.0, 174.0, 177.0], "value": 176.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 71.0, 74.0, 70.0, 74.0, 69.0, 74.0, 69.0, 69.0], "value": 71.2, "unit": "score"}], "name": "kraken", "value": 1562.0, "alertThreshold": 2.0}]} 14:59:27 INFO - Return code: 0 14:59:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:59:27 INFO - # TBPL SUCCESS # 14:59:27 INFO - Running post-action listener: _resource_record_post_action 14:59:27 INFO - [mozharness: 2016-10-11 21:59:27.245483Z] Finished run-tests step (success) 14:59:27 INFO - Running post-run listener: _resource_record_post_run 14:59:27 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 4096; Write bytes: 393474048; Read time: 12; Write time: 272096 14:59:27 INFO - TinderboxPrint: CPU usage
13.0% 14:59:27 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 14:59:27 INFO - TinderboxPrint: I/O write bytes / time
393,474,048 / 272,096 14:59:27 INFO - TinderboxPrint: CPU idle
8,340.6 (87.0%) 14:59:27 INFO - TinderboxPrint: CPU user
1,201.8 (12.5%) 14:59:27 INFO - TinderboxPrint: Swap in / out
0 / 0 14:59:27 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 100016128; Read time: 0; Write time: 105952 14:59:27 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 293457920; Read time: 0; Write time: 166144 14:59:27 INFO - Running post-run listener: _upload_blobber_files 14:59:27 INFO - Blob upload gear active. 14:59:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:59:27 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 14:59:27 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:59:27 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:59:28 INFO - (blobuploader) - INFO - Open directory for files ... 14:59:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:59:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:59:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:59:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:59:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:59:29 INFO - (blobuploader) - INFO - Done attempting. 14:59:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:59:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:59:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:59:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:59:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:59:32 INFO - (blobuploader) - INFO - Done attempting. 14:59:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:59:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:59:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:59:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:59:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:59:33 INFO - (blobuploader) - INFO - Done attempting. 14:59:33 INFO - (blobuploader) - INFO - Iteration through files over. 14:59:33 INFO - Return code: 0 14:59:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:59:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:59:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2c4b4eb3d48efdcb4352c95c4359146eb014f35fa024fdd9ac43ee3bd47a90a37d6e511d3f891f43e61856999372684620b952369a3a16b007f0567b70a19ea1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/cc9c65ebc90fa947d6fd5f5ad594d295cf57ac0076100a7294c10de870dfb7bd518f27f2b3d055807dab841ff3cf847e4ba8a35d90261c0fe30a8d3d3c9ad413", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d4594940aaef08223b65b4201a5c45567b7e2fc20aad04050939bedc447ed12f0a5aed3eacc7bfded790bc8103e6e2f2195650f2df80ea2d409ebe24b5af5448"} 14:59:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:59:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:59:33 INFO - Contents: 14:59:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2c4b4eb3d48efdcb4352c95c4359146eb014f35fa024fdd9ac43ee3bd47a90a37d6e511d3f891f43e61856999372684620b952369a3a16b007f0567b70a19ea1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/cc9c65ebc90fa947d6fd5f5ad594d295cf57ac0076100a7294c10de870dfb7bd518f27f2b3d055807dab841ff3cf847e4ba8a35d90261c0fe30a8d3d3c9ad413", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d4594940aaef08223b65b4201a5c45567b7e2fc20aad04050939bedc447ed12f0a5aed3eacc7bfded790bc8103e6e2f2195650f2df80ea2d409ebe24b5af5448"} 14:59:33 INFO - Running post-run listener: copy_logs_to_upload_dir 14:59:33 INFO - Copying logs to upload dir... 14:59:33 INFO - mkdir: /builds/slave/test/build/upload/logs 14:59:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.238509 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-11 14:59:32.677247) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 14:59:32.681198) ========= 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=923d835db2ba3686ebe126b700000192-1476221770.971008-777042118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2c4b4eb3d48efdcb4352c95c4359146eb014f35fa024fdd9ac43ee3bd47a90a37d6e511d3f891f43e61856999372684620b952369a3a16b007f0567b70a19ea1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/cc9c65ebc90fa947d6fd5f5ad594d295cf57ac0076100a7294c10de870dfb7bd518f27f2b3d055807dab841ff3cf847e4ba8a35d90261c0fe30a8d3d3c9ad413", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d4594940aaef08223b65b4201a5c45567b7e2fc20aad04050939bedc447ed12f0a5aed3eacc7bfded790bc8103e6e2f2195650f2df80ea2d409ebe24b5af5448"} build_url:https://queue.taskcluster.net/v1/task/e82tohu8T4OvkLUPgnuRUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011383 build_url: 'https://queue.taskcluster.net/v1/task/e82tohu8T4OvkLUPgnuRUA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2c4b4eb3d48efdcb4352c95c4359146eb014f35fa024fdd9ac43ee3bd47a90a37d6e511d3f891f43e61856999372684620b952369a3a16b007f0567b70a19ea1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/cc9c65ebc90fa947d6fd5f5ad594d295cf57ac0076100a7294c10de870dfb7bd518f27f2b3d055807dab841ff3cf847e4ba8a35d90261c0fe30a8d3d3c9ad413", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d4594940aaef08223b65b4201a5c45567b7e2fc20aad04050939bedc447ed12f0a5aed3eacc7bfded790bc8103e6e2f2195650f2df80ea2d409ebe24b5af5448"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 14:59:32.707335) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 14:59:32.707720) ========= 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=923d835db2ba3686ebe126b700000192-1476221770.971008-777042118 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004458 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 14:59:32.789752) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 14:59:32.790113) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 14:59:32.790471) ========= ========= Total master_lag: 0.17 =========