builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1480091305.61 results: success (0) buildid: 20161125054319 builduid: 3ee5a34bfa2749ab99753cc938a3c966 revision: 8102d0d48f8d7ea0f6fa76710ca8c44c620190e3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-25 08:28:25.608559) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-25 08:28:25.609297) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-25 08:28:25.609755) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-25 08:28:25.626581) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 08:28:25.627033) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1480084147.965414-419295775 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-25 08:28:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 38.0M=0s 2016-11-25 08:28:25 (38.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.087455 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 08:28:25.732328) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 08:28:25.733085) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1480084147.965414-419295775 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017457 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 08:28:25.783510) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 08:28:25.783924) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8102d0d48f8d7ea0f6fa76710ca8c44c620190e3 --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 8102d0d48f8d7ea0f6fa76710ca8c44c620190e3 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1480084147.965414-419295775 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-25 08:28:26,026 truncating revision to first 12 chars 2016-11-25 08:28:26,027 Setting DEBUG logging. 2016-11-25 08:28:26,027 attempt 1/10 2016-11-25 08:28:26,027 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8102d0d48f8d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-25 08:28:26,326 unpacking tar archive at: mozilla-aurora-8102d0d48f8d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.614586 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 08:28:26.418102) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-25 08:28:26.418469) ========= script_repo_revision: 8102d0d48f8d7ea0f6fa76710ca8c44c620190e3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-25 08:28:26.418929) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-25 08:28:26.419234) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-25 08:28:26.441012) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-11-25 08:28:26.441368) ========= /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=8c6b6742ce8f6f39ef4ce27d000001f1-1480084147.965414-419295775 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:28:26 INFO - MultiFileLogger online at 20161125 08:28:26 in /builds/slave/test 08:28:26 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 08:28:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:28:26 INFO - {'append_to_log': False, 08:28:26 INFO - 'base_work_dir': '/builds/slave/test', 08:28:26 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:28:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:28:26 INFO - 'branch': 'Mozilla-Aurora', 08:28:26 INFO - 'buildbot_json_path': 'buildprops.json', 08:28:26 INFO - 'config_files': ('talos/linux_config.py',), 08:28:26 INFO - 'default_actions': ('clobber', 08:28:26 INFO - 'read-buildbot-config', 08:28:26 INFO - 'download-and-extract', 08:28:26 INFO - 'populate-webroot', 08:28:26 INFO - 'create-virtualenv', 08:28:26 INFO - 'install', 08:28:26 INFO - 'run-tests'), 08:28:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:28:26 INFO - 'download_minidump_stackwalk': True, 08:28:26 INFO - 'download_symbols': 'ondemand', 08:28:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:28:26 INFO - 'tooltool.py': '/tools/tooltool.py', 08:28:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:28:26 INFO - '/tools/misc-python/virtualenv.py')}, 08:28:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:28:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:28:26 INFO - 'installer_path': 'installer.exe', 08:28:26 INFO - 'log_level': 'info', 08:28:26 INFO - 'log_name': 'talos', 08:28:26 INFO - 'log_to_console': True, 08:28:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:28:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:28:26 INFO - 'opt_config_files': (), 08:28:26 INFO - 'pip_index': False, 08:28:26 INFO - 'sps_profile': False, 08:28:26 INFO - 'sps_profile_interval': 0, 08:28:26 INFO - 'suite': 'dromaeojs', 08:28:26 INFO - 'system_bits': '32', 08:28:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:28:26 INFO - 'title': 'talos-linux64-ix-041', 08:28:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:28:26 INFO - 'use_talos_json': True, 08:28:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:28:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:28:26 INFO - 'work_dir': 'build'} 08:28:26 INFO - [mozharness: 2016-11-25 16:28:26.787644Z] Running clobber step. 08:28:26 INFO - Running pre-action listener: _resource_record_pre_action 08:28:26 INFO - Running main action method: clobber 08:28:26 INFO - rmtree: /builds/slave/test/build 08:28:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:28:27 INFO - Running post-action listener: _resource_record_post_action 08:28:27 INFO - [mozharness: 2016-11-25 16:28:27.242142Z] Finished clobber step (success) 08:28:27 INFO - [mozharness: 2016-11-25 16:28:27.242244Z] Running read-buildbot-config step. 08:28:27 INFO - Running pre-action listener: _resource_record_pre_action 08:28:27 INFO - Running main action method: read_buildbot_config 08:28:27 INFO - Using buildbot properties: 08:28:27 INFO - { 08:28:27 INFO - "project": "", 08:28:27 INFO - "product": "firefox", 08:28:27 INFO - "script_repo_revision": "production", 08:28:27 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:28:27 INFO - "repository": "", 08:28:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 08:28:27 INFO - "buildid": "20161125054319", 08:28:27 INFO - "pgo_build": "True", 08:28:27 INFO - "basedir": "/builds/slave/test", 08:28:27 INFO - "buildnumber": 645, 08:28:27 INFO - "slavename": "talos-linux64-ix-041", 08:28:27 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:28:27 INFO - "platform": "ubuntu64_hw", 08:28:27 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:28:27 INFO - "branch": "mozilla-aurora", 08:28:27 INFO - "repo_path": "releases/mozilla-aurora", 08:28:27 INFO - "revision": "8102d0d48f8d7ea0f6fa76710ca8c44c620190e3", 08:28:27 INFO - "stage_platform": "linux64-pgo", 08:28:27 INFO - "builduid": "3ee5a34bfa2749ab99753cc938a3c966", 08:28:27 INFO - "slavebuilddir": "test" 08:28:27 INFO - } 08:28:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/UvdwyDJuSF63hDWYVlWZSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 08:28:27 INFO - Running post-action listener: _resource_record_post_action 08:28:27 INFO - [mozharness: 2016-11-25 16:28:27.244688Z] Finished read-buildbot-config step (success) 08:28:27 INFO - [mozharness: 2016-11-25 16:28:27.244776Z] Running download-and-extract step. 08:28:27 INFO - Running pre-action listener: _resource_record_pre_action 08:28:27 INFO - Running main action method: download_and_extract 08:28:27 INFO - mkdir: /builds/slave/test/build/tests 08:28: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')]} 08:28:27 INFO - trying https://queue.taskcluster.net/v1/task/UvdwyDJuSF63hDWYVlWZSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:28:27 INFO - Downloading https://queue.taskcluster.net/v1/task/UvdwyDJuSF63hDWYVlWZSg/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 08:28:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UvdwyDJuSF63hDWYVlWZSg/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 08:28:27 INFO - Downloaded 1361 bytes. 08:28:27 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:28:27 INFO - Using the following test package requirements: 08:28:27 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:28:27 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:28:27 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:28:27 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:28:27 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:28:27 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:28:27 INFO - u'jsshell-linux-x86_64.zip'], 08:28:27 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:28:27 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:28:27 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:28:27 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:28:27 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:28:27 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:28:27 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:28:27 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:28:27 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:28:27 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:28:27 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:28:27 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:28:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UvdwyDJuSF63hDWYVlWZSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:28:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UvdwyDJuSF63hDWYVlWZSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:28:27 INFO - Fetch https://queue.taskcluster.net/v1/task/UvdwyDJuSF63hDWYVlWZSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:28:28 INFO - Http code: 200 08:28:28 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 08:28:28 INFO - x-amz-cf-id: KgNWfOXQadYS61KXAj4QXwvqqojGj3vYYPeXCf7MqvLRMAfRbh5FTg== 08:28:28 INFO - x-amz-version-id: O0haPPMWr_Pp_8H_TjF6XaRTg21EdyMm 08:28:28 INFO - Expected file size: 21951552 08:28:28 INFO - Obtained file size: 21951552 08:28:32 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 08:28:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UvdwyDJuSF63hDWYVlWZSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:28:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UvdwyDJuSF63hDWYVlWZSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:28:32 INFO - Fetch https://queue.taskcluster.net/v1/task/UvdwyDJuSF63hDWYVlWZSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:28:33 INFO - Http code: 200 08:28:33 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 08:28:33 INFO - x-amz-cf-id: -UKx0QodhMWHzrV64L22d-5oUSmEc7bBjpvD0e3s2ncmPkB9TPr-Bw== 08:28:33 INFO - x-amz-version-id: O0haPPMWr_Pp_8H_TjF6XaRTg21EdyMm 08:28:33 INFO - Expected file size: 21951552 08:28:33 INFO - Obtained file size: 21951552 08:28:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UvdwyDJuSF63hDWYVlWZSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 08:28:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UvdwyDJuSF63hDWYVlWZSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:28:37 INFO - Fetch https://queue.taskcluster.net/v1/task/UvdwyDJuSF63hDWYVlWZSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 08:28:38 INFO - Http code: 200 08:28:38 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 08:28:38 INFO - x-amz-cf-id: AMs8rJWGkUILOpeM8yCfb2rXD9SVq0cd029t0PfWMrczSsMfHIx3kg== 08:28:38 INFO - x-amz-version-id: RvJuxuDTWyy5RoS1eyFAM3ZDT3e1zG8i 08:28:38 INFO - Expected file size: 14409038 08:28:38 INFO - Obtained file size: 14409038 08:28:38 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')]} 08:28:38 INFO - trying https://queue.taskcluster.net/v1/task/UvdwyDJuSF63hDWYVlWZSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:28:38 INFO - Downloading https://queue.taskcluster.net/v1/task/UvdwyDJuSF63hDWYVlWZSg/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 08:28:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UvdwyDJuSF63hDWYVlWZSg/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 08:28:42 INFO - Downloaded 63893699 bytes. 08:28:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UvdwyDJuSF63hDWYVlWZSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:28:42 INFO - mkdir: /builds/slave/test/properties 08:28:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:28:42 INFO - Writing to file /builds/slave/test/properties/build_url 08:28:42 INFO - Contents: 08:28:42 INFO - build_url:https://queue.taskcluster.net/v1/task/UvdwyDJuSF63hDWYVlWZSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:28:42 INFO - Running post-action listener: _resource_record_post_action 08:28:42 INFO - Running post-action listener: set_extra_try_arguments 08:28:42 INFO - [mozharness: 2016-11-25 16:28:42.820141Z] Finished download-and-extract step (success) 08:28:42 INFO - [mozharness: 2016-11-25 16:28:42.820369Z] Running populate-webroot step. 08:28:42 INFO - Running pre-action listener: _resource_record_pre_action 08:28:42 INFO - Running main action method: populate_webroot 08:28:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:28:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:28:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:28:42 INFO - '--tppagecycles', 08:28:42 INFO - '7'], 08:28:42 INFO - 'tests': ['tsvgm']}}, 08:28:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:28:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:28:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:28:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:28:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:28:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:28:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:42 INFO - 'talos_options': ['--disable-e10s'], 08:28:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:28:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:28:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:42 INFO - 'talos_options': ['--disable-e10s'], 08:28:42 INFO - 'tests': ['damp', 'tps']}, 08:28:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:42 INFO - 'tests': ['damp', 'tps']}, 08:28:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:28:42 INFO - 'tests': ['dromaeo_dom']}, 08:28:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:28:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:28:42 INFO - 'tests': ['basic_compositor_video']}, 08:28:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:28:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:28:42 INFO - 'tests': ['a11yr', 08:28:42 INFO - 'ts_paint', 08:28:42 INFO - 'tpaint', 08:28:42 INFO - 'sessionrestore', 08:28:42 INFO - 'sessionrestore_no_auto_restore', 08:28:42 INFO - 'tabpaint']}, 08:28:42 INFO - 'other-e10s': {'tests': ['a11yr', 08:28:42 INFO - 'ts_paint', 08:28:42 INFO - 'tpaint', 08:28:42 INFO - 'sessionrestore', 08:28:42 INFO - 'sessionrestore_no_auto_restore', 08:28:42 INFO - 'tabpaint']}, 08:28:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:28:42 INFO - 'ts_paint', 08:28:42 INFO - 'tpaint', 08:28:42 INFO - 'sessionrestore', 08:28:42 INFO - 'sessionrestore_no_auto_restore', 08:28:42 INFO - 'tabpaint']}, 08:28:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:28:42 INFO - 'ts_paint', 08:28:42 INFO - 'tpaint', 08:28:42 INFO - 'sessionrestore', 08:28:42 INFO - 'sessionrestore_no_auto_restore', 08:28:42 INFO - 'tabpaint']}, 08:28:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:28:42 INFO - 'tests': ['a11yr', 08:28:42 INFO - 'ts_paint', 08:28:42 INFO - 'tpaint', 08:28:42 INFO - 'sessionrestore', 08:28:42 INFO - 'sessionrestore_no_auto_restore', 08:28:42 INFO - 'tabpaint']}, 08:28:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:28:42 INFO - 'tests': ['a11yr', 08:28:42 INFO - 'ts_paint', 08:28:42 INFO - 'tpaint', 08:28:42 INFO - 'sessionrestore', 08:28:42 INFO - 'sessionrestore_no_auto_restore', 08:28:42 INFO - 'tabpaint']}, 08:28:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:28:42 INFO - 'tests': ['tsvgx', 08:28:42 INFO - 'tsvgr_opacity', 08:28:42 INFO - 'tart', 08:28:42 INFO - 'tscrollx', 08:28:42 INFO - 'cart']}, 08:28:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:28:42 INFO - 'tsvgr_opacity', 08:28:42 INFO - 'tart', 08:28:42 INFO - 'tscrollx', 08:28:42 INFO - 'cart']}, 08:28:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:42 INFO - 'talos_options': ['--disable-e10s'], 08:28:42 INFO - 'tests': ['tp5o']}, 08:28:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:42 INFO - 'tests': ['tp5o']}, 08:28:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:42 INFO - 'talos_options': ['--disable-e10s', 08:28:42 INFO - '--xperf_path', 08:28:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:28:42 INFO - 'tests': ['tp5n']}, 08:28:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:28:42 INFO - 'talos_options': ['--xperf_path', 08:28:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:28:42 INFO - 'tests': ['tp5n']}}, 08:28:42 INFO - 'talos.zip': {'path': '', 08:28:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:28:42 INFO - Running post-action listener: _resource_record_post_action 08:28:42 INFO - [mozharness: 2016-11-25 16:28:42.837164Z] Finished populate-webroot step (success) 08:28:42 INFO - [mozharness: 2016-11-25 16:28:42.837252Z] Running create-virtualenv step. 08:28:42 INFO - Running pre-action listener: _resource_record_pre_action 08:28:42 INFO - Running main action method: create_virtualenv 08:28:42 INFO - Creating virtualenv /builds/slave/test/build/venv 08:28:42 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 08:28:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:28:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:28:42 INFO - Using real prefix '/usr' 08:28:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:28:43 INFO - Installing distribute.............................................................................................................................................................................................done. 08:28:45 INFO - Installing pip.................done. 08:28:45 INFO - Return code: 0 08:28:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:28:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:28:45 INFO - Reading from file tmpfile_stdout 08:28:45 INFO - Output received: 08:28:45 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) 08:28:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:45 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 0x7f61b8fecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe20ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1df60>, '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 0xe1ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1f1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1480084147.965414-419295775', '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 08:28:45 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 08:28:45 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 08:28:45 INFO - Using env: {'DISPLAY': ':0', 08:28:45 INFO - 'HOME': '/home/cltbld', 08:28:45 INFO - 'LANG': 'en_US.UTF-8', 08:28:45 INFO - 'LANGUAGE': 'en_US:en', 08:28:45 INFO - 'LOGNAME': 'cltbld', 08:28:45 INFO - 'MAIL': '/var/mail/cltbld', 08:28:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:45 INFO - 'MOZ_NO_REMOTE': '1', 08:28:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:45 INFO - 'NO_EM_RESTART': '1', 08:28:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:45 INFO - 'PWD': '/builds/slave/test', 08:28:45 INFO - 'SHELL': '/bin/bash', 08:28:45 INFO - 'SHLVL': '1', 08:28:45 INFO - 'TERM': 'linux', 08:28:45 INFO - 'TMOUT': '86400', 08:28:45 INFO - 'USER': 'cltbld', 08:28:45 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1480084147.965414-419295775', 08:28:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:45 INFO - '_': '/tools/buildbot/bin/python'} 08:28:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:45 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 08:28:45 INFO - Cleaning up... 08:28:45 INFO - Return code: 0 08:28:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:45 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 0x7f61b8fecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe20ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1df60>, '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 0xe1ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1f1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1480084147.965414-419295775', '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 08:28:45 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 08:28:45 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 08:28:45 INFO - Using env: {'DISPLAY': ':0', 08:28:45 INFO - 'HOME': '/home/cltbld', 08:28:45 INFO - 'LANG': 'en_US.UTF-8', 08:28:45 INFO - 'LANGUAGE': 'en_US:en', 08:28:45 INFO - 'LOGNAME': 'cltbld', 08:28:45 INFO - 'MAIL': '/var/mail/cltbld', 08:28:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:45 INFO - 'MOZ_NO_REMOTE': '1', 08:28:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:45 INFO - 'NO_EM_RESTART': '1', 08:28:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:45 INFO - 'PWD': '/builds/slave/test', 08:28:45 INFO - 'SHELL': '/bin/bash', 08:28:45 INFO - 'SHLVL': '1', 08:28:45 INFO - 'TERM': 'linux', 08:28:45 INFO - 'TMOUT': '86400', 08:28:45 INFO - 'USER': 'cltbld', 08:28:45 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1480084147.965414-419295775', 08:28:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:45 INFO - '_': '/tools/buildbot/bin/python'} 08:28:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:46 INFO - Downloading/unpacking psutil>=3.1.1 08:28:46 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 08:28:46 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 08:28:46 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 08:28:46 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 08:28:46 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 08:28:46 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 08:28:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:28:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:28:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:28:48 INFO - Installing collected packages: psutil 08:28:48 INFO - Running setup.py install for psutil 08:28:48 INFO - building 'psutil._psutil_linux' extension 08:28:48 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 08:28:48 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 08:28:48 INFO - building 'psutil._psutil_posix' extension 08:28:48 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 08:28:48 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 08:28:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:28:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:28:48 INFO - Successfully installed psutil 08:28:48 INFO - Cleaning up... 08:28:48 INFO - Return code: 0 08:28:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:28:48 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')]} 08:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:48 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')]} 08:28:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:48 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 0x7f61b8fecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe20ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1df60>, '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 0xe1ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1f1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1480084147.965414-419295775', '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 08:28:48 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 08:28:48 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 08:28:48 INFO - Using env: {'DISPLAY': ':0', 08:28:48 INFO - 'HOME': '/home/cltbld', 08:28:48 INFO - 'LANG': 'en_US.UTF-8', 08:28:48 INFO - 'LANGUAGE': 'en_US:en', 08:28:48 INFO - 'LOGNAME': 'cltbld', 08:28:48 INFO - 'MAIL': '/var/mail/cltbld', 08:28:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:48 INFO - 'MOZ_NO_REMOTE': '1', 08:28:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:48 INFO - 'NO_EM_RESTART': '1', 08:28:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:48 INFO - 'PWD': '/builds/slave/test', 08:28:48 INFO - 'SHELL': '/bin/bash', 08:28:48 INFO - 'SHLVL': '1', 08:28:48 INFO - 'TERM': 'linux', 08:28:48 INFO - 'TMOUT': '86400', 08:28:48 INFO - 'USER': 'cltbld', 08:28:48 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1480084147.965414-419295775', 08:28:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:48 INFO - '_': '/tools/buildbot/bin/python'} 08:28:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:28:48 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 08:28:48 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 08:28:48 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 08:28:48 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 08:28:48 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 08:28:48 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 08:28:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:28:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:28:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:28:50 INFO - Installing collected packages: mozsystemmonitor 08:28:50 INFO - Running setup.py install for mozsystemmonitor 08:28:50 INFO - Successfully installed mozsystemmonitor 08:28:50 INFO - Cleaning up... 08:28:51 INFO - Return code: 0 08:28:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:28: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')]} 08:28:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28: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')]} 08:28:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28: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', '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 0x7f61b8fecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe20ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1df60>, '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 0xe1ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1f1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1480084147.965414-419295775', '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 08:28: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:28: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 jsonschema==2.5.1 08:28:51 INFO - Using env: {'DISPLAY': ':0', 08:28:51 INFO - 'HOME': '/home/cltbld', 08:28:51 INFO - 'LANG': 'en_US.UTF-8', 08:28:51 INFO - 'LANGUAGE': 'en_US:en', 08:28:51 INFO - 'LOGNAME': 'cltbld', 08:28:51 INFO - 'MAIL': '/var/mail/cltbld', 08:28:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:51 INFO - 'MOZ_NO_REMOTE': '1', 08:28:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:51 INFO - 'NO_EM_RESTART': '1', 08:28:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:51 INFO - 'PWD': '/builds/slave/test', 08:28:51 INFO - 'SHELL': '/bin/bash', 08:28:51 INFO - 'SHLVL': '1', 08:28:51 INFO - 'TERM': 'linux', 08:28:51 INFO - 'TMOUT': '86400', 08:28:51 INFO - 'USER': 'cltbld', 08:28:51 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1480084147.965414-419295775', 08:28:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:51 INFO - '_': '/tools/buildbot/bin/python'} 08:28:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:51 INFO - Downloading/unpacking jsonschema==2.5.1 08:28: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 08:28: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 08:28: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 08:28: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 08:28: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 08:28: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 08:28:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:28:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:28:53 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 08:28:53 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 08:28:53 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 08:28:53 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 08:28:53 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 08:28:53 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 08:28:53 INFO - Downloading functools32-3.2.3-2.tar.gz 08:28:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:28:53 INFO - warning: no files found matching '*.txt' 08:28:53 INFO - no previously-included directories found matching 'build' 08:28:53 INFO - no previously-included directories found matching 'dist' 08:28:53 INFO - no previously-included directories found matching '.git*' 08:28:53 INFO - Installing collected packages: jsonschema, functools32 08:28:53 INFO - Running setup.py install for functools32 08:28:53 INFO - warning: no files found matching '*.txt' 08:28:53 INFO - no previously-included directories found matching 'build' 08:28:53 INFO - no previously-included directories found matching 'dist' 08:28:53 INFO - no previously-included directories found matching '.git*' 08:28:53 INFO - Successfully installed jsonschema functools32 08:28:53 INFO - Cleaning up... 08:28:53 INFO - Return code: 0 08:28:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:28:53 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')]} 08:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:53 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')]} 08:28:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:53 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 0x7f61b8fecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe20ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1df60>, '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 0xe1ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1f1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1480084147.965414-419295775', '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 08:28:53 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 08:28:53 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 08:28:53 INFO - Using env: {'DISPLAY': ':0', 08:28:53 INFO - 'HOME': '/home/cltbld', 08:28:53 INFO - 'LANG': 'en_US.UTF-8', 08:28:53 INFO - 'LANGUAGE': 'en_US:en', 08:28:53 INFO - 'LOGNAME': 'cltbld', 08:28:53 INFO - 'MAIL': '/var/mail/cltbld', 08:28:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:53 INFO - 'MOZ_NO_REMOTE': '1', 08:28:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:53 INFO - 'NO_EM_RESTART': '1', 08:28:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:53 INFO - 'PWD': '/builds/slave/test', 08:28:53 INFO - 'SHELL': '/bin/bash', 08:28:53 INFO - 'SHLVL': '1', 08:28:53 INFO - 'TERM': 'linux', 08:28:53 INFO - 'TMOUT': '86400', 08:28:53 INFO - 'USER': 'cltbld', 08:28:53 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1480084147.965414-419295775', 08:28:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:53 INFO - '_': '/tools/buildbot/bin/python'} 08:28:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:28:53 INFO - Cleaning up... 08:28:53 INFO - Return code: 0 08:28:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:28:53 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')]} 08:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:53 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')]} 08:28:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:53 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 0x7f61b8fecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe20ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1df60>, '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 0xe1ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1f1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1480084147.965414-419295775', '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 08:28:53 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 08:28:53 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 08:28:53 INFO - Using env: {'DISPLAY': ':0', 08:28:53 INFO - 'HOME': '/home/cltbld', 08:28:53 INFO - 'LANG': 'en_US.UTF-8', 08:28:53 INFO - 'LANGUAGE': 'en_US:en', 08:28:53 INFO - 'LOGNAME': 'cltbld', 08:28:53 INFO - 'MAIL': '/var/mail/cltbld', 08:28:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:53 INFO - 'MOZ_NO_REMOTE': '1', 08:28:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:53 INFO - 'NO_EM_RESTART': '1', 08:28:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:53 INFO - 'PWD': '/builds/slave/test', 08:28:53 INFO - 'SHELL': '/bin/bash', 08:28:53 INFO - 'SHLVL': '1', 08:28:53 INFO - 'TERM': 'linux', 08:28:53 INFO - 'TMOUT': '86400', 08:28:53 INFO - 'USER': 'cltbld', 08:28:53 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1480084147.965414-419295775', 08:28:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:53 INFO - '_': '/tools/buildbot/bin/python'} 08:28:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:54 INFO - Downloading/unpacking blobuploader==1.2.4 08:28: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 08:28: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 08:28: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 08:28: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 08:28: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 08:28: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 08:28:56 INFO - Downloading blobuploader-1.2.4.tar.gz 08:28:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:28:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:28: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 08:28: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 08:28: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 08:28: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 08:28: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 08:28: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 08:28:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:28:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:28: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 08:28: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 08:28: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 08:28: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 08:28: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 08:28: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 08:28:57 INFO - Downloading docopt-0.6.1.tar.gz 08:28:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:28:57 INFO - Installing collected packages: blobuploader, requests, docopt 08:28:57 INFO - Running setup.py install for blobuploader 08:28:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:28:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:28:57 INFO - Running setup.py install for requests 08:28:57 INFO - Running setup.py install for docopt 08:28:57 INFO - Successfully installed blobuploader requests docopt 08:28:57 INFO - Cleaning up... 08:28:57 INFO - Return code: 0 08:28:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:28:57 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')]} 08:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:57 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')]} 08:28:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:57 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 0x7f61b8fecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe20ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1df60>, '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 0xe1ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1f1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1480084147.965414-419295775', '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 08:28:57 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 08:28:57 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 08:28:57 INFO - Using env: {'DISPLAY': ':0', 08:28:57 INFO - 'HOME': '/home/cltbld', 08:28:57 INFO - 'LANG': 'en_US.UTF-8', 08:28:57 INFO - 'LANGUAGE': 'en_US:en', 08:28:57 INFO - 'LOGNAME': 'cltbld', 08:28:57 INFO - 'MAIL': '/var/mail/cltbld', 08:28:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:57 INFO - 'MOZ_NO_REMOTE': '1', 08:28:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:28:57 INFO - 'NO_EM_RESTART': '1', 08:28:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:28:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:57 INFO - 'PWD': '/builds/slave/test', 08:28:57 INFO - 'SHELL': '/bin/bash', 08:28:57 INFO - 'SHLVL': '1', 08:28:57 INFO - 'TERM': 'linux', 08:28:57 INFO - 'TMOUT': '86400', 08:28:57 INFO - 'USER': 'cltbld', 08:28:57 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1480084147.965414-419295775', 08:28:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:57 INFO - '_': '/tools/buildbot/bin/python'} 08:28:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:28:57 INFO - Running setup.py (path:/tmp/pip-VkYUa2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:28:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:28:57 INFO - Running setup.py (path:/tmp/pip-FlYBlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:28:58 INFO - Running setup.py (path:/tmp/pip-vBVFbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:28:58 INFO - Running setup.py (path:/tmp/pip-CTQpzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:28:58 INFO - Running setup.py (path:/tmp/pip-6wgrvs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:28:58 INFO - Running setup.py (path:/tmp/pip-kZI94H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:28:58 INFO - Running setup.py (path:/tmp/pip-AJoh8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:28:58 INFO - Running setup.py (path:/tmp/pip-tz2NNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:28:58 INFO - Running setup.py (path:/tmp/pip-S5uyyL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:28:58 INFO - Running setup.py (path:/tmp/pip-b21XsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:28:58 INFO - Running setup.py (path:/tmp/pip-NSDw1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:28:58 INFO - Running setup.py (path:/tmp/pip-MGDqWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:28:58 INFO - Running setup.py (path:/tmp/pip-bEmRGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:28:58 INFO - Running setup.py (path:/tmp/pip-Dadaer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:28:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:28:58 INFO - Running setup.py (path:/tmp/pip-QK3s55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:28:59 INFO - Running setup.py (path:/tmp/pip-xb23_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:28:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:28:59 INFO - Running setup.py (path:/tmp/pip-9cZa9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:28:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:28:59 INFO - Running setup.py install for manifestparser 08:28:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:28:59 INFO - Running setup.py install for mozcrash 08:28:59 INFO - Running setup.py install for mozdebug 08:28:59 INFO - Running setup.py install for mozdevice 08:28:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:28:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:28:59 INFO - Running setup.py install for mozfile 08:28:59 INFO - Running setup.py install for mozhttpd 08:28:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:28:59 INFO - Running setup.py install for mozinfo 08:28:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:28:59 INFO - Running setup.py install for mozInstall 08:28:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:28:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:28:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:28:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:28:59 INFO - Running setup.py install for mozleak 08:29:00 INFO - Running setup.py install for mozlog 08:29:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:29:00 INFO - Running setup.py install for moznetwork 08:29:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:29:00 INFO - Running setup.py install for mozprocess 08:29:00 INFO - Running setup.py install for mozprofile 08:29:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:29:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:29:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:29:00 INFO - Running setup.py install for mozrunner 08:29:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:29:00 INFO - Running setup.py install for mozscreenshot 08:29:00 INFO - Running setup.py install for moztest 08:29:00 INFO - Running setup.py install for mozversion 08:29:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:29:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:29:00 INFO - Cleaning up... 08:29:00 INFO - Return code: 0 08:29:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:29:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:00 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 0x7f61b8fecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe20ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1df60>, '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 0xe1ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1f1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1480084147.965414-419295775', '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 08:29:00 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 08:29:00 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 08:29:00 INFO - Using env: {'DISPLAY': ':0', 08:29:00 INFO - 'HOME': '/home/cltbld', 08:29:00 INFO - 'LANG': 'en_US.UTF-8', 08:29:00 INFO - 'LANGUAGE': 'en_US:en', 08:29:00 INFO - 'LOGNAME': 'cltbld', 08:29:00 INFO - 'MAIL': '/var/mail/cltbld', 08:29:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:00 INFO - 'MOZ_NO_REMOTE': '1', 08:29:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:00 INFO - 'NO_EM_RESTART': '1', 08:29:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:00 INFO - 'PWD': '/builds/slave/test', 08:29:00 INFO - 'SHELL': '/bin/bash', 08:29:00 INFO - 'SHLVL': '1', 08:29:00 INFO - 'TERM': 'linux', 08:29:00 INFO - 'TMOUT': '86400', 08:29:00 INFO - 'USER': 'cltbld', 08:29:00 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1480084147.965414-419295775', 08:29:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:00 INFO - '_': '/tools/buildbot/bin/python'} 08:29:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:29:01 INFO - Running setup.py (path:/tmp/pip-8TQsv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:29:01 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)) 08:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:29:01 INFO - Running setup.py (path:/tmp/pip-G9iBE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:29:01 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)) 08:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:29:01 INFO - Running setup.py (path:/tmp/pip-UAx1Oe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:29:01 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)) 08:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:29:01 INFO - Running setup.py (path:/tmp/pip-LXfq17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:29:01 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)) 08:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:29:01 INFO - Running setup.py (path:/tmp/pip-7wopdQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:29:01 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)) 08:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:29:01 INFO - Running setup.py (path:/tmp/pip-mIjwdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:29:01 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)) 08:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:29:01 INFO - Running setup.py (path:/tmp/pip-TNN0Jb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:29:01 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)) 08:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:29:01 INFO - Running setup.py (path:/tmp/pip-b9QR8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:29:01 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)) 08:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:29:01 INFO - Running setup.py (path:/tmp/pip-zG_pON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:29:01 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)) 08:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:29:01 INFO - Running setup.py (path:/tmp/pip-I62Q41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:29:01 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)) 08:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:29:01 INFO - Running setup.py (path:/tmp/pip-IUediI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:29:01 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)) 08:29:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:29:01 INFO - Running setup.py (path:/tmp/pip-FCBW5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:29:02 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)) 08:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:29:02 INFO - Running setup.py (path:/tmp/pip-G9T031-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:29:02 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)) 08:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:29:02 INFO - Running setup.py (path:/tmp/pip-W1iTa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:29:02 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)) 08:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:29:02 INFO - Running setup.py (path:/tmp/pip-4nyNKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:29:02 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)) 08:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:29:02 INFO - Running setup.py (path:/tmp/pip-exXCxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:29:02 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)) 08:29:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:29:02 INFO - Running setup.py (path:/tmp/pip-fczdII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:29:02 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)) 08:29:02 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)) 08:29:02 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)) 08:29:02 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)) 08:29:02 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)) 08:29:02 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)) 08:29:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:29: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 08:29: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 08:29: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 08:29: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 08:29: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 08:29: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 08:29:04 INFO - Downloading blessings-1.6.tar.gz 08:29:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:29:04 INFO - Installing collected packages: blessings 08:29:04 INFO - Running setup.py install for blessings 08:29:04 INFO - Successfully installed blessings 08:29:04 INFO - Cleaning up... 08:29:04 INFO - Return code: 0 08:29:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:29:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:29:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:29:04 INFO - Reading from file tmpfile_stdout 08:29:04 INFO - Current package versions: 08:29:04 INFO - argparse == 1.2.1 08:29:04 INFO - blessings == 1.6 08:29:04 INFO - blobuploader == 1.2.4 08:29:04 INFO - docopt == 0.6.1 08:29:04 INFO - functools32 == 3.2.3-2 08:29:04 INFO - jsonschema == 2.5.1 08:29:04 INFO - manifestparser == 1.1 08:29:04 INFO - mozInstall == 1.12 08:29:04 INFO - mozcrash == 1.0 08:29:04 INFO - mozdebug == 0.1 08:29:04 INFO - mozdevice == 0.48 08:29:04 INFO - mozfile == 1.2 08:29:04 INFO - mozhttpd == 0.7 08:29:04 INFO - mozinfo == 0.9 08:29:04 INFO - mozleak == 0.1 08:29:04 INFO - mozlog == 3.4 08:29:04 INFO - moznetwork == 0.27 08:29:04 INFO - mozprocess == 0.23 08:29:04 INFO - mozprofile == 0.28 08:29:04 INFO - mozrunner == 6.13 08:29:04 INFO - mozscreenshot == 0.1 08:29:04 INFO - mozsystemmonitor == 0.3 08:29:04 INFO - moztest == 0.7 08:29:04 INFO - mozversion == 1.4 08:29:04 INFO - psutil == 3.1.1 08:29:04 INFO - requests == 1.2.3 08:29:04 INFO - wsgiref == 0.1.2 08:29:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:29:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:04 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 0x7f61b8fecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe20ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1df60>, '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 0xe1ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1f1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1480084147.965414-419295775', '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 08:29:04 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 08:29:04 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 08:29:04 INFO - Using env: {'DISPLAY': ':0', 08:29:04 INFO - 'HOME': '/home/cltbld', 08:29:04 INFO - 'LANG': 'en_US.UTF-8', 08:29:04 INFO - 'LANGUAGE': 'en_US:en', 08:29:04 INFO - 'LOGNAME': 'cltbld', 08:29:04 INFO - 'MAIL': '/var/mail/cltbld', 08:29:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:04 INFO - 'MOZ_NO_REMOTE': '1', 08:29:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:04 INFO - 'NO_EM_RESTART': '1', 08:29:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:04 INFO - 'PWD': '/builds/slave/test', 08:29:04 INFO - 'SHELL': '/bin/bash', 08:29:04 INFO - 'SHLVL': '1', 08:29:04 INFO - 'TERM': 'linux', 08:29:04 INFO - 'TMOUT': '86400', 08:29:04 INFO - 'USER': 'cltbld', 08:29:04 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1480084147.965414-419295775', 08:29:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:04 INFO - '_': '/tools/buildbot/bin/python'} 08:29:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:05 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)) 08:29:05 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)) 08:29:05 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)) 08:29:05 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)) 08:29:05 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)) 08:29:05 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)) 08:29:05 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)) 08:29:05 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)) 08:29:05 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)) 08:29:05 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)) 08:29:05 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)) 08:29:05 INFO - Cleaning up... 08:29:05 INFO - Return code: 0 08:29:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:29:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f61b8fecf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd538a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe20ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe1df60>, '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 0xe1ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1f1d0>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1480084147.965414-419295775', '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 08:29:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:29:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:29:05 INFO - Using env: {'DISPLAY': ':0', 08:29:05 INFO - 'HOME': '/home/cltbld', 08:29:05 INFO - 'LANG': 'en_US.UTF-8', 08:29:05 INFO - 'LANGUAGE': 'en_US:en', 08:29:05 INFO - 'LOGNAME': 'cltbld', 08:29:05 INFO - 'MAIL': '/var/mail/cltbld', 08:29:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:05 INFO - 'MOZ_NO_REMOTE': '1', 08:29:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:05 INFO - 'NO_EM_RESTART': '1', 08:29:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:05 INFO - 'PWD': '/builds/slave/test', 08:29:05 INFO - 'SHELL': '/bin/bash', 08:29:05 INFO - 'SHLVL': '1', 08:29:05 INFO - 'TERM': 'linux', 08:29:05 INFO - 'TMOUT': '86400', 08:29:05 INFO - 'USER': 'cltbld', 08:29:05 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1480084147.965414-419295775', 08:29:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:05 INFO - '_': '/tools/buildbot/bin/python'} 08:29:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:29:05 INFO - Cleaning up... 08:29:05 INFO - Return code: 0 08:29:05 INFO - Running post-action listener: _resource_record_post_action 08:29:05 INFO - Running post-action listener: _start_resource_monitoring 08:29:05 INFO - Starting resource monitoring. 08:29:05 INFO - [mozharness: 2016-11-25 16:29:05.342966Z] Finished create-virtualenv step (success) 08:29:05 INFO - [mozharness: 2016-11-25 16:29:05.343425Z] Running install step. 08:29:05 INFO - Running pre-action listener: _resource_record_pre_action 08:29:05 INFO - Running main action method: install 08:29:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:29:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:29:05 INFO - Reading from file tmpfile_stdout 08:29:05 INFO - Detecting whether we're running mozinstall >=1.0... 08:29:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:29:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:29:05 INFO - Reading from file tmpfile_stdout 08:29:05 INFO - Output received: 08:29:05 INFO - Usage: mozinstall [options] installer 08:29:05 INFO - Options: 08:29:05 INFO - -h, --help show this help message and exit 08:29:05 INFO - -d DEST, --destination=DEST 08:29:05 INFO - Directory to install application into. [default: 08:29:05 INFO - "/builds/slave/test"] 08:29:05 INFO - --app=APP Application being installed. [default: firefox] 08:29:05 INFO - mkdir: /builds/slave/test/build/application 08:29:05 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'] 08:29:05 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 08:29:21 INFO - Reading from file tmpfile_stdout 08:29:21 INFO - Output received: 08:29:21 INFO - /builds/slave/test/build/application/firefox/firefox 08:29:21 INFO - Running post-action listener: _resource_record_post_action 08:29:21 INFO - [mozharness: 2016-11-25 16:29:21.550528Z] Finished install step (success) 08:29:21 INFO - [mozharness: 2016-11-25 16:29:21.550771Z] Running run-tests step. 08:29:21 INFO - Running pre-action listener: _resource_record_pre_action 08:29:21 INFO - Running main action method: run_tests 08:29:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:29:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:29:21 INFO - Python 2.7.3 08:29:21 INFO - Return code: 0 08:29:21 INFO - grabbing minidump binary from tooltool 08:29:21 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')]} 08:29:21 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 0xe1df60>, '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 0xe1ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe1f1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:29:21 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 08:29:21 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 08:29:21 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 08:29:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:29:21 INFO - Return code: 0 08:29:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:29:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:29:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:29:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:29:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:29:21 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/UvdwyDJuSF63hDWYVlWZSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 08:29:21 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/UvdwyDJuSF63hDWYVlWZSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 08:29:21 INFO - Using env: {'DISPLAY': ':0', 08:29:21 INFO - 'HOME': '/home/cltbld', 08:29:21 INFO - 'LANG': 'en_US.UTF-8', 08:29:21 INFO - 'LANGUAGE': 'en_US:en', 08:29:21 INFO - 'LOGNAME': 'cltbld', 08:29:21 INFO - 'MAIL': '/var/mail/cltbld', 08:29:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:29:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:29:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:21 INFO - 'MOZ_NO_REMOTE': '1', 08:29:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:29:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:29:21 INFO - 'NO_EM_RESTART': '1', 08:29:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:29:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:21 INFO - 'PWD': '/builds/slave/test', 08:29:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:29:21 INFO - 'SHELL': '/bin/bash', 08:29:21 INFO - 'SHLVL': '1', 08:29:21 INFO - 'TERM': 'linux', 08:29:21 INFO - 'TMOUT': '86400', 08:29:21 INFO - 'USER': 'cltbld', 08:29:21 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1480084147.965414-419295775', 08:29:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:21 INFO - '_': '/tools/buildbot/bin/python'} 08:29:21 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/UvdwyDJuSF63hDWYVlWZSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 08:29:21 INFO - mozversion application_buildid: 20161125054319 08:29:21 INFO - mozversion application_changeset: 8102d0d48f8d7ea0f6fa76710ca8c44c620190e3 08:29:21 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:29:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:29:21 INFO - mozversion application_name: Firefox 08:29:21 INFO - mozversion application_remotingname: firefox-dev 08:29:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:29:21 INFO - mozversion application_vendor: Mozilla 08:29:21 INFO - mozversion application_version: 52.0a2 08:29:21 INFO - mozversion platform_buildid: 20161125054319 08:29:21 INFO - mozversion platform_changeset: 8102d0d48f8d7ea0f6fa76710ca8c44c620190e3 08:29:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:29:21 INFO - mozversion platform_version: 52.0a2 08:29:21 INFO - using testdate: 1480091361 08:29:21 INFO - actual date: 1480091361 08:29:21 INFO - starting webserver on 'localhost:39425' 08:29:21 INFO - SUITE-START | Running 2 tests 08:29:21 INFO - TEST-START | dromaeo_css 08:29:21 INFO - operating with platform_type : linux_ 08:29:21 INFO - Initialising browser for dromaeo_css test... 08:29:21 INFO - TEST-INFO | started process 19784 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeMyVyM/profile http://localhost:39425/getInfo.html) 08:29:25 INFO - PROCESS | 19784 | __metrics Screen width/height:1600/1200 08:29:25 INFO - PROCESS | 19784 | colorDepth:24 08:29:25 INFO - PROCESS | 19784 | Browser inner width/height: 1024/697 08:29:25 INFO - PROCESS | 19784 | __metrics 08:29:26 INFO - PROCESS | 19784 | 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" 08:29:26 INFO - PROCESS | 19784 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:29:27 INFO - PROCESS | 19784 | console.error: PushService: 08:29:27 INFO - PROCESS | 19784 | stateChangeProcessEnqueue: Error transitioning state 08:29:27 INFO - PROCESS | 19784 | UnknownError 08:29:27 INFO - TEST-INFO | 19784: exit 0 08:29:27 INFO - Browser initialized. 08:29:27 INFO - Running cycle 1/1 for dromaeo_css test... 08:29:27 INFO - TEST-INFO | started process 19876 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeMyVyM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:29:39 INFO - PROCESS | 19876 | RSS: Main: 145113088 08:29:39 INFO - PROCESS | 19876 | 08:30:31 INFO - PROCESS | 19876 | 1480091431115 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] 08:32:41 INFO - PROCESS | 19876 | Cycle 1(1): loaded http://localhost:39425/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39425/tests/dromaeo/cssquery-ext.html) 08:32:42 INFO - PROCESS | 19876 | RSS: Main: 275587072 08:32:42 INFO - PROCESS | 19876 | 08:35:45 INFO - PROCESS | 19876 | Cycle 1(1): loaded http://localhost:39425/tests/dromaeo/cssquery-ext.html (next: http://localhost:39425/tests/dromaeo/cssquery-jquery.html) 08:35:45 INFO - PROCESS | 19876 | RSS: Main: 236003328 08:35:45 INFO - PROCESS | 19876 | 08:38:47 INFO - PROCESS | 19876 | Cycle 1(1): loaded http://localhost:39425/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39425/tests/dromaeo/cssquery-mootools.html) 08:38:48 INFO - PROCESS | 19876 | RSS: Main: 175878144 08:38:48 INFO - PROCESS | 19876 | 08:41:50 INFO - PROCESS | 19876 | Cycle 1(1): loaded http://localhost:39425/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39425/tests/dromaeo/cssquery-prototype.html) 08:41:50 INFO - PROCESS | 19876 | RSS: Main: 174043136 08:41:50 INFO - PROCESS | 19876 | 08:44:53 INFO - PROCESS | 19876 | Cycle 1(1): loaded http://localhost:39425/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39425/tests/dromaeo/cssquery-yui.html) 08:44:53 INFO - PROCESS | 19876 | RSS: Main: 179830784 08:44:53 INFO - PROCESS | 19876 | 08:47:56 INFO - PROCESS | 19876 | Cycle 1(1): loaded http://localhost:39425/tests/dromaeo/cssquery-yui.html (next: http://localhost:39425/tests/dromaeo/cssquery-dojo.html) 08:47:56 INFO - PROCESS | 19876 | RSS: Main: 268230656 08:47:56 INFO - PROCESS | 19876 | 08:47:56 INFO - PROCESS | 19876 | __start_tp_report 08:47:56 INFO - PROCESS | 19876 | _x_x_mozilla_page_load 08:47:56 INFO - PROCESS | 19876 | _x_x_mozilla_page_load_details 08:47:56 INFO - PROCESS | 19876 | |i|pagename|runs| 08:47:56 INFO - PROCESS | 19876 | |0;dojo.html;3272.296456261904;3318.950215746764;3320.3857286402017;3337.215754297741;3355.949660755089;5548.361938377087;5622.83131506055;5626.690532020737;5629.380768115504;5637.3517045539775;5488.4785945335225;5546.805861794838;5547.528460080888;5551.77792888284;5583.134614134806;4960.801567937278;4991.051700176973;5008.4240312364;5052.646314757969;5077.035363280983;4988.700677959316;5039.546440820325;5057.064443078024;5089.46560611136;5091.694498330112;4968.2795994580765;4981.850544483671;4991.875203119933;5000.7249601271915;5036;5000.424951130612;5029.446760856303;5036;5095.617828662828;5120.897582048376;4941.110600091982;5028.547430731215;5053.69677819332;5069.898602027939;5080.13637681595;5352.732363381815;5423.620346575742;5430.8913821723345;5495.917561236584;5533.6956467394275;5865.061590145556;5895;5902.32123305821;5968.045112781978;5973.253343332083;6019.969900150515;6025.096235564701;6026.005709058044;6038.879222415571;6047.425494578052;5494.313210848644;5538.113901775697;5548.167774833767;5585.106382978785;5599.524040456526;6092.603980741238;6110.7250173741395;6121.173641558333;6121.265448146251;6139.10982907476;5877.706114694248;5881.176635271066;5883.94116058834;5900.793472228537;5912.733926973297;5810.912836307459;5863.5309175265875;5909.5863289569315;5924.940750592526;5930.55520835939;5984.850378740566;5986.640801551834;5989.79035733756;6023.909641355383;6028.608140470856;5962.880742385128;5971.134185543159;5992.43071908168;5995.670238136857;6015.6691381974415;4489.147062058264;4535.092981403733;4551.5676010778925;4559.635229181657;4636.397268355092;4073.042834933788;4105.692073094529;4109.938350924738;4116.650084742771;4125.64931980785;5680.204771332017;5685.118806584986;5693.316801983706;5695.316562012585;5700.686462244616;5805.535557155417;5840.795572154954;5862.501687356623;5937.52499800015;5957.731902064417;5619.578531610146;5666.065099258659;5667.4615911488345;5682.914756278659;5686.601937864392;5055.924161137512;5070.315507406527;5070.391553013662;5092.6435149539175;5168.457311982263;6238.1266622672865;6267.6866156691985;6288.717007734572;6289.685515724195;6294.716737746904;5982.6410415373475;6035.305939816977;6035.486983606267;6050.6369617823075;6057.939420605914;5893.734781934738;5922.763089476372;6074.696265186812;6096.9390306096375;6262.2172228471445;5872.882542349214;5879.235699359056;5881.147233651011;5896.321922978912;5910.7340169693325;5925.081612350093;5978.133170690138;5980.401959803985;5986.491148252448;5986.640801551921;5592.161175823659;5642.379338272704;5727.083666613322;5838.474537291664;5858.531317494675;5724.885502289848;5831.854203644943;5831.912521312269;5837.270341207349;5866.061430171152;5716.485516303553;5742.626729262584;5767.538596912321;5773.797917072882;5775.768969241183;5677.489025987681;5680.289963754531;5796.275465566804;5840.386759390372;5843.065109582446;5644.548436125018;5690.630109042899;5700.800471983461;5722.027255366681;5776.220210271727 08:47:56 INFO - PROCESS | 19876 | |1;ext.html;573.4151165810873;608.9451949324562;646.8609249011463;659.074001028555;667.9933200667992;33776.4933525997;44336.11327773447;45091.098178036416;45258.09483810322;45321.773391133036;46302;46743;46761.532384676146;46798;46951;8346.540940248284;8859.867101993475;8988.550572471382;8991.910080899173;9002.639894404216;8401.117882622299;10433.321834080798;10774.138068954464;10777.5688972441;11055.170862185369;10886.40124793136;10944.781104377907;10946.835797463005;10948.45257737114;10961.232713710044;10709.678709638723;10768.407737574431;10783.245172837866;10784.892151078468;10792.352458852494;10693.893061069368;10753.892461075367;10754;10766;10770.35377877322;43659.78170109161;43971;43983.340249896275;44027.77986110081;44030.55969440297;3536.7877927324444;3557.7509574329806;3637.1452708613456;3714.275716235335;3780.2439512097417;32468.512972305434;32728;32923.835380823184;33029.6697033029;33119.6688033119;3783.5270591176104;3792.7345085844004;3820;3849.5957924418094;3868.6905047596124;354067;355246.99999999744;355250;356458;357209;38747.806260968515;62450.0632490513;63081.68459157675;63089.684551576946;63156.36843631597;39307.80346098251;41430.1713965719;41434.37848432276;41569.168616627496;41581.1683766323;15901.363945442054;15964;16038.518844434686;16051.919740401223;16058.598535036717;11857.940710296565;12047.096467764954;12694.555690550786;12869.4208760606;12957.611271661865;9221.723348299562;9409.623615055458;9445.763855903657;9492.430454172772;9509.619615215452;3591.748577599543;3610.151614370621;3634.109643137448;3658.359787037258;3658.762180458262;972.7957129002989;1034.2243317511866;1036.9429681367446;1049.040128282628;1065.6003998500562;31514.212144696106;33335.333293334;34473.31053378918;34630.653693462744;37032.81483592619;1027.2552399510444;1045.4459136657583;1048.5176818663347;1139.5327915554583;1162.0761494611804;16372.67254654924;17527.474175774747;17637.82362176362;17645.205965731573;17730.379436719653;550373;550886;552023;552210;555325;61435.38564614386;61801.38198618046;61825.38174618286;61837;61908.69045654743;1274.9490020399267;1303.5307289375817;1323.6227675112739;1363.2706502021372;1365.938532766008;31286;33762.15594610154;33814.15464613404;34316.656833432346;34982.65017349794;54136.45863541472;60285.69857150686;61658.38341616526;61799.69100154471;67039.32960670331;488450;491039;491193;492246;492785;29555.113346599635;29892.252693681963;30845.38309233758;31163;46857.297140543604;47087.293690593986;51020.489795101574;51348.74325628348;51412.74293628508;55517.1672424922;42190;42220.15559688728;43044.78477607592;44082.33876491791;44697;41093;41326.79336603298;41436.792816035726;41438.79280603577;42949.35575966426;42822;43863.56136438723;43984.34023489714;44131;44242.55757442513;36123.458148128324;37877.81061094677;37921;38034.42948355832;38776.2244755109;28786.28034299159;29092.279242251818;29216.26959326034;29275;29403.852980735814 08:47:56 INFO - PROCESS | 19876 | |2;jquery.html;393.3706070287542;412.6616174736717;421.2543797478463;431.15923948300804;443.6495168816635;14339.64150896228;16121.193940302983;19253.326133585346;19748.407547773553;20256.189752409886;19543.609127817435;19768.901155494237;20200.989950502488;20387.49031274219;20394.286199983002;5714.685692286923;5734.283214598176;5865.35481097079;5909.468147866691;5973.940260597404;4280.272353699863;4494.303382975628;5811.302643682764;5905.320888097859;5910.4089591040765;6289.245290565115;6535.575187612813;6566.047923051155;6692.39768420842;6695.397414232718;6422.710978006001;6488.578242414252;6571.3757193066585;6578.934210657928;6665.066890635315;5700.80283140541;5851.912221316684;5859;5859.648421094748;5861.5603829712945;23593.41016474602;23705.881470592536;23872.761272387226;23971.760282397303;24084.675342856135;2515.5220508103403;2653.8142330036903;2859.9285017874718;3178;3234.514822776579;14959.551213463614;14960.775588366183;14978.70042599142;15032.699346013127;15195.088294702353;1811.6829554827852;1905.7903630600622;1930.2857942561343;1953.872998255123;1954.2769175405192;85925.57037214836;87694;91411;102880.48559757153;103267.48366258196;17925.282988680567;17997.280108795763;18622.906885465487;18672.253109875724;18897.43307700771;33753.32493350119;33755.324893501995;33767.15582110467;33858.49212261818;33868.66131338704;9447.149756521945;9544.188743956842;9660.71017869465;9898.10917017472;10165.780106387281;7853.803654908559;7929;7942.523448593103;8068.919310806817;8420.326373890073;9137.177654011171;9505.42967421957;9568.282378821616;9595.13643772064;9624.951875240578;3440.776349537272;3517.3844577199397;3547.8935631931085;3565.732570057256;3690.815459227028;864.4381152250961;886.5389997201419;898.9820203595891;957.2342126298932;1060.6287799270194;18673.626527469376;18890.905545472186;19783.802161978485;19849.900750496156;20261.696074558895;946.7928391301147;955.0544960489066;960.1502670136839;997.945113018791;1010.6563768318659;10904.400257985886;11201.551937922555;11229.38238396896;11260.268082574607;11377.374244416636;483076;485113;485349;490916;498578;95201.52399238099;95371.52314238384;97170.51414742881;97381.51309243408;97624;1013.2198207380276;1029.994850025745;1064.0742553978089;1065.0840277361463;1069.5721711315537;17635.29458821633;18057;18100.09499524992;18225.635487289914;18380.724289135407;44018.559814401444;44149;44421.55578444174;44937.77531112454;45255.321170181815;61076;61254.38745612487;61483;62240;65057.67471162614;5674.460926212003;8318.37612179101;8473.872891906503;8791.824163516821;8810.427322224035;11906.166568340133;12102.636920892388;12406.193597416139;12699.047571432364;13306.866931330564;10679.839802402816;11168.609098681507;11200.663980080612;11298.717532061764;11791.528338866692;11027;11111.333320000826;11192.216544841784;11415.657530274106;11548.94225528867;11347.773044538897;11504.53981840717;11561;11810.645680629596;12193.207441516628;8414.410991230556;8700.60847261862;8717.782055448411;8726.956365218133;8818.38271321027;9756.707298781048;11317.773644527228;11661.125415594033;11792.882071179522;11826.172167948162 08:47:56 INFO - PROCESS | 19876 | |3;mootools.html;1498.4905132255035;1519.6656735518186;1665.4254282272611;1792.7759030121235;1812.5921667624787;8503.48979061256;9056.547172641367;9061;9064.048274931136;9066.592003359849;7851.685932562705;8038.678452861893;8079.555624440653;8220.876686849702;8926.241269492084;2153.5262242306667;2351.412146963259;2417.4802417480237;2426.1144682191048;2433.853968761871;2384.7853693167613;2456.828022038458;2461.040194324215;2463.310273123528;2465.790407815338;2467.284487498623;2484.428581426273;2489.3154382544762;2508.1723031399592;2510.723820379757;2315.8610483370967;2321.616933206019;2327.4297797039835;2334.334714606329;2338.333574931145;2443.6334549817493;2457.6559281700575;2490.3774056485877;2492.314613481289;2493.5137648158616;8948.328875334311;9005.909940900572;9026.86459703105;9035.728928132101;9123.543822808899;5405.297311349539;5567.248421463131;5568.415316391761;5568.582356323292;5571.721413929287;3334.71654909333;3459.844307006191;3535.2555974880324;3606.9278614427826;3608.3685355062757;1032.3650954662828;1060.9893901060968;1070.855434516346;1075.9515821788038;1083.9512221949951;12053.457594408274;12370.505179792888;12372.257664540157;12629.684257893534;12752.936235318764;4569.13186494565;4701.788419521062;4719.764011799396;4834.806607735722;4842.22524396102;9726.902730972599;9778.168855647207;9840.753981150385;9843.409395436296;9845;5431.592630552725;5436.755346009439;5437;5438.510534051875;5440.673559586358;4457.398251236106;4809.326694262806;4820.638452116105;5102.387713474407;5107.693538387709;3618.5295911531334;3916.980415097906;4031.254217969685;4052.9797351013644;4097.631213190827;1241.4475558376437;1270.9809352859716;1273.5096987659817;1277.2145130744525;1278.7953927371761;882.5984177199359;896.3814967672286;898.3784269393807;907.4147175072042;915.6612053540233;5680.062789639664;5751.367349591542;5880.411958804086;6166.537509686791;6253.499720022387;884.9513276769711;956.0535070280372;962.7051615577037;969.7139343893568;993.7018894331671;4094.344904815215;4141.358089496133;4158.9376159357635;4199.68502362324;4257.595528424795;10850.782984340269;11039.724006899893;11215.158863085302;11229.66311010671;11246.775064498665;10739.677809665722;11001.17491188164;11036.889631103746;11064.17018723599;11198.38408887519;8205.138460461685;8403.243708066304;8423.915760842314;8424.663013479514;8432.65077587583;5779.335376431764;5821.155932389865;5862.560307976833;5884.264466941632;5933.614315069507;9987.25095617817;10084.949575252076;10116.59533618647;10188.134008609351;10259.846102308322;10266.691999240034;10427.322224055411;10517.579296828042;10519.26365154432;10523.105536029523;7228.349448549656;7300.853982920418;7303.963480182565;7308.853822923618;7310.8903366448485;7639.433916047085;7796.688132474637;8441.78895527592;8447.408681392244;8740.868886966828;7416.629168541659;7662.73180438682;7690.730824421118;7770.417218708506;8056.274935255855;7156.463265255231;7228.710851565878;7344.11870575513;7410.036695229585;7629.0845098588525;7101.8579628406105;7113.786586402416;7164.068671072727;7167.964160179165;7168.964155179399;5075.720835354091;5248.556646922127;5262.158054711228;5405.540529055074;5483.670979741229;5281.9471805281455;5363.651362661414;5385.380681221553;5420.295361603125;5455.809046683347 08:47:56 INFO - PROCESS | 19876 | |4;prototype.html;342.49995007289357;350.10198839975465;352.6332614081355;355.6265920783177;357.9552555930509;5433.646812957155;5450.836474905749;5468.7539060742265;5483.396826349103;5498.202760599711;5392.325959255093;5407.242985981966;5417.674939503632;5438.265834112403;5443.346798384189;4133.648639865615;4288.44250247469;4291.785410729467;4294.162638285536;4300.075483770988;4235.188330502541;4246.80889359978;4267.658587313023;4273.615374616284;4314.935275970863;4012.638862502374;4125;4212.410262563229;4243.790519701885;4295;4164.896302479845;4226.309476209525;4232.280512312884;4235.618794308496;4255.510616279136;3785.356489396809;3791.3933770596573;3795.734298599099;3798.3922572388287;3805.8667946621736;4934.407871055496;5044;5307.3896501902;5328;5334.546563542103;4772.570468657803;4819.783109760069;4820.542048505421;4823.769938665653;4837;5634.323881134249;5637.210790489335;5640.210370548127;5654.688992105433;5656.4060773618585;3906.785126818024;4097.569755175693;4132.842804014881;4156.314208155651;4174.269502837022;5851.888141253191;5888.205092312526;5889.115483045427;5893.941060589425;5915.112733090028;4183.5398106208295;4206.338496293947;4210.200061988213;4212;4221.767802770877;4131.194417088639;4189.664826813848;4221.176870510221;4233.851815186454;4245.915081698348;4793.483421203826;4804.399450068741;4806.110869489155;4855.490173531728;4857;5705.572082093777;5739.397363276879;5749.511291540182;5750;5750.597458177971;1353.2218974089938;1391.325207274471;1401.3063533550958;1402.2287741742;1405.1779708870222;959.9280053995979;961.7211008807508;961.9711408657752;978.6103732699584;993.2749093162032;5365.7585408656705;5371.254342338755;5375.75809088592;5387.973060134753;5398.541124004425;5565.276514053228;5599.692016939108;5613.214150019001;5647.29408823897;5647.830565083054;5004.147635847532;5259.526642602184;5319.787208511616;5416.889537644774;5429.321334833146;2928.9707102929124;2936;2949.4101179764134;2949.926251843678;2971.301744090137;5680.437879583148;5784.8264552062665;5837;5854.199556363826;5858.5898987070495;5690.7439165237665;5715.228444160069;5715.457031581993;5756.740946657411;5757.280339957505;5806.21616081832;5817.447342502455;5833.741368800715;5843;5873.3832947539895;5337.919931201112;5609.27079479665;5610.633619828071;5611.214429979725;5613.214150018919;5533.916991245215;5553.361363443094;5559.861003474945;5564.888702226014;5565.30433695788;5575.832725018256;5828.892510423006;5856.004479238454;5865.14955331466;5883.705814709162;3980.442738016622;4049.2913740094777;4051.8784436466954;4057.3102572562143;4057.5333836609166;5662.85842853932;5668.348139963792;5695.943040569541;5726.914096288476;5738.942610573841;5239.4236633970995;5501.807436739695;5549.805756798492;5592.7762889483965;5600.355959064596;5376.156048425395;5432.239486471818;5458.399576046552;5486.972565137149;5491.36849262324;5341.4925582069645;5434.266374039454;5437.429069947599;5444.02007638613;5455.844941248264;5320.494553017457;5497.972510137423;5530.253415788817;5539.944600553943;5551.695351592291;5292.52367286946;5333.946660533345;5343;5379.300690910313;5381.919271211013 08:47:56 INFO - PROCESS | 19876 | |5;yui.html;711.3739908880185;731.254120796787;743.3532826440997;789.0216131996326;838.4047326398255;13305.667358316035;13544.593662190126;13592.796108058375;13611.319434028284;14203.289835508222;14125.576232713009;14282.642933926658;14288.285585720725;14297.49958751444;14307.356168972396;709.0852799888138;726.3027493606145;801.9719309824128;817.3910436724649;822.2763967708408;828.5443006346516;828.6354004238116;829.402829962426;831.222806675757;831.7546323834453;880.4277219807112;881.5239770523909;883.2757139145903;883.7127933421632;884.2969838978028;734.3207533031924;751.9022527071501;866.7183165471184;882.7837179890936;887.9600417981142;640.734095350429;642.457123730447;642.858571114354;643.7328508668944;643.9066335381343;14383.568492945229;14399;14426.711465770626;14434.133951962916;14437.278136093259;14298.28508574567;14329.35517901697;14427.35076921541;14676.412943482248;14808.925955370261;13234.205947643171;13387.397567109503;13405.396757145854;13509.392077356542;13747.243901585409;4481.731096134243;4517.390152329426;4546.318052292149;4633.142868569325;4644.628429725613;60402.69798650979;60677.6966115171;60757;60936.390636093514;64277.35722642761;11330.886691133148;11432.314061156358;11438.199326047097;11553.24903881245;11645.941770291263;20876.26933057366;20904.223141033184;20920.47698807542;21010.36968890936;21052.894735526224;8012.748462641319;8018.278354947966;8075.030996280484;8297.751067467985;8319.251267385964;4346.195953748566;4405.977970110129;4484.484284307347;4486.214912390384;4519.344695019204;3328.766986310935;3380.8985730428126;3392.0502259367418;3424.092615456906;3438.9312213756084;604.9546284028715;610.7618028968706;611.6421893192532;623.8908191066545;632.3834261595;586.6861229242335;640.8846407646669;703.426707233603;709.6593635055202;717.5156769180782;9401.153896149242;9647.807043859084;9651.420914745138;9937.254705897087;10061.144802691853;653.3172834388076;690.5097380859545;712.7968528969219;716.5808002318702;777.8172129549552;4706.835260765857;4994.2508623706735;5016.197408414636;5104.897902042013;5133.281340612317;90392.54803725939;90642;92495.53752231196;94300.52849735845;95049;63428;65732.34267657358;80262.19737802664;82421;83163;45502.317465237385;51628.99999999925;69492.30507694959;70066;72528.63735681394;10528.631497897537;10670.62652807148;10717.89282107169;10738.624148154777;10889.78220435571;45852.31221531613;46763;47757;48362;49017.75491122664;57897.421025789205;62934.68532657491;63000.36999629945;64346.67826660837;66245.33754662584;13462.124961877447;13589.505154433202;13653.180809151483;14039.087459315111;14127.293635318398;14205.573832785032;14340.282985850874;14649.560513184622;14764.926175369055;15099.24503774829;13215.339233038501;13549.661258468223;13706.65733356674;14232.288385580472;14548.709025819637;13016.349182541024;13324.533641322507;13695.863041369857;13793.793093103812;14081.155130692192;13295.734085318432;13630;13886;14215;14240.074395164282;10153.593856245963;10237.846432303373;10713.464326783474;10798.460076996276;11114.44427778624;10988.175886808682;11166.720831979266;11499;11598.88401115978;11774.293542387484 08:47:56 INFO - PROCESS | 19876 | __end_tp_report 08:47:56 INFO - PROCESS | 19876 | __start_cc_report 08:47:56 INFO - PROCESS | 19876 | _x_x_mozilla_cycle_collect,1315 08:47:56 INFO - PROCESS | 19876 | __end_cc_report 08:47:56 INFO - PROCESS | 19876 | __startTimestamp1480092476551__endTimestamp 08:47:56 INFO - PROCESS | 19876 | 08:47:56 INFO - PROCESS | 19876 | ------- Summary: start ------- 08:47:56 INFO - PROCESS | 19876 | Number of tests: 6 08:47:56 INFO - PROCESS | 19876 | 08:47:56 INFO - PROCESS | 19876 | [#0] dojo.html Cycles:165 Average:5529.11 Median:5716.49 stddev:621.07 (10.9%) stddev-sans-first:597.21 08:47:56 INFO - PROCESS | 19876 | Values: 3272.3 3319.0 3320.4 3337.2 3355.9 5548.4 5622.8 5626.7 5629.4 5637.4 5488.5 5546.8 5547.5 5551.8 5583.1 4960.8 4991.1 5008.4 5052.6 5077.0 4988.7 5039.5 5057.1 5089.5 5091.7 4968.3 4981.9 4991.9 5000.7 5036.0 5000.4 5029.4 5036.0 5095.6 5120.9 4941.1 5028.5 5053.7 5069.9 5080.1 5352.7 5423.6 5430.9 5495.9 5533.7 5865.1 5895.0 5902.3 5968.0 5973.3 6020.0 6025.1 6026.0 6038.9 6047.4 5494.3 5538.1 5548.2 5585.1 5599.5 6092.6 6110.7 6121.2 6121.3 6139.1 5877.7 5881.2 5883.9 5900.8 5912.7 5810.9 5863.5 5909.6 5924.9 5930.6 5984.9 5986.6 5989.8 6023.9 6028.6 5962.9 5971.1 5992.4 5995.7 6015.7 4489.1 4535.1 4551.6 4559.6 4636.4 4073.0 4105.7 4109.9 4116.7 4125.6 5680.2 5685.1 5693.3 5695.3 5700.7 5805.5 5840.8 5862.5 5937.5 5957.7 5619.6 5666.1 5667.5 5682.9 5686.6 5055.9 5070.3 5070.4 5092.6 5168.5 6238.1 6267.7 6288.7 6289.7 6294.7 5982.6 6035.3 6035.5 6050.6 6057.9 5893.7 5922.8 6074.7 6096.9 6262.2 5872.9 5879.2 5881.1 5896.3 5910.7 5925.1 5978.1 5980.4 5986.5 5986.6 5592.2 5642.4 5727.1 5838.5 5858.5 5724.9 5831.9 5831.9 5837.3 5866.1 5716.5 5742.6 5767.5 5773.8 5775.8 5677.5 5680.3 5796.3 5840.4 5843.1 5644.5 5690.6 5700.8 5722.0 5776.2 08:47:56 INFO - PROCESS | 19876 | 08:47:56 INFO - PROCESS | 19876 | [#1] ext.html Cycles:180 Average:62709.37 Median:20835.27 stddev:125746.95 (603.5%) stddev-sans-first:126013.17 08:47:56 INFO - PROCESS | 19876 | Values: 573.4 608.9 646.9 659.1 668.0 33776.5 44336.1 45091.1 45258.1 45321.8 46302.0 46743.0 46761.5 46798.0 46951.0 8346.5 8859.9 8988.6 8991.9 9002.6 8401.1 10433.3 10774.1 10777.6 11055.2 10886.4 10944.8 10946.8 10948.5 10961.2 10709.7 10768.4 10783.2 10784.9 10792.4 10693.9 10753.9 10754.0 10766.0 10770.4 43659.8 43971.0 43983.3 44027.8 44030.6 3536.8 3557.8 3637.1 3714.3 3780.2 32468.5 32728.0 32923.8 33029.7 33119.7 3783.5 3792.7 3820.0 3849.6 3868.7 354067.0 355247.0 355250.0 356458.0 357209.0 38747.8 62450.1 63081.7 63089.7 63156.4 39307.8 41430.2 41434.4 41569.2 41581.2 15901.4 15964.0 16038.5 16051.9 16058.6 11857.9 12047.1 12694.6 12869.4 12957.6 9221.7 9409.6 9445.8 9492.4 9509.6 3591.7 3610.2 3634.1 3658.4 3658.8 972.8 1034.2 1036.9 1049.0 1065.6 31514.2 33335.3 34473.3 34630.7 37032.8 1027.3 1045.4 1048.5 1139.5 1162.1 16372.7 17527.5 17637.8 17645.2 17730.4 550373.0 550886.0 552023.0 552210.0 555325.0 61435.4 61801.4 61825.4 61837.0 61908.7 1274.9 1303.5 1323.6 1363.3 1365.9 31286.0 33762.2 33814.2 34316.7 34982.7 54136.5 60285.7 61658.4 61799.7 67039.3 488450.0 491039.0 491193.0 492246.0 492785.0 29555.1 29892.3 30845.4 31163.0 46857.3 47087.3 51020.5 51348.7 51412.7 55517.2 42190.0 42220.2 43044.8 44082.3 44697.0 41093.0 41326.8 41436.8 41438.8 42949.4 42822.0 43863.6 43984.3 44131.0 44242.6 36123.5 37877.8 37921.0 38034.4 38776.2 28786.3 29092.3 29216.3 29275.0 29403.9 08:47:56 INFO - PROCESS | 19876 | 08:47:56 INFO - PROCESS | 19876 | [#2] jquery.html Cycles:180 Average:30769.38 Median:3532.64 stddev:80832.86 (2288.2%) stddev-sans-first:81027.44 08:47:56 INFO - PROCESS | 19876 | Values: 393.4 412.7 421.3 431.2 443.6 14339.6 16121.2 19253.3 19748.4 20256.2 19543.6 19768.9 20201.0 20387.5 20394.3 5714.7 5734.3 5865.4 5909.5 5973.9 4280.3 4494.3 5811.3 5905.3 5910.4 6289.2 6535.6 6566.0 6692.4 6695.4 6422.7 6488.6 6571.4 6578.9 6665.1 5700.8 5851.9 5859.0 5859.6 5861.6 23593.4 23705.9 23872.8 23971.8 24084.7 2515.5 2653.8 2859.9 3178.0 3234.5 14959.6 14960.8 14978.7 15032.7 15195.1 1811.7 1905.8 1930.3 1953.9 1954.3 85925.6 87694.0 91411.0 102880.5 103267.5 17925.3 17997.3 18622.9 18672.3 18897.4 33753.3 33755.3 33767.2 33858.5 33868.7 9447.1 9544.2 9660.7 9898.1 10165.8 7853.8 7929.0 7942.5 8068.9 8420.3 9137.2 9505.4 9568.3 9595.1 9625.0 3440.8 3517.4 3547.9 3565.7 3690.8 864.4 886.5 899.0 957.2 1060.6 18673.6 18890.9 19783.8 19849.9 20261.7 946.8 955.1 960.2 997.9 1010.7 10904.4 11201.6 11229.4 11260.3 11377.4 483076.0 485113.0 485349.0 490916.0 498578.0 95201.5 95371.5 97170.5 97381.5 97624.0 1013.2 1030.0 1064.1 1065.1 1069.6 17635.3 18057.0 18100.1 18225.6 18380.7 44018.6 44149.0 44421.6 44937.8 45255.3 61076.0 61254.4 61483.0 62240.0 65057.7 5674.5 8318.4 8473.9 8791.8 8810.4 11906.2 12102.6 12406.2 12699.0 13306.9 10679.8 11168.6 11200.7 11298.7 11791.5 11027.0 11111.3 11192.2 11415.7 11548.9 11347.8 11504.5 11561.0 11810.6 12193.2 8414.4 8700.6 8717.8 8727.0 8818.4 9756.7 11317.8 11661.1 11792.9 11826.2 08:47:56 INFO - PROCESS | 19876 | 08:47:56 INFO - PROCESS | 19876 | [#3] mootools.html Cycles:180 Average:5829.32 Median:5255.36 stddev:3275.99 (62.3%) stddev-sans-first:3269.01 08:47:56 INFO - PROCESS | 19876 | Values: 1498.5 1519.7 1665.4 1792.8 1812.6 8503.5 9056.5 9061.0 9064.0 9066.6 7851.7 8038.7 8079.6 8220.9 8926.2 2153.5 2351.4 2417.5 2426.1 2433.9 2384.8 2456.8 2461.0 2463.3 2465.8 2467.3 2484.4 2489.3 2508.2 2510.7 2315.9 2321.6 2327.4 2334.3 2338.3 2443.6 2457.7 2490.4 2492.3 2493.5 8948.3 9005.9 9026.9 9035.7 9123.5 5405.3 5567.2 5568.4 5568.6 5571.7 3334.7 3459.8 3535.3 3606.9 3608.4 1032.4 1061.0 1070.9 1076.0 1084.0 12053.5 12370.5 12372.3 12629.7 12752.9 4569.1 4701.8 4719.8 4834.8 4842.2 9726.9 9778.2 9840.8 9843.4 9845.0 5431.6 5436.8 5437.0 5438.5 5440.7 4457.4 4809.3 4820.6 5102.4 5107.7 3618.5 3917.0 4031.3 4053.0 4097.6 1241.4 1271.0 1273.5 1277.2 1278.8 882.6 896.4 898.4 907.4 915.7 5680.1 5751.4 5880.4 6166.5 6253.5 885.0 956.1 962.7 969.7 993.7 4094.3 4141.4 4158.9 4199.7 4257.6 10850.8 11039.7 11215.2 11229.7 11246.8 10739.7 11001.2 11036.9 11064.2 11198.4 8205.1 8403.2 8423.9 8424.7 8432.7 5779.3 5821.2 5862.6 5884.3 5933.6 9987.3 10084.9 10116.6 10188.1 10259.8 10266.7 10427.3 10517.6 10519.3 10523.1 7228.3 7300.9 7304.0 7308.9 7310.9 7639.4 7796.7 8441.8 8447.4 8740.9 7416.6 7662.7 7690.7 7770.4 8056.3 7156.5 7228.7 7344.1 7410.0 7629.1 7101.9 7113.8 7164.1 7168.0 7169.0 5075.7 5248.6 5262.2 5405.5 5483.7 5281.9 5363.7 5385.4 5420.3 5455.8 08:47:56 INFO - PROCESS | 19876 | 08:47:56 INFO - PROCESS | 19876 | [#4] prototype.html Cycles:180 Average:4704.89 Median:5384.95 stddev:1361.52 (25.3%) stddev-sans-first:1325.38 08:47:56 INFO - PROCESS | 19876 | Values: 342.5 350.1 352.6 355.6 358.0 5433.6 5450.8 5468.8 5483.4 5498.2 5392.3 5407.2 5417.7 5438.3 5443.3 4133.6 4288.4 4291.8 4294.2 4300.1 4235.2 4246.8 4267.7 4273.6 4314.9 4012.6 4125.0 4212.4 4243.8 4295.0 4164.9 4226.3 4232.3 4235.6 4255.5 3785.4 3791.4 3795.7 3798.4 3805.9 4934.4 5044.0 5307.4 5328.0 5334.5 4772.6 4819.8 4820.5 4823.8 4837.0 5634.3 5637.2 5640.2 5654.7 5656.4 3906.8 4097.6 4132.8 4156.3 4174.3 5851.9 5888.2 5889.1 5893.9 5915.1 4183.5 4206.3 4210.2 4212.0 4221.8 4131.2 4189.7 4221.2 4233.9 4245.9 4793.5 4804.4 4806.1 4855.5 4857.0 5705.6 5739.4 5749.5 5750.0 5750.6 1353.2 1391.3 1401.3 1402.2 1405.2 959.9 961.7 962.0 978.6 993.3 5365.8 5371.3 5375.8 5388.0 5398.5 5565.3 5599.7 5613.2 5647.3 5647.8 5004.1 5259.5 5319.8 5416.9 5429.3 2929.0 2936.0 2949.4 2949.9 2971.3 5680.4 5784.8 5837.0 5854.2 5858.6 5690.7 5715.2 5715.5 5756.7 5757.3 5806.2 5817.4 5833.7 5843.0 5873.4 5337.9 5609.3 5610.6 5611.2 5613.2 5533.9 5553.4 5559.9 5564.9 5565.3 5575.8 5828.9 5856.0 5865.1 5883.7 3980.4 4049.3 4051.9 4057.3 4057.5 5662.9 5668.3 5695.9 5726.9 5738.9 5239.4 5501.8 5549.8 5592.8 5600.4 5376.2 5432.2 5458.4 5487.0 5491.4 5341.5 5434.3 5437.4 5444.0 5455.8 5320.5 5498.0 5530.3 5539.9 5551.7 5292.5 5333.9 5343.0 5379.3 5381.9 08:47:56 INFO - PROCESS | 19876 | 08:47:56 INFO - PROCESS | 19876 | [#5] yui.html Cycles:180 Average:18010.58 Median:25242.73 stddev:23441.96 (92.9%) stddev-sans-first:23471.73 08:47:56 INFO - PROCESS | 19876 | Values: 711.4 731.3 743.4 789.0 838.4 13305.7 13544.6 13592.8 13611.3 14203.3 14125.6 14282.6 14288.3 14297.5 14307.4 709.1 726.3 802.0 817.4 822.3 828.5 828.6 829.4 831.2 831.8 880.4 881.5 883.3 883.7 884.3 734.3 751.9 866.7 882.8 888.0 640.7 642.5 642.9 643.7 643.9 14383.6 14399.0 14426.7 14434.1 14437.3 14298.3 14329.4 14427.4 14676.4 14808.9 13234.2 13387.4 13405.4 13509.4 13747.2 4481.7 4517.4 4546.3 4633.1 4644.6 60402.7 60677.7 60757.0 60936.4 64277.4 11330.9 11432.3 11438.2 11553.2 11645.9 20876.3 20904.2 20920.5 21010.4 21052.9 8012.7 8018.3 8075.0 8297.8 8319.3 4346.2 4406.0 4484.5 4486.2 4519.3 3328.8 3380.9 3392.1 3424.1 3438.9 605.0 610.8 611.6 623.9 632.4 586.7 640.9 703.4 709.7 717.5 9401.2 9647.8 9651.4 9937.3 10061.1 653.3 690.5 712.8 716.6 777.8 4706.8 4994.3 5016.2 5104.9 5133.3 90392.5 90642.0 92495.5 94300.5 95049.0 63428.0 65732.3 80262.2 82421.0 83163.0 45502.3 51629.0 69492.3 70066.0 72528.6 10528.6 10670.6 10717.9 10738.6 10889.8 45852.3 46763.0 47757.0 48362.0 49017.8 57897.4 62934.7 63000.4 64346.7 66245.3 13462.1 13589.5 13653.2 14039.1 14127.3 14205.6 14340.3 14649.6 14764.9 15099.2 13215.3 13549.7 13706.7 14232.3 14548.7 13016.3 13324.5 13695.9 13793.8 14081.2 13295.7 13630.0 13886.0 14215.0 14240.1 10153.6 10237.8 10713.5 10798.5 11114.4 10988.2 11166.7 11499.0 11598.9 11774.3 08:47:56 INFO - PROCESS | 19876 | -------- Summary: end -------- 08:47:56 INFO - PROCESS | 19876 | 08:47:57 INFO - TEST-INFO | 19876: exit 0 08:47:57 INFO - TEST-OK | dromaeo_css | took 1115517ms 08:47:57 INFO - TEST-START | kraken 08:47:57 INFO - operating with platform_type : linux_ 08:47:57 INFO - Initialising browser for kraken test... 08:47:57 INFO - TEST-INFO | started process 20195 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiliyTq/profile http://localhost:39425/getInfo.html) 08:48:01 INFO - PROCESS | 20195 | __metrics Screen width/height:1600/1200 08:48:01 INFO - PROCESS | 20195 | colorDepth:24 08:48:01 INFO - PROCESS | 20195 | Browser inner width/height: 1024/697 08:48:01 INFO - PROCESS | 20195 | __metrics 08:48:01 INFO - PROCESS | 20195 | 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" 08:48:01 INFO - PROCESS | 20195 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:48:02 INFO - PROCESS | 20195 | console.error: PushService: 08:48:02 INFO - PROCESS | 20195 | stateChangeProcessEnqueue: Error transitioning state 08:48:02 INFO - PROCESS | 20195 | UnknownError 08:48:03 INFO - TEST-INFO | 20195: exit 0 08:48:03 INFO - Browser initialized. 08:48:03 INFO - Running cycle 1/1 for kraken test... 08:48:03 INFO - TEST-INFO | started process 20288 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiliyTq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:48:14 INFO - PROCESS | 20288 | RSS: Main: 144756736 08:48:14 INFO - PROCESS | 20288 | 08:48:17 INFO - PROCESS | 20288 | Cycle 1(1): loaded http://localhost:39425/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39425/tests/kraken/driver.html?testName=audio-beat-detection) 08:48:18 INFO - PROCESS | 20288 | RSS: Main: 185958400 08:48:18 INFO - PROCESS | 20288 | 08:48:20 INFO - PROCESS | 20288 | Cycle 1(1): loaded http://localhost:39425/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39425/tests/kraken/driver.html?testName=audio-dft) 08:48:21 INFO - PROCESS | 20288 | RSS: Main: 175321088 08:48:21 INFO - PROCESS | 20288 | 08:48:24 INFO - PROCESS | 20288 | Cycle 1(1): loaded http://localhost:39425/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39425/tests/kraken/driver.html?testName=audio-fft) 08:48:24 INFO - PROCESS | 20288 | RSS: Main: 266604544 08:48:24 INFO - PROCESS | 20288 | 08:48:26 INFO - PROCESS | 20288 | Cycle 1(1): loaded http://localhost:39425/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39425/tests/kraken/driver.html?testName=audio-oscillator) 08:48:27 INFO - PROCESS | 20288 | RSS: Main: 174145536 08:48:27 INFO - PROCESS | 20288 | 08:48:29 INFO - PROCESS | 20288 | Cycle 1(1): loaded http://localhost:39425/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39425/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:48:29 INFO - PROCESS | 20288 | RSS: Main: 175722496 08:48:29 INFO - PROCESS | 20288 | 08:48:32 INFO - PROCESS | 20288 | Cycle 1(1): loaded http://localhost:39425/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39425/tests/kraken/driver.html?testName=imaging-darkroom) 08:48:33 INFO - PROCESS | 20288 | RSS: Main: 212258816 08:48:33 INFO - PROCESS | 20288 | 08:48:36 INFO - PROCESS | 20288 | Cycle 1(1): loaded http://localhost:39425/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39425/tests/kraken/driver.html?testName=imaging-desaturate) 08:48:37 INFO - PROCESS | 20288 | RSS: Main: 212807680 08:48:37 INFO - PROCESS | 20288 | 08:48:40 INFO - PROCESS | 20288 | Cycle 1(1): loaded http://localhost:39425/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39425/tests/kraken/driver.html?testName=json-parse-financial) 08:48:40 INFO - PROCESS | 20288 | RSS: Main: 211111936 08:48:40 INFO - PROCESS | 20288 | 08:48:42 INFO - PROCESS | 20288 | Cycle 1(1): loaded http://localhost:39425/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39425/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:48:42 INFO - PROCESS | 20288 | RSS: Main: 173944832 08:48:42 INFO - PROCESS | 20288 | 08:48:44 INFO - PROCESS | 20288 | Cycle 1(1): loaded http://localhost:39425/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39425/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:48:45 INFO - PROCESS | 20288 | RSS: Main: 180203520 08:48:45 INFO - PROCESS | 20288 | 08:48:46 INFO - PROCESS | 20288 | Cycle 1(1): loaded http://localhost:39425/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39425/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:48:47 INFO - PROCESS | 20288 | RSS: Main: 190083072 08:48:47 INFO - PROCESS | 20288 | 08:48:50 INFO - PROCESS | 20288 | Cycle 1(1): loaded http://localhost:39425/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39425/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:48:50 INFO - PROCESS | 20288 | RSS: Main: 199405568 08:48:50 INFO - PROCESS | 20288 | 08:48:53 INFO - PROCESS | 20288 | Cycle 1(1): loaded http://localhost:39425/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39425/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:48:54 INFO - PROCESS | 20288 | RSS: Main: 195149824 08:48:54 INFO - PROCESS | 20288 | 08:48:55 INFO - PROCESS | 20288 | Cycle 1(1): loaded http://localhost:39425/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39425/tests/kraken/driver.html?testName=ai-astar) 08:48:56 INFO - PROCESS | 20288 | RSS: Main: 247611392 08:48:56 INFO - PROCESS | 20288 | 08:48:56 INFO - PROCESS | 20288 | __start_tp_report 08:48:56 INFO - PROCESS | 20288 | _x_x_mozilla_page_load 08:48:56 INFO - PROCESS | 20288 | _x_x_mozilla_page_load_details 08:48:56 INFO - PROCESS | 20288 | |i|pagename|runs| 08:48:56 INFO - PROCESS | 20288 | |0;ai-astar;100;109;109;111;111;111;110;110;110;110 08:48:56 INFO - PROCESS | 20288 | |1;audio-beat-detection;152;120;119;158;124;121;121;121;153;124 08:48:56 INFO - PROCESS | 20288 | |2;audio-dft;159;159;161;161;159;159;162;159;162;160 08:48:56 INFO - PROCESS | 20288 | |3;audio-fft;75;75;76;107;75;75;74;76;97;74 08:48:56 INFO - PROCESS | 20288 | |4;audio-oscillator;83;82;111;82;82;82;98;82;81;116 08:48:56 INFO - PROCESS | 20288 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 08:48:56 INFO - PROCESS | 20288 | |6;imaging-darkroom;148;147;146;146;147;146;146;146;147;146 08:48:56 INFO - PROCESS | 20288 | |7;imaging-desaturate;85;85;84;85;84;85;85;85;84;85 08:48:56 INFO - PROCESS | 20288 | |8;json-parse-financial;52;49;51;51;50;51;52;50;49;53 08:48:56 INFO - PROCESS | 20288 | |9;json-stringify-tinderbox;58;61;59;58;60;58;58;58;58;60 08:48:56 INFO - PROCESS | 20288 | |10;stanford-crypto-aes;75;75;74;74;76;76;75;76;75;75 08:48:56 INFO - PROCESS | 20288 | |11;stanford-crypto-ccm;143;126;137;133;126;140;123;122;164;131 08:48:56 INFO - PROCESS | 20288 | |12;stanford-crypto-pbkdf2;158;152;152;155;156;156;151;153;158;155 08:48:56 INFO - PROCESS | 20288 | |13;stanford-crypto-sha256-iterative;61;61;62;63;61;66;63;61;60;63 08:48:56 INFO - PROCESS | 20288 | __end_tp_report 08:48:56 INFO - PROCESS | 20288 | __start_cc_report 08:48:56 INFO - PROCESS | 20288 | _x_x_mozilla_cycle_collect,1637 08:48:56 INFO - PROCESS | 20288 | __end_cc_report 08:48:56 INFO - PROCESS | 20288 | __startTimestamp1480092536032__endTimestamp 08:48:56 INFO - PROCESS | 20288 | 08:48:56 INFO - PROCESS | 20288 | ------- Summary: start ------- 08:48:56 INFO - PROCESS | 20288 | Number of tests: 14 08:48:56 INFO - PROCESS | 20288 | 08:48:56 INFO - PROCESS | 20288 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.00 stddev:3.28 (3.0%) stddev-sans-first:0.78 08:48:56 INFO - PROCESS | 20288 | Values: 100.0 109.0 109.0 111.0 111.0 111.0 110.0 110.0 110.0 110.0 08:48:56 INFO - PROCESS | 20288 | 08:48:56 INFO - PROCESS | 20288 | [#1] audio-beat-detection Cycles:10 Average:131.30 Median:124.00 stddev:16.04 (12.9%) stddev-sans-first:15.17 08:48:56 INFO - PROCESS | 20288 | Values: 152.0 120.0 119.0 158.0 124.0 121.0 121.0 121.0 153.0 124.0 08:48:56 INFO - PROCESS | 20288 | 08:48:56 INFO - PROCESS | 20288 | [#2] audio-dft Cycles:10 Average:160.10 Median:160.50 stddev:1.29 (0.8%) stddev-sans-first:1.30 08:48:56 INFO - PROCESS | 20288 | Values: 159.0 159.0 161.0 161.0 159.0 159.0 162.0 159.0 162.0 160.0 08:48:56 INFO - PROCESS | 20288 | 08:48:56 INFO - PROCESS | 20288 | [#3] audio-fft Cycles:10 Average:80.40 Median:75.00 stddev:11.64 (15.5%) stddev-sans-first:12.19 08:48:56 INFO - PROCESS | 20288 | Values: 75.0 75.0 76.0 107.0 75.0 75.0 74.0 76.0 97.0 74.0 08:48:56 INFO - PROCESS | 20288 | 08:48:56 INFO - PROCESS | 20288 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:82.00 stddev:13.46 (16.4%) stddev-sans-first:14.04 08:48:56 INFO - PROCESS | 20288 | Values: 83.0 82.0 111.0 82.0 82.0 82.0 98.0 82.0 81.0 116.0 08:48:56 INFO - PROCESS | 20288 | 08:48:56 INFO - PROCESS | 20288 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 08:48:56 INFO - PROCESS | 20288 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 08:48:56 INFO - PROCESS | 20288 | 08:48:56 INFO - PROCESS | 20288 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.50 08:48:56 INFO - PROCESS | 20288 | Values: 148.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 147.0 146.0 08:48:56 INFO - PROCESS | 20288 | 08:48:56 INFO - PROCESS | 20288 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 08:48:56 INFO - PROCESS | 20288 | Values: 85.0 85.0 84.0 85.0 84.0 85.0 85.0 85.0 84.0 85.0 08:48:56 INFO - PROCESS | 20288 | 08:48:56 INFO - PROCESS | 20288 | [#8] json-parse-financial Cycles:10 Average:50.80 Median:51.00 stddev:1.32 (2.6%) stddev-sans-first:1.32 08:48:56 INFO - PROCESS | 20288 | Values: 52.0 49.0 51.0 51.0 50.0 51.0 52.0 50.0 49.0 53.0 08:48:56 INFO - PROCESS | 20288 | 08:48:56 INFO - PROCESS | 20288 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:58.50 stddev:1.14 (1.9%) stddev-sans-first:1.17 08:48:56 INFO - PROCESS | 20288 | Values: 58.0 61.0 59.0 58.0 60.0 58.0 58.0 58.0 58.0 60.0 08:48:56 INFO - PROCESS | 20288 | 08:48:56 INFO - PROCESS | 20288 | [#10] stanford-crypto-aes Cycles:10 Average:75.10 Median:75.00 stddev:0.74 (1.0%) stddev-sans-first:0.78 08:48:56 INFO - PROCESS | 20288 | Values: 75.0 75.0 74.0 74.0 76.0 76.0 75.0 76.0 75.0 75.0 08:48:56 INFO - PROCESS | 20288 | 08:48:56 INFO - PROCESS | 20288 | [#11] stanford-crypto-ccm Cycles:10 Average:134.50 Median:135.00 stddev:12.59 (9.3%) stddev-sans-first:12.97 08:48:56 INFO - PROCESS | 20288 | Values: 143.0 126.0 137.0 133.0 126.0 140.0 123.0 122.0 164.0 131.0 08:48:56 INFO - PROCESS | 20288 | 08:48:56 INFO - PROCESS | 20288 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.60 Median:155.50 stddev:2.50 (1.6%) stddev-sans-first:2.33 08:48:56 INFO - PROCESS | 20288 | Values: 158.0 152.0 152.0 155.0 156.0 156.0 151.0 153.0 158.0 155.0 08:48:56 INFO - PROCESS | 20288 | 08:48:56 INFO - PROCESS | 20288 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.10 Median:62.50 stddev:1.73 (2.8%) stddev-sans-first:1.79 08:48:56 INFO - PROCESS | 20288 | Values: 61.0 61.0 62.0 63.0 61.0 66.0 63.0 61.0 60.0 63.0 08:48:56 INFO - PROCESS | 20288 | -------- Summary: end -------- 08:48:56 INFO - PROCESS | 20288 | 08:48:57 INFO - TEST-INFO | 20288: exit 0 08:48:57 INFO - TEST-OK | kraken | took 59901ms 08:48:57 INFO - SUITE-END | took 1175s 08:48:57 INFO - Completed test suite (00:19:35) 08:48:57 INFO - javascript benchmark 08:48:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3272.296456261904, 3318.950215746764, 3320.3857286402017, 3337.215754297741, 3355.949660755089, 5548.361938377087, 5622.83131506055, 5626.690532020737, 5629.380768115504, 5637.3517045539775, 5488.4785945335225, 5546.805861794838, 5547.528460080888, 5551.77792888284, 5583.134614134806, 4960.801567937278, 4991.051700176973, 5008.4240312364, 5052.646314757969, 5077.035363280983, 4988.700677959316, 5039.546440820325, 5057.064443078024, 5089.46560611136, 5091.694498330112, 4968.2795994580765, 4981.850544483671, 4991.875203119933, 5000.7249601271915, 5036.0, 5000.424951130612, 5029.446760856303, 5036.0, 5095.617828662828, 5120.897582048376, 4941.110600091982, 5028.547430731215, 5053.69677819332, 5069.898602027939, 5080.13637681595, 5352.732363381815, 5423.620346575742, 5430.8913821723345, 5495.917561236584, 5533.6956467394275, 5865.061590145556, 5895.0, 5902.32123305821, 5968.045112781978, 5973.253343332083, 6019.969900150515, 6025.096235564701, 6026.005709058044, 6038.879222415571, 6047.425494578052, 5494.313210848644, 5538.113901775697, 5548.167774833767, 5585.106382978785, 5599.524040456526, 6092.603980741238, 6110.7250173741395, 6121.173641558333, 6121.265448146251, 6139.10982907476, 5877.706114694248, 5881.176635271066, 5883.94116058834, 5900.793472228537, 5912.733926973297, 5810.912836307459, 5863.5309175265875, 5909.5863289569315, 5924.940750592526, 5930.55520835939, 5984.850378740566, 5986.640801551834, 5989.79035733756, 6023.909641355383, 6028.608140470856, 5962.880742385128, 5971.134185543159, 5992.43071908168, 5995.670238136857, 6015.6691381974415, 4489.147062058264, 4535.092981403733, 4551.5676010778925, 4559.635229181657, 4636.397268355092, 4073.042834933788, 4105.692073094529, 4109.938350924738, 4116.650084742771, 4125.64931980785, 5680.204771332017, 5685.118806584986, 5693.316801983706, 5695.316562012585, 5700.686462244616, 5805.535557155417, 5840.795572154954, 5862.501687356623, 5937.52499800015, 5957.731902064417, 5619.578531610146, 5666.065099258659, 5667.4615911488345, 5682.914756278659, 5686.601937864392, 5055.924161137512, 5070.315507406527, 5070.391553013662, 5092.6435149539175, 5168.457311982263, 6238.1266622672865, 6267.6866156691985, 6288.717007734572, 6289.685515724195, 6294.716737746904, 5982.6410415373475, 6035.305939816977, 6035.486983606267, 6050.6369617823075, 6057.939420605914, 5893.734781934738, 5922.763089476372, 6074.696265186812, 6096.9390306096375, 6262.2172228471445, 5872.882542349214, 5879.235699359056, 5881.147233651011, 5896.321922978912, 5910.7340169693325, 5925.081612350093, 5978.133170690138, 5980.401959803985, 5986.491148252448, 5986.640801551921, 5592.161175823659, 5642.379338272704, 5727.083666613322, 5838.474537291664, 5858.531317494675, 5724.885502289848, 5831.854203644943, 5831.912521312269, 5837.270341207349, 5866.061430171152, 5716.485516303553, 5742.626729262584, 5767.538596912321, 5773.797917072882, 5775.768969241183, 5677.489025987681, 5680.289963754531, 5796.275465566804, 5840.386759390372, 5843.065109582446, 5644.548436125018, 5690.630109042899, 5700.800471983461, 5722.027255366681, 5776.220210271727], "value": 5488.363557331304, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.4151165810873, 608.9451949324562, 646.8609249011463, 659.074001028555, 667.9933200667992, 33776.4933525997, 44336.11327773447, 45091.098178036416, 45258.09483810322, 45321.773391133036, 46302.0, 46743.0, 46761.532384676146, 46798.0, 46951.0, 8346.540940248284, 8859.867101993475, 8988.550572471382, 8991.910080899173, 9002.639894404216, 8401.117882622299, 10433.321834080798, 10774.138068954464, 10777.5688972441, 11055.170862185369, 10886.40124793136, 10944.781104377907, 10946.835797463005, 10948.45257737114, 10961.232713710044, 10709.678709638723, 10768.407737574431, 10783.245172837866, 10784.892151078468, 10792.352458852494, 10693.893061069368, 10753.892461075367, 10754.0, 10766.0, 10770.35377877322, 43659.78170109161, 43971.0, 43983.340249896275, 44027.77986110081, 44030.55969440297, 3536.7877927324444, 3557.7509574329806, 3637.1452708613456, 3714.275716235335, 3780.2439512097417, 32468.512972305434, 32728.0, 32923.835380823184, 33029.6697033029, 33119.6688033119, 3783.5270591176104, 3792.7345085844004, 3820.0, 3849.5957924418094, 3868.6905047596124, 354067.0, 355246.99999999744, 355250.0, 356458.0, 357209.0, 38747.806260968515, 62450.0632490513, 63081.68459157675, 63089.684551576946, 63156.36843631597, 39307.80346098251, 41430.1713965719, 41434.37848432276, 41569.168616627496, 41581.1683766323, 15901.363945442054, 15964.0, 16038.518844434686, 16051.919740401223, 16058.598535036717, 11857.940710296565, 12047.096467764954, 12694.555690550786, 12869.4208760606, 12957.611271661865, 9221.723348299562, 9409.623615055458, 9445.763855903657, 9492.430454172772, 9509.619615215452, 3591.748577599543, 3610.151614370621, 3634.109643137448, 3658.359787037258, 3658.762180458262, 972.7957129002989, 1034.2243317511866, 1036.9429681367446, 1049.040128282628, 1065.6003998500562, 31514.212144696106, 33335.333293334, 34473.31053378918, 34630.653693462744, 37032.81483592619, 1027.2552399510444, 1045.4459136657583, 1048.5176818663347, 1139.5327915554583, 1162.0761494611804, 16372.67254654924, 17527.474175774747, 17637.82362176362, 17645.205965731573, 17730.379436719653, 550373.0, 550886.0, 552023.0, 552210.0, 555325.0, 61435.38564614386, 61801.38198618046, 61825.38174618286, 61837.0, 61908.69045654743, 1274.9490020399267, 1303.5307289375817, 1323.6227675112739, 1363.2706502021372, 1365.938532766008, 31286.0, 33762.15594610154, 33814.15464613404, 34316.656833432346, 34982.65017349794, 54136.45863541472, 60285.69857150686, 61658.38341616526, 61799.69100154471, 67039.32960670331, 488450.0, 491039.0, 491193.0, 492246.0, 492785.0, 29555.113346599635, 29892.252693681963, 30845.38309233758, 31163.0, 46857.297140543604, 47087.293690593986, 51020.489795101574, 51348.74325628348, 51412.74293628508, 55517.1672424922, 42190.0, 42220.15559688728, 43044.78477607592, 44082.33876491791, 44697.0, 41093.0, 41326.79336603298, 41436.792816035726, 41438.79280603577, 42949.35575966426, 42822.0, 43863.56136438723, 43984.34023489714, 44131.0, 44242.55757442513, 36123.458148128324, 37877.81061094677, 37921.0, 38034.42948355832, 38776.2244755109, 28786.28034299159, 29092.279242251818, 29216.26959326034, 29275.0, 29403.852980735814], "value": 20064.68556717771, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.3706070287542, 412.6616174736717, 421.2543797478463, 431.15923948300804, 443.6495168816635, 14339.64150896228, 16121.193940302983, 19253.326133585346, 19748.407547773553, 20256.189752409886, 19543.609127817435, 19768.901155494237, 20200.989950502488, 20387.49031274219, 20394.286199983002, 5714.685692286923, 5734.283214598176, 5865.35481097079, 5909.468147866691, 5973.940260597404, 4280.272353699863, 4494.303382975628, 5811.302643682764, 5905.320888097859, 5910.4089591040765, 6289.245290565115, 6535.575187612813, 6566.047923051155, 6692.39768420842, 6695.397414232718, 6422.710978006001, 6488.578242414252, 6571.3757193066585, 6578.934210657928, 6665.066890635315, 5700.80283140541, 5851.912221316684, 5859.0, 5859.648421094748, 5861.5603829712945, 23593.41016474602, 23705.881470592536, 23872.761272387226, 23971.760282397303, 24084.675342856135, 2515.5220508103403, 2653.8142330036903, 2859.9285017874718, 3178.0, 3234.514822776579, 14959.551213463614, 14960.775588366183, 14978.70042599142, 15032.699346013127, 15195.088294702353, 1811.6829554827852, 1905.7903630600622, 1930.2857942561343, 1953.872998255123, 1954.2769175405192, 85925.57037214836, 87694.0, 91411.0, 102880.48559757153, 103267.48366258196, 17925.282988680567, 17997.280108795763, 18622.906885465487, 18672.253109875724, 18897.43307700771, 33753.32493350119, 33755.324893501995, 33767.15582110467, 33858.49212261818, 33868.66131338704, 9447.149756521945, 9544.188743956842, 9660.71017869465, 9898.10917017472, 10165.780106387281, 7853.803654908559, 7929.0, 7942.523448593103, 8068.919310806817, 8420.326373890073, 9137.177654011171, 9505.42967421957, 9568.282378821616, 9595.13643772064, 9624.951875240578, 3440.776349537272, 3517.3844577199397, 3547.8935631931085, 3565.732570057256, 3690.815459227028, 864.4381152250961, 886.5389997201419, 898.9820203595891, 957.2342126298932, 1060.6287799270194, 18673.626527469376, 18890.905545472186, 19783.802161978485, 19849.900750496156, 20261.696074558895, 946.7928391301147, 955.0544960489066, 960.1502670136839, 997.945113018791, 1010.6563768318659, 10904.400257985886, 11201.551937922555, 11229.38238396896, 11260.268082574607, 11377.374244416636, 483076.0, 485113.0, 485349.0, 490916.0, 498578.0, 95201.52399238099, 95371.52314238384, 97170.51414742881, 97381.51309243408, 97624.0, 1013.2198207380276, 1029.994850025745, 1064.0742553978089, 1065.0840277361463, 1069.5721711315537, 17635.29458821633, 18057.0, 18100.09499524992, 18225.635487289914, 18380.724289135407, 44018.559814401444, 44149.0, 44421.55578444174, 44937.77531112454, 45255.321170181815, 61076.0, 61254.38745612487, 61483.0, 62240.0, 65057.67471162614, 5674.460926212003, 8318.37612179101, 8473.872891906503, 8791.824163516821, 8810.427322224035, 11906.166568340133, 12102.636920892388, 12406.193597416139, 12699.047571432364, 13306.866931330564, 10679.839802402816, 11168.609098681507, 11200.663980080612, 11298.717532061764, 11791.528338866692, 11027.0, 11111.333320000826, 11192.216544841784, 11415.657530274106, 11548.94225528867, 11347.773044538897, 11504.53981840717, 11561.0, 11810.645680629596, 12193.207441516628, 8414.410991230556, 8700.60847261862, 8717.782055448411, 8726.956365218133, 8818.38271321027, 9756.707298781048, 11317.773644527228, 11661.125415594033, 11792.882071179522, 11826.172167948162], "value": 10264.032825150212, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1498.4905132255035, 1519.6656735518186, 1665.4254282272611, 1792.7759030121235, 1812.5921667624787, 8503.48979061256, 9056.547172641367, 9061.0, 9064.048274931136, 9066.592003359849, 7851.685932562705, 8038.678452861893, 8079.555624440653, 8220.876686849702, 8926.241269492084, 2153.5262242306667, 2351.412146963259, 2417.4802417480237, 2426.1144682191048, 2433.853968761871, 2384.7853693167613, 2456.828022038458, 2461.040194324215, 2463.310273123528, 2465.790407815338, 2467.284487498623, 2484.428581426273, 2489.3154382544762, 2508.1723031399592, 2510.723820379757, 2315.8610483370967, 2321.616933206019, 2327.4297797039835, 2334.334714606329, 2338.333574931145, 2443.6334549817493, 2457.6559281700575, 2490.3774056485877, 2492.314613481289, 2493.5137648158616, 8948.328875334311, 9005.909940900572, 9026.86459703105, 9035.728928132101, 9123.543822808899, 5405.297311349539, 5567.248421463131, 5568.415316391761, 5568.582356323292, 5571.721413929287, 3334.71654909333, 3459.844307006191, 3535.2555974880324, 3606.9278614427826, 3608.3685355062757, 1032.3650954662828, 1060.9893901060968, 1070.855434516346, 1075.9515821788038, 1083.9512221949951, 12053.457594408274, 12370.505179792888, 12372.257664540157, 12629.684257893534, 12752.936235318764, 4569.13186494565, 4701.788419521062, 4719.764011799396, 4834.806607735722, 4842.22524396102, 9726.902730972599, 9778.168855647207, 9840.753981150385, 9843.409395436296, 9845.0, 5431.592630552725, 5436.755346009439, 5437.0, 5438.510534051875, 5440.673559586358, 4457.398251236106, 4809.326694262806, 4820.638452116105, 5102.387713474407, 5107.693538387709, 3618.5295911531334, 3916.980415097906, 4031.254217969685, 4052.9797351013644, 4097.631213190827, 1241.4475558376437, 1270.9809352859716, 1273.5096987659817, 1277.2145130744525, 1278.7953927371761, 882.5984177199359, 896.3814967672286, 898.3784269393807, 907.4147175072042, 915.6612053540233, 5680.062789639664, 5751.367349591542, 5880.411958804086, 6166.537509686791, 6253.499720022387, 884.9513276769711, 956.0535070280372, 962.7051615577037, 969.7139343893568, 993.7018894331671, 4094.344904815215, 4141.358089496133, 4158.9376159357635, 4199.68502362324, 4257.595528424795, 10850.782984340269, 11039.724006899893, 11215.158863085302, 11229.66311010671, 11246.775064498665, 10739.677809665722, 11001.17491188164, 11036.889631103746, 11064.17018723599, 11198.38408887519, 8205.138460461685, 8403.243708066304, 8423.915760842314, 8424.663013479514, 8432.65077587583, 5779.335376431764, 5821.155932389865, 5862.560307976833, 5884.264466941632, 5933.614315069507, 9987.25095617817, 10084.949575252076, 10116.59533618647, 10188.134008609351, 10259.846102308322, 10266.691999240034, 10427.322224055411, 10517.579296828042, 10519.26365154432, 10523.105536029523, 7228.349448549656, 7300.853982920418, 7303.963480182565, 7308.853822923618, 7310.8903366448485, 7639.433916047085, 7796.688132474637, 8441.78895527592, 8447.408681392244, 8740.868886966828, 7416.629168541659, 7662.73180438682, 7690.730824421118, 7770.417218708506, 8056.274935255855, 7156.463265255231, 7228.710851565878, 7344.11870575513, 7410.036695229585, 7629.0845098588525, 7101.8579628406105, 7113.786586402416, 7164.068671072727, 7167.964160179165, 7168.964155179399, 5075.720835354091, 5248.556646922127, 5262.158054711228, 5405.540529055074, 5483.670979741229, 5281.9471805281455, 5363.651362661414, 5385.380681221553, 5420.295361603125, 5455.809046683347], "value": 4680.456299579027, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.49995007289357, 350.10198839975465, 352.6332614081355, 355.6265920783177, 357.9552555930509, 5433.646812957155, 5450.836474905749, 5468.7539060742265, 5483.396826349103, 5498.202760599711, 5392.325959255093, 5407.242985981966, 5417.674939503632, 5438.265834112403, 5443.346798384189, 4133.648639865615, 4288.44250247469, 4291.785410729467, 4294.162638285536, 4300.075483770988, 4235.188330502541, 4246.80889359978, 4267.658587313023, 4273.615374616284, 4314.935275970863, 4012.638862502374, 4125.0, 4212.410262563229, 4243.790519701885, 4295.0, 4164.896302479845, 4226.309476209525, 4232.280512312884, 4235.618794308496, 4255.510616279136, 3785.356489396809, 3791.3933770596573, 3795.734298599099, 3798.3922572388287, 3805.8667946621736, 4934.407871055496, 5044.0, 5307.3896501902, 5328.0, 5334.546563542103, 4772.570468657803, 4819.783109760069, 4820.542048505421, 4823.769938665653, 4837.0, 5634.323881134249, 5637.210790489335, 5640.210370548127, 5654.688992105433, 5656.4060773618585, 3906.785126818024, 4097.569755175693, 4132.842804014881, 4156.314208155651, 4174.269502837022, 5851.888141253191, 5888.205092312526, 5889.115483045427, 5893.941060589425, 5915.112733090028, 4183.5398106208295, 4206.338496293947, 4210.200061988213, 4212.0, 4221.767802770877, 4131.194417088639, 4189.664826813848, 4221.176870510221, 4233.851815186454, 4245.915081698348, 4793.483421203826, 4804.399450068741, 4806.110869489155, 4855.490173531728, 4857.0, 5705.572082093777, 5739.397363276879, 5749.511291540182, 5750.0, 5750.597458177971, 1353.2218974089938, 1391.325207274471, 1401.3063533550958, 1402.2287741742, 1405.1779708870222, 959.9280053995979, 961.7211008807508, 961.9711408657752, 978.6103732699584, 993.2749093162032, 5365.7585408656705, 5371.254342338755, 5375.75809088592, 5387.973060134753, 5398.541124004425, 5565.276514053228, 5599.692016939108, 5613.214150019001, 5647.29408823897, 5647.830565083054, 5004.147635847532, 5259.526642602184, 5319.787208511616, 5416.889537644774, 5429.321334833146, 2928.9707102929124, 2936.0, 2949.4101179764134, 2949.926251843678, 2971.301744090137, 5680.437879583148, 5784.8264552062665, 5837.0, 5854.199556363826, 5858.5898987070495, 5690.7439165237665, 5715.228444160069, 5715.457031581993, 5756.740946657411, 5757.280339957505, 5806.21616081832, 5817.447342502455, 5833.741368800715, 5843.0, 5873.3832947539895, 5337.919931201112, 5609.27079479665, 5610.633619828071, 5611.214429979725, 5613.214150018919, 5533.916991245215, 5553.361363443094, 5559.861003474945, 5564.888702226014, 5565.30433695788, 5575.832725018256, 5828.892510423006, 5856.004479238454, 5865.14955331466, 5883.705814709162, 3980.442738016622, 4049.2913740094777, 4051.8784436466954, 4057.3102572562143, 4057.5333836609166, 5662.85842853932, 5668.348139963792, 5695.943040569541, 5726.914096288476, 5738.942610573841, 5239.4236633970995, 5501.807436739695, 5549.805756798492, 5592.7762889483965, 5600.355959064596, 5376.156048425395, 5432.239486471818, 5458.399576046552, 5486.972565137149, 5491.36849262324, 5341.4925582069645, 5434.266374039454, 5437.429069947599, 5444.02007638613, 5455.844941248264, 5320.494553017457, 5497.972510137423, 5530.253415788817, 5539.944600553943, 5551.695351592291, 5292.52367286946, 5333.946660533345, 5343.0, 5379.300690910313, 5381.919271211013], "value": 4273.984033972516, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.3739908880185, 731.254120796787, 743.3532826440997, 789.0216131996326, 838.4047326398255, 13305.667358316035, 13544.593662190126, 13592.796108058375, 13611.319434028284, 14203.289835508222, 14125.576232713009, 14282.642933926658, 14288.285585720725, 14297.49958751444, 14307.356168972396, 709.0852799888138, 726.3027493606145, 801.9719309824128, 817.3910436724649, 822.2763967708408, 828.5443006346516, 828.6354004238116, 829.402829962426, 831.222806675757, 831.7546323834453, 880.4277219807112, 881.5239770523909, 883.2757139145903, 883.7127933421632, 884.2969838978028, 734.3207533031924, 751.9022527071501, 866.7183165471184, 882.7837179890936, 887.9600417981142, 640.734095350429, 642.457123730447, 642.858571114354, 643.7328508668944, 643.9066335381343, 14383.568492945229, 14399.0, 14426.711465770626, 14434.133951962916, 14437.278136093259, 14298.28508574567, 14329.35517901697, 14427.35076921541, 14676.412943482248, 14808.925955370261, 13234.205947643171, 13387.397567109503, 13405.396757145854, 13509.392077356542, 13747.243901585409, 4481.731096134243, 4517.390152329426, 4546.318052292149, 4633.142868569325, 4644.628429725613, 60402.69798650979, 60677.6966115171, 60757.0, 60936.390636093514, 64277.35722642761, 11330.886691133148, 11432.314061156358, 11438.199326047097, 11553.24903881245, 11645.941770291263, 20876.26933057366, 20904.223141033184, 20920.47698807542, 21010.36968890936, 21052.894735526224, 8012.748462641319, 8018.278354947966, 8075.030996280484, 8297.751067467985, 8319.251267385964, 4346.195953748566, 4405.977970110129, 4484.484284307347, 4486.214912390384, 4519.344695019204, 3328.766986310935, 3380.8985730428126, 3392.0502259367418, 3424.092615456906, 3438.9312213756084, 604.9546284028715, 610.7618028968706, 611.6421893192532, 623.8908191066545, 632.3834261595, 586.6861229242335, 640.8846407646669, 703.426707233603, 709.6593635055202, 717.5156769180782, 9401.153896149242, 9647.807043859084, 9651.420914745138, 9937.254705897087, 10061.144802691853, 653.3172834388076, 690.5097380859545, 712.7968528969219, 716.5808002318702, 777.8172129549552, 4706.835260765857, 4994.2508623706735, 5016.197408414636, 5104.897902042013, 5133.281340612317, 90392.54803725939, 90642.0, 92495.53752231196, 94300.52849735845, 95049.0, 63428.0, 65732.34267657358, 80262.19737802664, 82421.0, 83163.0, 45502.317465237385, 51628.99999999925, 69492.30507694959, 70066.0, 72528.63735681394, 10528.631497897537, 10670.62652807148, 10717.89282107169, 10738.624148154777, 10889.78220435571, 45852.31221531613, 46763.0, 47757.0, 48362.0, 49017.75491122664, 57897.421025789205, 62934.68532657491, 63000.36999629945, 64346.67826660837, 66245.33754662584, 13462.124961877447, 13589.505154433202, 13653.180809151483, 14039.087459315111, 14127.293635318398, 14205.573832785032, 14340.282985850874, 14649.560513184622, 14764.926175369055, 15099.24503774829, 13215.339233038501, 13549.661258468223, 13706.65733356674, 14232.288385580472, 14548.709025819637, 13016.349182541024, 13324.533641322507, 13695.863041369857, 13793.793093103812, 14081.155130692192, 13295.734085318432, 13630.0, 13886.0, 14215.0, 14240.074395164282, 10153.593856245963, 10237.846432303373, 10713.464326783474, 10798.460076996276, 11114.44427778624, 10988.175886808682, 11166.720831979266, 11499.0, 11598.88401115978, 11774.293542387484], "value": 7318.150246744987, "unit": "score"}], "name": "dromaeo_css", "value": 7409.577932176274, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 109.0, 109.0, 111.0, 111.0, 111.0, 110.0, 110.0, 110.0, 110.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 120.0, 119.0, 158.0, 124.0, 121.0, 121.0, 121.0, 153.0, 124.0], "value": 131.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 161.0, 161.0, 159.0, 159.0, 162.0, 159.0, 162.0, 160.0], "value": 160.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 107.0, 75.0, 75.0, 74.0, 76.0, 97.0, 74.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 111.0, 82.0, 82.0, 82.0, 98.0, 82.0, 81.0, 116.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 85.0, 84.0, 85.0, 85.0, 85.0, 84.0, 85.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 49.0, 51.0, 51.0, 50.0, 51.0, 52.0, 50.0, 49.0, 53.0], "value": 50.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 61.0, 59.0, 58.0, 60.0, 58.0, 58.0, 58.0, 58.0, 60.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 74.0, 76.0, 76.0, 75.0, 76.0, 75.0, 75.0], "value": 75.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 126.0, 137.0, 133.0, 126.0, 140.0, 123.0, 122.0, 164.0, 131.0], "value": 134.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 152.0, 152.0, 155.0, 156.0, 156.0, 151.0, 153.0, 158.0, 155.0], "value": 154.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 63.0, 61.0, 66.0, 63.0, 61.0, 60.0, 63.0], "value": 62.1, "unit": "score"}], "name": "kraken", "value": 1454.8999999999996, "alertThreshold": 2.0}]} 08:48:57 INFO - Return code: 0 08:48:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:48:57 INFO - # TBPL SUCCESS # 08:48:57 INFO - Running post-action listener: _resource_record_post_action 08:48:57 INFO - [mozharness: 2016-11-25 16:48:57.843380Z] Finished run-tests step (success) 08:48:57 INFO - Running post-run listener: _resource_record_post_run 08:48:57 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 266240; Write bytes: 366714880; Read time: 28; Write time: 216784 08:48:57 INFO - TinderboxPrint: CPU usage
13.0% 08:48:57 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 28 08:48:57 INFO - TinderboxPrint: I/O write bytes / time
366,714,880 / 216,784 08:48:57 INFO - TinderboxPrint: CPU idle
8,274.5 (87.0%) 08:48:57 INFO - TinderboxPrint: CPU user
1,193.6 (12.5%) 08:48:57 INFO - TinderboxPrint: Swap in / out
0 / 0 08:48:57 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108118016; Read time: 0; Write time: 73448 08:48:57 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 262144; Write bytes: 246943744; Read time: 16; Write time: 140676 08:48:58 INFO - Running post-run listener: _upload_blobber_files 08:48:58 INFO - Blob upload gear active. 08:48:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:48:58 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 08:48:58 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'] 08:48:58 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 08:48:58 INFO - (blobuploader) - INFO - Open directory for files ... 08:48:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:48:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:48:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:49:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:49:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:49:02 INFO - (blobuploader) - INFO - Done attempting. 08:49:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:49:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:49:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:49:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:49:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:49:03 INFO - (blobuploader) - INFO - Done attempting. 08:49:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:49:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:49:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:49:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:49:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:49:03 INFO - (blobuploader) - INFO - Done attempting. 08:49:03 INFO - (blobuploader) - INFO - Iteration through files over. 08:49:03 INFO - Return code: 0 08:49:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:49:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:49:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f347c9d9af9846068c16ed76e5bf8d8eb3abf94f4e3c278a42390521615cbaa6ee2b8ae0866e124aac88b296140025429881f83eb0332d56b81ed06a1fde4fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9511b1e710c08fce9e3cd3f40af1379e999de69958a848a9f712ac15ab754f19e12335abc2fdda5707cd7322ad417e332ec51da74b28d7d8747d7e3cab11dbef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/62adfbfaa81368b2b7c48c5393c1097a7f1c75f3c5e0771857deea6cefbac897e127f3bcb83d2e95e52984d0ed78bc63aa47ffb3f1339d7468e300b268bbc15a"} 08:49:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:49:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:49:03 INFO - Contents: 08:49:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1f347c9d9af9846068c16ed76e5bf8d8eb3abf94f4e3c278a42390521615cbaa6ee2b8ae0866e124aac88b296140025429881f83eb0332d56b81ed06a1fde4fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9511b1e710c08fce9e3cd3f40af1379e999de69958a848a9f712ac15ab754f19e12335abc2fdda5707cd7322ad417e332ec51da74b28d7d8747d7e3cab11dbef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/62adfbfaa81368b2b7c48c5393c1097a7f1c75f3c5e0771857deea6cefbac897e127f3bcb83d2e95e52984d0ed78bc63aa47ffb3f1339d7468e300b268bbc15a"} 08:49:03 INFO - Running post-run listener: copy_logs_to_upload_dir 08:49:03 INFO - Copying logs to upload dir... 08:49:03 INFO - mkdir: /builds/slave/test/build/upload/logs 08:49:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.302995 ========= master_lag: 0.68 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-11-25 08:49:04.427179) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-25 08:49:04.435913) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1480084147.965414-419295775 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/1f347c9d9af9846068c16ed76e5bf8d8eb3abf94f4e3c278a42390521615cbaa6ee2b8ae0866e124aac88b296140025429881f83eb0332d56b81ed06a1fde4fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9511b1e710c08fce9e3cd3f40af1379e999de69958a848a9f712ac15ab754f19e12335abc2fdda5707cd7322ad417e332ec51da74b28d7d8747d7e3cab11dbef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/62adfbfaa81368b2b7c48c5393c1097a7f1c75f3c5e0771857deea6cefbac897e127f3bcb83d2e95e52984d0ed78bc63aa47ffb3f1339d7468e300b268bbc15a"} build_url:https://queue.taskcluster.net/v1/task/UvdwyDJuSF63hDWYVlWZSg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011371 build_url: 'https://queue.taskcluster.net/v1/task/UvdwyDJuSF63hDWYVlWZSg/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/1f347c9d9af9846068c16ed76e5bf8d8eb3abf94f4e3c278a42390521615cbaa6ee2b8ae0866e124aac88b296140025429881f83eb0332d56b81ed06a1fde4fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9511b1e710c08fce9e3cd3f40af1379e999de69958a848a9f712ac15ab754f19e12335abc2fdda5707cd7322ad417e332ec51da74b28d7d8747d7e3cab11dbef", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/62adfbfaa81368b2b7c48c5393c1097a7f1c75f3c5e0771857deea6cefbac897e127f3bcb83d2e95e52984d0ed78bc63aa47ffb3f1339d7468e300b268bbc15a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-25 08:49:04.464642) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 08:49:04.465023) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1480084147.965414-419295775 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004509 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-25 08:49:04.519237) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-25 08:49:04.521638) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-25 08:49:04.522005) ========= ========= Total master_lag: 0.82 =========