builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-054 starttime: 1480781333.53 results: success (0) buildid: 20161203062844 builduid: 91922d5fece94bc2aba7341ec5c85ab4 revision: c21f4124a5b79b9989579efa33edc20795692af2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-03 08:08:53.528287) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-03 08:08:53.528739) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-03 08:08:53.529151) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-03 08:08:53.544018) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 08:08:53.544338) ========= 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=cbe409c6de289db6ac707de3000001d4-1480779155.676801-352532681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-03 08:08:54-- 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% 63.3K=0.2s 2016-12-03 08:08:54 (63.3 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.312299 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 08:08:53.873448) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 08:08:53.873815) ========= 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=cbe409c6de289db6ac707de3000001d4-1480779155.676801-352532681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016626 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 08:08:53.929090) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 08:08:53.929555) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev c21f4124a5b79b9989579efa33edc20795692af2 --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 c21f4124a5b79b9989579efa33edc20795692af2 --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=cbe409c6de289db6ac707de3000001d4-1480779155.676801-352532681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-03 08:08:54,538 truncating revision to first 12 chars 2016-12-03 08:08:54,538 Setting DEBUG logging. 2016-12-03 08:08:54,538 attempt 1/10 2016-12-03 08:08:54,538 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/c21f4124a5b7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-03 08:08:54,857 unpacking tar archive at: mozilla-aurora-c21f4124a5b7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.607110 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 08:08:54.551910) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-03 08:08:54.552276) ========= script_repo_revision: c21f4124a5b79b9989579efa33edc20795692af2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-03 08:08:54.553126) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-03 08:08:54.553450) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-03 08:08:54.568052) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-12-03 08:08:54.568400) ========= /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=cbe409c6de289db6ac707de3000001d4-1480779155.676801-352532681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:08:55 INFO - MultiFileLogger online at 20161203 08:08:55 in /builds/slave/test 08:08:55 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:08:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:08:55 INFO - {'append_to_log': False, 08:08:55 INFO - 'base_work_dir': '/builds/slave/test', 08:08:55 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:08:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:08:55 INFO - 'branch': 'Mozilla-Aurora', 08:08:55 INFO - 'buildbot_json_path': 'buildprops.json', 08:08:55 INFO - 'config_files': ('talos/linux_config.py',), 08:08:55 INFO - 'default_actions': ('clobber', 08:08:55 INFO - 'read-buildbot-config', 08:08:55 INFO - 'download-and-extract', 08:08:55 INFO - 'populate-webroot', 08:08:55 INFO - 'create-virtualenv', 08:08:55 INFO - 'install', 08:08:55 INFO - 'run-tests'), 08:08:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:08:55 INFO - 'download_minidump_stackwalk': True, 08:08:55 INFO - 'download_symbols': 'ondemand', 08:08:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:08:55 INFO - 'tooltool.py': '/tools/tooltool.py', 08:08:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:08:55 INFO - '/tools/misc-python/virtualenv.py')}, 08:08:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:08:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:08:55 INFO - 'installer_path': 'installer.exe', 08:08:55 INFO - 'log_level': 'info', 08:08:55 INFO - 'log_name': 'talos', 08:08:55 INFO - 'log_to_console': True, 08:08:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:08:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:08:55 INFO - 'opt_config_files': (), 08:08:55 INFO - 'pip_index': False, 08:08:55 INFO - 'sps_profile': False, 08:08:55 INFO - 'sps_profile_interval': 0, 08:08:55 INFO - 'suite': 'dromaeojs', 08:08:55 INFO - 'system_bits': '32', 08:08:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:08:55 INFO - 'title': 'talos-linux64-ix-054', 08:08:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:08:55 INFO - 'use_talos_json': True, 08:08:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:08:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:08:55 INFO - 'work_dir': 'build'} 08:08:55 INFO - [mozharness: 2016-12-03 16:08:55.275547Z] Running clobber step. 08:08:55 INFO - Running pre-action listener: _resource_record_pre_action 08:08:55 INFO - Running main action method: clobber 08:08:55 INFO - rmtree: /builds/slave/test/build 08:08:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:08:55 INFO - Running post-action listener: _resource_record_post_action 08:08:55 INFO - [mozharness: 2016-12-03 16:08:55.734113Z] Finished clobber step (success) 08:08:55 INFO - [mozharness: 2016-12-03 16:08:55.734213Z] Running read-buildbot-config step. 08:08:55 INFO - Running pre-action listener: _resource_record_pre_action 08:08:55 INFO - Running main action method: read_buildbot_config 08:08:55 INFO - Using buildbot properties: 08:08:55 INFO - { 08:08:55 INFO - "project": "", 08:08:55 INFO - "product": "firefox", 08:08:55 INFO - "script_repo_revision": "production", 08:08:55 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:08:55 INFO - "repository": "", 08:08:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 08:08:55 INFO - "buildid": "20161203062844", 08:08:55 INFO - "pgo_build": "True", 08:08:55 INFO - "basedir": "/builds/slave/test", 08:08:55 INFO - "buildnumber": 627, 08:08:55 INFO - "slavename": "talos-linux64-ix-054", 08:08:55 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:08:55 INFO - "platform": "ubuntu64_hw", 08:08:55 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:08:55 INFO - "branch": "mozilla-aurora", 08:08:55 INFO - "repo_path": "releases/mozilla-aurora", 08:08:55 INFO - "revision": "c21f4124a5b79b9989579efa33edc20795692af2", 08:08:55 INFO - "stage_platform": "linux64-pgo", 08:08:55 INFO - "builduid": "91922d5fece94bc2aba7341ec5c85ab4", 08:08:55 INFO - "slavebuilddir": "test" 08:08:55 INFO - } 08:08:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/GMLK47MJRT-aPgSee8NGXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 08:08:55 INFO - Running post-action listener: _resource_record_post_action 08:08:55 INFO - [mozharness: 2016-12-03 16:08:55.736659Z] Finished read-buildbot-config step (success) 08:08:55 INFO - [mozharness: 2016-12-03 16:08:55.736748Z] Running download-and-extract step. 08:08:55 INFO - Running pre-action listener: _resource_record_pre_action 08:08:55 INFO - Running main action method: download_and_extract 08:08:55 INFO - mkdir: /builds/slave/test/build/tests 08:08:55 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:08:55 INFO - trying https://queue.taskcluster.net/v1/task/GMLK47MJRT-aPgSee8NGXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:08:55 INFO - Downloading https://queue.taskcluster.net/v1/task/GMLK47MJRT-aPgSee8NGXg/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:08:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GMLK47MJRT-aPgSee8NGXg/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:08:56 INFO - Downloaded 1361 bytes. 08:08:56 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:08:56 INFO - Using the following test package requirements: 08:08:56 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:08:56 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:08:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:08:56 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:08:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:08:56 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:08:56 INFO - u'jsshell-linux-x86_64.zip'], 08:08:56 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:08:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:08:56 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:08:56 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:08:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:08:56 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:08:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:08:56 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:08:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:08:56 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:08:56 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:08:56 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:08:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GMLK47MJRT-aPgSee8NGXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:08:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GMLK47MJRT-aPgSee8NGXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:08:56 INFO - Fetch https://queue.taskcluster.net/v1/task/GMLK47MJRT-aPgSee8NGXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:08:56 INFO - Http code: 200 08:08:56 INFO - via: 1.1 b3bccc0e4c2cc0a33e7e8308d88cacdd.cloudfront.net (CloudFront) 08:08:56 INFO - x-amz-cf-id: ueWJABrkfeET6a9ZN81b45Mu_wsuZrMqvRzumi-zcygm0jilwas5WA== 08:08:56 INFO - x-amz-version-id: dRJS6sM4_diAUDHAvL15ALf18qShVSsq 08:08:57 INFO - Expected file size: 21954941 08:08:57 INFO - Obtained file size: 21954941 08:09:01 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:09:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GMLK47MJRT-aPgSee8NGXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:09:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GMLK47MJRT-aPgSee8NGXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:09:01 INFO - Fetch https://queue.taskcluster.net/v1/task/GMLK47MJRT-aPgSee8NGXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:09:01 INFO - Http code: 200 08:09:01 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 08:09:01 INFO - x-amz-cf-id: SQOAKDV9aEJoaypXo9qmSV12oPs7JW12gRiGnLPzutnvMZIH55sSIA== 08:09:01 INFO - x-amz-version-id: dRJS6sM4_diAUDHAvL15ALf18qShVSsq 08:09:02 INFO - Expected file size: 21954941 08:09:02 INFO - Obtained file size: 21954941 08:09:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GMLK47MJRT-aPgSee8NGXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 08:09:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GMLK47MJRT-aPgSee8NGXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:09:06 INFO - Fetch https://queue.taskcluster.net/v1/task/GMLK47MJRT-aPgSee8NGXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 08:09:07 INFO - Http code: 200 08:09:07 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 08:09:07 INFO - x-amz-cf-id: r0W8XmgJrmBcuEabuAw3vTYUxup0olqkxyBzM0YBrxG19CazpMLnHw== 08:09:07 INFO - x-amz-version-id: dkQYXjQyiYOHXWb91l_fQfEc5_dkQ8ug 08:09:08 INFO - Expected file size: 14409038 08:09:08 INFO - Obtained file size: 14409038 08:09:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:08 INFO - trying https://queue.taskcluster.net/v1/task/GMLK47MJRT-aPgSee8NGXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:09:08 INFO - Downloading https://queue.taskcluster.net/v1/task/GMLK47MJRT-aPgSee8NGXg/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:09:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GMLK47MJRT-aPgSee8NGXg/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:09:11 INFO - Downloaded 63995854 bytes. 08:09:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GMLK47MJRT-aPgSee8NGXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:09:11 INFO - mkdir: /builds/slave/test/properties 08:09:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:09:11 INFO - Writing to file /builds/slave/test/properties/build_url 08:09:11 INFO - Contents: 08:09:11 INFO - build_url:https://queue.taskcluster.net/v1/task/GMLK47MJRT-aPgSee8NGXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:09:11 INFO - Running post-action listener: _resource_record_post_action 08:09:11 INFO - Running post-action listener: set_extra_try_arguments 08:09:11 INFO - [mozharness: 2016-12-03 16:09:11.920444Z] Finished download-and-extract step (success) 08:09:11 INFO - [mozharness: 2016-12-03 16:09:11.920671Z] Running populate-webroot step. 08:09:11 INFO - Running pre-action listener: _resource_record_pre_action 08:09:11 INFO - Running main action method: populate_webroot 08:09:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:09:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:09:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:09:11 INFO - '--tppagecycles', 08:09:11 INFO - '7'], 08:09:11 INFO - 'tests': ['tsvgm']}}, 08:09:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:09:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:09:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:09:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:09:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:09:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:09:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:11 INFO - 'talos_options': ['--disable-e10s'], 08:09:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:09:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:09:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:11 INFO - 'talos_options': ['--disable-e10s'], 08:09:11 INFO - 'tests': ['damp', 'tps']}, 08:09:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:11 INFO - 'tests': ['damp', 'tps']}, 08:09:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:09:11 INFO - 'tests': ['dromaeo_dom']}, 08:09:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:09:11 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:09:11 INFO - 'tests': ['basic_compositor_video']}, 08:09:11 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:09:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:09:11 INFO - 'tests': ['a11yr', 08:09:11 INFO - 'ts_paint', 08:09:11 INFO - 'tpaint', 08:09:11 INFO - 'sessionrestore', 08:09:11 INFO - 'sessionrestore_no_auto_restore', 08:09:11 INFO - 'tabpaint']}, 08:09:11 INFO - 'other-e10s': {'tests': ['a11yr', 08:09:11 INFO - 'ts_paint', 08:09:11 INFO - 'tpaint', 08:09:11 INFO - 'sessionrestore', 08:09:11 INFO - 'sessionrestore_no_auto_restore', 08:09:11 INFO - 'tabpaint']}, 08:09:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:09:11 INFO - 'ts_paint', 08:09:11 INFO - 'tpaint', 08:09:11 INFO - 'sessionrestore', 08:09:11 INFO - 'sessionrestore_no_auto_restore', 08:09:11 INFO - 'tabpaint']}, 08:09:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:09:11 INFO - 'ts_paint', 08:09:11 INFO - 'tpaint', 08:09:11 INFO - 'sessionrestore', 08:09:11 INFO - 'sessionrestore_no_auto_restore', 08:09:11 INFO - 'tabpaint']}, 08:09:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:09:11 INFO - 'tests': ['a11yr', 08:09:11 INFO - 'ts_paint', 08:09:11 INFO - 'tpaint', 08:09:11 INFO - 'sessionrestore', 08:09:11 INFO - 'sessionrestore_no_auto_restore', 08:09:11 INFO - 'tabpaint']}, 08:09:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:09:11 INFO - 'tests': ['a11yr', 08:09:11 INFO - 'ts_paint', 08:09:11 INFO - 'tpaint', 08:09:11 INFO - 'sessionrestore', 08:09:11 INFO - 'sessionrestore_no_auto_restore', 08:09:11 INFO - 'tabpaint']}, 08:09:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:09:11 INFO - 'tests': ['tsvgx', 08:09:11 INFO - 'tsvgr_opacity', 08:09:11 INFO - 'tart', 08:09:11 INFO - 'tscrollx', 08:09:11 INFO - 'cart']}, 08:09:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:09:11 INFO - 'tsvgr_opacity', 08:09:11 INFO - 'tart', 08:09:11 INFO - 'tscrollx', 08:09:11 INFO - 'cart']}, 08:09:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:11 INFO - 'talos_options': ['--disable-e10s'], 08:09:11 INFO - 'tests': ['tp5o']}, 08:09:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:11 INFO - 'tests': ['tp5o']}, 08:09:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:11 INFO - 'talos_options': ['--disable-e10s', 08:09:11 INFO - '--xperf_path', 08:09:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:09:11 INFO - 'tests': ['tp5n']}, 08:09:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:11 INFO - 'talos_options': ['--xperf_path', 08:09:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:09:11 INFO - 'tests': ['tp5n']}}, 08:09:11 INFO - 'talos.zip': {'path': '', 08:09:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:09:11 INFO - Running post-action listener: _resource_record_post_action 08:09:11 INFO - [mozharness: 2016-12-03 16:09:11.939294Z] Finished populate-webroot step (success) 08:09:11 INFO - [mozharness: 2016-12-03 16:09:11.939383Z] Running create-virtualenv step. 08:09:11 INFO - Running pre-action listener: _resource_record_pre_action 08:09:11 INFO - Running main action method: create_virtualenv 08:09:11 INFO - Creating virtualenv /builds/slave/test/build/venv 08:09:11 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:09:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:09:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:09:12 INFO - Using real prefix '/usr' 08:09:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:09:12 INFO - Installing distribute.............................................................................................................................................................................................done. 08:09:14 INFO - Installing pip.................done. 08:09:14 INFO - Return code: 0 08:09:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:09:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:09:14 INFO - Reading from file tmpfile_stdout 08:09:14 INFO - Output received: 08:09:14 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:09:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:09:14 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:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:14 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:09:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:14 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 0x7f34aecf3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cdf60>, '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 0x22ced40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cf1d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1480779155.676801-352532681', '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:09:14 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:09:14 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:09:14 INFO - Using env: {'DISPLAY': ':0', 08:09:14 INFO - 'HOME': '/home/cltbld', 08:09:14 INFO - 'LANG': 'en_US.UTF-8', 08:09:14 INFO - 'LANGUAGE': 'en_US:en', 08:09:14 INFO - 'LOGNAME': 'cltbld', 08:09:14 INFO - 'MAIL': '/var/mail/cltbld', 08:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:14 INFO - 'MOZ_NO_REMOTE': '1', 08:09:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:14 INFO - 'NO_EM_RESTART': '1', 08:09:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:14 INFO - 'PWD': '/builds/slave/test', 08:09:14 INFO - 'SHELL': '/bin/bash', 08:09:14 INFO - 'SHLVL': '1', 08:09:14 INFO - 'TERM': 'linux', 08:09:14 INFO - 'TMOUT': '86400', 08:09:14 INFO - 'USER': 'cltbld', 08:09:14 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1480779155.676801-352532681', 08:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:14 INFO - '_': '/tools/buildbot/bin/python'} 08:09:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:14 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:09:14 INFO - Cleaning up... 08:09:14 INFO - Return code: 0 08:09:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:09:14 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:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:14 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:09:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:14 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 0x7f34aecf3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cdf60>, '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 0x22ced40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cf1d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1480779155.676801-352532681', '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:09:14 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:09:14 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:09:14 INFO - Using env: {'DISPLAY': ':0', 08:09:14 INFO - 'HOME': '/home/cltbld', 08:09:14 INFO - 'LANG': 'en_US.UTF-8', 08:09:14 INFO - 'LANGUAGE': 'en_US:en', 08:09:14 INFO - 'LOGNAME': 'cltbld', 08:09:14 INFO - 'MAIL': '/var/mail/cltbld', 08:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:14 INFO - 'MOZ_NO_REMOTE': '1', 08:09:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:14 INFO - 'NO_EM_RESTART': '1', 08:09:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:14 INFO - 'PWD': '/builds/slave/test', 08:09:14 INFO - 'SHELL': '/bin/bash', 08:09:14 INFO - 'SHLVL': '1', 08:09:14 INFO - 'TERM': 'linux', 08:09:14 INFO - 'TMOUT': '86400', 08:09:14 INFO - 'USER': 'cltbld', 08:09:14 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1480779155.676801-352532681', 08:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:14 INFO - '_': '/tools/buildbot/bin/python'} 08:09:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:15 INFO - Downloading/unpacking psutil>=3.1.1 08:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:09:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:09:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:09:17 INFO - Installing collected packages: psutil 08:09:17 INFO - Running setup.py install for psutil 08:09:17 INFO - building 'psutil._psutil_linux' extension 08:09:17 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:09:17 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:09:17 INFO - building 'psutil._psutil_posix' extension 08:09:17 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:09:17 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:09:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:09:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:09:17 INFO - Successfully installed psutil 08:09:17 INFO - Cleaning up... 08:09:17 INFO - Return code: 0 08:09:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:09:17 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:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:17 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:09:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:17 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 0x7f34aecf3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cdf60>, '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 0x22ced40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cf1d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1480779155.676801-352532681', '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:09:17 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:09:17 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:09:17 INFO - Using env: {'DISPLAY': ':0', 08:09:17 INFO - 'HOME': '/home/cltbld', 08:09:17 INFO - 'LANG': 'en_US.UTF-8', 08:09:17 INFO - 'LANGUAGE': 'en_US:en', 08:09:17 INFO - 'LOGNAME': 'cltbld', 08:09:17 INFO - 'MAIL': '/var/mail/cltbld', 08:09:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:17 INFO - 'MOZ_NO_REMOTE': '1', 08:09:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:17 INFO - 'NO_EM_RESTART': '1', 08:09:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:17 INFO - 'PWD': '/builds/slave/test', 08:09:17 INFO - 'SHELL': '/bin/bash', 08:09:17 INFO - 'SHLVL': '1', 08:09:17 INFO - 'TERM': 'linux', 08:09:17 INFO - 'TMOUT': '86400', 08:09:17 INFO - 'USER': 'cltbld', 08:09:17 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1480779155.676801-352532681', 08:09:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:17 INFO - '_': '/tools/buildbot/bin/python'} 08:09:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:09:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:09:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:09:20 INFO - Installing collected packages: mozsystemmonitor 08:09:20 INFO - Running setup.py install for mozsystemmonitor 08:09:20 INFO - Successfully installed mozsystemmonitor 08:09:20 INFO - Cleaning up... 08:09:20 INFO - Return code: 0 08:09:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:09:20 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:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:20 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:09:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:20 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 0x7f34aecf3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cdf60>, '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 0x22ced40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cf1d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1480779155.676801-352532681', '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:09:20 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:09:20 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:09:20 INFO - Using env: {'DISPLAY': ':0', 08:09:20 INFO - 'HOME': '/home/cltbld', 08:09:20 INFO - 'LANG': 'en_US.UTF-8', 08:09:20 INFO - 'LANGUAGE': 'en_US:en', 08:09:20 INFO - 'LOGNAME': 'cltbld', 08:09:20 INFO - 'MAIL': '/var/mail/cltbld', 08:09:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:20 INFO - 'MOZ_NO_REMOTE': '1', 08:09:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:20 INFO - 'NO_EM_RESTART': '1', 08:09:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:20 INFO - 'PWD': '/builds/slave/test', 08:09:20 INFO - 'SHELL': '/bin/bash', 08:09:20 INFO - 'SHLVL': '1', 08:09:20 INFO - 'TERM': 'linux', 08:09:20 INFO - 'TMOUT': '86400', 08:09:20 INFO - 'USER': 'cltbld', 08:09:20 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1480779155.676801-352532681', 08:09:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:20 INFO - '_': '/tools/buildbot/bin/python'} 08:09:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:20 INFO - Downloading/unpacking jsonschema==2.5.1 08:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:09:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:09:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:09:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:09:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:09:22 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:09:22 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:09:22 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:09:22 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:09:22 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:09:22 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:09:22 INFO - Downloading functools32-3.2.3-2.tar.gz 08:09:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:09:22 INFO - warning: no files found matching '*.txt' 08:09:22 INFO - no previously-included directories found matching 'build' 08:09:22 INFO - no previously-included directories found matching 'dist' 08:09:22 INFO - no previously-included directories found matching '.git*' 08:09:22 INFO - Installing collected packages: jsonschema, functools32 08:09:22 INFO - Running setup.py install for functools32 08:09:22 INFO - warning: no files found matching '*.txt' 08:09:22 INFO - no previously-included directories found matching 'build' 08:09:22 INFO - no previously-included directories found matching 'dist' 08:09:22 INFO - no previously-included directories found matching '.git*' 08:09:22 INFO - Successfully installed jsonschema functools32 08:09:22 INFO - Cleaning up... 08:09:22 INFO - Return code: 0 08:09:22 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:22 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 0x7f34aecf3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cdf60>, '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 0x22ced40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cf1d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1480779155.676801-352532681', '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:09:22 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:09:22 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:09:22 INFO - Using env: {'DISPLAY': ':0', 08:09:22 INFO - 'HOME': '/home/cltbld', 08:09:22 INFO - 'LANG': 'en_US.UTF-8', 08:09:22 INFO - 'LANGUAGE': 'en_US:en', 08:09:22 INFO - 'LOGNAME': 'cltbld', 08:09:22 INFO - 'MAIL': '/var/mail/cltbld', 08:09:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:22 INFO - 'MOZ_NO_REMOTE': '1', 08:09:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:22 INFO - 'NO_EM_RESTART': '1', 08:09:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:22 INFO - 'PWD': '/builds/slave/test', 08:09:22 INFO - 'SHELL': '/bin/bash', 08:09:22 INFO - 'SHLVL': '1', 08:09:22 INFO - 'TERM': 'linux', 08:09:22 INFO - 'TMOUT': '86400', 08:09:22 INFO - 'USER': 'cltbld', 08:09:22 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1480779155.676801-352532681', 08:09:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:22 INFO - '_': '/tools/buildbot/bin/python'} 08:09:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:09:23 INFO - Cleaning up... 08:09:23 INFO - Return code: 0 08:09:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f34aecf3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cdf60>, '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 0x22ced40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cf1d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1480779155.676801-352532681', '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:09:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:09:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:09:23 INFO - Using env: {'DISPLAY': ':0', 08:09:23 INFO - 'HOME': '/home/cltbld', 08:09:23 INFO - 'LANG': 'en_US.UTF-8', 08:09:23 INFO - 'LANGUAGE': 'en_US:en', 08:09:23 INFO - 'LOGNAME': 'cltbld', 08:09:23 INFO - 'MAIL': '/var/mail/cltbld', 08:09:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:23 INFO - 'MOZ_NO_REMOTE': '1', 08:09:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:23 INFO - 'NO_EM_RESTART': '1', 08:09:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:23 INFO - 'PWD': '/builds/slave/test', 08:09:23 INFO - 'SHELL': '/bin/bash', 08:09:23 INFO - 'SHLVL': '1', 08:09:23 INFO - 'TERM': 'linux', 08:09:23 INFO - 'TMOUT': '86400', 08:09:23 INFO - 'USER': 'cltbld', 08:09:23 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1480779155.676801-352532681', 08:09:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:23 INFO - '_': '/tools/buildbot/bin/python'} 08:09:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:23 INFO - Downloading/unpacking blobuploader==1.2.4 08:09:23 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:09:23 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:09:23 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:09:23 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:09:23 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:09:23 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:09:25 INFO - Downloading blobuploader-1.2.4.tar.gz 08:09:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:09:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:09:25 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:09:25 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:09:25 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:09:25 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:09:25 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:09:25 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:09:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:09:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:09:25 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:09:25 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:09:25 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:09:25 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:09:25 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:09:25 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:09:26 INFO - Downloading docopt-0.6.1.tar.gz 08:09:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:09:26 INFO - Installing collected packages: blobuploader, requests, docopt 08:09:26 INFO - Running setup.py install for blobuploader 08:09:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:09:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:09:26 INFO - Running setup.py install for requests 08:09:26 INFO - Running setup.py install for docopt 08:09:26 INFO - Successfully installed blobuploader requests docopt 08:09:26 INFO - Cleaning up... 08:09:26 INFO - Return code: 0 08:09:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09:26 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:09:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:26 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:09:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:26 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 0x7f34aecf3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cdf60>, '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 0x22ced40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cf1d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1480779155.676801-352532681', '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:09:26 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:09:26 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:09:26 INFO - Using env: {'DISPLAY': ':0', 08:09:26 INFO - 'HOME': '/home/cltbld', 08:09:26 INFO - 'LANG': 'en_US.UTF-8', 08:09:26 INFO - 'LANGUAGE': 'en_US:en', 08:09:26 INFO - 'LOGNAME': 'cltbld', 08:09:26 INFO - 'MAIL': '/var/mail/cltbld', 08:09:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:26 INFO - 'MOZ_NO_REMOTE': '1', 08:09:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:26 INFO - 'NO_EM_RESTART': '1', 08:09:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:26 INFO - 'PWD': '/builds/slave/test', 08:09:26 INFO - 'SHELL': '/bin/bash', 08:09:26 INFO - 'SHLVL': '1', 08:09:26 INFO - 'TERM': 'linux', 08:09:26 INFO - 'TMOUT': '86400', 08:09:26 INFO - 'USER': 'cltbld', 08:09:26 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1480779155.676801-352532681', 08:09:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:26 INFO - '_': '/tools/buildbot/bin/python'} 08:09:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:09:26 INFO - Running setup.py (path:/tmp/pip-uUAagz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:09:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:09:26 INFO - Running setup.py (path:/tmp/pip-5qadES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:09:27 INFO - Running setup.py (path:/tmp/pip-xUlXnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:09:27 INFO - Running setup.py (path:/tmp/pip-eEONoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:09:27 INFO - Running setup.py (path:/tmp/pip-OIFWXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:09:27 INFO - Running setup.py (path:/tmp/pip-o8qIRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:09:27 INFO - Running setup.py (path:/tmp/pip-MLhyoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:09:27 INFO - Running setup.py (path:/tmp/pip-CWRscQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:09:27 INFO - Running setup.py (path:/tmp/pip-qpQbd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:09:27 INFO - Running setup.py (path:/tmp/pip-sNFFr8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:09:27 INFO - Running setup.py (path:/tmp/pip-Xewp8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:09:27 INFO - Running setup.py (path:/tmp/pip-13_Iwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:09:27 INFO - Running setup.py (path:/tmp/pip-oEOH2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:09:27 INFO - Running setup.py (path:/tmp/pip-_0LZaU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:27 INFO - Running setup.py (path:/tmp/pip-jAQXDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:09:27 INFO - Running setup.py (path:/tmp/pip-TASK4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:09:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:09:28 INFO - Running setup.py (path:/tmp/pip-pgTVBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:09:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:09:28 INFO - Running setup.py install for manifestparser 08:09:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:09:28 INFO - Running setup.py install for mozcrash 08:09:28 INFO - Running setup.py install for mozdebug 08:09:28 INFO - Running setup.py install for mozdevice 08:09:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:09:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:09:28 INFO - Running setup.py install for mozfile 08:09:28 INFO - Running setup.py install for mozhttpd 08:09:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:09:28 INFO - Running setup.py install for mozinfo 08:09:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:09:28 INFO - Running setup.py install for mozInstall 08:09:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:09:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:09:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:09:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:09:28 INFO - Running setup.py install for mozleak 08:09:29 INFO - Running setup.py install for mozlog 08:09:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:09:29 INFO - Running setup.py install for moznetwork 08:09:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:09:29 INFO - Running setup.py install for mozprocess 08:09:29 INFO - Running setup.py install for mozprofile 08:09:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:09:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:09:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:09:29 INFO - Running setup.py install for mozrunner 08:09:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:09:29 INFO - Running setup.py install for mozscreenshot 08:09:29 INFO - Running setup.py install for moztest 08:09:29 INFO - Running setup.py install for mozversion 08:09:29 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:09:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:09:29 INFO - Cleaning up... 08:09:29 INFO - Return code: 0 08:09:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09:29 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:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:29 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:09:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:29 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 0x7f34aecf3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cdf60>, '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 0x22ced40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cf1d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1480779155.676801-352532681', '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:09:29 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:09:29 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:09:29 INFO - Using env: {'DISPLAY': ':0', 08:09:29 INFO - 'HOME': '/home/cltbld', 08:09:29 INFO - 'LANG': 'en_US.UTF-8', 08:09:29 INFO - 'LANGUAGE': 'en_US:en', 08:09:29 INFO - 'LOGNAME': 'cltbld', 08:09:29 INFO - 'MAIL': '/var/mail/cltbld', 08:09:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:29 INFO - 'MOZ_NO_REMOTE': '1', 08:09:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:29 INFO - 'NO_EM_RESTART': '1', 08:09:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:29 INFO - 'PWD': '/builds/slave/test', 08:09:29 INFO - 'SHELL': '/bin/bash', 08:09:29 INFO - 'SHLVL': '1', 08:09:29 INFO - 'TERM': 'linux', 08:09:29 INFO - 'TMOUT': '86400', 08:09:29 INFO - 'USER': 'cltbld', 08:09:29 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1480779155.676801-352532681', 08:09:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:29 INFO - '_': '/tools/buildbot/bin/python'} 08:09:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:09:30 INFO - Running setup.py (path:/tmp/pip-KfCMuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:09:30 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:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:09:30 INFO - Running setup.py (path:/tmp/pip-8KPIeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:09:30 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:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:09:30 INFO - Running setup.py (path:/tmp/pip-f32gRm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:09:30 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:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:09:30 INFO - Running setup.py (path:/tmp/pip-ODNEWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:09:30 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:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:09:30 INFO - Running setup.py (path:/tmp/pip-094s1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:09:30 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:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:09:30 INFO - Running setup.py (path:/tmp/pip-9Xr_WU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:09:30 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:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:09:30 INFO - Running setup.py (path:/tmp/pip-VSpERT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:09:30 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:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:09:30 INFO - Running setup.py (path:/tmp/pip-R7UJzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:09:30 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:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:09:30 INFO - Running setup.py (path:/tmp/pip-8YemFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:09:30 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:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:09:30 INFO - Running setup.py (path:/tmp/pip-X9b9Mz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:09:30 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:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:09:30 INFO - Running setup.py (path:/tmp/pip-2CGZRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:09:30 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:09:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:09:30 INFO - Running setup.py (path:/tmp/pip-AsQfkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:09:31 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:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:09:31 INFO - Running setup.py (path:/tmp/pip-AoJxfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:09:31 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:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:09:31 INFO - Running setup.py (path:/tmp/pip-nnnpAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:09:31 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:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:31 INFO - Running setup.py (path:/tmp/pip-lgbRth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:31 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:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:09:31 INFO - Running setup.py (path:/tmp/pip-lpPHNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:09:31 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:09:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:09:31 INFO - Running setup.py (path:/tmp/pip-WoMPjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:09:31 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:09:31 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:09:31 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:09:31 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:09:31 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:09:31 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:09:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:09:31 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:09:31 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:09:31 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:09:31 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:09:31 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:09:31 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:09:33 INFO - Downloading blessings-1.6.tar.gz 08:09:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:09:33 INFO - Installing collected packages: blessings 08:09:33 INFO - Running setup.py install for blessings 08:09:33 INFO - Successfully installed blessings 08:09:33 INFO - Cleaning up... 08:09:33 INFO - Return code: 0 08:09:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:09:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:09:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:09:33 INFO - Reading from file tmpfile_stdout 08:09:33 INFO - Current package versions: 08:09:33 INFO - argparse == 1.2.1 08:09:33 INFO - blessings == 1.6 08:09:33 INFO - blobuploader == 1.2.4 08:09:33 INFO - docopt == 0.6.1 08:09:33 INFO - functools32 == 3.2.3-2 08:09:33 INFO - jsonschema == 2.5.1 08:09:33 INFO - manifestparser == 1.1 08:09:33 INFO - mozInstall == 1.12 08:09:33 INFO - mozcrash == 1.0 08:09:33 INFO - mozdebug == 0.1 08:09:33 INFO - mozdevice == 0.48 08:09:33 INFO - mozfile == 1.2 08:09:33 INFO - mozhttpd == 0.7 08:09:33 INFO - mozinfo == 0.9 08:09:33 INFO - mozleak == 0.1 08:09:33 INFO - mozlog == 3.4 08:09:33 INFO - moznetwork == 0.27 08:09:33 INFO - mozprocess == 0.23 08:09:33 INFO - mozprofile == 0.28 08:09:33 INFO - mozrunner == 6.13 08:09:33 INFO - mozscreenshot == 0.1 08:09:33 INFO - mozsystemmonitor == 0.3 08:09:33 INFO - moztest == 0.7 08:09:33 INFO - mozversion == 1.4 08:09:33 INFO - psutil == 3.1.1 08:09:33 INFO - requests == 1.2.3 08:09:33 INFO - wsgiref == 0.1.2 08:09:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09:33 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:09:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:33 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:09:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:33 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 0x7f34aecf3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cdf60>, '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 0x22ced40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cf1d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1480779155.676801-352532681', '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:09:33 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:09:33 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:09:33 INFO - Using env: {'DISPLAY': ':0', 08:09:33 INFO - 'HOME': '/home/cltbld', 08:09:33 INFO - 'LANG': 'en_US.UTF-8', 08:09:33 INFO - 'LANGUAGE': 'en_US:en', 08:09:33 INFO - 'LOGNAME': 'cltbld', 08:09:33 INFO - 'MAIL': '/var/mail/cltbld', 08:09:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:33 INFO - 'MOZ_NO_REMOTE': '1', 08:09:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:33 INFO - 'NO_EM_RESTART': '1', 08:09:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:33 INFO - 'PWD': '/builds/slave/test', 08:09:33 INFO - 'SHELL': '/bin/bash', 08:09:33 INFO - 'SHLVL': '1', 08:09:33 INFO - 'TERM': 'linux', 08:09:33 INFO - 'TMOUT': '86400', 08:09:33 INFO - 'USER': 'cltbld', 08:09:33 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1480779155.676801-352532681', 08:09:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:33 INFO - '_': '/tools/buildbot/bin/python'} 08:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:34 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:09:34 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:09:34 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:09:34 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:09:34 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:09:34 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:09:34 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:09:34 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:09:34 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:09:34 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:09:34 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:09:34 INFO - Cleaning up... 08:09:34 INFO - Return code: 0 08:09:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:09:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:34 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 0x7f34aecf3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d0ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cdf60>, '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 0x22ced40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cf1d0>, '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': 'cbe409c6de289db6ac707de3000001d4-1480779155.676801-352532681', '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:09:34 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:09:34 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:09:34 INFO - Using env: {'DISPLAY': ':0', 08:09:34 INFO - 'HOME': '/home/cltbld', 08:09:34 INFO - 'LANG': 'en_US.UTF-8', 08:09:34 INFO - 'LANGUAGE': 'en_US:en', 08:09:34 INFO - 'LOGNAME': 'cltbld', 08:09:34 INFO - 'MAIL': '/var/mail/cltbld', 08:09:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:34 INFO - 'MOZ_NO_REMOTE': '1', 08:09:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:34 INFO - 'NO_EM_RESTART': '1', 08:09:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:34 INFO - 'PWD': '/builds/slave/test', 08:09:34 INFO - 'SHELL': '/bin/bash', 08:09:34 INFO - 'SHLVL': '1', 08:09:34 INFO - 'TERM': 'linux', 08:09:34 INFO - 'TMOUT': '86400', 08:09:34 INFO - 'USER': 'cltbld', 08:09:34 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1480779155.676801-352532681', 08:09:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:34 INFO - '_': '/tools/buildbot/bin/python'} 08:09:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:09:34 INFO - Cleaning up... 08:09:34 INFO - Return code: 0 08:09:34 INFO - Running post-action listener: _resource_record_post_action 08:09:34 INFO - Running post-action listener: _start_resource_monitoring 08:09:34 INFO - Starting resource monitoring. 08:09:34 INFO - [mozharness: 2016-12-03 16:09:34.363855Z] Finished create-virtualenv step (success) 08:09:34 INFO - [mozharness: 2016-12-03 16:09:34.364355Z] Running install step. 08:09:34 INFO - Running pre-action listener: _resource_record_pre_action 08:09:34 INFO - Running main action method: install 08:09:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:09:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:09:34 INFO - Reading from file tmpfile_stdout 08:09:34 INFO - Detecting whether we're running mozinstall >=1.0... 08:09:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:09:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:09:34 INFO - Reading from file tmpfile_stdout 08:09:34 INFO - Output received: 08:09:34 INFO - Usage: mozinstall [options] installer 08:09:34 INFO - Options: 08:09:34 INFO - -h, --help show this help message and exit 08:09:34 INFO - -d DEST, --destination=DEST 08:09:34 INFO - Directory to install application into. [default: 08:09:34 INFO - "/builds/slave/test"] 08:09:34 INFO - --app=APP Application being installed. [default: firefox] 08:09:34 INFO - mkdir: /builds/slave/test/build/application 08:09:34 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:09:34 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:09:50 INFO - Reading from file tmpfile_stdout 08:09:50 INFO - Output received: 08:09:50 INFO - /builds/slave/test/build/application/firefox/firefox 08:09:50 INFO - Running post-action listener: _resource_record_post_action 08:09:50 INFO - [mozharness: 2016-12-03 16:09:50.581057Z] Finished install step (success) 08:09:50 INFO - [mozharness: 2016-12-03 16:09:50.581302Z] Running run-tests step. 08:09:50 INFO - Running pre-action listener: _resource_record_pre_action 08:09:50 INFO - Running main action method: run_tests 08:09:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:09:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:09:50 INFO - Python 2.7.3 08:09:50 INFO - Return code: 0 08:09:50 INFO - grabbing minidump binary from tooltool 08:09:50 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:09:50 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 0x22cdf60>, '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 0x22ced40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cf1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:09:50 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:09:50 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:09:50 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:09:50 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:09:50 INFO - Return code: 0 08:09:50 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:09:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:09:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:09:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:09:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:09:50 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/GMLK47MJRT-aPgSee8NGXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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:09:50 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/GMLK47MJRT-aPgSee8NGXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --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:09:50 INFO - Using env: {'DISPLAY': ':0', 08:09:50 INFO - 'HOME': '/home/cltbld', 08:09:50 INFO - 'LANG': 'en_US.UTF-8', 08:09:50 INFO - 'LANGUAGE': 'en_US:en', 08:09:50 INFO - 'LOGNAME': 'cltbld', 08:09:50 INFO - 'MAIL': '/var/mail/cltbld', 08:09:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:09:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:50 INFO - 'MOZ_NO_REMOTE': '1', 08:09:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:09:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:50 INFO - 'NO_EM_RESTART': '1', 08:09:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:50 INFO - 'PWD': '/builds/slave/test', 08:09:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:09:50 INFO - 'SHELL': '/bin/bash', 08:09:50 INFO - 'SHLVL': '1', 08:09:50 INFO - 'TERM': 'linux', 08:09:50 INFO - 'TMOUT': '86400', 08:09:50 INFO - 'USER': 'cltbld', 08:09:50 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1480779155.676801-352532681', 08:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:50 INFO - '_': '/tools/buildbot/bin/python'} 08:09:50 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/GMLK47MJRT-aPgSee8NGXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--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:09:50 INFO - mozversion application_buildid: 20161203062844 08:09:50 INFO - mozversion application_changeset: c21f4124a5b79b9989579efa33edc20795692af2 08:09:50 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:09:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:09:50 INFO - mozversion application_name: Firefox 08:09:50 INFO - mozversion application_remotingname: firefox-dev 08:09:50 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:09:50 INFO - mozversion application_vendor: Mozilla 08:09:50 INFO - mozversion application_version: 52.0a2 08:09:50 INFO - mozversion platform_buildid: 20161203062844 08:09:50 INFO - mozversion platform_changeset: c21f4124a5b79b9989579efa33edc20795692af2 08:09:50 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:09:50 INFO - mozversion platform_version: 52.0a2 08:09:50 INFO - using testdate: 1480781390 08:09:50 INFO - actual date: 1480781390 08:09:50 INFO - starting webserver on 'localhost:43946' 08:09:50 INFO - SUITE-START | Running 2 tests 08:09:50 INFO - TEST-START | dromaeo_css 08:09:50 INFO - operating with platform_type : linux_ 08:09:50 INFO - Initialising browser for dromaeo_css test... 08:09:50 INFO - TEST-INFO | started process 7924 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQlMVJn/profile http://localhost:43946/getInfo.html) 08:09:55 INFO - PROCESS | 7924 | __metrics Screen width/height:1600/1200 08:09:55 INFO - PROCESS | 7924 | colorDepth:24 08:09:55 INFO - PROCESS | 7924 | Browser inner width/height: 1024/697 08:09:55 INFO - PROCESS | 7924 | __metrics 08:09:55 INFO - PROCESS | 7924 | 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:09:55 INFO - PROCESS | 7924 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:09:56 INFO - PROCESS | 7924 | console.error: PushService: 08:09:56 INFO - PROCESS | 7924 | stateChangeProcessEnqueue: Error transitioning state 08:09:56 INFO - PROCESS | 7924 | UnknownError 08:09:56 INFO - TEST-INFO | 7924: exit 0 08:09:56 INFO - Browser initialized. 08:09:56 INFO - Running cycle 1/1 for dromaeo_css test... 08:09:56 INFO - TEST-INFO | started process 8015 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQlMVJn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:10:08 INFO - PROCESS | 8015 | RSS: Main: 144695296 08:10:08 INFO - PROCESS | 8015 | 08:11:00 INFO - PROCESS | 8015 | 1480781460378 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:13:10 INFO - PROCESS | 8015 | Cycle 1(1): loaded http://localhost:43946/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43946/tests/dromaeo/cssquery-ext.html) 08:13:11 INFO - PROCESS | 8015 | RSS: Main: 247656448 08:13:11 INFO - PROCESS | 8015 | 08:16:14 INFO - PROCESS | 8015 | Cycle 1(1): loaded http://localhost:43946/tests/dromaeo/cssquery-ext.html (next: http://localhost:43946/tests/dromaeo/cssquery-jquery.html) 08:16:14 INFO - PROCESS | 8015 | RSS: Main: 228188160 08:16:14 INFO - PROCESS | 8015 | 08:19:16 INFO - PROCESS | 8015 | Cycle 1(1): loaded http://localhost:43946/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43946/tests/dromaeo/cssquery-mootools.html) 08:19:17 INFO - PROCESS | 8015 | RSS: Main: 176807936 08:19:17 INFO - PROCESS | 8015 | 08:22:19 INFO - PROCESS | 8015 | Cycle 1(1): loaded http://localhost:43946/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43946/tests/dromaeo/cssquery-prototype.html) 08:22:20 INFO - PROCESS | 8015 | RSS: Main: 224907264 08:22:20 INFO - PROCESS | 8015 | 08:25:22 INFO - PROCESS | 8015 | Cycle 1(1): loaded http://localhost:43946/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43946/tests/dromaeo/cssquery-yui.html) 08:25:23 INFO - PROCESS | 8015 | RSS: Main: 176336896 08:25:23 INFO - PROCESS | 8015 | 08:28:25 INFO - PROCESS | 8015 | Cycle 1(1): loaded http://localhost:43946/tests/dromaeo/cssquery-yui.html (next: http://localhost:43946/tests/dromaeo/cssquery-dojo.html) 08:28:26 INFO - PROCESS | 8015 | RSS: Main: 256708608 08:28:26 INFO - PROCESS | 8015 | 08:28:26 INFO - PROCESS | 8015 | __start_tp_report 08:28:26 INFO - PROCESS | 8015 | _x_x_mozilla_page_load 08:28:26 INFO - PROCESS | 8015 | _x_x_mozilla_page_load_details 08:28:26 INFO - PROCESS | 8015 | |i|pagename|runs| 08:28:26 INFO - PROCESS | 8015 | |0;dojo.html;3205.871765129394;3258.4949332853407;3262.4290749118913;3286.671332866712;3292.3250733599616;5597.524210442112;5664.716764161796;5685.886282274352;5724.542036637069;5729.484346408823;5676.545876329894;5739.770409183638;5747.942520574793;5756.568257380703;5765.077587585987;5195.19474481455;5222.738863056851;5227.947720522803;5257.842264732045;5309.814156504523;5095.84712458625;5307.548858347045;5313.521783039526;5318.361796584415;5339.385970613371;5073.949260507403;5125.692458452505;5169.431362550116;5177.094008548508;5246.501582349671;5200.6099542534275;5223;5305.151175811851;5306;5341.599380046512;5000.774965126541;5123.923141152885;5201.687898726089;5249.396319423277;5264.6051546134195;5473.644213126134;5480.177973304037;5487.6981766002855;5562.888742225133;5623.268975033219;5879.412058794129;5898.849724303763;5991.64050156992;5992.131140984577;5993.61041532299;5905.143754155666;6040.12418199363;6051.062085376773;6057.485113765335;6058.818235452899;5563.36021357545;5594.021046316919;5640.238567793377;5640.492355687926;5670.489655930986;6175.59858609189;6183.5671502994355;6184.072389141575;6186.412290832363;6186.566940314135;5736.1682556029145;5960.910586341209;5974.731137098754;5985.581009329305;5986.760529578768;5865.237519122572;5941.197938278364;5999.940000600025;6010.429009244115;6110.480609148183;5998.580099393001;6003.459688628044;6021.096835474714;6025.15647809307;6062.242219722535;5981.043033114681;5983.910241346383;5984.401559843981;5991;6028.09578563219;4546.840860569931;4579.244424669892;4598.218302888517;4614.353990441341;4622.144903192853;4143.91712165755;4161;4168.124693814333;4188.85339013133;4189.329707246826;5722.198892155102;5731.312242530839;5735.053716136791;5737.971310143423;5740.397258287903;5862.912056319158;5906.2912450505355;5940.79207227745;5989.79035733756;6061.605995610271;5714;5715.199872017921;5723.370429252779;5730.7421166047625;5756.165356023437;5154.458781827929;5173.715445650525;5176.611754118456;5176.663516871391;5178.974105129526;6102.931986902363;6122.489639783254;6175.104609831639;6180.351063138396;6232.25212974446;5973.761049558143;6099.115628233792;6103.664298463627;6127.172831667668;6143.600665956698;6278.309385967448;6325.588836725598;6326.082718005955;6326.493880489457;6326.841828954313;5688.971555142198;5704.11586204139;5979.4618484336615;5986.910196347146;5990.191324171181;5852.4147585241135;5894.823155305176;5959.582829201914;5984.790532331522;6034.24571928509;5844.678542680023;5864.706764661835;5870.970645146747;5895.351511333835;5900.203472531153;5655.660660360227;5874.794382196603;5875.265591801025;5879.794207202727;5886.440788125121;5670.177824215383;5773.278340207474;5815.9709201453725;5820.70896455184;5890.970545147246;5900.822975310747;5919;5919.644821310735;5929.970350148222;5932.49573786233;5658.377578466283;5709.058005429058;5715.799947001835;5779.017567013701;5790.681512516852 08:28:26 INFO - PROCESS | 8015 | |1;ext.html;589.3840936221648;628.949684025278;631.4790298004147;669.701982617735;680.5644387591946;34068.82965585172;45679.31481027787;46496.8375790605;46645.53354466463;46666;47929.52070479294;48377.51622483774;48416.75791621046;48474.27288590674;48518.75740621301;8429.620667069967;8827.16141966512;8964;8974.50640214788;8985.326100542452;8423.747287581382;8648.913510864904;8654.394192406535;10639.414832184228;10811.297265677706;11011.229213955026;11035.227534072617;11036.448177591128;11048.06091482225;11049;10771.192160587949;10840.024397804196;10874.565017399294;10878.564857405694;10878.673639790819;10710.089642380408;10769.084627806646;10777.62278320255;10779.730506737316;10796.136309095253;44622.33066504005;44718.55281447209;44940.55059449429;44979.10041799179;45033.77483112564;3642.1076836175043;3696.5194524711883;3755.605661405568;3950.0914789598264;4292.463442069741;34250.48624270638;34251.143721406916;34362;34427;34771.478427823604;4402.5561952093885;4420.359047938063;4427.756473393962;4441.644668426518;4459.620932220765;359934;379178.10410948045;385015;385599;385698;67873;67891.66054169796;68159.65920170367;68286.31713682899;68334;40503;41756.37365439521;41759.164816703495;43756.12487750291;43876.12247755091;16854.831451685328;17025.48923532296;17029;17029.659406811796;17045.40341088056;11932.105092118127;11945.462454189583;11960.58137965167;11966.64100076999;11970.880291196976;19001.524961876064;19347.806521934883;19348.903255483634;19522.62095147003;20301.695474567892;7335.339819416172;7605.809854753565;7615.210425549992;7616.657250423744;7641.732539361207;1042.5985995391677;1107.7950579142723;1110.8778034416207;1113.9554417823358;1157.8205378166397;35374.11564710903;35527.11182220465;35646.64353356433;35741.46387804185;35764.105897352776;1044.2794471814423;1105.038616403718;1159.9884001160049;1176.1766763265578;1181.4506254591656;16570.254338554794;18402.815971840377;18616.255349786126;18671.81328186728;18924;542219;544142;546739;547598;548959;56553.717231414405;57810.13284800731;61900.38099619036;64221.35778642247;64339.356606433335;1385.1896640465238;1385.9168449893039;1413.893957953137;1428.7071150414347;1430.3134495442246;33877.66122338745;36311.455328170625;36548.63451365559;36597;36683;56757.71621142033;57461.425385745606;57495.7125214388;57546.7122664384;57570.712146439;469307;470932;472795;472802;473482;31536.526952096196;31825.8408707955;31857.203569910936;32055.839720801247;32149.517757234127;51939.48060519498;52071;52406;52624;53191.4680853202;44008.54361215949;44379.11241775211;44763;44887;45465.318020230385;43984;44299.557004429545;44323.11353772971;45908;46401.53598464107;44258.33612495751;45488.31767523556;45513.089738205716;45962.540374595825;46282.30576541287;38359.80820095993;40213.396799047456;40277.597224027384;40331.59668403278;40939.1812163761;30079.398412031198;30768.84615576908;31198.688013120485;31229.68770312268;31320.843395782875 08:28:26 INFO - PROCESS | 8015 | |2;jquery.html;384.23920637138445;427.3711345201524;431.5188564750303;435.09717336526717;445.86846880170367;15533.611659708513;18907.810921890796;20020.499487512818;21251.57496850062;21441.249556265535;20575.588488230227;21061;21085.578288434222;21127.366179014654;21347.786522134775;5636.549076073915;5831.154482600021;5906.61606995546;5908.970455147718;5908.970455147718;5606.103023516238;5857.76568937242;5858.1505681676135;5862.677552734598;5867.178594996704;5492.697901615409;5827.125931110346;5831.912521312183;5840.970795146019;5847.356790753014;5628.0713682242385;5714.885702285973;5723.771049158028;5724.542036637059;5731.570132240098;5107.106256405114;5117.437081920985;5124.436312005676;5165.63840531163;5420.24116623669;14893.47872824446;15142.772858407132;15201.543953681406;16547.669046619;24057.15799947011;2424.2727181845553;2557.8593177375237;2796.14717511159;2957.349383135707;3061.678523754996;10504.2647014709;10534;10828.675139745821;10961.013508784168;11418.086553075735;1970.6846904495355;1971.5761111361126;1983.0679580597096;2017.0923084611836;2053.9897300513553;75535;79297;83801.58099209526;92711.53644231803;94852;10415.479226038668;11451.198416110792;11633.185677002697;11798.941005294919;11897;15008.924955375373;15941.442049528443;15976;15976.600584985235;16576.17119144038;6664.433523150489;7699.730509432143;8055;8091.878621820678;8100.270975612223;7713.65288562016;7785.455018148788;8021.796730490473;8214.342852571779;8239.835203295901;5056.696598204119;5158.690478571298;5158.845234642967;5180;5270.92093618596;2075.2321640992627;2105.1368938735045;2144.991853828698;2154.2352464875057;2156.698062271283;905.3300557587338;1022.4274406332329;1052.4316868890867;1057.2916146182076;1121.0919155484085;20192;20702.378928632166;20896.05967731456;20989;21305.36083917485;989.7426669066094;1008.9243306752023;1014.8832884218261;1056.2078441169124;1115.8158903780786;10764.300320479144;11584.76830463386;11689.707757306136;11803.88196118045;11833.881661183277;173910;175582;176098;177299;510890;96215;101373;101828;103514.48242758738;104132;989.0554520432969;1008.5511947183579;1043.879953805307;1055.150603763962;1074.9623763168408;17399.30402783925;18008.639827203646;18176.09119544044;18239.908800455913;18689.90655046716;44754;45199.548004519536;45392.09215815731;45424.318635221156;45670.314945276514;59432.70283648554;60169;60795.08807367981;60848.69575652093;61594.0760888596;8949.507777072324;9181.127792859668;9256.768580785265;9288.674896378594;9424.29317801154;12837.550685725955;12880;13179.802302965654;13807.309634518033;14469.204193769443;10979.83530247031;11005.724856878642;11181.832272516082;11204.88795112071;11665.59170429065;11439.142064345373;11537.769244615229;11614.825777613512;11719.355435451133;11976.880231197925;10871.510782014986;10899.455027248765;11017.889821101686;11203.21577489568;11495;9137.862932055892;9189.081091890757;9224.584893679934;9315.580798864203;9369.578368973276;9856;10651.30766500175;10738;11031.22781405294;11334.60328888485 08:28:26 INFO - PROCESS | 8015 | |3;mootools.html;1393.4704812171385;1512.8638422541972;1545.4359158906998;1716.8369004944534;1840.6778813707597;7939.126696063436;8579.613917373717;8870.201681848632;8888.64445422184;9103.499307538083;8815.735527934155;8947.150020748019;8948.418352807063;8951.507667078307;8958.059403762609;2511.171313466556;2515.6855393075866;2531.898724051045;2534.3030666566656;2537.7716005559496;2422.358075110097;2495.2763698527406;2499.8875050622673;2508.423062695572;2513.969272598235;2477.4549599088173;2498.750124987505;2517.1567524879097;2518.534071196825;2525.7095434025046;2409.072507084776;2428.732839387666;2429.0405289910564;2432.878356082189;2455.7789798918093;2376.6791483149727;2402.25530085674;2420.649005894153;2431.598786200275;2461.90152393904;8826.514541700204;8894.59974301158;9040.77398065047;9113.0886911309;9122.133397327243;5451.427600101972;5611.186377975211;5611.7474713637985;5613.214150019001;5614.494695477427;3591.371509985768;3697.9445308320396;3773.1699026214187;3792.981035094807;3798.639129282714;1250.6248125562295;1265.1270623270007;1283.8716128387086;1303.3352989975085;1312.409415762901;12726.23642581448;12837.550685726048;12848.421821017982;12860.742785144244;12868.420921058574;4783.497732738012;4875.122477953932;4979.875503112378;5000.999999999927;5044.747762611854;10043.397396156253;10072.345297555636;10113.544890479947;10119.848202276971;10120.089191972758;5693.202951586698;5701.942980570224;5706.71466426677;5707;5708.400617935057;4515.458145022552;4716.646251531149;4839.733814640158;5228.529432351107;5250.842474725764;4031.455753473302;4092.6521245693853;4164.583541645872;4199.202151591249;4201.4538110046105;1261.2810697902107;1263.6335462715892;1282.8845403913692;1290.2387591320978;1292.689754458923;940.6942743608355;962.764122789921;968.9951550242204;969.2100937735722;980.2745967983641;5580.609357344947;5730.598858079978;5747.3677895431465;5854.590178687451;5908.124540523346;493.30444073855693;497.27149725652095;507.22394736053894;514.8687084793354;522.2531779555272;3918.9608103919168;3931.92136157281;3948.506436695413;3956.66368358687;3987;10650.573977040987;11181.608643697595;11194.216404851582;11211.047060999907;11264.493097810619;11106.833397499044;11110.111191104692;11126.61056863006;11128;11135.33188008722;8216.958915205505;8425.662973481114;8519.403641745143;8549.187827156411;8550.743477695554;5659.943400565941;5707.429257074259;5737.139429085503;5798.507126894261;5920.881582368243;9987.800243994934;10043.598256069676;10113.5448904798;10241.641542545975;10300;9398.624055037995;9711.223102151953;9915.256355773201;10536.631217907336;10647.148228141576;7611.771646850603;7723.073231212291;7724.806879828049;7793;7838.882416763639;8719.956400217958;8803.075677054074;8813.338999575186;8818.91181088181;8821.250193733604;7963.442559021045;7976.960115199619;7991.081025681889;8160.551169685724;8220.547869867214;7642.975140616808;7712.151663317143;7753.1859154787935;7987.760367188994;8008.079070906921;6957.721691132298;7033.753818616528;7088.716451341888;7240.420766338575;7291.38023268007;4863.562279394871;4884.340614017062;5011.699298042129;5064.240363945438;5073.86897503057;4946.307516947558;5097.057044446641;5187.740612969412;5243.475652434726;5284.577233821362 08:28:26 INFO - PROCESS | 8015 | |4;prototype.html;351.90322661268146;357.7567254267099;364.65175757151917;371.758357067906;372.114367804625;5333.493318134776;5468.425815289397;5480.232767412565;5487.6158668893195;5507.576666266845;5307.469253074691;5358.169483730018;5360.437154098822;5381.0045141648825;5385.434529374408;3863.497745293108;4093.385992101179;4345.608895199432;4347.347897815329;4351.6953813233085;4230.921115115657;4261.744295342274;4269.87190384289;4277.593628605277;4295.634871035965;4223.472065991751;4229.259879521087;4237.237297286487;4244.83020679174;4256.616904478597;4102.835886564534;4196.391523229146;4281.272183728758;4291.270484017708;4297.140571885604;3753.7560058596105;3806.352920003606;3840.9423858642144;3845.6346647068763;3864.806759662006;5178.585713142939;5180.6373553851245;5235.476452354734;5247.921281180786;5302.2841916341185;4750.978539613965;4852.902941941176;4912.238603016503;4912.312276281324;4927.679700819435;5540.639858409231;5573.219749235111;5609.962157000968;5614.887702245932;5623.678435567638;4220.725652832556;4221.155768846243;4230.7038507304505;4232.280512312914;4242.278812601865;5435.864103397407;5606.691631960241;5786.82993877296;5811.2445382100905;5819.661477860116;4289.399484072233;4299.312110062375;4301.139772045541;4318.481782186095;4324.567543245713;4350.847720329773;4361;4362.563743625612;4373.2128216921255;4375.27807911691;4741.2651039089;4845.176320025604;4858.708477491362;4860.878478038077;4863.683860549053;5650.915236271459;5650.971745141248;5651.9152212716845;5654.236678048411;5667.319921609434;1439.3522914688433;1447.7104579084225;1448.891333150018;1469.3755154059481;1471.8675319221322;985.7234880829343;1043.8329867221207;1043.91432909773;1045.811753884308;1057.4131357096885;5253.605979551549;5262.89489201373;5269.810500651991;5301.946980530222;5342.252084708066;5527.39198688144;5528.778848846082;5537.089704052096;5544.22380866679;5568.276124103841;4947.90104197914;5203.5576975957465;5231.267622532849;5249.658772179796;5271.920921186185;2930.4578652948844;2934.6038284831275;2938.5298352263535;2944.8969286074885;2948.469275530425;5718.254543274162;5740.368559458456;5745.218982115474;5771.278590176228;5775.740091695884;5614.6631202128;5904;5908.291005079418;5937.960856850034;5946.405359464019;6033.78881739137;6052.425019623129;6056.182415373956;6064;6077.450250186174;5604.523615492729;5777.24895763548;5788.768449261982;5812.7674893003805;5860.736266867916;5735.11105778605;5747.8563035924435;5748.419184724235;5756.625819321731;5758.769649213985;5785.103308987113;5863.706814659336;5900.64596124234;6002.669853158118;6026.630692747723;4119.9176016478905;4161.563035881189;4186.644135248538;4200.516940551875;4227.830886764495;5637.9718101409235;5773.134029895549;5783.248177736868;5788.855278618068;5793.884122317446;5653.717314134359;5655.604107712586;5668.890054710302;5669.234653321749;5674.432556744293;5662.546996240373;5674.347450043133;5683.3748287687495;5688.943110568841;5715.457031581993;5388.114160043953;5596.908602822574;5609.859753506195;5618.831435056954;5627.746751396279;5659.151127330933;5672.943270567406;5673.687947162945;5675.013745189316;5682.43175682445;5350.919736204038;5578.442155784389;5581.5255703265675;5581.944180558305;5588.38527761954 08:28:26 INFO - PROCESS | 8015 | |5;yui.html;768.6886810841611;782.2373186143511;789.1713700614355;799.5602418669738;838.7316058861165;14922;15547.222638868068;15595;15624.375024999015;15728.764068538967;13495.392707328168;13640.863591364083;13720.45118195271;13725.65685857854;13731.65670858229;731.2358585278397;757.4016526943708;843.2916350265806;865.7835541114706;866.8439680857443;867.7093173786789;871.2768402226169;872.1583671756754;874.3180319350885;874.470945078228;915.1351972386097;916.1617120334886;916.3860213656833;916.7891384981458;917.2661870503571;777.9338756205701;797.4139007829241;798.0822054637184;799.3165843204093;907.859281811317;646.6411141816291;672.0456951129408;673.518434319464;674.81442603284;676.0940339944449;14609.48135294027;14694.926525367411;14722.190279534621;14744.483943061941;14756.114633122046;13257;13459.798103028463;13492;13516.12145210558;13518.59444216675;11724.179307448481;11776.882231177664;11873.16887817853;12084.758304833855;12243.265404075784;4102.405151253051;4122.484689413824;4153.148604536093;4288.035192081757;4315.158544083905;62932.05601915975;64924.675376622814;66725.3327466724;67224.3277567223;67334.66332668354;10480.895191048145;10914.290571112851;10916.945415272872;10932.234743568033;11099.944500277608;19831.206751730057;19935.800641993683;20015.09932053061;20175.697364539545;20439.386818395473;8311.293540049042;8318.45930014547;8392;8396.370272229608;8441.198086181803;4444.488883778342;4566.246569316092;4581.335706322565;4694.859154225379;4855.975720121447;3622.4385220290897;3711.832967516468;3738.6074462181623;3758.1356288053903;3759.285735710206;607.7781609712423;614.3027663601755;615.4553220399978;617.3301967365369;624.6470744029609;528.3422139436426;587.6620942957817;628.9967501834567;683.6205905722372;701.0990876723386;8684.43551169172;9160.496172710431;9246.352755307063;9281.39670921388;9329.253659707207;623.2925629410561;639.5842702243579;679.7247114918466;691.6852831961445;696.9686364113627;4296.6347860432215;4512.187806194916;4527.1172121436;4573.131105090022;4606.447226332862;91734.08265917389;95362;95786;96025;97255.51372243093;55056;62698.68650656717;80608.59695701601;83646.16353836506;86497.56751216203;74277.62861185551;75329.62335188399;75560.24439755642;76306.23693763102;76993.23006769973;8698.21716045559;8867.866981995146;8877.378583499092;9023.503707296162;9039.548022598976;49811.75094124506;51123.48876511187;51187.48812511976;51664.225036625234;51713.741431292605;67689.66155169193;68298.31701683118;70413.29586704272;70667.64666176637;72286.27713722795;11601.651950441501;11731.41342932833;11889.643310700692;12003.759924801281;12236.87763122393;12750.426230819821;13004.21974681522;13161;13461;13542.187468751907;12119.939400302943;12349.938250309051;12551.748965020832;12725.681857953625;12866.485340586272;12055.336956467478;12228.816567751313;12378.690532736753;12491.375431228584;12838.935805320914;11359;11432.94283528577;11833.763324733629;12066.51733930668;12401.813972790596;9838.36050656705;9934.105930466292;10079.647212347532;10204.2346823987;10336.12142967826;9369.492465197234;10075.5667506297;10084.587827946307;10104.393736375841;10110.39337639744 08:28:26 INFO - PROCESS | 8015 | __end_tp_report 08:28:26 INFO - PROCESS | 8015 | __start_cc_report 08:28:26 INFO - PROCESS | 8015 | _x_x_mozilla_cycle_collect,1057 08:28:26 INFO - PROCESS | 8015 | __end_cc_report 08:28:26 INFO - PROCESS | 8015 | __startTimestamp1480782506095__endTimestamp 08:28:26 INFO - PROCESS | 8015 | 08:28:26 INFO - PROCESS | 8015 | ------- Summary: start ------- 08:28:26 INFO - PROCESS | 8015 | Number of tests: 6 08:28:26 INFO - PROCESS | 8015 | 08:28:26 INFO - PROCESS | 8015 | [#0] dojo.html Cycles:165 Average:5603.61 Median:5765.08 stddev:617.68 (10.7%) stddev-sans-first:590.24 08:28:26 INFO - PROCESS | 8015 | Values: 3205.9 3258.5 3262.4 3286.7 3292.3 5597.5 5664.7 5685.9 5724.5 5729.5 5676.5 5739.8 5747.9 5756.6 5765.1 5195.2 5222.7 5227.9 5257.8 5309.8 5095.8 5307.5 5313.5 5318.4 5339.4 5073.9 5125.7 5169.4 5177.1 5246.5 5200.6 5223.0 5305.2 5306.0 5341.6 5000.8 5123.9 5201.7 5249.4 5264.6 5473.6 5480.2 5487.7 5562.9 5623.3 5879.4 5898.8 5991.6 5992.1 5993.6 5905.1 6040.1 6051.1 6057.5 6058.8 5563.4 5594.0 5640.2 5640.5 5670.5 6175.6 6183.6 6184.1 6186.4 6186.6 5736.2 5960.9 5974.7 5985.6 5986.8 5865.2 5941.2 5999.9 6010.4 6110.5 5998.6 6003.5 6021.1 6025.2 6062.2 5981.0 5983.9 5984.4 5991.0 6028.1 4546.8 4579.2 4598.2 4614.4 4622.1 4143.9 4161.0 4168.1 4188.9 4189.3 5722.2 5731.3 5735.1 5738.0 5740.4 5862.9 5906.3 5940.8 5989.8 6061.6 5714.0 5715.2 5723.4 5730.7 5756.2 5154.5 5173.7 5176.6 5176.7 5179.0 6102.9 6122.5 6175.1 6180.4 6232.3 5973.8 6099.1 6103.7 6127.2 6143.6 6278.3 6325.6 6326.1 6326.5 6326.8 5689.0 5704.1 5979.5 5986.9 5990.2 5852.4 5894.8 5959.6 5984.8 6034.2 5844.7 5864.7 5871.0 5895.4 5900.2 5655.7 5874.8 5875.3 5879.8 5886.4 5670.2 5773.3 5816.0 5820.7 5891.0 5900.8 5919.0 5919.6 5930.0 5932.5 5658.4 5709.1 5715.8 5779.0 5790.7 08:28:26 INFO - PROCESS | 8015 | 08:28:26 INFO - PROCESS | 8015 | [#1] ext.html Cycles:180 Average:63806.01 Median:40417.30 stddev:124581.17 (308.2%) stddev-sans-first:124840.24 08:28:26 INFO - PROCESS | 8015 | Values: 589.4 628.9 631.5 669.7 680.6 34068.8 45679.3 46496.8 46645.5 46666.0 47929.5 48377.5 48416.8 48474.3 48518.8 8429.6 8827.2 8964.0 8974.5 8985.3 8423.7 8648.9 8654.4 10639.4 10811.3 11011.2 11035.2 11036.4 11048.1 11049.0 10771.2 10840.0 10874.6 10878.6 10878.7 10710.1 10769.1 10777.6 10779.7 10796.1 44622.3 44718.6 44940.6 44979.1 45033.8 3642.1 3696.5 3755.6 3950.1 4292.5 34250.5 34251.1 34362.0 34427.0 34771.5 4402.6 4420.4 4427.8 4441.6 4459.6 359934.0 379178.1 385015.0 385599.0 385698.0 67873.0 67891.7 68159.7 68286.3 68334.0 40503.0 41756.4 41759.2 43756.1 43876.1 16854.8 17025.5 17029.0 17029.7 17045.4 11932.1 11945.5 11960.6 11966.6 11970.9 19001.5 19347.8 19348.9 19522.6 20301.7 7335.3 7605.8 7615.2 7616.7 7641.7 1042.6 1107.8 1110.9 1114.0 1157.8 35374.1 35527.1 35646.6 35741.5 35764.1 1044.3 1105.0 1160.0 1176.2 1181.5 16570.3 18402.8 18616.3 18671.8 18924.0 542219.0 544142.0 546739.0 547598.0 548959.0 56553.7 57810.1 61900.4 64221.4 64339.4 1385.2 1385.9 1413.9 1428.7 1430.3 33877.7 36311.5 36548.6 36597.0 36683.0 56757.7 57461.4 57495.7 57546.7 57570.7 469307.0 470932.0 472795.0 472802.0 473482.0 31536.5 31825.8 31857.2 32055.8 32149.5 51939.5 52071.0 52406.0 52624.0 53191.5 44008.5 44379.1 44763.0 44887.0 45465.3 43984.0 44299.6 44323.1 45908.0 46401.5 44258.3 45488.3 45513.1 45962.5 46282.3 38359.8 40213.4 40277.6 40331.6 40939.2 30079.4 30768.8 31198.7 31229.7 31320.8 08:28:26 INFO - PROCESS | 8015 | 08:28:26 INFO - PROCESS | 8015 | [#2] jquery.html Cycles:180 Average:22714.82 Median:21189.47 stddev:48834.34 (230.5%) stddev-sans-first:48942.56 08:28:26 INFO - PROCESS | 8015 | Values: 384.2 427.4 431.5 435.1 445.9 15533.6 18907.8 20020.5 21251.6 21441.2 20575.6 21061.0 21085.6 21127.4 21347.8 5636.5 5831.2 5906.6 5909.0 5909.0 5606.1 5857.8 5858.2 5862.7 5867.2 5492.7 5827.1 5831.9 5841.0 5847.4 5628.1 5714.9 5723.8 5724.5 5731.6 5107.1 5117.4 5124.4 5165.6 5420.2 14893.5 15142.8 15201.5 16547.7 24057.2 2424.3 2557.9 2796.1 2957.3 3061.7 10504.3 10534.0 10828.7 10961.0 11418.1 1970.7 1971.6 1983.1 2017.1 2054.0 75535.0 79297.0 83801.6 92711.5 94852.0 10415.5 11451.2 11633.2 11798.9 11897.0 15008.9 15941.4 15976.0 15976.6 16576.2 6664.4 7699.7 8055.0 8091.9 8100.3 7713.7 7785.5 8021.8 8214.3 8239.8 5056.7 5158.7 5158.8 5180.0 5270.9 2075.2 2105.1 2145.0 2154.2 2156.7 905.3 1022.4 1052.4 1057.3 1121.1 20192.0 20702.4 20896.1 20989.0 21305.4 989.7 1008.9 1014.9 1056.2 1115.8 10764.3 11584.8 11689.7 11803.9 11833.9 173910.0 175582.0 176098.0 177299.0 510890.0 96215.0 101373.0 101828.0 103514.5 104132.0 989.1 1008.6 1043.9 1055.2 1075.0 17399.3 18008.6 18176.1 18239.9 18689.9 44754.0 45199.5 45392.1 45424.3 45670.3 59432.7 60169.0 60795.1 60848.7 61594.1 8949.5 9181.1 9256.8 9288.7 9424.3 12837.6 12880.0 13179.8 13807.3 14469.2 10979.8 11005.7 11181.8 11204.9 11665.6 11439.1 11537.8 11614.8 11719.4 11976.9 10871.5 10899.5 11017.9 11203.2 11495.0 9137.9 9189.1 9224.6 9315.6 9369.6 9856.0 10651.3 10738.0 11031.2 11334.6 08:28:26 INFO - PROCESS | 8015 | 08:28:26 INFO - PROCESS | 8015 | [#3] mootools.html Cycles:180 Average:5903.58 Median:2738.57 stddev:3337.31 (121.9%) stddev-sans-first:3329.45 08:28:26 INFO - PROCESS | 8015 | Values: 1393.5 1512.9 1545.4 1716.8 1840.7 7939.1 8579.6 8870.2 8888.6 9103.5 8815.7 8947.2 8948.4 8951.5 8958.1 2511.2 2515.7 2531.9 2534.3 2537.8 2422.4 2495.3 2499.9 2508.4 2514.0 2477.5 2498.8 2517.2 2518.5 2525.7 2409.1 2428.7 2429.0 2432.9 2455.8 2376.7 2402.3 2420.6 2431.6 2461.9 8826.5 8894.6 9040.8 9113.1 9122.1 5451.4 5611.2 5611.7 5613.2 5614.5 3591.4 3697.9 3773.2 3793.0 3798.6 1250.6 1265.1 1283.9 1303.3 1312.4 12726.2 12837.6 12848.4 12860.7 12868.4 4783.5 4875.1 4979.9 5001.0 5044.7 10043.4 10072.3 10113.5 10119.8 10120.1 5693.2 5701.9 5706.7 5707.0 5708.4 4515.5 4716.6 4839.7 5228.5 5250.8 4031.5 4092.7 4164.6 4199.2 4201.5 1261.3 1263.6 1282.9 1290.2 1292.7 940.7 962.8 969.0 969.2 980.3 5580.6 5730.6 5747.4 5854.6 5908.1 493.3 497.3 507.2 514.9 522.3 3919.0 3931.9 3948.5 3956.7 3987.0 10650.6 11181.6 11194.2 11211.0 11264.5 11106.8 11110.1 11126.6 11128.0 11135.3 8217.0 8425.7 8519.4 8549.2 8550.7 5659.9 5707.4 5737.1 5798.5 5920.9 9987.8 10043.6 10113.5 10241.6 10300.0 9398.6 9711.2 9915.3 10536.6 10647.1 7611.8 7723.1 7724.8 7793.0 7838.9 8720.0 8803.1 8813.3 8818.9 8821.3 7963.4 7977.0 7991.1 8160.6 8220.5 7643.0 7712.2 7753.2 7987.8 8008.1 6957.7 7033.8 7088.7 7240.4 7291.4 4863.6 4884.3 5011.7 5064.2 5073.9 4946.3 5097.1 5187.7 5243.5 5284.6 08:28:26 INFO - PROCESS | 8015 | 08:28:26 INFO - PROCESS | 8015 | [#4] prototype.html Cycles:180 Average:4758.79 Median:5346.59 stddev:1368.27 (25.6%) stddev-sans-first:1331.52 08:28:26 INFO - PROCESS | 8015 | Values: 351.9 357.8 364.7 371.8 372.1 5333.5 5468.4 5480.2 5487.6 5507.6 5307.5 5358.2 5360.4 5381.0 5385.4 3863.5 4093.4 4345.6 4347.3 4351.7 4230.9 4261.7 4269.9 4277.6 4295.6 4223.5 4229.3 4237.2 4244.8 4256.6 4102.8 4196.4 4281.3 4291.3 4297.1 3753.8 3806.4 3840.9 3845.6 3864.8 5178.6 5180.6 5235.5 5247.9 5302.3 4751.0 4852.9 4912.2 4912.3 4927.7 5540.6 5573.2 5610.0 5614.9 5623.7 4220.7 4221.2 4230.7 4232.3 4242.3 5435.9 5606.7 5786.8 5811.2 5819.7 4289.4 4299.3 4301.1 4318.5 4324.6 4350.8 4361.0 4362.6 4373.2 4375.3 4741.3 4845.2 4858.7 4860.9 4863.7 5650.9 5651.0 5651.9 5654.2 5667.3 1439.4 1447.7 1448.9 1469.4 1471.9 985.7 1043.8 1043.9 1045.8 1057.4 5253.6 5262.9 5269.8 5301.9 5342.3 5527.4 5528.8 5537.1 5544.2 5568.3 4947.9 5203.6 5231.3 5249.7 5271.9 2930.5 2934.6 2938.5 2944.9 2948.5 5718.3 5740.4 5745.2 5771.3 5775.7 5614.7 5904.0 5908.3 5938.0 5946.4 6033.8 6052.4 6056.2 6064.0 6077.5 5604.5 5777.2 5788.8 5812.8 5860.7 5735.1 5747.9 5748.4 5756.6 5758.8 5785.1 5863.7 5900.6 6002.7 6026.6 4119.9 4161.6 4186.6 4200.5 4227.8 5638.0 5773.1 5783.2 5788.9 5793.9 5653.7 5655.6 5668.9 5669.2 5674.4 5662.5 5674.3 5683.4 5688.9 5715.5 5388.1 5596.9 5609.9 5618.8 5627.7 5659.2 5672.9 5673.7 5675.0 5682.4 5350.9 5578.4 5581.5 5581.9 5588.4 08:28:26 INFO - PROCESS | 8015 | 08:28:26 INFO - PROCESS | 8015 | [#5] yui.html Cycles:180 Average:18436.37 Median:51688.98 stddev:25210.05 (48.8%) stddev-sans-first:25245.87 08:28:26 INFO - PROCESS | 8015 | Values: 768.7 782.2 789.2 799.6 838.7 14922.0 15547.2 15595.0 15624.4 15728.8 13495.4 13640.9 13720.5 13725.7 13731.7 731.2 757.4 843.3 865.8 866.8 867.7 871.3 872.2 874.3 874.5 915.1 916.2 916.4 916.8 917.3 777.9 797.4 798.1 799.3 907.9 646.6 672.0 673.5 674.8 676.1 14609.5 14694.9 14722.2 14744.5 14756.1 13257.0 13459.8 13492.0 13516.1 13518.6 11724.2 11776.9 11873.2 12084.8 12243.3 4102.4 4122.5 4153.1 4288.0 4315.2 62932.1 64924.7 66725.3 67224.3 67334.7 10480.9 10914.3 10916.9 10932.2 11099.9 19831.2 19935.8 20015.1 20175.7 20439.4 8311.3 8318.5 8392.0 8396.4 8441.2 4444.5 4566.2 4581.3 4694.9 4856.0 3622.4 3711.8 3738.6 3758.1 3759.3 607.8 614.3 615.5 617.3 624.6 528.3 587.7 629.0 683.6 701.1 8684.4 9160.5 9246.4 9281.4 9329.3 623.3 639.6 679.7 691.7 697.0 4296.6 4512.2 4527.1 4573.1 4606.4 91734.1 95362.0 95786.0 96025.0 97255.5 55056.0 62698.7 80608.6 83646.2 86497.6 74277.6 75329.6 75560.2 76306.2 76993.2 8698.2 8867.9 8877.4 9023.5 9039.5 49811.8 51123.5 51187.5 51664.2 51713.7 67689.7 68298.3 70413.3 70667.6 72286.3 11601.7 11731.4 11889.6 12003.8 12236.9 12750.4 13004.2 13161.0 13461.0 13542.2 12119.9 12349.9 12551.7 12725.7 12866.5 12055.3 12228.8 12378.7 12491.4 12838.9 11359.0 11432.9 11833.8 12066.5 12401.8 9838.4 9934.1 10079.6 10204.2 10336.1 9369.5 10075.6 10084.6 10104.4 10110.4 08:28:26 INFO - PROCESS | 8015 | -------- Summary: end -------- 08:28:26 INFO - PROCESS | 8015 | 08:28:26 INFO - TEST-INFO | 8015: exit 0 08:28:26 INFO - TEST-OK | dromaeo_css | took 1116042ms 08:28:26 INFO - TEST-START | kraken 08:28:26 INFO - operating with platform_type : linux_ 08:28:26 INFO - Initialising browser for kraken test... 08:28:26 INFO - TEST-INFO | started process 8333 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_d1Oi1/profile http://localhost:43946/getInfo.html) 08:28:31 INFO - PROCESS | 8333 | __metrics Screen width/height:1600/1200 08:28:31 INFO - PROCESS | 8333 | colorDepth:24 08:28:31 INFO - PROCESS | 8333 | Browser inner width/height: 1024/697 08:28:31 INFO - PROCESS | 8333 | __metrics 08:28:31 INFO - PROCESS | 8333 | 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:28:31 INFO - PROCESS | 8333 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:28:32 INFO - PROCESS | 8333 | console.error: PushService: 08:28:32 INFO - PROCESS | 8333 | stateChangeProcessEnqueue: Error transitioning state 08:28:32 INFO - PROCESS | 8333 | UnknownError 08:28:32 INFO - TEST-INFO | 8333: exit 0 08:28:32 INFO - Browser initialized. 08:28:32 INFO - Running cycle 1/1 for kraken test... 08:28:32 INFO - TEST-INFO | started process 8430 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_d1Oi1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:28:44 INFO - PROCESS | 8430 | RSS: Main: 144793600 08:28:44 INFO - PROCESS | 8430 | 08:28:47 INFO - PROCESS | 8430 | Cycle 1(1): loaded http://localhost:43946/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43946/tests/kraken/driver.html?testName=audio-beat-detection) 08:28:48 INFO - PROCESS | 8430 | RSS: Main: 185696256 08:28:48 INFO - PROCESS | 8430 | 08:28:50 INFO - PROCESS | 8430 | Cycle 1(1): loaded http://localhost:43946/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43946/tests/kraken/driver.html?testName=audio-dft) 08:28:51 INFO - PROCESS | 8430 | RSS: Main: 176074752 08:28:51 INFO - PROCESS | 8430 | 08:28:54 INFO - PROCESS | 8430 | Cycle 1(1): loaded http://localhost:43946/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43946/tests/kraken/driver.html?testName=audio-fft) 08:28:54 INFO - PROCESS | 8430 | RSS: Main: 266784768 08:28:54 INFO - PROCESS | 8430 | 08:28:56 INFO - PROCESS | 8430 | Cycle 1(1): loaded http://localhost:43946/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43946/tests/kraken/driver.html?testName=audio-oscillator) 08:28:57 INFO - PROCESS | 8430 | RSS: Main: 172941312 08:28:57 INFO - PROCESS | 8430 | 08:28:59 INFO - PROCESS | 8430 | Cycle 1(1): loaded http://localhost:43946/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43946/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:29:00 INFO - PROCESS | 8430 | RSS: Main: 175747072 08:29:00 INFO - PROCESS | 8430 | 08:29:03 INFO - PROCESS | 8430 | Cycle 1(1): loaded http://localhost:43946/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43946/tests/kraken/driver.html?testName=imaging-darkroom) 08:29:03 INFO - PROCESS | 8430 | RSS: Main: 214417408 08:29:03 INFO - PROCESS | 8430 | 08:29:06 INFO - PROCESS | 8430 | Cycle 1(1): loaded http://localhost:43946/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43946/tests/kraken/driver.html?testName=imaging-desaturate) 08:29:07 INFO - PROCESS | 8430 | RSS: Main: 213172224 08:29:07 INFO - PROCESS | 8430 | 08:29:10 INFO - PROCESS | 8430 | Cycle 1(1): loaded http://localhost:43946/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43946/tests/kraken/driver.html?testName=json-parse-financial) 08:29:10 INFO - PROCESS | 8430 | RSS: Main: 211234816 08:29:10 INFO - PROCESS | 8430 | 08:29:12 INFO - PROCESS | 8430 | Cycle 1(1): loaded http://localhost:43946/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43946/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:29:12 INFO - PROCESS | 8430 | RSS: Main: 173780992 08:29:12 INFO - PROCESS | 8430 | 08:29:14 INFO - PROCESS | 8430 | Cycle 1(1): loaded http://localhost:43946/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43946/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:29:15 INFO - PROCESS | 8430 | RSS: Main: 180715520 08:29:15 INFO - PROCESS | 8430 | 08:29:17 INFO - PROCESS | 8430 | Cycle 1(1): loaded http://localhost:43946/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43946/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:29:17 INFO - PROCESS | 8430 | RSS: Main: 190373888 08:29:17 INFO - PROCESS | 8430 | 08:29:20 INFO - PROCESS | 8430 | Cycle 1(1): loaded http://localhost:43946/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43946/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:29:21 INFO - PROCESS | 8430 | RSS: Main: 199008256 08:29:21 INFO - PROCESS | 8430 | 08:29:23 INFO - PROCESS | 8430 | Cycle 1(1): loaded http://localhost:43946/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43946/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:29:24 INFO - PROCESS | 8430 | RSS: Main: 195780608 08:29:24 INFO - PROCESS | 8430 | 08:29:25 INFO - PROCESS | 8430 | Cycle 1(1): loaded http://localhost:43946/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43946/tests/kraken/driver.html?testName=ai-astar) 08:29:26 INFO - PROCESS | 8430 | RSS: Main: 245792768 08:29:26 INFO - PROCESS | 8430 | 08:29:26 INFO - PROCESS | 8430 | __start_tp_report 08:29:26 INFO - PROCESS | 8430 | _x_x_mozilla_page_load 08:29:26 INFO - PROCESS | 8430 | _x_x_mozilla_page_load_details 08:29:26 INFO - PROCESS | 8430 | |i|pagename|runs| 08:29:26 INFO - PROCESS | 8430 | |0;ai-astar;101;110;111;110;111;110;111;112;111;110 08:29:26 INFO - PROCESS | 8430 | |1;audio-beat-detection;150;121;136;157;125;123;120;123;149;120 08:29:26 INFO - PROCESS | 8430 | |2;audio-dft;161;160;160;160;162;161;161;162;159;159 08:29:26 INFO - PROCESS | 8430 | |3;audio-fft;74;76;75;103;76;76;81;76;104;76 08:29:26 INFO - PROCESS | 8430 | |4;audio-oscillator;81;81;121;82;82;83;102;82;81;108 08:29:26 INFO - PROCESS | 8430 | |5;imaging-gaussian-blur;117;116;117;117;117;117;116;118;117;117 08:29:26 INFO - PROCESS | 8430 | |6;imaging-darkroom;146;146;146;146;147;146;146;147;146;145 08:29:26 INFO - PROCESS | 8430 | |7;imaging-desaturate;84;84;85;85;84;84;84;84;84;84 08:29:26 INFO - PROCESS | 8430 | |8;json-parse-financial;50;51;49;50;57;52;50;51;50;50 08:29:26 INFO - PROCESS | 8430 | |9;json-stringify-tinderbox;57;58;58;59;58;58;58;59;59;60 08:29:26 INFO - PROCESS | 8430 | |10;stanford-crypto-aes;75;81;76;76;77;75;75;75;76;74 08:29:26 INFO - PROCESS | 8430 | |11;stanford-crypto-ccm;134;136;137;125;127;135;126;123;173;124 08:29:26 INFO - PROCESS | 8430 | |12;stanford-crypto-pbkdf2;156;157;154;156;157;153;155;154;154;153 08:29:26 INFO - PROCESS | 8430 | |13;stanford-crypto-sha256-iterative;62;63;63;62;63;63;62;63;61;63 08:29:26 INFO - PROCESS | 8430 | __end_tp_report 08:29:26 INFO - PROCESS | 8430 | __start_cc_report 08:29:26 INFO - PROCESS | 8430 | _x_x_mozilla_cycle_collect,1629 08:29:26 INFO - PROCESS | 8430 | __end_cc_report 08:29:26 INFO - PROCESS | 8430 | __startTimestamp1480782566214__endTimestamp 08:29:26 INFO - PROCESS | 8430 | 08:29:26 INFO - PROCESS | 8430 | ------- Summary: start ------- 08:29:26 INFO - PROCESS | 8430 | Number of tests: 14 08:29:26 INFO - PROCESS | 8430 | 08:29:26 INFO - PROCESS | 8430 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.00 stddev:3.13 (2.8%) stddev-sans-first:0.71 08:29:26 INFO - PROCESS | 8430 | Values: 101.0 110.0 111.0 110.0 111.0 110.0 111.0 112.0 111.0 110.0 08:29:26 INFO - PROCESS | 8430 | 08:29:26 INFO - PROCESS | 8430 | [#1] audio-beat-detection Cycles:10 Average:132.40 Median:130.50 stddev:14.42 (11.1%) stddev-sans-first:13.82 08:29:26 INFO - PROCESS | 8430 | Values: 150.0 121.0 136.0 157.0 125.0 123.0 120.0 123.0 149.0 120.0 08:29:26 INFO - PROCESS | 8430 | 08:29:26 INFO - PROCESS | 8430 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:1.08 (0.7%) stddev-sans-first:1.13 08:29:26 INFO - PROCESS | 8430 | Values: 161.0 160.0 160.0 160.0 162.0 161.0 161.0 162.0 159.0 159.0 08:29:26 INFO - PROCESS | 8430 | 08:29:26 INFO - PROCESS | 8430 | [#3] audio-fft Cycles:10 Average:81.70 Median:76.00 stddev:11.63 (15.3%) stddev-sans-first:12.00 08:29:26 INFO - PROCESS | 8430 | Values: 74.0 76.0 75.0 103.0 76.0 76.0 81.0 76.0 104.0 76.0 08:29:26 INFO - PROCESS | 8430 | 08:29:26 INFO - PROCESS | 8430 | [#4] audio-oscillator Cycles:10 Average:90.30 Median:81.50 stddev:14.58 (17.9%) stddev-sans-first:15.07 08:29:26 INFO - PROCESS | 8430 | Values: 81.0 81.0 121.0 82.0 82.0 83.0 102.0 82.0 81.0 108.0 08:29:26 INFO - PROCESS | 8430 | 08:29:26 INFO - PROCESS | 8430 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 08:29:26 INFO - PROCESS | 8430 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 116.0 118.0 117.0 117.0 08:29:26 INFO - PROCESS | 8430 | 08:29:26 INFO - PROCESS | 8430 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 08:29:26 INFO - PROCESS | 8430 | Values: 146.0 146.0 146.0 146.0 147.0 146.0 146.0 147.0 146.0 145.0 08:29:26 INFO - PROCESS | 8430 | 08:29:26 INFO - PROCESS | 8430 | [#7] imaging-desaturate Cycles:10 Average:84.20 Median:84.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 08:29:26 INFO - PROCESS | 8430 | Values: 84.0 84.0 85.0 85.0 84.0 84.0 84.0 84.0 84.0 84.0 08:29:26 INFO - PROCESS | 8430 | 08:29:26 INFO - PROCESS | 8430 | [#8] json-parse-financial Cycles:10 Average:51.00 Median:50.50 stddev:2.26 (4.5%) stddev-sans-first:2.37 08:29:26 INFO - PROCESS | 8430 | Values: 50.0 51.0 49.0 50.0 57.0 52.0 50.0 51.0 50.0 50.0 08:29:26 INFO - PROCESS | 8430 | 08:29:26 INFO - PROCESS | 8430 | [#9] json-stringify-tinderbox Cycles:10 Average:58.40 Median:58.50 stddev:0.84 (1.4%) stddev-sans-first:0.73 08:29:26 INFO - PROCESS | 8430 | Values: 57.0 58.0 58.0 59.0 58.0 58.0 58.0 59.0 59.0 60.0 08:29:26 INFO - PROCESS | 8430 | 08:29:26 INFO - PROCESS | 8430 | [#10] stanford-crypto-aes Cycles:10 Average:76.00 Median:76.00 stddev:1.94 (2.6%) stddev-sans-first:2.03 08:29:26 INFO - PROCESS | 8430 | Values: 75.0 81.0 76.0 76.0 77.0 75.0 75.0 75.0 76.0 74.0 08:29:26 INFO - PROCESS | 8430 | 08:29:26 INFO - PROCESS | 8430 | [#11] stanford-crypto-ccm Cycles:10 Average:134.00 Median:134.50 stddev:14.72 (10.9%) stddev-sans-first:15.61 08:29:26 INFO - PROCESS | 8430 | Values: 134.0 136.0 137.0 125.0 127.0 135.0 126.0 123.0 173.0 124.0 08:29:26 INFO - PROCESS | 8430 | 08:29:26 INFO - PROCESS | 8430 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.90 Median:155.50 stddev:1.52 (1.0%) stddev-sans-first:1.56 08:29:26 INFO - PROCESS | 8430 | Values: 156.0 157.0 154.0 156.0 157.0 153.0 155.0 154.0 154.0 153.0 08:29:26 INFO - PROCESS | 8430 | 08:29:26 INFO - PROCESS | 8430 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.50 Median:63.00 stddev:0.71 (1.1%) stddev-sans-first:0.73 08:29:26 INFO - PROCESS | 8430 | Values: 62.0 63.0 63.0 62.0 63.0 63.0 62.0 63.0 61.0 63.0 08:29:26 INFO - PROCESS | 8430 | -------- Summary: end -------- 08:29:26 INFO - PROCESS | 8430 | 08:29:27 INFO - TEST-INFO | 8430: exit 0 08:29:27 INFO - TEST-OK | kraken | took 60369ms 08:29:27 INFO - SUITE-END | took 1176s 08:29:27 INFO - Completed test suite (00:19:36) 08:29:27 INFO - javascript benchmark 08:29:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3205.871765129394, 3258.4949332853407, 3262.4290749118913, 3286.671332866712, 3292.3250733599616, 5597.524210442112, 5664.716764161796, 5685.886282274352, 5724.542036637069, 5729.484346408823, 5676.545876329894, 5739.770409183638, 5747.942520574793, 5756.568257380703, 5765.077587585987, 5195.19474481455, 5222.738863056851, 5227.947720522803, 5257.842264732045, 5309.814156504523, 5095.84712458625, 5307.548858347045, 5313.521783039526, 5318.361796584415, 5339.385970613371, 5073.949260507403, 5125.692458452505, 5169.431362550116, 5177.094008548508, 5246.501582349671, 5200.6099542534275, 5223.0, 5305.151175811851, 5306.0, 5341.599380046512, 5000.774965126541, 5123.923141152885, 5201.687898726089, 5249.396319423277, 5264.6051546134195, 5473.644213126134, 5480.177973304037, 5487.6981766002855, 5562.888742225133, 5623.268975033219, 5879.412058794129, 5898.849724303763, 5991.64050156992, 5992.131140984577, 5993.61041532299, 5905.143754155666, 6040.12418199363, 6051.062085376773, 6057.485113765335, 6058.818235452899, 5563.36021357545, 5594.021046316919, 5640.238567793377, 5640.492355687926, 5670.489655930986, 6175.59858609189, 6183.5671502994355, 6184.072389141575, 6186.412290832363, 6186.566940314135, 5736.1682556029145, 5960.910586341209, 5974.731137098754, 5985.581009329305, 5986.760529578768, 5865.237519122572, 5941.197938278364, 5999.940000600025, 6010.429009244115, 6110.480609148183, 5998.580099393001, 6003.459688628044, 6021.096835474714, 6025.15647809307, 6062.242219722535, 5981.043033114681, 5983.910241346383, 5984.401559843981, 5991.0, 6028.09578563219, 4546.840860569931, 4579.244424669892, 4598.218302888517, 4614.353990441341, 4622.144903192853, 4143.91712165755, 4161.0, 4168.124693814333, 4188.85339013133, 4189.329707246826, 5722.198892155102, 5731.312242530839, 5735.053716136791, 5737.971310143423, 5740.397258287903, 5862.912056319158, 5906.2912450505355, 5940.79207227745, 5989.79035733756, 6061.605995610271, 5714.0, 5715.199872017921, 5723.370429252779, 5730.7421166047625, 5756.165356023437, 5154.458781827929, 5173.715445650525, 5176.611754118456, 5176.663516871391, 5178.974105129526, 6102.931986902363, 6122.489639783254, 6175.104609831639, 6180.351063138396, 6232.25212974446, 5973.761049558143, 6099.115628233792, 6103.664298463627, 6127.172831667668, 6143.600665956698, 6278.309385967448, 6325.588836725598, 6326.082718005955, 6326.493880489457, 6326.841828954313, 5688.971555142198, 5704.11586204139, 5979.4618484336615, 5986.910196347146, 5990.191324171181, 5852.4147585241135, 5894.823155305176, 5959.582829201914, 5984.790532331522, 6034.24571928509, 5844.678542680023, 5864.706764661835, 5870.970645146747, 5895.351511333835, 5900.203472531153, 5655.660660360227, 5874.794382196603, 5875.265591801025, 5879.794207202727, 5886.440788125121, 5670.177824215383, 5773.278340207474, 5815.9709201453725, 5820.70896455184, 5890.970545147246, 5900.822975310747, 5919.0, 5919.644821310735, 5929.970350148222, 5932.49573786233, 5658.377578466283, 5709.058005429058, 5715.799947001835, 5779.017567013701, 5790.681512516852], "value": 5562.8528642362635, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.3840936221648, 628.949684025278, 631.4790298004147, 669.701982617735, 680.5644387591946, 34068.82965585172, 45679.31481027787, 46496.8375790605, 46645.53354466463, 46666.0, 47929.52070479294, 48377.51622483774, 48416.75791621046, 48474.27288590674, 48518.75740621301, 8429.620667069967, 8827.16141966512, 8964.0, 8974.50640214788, 8985.326100542452, 8423.747287581382, 8648.913510864904, 8654.394192406535, 10639.414832184228, 10811.297265677706, 11011.229213955026, 11035.227534072617, 11036.448177591128, 11048.06091482225, 11049.0, 10771.192160587949, 10840.024397804196, 10874.565017399294, 10878.564857405694, 10878.673639790819, 10710.089642380408, 10769.084627806646, 10777.62278320255, 10779.730506737316, 10796.136309095253, 44622.33066504005, 44718.55281447209, 44940.55059449429, 44979.10041799179, 45033.77483112564, 3642.1076836175043, 3696.5194524711883, 3755.605661405568, 3950.0914789598264, 4292.463442069741, 34250.48624270638, 34251.143721406916, 34362.0, 34427.0, 34771.478427823604, 4402.5561952093885, 4420.359047938063, 4427.756473393962, 4441.644668426518, 4459.620932220765, 359934.0, 379178.10410948045, 385015.0, 385599.0, 385698.0, 67873.0, 67891.66054169796, 68159.65920170367, 68286.31713682899, 68334.0, 40503.0, 41756.37365439521, 41759.164816703495, 43756.12487750291, 43876.12247755091, 16854.831451685328, 17025.48923532296, 17029.0, 17029.659406811796, 17045.40341088056, 11932.105092118127, 11945.462454189583, 11960.58137965167, 11966.64100076999, 11970.880291196976, 19001.524961876064, 19347.806521934883, 19348.903255483634, 19522.62095147003, 20301.695474567892, 7335.339819416172, 7605.809854753565, 7615.210425549992, 7616.657250423744, 7641.732539361207, 1042.5985995391677, 1107.7950579142723, 1110.8778034416207, 1113.9554417823358, 1157.8205378166397, 35374.11564710903, 35527.11182220465, 35646.64353356433, 35741.46387804185, 35764.105897352776, 1044.2794471814423, 1105.038616403718, 1159.9884001160049, 1176.1766763265578, 1181.4506254591656, 16570.254338554794, 18402.815971840377, 18616.255349786126, 18671.81328186728, 18924.0, 542219.0, 544142.0, 546739.0, 547598.0, 548959.0, 56553.717231414405, 57810.13284800731, 61900.38099619036, 64221.35778642247, 64339.356606433335, 1385.1896640465238, 1385.9168449893039, 1413.893957953137, 1428.7071150414347, 1430.3134495442246, 33877.66122338745, 36311.455328170625, 36548.63451365559, 36597.0, 36683.0, 56757.71621142033, 57461.425385745606, 57495.7125214388, 57546.7122664384, 57570.712146439, 469307.0, 470932.0, 472795.0, 472802.0, 473482.0, 31536.526952096196, 31825.8408707955, 31857.203569910936, 32055.839720801247, 32149.517757234127, 51939.48060519498, 52071.0, 52406.0, 52624.0, 53191.4680853202, 44008.54361215949, 44379.11241775211, 44763.0, 44887.0, 45465.318020230385, 43984.0, 44299.557004429545, 44323.11353772971, 45908.0, 46401.53598464107, 44258.33612495751, 45488.31767523556, 45513.089738205716, 45962.540374595825, 46282.30576541287, 38359.80820095993, 40213.396799047456, 40277.597224027384, 40331.59668403278, 40939.1812163761, 30079.398412031198, 30768.84615576908, 31198.688013120485, 31229.68770312268, 31320.843395782875], "value": 21478.293298387864, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.23920637138445, 427.3711345201524, 431.5188564750303, 435.09717336526717, 445.86846880170367, 15533.611659708513, 18907.810921890796, 20020.499487512818, 21251.57496850062, 21441.249556265535, 20575.588488230227, 21061.0, 21085.578288434222, 21127.366179014654, 21347.786522134775, 5636.549076073915, 5831.154482600021, 5906.61606995546, 5908.970455147718, 5908.970455147718, 5606.103023516238, 5857.76568937242, 5858.1505681676135, 5862.677552734598, 5867.178594996704, 5492.697901615409, 5827.125931110346, 5831.912521312183, 5840.970795146019, 5847.356790753014, 5628.0713682242385, 5714.885702285973, 5723.771049158028, 5724.542036637059, 5731.570132240098, 5107.106256405114, 5117.437081920985, 5124.436312005676, 5165.63840531163, 5420.24116623669, 14893.47872824446, 15142.772858407132, 15201.543953681406, 16547.669046619, 24057.15799947011, 2424.2727181845553, 2557.8593177375237, 2796.14717511159, 2957.349383135707, 3061.678523754996, 10504.2647014709, 10534.0, 10828.675139745821, 10961.013508784168, 11418.086553075735, 1970.6846904495355, 1971.5761111361126, 1983.0679580597096, 2017.0923084611836, 2053.9897300513553, 75535.0, 79297.0, 83801.58099209526, 92711.53644231803, 94852.0, 10415.479226038668, 11451.198416110792, 11633.185677002697, 11798.941005294919, 11897.0, 15008.924955375373, 15941.442049528443, 15976.0, 15976.600584985235, 16576.17119144038, 6664.433523150489, 7699.730509432143, 8055.0, 8091.878621820678, 8100.270975612223, 7713.65288562016, 7785.455018148788, 8021.796730490473, 8214.342852571779, 8239.835203295901, 5056.696598204119, 5158.690478571298, 5158.845234642967, 5180.0, 5270.92093618596, 2075.2321640992627, 2105.1368938735045, 2144.991853828698, 2154.2352464875057, 2156.698062271283, 905.3300557587338, 1022.4274406332329, 1052.4316868890867, 1057.2916146182076, 1121.0919155484085, 20192.0, 20702.378928632166, 20896.05967731456, 20989.0, 21305.36083917485, 989.7426669066094, 1008.9243306752023, 1014.8832884218261, 1056.2078441169124, 1115.8158903780786, 10764.300320479144, 11584.76830463386, 11689.707757306136, 11803.88196118045, 11833.881661183277, 173910.0, 175582.0, 176098.0, 177299.0, 510890.0, 96215.0, 101373.0, 101828.0, 103514.48242758738, 104132.0, 989.0554520432969, 1008.5511947183579, 1043.879953805307, 1055.150603763962, 1074.9623763168408, 17399.30402783925, 18008.639827203646, 18176.09119544044, 18239.908800455913, 18689.90655046716, 44754.0, 45199.548004519536, 45392.09215815731, 45424.318635221156, 45670.314945276514, 59432.70283648554, 60169.0, 60795.08807367981, 60848.69575652093, 61594.0760888596, 8949.507777072324, 9181.127792859668, 9256.768580785265, 9288.674896378594, 9424.29317801154, 12837.550685725955, 12880.0, 13179.802302965654, 13807.309634518033, 14469.204193769443, 10979.83530247031, 11005.724856878642, 11181.832272516082, 11204.88795112071, 11665.59170429065, 11439.142064345373, 11537.769244615229, 11614.825777613512, 11719.355435451133, 11976.880231197925, 10871.510782014986, 10899.455027248765, 11017.889821101686, 11203.21577489568, 11495.0, 9137.862932055892, 9189.081091890757, 9224.584893679934, 9315.580798864203, 9369.578368973276, 9856.0, 10651.30766500175, 10738.0, 11031.22781405294, 11334.60328888485], "value": 9261.57021440697, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1393.4704812171385, 1512.8638422541972, 1545.4359158906998, 1716.8369004944534, 1840.6778813707597, 7939.126696063436, 8579.613917373717, 8870.201681848632, 8888.64445422184, 9103.499307538083, 8815.735527934155, 8947.150020748019, 8948.418352807063, 8951.507667078307, 8958.059403762609, 2511.171313466556, 2515.6855393075866, 2531.898724051045, 2534.3030666566656, 2537.7716005559496, 2422.358075110097, 2495.2763698527406, 2499.8875050622673, 2508.423062695572, 2513.969272598235, 2477.4549599088173, 2498.750124987505, 2517.1567524879097, 2518.534071196825, 2525.7095434025046, 2409.072507084776, 2428.732839387666, 2429.0405289910564, 2432.878356082189, 2455.7789798918093, 2376.6791483149727, 2402.25530085674, 2420.649005894153, 2431.598786200275, 2461.90152393904, 8826.514541700204, 8894.59974301158, 9040.77398065047, 9113.0886911309, 9122.133397327243, 5451.427600101972, 5611.186377975211, 5611.7474713637985, 5613.214150019001, 5614.494695477427, 3591.371509985768, 3697.9445308320396, 3773.1699026214187, 3792.981035094807, 3798.639129282714, 1250.6248125562295, 1265.1270623270007, 1283.8716128387086, 1303.3352989975085, 1312.409415762901, 12726.23642581448, 12837.550685726048, 12848.421821017982, 12860.742785144244, 12868.420921058574, 4783.497732738012, 4875.122477953932, 4979.875503112378, 5000.999999999927, 5044.747762611854, 10043.397396156253, 10072.345297555636, 10113.544890479947, 10119.848202276971, 10120.089191972758, 5693.202951586698, 5701.942980570224, 5706.71466426677, 5707.0, 5708.400617935057, 4515.458145022552, 4716.646251531149, 4839.733814640158, 5228.529432351107, 5250.842474725764, 4031.455753473302, 4092.6521245693853, 4164.583541645872, 4199.202151591249, 4201.4538110046105, 1261.2810697902107, 1263.6335462715892, 1282.8845403913692, 1290.2387591320978, 1292.689754458923, 940.6942743608355, 962.764122789921, 968.9951550242204, 969.2100937735722, 980.2745967983641, 5580.609357344947, 5730.598858079978, 5747.3677895431465, 5854.590178687451, 5908.124540523346, 493.30444073855693, 497.27149725652095, 507.22394736053894, 514.8687084793354, 522.2531779555272, 3918.9608103919168, 3931.92136157281, 3948.506436695413, 3956.66368358687, 3987.0, 10650.573977040987, 11181.608643697595, 11194.216404851582, 11211.047060999907, 11264.493097810619, 11106.833397499044, 11110.111191104692, 11126.61056863006, 11128.0, 11135.33188008722, 8216.958915205505, 8425.662973481114, 8519.403641745143, 8549.187827156411, 8550.743477695554, 5659.943400565941, 5707.429257074259, 5737.139429085503, 5798.507126894261, 5920.881582368243, 9987.800243994934, 10043.598256069676, 10113.5448904798, 10241.641542545975, 10300.0, 9398.624055037995, 9711.223102151953, 9915.256355773201, 10536.631217907336, 10647.148228141576, 7611.771646850603, 7723.073231212291, 7724.806879828049, 7793.0, 7838.882416763639, 8719.956400217958, 8803.075677054074, 8813.338999575186, 8818.91181088181, 8821.250193733604, 7963.442559021045, 7976.960115199619, 7991.081025681889, 8160.551169685724, 8220.547869867214, 7642.975140616808, 7712.151663317143, 7753.1859154787935, 7987.760367188994, 8008.079070906921, 6957.721691132298, 7033.753818616528, 7088.716451341888, 7240.420766338575, 7291.38023268007, 4863.562279394871, 4884.340614017062, 5011.699298042129, 5064.240363945438, 5073.86897503057, 4946.307516947558, 5097.057044446641, 5187.740612969412, 5243.475652434726, 5284.577233821362], "value": 4685.42847574035, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.90322661268146, 357.7567254267099, 364.65175757151917, 371.758357067906, 372.114367804625, 5333.493318134776, 5468.425815289397, 5480.232767412565, 5487.6158668893195, 5507.576666266845, 5307.469253074691, 5358.169483730018, 5360.437154098822, 5381.0045141648825, 5385.434529374408, 3863.497745293108, 4093.385992101179, 4345.608895199432, 4347.347897815329, 4351.6953813233085, 4230.921115115657, 4261.744295342274, 4269.87190384289, 4277.593628605277, 4295.634871035965, 4223.472065991751, 4229.259879521087, 4237.237297286487, 4244.83020679174, 4256.616904478597, 4102.835886564534, 4196.391523229146, 4281.272183728758, 4291.270484017708, 4297.140571885604, 3753.7560058596105, 3806.352920003606, 3840.9423858642144, 3845.6346647068763, 3864.806759662006, 5178.585713142939, 5180.6373553851245, 5235.476452354734, 5247.921281180786, 5302.2841916341185, 4750.978539613965, 4852.902941941176, 4912.238603016503, 4912.312276281324, 4927.679700819435, 5540.639858409231, 5573.219749235111, 5609.962157000968, 5614.887702245932, 5623.678435567638, 4220.725652832556, 4221.155768846243, 4230.7038507304505, 4232.280512312914, 4242.278812601865, 5435.864103397407, 5606.691631960241, 5786.82993877296, 5811.2445382100905, 5819.661477860116, 4289.399484072233, 4299.312110062375, 4301.139772045541, 4318.481782186095, 4324.567543245713, 4350.847720329773, 4361.0, 4362.563743625612, 4373.2128216921255, 4375.27807911691, 4741.2651039089, 4845.176320025604, 4858.708477491362, 4860.878478038077, 4863.683860549053, 5650.915236271459, 5650.971745141248, 5651.9152212716845, 5654.236678048411, 5667.319921609434, 1439.3522914688433, 1447.7104579084225, 1448.891333150018, 1469.3755154059481, 1471.8675319221322, 985.7234880829343, 1043.8329867221207, 1043.91432909773, 1045.811753884308, 1057.4131357096885, 5253.605979551549, 5262.89489201373, 5269.810500651991, 5301.946980530222, 5342.252084708066, 5527.39198688144, 5528.778848846082, 5537.089704052096, 5544.22380866679, 5568.276124103841, 4947.90104197914, 5203.5576975957465, 5231.267622532849, 5249.658772179796, 5271.920921186185, 2930.4578652948844, 2934.6038284831275, 2938.5298352263535, 2944.8969286074885, 2948.469275530425, 5718.254543274162, 5740.368559458456, 5745.218982115474, 5771.278590176228, 5775.740091695884, 5614.6631202128, 5904.0, 5908.291005079418, 5937.960856850034, 5946.405359464019, 6033.78881739137, 6052.425019623129, 6056.182415373956, 6064.0, 6077.450250186174, 5604.523615492729, 5777.24895763548, 5788.768449261982, 5812.7674893003805, 5860.736266867916, 5735.11105778605, 5747.8563035924435, 5748.419184724235, 5756.625819321731, 5758.769649213985, 5785.103308987113, 5863.706814659336, 5900.64596124234, 6002.669853158118, 6026.630692747723, 4119.9176016478905, 4161.563035881189, 4186.644135248538, 4200.516940551875, 4227.830886764495, 5637.9718101409235, 5773.134029895549, 5783.248177736868, 5788.855278618068, 5793.884122317446, 5653.717314134359, 5655.604107712586, 5668.890054710302, 5669.234653321749, 5674.432556744293, 5662.546996240373, 5674.347450043133, 5683.3748287687495, 5688.943110568841, 5715.457031581993, 5388.114160043953, 5596.908602822574, 5609.859753506195, 5618.831435056954, 5627.746751396279, 5659.151127330933, 5672.943270567406, 5673.687947162945, 5675.013745189316, 5682.43175682445, 5350.919736204038, 5578.442155784389, 5581.5255703265675, 5581.944180558305, 5588.38527761954], "value": 4333.271144515369, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [768.6886810841611, 782.2373186143511, 789.1713700614355, 799.5602418669738, 838.7316058861165, 14922.0, 15547.222638868068, 15595.0, 15624.375024999015, 15728.764068538967, 13495.392707328168, 13640.863591364083, 13720.45118195271, 13725.65685857854, 13731.65670858229, 731.2358585278397, 757.4016526943708, 843.2916350265806, 865.7835541114706, 866.8439680857443, 867.7093173786789, 871.2768402226169, 872.1583671756754, 874.3180319350885, 874.470945078228, 915.1351972386097, 916.1617120334886, 916.3860213656833, 916.7891384981458, 917.2661870503571, 777.9338756205701, 797.4139007829241, 798.0822054637184, 799.3165843204093, 907.859281811317, 646.6411141816291, 672.0456951129408, 673.518434319464, 674.81442603284, 676.0940339944449, 14609.48135294027, 14694.926525367411, 14722.190279534621, 14744.483943061941, 14756.114633122046, 13257.0, 13459.798103028463, 13492.0, 13516.12145210558, 13518.59444216675, 11724.179307448481, 11776.882231177664, 11873.16887817853, 12084.758304833855, 12243.265404075784, 4102.405151253051, 4122.484689413824, 4153.148604536093, 4288.035192081757, 4315.158544083905, 62932.05601915975, 64924.675376622814, 66725.3327466724, 67224.3277567223, 67334.66332668354, 10480.895191048145, 10914.290571112851, 10916.945415272872, 10932.234743568033, 11099.944500277608, 19831.206751730057, 19935.800641993683, 20015.09932053061, 20175.697364539545, 20439.386818395473, 8311.293540049042, 8318.45930014547, 8392.0, 8396.370272229608, 8441.198086181803, 4444.488883778342, 4566.246569316092, 4581.335706322565, 4694.859154225379, 4855.975720121447, 3622.4385220290897, 3711.832967516468, 3738.6074462181623, 3758.1356288053903, 3759.285735710206, 607.7781609712423, 614.3027663601755, 615.4553220399978, 617.3301967365369, 624.6470744029609, 528.3422139436426, 587.6620942957817, 628.9967501834567, 683.6205905722372, 701.0990876723386, 8684.43551169172, 9160.496172710431, 9246.352755307063, 9281.39670921388, 9329.253659707207, 623.2925629410561, 639.5842702243579, 679.7247114918466, 691.6852831961445, 696.9686364113627, 4296.6347860432215, 4512.187806194916, 4527.1172121436, 4573.131105090022, 4606.447226332862, 91734.08265917389, 95362.0, 95786.0, 96025.0, 97255.51372243093, 55056.0, 62698.68650656717, 80608.59695701601, 83646.16353836506, 86497.56751216203, 74277.62861185551, 75329.62335188399, 75560.24439755642, 76306.23693763102, 76993.23006769973, 8698.21716045559, 8867.866981995146, 8877.378583499092, 9023.503707296162, 9039.548022598976, 49811.75094124506, 51123.48876511187, 51187.48812511976, 51664.225036625234, 51713.741431292605, 67689.66155169193, 68298.31701683118, 70413.29586704272, 70667.64666176637, 72286.27713722795, 11601.651950441501, 11731.41342932833, 11889.643310700692, 12003.759924801281, 12236.87763122393, 12750.426230819821, 13004.21974681522, 13161.0, 13461.0, 13542.187468751907, 12119.939400302943, 12349.938250309051, 12551.748965020832, 12725.681857953625, 12866.485340586272, 12055.336956467478, 12228.816567751313, 12378.690532736753, 12491.375431228584, 12838.935805320914, 11359.0, 11432.94283528577, 11833.763324733629, 12066.51733930668, 12401.813972790596, 9838.36050656705, 9934.105930466292, 10079.647212347532, 10204.2346823987, 10336.12142967826, 9369.492465197234, 10075.5667506297, 10084.587827946307, 10104.393736375841, 10110.39337639744], "value": 7172.270089252727, "unit": "score"}], "name": "dromaeo_css", "value": 7376.916433396546, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 111.0, 110.0, 111.0, 110.0, 111.0, 112.0, 111.0, 110.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 121.0, 136.0, 157.0, 125.0, 123.0, 120.0, 123.0, 149.0, 120.0], "value": 132.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 160.0, 162.0, 161.0, 161.0, 162.0, 159.0, 159.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 103.0, 76.0, 76.0, 81.0, 76.0, 104.0, 76.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 121.0, 82.0, 82.0, 83.0, 102.0, 82.0, 81.0, 108.0], "value": 90.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 118.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 147.0, 146.0, 145.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 85.0, 85.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0], "value": 84.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 49.0, 50.0, 57.0, 52.0, 50.0, 51.0, 50.0, 50.0], "value": 51.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 59.0, 58.0, 58.0, 58.0, 59.0, 59.0, 60.0], "value": 58.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 81.0, 76.0, 76.0, 77.0, 75.0, 75.0, 75.0, 76.0, 74.0], "value": 76.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 136.0, 137.0, 125.0, 127.0, 135.0, 126.0, 123.0, 173.0, 124.0], "value": 134.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 157.0, 154.0, 156.0, 157.0, 153.0, 155.0, 154.0, 154.0, 153.0], "value": 154.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 62.0, 63.0, 63.0, 62.0, 63.0, 61.0, 63.0], "value": 62.5, "unit": "score"}], "name": "kraken", "value": 1458.6000000000001, "alertThreshold": 2.0}]} 08:29:27 INFO - Return code: 0 08:29:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:29:27 INFO - # TBPL SUCCESS # 08:29:27 INFO - Running post-action listener: _resource_record_post_action 08:29:27 INFO - [mozharness: 2016-12-03 16:29:27.532114Z] Finished run-tests step (success) 08:29:27 INFO - Running post-run listener: _resource_record_post_run 08:29:27 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 354910208; Read time: 0; Write time: 311420 08:29:27 INFO - TinderboxPrint: CPU usage
13.0% 08:29:27 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:29:27 INFO - TinderboxPrint: I/O write bytes / time
354,910,208 / 311,420 08:29:27 INFO - TinderboxPrint: CPU idle
8,286.5 (87.0%) 08:29:27 INFO - TinderboxPrint: CPU user
1,189.4 (12.5%) 08:29:27 INFO - TinderboxPrint: Swap in / out
0 / 0 08:29:27 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108179456; Read time: 0; Write time: 135624 08:29:27 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 246403072; Read time: 0; Write time: 175796 08:29:28 INFO - Running post-run listener: _upload_blobber_files 08:29:28 INFO - Blob upload gear active. 08:29:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:29:28 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:29:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:29:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:29:28 INFO - (blobuploader) - INFO - Open directory for files ... 08:29:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:29:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:29:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:35 INFO - (blobuploader) - INFO - Done attempting. 08:29:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:29:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:29:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:38 INFO - (blobuploader) - INFO - Done attempting. 08:29:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:29:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:29:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:39 INFO - (blobuploader) - INFO - Done attempting. 08:29:39 INFO - (blobuploader) - INFO - Iteration through files over. 08:29:39 INFO - Return code: 0 08:29:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:29:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:29:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/62f31d7a8cffc7c6f36dcaa3c7e1f29a8d8006d549e93bc2e8db95e1d174b805d9badd20f615e4b03e571b06d11ed87045a0ee07973a595feca62ca56ee1aba6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a9c65a8ddd716ff508fe2e48ab0533ad70366d60c4b2b25daf2fb03fb2907aa40555916115c2b5904742bb746030da1fa5afb856e024ef3465858923d964c70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eb549a53bacce6bb94a89334f88bb71f7dc5464bf5cd72587adefe0177a6f4c17212f44cb4f21eca74626a36ef496f4f5669e28aeea4782d25fc8c2ec37ccaa3"} 08:29:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:29:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:29:39 INFO - Contents: 08:29:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/62f31d7a8cffc7c6f36dcaa3c7e1f29a8d8006d549e93bc2e8db95e1d174b805d9badd20f615e4b03e571b06d11ed87045a0ee07973a595feca62ca56ee1aba6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a9c65a8ddd716ff508fe2e48ab0533ad70366d60c4b2b25daf2fb03fb2907aa40555916115c2b5904742bb746030da1fa5afb856e024ef3465858923d964c70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eb549a53bacce6bb94a89334f88bb71f7dc5464bf5cd72587adefe0177a6f4c17212f44cb4f21eca74626a36ef496f4f5669e28aeea4782d25fc8c2ec37ccaa3"} 08:29:39 INFO - Running post-run listener: copy_logs_to_upload_dir 08:29:39 INFO - Copying logs to upload dir... 08:29:39 INFO - mkdir: /builds/slave/test/build/upload/logs 08:29:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.253413 ========= master_lag: 0.99 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-12-03 08:29:39.810577) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-03 08:29:39.817311) ========= 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=cbe409c6de289db6ac707de3000001d4-1480779155.676801-352532681 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/62f31d7a8cffc7c6f36dcaa3c7e1f29a8d8006d549e93bc2e8db95e1d174b805d9badd20f615e4b03e571b06d11ed87045a0ee07973a595feca62ca56ee1aba6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a9c65a8ddd716ff508fe2e48ab0533ad70366d60c4b2b25daf2fb03fb2907aa40555916115c2b5904742bb746030da1fa5afb856e024ef3465858923d964c70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eb549a53bacce6bb94a89334f88bb71f7dc5464bf5cd72587adefe0177a6f4c17212f44cb4f21eca74626a36ef496f4f5669e28aeea4782d25fc8c2ec37ccaa3"} build_url:https://queue.taskcluster.net/v1/task/GMLK47MJRT-aPgSee8NGXg/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011747 build_url: 'https://queue.taskcluster.net/v1/task/GMLK47MJRT-aPgSee8NGXg/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/62f31d7a8cffc7c6f36dcaa3c7e1f29a8d8006d549e93bc2e8db95e1d174b805d9badd20f615e4b03e571b06d11ed87045a0ee07973a595feca62ca56ee1aba6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8a9c65a8ddd716ff508fe2e48ab0533ad70366d60c4b2b25daf2fb03fb2907aa40555916115c2b5904742bb746030da1fa5afb856e024ef3465858923d964c70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/eb549a53bacce6bb94a89334f88bb71f7dc5464bf5cd72587adefe0177a6f4c17212f44cb4f21eca74626a36ef496f4f5669e28aeea4782d25fc8c2ec37ccaa3"}' ========= master_lag: 0.09 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-03 08:29:39.919436) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 08:29:39.919796) ========= 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=cbe409c6de289db6ac707de3000001d4-1480779155.676801-352532681 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004795 ========= master_lag: 0.42 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-03 08:29:40.345057) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-03 08:29:40.345397) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-03 08:29:40.351535) ========= ========= Total master_lag: 1.57 =========