builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-061 starttime: 1483082972.79 results: success (0) buildid: 20161229214720 builduid: f68f38a0d8a049ff8528092feaceda10 revision: b213de949cddebe0a123654be580ba114b951020 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-29 23:29:32.788508) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-29 23:29:32.789017) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-29 23:29:32.789294) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-29 23:29:32.803762) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 23:29:32.804263) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1483082972.429503-1162778758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-29 23:29:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 101M=0s 2016-12-29 23:29:33 (101 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.081883 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 23:29:32.903216) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 23:29:32.903812) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1483082972.429503-1162778758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021922 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 23:29:32.954770) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 23:29:32.955164) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b213de949cddebe0a123654be580ba114b951020 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b213de949cddebe0a123654be580ba114b951020 --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=516f8d7ca085b4d087ab0a71000001a4-1483082972.429503-1162778758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-29 23:29:33,413 truncating revision to first 12 chars 2016-12-29 23:29:33,413 Setting DEBUG logging. 2016-12-29 23:29:33,413 attempt 1/10 2016-12-29 23:29:33,413 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b213de949cdd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-29 23:29:33,939 unpacking tar archive at: mozilla-aurora-b213de949cdd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.815879 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 23:29:33.786416) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-29 23:29:33.787004) ========= script_repo_revision: b213de949cddebe0a123654be580ba114b951020 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-29 23:29:33.787697) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-29 23:29:33.788181) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-29 23:29:33.798881) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-12-29 23:29:33.799428) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=516f8d7ca085b4d087ab0a71000001a4-1483082972.429503-1162778758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:29:34 INFO - MultiFileLogger online at 20161229 23:29:34 in /builds/slave/test 23:29:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 23:29:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:29:34 INFO - {'append_to_log': False, 23:29:34 INFO - 'base_work_dir': '/builds/slave/test', 23:29:34 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 23:29:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:29:34 INFO - 'branch': 'Mozilla-Aurora', 23:29:34 INFO - 'buildbot_json_path': 'buildprops.json', 23:29:34 INFO - 'config_files': ('talos/linux_config.py',), 23:29:34 INFO - 'default_actions': ('clobber', 23:29:34 INFO - 'read-buildbot-config', 23:29:34 INFO - 'download-and-extract', 23:29:34 INFO - 'populate-webroot', 23:29:34 INFO - 'create-virtualenv', 23:29:34 INFO - 'install', 23:29:34 INFO - 'run-tests'), 23:29:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:29:34 INFO - 'download_minidump_stackwalk': True, 23:29:34 INFO - 'download_symbols': 'ondemand', 23:29:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:29:34 INFO - 'tooltool.py': '/tools/tooltool.py', 23:29:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:29:34 INFO - '/tools/misc-python/virtualenv.py')}, 23:29:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:29:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:29:34 INFO - 'installer_path': 'installer.exe', 23:29:34 INFO - 'log_level': 'info', 23:29:34 INFO - 'log_name': 'talos', 23:29:34 INFO - 'log_to_console': True, 23:29:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:29:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:29:34 INFO - 'opt_config_files': (), 23:29:34 INFO - 'pip_index': False, 23:29:34 INFO - 'sps_profile': False, 23:29:34 INFO - 'sps_profile_interval': 0, 23:29:34 INFO - 'suite': 'dromaeojs', 23:29:34 INFO - 'system_bits': '32', 23:29:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:29:34 INFO - 'title': 'talos-linux64-ix-061', 23:29:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:29:34 INFO - 'use_talos_json': True, 23:29:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:29:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:29:34 INFO - 'work_dir': 'build'} 23:29:34 INFO - [mozharness: 2016-12-30 07:29:34.355773Z] Running clobber step. 23:29:34 INFO - Running pre-action listener: _resource_record_pre_action 23:29:34 INFO - Running main action method: clobber 23:29:34 INFO - rmtree: /builds/slave/test/build 23:29:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:29:34 INFO - Running post-action listener: _resource_record_post_action 23:29:34 INFO - [mozharness: 2016-12-30 07:29:34.823665Z] Finished clobber step (success) 23:29:34 INFO - [mozharness: 2016-12-30 07:29:34.823764Z] Running read-buildbot-config step. 23:29:34 INFO - Running pre-action listener: _resource_record_pre_action 23:29:34 INFO - Running main action method: read_buildbot_config 23:29:34 INFO - Using buildbot properties: 23:29:34 INFO - { 23:29:34 INFO - "project": "", 23:29:34 INFO - "product": "firefox", 23:29:34 INFO - "script_repo_revision": "production", 23:29:34 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 23:29:34 INFO - "repository": "", 23:29:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 23:29:34 INFO - "buildid": "20161229214720", 23:29:34 INFO - "pgo_build": "True", 23:29:34 INFO - "basedir": "/builds/slave/test", 23:29:34 INFO - "buildnumber": 666, 23:29:34 INFO - "slavename": "talos-linux64-ix-061", 23:29:34 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:29:34 INFO - "platform": "ubuntu64_hw", 23:29:34 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 23:29:34 INFO - "branch": "mozilla-aurora", 23:29:34 INFO - "repo_path": "releases/mozilla-aurora", 23:29:34 INFO - "revision": "b213de949cddebe0a123654be580ba114b951020", 23:29:34 INFO - "stage_platform": "linux64-pgo", 23:29:34 INFO - "builduid": "f68f38a0d8a049ff8528092feaceda10", 23:29:34 INFO - "slavebuilddir": "test" 23:29:34 INFO - } 23:29:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/faRoWNgqR2q3Wnvk807WnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 23:29:34 INFO - Running post-action listener: _resource_record_post_action 23:29:34 INFO - [mozharness: 2016-12-30 07:29:34.826193Z] Finished read-buildbot-config step (success) 23:29:34 INFO - [mozharness: 2016-12-30 07:29:34.826282Z] Running download-and-extract step. 23:29:34 INFO - Running pre-action listener: _resource_record_pre_action 23:29:34 INFO - Running main action method: download_and_extract 23:29:34 INFO - mkdir: /builds/slave/test/build/tests 23:29:34 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')]} 23:29:34 INFO - trying https://queue.taskcluster.net/v1/task/faRoWNgqR2q3Wnvk807WnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 23:29:34 INFO - Downloading https://queue.taskcluster.net/v1/task/faRoWNgqR2q3Wnvk807WnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 23:29:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/faRoWNgqR2q3Wnvk807WnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:29:35 INFO - Downloaded 1361 bytes. 23:29:35 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 23:29:35 INFO - Using the following test package requirements: 23:29:35 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 23:29:35 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 23:29:35 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 23:29:35 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 23:29:35 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 23:29:35 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 23:29:35 INFO - u'jsshell-linux-x86_64.zip'], 23:29:35 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 23:29:35 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 23:29:35 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 23:29:35 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 23:29:35 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 23:29:35 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 23:29:35 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 23:29:35 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 23:29:35 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 23:29:35 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 23:29:35 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 23:29:35 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:29:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/faRoWNgqR2q3Wnvk807WnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 23:29:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/faRoWNgqR2q3Wnvk807WnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:29:35 INFO - Fetch https://queue.taskcluster.net/v1/task/faRoWNgqR2q3Wnvk807WnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 23:29:35 INFO - Http code: 200 23:29:35 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 23:29:35 INFO - x-amz-cf-id: zpJ-t9xEpEwZC9aNXF0n6U5CFjU9phj5KBCaF8gz6iiSTkmfDVT2fA== 23:29:35 INFO - x-amz-version-id: Ki1VRohyTETbz6V56aJcZ_lQw7jVyIci 23:29:36 INFO - Expected file size: 21940846 23:29:36 INFO - Obtained file size: 21940846 23:29:40 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:29:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/faRoWNgqR2q3Wnvk807WnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 23:29:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/faRoWNgqR2q3Wnvk807WnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:29:40 INFO - Fetch https://queue.taskcluster.net/v1/task/faRoWNgqR2q3Wnvk807WnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 23:29:40 INFO - Http code: 200 23:29:40 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 23:29:40 INFO - x-amz-cf-id: KFEN8cT7XG1rfwHMqyWk3CBPdHIcn0CKS8WxyZdtMChyJ95S5v7-Wg== 23:29:40 INFO - x-amz-version-id: Ki1VRohyTETbz6V56aJcZ_lQw7jVyIci 23:29:40 INFO - Expected file size: 21940846 23:29:40 INFO - Obtained file size: 21940846 23:29:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/faRoWNgqR2q3Wnvk807WnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 23:29:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/faRoWNgqR2q3Wnvk807WnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:29:45 INFO - Fetch https://queue.taskcluster.net/v1/task/faRoWNgqR2q3Wnvk807WnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 23:29:45 INFO - Http code: 200 23:29:45 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 23:29:45 INFO - x-amz-cf-id: 0_oIHf8F814c-kQDkyVg_mykLG2xQqmM0CXaXJbip9Gcz8B8ezkfdQ== 23:29:45 INFO - x-amz-version-id: oRoGpBDkTE7h_EMfy_kGrQ1E4pe6.Hm3 23:29:46 INFO - Expected file size: 14409038 23:29:46 INFO - Obtained file size: 14409038 23:29:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:29:46 INFO - trying https://queue.taskcluster.net/v1/task/faRoWNgqR2q3Wnvk807WnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 23:29:46 INFO - Downloading https://queue.taskcluster.net/v1/task/faRoWNgqR2q3Wnvk807WnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 23:29:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/faRoWNgqR2q3Wnvk807WnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:29:47 INFO - Downloaded 64003255 bytes. 23:29:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/faRoWNgqR2q3Wnvk807WnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 23:29:47 INFO - mkdir: /builds/slave/test/properties 23:29:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:29:47 INFO - Writing to file /builds/slave/test/properties/build_url 23:29:47 INFO - Contents: 23:29:47 INFO - build_url:https://queue.taskcluster.net/v1/task/faRoWNgqR2q3Wnvk807WnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 23:29:48 INFO - Running post-action listener: _resource_record_post_action 23:29:48 INFO - Running post-action listener: set_extra_try_arguments 23:29:48 INFO - [mozharness: 2016-12-30 07:29:48.267576Z] Finished download-and-extract step (success) 23:29:48 INFO - [mozharness: 2016-12-30 07:29:48.267802Z] Running populate-webroot step. 23:29:48 INFO - Running pre-action listener: _resource_record_pre_action 23:29:48 INFO - Running main action method: populate_webroot 23:29:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:29:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:29:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:29:48 INFO - '--tppagecycles', 23:29:48 INFO - '7'], 23:29:48 INFO - 'tests': ['tsvgm']}}, 23:29:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:29:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:29:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:29:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:29:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:29:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:29:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:29:48 INFO - 'talos_options': ['--disable-e10s'], 23:29:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:29:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:29:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:29:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:29:48 INFO - 'talos_options': ['--disable-e10s'], 23:29:48 INFO - 'tests': ['damp', 'tps']}, 23:29:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:29:48 INFO - 'tests': ['damp', 'tps']}, 23:29:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:29:48 INFO - 'tests': ['dromaeo_dom']}, 23:29:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:29:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:29:48 INFO - 'tests': ['basic_compositor_video']}, 23:29:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:29:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:29:48 INFO - 'tests': ['a11yr', 23:29:48 INFO - 'ts_paint', 23:29:48 INFO - 'tpaint', 23:29:48 INFO - 'sessionrestore', 23:29:48 INFO - 'sessionrestore_no_auto_restore', 23:29:48 INFO - 'tabpaint']}, 23:29:48 INFO - 'other-e10s': {'tests': ['a11yr', 23:29:48 INFO - 'ts_paint', 23:29:48 INFO - 'tpaint', 23:29:48 INFO - 'sessionrestore', 23:29:48 INFO - 'sessionrestore_no_auto_restore', 23:29:48 INFO - 'tabpaint']}, 23:29:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:29:48 INFO - 'ts_paint', 23:29:48 INFO - 'tpaint', 23:29:48 INFO - 'sessionrestore', 23:29:48 INFO - 'sessionrestore_no_auto_restore', 23:29:48 INFO - 'tabpaint']}, 23:29:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:29:48 INFO - 'ts_paint', 23:29:48 INFO - 'tpaint', 23:29:48 INFO - 'sessionrestore', 23:29:48 INFO - 'sessionrestore_no_auto_restore', 23:29:48 INFO - 'tabpaint']}, 23:29:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:29:48 INFO - 'tests': ['a11yr', 23:29:48 INFO - 'ts_paint', 23:29:48 INFO - 'tpaint', 23:29:48 INFO - 'sessionrestore', 23:29:48 INFO - 'sessionrestore_no_auto_restore', 23:29:48 INFO - 'tabpaint']}, 23:29:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:29:48 INFO - 'tests': ['a11yr', 23:29:48 INFO - 'ts_paint', 23:29:48 INFO - 'tpaint', 23:29:48 INFO - 'sessionrestore', 23:29:48 INFO - 'sessionrestore_no_auto_restore', 23:29:48 INFO - 'tabpaint']}, 23:29:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:29:48 INFO - 'tests': ['tsvgx', 23:29:48 INFO - 'tsvgr_opacity', 23:29:48 INFO - 'tart', 23:29:48 INFO - 'tscrollx', 23:29:48 INFO - 'cart']}, 23:29:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:29:48 INFO - 'tsvgr_opacity', 23:29:48 INFO - 'tart', 23:29:48 INFO - 'tscrollx', 23:29:48 INFO - 'cart']}, 23:29:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:29:48 INFO - 'talos_options': ['--disable-e10s'], 23:29:48 INFO - 'tests': ['tp5o']}, 23:29:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:29:48 INFO - 'tests': ['tp5o']}, 23:29:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:29:48 INFO - 'talos_options': ['--disable-e10s', 23:29:48 INFO - '--xperf_path', 23:29:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:29:48 INFO - 'tests': ['tp5n']}, 23:29:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:29:48 INFO - 'talos_options': ['--xperf_path', 23:29:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:29:48 INFO - 'tests': ['tp5n']}}, 23:29:48 INFO - 'talos.zip': {'path': '', 23:29:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:29:48 INFO - Running post-action listener: _resource_record_post_action 23:29:48 INFO - [mozharness: 2016-12-30 07:29:48.283959Z] Finished populate-webroot step (success) 23:29:48 INFO - [mozharness: 2016-12-30 07:29:48.284046Z] Running create-virtualenv step. 23:29:48 INFO - Running pre-action listener: _resource_record_pre_action 23:29:48 INFO - Running main action method: create_virtualenv 23:29:48 INFO - Creating virtualenv /builds/slave/test/build/venv 23:29:48 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 23:29:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:29:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:29:48 INFO - Using real prefix '/usr' 23:29:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:29:48 INFO - Installing distribute.............................................................................................................................................................................................done. 23:29:50 INFO - Installing pip.................done. 23:29:50 INFO - Return code: 0 23:29:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:29:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:29:51 INFO - Reading from file tmpfile_stdout 23:29:51 INFO - Output received: 23:29:51 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) 23:29:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:29:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:29:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:29:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:51 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 0x7f233fe24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16beca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bbf60>, '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 0x16bcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bd1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1483082972.429503-1162778758', '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 23:29:51 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 23:29:51 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 23:29:51 INFO - Using env: {'DISPLAY': ':0', 23:29:51 INFO - 'HOME': '/home/cltbld', 23:29:51 INFO - 'LANG': 'en_US.UTF-8', 23:29:51 INFO - 'LANGUAGE': 'en_US:en', 23:29:51 INFO - 'LOGNAME': 'cltbld', 23:29:51 INFO - 'MAIL': '/var/mail/cltbld', 23:29:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:51 INFO - 'MOZ_NO_REMOTE': '1', 23:29:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:29:51 INFO - 'NO_EM_RESTART': '1', 23:29:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:29:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:29:51 INFO - 'PWD': '/builds/slave/test', 23:29:51 INFO - 'SHELL': '/bin/bash', 23:29:51 INFO - 'SHLVL': '1', 23:29:51 INFO - 'TERM': 'linux', 23:29:51 INFO - 'TMOUT': '86400', 23:29:51 INFO - 'USER': 'cltbld', 23:29:51 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1483082972.429503-1162778758', 23:29:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:51 INFO - '_': '/tools/buildbot/bin/python'} 23:29:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:51 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 23:29:51 INFO - Cleaning up... 23:29:51 INFO - Return code: 0 23:29:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:29:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:29:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:29:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:51 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 0x7f233fe24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16beca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bbf60>, '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 0x16bcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bd1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1483082972.429503-1162778758', '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 23:29:51 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 23:29:51 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 23:29:51 INFO - Using env: {'DISPLAY': ':0', 23:29:51 INFO - 'HOME': '/home/cltbld', 23:29:51 INFO - 'LANG': 'en_US.UTF-8', 23:29:51 INFO - 'LANGUAGE': 'en_US:en', 23:29:51 INFO - 'LOGNAME': 'cltbld', 23:29:51 INFO - 'MAIL': '/var/mail/cltbld', 23:29:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:51 INFO - 'MOZ_NO_REMOTE': '1', 23:29:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:29:51 INFO - 'NO_EM_RESTART': '1', 23:29:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:29:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:29:51 INFO - 'PWD': '/builds/slave/test', 23:29:51 INFO - 'SHELL': '/bin/bash', 23:29:51 INFO - 'SHLVL': '1', 23:29:51 INFO - 'TERM': 'linux', 23:29:51 INFO - 'TMOUT': '86400', 23:29:51 INFO - 'USER': 'cltbld', 23:29:51 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1483082972.429503-1162778758', 23:29:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:51 INFO - '_': '/tools/buildbot/bin/python'} 23:29:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:51 INFO - Downloading/unpacking psutil>=3.1.1 23:29:51 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 23:29:51 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 23:29:51 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 23:29:51 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 23:29:51 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 23:29:51 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 23:29:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:29:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:29:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:29:53 INFO - Installing collected packages: psutil 23:29:53 INFO - Running setup.py install for psutil 23:29:53 INFO - building 'psutil._psutil_linux' extension 23:29:53 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 23:29:53 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 23:29:53 INFO - building 'psutil._psutil_posix' extension 23:29:53 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 23:29:53 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 23:29:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:29:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:29:54 INFO - Successfully installed psutil 23:29:54 INFO - Cleaning up... 23:29:54 INFO - Return code: 0 23:29:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:29:54 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')]} 23:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:54 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')]} 23:29:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:54 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 0x7f233fe24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16beca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bbf60>, '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 0x16bcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bd1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1483082972.429503-1162778758', '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 23:29:54 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 23:29:54 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 23:29:54 INFO - Using env: {'DISPLAY': ':0', 23:29:54 INFO - 'HOME': '/home/cltbld', 23:29:54 INFO - 'LANG': 'en_US.UTF-8', 23:29:54 INFO - 'LANGUAGE': 'en_US:en', 23:29:54 INFO - 'LOGNAME': 'cltbld', 23:29:54 INFO - 'MAIL': '/var/mail/cltbld', 23:29:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:54 INFO - 'MOZ_NO_REMOTE': '1', 23:29:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:29:54 INFO - 'NO_EM_RESTART': '1', 23:29:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:29:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:29:54 INFO - 'PWD': '/builds/slave/test', 23:29:54 INFO - 'SHELL': '/bin/bash', 23:29:54 INFO - 'SHLVL': '1', 23:29:54 INFO - 'TERM': 'linux', 23:29:54 INFO - 'TMOUT': '86400', 23:29:54 INFO - 'USER': 'cltbld', 23:29:54 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1483082972.429503-1162778758', 23:29:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:54 INFO - '_': '/tools/buildbot/bin/python'} 23:29:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:29:54 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 23:29:54 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 23:29:54 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 23:29:54 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 23:29:54 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 23:29:54 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 23:29:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:29:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:29:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:29:56 INFO - Installing collected packages: mozsystemmonitor 23:29:56 INFO - Running setup.py install for mozsystemmonitor 23:29:56 INFO - Successfully installed mozsystemmonitor 23:29:56 INFO - Cleaning up... 23:29:56 INFO - Return code: 0 23:29:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:29:56 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')]} 23:29:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:56 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')]} 23:29:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:56 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 0x7f233fe24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16beca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bbf60>, '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 0x16bcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bd1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1483082972.429503-1162778758', '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 23:29:56 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 23:29:56 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 23:29:56 INFO - Using env: {'DISPLAY': ':0', 23:29:56 INFO - 'HOME': '/home/cltbld', 23:29:56 INFO - 'LANG': 'en_US.UTF-8', 23:29:56 INFO - 'LANGUAGE': 'en_US:en', 23:29:56 INFO - 'LOGNAME': 'cltbld', 23:29:56 INFO - 'MAIL': '/var/mail/cltbld', 23:29:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:56 INFO - 'MOZ_NO_REMOTE': '1', 23:29:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:29:56 INFO - 'NO_EM_RESTART': '1', 23:29:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:29:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:29:56 INFO - 'PWD': '/builds/slave/test', 23:29:56 INFO - 'SHELL': '/bin/bash', 23:29:56 INFO - 'SHLVL': '1', 23:29:56 INFO - 'TERM': 'linux', 23:29:56 INFO - 'TMOUT': '86400', 23:29:56 INFO - 'USER': 'cltbld', 23:29:56 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1483082972.429503-1162778758', 23:29:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:56 INFO - '_': '/tools/buildbot/bin/python'} 23:29:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:56 INFO - Downloading/unpacking jsonschema==2.5.1 23:29:56 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 23:29:56 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 23:29:56 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 23:29:56 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 23:29:56 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 23:29:56 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 23:29:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:29:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:29:58 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 23:29:58 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 23:29:58 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 23:29:58 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 23:29:58 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 23:29:58 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 23:29:58 INFO - Downloading functools32-3.2.3-2.tar.gz 23:29:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:29:59 INFO - warning: no files found matching '*.txt' 23:29:59 INFO - no previously-included directories found matching 'build' 23:29:59 INFO - no previously-included directories found matching 'dist' 23:29:59 INFO - no previously-included directories found matching '.git*' 23:29:59 INFO - Installing collected packages: jsonschema, functools32 23:29:59 INFO - Running setup.py install for functools32 23:29:59 INFO - warning: no files found matching '*.txt' 23:29:59 INFO - no previously-included directories found matching 'build' 23:29:59 INFO - no previously-included directories found matching 'dist' 23:29:59 INFO - no previously-included directories found matching '.git*' 23:29:59 INFO - Successfully installed jsonschema functools32 23:29:59 INFO - Cleaning up... 23:29:59 INFO - Return code: 0 23:29:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:29: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')]} 23:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29: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')]} 23:29:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:59 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 0x7f233fe24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16beca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bbf60>, '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 0x16bcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bd1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1483082972.429503-1162778758', '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 23:29:59 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 23:29:59 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 23:29:59 INFO - Using env: {'DISPLAY': ':0', 23:29:59 INFO - 'HOME': '/home/cltbld', 23:29:59 INFO - 'LANG': 'en_US.UTF-8', 23:29:59 INFO - 'LANGUAGE': 'en_US:en', 23:29:59 INFO - 'LOGNAME': 'cltbld', 23:29:59 INFO - 'MAIL': '/var/mail/cltbld', 23:29:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:59 INFO - 'MOZ_NO_REMOTE': '1', 23:29:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:29:59 INFO - 'NO_EM_RESTART': '1', 23:29:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:29:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:29:59 INFO - 'PWD': '/builds/slave/test', 23:29:59 INFO - 'SHELL': '/bin/bash', 23:29:59 INFO - 'SHLVL': '1', 23:29:59 INFO - 'TERM': 'linux', 23:29:59 INFO - 'TMOUT': '86400', 23:29:59 INFO - 'USER': 'cltbld', 23:29:59 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1483082972.429503-1162778758', 23:29:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:59 INFO - '_': '/tools/buildbot/bin/python'} 23:29:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:29:59 INFO - Cleaning up... 23:29:59 INFO - Return code: 0 23:29:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:29: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')]} 23:29:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:29:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29: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')]} 23:29:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:29:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:29:59 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 0x7f233fe24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16beca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bbf60>, '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 0x16bcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bd1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1483082972.429503-1162778758', '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 23:29:59 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 23:29:59 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 23:29:59 INFO - Using env: {'DISPLAY': ':0', 23:29:59 INFO - 'HOME': '/home/cltbld', 23:29:59 INFO - 'LANG': 'en_US.UTF-8', 23:29:59 INFO - 'LANGUAGE': 'en_US:en', 23:29:59 INFO - 'LOGNAME': 'cltbld', 23:29:59 INFO - 'MAIL': '/var/mail/cltbld', 23:29:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:29:59 INFO - 'MOZ_NO_REMOTE': '1', 23:29:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:29:59 INFO - 'NO_EM_RESTART': '1', 23:29:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:29:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:29:59 INFO - 'PWD': '/builds/slave/test', 23:29:59 INFO - 'SHELL': '/bin/bash', 23:29:59 INFO - 'SHLVL': '1', 23:29:59 INFO - 'TERM': 'linux', 23:29:59 INFO - 'TMOUT': '86400', 23:29:59 INFO - 'USER': 'cltbld', 23:29:59 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1483082972.429503-1162778758', 23:29:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:29:59 INFO - '_': '/tools/buildbot/bin/python'} 23:29:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:29:59 INFO - Downloading/unpacking blobuploader==1.2.4 23:29:59 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 23:29:59 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 23:29:59 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 23:29:59 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 23:29:59 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 23:29:59 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 23:30:01 INFO - Downloading blobuploader-1.2.4.tar.gz 23:30:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:30:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:30:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:30:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:30:02 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 23:30:02 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 23:30:02 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 23:30:02 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 23:30:02 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 23:30:02 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 23:30:02 INFO - Downloading docopt-0.6.1.tar.gz 23:30:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:30:02 INFO - Installing collected packages: blobuploader, requests, docopt 23:30:02 INFO - Running setup.py install for blobuploader 23:30:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:30:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:30:02 INFO - Running setup.py install for requests 23:30:02 INFO - Running setup.py install for docopt 23:30:03 INFO - Successfully installed blobuploader requests docopt 23:30:03 INFO - Cleaning up... 23:30:03 INFO - Return code: 0 23:30:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:30:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:30:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:30:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:03 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 0x7f233fe24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16beca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bbf60>, '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 0x16bcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bd1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1483082972.429503-1162778758', '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 23:30:03 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 23:30:03 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 23:30:03 INFO - Using env: {'DISPLAY': ':0', 23:30:03 INFO - 'HOME': '/home/cltbld', 23:30:03 INFO - 'LANG': 'en_US.UTF-8', 23:30:03 INFO - 'LANGUAGE': 'en_US:en', 23:30:03 INFO - 'LOGNAME': 'cltbld', 23:30:03 INFO - 'MAIL': '/var/mail/cltbld', 23:30:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:03 INFO - 'MOZ_NO_REMOTE': '1', 23:30:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:30:03 INFO - 'NO_EM_RESTART': '1', 23:30:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:30:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:03 INFO - 'PWD': '/builds/slave/test', 23:30:03 INFO - 'SHELL': '/bin/bash', 23:30:03 INFO - 'SHLVL': '1', 23:30:03 INFO - 'TERM': 'linux', 23:30:03 INFO - 'TMOUT': '86400', 23:30:03 INFO - 'USER': 'cltbld', 23:30:03 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1483082972.429503-1162778758', 23:30:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:03 INFO - '_': '/tools/buildbot/bin/python'} 23:30:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:30:03 INFO - Running setup.py (path:/tmp/pip-Gisx_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:30:03 INFO - Running setup.py (path:/tmp/pip-Kdn7hK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:30:03 INFO - Running setup.py (path:/tmp/pip-SMrvH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:30:03 INFO - Running setup.py (path:/tmp/pip-4IWl1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:30:03 INFO - Running setup.py (path:/tmp/pip-K8Jp14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:30:03 INFO - Running setup.py (path:/tmp/pip-jdQYOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:30:03 INFO - Running setup.py (path:/tmp/pip-KJ81ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:30:03 INFO - Running setup.py (path:/tmp/pip-HhbLff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:30:03 INFO - Running setup.py (path:/tmp/pip-Cu_B3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:30:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:30:03 INFO - Running setup.py (path:/tmp/pip-0Ryoml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:30:04 INFO - Running setup.py (path:/tmp/pip-pxzq7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:30:04 INFO - Running setup.py (path:/tmp/pip-ygLJZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:30:04 INFO - Running setup.py (path:/tmp/pip-StAYIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:30:04 INFO - Running setup.py (path:/tmp/pip-eparVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:30:04 INFO - Running setup.py (path:/tmp/pip-zGH9G0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:30:04 INFO - Running setup.py (path:/tmp/pip-MqIPNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:30:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:30:04 INFO - Running setup.py (path:/tmp/pip-ZpLNLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:30:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:30:04 INFO - Running setup.py install for manifestparser 23:30:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:30:04 INFO - Running setup.py install for mozcrash 23:30:04 INFO - Running setup.py install for mozdebug 23:30:04 INFO - Running setup.py install for mozdevice 23:30:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:30:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:30:04 INFO - Running setup.py install for mozfile 23:30:05 INFO - Running setup.py install for mozhttpd 23:30:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:30:05 INFO - Running setup.py install for mozinfo 23:30:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:30:05 INFO - Running setup.py install for mozInstall 23:30:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:30:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:30:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:30:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:30:05 INFO - Running setup.py install for mozleak 23:30:05 INFO - Running setup.py install for mozlog 23:30:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:30:05 INFO - Running setup.py install for moznetwork 23:30:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:30:05 INFO - Running setup.py install for mozprocess 23:30:05 INFO - Running setup.py install for mozprofile 23:30:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:30:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:30:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:30:05 INFO - Running setup.py install for mozrunner 23:30:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:30:06 INFO - Running setup.py install for mozscreenshot 23:30:06 INFO - Running setup.py install for moztest 23:30:06 INFO - Running setup.py install for mozversion 23:30:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:30:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:30:06 INFO - Cleaning up... 23:30:06 INFO - Return code: 0 23:30:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:30:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:30:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:30:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:06 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 0x7f233fe24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16beca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bbf60>, '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 0x16bcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bd1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1483082972.429503-1162778758', '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 23:30:06 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 23:30:06 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 23:30:06 INFO - Using env: {'DISPLAY': ':0', 23:30:06 INFO - 'HOME': '/home/cltbld', 23:30:06 INFO - 'LANG': 'en_US.UTF-8', 23:30:06 INFO - 'LANGUAGE': 'en_US:en', 23:30:06 INFO - 'LOGNAME': 'cltbld', 23:30:06 INFO - 'MAIL': '/var/mail/cltbld', 23:30:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:06 INFO - 'MOZ_NO_REMOTE': '1', 23:30:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:30:06 INFO - 'NO_EM_RESTART': '1', 23:30:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:30:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:06 INFO - 'PWD': '/builds/slave/test', 23:30:06 INFO - 'SHELL': '/bin/bash', 23:30:06 INFO - 'SHLVL': '1', 23:30:06 INFO - 'TERM': 'linux', 23:30:06 INFO - 'TMOUT': '86400', 23:30:06 INFO - 'USER': 'cltbld', 23:30:06 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1483082972.429503-1162778758', 23:30:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:06 INFO - '_': '/tools/buildbot/bin/python'} 23:30:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:30:06 INFO - Running setup.py (path:/tmp/pip-eqrgkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:30:06 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)) 23:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:30:06 INFO - Running setup.py (path:/tmp/pip-McfZy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:30:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:30:06 INFO - Running setup.py (path:/tmp/pip-8tfy25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:30:06 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)) 23:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:30:06 INFO - Running setup.py (path:/tmp/pip-G6gw7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:30:06 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)) 23:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:30:06 INFO - Running setup.py (path:/tmp/pip-f4e4Dy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:30:06 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)) 23:30:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:30:06 INFO - Running setup.py (path:/tmp/pip-7yKQ77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:30:07 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)) 23:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:30:07 INFO - Running setup.py (path:/tmp/pip-aa2n7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:30:07 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)) 23:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:30:07 INFO - Running setup.py (path:/tmp/pip-mnUucW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:30:07 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)) 23:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:30:07 INFO - Running setup.py (path:/tmp/pip-mUtOAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:30:07 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)) 23:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:30:07 INFO - Running setup.py (path:/tmp/pip-1sCn8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:30:07 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)) 23:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:30:07 INFO - Running setup.py (path:/tmp/pip-zHdaVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:30:07 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)) 23:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:30:07 INFO - Running setup.py (path:/tmp/pip-XntgKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:30:07 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)) 23:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:30:07 INFO - Running setup.py (path:/tmp/pip-YtgNd2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:30:07 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)) 23:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:30:07 INFO - Running setup.py (path:/tmp/pip-EIR4uf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:30:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:30:07 INFO - Running setup.py (path:/tmp/pip-EQjWeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:30:07 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)) 23:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:30:07 INFO - Running setup.py (path:/tmp/pip-1iqjTG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:30:07 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)) 23:30:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:30:07 INFO - Running setup.py (path:/tmp/pip-GcNi1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:30:07 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)) 23:30:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:30:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:30:07 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)) 23:30:07 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)) 23:30:07 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)) 23:30:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:30:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:30:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:30:09 INFO - Downloading blessings-1.6.tar.gz 23:30:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:30:09 INFO - Installing collected packages: blessings 23:30:09 INFO - Running setup.py install for blessings 23:30:10 INFO - Successfully installed blessings 23:30:10 INFO - Cleaning up... 23:30:10 INFO - Return code: 0 23:30:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:30:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:30:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:30:10 INFO - Reading from file tmpfile_stdout 23:30:10 INFO - Current package versions: 23:30:10 INFO - argparse == 1.2.1 23:30:10 INFO - blessings == 1.6 23:30:10 INFO - blobuploader == 1.2.4 23:30:10 INFO - docopt == 0.6.1 23:30:10 INFO - functools32 == 3.2.3-2 23:30:10 INFO - jsonschema == 2.5.1 23:30:10 INFO - manifestparser == 1.1 23:30:10 INFO - mozInstall == 1.12 23:30:10 INFO - mozcrash == 1.0 23:30:10 INFO - mozdebug == 0.1 23:30:10 INFO - mozdevice == 0.48 23:30:10 INFO - mozfile == 1.2 23:30:10 INFO - mozhttpd == 0.7 23:30:10 INFO - mozinfo == 0.9 23:30:10 INFO - mozleak == 0.1 23:30:10 INFO - mozlog == 3.4 23:30:10 INFO - moznetwork == 0.27 23:30:10 INFO - mozprocess == 0.23 23:30:10 INFO - mozprofile == 0.28 23:30:10 INFO - mozrunner == 6.13 23:30:10 INFO - mozscreenshot == 0.1 23:30:10 INFO - mozsystemmonitor == 0.3 23:30:10 INFO - moztest == 0.7 23:30:10 INFO - mozversion == 1.4 23:30:10 INFO - psutil == 3.1.1 23:30:10 INFO - requests == 1.2.3 23:30:10 INFO - wsgiref == 0.1.2 23:30:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:30: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')]} 23:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:30:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30: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')]} 23:30:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:30:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30:10 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 0x7f233fe24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16beca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bbf60>, '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 0x16bcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bd1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1483082972.429503-1162778758', '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 23:30:10 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 23:30:10 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 23:30:10 INFO - Using env: {'DISPLAY': ':0', 23:30:10 INFO - 'HOME': '/home/cltbld', 23:30:10 INFO - 'LANG': 'en_US.UTF-8', 23:30:10 INFO - 'LANGUAGE': 'en_US:en', 23:30:10 INFO - 'LOGNAME': 'cltbld', 23:30:10 INFO - 'MAIL': '/var/mail/cltbld', 23:30:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:10 INFO - 'MOZ_NO_REMOTE': '1', 23:30:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:30:10 INFO - 'NO_EM_RESTART': '1', 23:30:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:30:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:10 INFO - 'PWD': '/builds/slave/test', 23:30:10 INFO - 'SHELL': '/bin/bash', 23:30:10 INFO - 'SHLVL': '1', 23:30:10 INFO - 'TERM': 'linux', 23:30:10 INFO - 'TMOUT': '86400', 23:30:10 INFO - 'USER': 'cltbld', 23:30:10 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1483082972.429503-1162778758', 23:30:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:10 INFO - '_': '/tools/buildbot/bin/python'} 23:30:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:30:10 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)) 23:30:10 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)) 23:30:10 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)) 23:30:10 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)) 23:30:10 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)) 23:30:10 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)) 23:30:10 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)) 23:30:10 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)) 23:30:10 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)) 23:30:10 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)) 23:30:10 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)) 23:30:10 INFO - Cleaning up... 23:30:10 INFO - Return code: 0 23:30:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:30: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')]} 23:30:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:30:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30: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')]} 23:30:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:30:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:30: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f233fe24f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16beca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16bbf60>, '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 0x16bcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bd1d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1483082972.429503-1162778758', '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 23:30: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'] in /builds/slave/test/build 23:30: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 23:30:10 INFO - Using env: {'DISPLAY': ':0', 23:30:10 INFO - 'HOME': '/home/cltbld', 23:30:10 INFO - 'LANG': 'en_US.UTF-8', 23:30:10 INFO - 'LANGUAGE': 'en_US:en', 23:30:10 INFO - 'LOGNAME': 'cltbld', 23:30:10 INFO - 'MAIL': '/var/mail/cltbld', 23:30:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:10 INFO - 'MOZ_NO_REMOTE': '1', 23:30:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:30:10 INFO - 'NO_EM_RESTART': '1', 23:30:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:30:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:10 INFO - 'PWD': '/builds/slave/test', 23:30:10 INFO - 'SHELL': '/bin/bash', 23:30:10 INFO - 'SHLVL': '1', 23:30:10 INFO - 'TERM': 'linux', 23:30:10 INFO - 'TMOUT': '86400', 23:30:10 INFO - 'USER': 'cltbld', 23:30:10 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1483082972.429503-1162778758', 23:30:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:10 INFO - '_': '/tools/buildbot/bin/python'} 23:30:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:30:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:30:10 INFO - Cleaning up... 23:30:10 INFO - Return code: 0 23:30:10 INFO - Running post-action listener: _resource_record_post_action 23:30:10 INFO - Running post-action listener: _start_resource_monitoring 23:30:10 INFO - Starting resource monitoring. 23:30:10 INFO - [mozharness: 2016-12-30 07:30:10.859829Z] Finished create-virtualenv step (success) 23:30:10 INFO - [mozharness: 2016-12-30 07:30:10.860290Z] Running install step. 23:30:10 INFO - Running pre-action listener: _resource_record_pre_action 23:30:10 INFO - Running main action method: install 23:30:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:30:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:30:11 INFO - Reading from file tmpfile_stdout 23:30:11 INFO - Detecting whether we're running mozinstall >=1.0... 23:30:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:30:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:30:11 INFO - Reading from file tmpfile_stdout 23:30:11 INFO - Output received: 23:30:11 INFO - Usage: mozinstall [options] installer 23:30:11 INFO - Options: 23:30:11 INFO - -h, --help show this help message and exit 23:30:11 INFO - -d DEST, --destination=DEST 23:30:11 INFO - Directory to install application into. [default: 23:30:11 INFO - "/builds/slave/test"] 23:30:11 INFO - --app=APP Application being installed. [default: firefox] 23:30:11 INFO - mkdir: /builds/slave/test/build/application 23:30:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:30:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:30:27 INFO - Reading from file tmpfile_stdout 23:30:27 INFO - Output received: 23:30:27 INFO - /builds/slave/test/build/application/firefox/firefox 23:30:27 INFO - Running post-action listener: _resource_record_post_action 23:30:27 INFO - [mozharness: 2016-12-30 07:30:27.368582Z] Finished install step (success) 23:30:27 INFO - [mozharness: 2016-12-30 07:30:27.368823Z] Running run-tests step. 23:30:27 INFO - Running pre-action listener: _resource_record_pre_action 23:30:27 INFO - Running main action method: run_tests 23:30:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:30:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:30:27 INFO - Python 2.7.3 23:30:27 INFO - Return code: 0 23:30:27 INFO - grabbing minidump binary from tooltool 23:30:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:30:27 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 0x16bbf60>, '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 0x16bcd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16bd1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:30:27 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 23:30:27 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 23:30:27 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 23:30:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:30:27 INFO - Return code: 0 23:30:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:30:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:30:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:30:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:30:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:30:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/faRoWNgqR2q3Wnvk807WnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 23:30:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/faRoWNgqR2q3Wnvk807WnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 23:30:27 INFO - Using env: {'DISPLAY': ':0', 23:30:27 INFO - 'HOME': '/home/cltbld', 23:30:27 INFO - 'LANG': 'en_US.UTF-8', 23:30:27 INFO - 'LANGUAGE': 'en_US:en', 23:30:27 INFO - 'LOGNAME': 'cltbld', 23:30:27 INFO - 'MAIL': '/var/mail/cltbld', 23:30:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:30:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:30:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:30:27 INFO - 'MOZ_NO_REMOTE': '1', 23:30:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:30:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:30:27 INFO - 'NO_EM_RESTART': '1', 23:30:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:30:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:30:27 INFO - 'PWD': '/builds/slave/test', 23:30:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:30:27 INFO - 'SHELL': '/bin/bash', 23:30:27 INFO - 'SHLVL': '1', 23:30:27 INFO - 'TERM': 'linux', 23:30:27 INFO - 'TMOUT': '86400', 23:30:27 INFO - 'USER': 'cltbld', 23:30:27 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1483082972.429503-1162778758', 23:30:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:30:27 INFO - '_': '/tools/buildbot/bin/python'} 23:30:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/faRoWNgqR2q3Wnvk807WnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 23:30:27 INFO - mozversion application_buildid: 20161229214720 23:30:27 INFO - mozversion application_changeset: b213de949cddebe0a123654be580ba114b951020 23:30:27 INFO - mozversion application_display_name: FirefoxDeveloperEdition 23:30:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:30:27 INFO - mozversion application_name: Firefox 23:30:27 INFO - mozversion application_remotingname: firefox-dev 23:30:27 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:30:27 INFO - mozversion application_vendor: Mozilla 23:30:27 INFO - mozversion application_version: 52.0a2 23:30:27 INFO - mozversion platform_buildid: 20161229214720 23:30:27 INFO - mozversion platform_changeset: b213de949cddebe0a123654be580ba114b951020 23:30:27 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 23:30:27 INFO - mozversion platform_version: 52.0a2 23:30:27 INFO - using testdate: 1483083027 23:30:27 INFO - actual date: 1483083027 23:30:27 INFO - starting webserver on 'localhost:45731' 23:30:27 INFO - SUITE-START | Running 2 tests 23:30:27 INFO - TEST-START | dromaeo_css 23:30:27 INFO - operating with platform_type : linux_ 23:30:27 INFO - Initialising browser for dromaeo_css test... 23:30:27 INFO - TEST-INFO | started process 18581 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKy8vRY/profile http://localhost:45731/getInfo.html) 23:30:31 INFO - PROCESS | 18581 | __metrics Screen width/height:1600/1200 23:30:31 INFO - PROCESS | 18581 | colorDepth:24 23:30:31 INFO - PROCESS | 18581 | Browser inner width/height: 1024/697 23:30:31 INFO - PROCESS | 18581 | __metrics 23:30:32 INFO - PROCESS | 18581 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:30:32 INFO - PROCESS | 18581 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:30:33 INFO - PROCESS | 18581 | console.error: PushService: 23:30:33 INFO - PROCESS | 18581 | stateChangeProcessEnqueue: Error transitioning state 23:30:33 INFO - PROCESS | 18581 | UnknownError 23:30:33 INFO - TEST-INFO | 18581: exit 0 23:30:33 INFO - Browser initialized. 23:30:33 INFO - Running cycle 1/1 for dromaeo_css test... 23:30:33 INFO - TEST-INFO | started process 18676 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKy8vRY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:30:45 INFO - PROCESS | 18676 | RSS: Main: 144957440 23:30:45 INFO - PROCESS | 18676 | 23:31:37 INFO - PROCESS | 18676 | 1483083097238 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] 23:33:47 INFO - PROCESS | 18676 | Cycle 1(1): loaded http://localhost:45731/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45731/tests/dromaeo/cssquery-ext.html) 23:33:48 INFO - PROCESS | 18676 | RSS: Main: 232112128 23:33:48 INFO - PROCESS | 18676 | 23:36:50 INFO - PROCESS | 18676 | Cycle 1(1): loaded http://localhost:45731/tests/dromaeo/cssquery-ext.html (next: http://localhost:45731/tests/dromaeo/cssquery-jquery.html) 23:36:51 INFO - PROCESS | 18676 | RSS: Main: 234946560 23:36:51 INFO - PROCESS | 18676 | 23:39:53 INFO - PROCESS | 18676 | Cycle 1(1): loaded http://localhost:45731/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45731/tests/dromaeo/cssquery-mootools.html) 23:39:53 INFO - PROCESS | 18676 | RSS: Main: 176967680 23:39:53 INFO - PROCESS | 18676 | 23:42:55 INFO - PROCESS | 18676 | Cycle 1(1): loaded http://localhost:45731/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45731/tests/dromaeo/cssquery-prototype.html) 23:42:56 INFO - PROCESS | 18676 | RSS: Main: 175161344 23:42:56 INFO - PROCESS | 18676 | 23:45:59 INFO - PROCESS | 18676 | Cycle 1(1): loaded http://localhost:45731/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45731/tests/dromaeo/cssquery-yui.html) 23:45:59 INFO - PROCESS | 18676 | RSS: Main: 175333376 23:45:59 INFO - PROCESS | 18676 | 23:49:02 INFO - PROCESS | 18676 | Cycle 1(1): loaded http://localhost:45731/tests/dromaeo/cssquery-yui.html (next: http://localhost:45731/tests/dromaeo/cssquery-dojo.html) 23:49:02 INFO - PROCESS | 18676 | RSS: Main: 268353536 23:49:02 INFO - PROCESS | 18676 | 23:49:02 INFO - PROCESS | 18676 | __start_tp_report 23:49:02 INFO - PROCESS | 18676 | _x_x_mozilla_page_load 23:49:02 INFO - PROCESS | 18676 | _x_x_mozilla_page_load_details 23:49:02 INFO - PROCESS | 18676 | |i|pagename|runs| 23:49:02 INFO - PROCESS | 18676 | |0;dojo.html;3193.80837149771;3231.2729635831924;3233.1432170474827;3234.5956755405573;3277.3281477297155;5394.2717733106065;5446.373667028293;5461.453854614537;5470.753816078276;5472.808451704191;5470.398256191816;5523.867607140536;5556.333240011194;5561.082421400474;5561.972190139054;4994.67534610251;5031.748412579356;5044.672096313728;5119;5122.948770512285;4923.58149557288;5124.820631277906;5170.767315470813;5179.197224430201;5191.662541934781;4915.778789954443;5021.748912554358;5053.873653158664;5061.848144555669;5066.544011039005;5080.085584594772;5118.897622047538;5123.20590308501;5160.56135228506;5188.92216616751;5037.395512538482;5108.463611320795;5144.922826157611;5166.07010738067;5187.662801917901;5402.108652072403;5422.728863556846;5441.700706461143;5447.373552041527;5479.150731636602;5863.794767183128;5936.851578710523;5954.047352423635;5954.791582294599;5958.046712526018;5981.820545383645;5986.73059712314;6002.96998515009;6012.488938440238;6016.368281330485;5475.780968761244;5482.945170548323;5507.5593952483705;5515.972420137914;5591.7483713233005;6019.097135429721;6039.63762174271;6039.909401358983;6079.513638908877;6080.69596520181;5838.503727183237;5845.444682755132;5856.560757943086;5863.472287494146;5870.148828419855;5743.511801496919;5753.712314384264;5927.881442371128;5943.940560594425;5944.6730429826775;5817.738201780845;5861.5603829712945;5867.735951882176;5952.523798096142;5955.464008239279;5847.181394604759;5884.764609415661;5885.970570147122;5889.676067816311;5894.38108998549;4407.845725399596;4568.33759104928;4571.519990401027;4576.336431217454;4605.355250264965;4004.6395824375945;4012.378081397388;4054.2296963576828;4059.6955228357992;4116.217918595457;5679;5683.119116536944;5687.203791469197;5689.829305120853;5691.345495268097;5931.051031834886;5935;5945.108233764883;5948.196993405922;5950.67271300074;5506.256655351476;5567.3040869891265;5636.971815140898;5690;5691.203231547586;5161.974190129101;5165.664231824994;5166.225066240094;5168.173092305213;5168.767405466763;6218.471429928416;6282.246130464374;6284.685765711604;6285.277193122758;6288.371162883766;5807.186993820784;5854.824355269348;5865.149553314831;5910.586258961831;5934.584579079596;6227.595206311576;6236.532260080421;6239.500839932885;6242.750289988531;6251.218597675291;5864.9413505866105;5866.266716660418;5868.38381969887;5869.7945571904775;5907.763689452374;5819.883602328015;5822.621529600562;5900.970495147497;5973.283206015132;5978.252718410199;5791.942080579141;5804.82585522435;5859.20900678403;5871.530277577698;5887.793927212527;5779.566532509994;5785.508231800176;5843.386444423274;5847.795327163529;5851.414858514115;5471.890562188654;5491.890162196653;5712.6286791358425;5724.713764311685;5729.742161602821;5763.5965482417505;5823.534117270524;5830.591858569859;5859.355470898283;5889.823305300848;5726.8568285791525;5735.827925162252;5736.971315143398;5741.885162296647;5766.826995190151 23:49:02 INFO - PROCESS | 18676 | |1;ext.html;570.9514691251244;603.9728212230449;611.8776244751051;624.2976651267321;653.7646447278976;33458;45589.31616025758;46490;46600;46661.30008049882;45544.35645148389;45777.7711111444;46185.769071154595;46235.76882115585;46303.768481157545;8320.791980200513;8507.106753790855;8742.868856967134;8910.688125915594;8936.865947010767;10389.1688664907;10608.204384671142;10611.204159688015;10876.184286178528;10887.292325998824;10742.462876856125;10800.78398432031;10801.081908037788;10803.78392432151;10825.67522974312;10598.152147828156;10638.148948084136;10647.14822814173;10654.360738355685;10671.19966002553;10670.733231669194;10733.463326833706;10738.409387483685;10743.785124297548;10754.139668826476;43668;43880.56119438797;43938;43952.78023609894;43983.56016439859;3490.965090349089;3617.276544691072;3659.2681463707363;3666.2667466506537;3949.0917089069676;30620.8468957656;30675.2331191722;30984.225394365098;31093.067207983797;31689.366212675846;4288.421063156465;4362.322312729587;4414.139242847646;4422.690411671184;4426.449401361233;256270.71864640745;256615;257231;257559;259350;63931.36068639347;64181.358186417536;64281;64359.356406435334;64377.356226438074;40998.590014100075;67133;67328.6633566829;67445;67581;17771.822281777277;17819;17836.3757268495;17994.64010719778;18006.5498362542;12659.430325635369;12756.362181890869;13402.329883505785;13743.312834358243;14019.579412617637;20888.58222835565;20950.89524552398;21063.8946805265;21120.04959776814;21188.78811211868;7272.418206543463;7292.927070729224;7569.633643703291;7661.923380766232;7676.200280860898;989.7129832348683;1038.6728180623231;1040.953157107932;1042.9426381548935;1082.1451053667515;33427;33945.830270848484;34000.829995850356;34044.65955340464;34089.65910340915;1114.4483480676954;1118.645251745065;1177.7585594953014;1185.5850452341783;1253.7053792358788;16731.91634041822;17846.910765446348;17880.46358609244;18044;18057.187426565837;530034;532898;535192;535756;538367;61054.38945610487;62302.37697622966;62470.68764656239;62537.68731156315;62711.059334110025;1313.9934300328437;1339.3035621476777;1344.8722371374508;1371.245814801855;1430.1490613085198;27563.724362756115;36601.81699091488;37151.442728358554;37256.62743372531;37330;60061;60573;60712;60850;60869.39130608637;461019;462711;463828;465734;466633;30485.390292193588;31127.377452451277;31230;31324.843375782973;31414.685853141174;49459.75270123626;49665.751671241414;49803.75098124486;50496.24255636242;51581.226281606556;42639;42924;44074;44179.337309939736;45431.772841135586;42787.7860610695;43117;43316;43544;43909.341359880265;43149.78425107854;43464.34803478014;43897.78051109724;44337.33493997657;44506;35019.29961400809;38050.80974595109;38087.42868856914;38425.80787096047;38868.22263554657;29118.7088129116;29139.271518211368;29322.56016159717;29443.263918402212;29680.851595742748 23:49:02 INFO - PROCESS | 18676 | |2;jquery.html;386.77567011133544;405.2179293962651;422.666093785909;423.0861339506665;431.94600674915637;14442.350094245758;16220.432284870032;19648.115834787415;20207.292744753937;20686.37940861773;19470.707939380885;20228.797712022875;20270.797292027077;20368.796312036877;20460;5662.6602403855695;5719;5868.119782032708;5905.970470147665;5970.940290597082;4306.35404689296;4501.257292546742;5854.326752423462;5940.405959404068;5941.732622032019;4471.284594464886;4472.262076757331;6288.182536270278;6529.1512103426485;6548.9345106549035;6521.054447105167;6547.6726163691865;6590.703418346186;6605.174353205849;6626.403623673868;5854.18041474194;5857.4435428634215;5857.7949771757785;5860.033094539396;5867.061270196791;14707.779383309258;16120.516384508366;22286.77713222863;22854;23005.194818181284;2211.1487077475126;2274.715660542432;2286.8284878634004;2381.46417056161;2411.9155829546057;10256.179505639531;10336;10438.582456701723;10446.26876118672;10589.470526473722;1843.5298998755231;1843.7142242952364;1876.352658332873;1878.5209771508314;1912.7895931447529;91179.54410227973;91314.5434272831;93611;94889;96194;11292.15308851823;11334.093272538343;11512.539498420138;11568.479418426192;11573.42132893352;16182.433614823425;16194.190290485663;16250.837491625169;16267.18664066792;16273.186340682918;8284.047334556482;8312.8753068704;8405.411621186458;8489.702860399857;8797.38418310712;7926.167752386032;8049.718259860877;8052.396070294634;8109.229623185788;8127.1466496017065;4539.137563862855;4626.467956185014;4907.2393778964315;4920.704757714477;4937.604991600663;2031.89840507974;2065.4113577630606;2083.7603675577197;2084.6143463459307;2100.947476313074;908.100980029779;908.7591788176138;972.8248915195192;1044.3316277582353;1104.7790441911488;19360.225590976203;19548;19848.801511984697;20072.799272007094;20248.392548223575;1038.3043360948184;1042.4266653340633;1053.1574740207802;1056.265895202842;1076.0261962923566;10252.179825614083;11115.277506962022;11139.498722557342;11167.944160279147;11170.832437513443;445248;463140;490890;510285;513038;95787.52106239424;99772.50113749385;100680;102717.48641256895;103412;982.9311948163703;1000.8949060348705;1013.0882206014646;1022.9488525573692;1026.573971801694;17395;17764.91117544456;18075.638487230444;18110.90944545269;18438.81561184371;43709.56290437055;44229.55770442254;44964.77517612391;45318;45397;57748;62037.379626204965;63258.68370658117;63870.36129638644;64186.67906660437;8650;8705.956470217609;9011;9120.680776172801;9265.212456940966;12502.687432814253;12789.872101278868;13009.154404963647;13501.189928604315;13525.932370338085;11480.368579727861;11509.769804604028;11565.306081635128;11684.474198660911;11749.647510574696;11451;11499.080073593925;11599.362035088152;11601.651950441501;11674.591389301333;11530.365829879438;11746.70633234176;11754.353510556659;11901.702457438287;12015.519379225083;8630.525321107149;8739.519326436852;8825.161609647073;9005.36962412651;9087.500187489752;10421.791564168825;11334.319940803578;11390.430478475877;11682.649520514398;11958.461869215733 23:49:02 INFO - PROCESS | 18676 | |3;mootools.html;1385.8129152564404;1441.7116576684664;1502.7896094546766;1724.3878423159786;1739.512936377814;7805.219478052192;8072.55600941948;8083.91916080839;8089.23152300532;8107.6756929722815;6986.3362980516895;7163.068801055855;7578.128515220751;7756;7941.801454963629;2298.402415372007;2314.826388020897;2315.9652605210936;2319.744828068911;2328.0338659456306;2339.7660233976635;2387.940301492468;2390.725066617344;2394.95819318597;2405.579023670851;2354.364321633158;2359.0210062823908;2368.834181607288;2380;2380.5238952209543;2254.842161048727;2258.8192944564394;2276.362618466832;2276.635738281875;2300.332903457995;2267.036509483479;2283.5318759654233;2285.223024171773;2286.3483907086566;2286.4283929017747;7957;8006.079300880415;8013.318867896178;8015.158408367096;8026.518408895485;4983.975080124576;5133.717645529495;5134.17853143499;5136.255242989783;5138.46046165151;3164.4145833020966;3222.130024893289;3419.9829000855084;3424.8423493199375;3432.2792213634916;1119.306030261235;1162.5582278734028;1169.1990986174499;1175.1186610042469;1182.148852825964;10817.567297308098;10915.181361397927;10917.23579349446;10917.890821091767;10933.453327333682;4399.73601583906;4512.75179865104;4581.427321584802;4617;4724;9346.626134954662;9347.2054875335;9359.672411465703;9360.812783744286;9363.438193708263;5165.870853228625;5170.043541944752;5176.120059589879;5180.637355385163;5181.948180518222;4225.345071513921;4241.4698162729655;4618.145643056046;4686.6485013624115;4760.833370832004;3873.670737987303;3946.625070618287;3993.7803420812133;4032.4556184915245;4046.838126474967;1354.613935028512;1356.3489525028042;1360.6122255157431;1372.8695773901463;1373.3819781098346;791.9485233459807;926.3006430145198;936.4053825820653;937.3906960475746;964.7491652170486;5217.6086793489885;5420.24116623673;5443.156310771837;5533.833984980457;5562.666240025531;465.37174814001503;470.35796138271695;482.7610332885244;488.18473149839855;498.5214194373442;3708.128589781399;3711.814409279525;3752.1370084880086;3753.8123093845197;3797.0697179191275;9182;9743.317967742332;9747.951260243653;9759.414435133773;9766.755831104138;9542.093501117382;9679.467629280458;9702.75743106414;9751.561179746928;9761.755956101013;7588.780762465668;7597.202293759186;7668.501547399401;7673;7714.459987800912;5247.55395791362;5271.077561426659;5349.97325013388;5383.057964856056;5438.8368348948015;8985.101489850962;8993.965693945018;9085.954570227106;9125.406848554823;9144.3598948073;8761.25529330014;9074.682386116454;9095;9124.49815260167;9136.360454768368;6437.420632143129;6598.04328372393;7016.964915175391;7374.483786134919;7520.172780994196;7365.8526829462035;7641.885371719318;7648.961755191189;7649.196834332315;7649.732259370895;6798.150231221098;6904.516683832084;6968.616726080114;6976.5465244758925;6989.231184569795;6795.150606174228;6947.548409353376;7010.47421443404;7033.366996970297;7071.71713131469;6269.059641053878;6347.174867267226;6363.172787537591;6381.361863813581;6411.358864113738;4598.057398233287;4658.254679251304;4691.249400095969;4717.386739723814;4740.691855029412;4800.3279540865005;4886.438059623189;4897.877553061202;4929.950700493093;4978.8755281118265 23:49:02 INFO - PROCESS | 18676 | |4;prototype.html;343.6237320134453;350.77725644215917;350.93156834417283;353.05029470723736;354.9059499232704;5373.623846330758;5399.48704873037;5402.217268301466;5403.8108666196695;5444.700541470217;5325.281087053247;5340.946590534093;5353.250544923704;5361.329833770778;5375.650582712121;3986.900327491807;4063.3701776224657;4192.622663960243;4215.241256573816;4235.703500754948;4144.772037537934;4188.937165942513;4227.239096962546;4227.746335219881;4247.63895068918;4145.336746120622;4187.28816101262;4190.832366705344;4198.748075115487;4201.537830838605;3985.3224951758125;4061.6953728470335;4190.853320133811;4212.85255016073;4236.872893813191;3741.5594995926763;3745.213505163919;3750.8124593770203;3756.455313979485;3771.41543060826;5182.170058683981;5195.1687729963405;5197.350331208599;5199.974000129975;5246.554042906358;4533.365328853963;4694.929576056362;4778.351468743278;4780.856574302777;4838.975805120987;5548.334199896039;5582.274304340451;5583.162525621189;5593.3847276799515;5628.887422251532;4062.106336605942;4080.5307389650275;4084.5711200323835;4087.6729861611;4105.876823695294;5608.6073974821775;5783.479486846162;5813.738381772788;5834.474897259224;5876.265466816648;4153.91692166155;4170.436991006236;4185.351270553069;4193.622573968358;4212.220739163204;4247.3628955656895;4256.87229383119;4259.742336561627;4267.615914567704;4276.957230427718;4760.428748550196;4764.714117152982;4810.230363141881;4815.903681926342;4832.420109586872;5634.85912852182;5635.520980716603;5639.379668236491;5645.717714114277;5655.5475561954945;1405.4237762517319;1420.8081908942368;1423.7152569486145;1424.9928750356182;1433.6989232261342;973.2651847854966;991.8115558044093;993.8658281132099;998.3610489286863;1012.7518757904213;5265.7103859287345;5404.189371594213;5426.484483974016;5536.4186760389575;5559.416261292587;5684.7157642118555;5791.160281759121;5800.796972105956;5805.680687562224;5823.359430462646;5387.81142660005;5480.6437581557075;5498.533361693275;5529.170624406291;5611.859703507445;2964.7479964202853;2965.087518550523;2973.4647763402795;2973.6134302540963;2978.8659510322086;5788.7684492620665;5834.241548598655;5876.823695289148;5908.172855800191;5960;5473.877855039707;5707.828765137053;5713.343130492194;5718.771249149988;5753.88492230153;5875.50058245054;5889.646621202742;5901.29184497863;5921.240012591949;5946.375630558729;5473.233747275305;5550.195221692913;5748.304250246104;5775.27809023872;5781.653100813965;5740.942590574041;5757.8560535986935;5776.56675749312;5792.420757924174;5808.796692115756;6068.787592434243;6113.5414843887775;6127.446081272762;6132.386761323832;6139.416755408408;4046.453728746699;4193.97903010483;4196.958030419657;4213.157368526368;4219.767912764827;5831.650100993954;5841.773227622247;5841.94158058431;5847.707614619167;5892.6759028253855;5491.835244942658;5711.058240198353;5723.284589426322;5727.971360143172;5736.598438109292;5672.971635141798;5673.432656734293;5679.432056794288;5679.659220446786;5680.744366503434;5621.887562248814;5624.156376543551;5638.661680299195;5649.237352957298;5671.546276297804;5462.371827239759;5513.338399392099;5546.972265138648;5621.128725047624;5655.547556195412;5525.336959564878;5527.613067085265;5565.610407271614;5574.219609254626;5576.804811831566 23:49:02 INFO - PROCESS | 18676 | |5;yui.html;729.8832186850102;760.1334478694289;760.422079219793;804.955727434991;826.6280173921737;15033.323500442479;15981.200939953014;16146.434874779385;16154.111523866197;16194.595135121628;13891.861081389208;14001.649958751037;14012;14042.859571404282;14433.855661443382;712.1169749510595;730.1274976403174;834.9540775257359;836.8368168207187;859.3898332184126;840.231188462556;850.086157380815;850.1583432401909;850.7958090058372;851.5444237333028;899.1413200393641;899.6266549382032;900.954952252388;901.0898992018076;901.1394118616738;749.306891125712;765.4221063097382;876.2376732242926;898.8292224477328;899.3434792601405;656.2354856592065;657.2605818454239;657.5692921136663;658.0195508692062;658.236445722959;14663.120212787268;14694;14694.55916322512;14694.926525367304;14718.92640536801;12989.805152922714;13213.471461141542;13420.194788312732;13527.256000919946;13560.254186019765;11743.882561174365;11868;11890.881091189063;12016.339101349422;12173.817392739116;4075.32757095079;4097.09863829957;4141.503019637633;4145.129522800185;4217.536071032184;70920.29079709189;71040.64479677568;72457.6377118111;73153.63423182956;74787;10172.28793984414;10258.43578603184;10264.076233139054;10312.742181445525;10354.844677329846;20596.382108536767;20741.79258207429;20901.268455603982;21142.15431382758;21160.365189044045;7701.730439434593;7817.140114587391;7835.059792824897;7899.368050555941;7979.162187970295;4208.22147902639;4311.073119279307;4344.891377715582;4384.408104905797;4493.73037617744;3252.349530093991;3334.9666503334656;3371.662833716609;3372.173817414749;3372.612149602778;542.5665888490119;547.3623228938322;557.2532806039926;559.2924949938331;560.8205374280191;665.6871270502855;683.2927919603187;689.689639662154;698.0785363320368;709.7303024850523;8153.8776918346275;8223.629936652866;8449.366297527587;8497.872531912026;8633.050364459905;553.8892221555625;593.7654626422539;640.8590110175754;678.8268991407159;689.762032098925;4190.916181676349;4250.511191212988;4256.423307036324;4311.547287534827;4480.103979204107;53828;54109.45890541123;54574;54785.72607136939;94789.5260523693;81429.59285203536;81857.59071204606;82167.17832821715;83472.58263708642;83948.58025709954;71547.28452715406;75607.62196188983;76035.61982190053;77452.61273693708;78552;8023.518588884685;8268;8386.832263354576;8455.567718180962;8518.446300990416;49078.75460622674;49458;49692.75153624209;50015;51460.74269628778;62299.688501559016;64316.78416079271;69827;70234.64882675554;72020.27979720346;10042.849357259502;10149.441780702133;10207.540660670436;10350.430726309824;10482.528286226985;11572.132090093108;11585.304881707125;11597.478113484745;11655.650330490098;11707.356095414834;10713.303635263683;10720.142388608736;10726.356418614909;10945.01494865466;10975.341479510935;10566.735831604272;10638.627648032281;10661.946690266499;11011.229213954946;11096.278741882075;10937.343759374464;10947.124230061416;11023.944880275547;11061.391623460466;11369.715757106138;9178.219851312713;9259.120383563552;9478.336516443782;9488.573014214238;9525.476098814632;9466.100720431548;9814.85277720849;9871.353904061854;9914.652987145415;9929.503524823875 23:49:02 INFO - PROCESS | 18676 | __end_tp_report 23:49:02 INFO - PROCESS | 18676 | __start_cc_report 23:49:02 INFO - PROCESS | 18676 | _x_x_mozilla_cycle_collect,1329 23:49:02 INFO - PROCESS | 18676 | __end_cc_report 23:49:02 INFO - PROCESS | 18676 | __startTimestamp1483084142541__endTimestamp 23:49:02 INFO - PROCESS | 18676 | 23:49:02 INFO - PROCESS | 18676 | ------- Summary: start ------- 23:49:02 INFO - PROCESS | 18676 | Number of tests: 6 23:49:02 INFO - PROCESS | 18676 | 23:49:02 INFO - PROCESS | 18676 | [#0] dojo.html Cycles:165 Average:5519.62 Median:5736.97 stddev:622.23 (10.8%) stddev-sans-first:596.78 23:49:02 INFO - PROCESS | 18676 | Values: 3193.8 3231.3 3233.1 3234.6 3277.3 5394.3 5446.4 5461.5 5470.8 5472.8 5470.4 5523.9 5556.3 5561.1 5562.0 4994.7 5031.7 5044.7 5119.0 5122.9 4923.6 5124.8 5170.8 5179.2 5191.7 4915.8 5021.7 5053.9 5061.8 5066.5 5080.1 5118.9 5123.2 5160.6 5188.9 5037.4 5108.5 5144.9 5166.1 5187.7 5402.1 5422.7 5441.7 5447.4 5479.2 5863.8 5936.9 5954.0 5954.8 5958.0 5981.8 5986.7 6003.0 6012.5 6016.4 5475.8 5482.9 5507.6 5516.0 5591.7 6019.1 6039.6 6039.9 6079.5 6080.7 5838.5 5845.4 5856.6 5863.5 5870.1 5743.5 5753.7 5927.9 5943.9 5944.7 5817.7 5861.6 5867.7 5952.5 5955.5 5847.2 5884.8 5886.0 5889.7 5894.4 4407.8 4568.3 4571.5 4576.3 4605.4 4004.6 4012.4 4054.2 4059.7 4116.2 5679.0 5683.1 5687.2 5689.8 5691.3 5931.1 5935.0 5945.1 5948.2 5950.7 5506.3 5567.3 5637.0 5690.0 5691.2 5162.0 5165.7 5166.2 5168.2 5168.8 6218.5 6282.2 6284.7 6285.3 6288.4 5807.2 5854.8 5865.1 5910.6 5934.6 6227.6 6236.5 6239.5 6242.8 6251.2 5864.9 5866.3 5868.4 5869.8 5907.8 5819.9 5822.6 5901.0 5973.3 5978.3 5791.9 5804.8 5859.2 5871.5 5887.8 5779.6 5785.5 5843.4 5847.8 5851.4 5471.9 5491.9 5712.6 5724.7 5729.7 5763.6 5823.5 5830.6 5859.4 5889.8 5726.9 5735.8 5737.0 5741.9 5766.8 23:49:02 INFO - PROCESS | 18676 | 23:49:02 INFO - PROCESS | 18676 | [#1] ext.html Cycles:180 Average:59982.20 Median:38069.12 stddev:115312.62 (302.9%) stddev-sans-first:115549.83 23:49:02 INFO - PROCESS | 18676 | Values: 571.0 604.0 611.9 624.3 653.8 33458.0 45589.3 46490.0 46600.0 46661.3 45544.4 45777.8 46185.8 46235.8 46303.8 8320.8 8507.1 8742.9 8910.7 8936.9 10389.2 10608.2 10611.2 10876.2 10887.3 10742.5 10800.8 10801.1 10803.8 10825.7 10598.2 10638.1 10647.1 10654.4 10671.2 10670.7 10733.5 10738.4 10743.8 10754.1 43668.0 43880.6 43938.0 43952.8 43983.6 3491.0 3617.3 3659.3 3666.3 3949.1 30620.8 30675.2 30984.2 31093.1 31689.4 4288.4 4362.3 4414.1 4422.7 4426.4 256270.7 256615.0 257231.0 257559.0 259350.0 63931.4 64181.4 64281.0 64359.4 64377.4 40998.6 67133.0 67328.7 67445.0 67581.0 17771.8 17819.0 17836.4 17994.6 18006.5 12659.4 12756.4 13402.3 13743.3 14019.6 20888.6 20950.9 21063.9 21120.0 21188.8 7272.4 7292.9 7569.6 7661.9 7676.2 989.7 1038.7 1041.0 1042.9 1082.1 33427.0 33945.8 34000.8 34044.7 34089.7 1114.4 1118.6 1177.8 1185.6 1253.7 16731.9 17846.9 17880.5 18044.0 18057.2 530034.0 532898.0 535192.0 535756.0 538367.0 61054.4 62302.4 62470.7 62537.7 62711.1 1314.0 1339.3 1344.9 1371.2 1430.1 27563.7 36601.8 37151.4 37256.6 37330.0 60061.0 60573.0 60712.0 60850.0 60869.4 461019.0 462711.0 463828.0 465734.0 466633.0 30485.4 31127.4 31230.0 31324.8 31414.7 49459.8 49665.8 49803.8 50496.2 51581.2 42639.0 42924.0 44074.0 44179.3 45431.8 42787.8 43117.0 43316.0 43544.0 43909.3 43149.8 43464.3 43897.8 44337.3 44506.0 35019.3 38050.8 38087.4 38425.8 38868.2 29118.7 29139.3 29322.6 29443.3 29680.9 23:49:02 INFO - PROCESS | 18676 | 23:49:02 INFO - PROCESS | 18676 | [#2] jquery.html Cycles:180 Average:29662.58 Median:2156.05 stddev:80537.07 (3735.4%) stddev-sans-first:80733.00 23:49:02 INFO - PROCESS | 18676 | Values: 386.8 405.2 422.7 423.1 431.9 14442.4 16220.4 19648.1 20207.3 20686.4 19470.7 20228.8 20270.8 20368.8 20460.0 5662.7 5719.0 5868.1 5906.0 5970.9 4306.4 4501.3 5854.3 5940.4 5941.7 4471.3 4472.3 6288.2 6529.2 6548.9 6521.1 6547.7 6590.7 6605.2 6626.4 5854.2 5857.4 5857.8 5860.0 5867.1 14707.8 16120.5 22286.8 22854.0 23005.2 2211.1 2274.7 2286.8 2381.5 2411.9 10256.2 10336.0 10438.6 10446.3 10589.5 1843.5 1843.7 1876.4 1878.5 1912.8 91179.5 91314.5 93611.0 94889.0 96194.0 11292.2 11334.1 11512.5 11568.5 11573.4 16182.4 16194.2 16250.8 16267.2 16273.2 8284.0 8312.9 8405.4 8489.7 8797.4 7926.2 8049.7 8052.4 8109.2 8127.1 4539.1 4626.5 4907.2 4920.7 4937.6 2031.9 2065.4 2083.8 2084.6 2100.9 908.1 908.8 972.8 1044.3 1104.8 19360.2 19548.0 19848.8 20072.8 20248.4 1038.3 1042.4 1053.2 1056.3 1076.0 10252.2 11115.3 11139.5 11167.9 11170.8 445248.0 463140.0 490890.0 510285.0 513038.0 95787.5 99772.5 100680.0 102717.5 103412.0 982.9 1000.9 1013.1 1022.9 1026.6 17395.0 17764.9 18075.6 18110.9 18438.8 43709.6 44229.6 44964.8 45318.0 45397.0 57748.0 62037.4 63258.7 63870.4 64186.7 8650.0 8706.0 9011.0 9120.7 9265.2 12502.7 12789.9 13009.2 13501.2 13525.9 11480.4 11509.8 11565.3 11684.5 11749.6 11451.0 11499.1 11599.4 11601.7 11674.6 11530.4 11746.7 11754.4 11901.7 12015.5 8630.5 8739.5 8825.2 9005.4 9087.5 10421.8 11334.3 11390.4 11682.6 11958.5 23:49:02 INFO - PROCESS | 18676 | 23:49:02 INFO - PROCESS | 18676 | [#3] mootools.html Cycles:180 Average:5320.94 Median:5167.96 stddev:2882.88 (55.8%) stddev-sans-first:2875.80 23:49:02 INFO - PROCESS | 18676 | Values: 1385.8 1441.7 1502.8 1724.4 1739.5 7805.2 8072.6 8083.9 8089.2 8107.7 6986.3 7163.1 7578.1 7756.0 7941.8 2298.4 2314.8 2316.0 2319.7 2328.0 2339.8 2387.9 2390.7 2395.0 2405.6 2354.4 2359.0 2368.8 2380.0 2380.5 2254.8 2258.8 2276.4 2276.6 2300.3 2267.0 2283.5 2285.2 2286.3 2286.4 7957.0 8006.1 8013.3 8015.2 8026.5 4984.0 5133.7 5134.2 5136.3 5138.5 3164.4 3222.1 3420.0 3424.8 3432.3 1119.3 1162.6 1169.2 1175.1 1182.1 10817.6 10915.2 10917.2 10917.9 10933.5 4399.7 4512.8 4581.4 4617.0 4724.0 9346.6 9347.2 9359.7 9360.8 9363.4 5165.9 5170.0 5176.1 5180.6 5181.9 4225.3 4241.5 4618.1 4686.6 4760.8 3873.7 3946.6 3993.8 4032.5 4046.8 1354.6 1356.3 1360.6 1372.9 1373.4 791.9 926.3 936.4 937.4 964.7 5217.6 5420.2 5443.2 5533.8 5562.7 465.4 470.4 482.8 488.2 498.5 3708.1 3711.8 3752.1 3753.8 3797.1 9182.0 9743.3 9748.0 9759.4 9766.8 9542.1 9679.5 9702.8 9751.6 9761.8 7588.8 7597.2 7668.5 7673.0 7714.5 5247.6 5271.1 5350.0 5383.1 5438.8 8985.1 8994.0 9086.0 9125.4 9144.4 8761.3 9074.7 9095.0 9124.5 9136.4 6437.4 6598.0 7017.0 7374.5 7520.2 7365.9 7641.9 7649.0 7649.2 7649.7 6798.2 6904.5 6968.6 6976.5 6989.2 6795.2 6947.5 7010.5 7033.4 7071.7 6269.1 6347.2 6363.2 6381.4 6411.4 4598.1 4658.3 4691.2 4717.4 4740.7 4800.3 4886.4 4897.9 4930.0 4978.9 23:49:02 INFO - PROCESS | 18676 | 23:49:02 INFO - PROCESS | 18676 | [#4] prototype.html Cycles:180 Average:4751.42 Median:5467.80 stddev:1392.47 (25.5%) stddev-sans-first:1356.51 23:49:02 INFO - PROCESS | 18676 | Values: 343.6 350.8 350.9 353.1 354.9 5373.6 5399.5 5402.2 5403.8 5444.7 5325.3 5340.9 5353.3 5361.3 5375.7 3986.9 4063.4 4192.6 4215.2 4235.7 4144.8 4188.9 4227.2 4227.7 4247.6 4145.3 4187.3 4190.8 4198.7 4201.5 3985.3 4061.7 4190.9 4212.9 4236.9 3741.6 3745.2 3750.8 3756.5 3771.4 5182.2 5195.2 5197.4 5200.0 5246.6 4533.4 4694.9 4778.4 4780.9 4839.0 5548.3 5582.3 5583.2 5593.4 5628.9 4062.1 4080.5 4084.6 4087.7 4105.9 5608.6 5783.5 5813.7 5834.5 5876.3 4153.9 4170.4 4185.4 4193.6 4212.2 4247.4 4256.9 4259.7 4267.6 4277.0 4760.4 4764.7 4810.2 4815.9 4832.4 5634.9 5635.5 5639.4 5645.7 5655.5 1405.4 1420.8 1423.7 1425.0 1433.7 973.3 991.8 993.9 998.4 1012.8 5265.7 5404.2 5426.5 5536.4 5559.4 5684.7 5791.2 5800.8 5805.7 5823.4 5387.8 5480.6 5498.5 5529.2 5611.9 2964.7 2965.1 2973.5 2973.6 2978.9 5788.8 5834.2 5876.8 5908.2 5960.0 5473.9 5707.8 5713.3 5718.8 5753.9 5875.5 5889.6 5901.3 5921.2 5946.4 5473.2 5550.2 5748.3 5775.3 5781.7 5740.9 5757.9 5776.6 5792.4 5808.8 6068.8 6113.5 6127.4 6132.4 6139.4 4046.5 4194.0 4197.0 4213.2 4219.8 5831.7 5841.8 5841.9 5847.7 5892.7 5491.8 5711.1 5723.3 5728.0 5736.6 5673.0 5673.4 5679.4 5679.7 5680.7 5621.9 5624.2 5638.7 5649.2 5671.5 5462.4 5513.3 5547.0 5621.1 5655.5 5525.3 5527.6 5565.6 5574.2 5576.8 23:49:02 INFO - PROCESS | 18676 | 23:49:02 INFO - PROCESS | 18676 | [#5] yui.html Cycles:180 Average:17589.78 Median:27669.81 stddev:23947.84 (86.5%) stddev-sans-first:23981.55 23:49:02 INFO - PROCESS | 18676 | Values: 729.9 760.1 760.4 805.0 826.6 15033.3 15981.2 16146.4 16154.1 16194.6 13891.9 14001.6 14012.0 14042.9 14433.9 712.1 730.1 835.0 836.8 859.4 840.2 850.1 850.2 850.8 851.5 899.1 899.6 901.0 901.1 901.1 749.3 765.4 876.2 898.8 899.3 656.2 657.3 657.6 658.0 658.2 14663.1 14694.0 14694.6 14694.9 14718.9 12989.8 13213.5 13420.2 13527.3 13560.3 11743.9 11868.0 11890.9 12016.3 12173.8 4075.3 4097.1 4141.5 4145.1 4217.5 70920.3 71040.6 72457.6 73153.6 74787.0 10172.3 10258.4 10264.1 10312.7 10354.8 20596.4 20741.8 20901.3 21142.2 21160.4 7701.7 7817.1 7835.1 7899.4 7979.2 4208.2 4311.1 4344.9 4384.4 4493.7 3252.3 3335.0 3371.7 3372.2 3372.6 542.6 547.4 557.3 559.3 560.8 665.7 683.3 689.7 698.1 709.7 8153.9 8223.6 8449.4 8497.9 8633.1 553.9 593.8 640.9 678.8 689.8 4190.9 4250.5 4256.4 4311.5 4480.1 53828.0 54109.5 54574.0 54785.7 94789.5 81429.6 81857.6 82167.2 83472.6 83948.6 71547.3 75607.6 76035.6 77452.6 78552.0 8023.5 8268.0 8386.8 8455.6 8518.4 49078.8 49458.0 49692.8 50015.0 51460.7 62299.7 64316.8 69827.0 70234.6 72020.3 10042.8 10149.4 10207.5 10350.4 10482.5 11572.1 11585.3 11597.5 11655.7 11707.4 10713.3 10720.1 10726.4 10945.0 10975.3 10566.7 10638.6 10661.9 11011.2 11096.3 10937.3 10947.1 11023.9 11061.4 11369.7 9178.2 9259.1 9478.3 9488.6 9525.5 9466.1 9814.9 9871.4 9914.7 9929.5 23:49:02 INFO - PROCESS | 18676 | -------- Summary: end -------- 23:49:02 INFO - PROCESS | 18676 | 23:49:03 INFO - TEST-INFO | 18676: exit 0 23:49:03 INFO - TEST-OK | dromaeo_css | took 1115689ms 23:49:03 INFO - TEST-START | kraken 23:49:03 INFO - operating with platform_type : linux_ 23:49:03 INFO - Initialising browser for kraken test... 23:49:03 INFO - TEST-INFO | started process 18993 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTvtbuv/profile http://localhost:45731/getInfo.html) 23:49:07 INFO - PROCESS | 18993 | __metrics Screen width/height:1600/1200 23:49:07 INFO - PROCESS | 18993 | colorDepth:24 23:49:07 INFO - PROCESS | 18993 | Browser inner width/height: 1024/697 23:49:07 INFO - PROCESS | 18993 | __metrics 23:49:08 INFO - PROCESS | 18993 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 23:49:08 INFO - PROCESS | 18993 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:49:08 INFO - PROCESS | 18993 | console.error: PushService: 23:49:08 INFO - PROCESS | 18993 | stateChangeProcessEnqueue: Error transitioning state 23:49:08 INFO - PROCESS | 18993 | UnknownError 23:49:09 INFO - TEST-INFO | 18993: exit 0 23:49:09 INFO - Browser initialized. 23:49:09 INFO - Running cycle 1/1 for kraken test... 23:49:09 INFO - TEST-INFO | started process 19087 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTvtbuv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:49:21 INFO - PROCESS | 19087 | RSS: Main: 144510976 23:49:21 INFO - PROCESS | 19087 | 23:49:23 INFO - PROCESS | 19087 | Cycle 1(1): loaded http://localhost:45731/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45731/tests/kraken/driver.html?testName=audio-beat-detection) 23:49:24 INFO - PROCESS | 19087 | RSS: Main: 186372096 23:49:24 INFO - PROCESS | 19087 | 23:49:27 INFO - PROCESS | 19087 | Cycle 1(1): loaded http://localhost:45731/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45731/tests/kraken/driver.html?testName=audio-dft) 23:49:27 INFO - PROCESS | 19087 | RSS: Main: 175550464 23:49:27 INFO - PROCESS | 19087 | 23:49:30 INFO - PROCESS | 19087 | Cycle 1(1): loaded http://localhost:45731/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45731/tests/kraken/driver.html?testName=audio-fft) 23:49:31 INFO - PROCESS | 19087 | RSS: Main: 266985472 23:49:31 INFO - PROCESS | 19087 | 23:49:33 INFO - PROCESS | 19087 | Cycle 1(1): loaded http://localhost:45731/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45731/tests/kraken/driver.html?testName=audio-oscillator) 23:49:33 INFO - PROCESS | 19087 | RSS: Main: 173142016 23:49:33 INFO - PROCESS | 19087 | 23:49:35 INFO - PROCESS | 19087 | Cycle 1(1): loaded http://localhost:45731/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45731/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:49:36 INFO - PROCESS | 19087 | RSS: Main: 175747072 23:49:36 INFO - PROCESS | 19087 | 23:49:39 INFO - PROCESS | 19087 | Cycle 1(1): loaded http://localhost:45731/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45731/tests/kraken/driver.html?testName=imaging-darkroom) 23:49:40 INFO - PROCESS | 19087 | RSS: Main: 214220800 23:49:40 INFO - PROCESS | 19087 | 23:49:43 INFO - PROCESS | 19087 | Cycle 1(1): loaded http://localhost:45731/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45731/tests/kraken/driver.html?testName=imaging-desaturate) 23:49:43 INFO - PROCESS | 19087 | RSS: Main: 212639744 23:49:43 INFO - PROCESS | 19087 | 23:49:46 INFO - PROCESS | 19087 | Cycle 1(1): loaded http://localhost:45731/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45731/tests/kraken/driver.html?testName=json-parse-financial) 23:49:47 INFO - PROCESS | 19087 | RSS: Main: 211169280 23:49:47 INFO - PROCESS | 19087 | 23:49:48 INFO - PROCESS | 19087 | Cycle 1(1): loaded http://localhost:45731/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45731/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:49:49 INFO - PROCESS | 19087 | RSS: Main: 173932544 23:49:49 INFO - PROCESS | 19087 | 23:49:50 INFO - PROCESS | 19087 | Cycle 1(1): loaded http://localhost:45731/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45731/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:49:51 INFO - PROCESS | 19087 | RSS: Main: 180871168 23:49:51 INFO - PROCESS | 19087 | 23:49:53 INFO - PROCESS | 19087 | Cycle 1(1): loaded http://localhost:45731/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45731/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:49:54 INFO - PROCESS | 19087 | RSS: Main: 190046208 23:49:54 INFO - PROCESS | 19087 | 23:49:56 INFO - PROCESS | 19087 | Cycle 1(1): loaded http://localhost:45731/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45731/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:49:57 INFO - PROCESS | 19087 | RSS: Main: 198475776 23:49:57 INFO - PROCESS | 19087 | 23:50:00 INFO - PROCESS | 19087 | Cycle 1(1): loaded http://localhost:45731/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45731/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:50:00 INFO - PROCESS | 19087 | RSS: Main: 195227648 23:50:00 INFO - PROCESS | 19087 | 23:50:02 INFO - PROCESS | 19087 | Cycle 1(1): loaded http://localhost:45731/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45731/tests/kraken/driver.html?testName=ai-astar) 23:50:02 INFO - PROCESS | 19087 | RSS: Main: 247427072 23:50:02 INFO - PROCESS | 19087 | 23:50:02 INFO - PROCESS | 19087 | __start_tp_report 23:50:02 INFO - PROCESS | 19087 | _x_x_mozilla_page_load 23:50:02 INFO - PROCESS | 19087 | _x_x_mozilla_page_load_details 23:50:02 INFO - PROCESS | 19087 | |i|pagename|runs| 23:50:02 INFO - PROCESS | 19087 | |0;ai-astar;102;111;111;112;111;110;110;113;110;111 23:50:02 INFO - PROCESS | 19087 | |1;audio-beat-detection;141;118;120;164;119;120;118;122;170;121 23:50:02 INFO - PROCESS | 19087 | |2;audio-dft;159;159;160;159;159;160;161;159;160;159 23:50:02 INFO - PROCESS | 19087 | |3;audio-fft;76;75;84;106;75;76;75;76;109;75 23:50:02 INFO - PROCESS | 19087 | |4;audio-oscillator;82;82;114;82;82;82;113;89;82;113 23:50:02 INFO - PROCESS | 19087 | |5;imaging-gaussian-blur;118;117;118;117;117;117;117;117;116;117 23:50:02 INFO - PROCESS | 19087 | |6;imaging-darkroom;145;146;146;145;146;146;146;146;146;147 23:50:02 INFO - PROCESS | 19087 | |7;imaging-desaturate;86;85;85;85;84;84;85;85;84;84 23:50:02 INFO - PROCESS | 19087 | |8;json-parse-financial;52;53;52;52;52;52;51;53;51;51 23:50:02 INFO - PROCESS | 19087 | |9;json-stringify-tinderbox;60;59;59;59;59;60;60;60;59;59 23:50:02 INFO - PROCESS | 19087 | |10;stanford-crypto-aes;75;74;78;81;76;77;74;74;77;74 23:50:02 INFO - PROCESS | 19087 | |11;stanford-crypto-ccm;123;124;131;128;134;120;120;119;162;120 23:50:02 INFO - PROCESS | 19087 | |12;stanford-crypto-pbkdf2;153;153;153;152;153;152;155;156;154;155 23:50:02 INFO - PROCESS | 19087 | |13;stanford-crypto-sha256-iterative;62;62;63;62;62;63;61;64;62;60 23:50:02 INFO - PROCESS | 19087 | __end_tp_report 23:50:02 INFO - PROCESS | 19087 | __start_cc_report 23:50:02 INFO - PROCESS | 19087 | _x_x_mozilla_cycle_collect,1658 23:50:02 INFO - PROCESS | 19087 | __end_cc_report 23:50:02 INFO - PROCESS | 19087 | __startTimestamp1483084202518__endTimestamp 23:50:02 INFO - PROCESS | 19087 | 23:50:02 INFO - PROCESS | 19087 | ------- Summary: start ------- 23:50:02 INFO - PROCESS | 19087 | Number of tests: 14 23:50:02 INFO - PROCESS | 19087 | 23:50:02 INFO - PROCESS | 19087 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:3.00 (2.7%) stddev-sans-first:1.00 23:50:02 INFO - PROCESS | 19087 | Values: 102.0 111.0 111.0 112.0 111.0 110.0 110.0 113.0 110.0 111.0 23:50:02 INFO - PROCESS | 19087 | 23:50:02 INFO - PROCESS | 19087 | [#1] audio-beat-detection Cycles:10 Average:131.30 Median:121.50 stddev:20.04 (16.5%) stddev-sans-first:20.95 23:50:02 INFO - PROCESS | 19087 | Values: 141.0 118.0 120.0 164.0 119.0 120.0 118.0 122.0 170.0 121.0 23:50:02 INFO - PROCESS | 19087 | 23:50:02 INFO - PROCESS | 19087 | [#2] audio-dft Cycles:10 Average:159.50 Median:159.50 stddev:0.71 (0.4%) stddev-sans-first:0.73 23:50:02 INFO - PROCESS | 19087 | Values: 159.0 159.0 160.0 159.0 159.0 160.0 161.0 159.0 160.0 159.0 23:50:02 INFO - PROCESS | 19087 | 23:50:02 INFO - PROCESS | 19087 | [#3] audio-fft Cycles:10 Average:82.70 Median:75.50 stddev:13.37 (17.7%) stddev-sans-first:13.96 23:50:02 INFO - PROCESS | 19087 | Values: 76.0 75.0 84.0 106.0 75.0 76.0 75.0 76.0 109.0 75.0 23:50:02 INFO - PROCESS | 19087 | 23:50:02 INFO - PROCESS | 19087 | [#4] audio-oscillator Cycles:10 Average:92.10 Median:82.00 stddev:14.81 (18.1%) stddev-sans-first:15.25 23:50:02 INFO - PROCESS | 19087 | Values: 82.0 82.0 114.0 82.0 82.0 82.0 113.0 89.0 82.0 113.0 23:50:02 INFO - PROCESS | 19087 | 23:50:02 INFO - PROCESS | 19087 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 23:50:02 INFO - PROCESS | 19087 | Values: 118.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 116.0 117.0 23:50:02 INFO - PROCESS | 19087 | 23:50:02 INFO - PROCESS | 19087 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 23:50:02 INFO - PROCESS | 19087 | Values: 145.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 147.0 23:50:02 INFO - PROCESS | 19087 | 23:50:02 INFO - PROCESS | 19087 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.67 (0.8%) stddev-sans-first:0.53 23:50:02 INFO - PROCESS | 19087 | Values: 86.0 85.0 85.0 85.0 84.0 84.0 85.0 85.0 84.0 84.0 23:50:02 INFO - PROCESS | 19087 | 23:50:02 INFO - PROCESS | 19087 | [#8] json-parse-financial Cycles:10 Average:51.90 Median:52.00 stddev:0.74 (1.4%) stddev-sans-first:0.78 23:50:02 INFO - PROCESS | 19087 | Values: 52.0 53.0 52.0 52.0 52.0 52.0 51.0 53.0 51.0 51.0 23:50:02 INFO - PROCESS | 19087 | 23:50:02 INFO - PROCESS | 19087 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:0.52 (0.9%) stddev-sans-first:0.50 23:50:02 INFO - PROCESS | 19087 | Values: 60.0 59.0 59.0 59.0 59.0 60.0 60.0 60.0 59.0 59.0 23:50:02 INFO - PROCESS | 19087 | 23:50:02 INFO - PROCESS | 19087 | [#10] stanford-crypto-aes Cycles:10 Average:76.00 Median:76.50 stddev:2.31 (3.0%) stddev-sans-first:2.42 23:50:02 INFO - PROCESS | 19087 | Values: 75.0 74.0 78.0 81.0 76.0 77.0 74.0 74.0 77.0 74.0 23:50:02 INFO - PROCESS | 19087 | 23:50:02 INFO - PROCESS | 19087 | [#11] stanford-crypto-ccm Cycles:10 Average:128.10 Median:126.00 stddev:12.97 (10.3%) stddev-sans-first:13.63 23:50:02 INFO - PROCESS | 19087 | Values: 123.0 124.0 131.0 128.0 134.0 120.0 120.0 119.0 162.0 120.0 23:50:02 INFO - PROCESS | 19087 | 23:50:02 INFO - PROCESS | 19087 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.60 Median:153.50 stddev:1.35 (0.9%) stddev-sans-first:1.41 23:50:02 INFO - PROCESS | 19087 | Values: 153.0 153.0 153.0 152.0 153.0 152.0 155.0 156.0 154.0 155.0 23:50:02 INFO - PROCESS | 19087 | 23:50:02 INFO - PROCESS | 19087 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.00 stddev:1.10 (1.8%) stddev-sans-first:1.17 23:50:02 INFO - PROCESS | 19087 | Values: 62.0 62.0 63.0 62.0 62.0 63.0 61.0 64.0 62.0 60.0 23:50:02 INFO - PROCESS | 19087 | -------- Summary: end -------- 23:50:02 INFO - PROCESS | 19087 | 23:50:03 INFO - TEST-INFO | 19087: exit 0 23:50:03 INFO - TEST-OK | kraken | took 60252ms 23:50:03 INFO - SUITE-END | took 1175s 23:50:03 INFO - Completed test suite (00:19:36) 23:50:03 INFO - javascript benchmark 23:50:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3193.80837149771, 3231.2729635831924, 3233.1432170474827, 3234.5956755405573, 3277.3281477297155, 5394.2717733106065, 5446.373667028293, 5461.453854614537, 5470.753816078276, 5472.808451704191, 5470.398256191816, 5523.867607140536, 5556.333240011194, 5561.082421400474, 5561.972190139054, 4994.67534610251, 5031.748412579356, 5044.672096313728, 5119.0, 5122.948770512285, 4923.58149557288, 5124.820631277906, 5170.767315470813, 5179.197224430201, 5191.662541934781, 4915.778789954443, 5021.748912554358, 5053.873653158664, 5061.848144555669, 5066.544011039005, 5080.085584594772, 5118.897622047538, 5123.20590308501, 5160.56135228506, 5188.92216616751, 5037.395512538482, 5108.463611320795, 5144.922826157611, 5166.07010738067, 5187.662801917901, 5402.108652072403, 5422.728863556846, 5441.700706461143, 5447.373552041527, 5479.150731636602, 5863.794767183128, 5936.851578710523, 5954.047352423635, 5954.791582294599, 5958.046712526018, 5981.820545383645, 5986.73059712314, 6002.96998515009, 6012.488938440238, 6016.368281330485, 5475.780968761244, 5482.945170548323, 5507.5593952483705, 5515.972420137914, 5591.7483713233005, 6019.097135429721, 6039.63762174271, 6039.909401358983, 6079.513638908877, 6080.69596520181, 5838.503727183237, 5845.444682755132, 5856.560757943086, 5863.472287494146, 5870.148828419855, 5743.511801496919, 5753.712314384264, 5927.881442371128, 5943.940560594425, 5944.6730429826775, 5817.738201780845, 5861.5603829712945, 5867.735951882176, 5952.523798096142, 5955.464008239279, 5847.181394604759, 5884.764609415661, 5885.970570147122, 5889.676067816311, 5894.38108998549, 4407.845725399596, 4568.33759104928, 4571.519990401027, 4576.336431217454, 4605.355250264965, 4004.6395824375945, 4012.378081397388, 4054.2296963576828, 4059.6955228357992, 4116.217918595457, 5679.0, 5683.119116536944, 5687.203791469197, 5689.829305120853, 5691.345495268097, 5931.051031834886, 5935.0, 5945.108233764883, 5948.196993405922, 5950.67271300074, 5506.256655351476, 5567.3040869891265, 5636.971815140898, 5690.0, 5691.203231547586, 5161.974190129101, 5165.664231824994, 5166.225066240094, 5168.173092305213, 5168.767405466763, 6218.471429928416, 6282.246130464374, 6284.685765711604, 6285.277193122758, 6288.371162883766, 5807.186993820784, 5854.824355269348, 5865.149553314831, 5910.586258961831, 5934.584579079596, 6227.595206311576, 6236.532260080421, 6239.500839932885, 6242.750289988531, 6251.218597675291, 5864.9413505866105, 5866.266716660418, 5868.38381969887, 5869.7945571904775, 5907.763689452374, 5819.883602328015, 5822.621529600562, 5900.970495147497, 5973.283206015132, 5978.252718410199, 5791.942080579141, 5804.82585522435, 5859.20900678403, 5871.530277577698, 5887.793927212527, 5779.566532509994, 5785.508231800176, 5843.386444423274, 5847.795327163529, 5851.414858514115, 5471.890562188654, 5491.890162196653, 5712.6286791358425, 5724.713764311685, 5729.742161602821, 5763.5965482417505, 5823.534117270524, 5830.591858569859, 5859.355470898283, 5889.823305300848, 5726.8568285791525, 5735.827925162252, 5736.971315143398, 5741.885162296647, 5766.826995190151], "value": 5477.996572965521, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.9514691251244, 603.9728212230449, 611.8776244751051, 624.2976651267321, 653.7646447278976, 33458.0, 45589.31616025758, 46490.0, 46600.0, 46661.30008049882, 45544.35645148389, 45777.7711111444, 46185.769071154595, 46235.76882115585, 46303.768481157545, 8320.791980200513, 8507.106753790855, 8742.868856967134, 8910.688125915594, 8936.865947010767, 10389.1688664907, 10608.204384671142, 10611.204159688015, 10876.184286178528, 10887.292325998824, 10742.462876856125, 10800.78398432031, 10801.081908037788, 10803.78392432151, 10825.67522974312, 10598.152147828156, 10638.148948084136, 10647.14822814173, 10654.360738355685, 10671.19966002553, 10670.733231669194, 10733.463326833706, 10738.409387483685, 10743.785124297548, 10754.139668826476, 43668.0, 43880.56119438797, 43938.0, 43952.78023609894, 43983.56016439859, 3490.965090349089, 3617.276544691072, 3659.2681463707363, 3666.2667466506537, 3949.0917089069676, 30620.8468957656, 30675.2331191722, 30984.225394365098, 31093.067207983797, 31689.366212675846, 4288.421063156465, 4362.322312729587, 4414.139242847646, 4422.690411671184, 4426.449401361233, 256270.71864640745, 256615.0, 257231.0, 257559.0, 259350.0, 63931.36068639347, 64181.358186417536, 64281.0, 64359.356406435334, 64377.356226438074, 40998.590014100075, 67133.0, 67328.6633566829, 67445.0, 67581.0, 17771.822281777277, 17819.0, 17836.3757268495, 17994.64010719778, 18006.5498362542, 12659.430325635369, 12756.362181890869, 13402.329883505785, 13743.312834358243, 14019.579412617637, 20888.58222835565, 20950.89524552398, 21063.8946805265, 21120.04959776814, 21188.78811211868, 7272.418206543463, 7292.927070729224, 7569.633643703291, 7661.923380766232, 7676.200280860898, 989.7129832348683, 1038.6728180623231, 1040.953157107932, 1042.9426381548935, 1082.1451053667515, 33427.0, 33945.830270848484, 34000.829995850356, 34044.65955340464, 34089.65910340915, 1114.4483480676954, 1118.645251745065, 1177.7585594953014, 1185.5850452341783, 1253.7053792358788, 16731.91634041822, 17846.910765446348, 17880.46358609244, 18044.0, 18057.187426565837, 530034.0, 532898.0, 535192.0, 535756.0, 538367.0, 61054.38945610487, 62302.37697622966, 62470.68764656239, 62537.68731156315, 62711.059334110025, 1313.9934300328437, 1339.3035621476777, 1344.8722371374508, 1371.245814801855, 1430.1490613085198, 27563.724362756115, 36601.81699091488, 37151.442728358554, 37256.62743372531, 37330.0, 60061.0, 60573.0, 60712.0, 60850.0, 60869.39130608637, 461019.0, 462711.0, 463828.0, 465734.0, 466633.0, 30485.390292193588, 31127.377452451277, 31230.0, 31324.843375782973, 31414.685853141174, 49459.75270123626, 49665.751671241414, 49803.75098124486, 50496.24255636242, 51581.226281606556, 42639.0, 42924.0, 44074.0, 44179.337309939736, 45431.772841135586, 42787.7860610695, 43117.0, 43316.0, 43544.0, 43909.341359880265, 43149.78425107854, 43464.34803478014, 43897.78051109724, 44337.33493997657, 44506.0, 35019.29961400809, 38050.80974595109, 38087.42868856914, 38425.80787096047, 38868.22263554657, 29118.7088129116, 29139.271518211368, 29322.56016159717, 29443.263918402212, 29680.851595742748], "value": 21203.2925257406, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.77567011133544, 405.2179293962651, 422.666093785909, 423.0861339506665, 431.94600674915637, 14442.350094245758, 16220.432284870032, 19648.115834787415, 20207.292744753937, 20686.37940861773, 19470.707939380885, 20228.797712022875, 20270.797292027077, 20368.796312036877, 20460.0, 5662.6602403855695, 5719.0, 5868.119782032708, 5905.970470147665, 5970.940290597082, 4306.35404689296, 4501.257292546742, 5854.326752423462, 5940.405959404068, 5941.732622032019, 4471.284594464886, 4472.262076757331, 6288.182536270278, 6529.1512103426485, 6548.9345106549035, 6521.054447105167, 6547.6726163691865, 6590.703418346186, 6605.174353205849, 6626.403623673868, 5854.18041474194, 5857.4435428634215, 5857.7949771757785, 5860.033094539396, 5867.061270196791, 14707.779383309258, 16120.516384508366, 22286.77713222863, 22854.0, 23005.194818181284, 2211.1487077475126, 2274.715660542432, 2286.8284878634004, 2381.46417056161, 2411.9155829546057, 10256.179505639531, 10336.0, 10438.582456701723, 10446.26876118672, 10589.470526473722, 1843.5298998755231, 1843.7142242952364, 1876.352658332873, 1878.5209771508314, 1912.7895931447529, 91179.54410227973, 91314.5434272831, 93611.0, 94889.0, 96194.0, 11292.15308851823, 11334.093272538343, 11512.539498420138, 11568.479418426192, 11573.42132893352, 16182.433614823425, 16194.190290485663, 16250.837491625169, 16267.18664066792, 16273.186340682918, 8284.047334556482, 8312.8753068704, 8405.411621186458, 8489.702860399857, 8797.38418310712, 7926.167752386032, 8049.718259860877, 8052.396070294634, 8109.229623185788, 8127.1466496017065, 4539.137563862855, 4626.467956185014, 4907.2393778964315, 4920.704757714477, 4937.604991600663, 2031.89840507974, 2065.4113577630606, 2083.7603675577197, 2084.6143463459307, 2100.947476313074, 908.100980029779, 908.7591788176138, 972.8248915195192, 1044.3316277582353, 1104.7790441911488, 19360.225590976203, 19548.0, 19848.801511984697, 20072.799272007094, 20248.392548223575, 1038.3043360948184, 1042.4266653340633, 1053.1574740207802, 1056.265895202842, 1076.0261962923566, 10252.179825614083, 11115.277506962022, 11139.498722557342, 11167.944160279147, 11170.832437513443, 445248.0, 463140.0, 490890.0, 510285.0, 513038.0, 95787.52106239424, 99772.50113749385, 100680.0, 102717.48641256895, 103412.0, 982.9311948163703, 1000.8949060348705, 1013.0882206014646, 1022.9488525573692, 1026.573971801694, 17395.0, 17764.91117544456, 18075.638487230444, 18110.90944545269, 18438.81561184371, 43709.56290437055, 44229.55770442254, 44964.77517612391, 45318.0, 45397.0, 57748.0, 62037.379626204965, 63258.68370658117, 63870.36129638644, 64186.67906660437, 8650.0, 8705.956470217609, 9011.0, 9120.680776172801, 9265.212456940966, 12502.687432814253, 12789.872101278868, 13009.154404963647, 13501.189928604315, 13525.932370338085, 11480.368579727861, 11509.769804604028, 11565.306081635128, 11684.474198660911, 11749.647510574696, 11451.0, 11499.080073593925, 11599.362035088152, 11601.651950441501, 11674.591389301333, 11530.365829879438, 11746.70633234176, 11754.353510556659, 11901.702457438287, 12015.519379225083, 8630.525321107149, 8739.519326436852, 8825.161609647073, 9005.36962412651, 9087.500187489752, 10421.791564168825, 11334.319940803578, 11390.430478475877, 11682.649520514398, 11958.461869215733], "value": 9409.551920475693, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1385.8129152564404, 1441.7116576684664, 1502.7896094546766, 1724.3878423159786, 1739.512936377814, 7805.219478052192, 8072.55600941948, 8083.91916080839, 8089.23152300532, 8107.6756929722815, 6986.3362980516895, 7163.068801055855, 7578.128515220751, 7756.0, 7941.801454963629, 2298.402415372007, 2314.826388020897, 2315.9652605210936, 2319.744828068911, 2328.0338659456306, 2339.7660233976635, 2387.940301492468, 2390.725066617344, 2394.95819318597, 2405.579023670851, 2354.364321633158, 2359.0210062823908, 2368.834181607288, 2380.0, 2380.5238952209543, 2254.842161048727, 2258.8192944564394, 2276.362618466832, 2276.635738281875, 2300.332903457995, 2267.036509483479, 2283.5318759654233, 2285.223024171773, 2286.3483907086566, 2286.4283929017747, 7957.0, 8006.079300880415, 8013.318867896178, 8015.158408367096, 8026.518408895485, 4983.975080124576, 5133.717645529495, 5134.17853143499, 5136.255242989783, 5138.46046165151, 3164.4145833020966, 3222.130024893289, 3419.9829000855084, 3424.8423493199375, 3432.2792213634916, 1119.306030261235, 1162.5582278734028, 1169.1990986174499, 1175.1186610042469, 1182.148852825964, 10817.567297308098, 10915.181361397927, 10917.23579349446, 10917.890821091767, 10933.453327333682, 4399.73601583906, 4512.75179865104, 4581.427321584802, 4617.0, 4724.0, 9346.626134954662, 9347.2054875335, 9359.672411465703, 9360.812783744286, 9363.438193708263, 5165.870853228625, 5170.043541944752, 5176.120059589879, 5180.637355385163, 5181.948180518222, 4225.345071513921, 4241.4698162729655, 4618.145643056046, 4686.6485013624115, 4760.833370832004, 3873.670737987303, 3946.625070618287, 3993.7803420812133, 4032.4556184915245, 4046.838126474967, 1354.613935028512, 1356.3489525028042, 1360.6122255157431, 1372.8695773901463, 1373.3819781098346, 791.9485233459807, 926.3006430145198, 936.4053825820653, 937.3906960475746, 964.7491652170486, 5217.6086793489885, 5420.24116623673, 5443.156310771837, 5533.833984980457, 5562.666240025531, 465.37174814001503, 470.35796138271695, 482.7610332885244, 488.18473149839855, 498.5214194373442, 3708.128589781399, 3711.814409279525, 3752.1370084880086, 3753.8123093845197, 3797.0697179191275, 9182.0, 9743.317967742332, 9747.951260243653, 9759.414435133773, 9766.755831104138, 9542.093501117382, 9679.467629280458, 9702.75743106414, 9751.561179746928, 9761.755956101013, 7588.780762465668, 7597.202293759186, 7668.501547399401, 7673.0, 7714.459987800912, 5247.55395791362, 5271.077561426659, 5349.97325013388, 5383.057964856056, 5438.8368348948015, 8985.101489850962, 8993.965693945018, 9085.954570227106, 9125.406848554823, 9144.3598948073, 8761.25529330014, 9074.682386116454, 9095.0, 9124.49815260167, 9136.360454768368, 6437.420632143129, 6598.04328372393, 7016.964915175391, 7374.483786134919, 7520.172780994196, 7365.8526829462035, 7641.885371719318, 7648.961755191189, 7649.196834332315, 7649.732259370895, 6798.150231221098, 6904.516683832084, 6968.616726080114, 6976.5465244758925, 6989.231184569795, 6795.150606174228, 6947.548409353376, 7010.47421443404, 7033.366996970297, 7071.71713131469, 6269.059641053878, 6347.174867267226, 6363.172787537591, 6381.361863813581, 6411.358864113738, 4598.057398233287, 4658.254679251304, 4691.249400095969, 4717.386739723814, 4740.691855029412, 4800.3279540865005, 4886.438059623189, 4897.877553061202, 4929.950700493093, 4978.8755281118265], "value": 4296.348160245324, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.6237320134453, 350.77725644215917, 350.93156834417283, 353.05029470723736, 354.9059499232704, 5373.623846330758, 5399.48704873037, 5402.217268301466, 5403.8108666196695, 5444.700541470217, 5325.281087053247, 5340.946590534093, 5353.250544923704, 5361.329833770778, 5375.650582712121, 3986.900327491807, 4063.3701776224657, 4192.622663960243, 4215.241256573816, 4235.703500754948, 4144.772037537934, 4188.937165942513, 4227.239096962546, 4227.746335219881, 4247.63895068918, 4145.336746120622, 4187.28816101262, 4190.832366705344, 4198.748075115487, 4201.537830838605, 3985.3224951758125, 4061.6953728470335, 4190.853320133811, 4212.85255016073, 4236.872893813191, 3741.5594995926763, 3745.213505163919, 3750.8124593770203, 3756.455313979485, 3771.41543060826, 5182.170058683981, 5195.1687729963405, 5197.350331208599, 5199.974000129975, 5246.554042906358, 4533.365328853963, 4694.929576056362, 4778.351468743278, 4780.856574302777, 4838.975805120987, 5548.334199896039, 5582.274304340451, 5583.162525621189, 5593.3847276799515, 5628.887422251532, 4062.106336605942, 4080.5307389650275, 4084.5711200323835, 4087.6729861611, 4105.876823695294, 5608.6073974821775, 5783.479486846162, 5813.738381772788, 5834.474897259224, 5876.265466816648, 4153.91692166155, 4170.436991006236, 4185.351270553069, 4193.622573968358, 4212.220739163204, 4247.3628955656895, 4256.87229383119, 4259.742336561627, 4267.615914567704, 4276.957230427718, 4760.428748550196, 4764.714117152982, 4810.230363141881, 4815.903681926342, 4832.420109586872, 5634.85912852182, 5635.520980716603, 5639.379668236491, 5645.717714114277, 5655.5475561954945, 1405.4237762517319, 1420.8081908942368, 1423.7152569486145, 1424.9928750356182, 1433.6989232261342, 973.2651847854966, 991.8115558044093, 993.8658281132099, 998.3610489286863, 1012.7518757904213, 5265.7103859287345, 5404.189371594213, 5426.484483974016, 5536.4186760389575, 5559.416261292587, 5684.7157642118555, 5791.160281759121, 5800.796972105956, 5805.680687562224, 5823.359430462646, 5387.81142660005, 5480.6437581557075, 5498.533361693275, 5529.170624406291, 5611.859703507445, 2964.7479964202853, 2965.087518550523, 2973.4647763402795, 2973.6134302540963, 2978.8659510322086, 5788.7684492620665, 5834.241548598655, 5876.823695289148, 5908.172855800191, 5960.0, 5473.877855039707, 5707.828765137053, 5713.343130492194, 5718.771249149988, 5753.88492230153, 5875.50058245054, 5889.646621202742, 5901.29184497863, 5921.240012591949, 5946.375630558729, 5473.233747275305, 5550.195221692913, 5748.304250246104, 5775.27809023872, 5781.653100813965, 5740.942590574041, 5757.8560535986935, 5776.56675749312, 5792.420757924174, 5808.796692115756, 6068.787592434243, 6113.5414843887775, 6127.446081272762, 6132.386761323832, 6139.416755408408, 4046.453728746699, 4193.97903010483, 4196.958030419657, 4213.157368526368, 4219.767912764827, 5831.650100993954, 5841.773227622247, 5841.94158058431, 5847.707614619167, 5892.6759028253855, 5491.835244942658, 5711.058240198353, 5723.284589426322, 5727.971360143172, 5736.598438109292, 5672.971635141798, 5673.432656734293, 5679.432056794288, 5679.659220446786, 5680.744366503434, 5621.887562248814, 5624.156376543551, 5638.661680299195, 5649.237352957298, 5671.546276297804, 5462.371827239759, 5513.338399392099, 5546.972265138648, 5621.128725047624, 5655.547556195412, 5525.336959564878, 5527.613067085265, 5565.610407271614, 5574.219609254626, 5576.804811831566], "value": 4312.291148503713, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [729.8832186850102, 760.1334478694289, 760.422079219793, 804.955727434991, 826.6280173921737, 15033.323500442479, 15981.200939953014, 16146.434874779385, 16154.111523866197, 16194.595135121628, 13891.861081389208, 14001.649958751037, 14012.0, 14042.859571404282, 14433.855661443382, 712.1169749510595, 730.1274976403174, 834.9540775257359, 836.8368168207187, 859.3898332184126, 840.231188462556, 850.086157380815, 850.1583432401909, 850.7958090058372, 851.5444237333028, 899.1413200393641, 899.6266549382032, 900.954952252388, 901.0898992018076, 901.1394118616738, 749.306891125712, 765.4221063097382, 876.2376732242926, 898.8292224477328, 899.3434792601405, 656.2354856592065, 657.2605818454239, 657.5692921136663, 658.0195508692062, 658.236445722959, 14663.120212787268, 14694.0, 14694.55916322512, 14694.926525367304, 14718.92640536801, 12989.805152922714, 13213.471461141542, 13420.194788312732, 13527.256000919946, 13560.254186019765, 11743.882561174365, 11868.0, 11890.881091189063, 12016.339101349422, 12173.817392739116, 4075.32757095079, 4097.09863829957, 4141.503019637633, 4145.129522800185, 4217.536071032184, 70920.29079709189, 71040.64479677568, 72457.6377118111, 73153.63423182956, 74787.0, 10172.28793984414, 10258.43578603184, 10264.076233139054, 10312.742181445525, 10354.844677329846, 20596.382108536767, 20741.79258207429, 20901.268455603982, 21142.15431382758, 21160.365189044045, 7701.730439434593, 7817.140114587391, 7835.059792824897, 7899.368050555941, 7979.162187970295, 4208.22147902639, 4311.073119279307, 4344.891377715582, 4384.408104905797, 4493.73037617744, 3252.349530093991, 3334.9666503334656, 3371.662833716609, 3372.173817414749, 3372.612149602778, 542.5665888490119, 547.3623228938322, 557.2532806039926, 559.2924949938331, 560.8205374280191, 665.6871270502855, 683.2927919603187, 689.689639662154, 698.0785363320368, 709.7303024850523, 8153.8776918346275, 8223.629936652866, 8449.366297527587, 8497.872531912026, 8633.050364459905, 553.8892221555625, 593.7654626422539, 640.8590110175754, 678.8268991407159, 689.762032098925, 4190.916181676349, 4250.511191212988, 4256.423307036324, 4311.547287534827, 4480.103979204107, 53828.0, 54109.45890541123, 54574.0, 54785.72607136939, 94789.5260523693, 81429.59285203536, 81857.59071204606, 82167.17832821715, 83472.58263708642, 83948.58025709954, 71547.28452715406, 75607.62196188983, 76035.61982190053, 77452.61273693708, 78552.0, 8023.518588884685, 8268.0, 8386.832263354576, 8455.567718180962, 8518.446300990416, 49078.75460622674, 49458.0, 49692.75153624209, 50015.0, 51460.74269628778, 62299.688501559016, 64316.78416079271, 69827.0, 70234.64882675554, 72020.27979720346, 10042.849357259502, 10149.441780702133, 10207.540660670436, 10350.430726309824, 10482.528286226985, 11572.132090093108, 11585.304881707125, 11597.478113484745, 11655.650330490098, 11707.356095414834, 10713.303635263683, 10720.142388608736, 10726.356418614909, 10945.01494865466, 10975.341479510935, 10566.735831604272, 10638.627648032281, 10661.946690266499, 11011.229213954946, 11096.278741882075, 10937.343759374464, 10947.124230061416, 11023.944880275547, 11061.391623460466, 11369.715757106138, 9178.219851312713, 9259.120383563552, 9478.336516443782, 9488.573014214238, 9525.476098814632, 9466.100720431548, 9814.85277720849, 9871.353904061854, 9914.652987145415, 9929.503524823875], "value": 6872.139204680674, "unit": "score"}], "name": "dromaeo_css", "value": 7198.74963125354, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 111.0, 112.0, 111.0, 110.0, 110.0, 113.0, 110.0, 111.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 118.0, 120.0, 164.0, 119.0, 120.0, 118.0, 122.0, 170.0, 121.0], "value": 131.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 160.0, 159.0, 159.0, 160.0, 161.0, 159.0, 160.0, 159.0], "value": 159.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 84.0, 106.0, 75.0, 76.0, 75.0, 76.0, 109.0, 75.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 114.0, 82.0, 82.0, 82.0, 113.0, 89.0, 82.0, 113.0], "value": 92.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 85.0, 85.0, 84.0, 84.0, 85.0, 85.0, 84.0, 84.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 52.0, 52.0, 52.0, 52.0, 51.0, 53.0, 51.0, 51.0], "value": 51.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 59.0, 59.0, 59.0, 60.0, 60.0, 60.0, 59.0, 59.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 78.0, 81.0, 76.0, 77.0, 74.0, 74.0, 77.0, 74.0], "value": 76.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 124.0, 131.0, 128.0, 134.0, 120.0, 120.0, 119.0, 162.0, 120.0], "value": 128.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 153.0, 153.0, 152.0, 153.0, 152.0, 155.0, 156.0, 154.0, 155.0], "value": 153.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 63.0, 62.0, 62.0, 63.0, 61.0, 64.0, 62.0, 60.0], "value": 62.1, "unit": "score"}], "name": "kraken", "value": 1454.4999999999998, "alertThreshold": 2.0}]} 23:50:03 INFO - Return code: 0 23:50:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:50:03 INFO - # TBPL SUCCESS # 23:50:03 INFO - Running post-action listener: _resource_record_post_action 23:50:03 INFO - [mozharness: 2016-12-30 07:50:03.815904Z] Finished run-tests step (success) 23:50:03 INFO - Running post-run listener: _resource_record_post_run 23:50:03 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 270336; Write bytes: 355635200; Read time: 32; Write time: 375104 23:50:03 INFO - TinderboxPrint: CPU usage
13.0% 23:50:03 INFO - TinderboxPrint: I/O read bytes / time
270,336 / 32 23:50:03 INFO - TinderboxPrint: I/O write bytes / time
355,635,200 / 375,104 23:50:03 INFO - TinderboxPrint: CPU idle
8,278.8 (87.0%) 23:50:03 INFO - TinderboxPrint: CPU user
1,189.6 (12.5%) 23:50:03 INFO - TinderboxPrint: Swap in / out
0 / 0 23:50:03 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 109068288; Read time: 0; Write time: 152556 23:50:03 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 266240; Write bytes: 245559296; Read time: 24; Write time: 222524 23:50:04 INFO - Running post-run listener: _upload_blobber_files 23:50:04 INFO - Blob upload gear active. 23:50:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:50:04 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 23:50:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:50:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:50:04 INFO - (blobuploader) - INFO - Open directory for files ... 23:50:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:50:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:50:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:50:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:50:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:50:05 INFO - (blobuploader) - INFO - Done attempting. 23:50:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:50:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:50:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:50:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:50:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:50:09 INFO - (blobuploader) - INFO - Done attempting. 23:50:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:50:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:50:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:50:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:50:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:50:10 INFO - (blobuploader) - INFO - Done attempting. 23:50:10 INFO - (blobuploader) - INFO - Iteration through files over. 23:50:10 INFO - Return code: 0 23:50:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:50:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:50:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/43d420e889f4306b0a2bc56fe5f3e431890e3bb9968c850ad600826709f9b7aa3274a32d7dae87d97fae1810ae69b9a8595c7322ee93b54b6161070abaa3f229", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c3614a079c3325fd5b85cabc7257043437eed461050f8ec1987ee87b513cf088986d73a5a0b84db8ca19b3b5aa7ba1a33e113a9e3f4456df30d01c187303eda8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e04e592370a84b8de4a93a99022239e238bea36a78c6e5a65529c12e0b980286bd3d52958ccf7738e89f2917a51de83578523b2048b966050d4427f191881161"} 23:50:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:50:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:50:10 INFO - Contents: 23:50:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/43d420e889f4306b0a2bc56fe5f3e431890e3bb9968c850ad600826709f9b7aa3274a32d7dae87d97fae1810ae69b9a8595c7322ee93b54b6161070abaa3f229", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c3614a079c3325fd5b85cabc7257043437eed461050f8ec1987ee87b513cf088986d73a5a0b84db8ca19b3b5aa7ba1a33e113a9e3f4456df30d01c187303eda8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e04e592370a84b8de4a93a99022239e238bea36a78c6e5a65529c12e0b980286bd3d52958ccf7738e89f2917a51de83578523b2048b966050d4427f191881161"} 23:50:10 INFO - Running post-run listener: copy_logs_to_upload_dir 23:50:10 INFO - Copying logs to upload dir... 23:50:10 INFO - mkdir: /builds/slave/test/build/upload/logs 23:50:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.939486 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-12-29 23:50:09.747318) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-29 23:50:09.750942) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1483082972.429503-1162778758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/43d420e889f4306b0a2bc56fe5f3e431890e3bb9968c850ad600826709f9b7aa3274a32d7dae87d97fae1810ae69b9a8595c7322ee93b54b6161070abaa3f229", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c3614a079c3325fd5b85cabc7257043437eed461050f8ec1987ee87b513cf088986d73a5a0b84db8ca19b3b5aa7ba1a33e113a9e3f4456df30d01c187303eda8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e04e592370a84b8de4a93a99022239e238bea36a78c6e5a65529c12e0b980286bd3d52958ccf7738e89f2917a51de83578523b2048b966050d4427f191881161"} build_url:https://queue.taskcluster.net/v1/task/faRoWNgqR2q3Wnvk807WnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011670 build_url: 'https://queue.taskcluster.net/v1/task/faRoWNgqR2q3Wnvk807WnA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/43d420e889f4306b0a2bc56fe5f3e431890e3bb9968c850ad600826709f9b7aa3274a32d7dae87d97fae1810ae69b9a8595c7322ee93b54b6161070abaa3f229", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c3614a079c3325fd5b85cabc7257043437eed461050f8ec1987ee87b513cf088986d73a5a0b84db8ca19b3b5aa7ba1a33e113a9e3f4456df30d01c187303eda8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e04e592370a84b8de4a93a99022239e238bea36a78c6e5a65529c12e0b980286bd3d52958ccf7738e89f2917a51de83578523b2048b966050d4427f191881161"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-29 23:50:09.778166) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 23:50:09.778502) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1483082972.429503-1162778758 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004527 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-29 23:50:09.862396) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-29 23:50:09.862715) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-29 23:50:09.863000) ========= ========= Total master_lag: 0.16 =========