builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-066 starttime: 1484246267.85 results: success (0) buildid: 20170112090117 builduid: 5be27114ca10479593e86562112f670d revision: 8a89dd47e7847c27ffe04b12832f0cdba7262b56 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 10:37:47.846568) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-12 10:37:47.847347) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 10:37:47.847867) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-12 10:37:47.864323) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 10:37:47.864736) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1484246267.213446-354033062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-12 10:37:48-- 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% 87.0M=0s 2017-01-12 10:37:48 (87.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.077704 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 10:37:47.957267) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 10:37:47.957651) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1484246267.213446-354033062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014272 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 10:37:48.007417) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 10:37:48.007805) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8a89dd47e7847c27ffe04b12832f0cdba7262b56 --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 8a89dd47e7847c27ffe04b12832f0cdba7262b56 --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=82c74bd3bc9a11c5833d2010000001e6-1484246267.213446-354033062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-12 10:37:48,995 truncating revision to first 12 chars 2017-01-12 10:37:48,995 Setting DEBUG logging. 2017-01-12 10:37:48,995 attempt 1/10 2017-01-12 10:37:48,995 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8a89dd47e784?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-12 10:37:49,514 unpacking tar archive at: mozilla-aurora-8a89dd47e784/testing/mozharness/ program finished with exit code 0 elapsedTime=0.816631 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 10:37:48.838549) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 10:37:48.838860) ========= script_repo_revision: 8a89dd47e7847c27ffe04b12832f0cdba7262b56 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-12 10:37:48.839259) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 10:37:48.839524) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-12 10:37:48.849056) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-01-12 10:37:48.849475) ========= /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=82c74bd3bc9a11c5833d2010000001e6-1484246267.213446-354033062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:37:49 INFO - MultiFileLogger online at 20170112 10:37:49 in /builds/slave/test 10:37:49 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 10:37:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:37:49 INFO - {'append_to_log': False, 10:37:49 INFO - 'base_work_dir': '/builds/slave/test', 10:37:49 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 10:37:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:37:49 INFO - 'branch': 'Mozilla-Aurora', 10:37:49 INFO - 'buildbot_json_path': 'buildprops.json', 10:37:49 INFO - 'config_files': ('talos/linux_config.py',), 10:37:49 INFO - 'default_actions': ('clobber', 10:37:49 INFO - 'read-buildbot-config', 10:37:49 INFO - 'download-and-extract', 10:37:49 INFO - 'populate-webroot', 10:37:49 INFO - 'create-virtualenv', 10:37:49 INFO - 'install', 10:37:49 INFO - 'run-tests'), 10:37:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:37:49 INFO - 'download_minidump_stackwalk': True, 10:37:49 INFO - 'download_symbols': 'ondemand', 10:37:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:37:49 INFO - 'tooltool.py': '/tools/tooltool.py', 10:37:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:37:49 INFO - '/tools/misc-python/virtualenv.py')}, 10:37:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:37:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:37:49 INFO - 'installer_path': 'installer.exe', 10:37:49 INFO - 'log_level': 'info', 10:37:49 INFO - 'log_name': 'talos', 10:37:49 INFO - 'log_to_console': True, 10:37:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:37:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:37:49 INFO - 'opt_config_files': (), 10:37:49 INFO - 'pip_index': False, 10:37:49 INFO - 'sps_profile': False, 10:37:49 INFO - 'sps_profile_interval': 0, 10:37:49 INFO - 'suite': 'dromaeojs', 10:37:49 INFO - 'system_bits': '32', 10:37:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:37:49 INFO - 'title': 'talos-linux64-ix-066', 10:37:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:37:49 INFO - 'use_talos_json': True, 10:37:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:37:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:37:49 INFO - 'work_dir': 'build'} 10:37:49 INFO - [mozharness: 2017-01-12 18:37:49.933130Z] Running clobber step. 10:37:49 INFO - Running pre-action listener: _resource_record_pre_action 10:37:49 INFO - Running main action method: clobber 10:37:49 INFO - rmtree: /builds/slave/test/build 10:37:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:37:50 INFO - Running post-action listener: _resource_record_post_action 10:37:50 INFO - [mozharness: 2017-01-12 18:37:50.443203Z] Finished clobber step (success) 10:37:50 INFO - [mozharness: 2017-01-12 18:37:50.443304Z] Running read-buildbot-config step. 10:37:50 INFO - Running pre-action listener: _resource_record_pre_action 10:37:50 INFO - Running main action method: read_buildbot_config 10:37:50 INFO - Using buildbot properties: 10:37:50 INFO - { 10:37:50 INFO - "project": "", 10:37:50 INFO - "product": "firefox", 10:37:50 INFO - "script_repo_revision": "production", 10:37:50 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 10:37:50 INFO - "repository": "", 10:37:50 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 10:37:50 INFO - "buildid": "20170112090117", 10:37:50 INFO - "pgo_build": "True", 10:37:50 INFO - "basedir": "/builds/slave/test", 10:37:50 INFO - "buildnumber": 735, 10:37:50 INFO - "slavename": "talos-linux64-ix-066", 10:37:50 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:37:50 INFO - "platform": "ubuntu64_hw", 10:37:50 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 10:37:50 INFO - "branch": "mozilla-aurora", 10:37:50 INFO - "repo_path": "releases/mozilla-aurora", 10:37:50 INFO - "revision": "8a89dd47e7847c27ffe04b12832f0cdba7262b56", 10:37:50 INFO - "stage_platform": "linux64-pgo", 10:37:50 INFO - "builduid": "5be27114ca10479593e86562112f670d", 10:37:50 INFO - "slavebuilddir": "test" 10:37:50 INFO - } 10:37:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/J40wkCC5TIy-aCCdT_VCug/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 10:37:50 INFO - Running post-action listener: _resource_record_post_action 10:37:50 INFO - [mozharness: 2017-01-12 18:37:50.445739Z] Finished read-buildbot-config step (success) 10:37:50 INFO - [mozharness: 2017-01-12 18:37:50.445828Z] Running download-and-extract step. 10:37:50 INFO - Running pre-action listener: _resource_record_pre_action 10:37:50 INFO - Running main action method: download_and_extract 10:37:50 INFO - mkdir: /builds/slave/test/build/tests 10:37: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')]} 10:37:50 INFO - trying https://queue.taskcluster.net/v1/task/J40wkCC5TIy-aCCdT_VCug/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 10:37:50 INFO - Downloading https://queue.taskcluster.net/v1/task/J40wkCC5TIy-aCCdT_VCug/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 10:37:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J40wkCC5TIy-aCCdT_VCug/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 10:37:51 INFO - Downloaded 1361 bytes. 10:37:51 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 10:37:51 INFO - Using the following test package requirements: 10:37:51 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 10:37:51 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 10:37:51 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 10:37:51 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 10:37:51 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 10:37:51 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 10:37:51 INFO - u'jsshell-linux-x86_64.zip'], 10:37:51 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 10:37:51 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 10:37:51 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 10:37:51 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 10:37:51 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 10:37:51 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 10:37:51 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 10:37:51 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 10:37:51 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 10:37:51 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 10:37:51 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 10:37:51 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:37:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J40wkCC5TIy-aCCdT_VCug/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 10:37:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J40wkCC5TIy-aCCdT_VCug/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:37:51 INFO - Fetch https://queue.taskcluster.net/v1/task/J40wkCC5TIy-aCCdT_VCug/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 10:37:51 INFO - Http code: 200 10:37:51 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 10:37:51 INFO - x-amz-cf-id: 455EHyumCj84aUJpGH2yxI_p0Te9VNP1not74ebqjFjmhujWZZizzw== 10:37:51 INFO - x-amz-version-id: DKAe4VOhV31BAQufgmzlNIBBapMsKIi1 10:37:51 INFO - Expected file size: 21948918 10:37:51 INFO - Obtained file size: 21948918 10:37:55 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 10:37:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J40wkCC5TIy-aCCdT_VCug/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 10:37:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J40wkCC5TIy-aCCdT_VCug/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:37:55 INFO - Fetch https://queue.taskcluster.net/v1/task/J40wkCC5TIy-aCCdT_VCug/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 10:37:56 INFO - Http code: 200 10:37:56 INFO - via: 1.1 5ed093c37d643652e278a198e0556a40.cloudfront.net (CloudFront) 10:37:56 INFO - x-amz-cf-id: Bpv0GpDk_8LN68qwI1cmU5WAAiGGA9uzZDnGNdym0ei55u9mvEkarA== 10:37:56 INFO - x-amz-version-id: DKAe4VOhV31BAQufgmzlNIBBapMsKIi1 10:37:56 INFO - Expected file size: 21948918 10:37:56 INFO - Obtained file size: 21948918 10:38:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/J40wkCC5TIy-aCCdT_VCug/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 10:38:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/J40wkCC5TIy-aCCdT_VCug/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:38:01 INFO - Fetch https://queue.taskcluster.net/v1/task/J40wkCC5TIy-aCCdT_VCug/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 10:38:01 INFO - Http code: 200 10:38:01 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 10:38:01 INFO - x-amz-cf-id: TXcMa6Kt3JZE7lXdHksG2l3FAsPhbYtZNvUsGkb_QoXJt8u5xSQs4w== 10:38:01 INFO - x-amz-version-id: 5nIldDQAJVDVE.rtz.lBUx5XNUe7FuB_ 10:38:01 INFO - Expected file size: 14409038 10:38:01 INFO - Obtained file size: 14409038 10:38:02 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')]} 10:38:02 INFO - trying https://queue.taskcluster.net/v1/task/J40wkCC5TIy-aCCdT_VCug/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 10:38:02 INFO - Downloading https://queue.taskcluster.net/v1/task/J40wkCC5TIy-aCCdT_VCug/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 10:38:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/J40wkCC5TIy-aCCdT_VCug/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 10:38:03 INFO - Downloaded 64108910 bytes. 10:38:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/J40wkCC5TIy-aCCdT_VCug/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 10:38:03 INFO - mkdir: /builds/slave/test/properties 10:38:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:38:03 INFO - Writing to file /builds/slave/test/properties/build_url 10:38:03 INFO - Contents: 10:38:03 INFO - build_url:https://queue.taskcluster.net/v1/task/J40wkCC5TIy-aCCdT_VCug/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 10:38:03 INFO - Running post-action listener: _resource_record_post_action 10:38:03 INFO - Running post-action listener: set_extra_try_arguments 10:38:03 INFO - [mozharness: 2017-01-12 18:38:03.977101Z] Finished download-and-extract step (success) 10:38:03 INFO - [mozharness: 2017-01-12 18:38:03.977329Z] Running populate-webroot step. 10:38:03 INFO - Running pre-action listener: _resource_record_pre_action 10:38:03 INFO - Running main action method: populate_webroot 10:38:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:38:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:38:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:38:03 INFO - '--tppagecycles', 10:38:03 INFO - '7'], 10:38:03 INFO - 'tests': ['tsvgm']}}, 10:38:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:38:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:38:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:38:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:38:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:38:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:38:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:38:03 INFO - 'talos_options': ['--disable-e10s'], 10:38:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:38:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:38:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:38:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:38:03 INFO - 'talos_options': ['--disable-e10s'], 10:38:03 INFO - 'tests': ['damp', 'tps']}, 10:38:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:38:03 INFO - 'tests': ['damp', 'tps']}, 10:38:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:38:03 INFO - 'tests': ['dromaeo_dom']}, 10:38:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:38:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:38:03 INFO - 'tests': ['basic_compositor_video']}, 10:38:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:38:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:38:03 INFO - 'tests': ['a11yr', 10:38:03 INFO - 'ts_paint', 10:38:03 INFO - 'tpaint', 10:38:03 INFO - 'sessionrestore', 10:38:03 INFO - 'sessionrestore_no_auto_restore', 10:38:03 INFO - 'tabpaint']}, 10:38:03 INFO - 'other-e10s': {'tests': ['a11yr', 10:38:03 INFO - 'ts_paint', 10:38:03 INFO - 'tpaint', 10:38:03 INFO - 'sessionrestore', 10:38:03 INFO - 'sessionrestore_no_auto_restore', 10:38:03 INFO - 'tabpaint']}, 10:38:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:38:03 INFO - 'ts_paint', 10:38:03 INFO - 'tpaint', 10:38:03 INFO - 'sessionrestore', 10:38:03 INFO - 'sessionrestore_no_auto_restore', 10:38:03 INFO - 'tabpaint']}, 10:38:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:38:03 INFO - 'ts_paint', 10:38:03 INFO - 'tpaint', 10:38:03 INFO - 'sessionrestore', 10:38:03 INFO - 'sessionrestore_no_auto_restore', 10:38:03 INFO - 'tabpaint']}, 10:38:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:38:03 INFO - 'tests': ['a11yr', 10:38:03 INFO - 'ts_paint', 10:38:03 INFO - 'tpaint', 10:38:03 INFO - 'sessionrestore', 10:38:03 INFO - 'sessionrestore_no_auto_restore', 10:38:03 INFO - 'tabpaint']}, 10:38:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:38:03 INFO - 'tests': ['a11yr', 10:38:03 INFO - 'ts_paint', 10:38:03 INFO - 'tpaint', 10:38:03 INFO - 'sessionrestore', 10:38:03 INFO - 'sessionrestore_no_auto_restore', 10:38:03 INFO - 'tabpaint']}, 10:38:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:38:03 INFO - 'tests': ['tsvgx', 10:38:03 INFO - 'tsvgr_opacity', 10:38:03 INFO - 'tart', 10:38:03 INFO - 'tscrollx', 10:38:03 INFO - 'cart']}, 10:38:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:38:03 INFO - 'tsvgr_opacity', 10:38:03 INFO - 'tart', 10:38:03 INFO - 'tscrollx', 10:38:03 INFO - 'cart']}, 10:38:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:38:03 INFO - 'talos_options': ['--disable-e10s'], 10:38:03 INFO - 'tests': ['tp5o']}, 10:38:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:38:03 INFO - 'tests': ['tp5o']}, 10:38:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:38:03 INFO - 'talos_options': ['--disable-e10s', 10:38:03 INFO - '--xperf_path', 10:38:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:38:03 INFO - 'tests': ['tp5n']}, 10:38:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:38:03 INFO - 'talos_options': ['--xperf_path', 10:38:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:38:03 INFO - 'tests': ['tp5n']}}, 10:38:03 INFO - 'talos.zip': {'path': '', 10:38:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:38:03 INFO - Running post-action listener: _resource_record_post_action 10:38:03 INFO - [mozharness: 2017-01-12 18:38:03.992866Z] Finished populate-webroot step (success) 10:38:03 INFO - [mozharness: 2017-01-12 18:38:03.992955Z] Running create-virtualenv step. 10:38:03 INFO - Running pre-action listener: _resource_record_pre_action 10:38:03 INFO - Running main action method: create_virtualenv 10:38:03 INFO - Creating virtualenv /builds/slave/test/build/venv 10:38:03 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 10:38:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:38:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:38:04 INFO - Using real prefix '/usr' 10:38:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:38:04 INFO - Installing distribute.............................................................................................................................................................................................done. 10:38:06 INFO - Installing pip.................done. 10:38:06 INFO - Return code: 0 10:38:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:38:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:38:06 INFO - Reading from file tmpfile_stdout 10:38:06 INFO - Output received: 10:38:06 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) 10:38:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:38:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:38:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:06 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 0x7f71fd3dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229af60>, '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 0x229bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229c1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1484246267.213446-354033062', '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 10:38:06 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 10:38:06 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 10:38:06 INFO - Using env: {'DISPLAY': ':0', 10:38:06 INFO - 'HOME': '/home/cltbld', 10:38:06 INFO - 'LANG': 'en_US.UTF-8', 10:38:06 INFO - 'LANGUAGE': 'en_US:en', 10:38:06 INFO - 'LOGNAME': 'cltbld', 10:38:06 INFO - 'MAIL': '/var/mail/cltbld', 10:38:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:06 INFO - 'MOZ_NO_REMOTE': '1', 10:38:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:06 INFO - 'NO_EM_RESTART': '1', 10:38:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:06 INFO - 'PWD': '/builds/slave/test', 10:38:06 INFO - 'SHELL': '/bin/bash', 10:38:06 INFO - 'SHLVL': '1', 10:38:06 INFO - 'TERM': 'linux', 10:38:06 INFO - 'TMOUT': '86400', 10:38:06 INFO - 'USER': 'cltbld', 10:38:06 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1484246267.213446-354033062', 10:38:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:06 INFO - '_': '/tools/buildbot/bin/python'} 10:38:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:07 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 10:38:07 INFO - Cleaning up... 10:38:07 INFO - Return code: 0 10:38:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:38:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:38:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f71fd3dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229af60>, '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 0x229bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229c1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1484246267.213446-354033062', '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 10:38:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:38:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:38:07 INFO - Using env: {'DISPLAY': ':0', 10:38:07 INFO - 'HOME': '/home/cltbld', 10:38:07 INFO - 'LANG': 'en_US.UTF-8', 10:38:07 INFO - 'LANGUAGE': 'en_US:en', 10:38:07 INFO - 'LOGNAME': 'cltbld', 10:38:07 INFO - 'MAIL': '/var/mail/cltbld', 10:38:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:07 INFO - 'MOZ_NO_REMOTE': '1', 10:38:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:07 INFO - 'NO_EM_RESTART': '1', 10:38:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:07 INFO - 'PWD': '/builds/slave/test', 10:38:07 INFO - 'SHELL': '/bin/bash', 10:38:07 INFO - 'SHLVL': '1', 10:38:07 INFO - 'TERM': 'linux', 10:38:07 INFO - 'TMOUT': '86400', 10:38:07 INFO - 'USER': 'cltbld', 10:38:07 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1484246267.213446-354033062', 10:38:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:07 INFO - '_': '/tools/buildbot/bin/python'} 10:38:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:07 INFO - Downloading/unpacking psutil>=3.1.1 10:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:38:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:38:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:38:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:38:09 INFO - Installing collected packages: psutil 10:38:09 INFO - Running setup.py install for psutil 10:38:09 INFO - building 'psutil._psutil_linux' extension 10:38:09 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 10:38:09 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 10:38:09 INFO - building 'psutil._psutil_posix' extension 10:38:09 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 10:38:09 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 10:38:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:38:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:38:09 INFO - Successfully installed psutil 10:38:09 INFO - Cleaning up... 10:38:09 INFO - Return code: 0 10:38:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:38:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:38:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:38:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f71fd3dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229af60>, '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 0x229bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229c1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1484246267.213446-354033062', '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 10:38:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:38:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:38:09 INFO - Using env: {'DISPLAY': ':0', 10:38:09 INFO - 'HOME': '/home/cltbld', 10:38:09 INFO - 'LANG': 'en_US.UTF-8', 10:38:09 INFO - 'LANGUAGE': 'en_US:en', 10:38:09 INFO - 'LOGNAME': 'cltbld', 10:38:09 INFO - 'MAIL': '/var/mail/cltbld', 10:38:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:09 INFO - 'MOZ_NO_REMOTE': '1', 10:38:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:09 INFO - 'NO_EM_RESTART': '1', 10:38:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:09 INFO - 'PWD': '/builds/slave/test', 10:38:09 INFO - 'SHELL': '/bin/bash', 10:38:09 INFO - 'SHLVL': '1', 10:38:09 INFO - 'TERM': 'linux', 10:38:09 INFO - 'TMOUT': '86400', 10:38:09 INFO - 'USER': 'cltbld', 10:38:09 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1484246267.213446-354033062', 10:38:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:09 INFO - '_': '/tools/buildbot/bin/python'} 10:38:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:38:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:38:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:38:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:38:12 INFO - Installing collected packages: mozsystemmonitor 10:38:12 INFO - Running setup.py install for mozsystemmonitor 10:38:12 INFO - Successfully installed mozsystemmonitor 10:38:12 INFO - Cleaning up... 10:38:12 INFO - Return code: 0 10:38:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:38:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f71fd3dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229af60>, '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 0x229bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229c1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1484246267.213446-354033062', '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 10:38:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:38:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:38:12 INFO - Using env: {'DISPLAY': ':0', 10:38:12 INFO - 'HOME': '/home/cltbld', 10:38:12 INFO - 'LANG': 'en_US.UTF-8', 10:38:12 INFO - 'LANGUAGE': 'en_US:en', 10:38:12 INFO - 'LOGNAME': 'cltbld', 10:38:12 INFO - 'MAIL': '/var/mail/cltbld', 10:38:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:12 INFO - 'MOZ_NO_REMOTE': '1', 10:38:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:12 INFO - 'NO_EM_RESTART': '1', 10:38:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:12 INFO - 'PWD': '/builds/slave/test', 10:38:12 INFO - 'SHELL': '/bin/bash', 10:38:12 INFO - 'SHLVL': '1', 10:38:12 INFO - 'TERM': 'linux', 10:38:12 INFO - 'TMOUT': '86400', 10:38:12 INFO - 'USER': 'cltbld', 10:38:12 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1484246267.213446-354033062', 10:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:12 INFO - '_': '/tools/buildbot/bin/python'} 10:38:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:12 INFO - Downloading/unpacking jsonschema==2.5.1 10:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:38:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:38:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:38:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:38:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:38:14 INFO - Downloading functools32-3.2.3-2.tar.gz 10:38:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:38:14 INFO - warning: no files found matching '*.txt' 10:38:14 INFO - no previously-included directories found matching 'build' 10:38:14 INFO - no previously-included directories found matching 'dist' 10:38:14 INFO - no previously-included directories found matching '.git*' 10:38:14 INFO - Installing collected packages: jsonschema, functools32 10:38:14 INFO - Running setup.py install for functools32 10:38:14 INFO - warning: no files found matching '*.txt' 10:38:14 INFO - no previously-included directories found matching 'build' 10:38:14 INFO - no previously-included directories found matching 'dist' 10:38:14 INFO - no previously-included directories found matching '.git*' 10:38:14 INFO - Successfully installed jsonschema functools32 10:38:14 INFO - Cleaning up... 10:38:15 INFO - Return code: 0 10:38:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:38:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:38:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:15 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 0x7f71fd3dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229af60>, '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 0x229bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229c1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1484246267.213446-354033062', '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 10:38:15 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 10:38:15 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 10:38:15 INFO - Using env: {'DISPLAY': ':0', 10:38:15 INFO - 'HOME': '/home/cltbld', 10:38:15 INFO - 'LANG': 'en_US.UTF-8', 10:38:15 INFO - 'LANGUAGE': 'en_US:en', 10:38:15 INFO - 'LOGNAME': 'cltbld', 10:38:15 INFO - 'MAIL': '/var/mail/cltbld', 10:38:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:15 INFO - 'MOZ_NO_REMOTE': '1', 10:38:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:15 INFO - 'NO_EM_RESTART': '1', 10:38:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:15 INFO - 'PWD': '/builds/slave/test', 10:38:15 INFO - 'SHELL': '/bin/bash', 10:38:15 INFO - 'SHLVL': '1', 10:38:15 INFO - 'TERM': 'linux', 10:38:15 INFO - 'TMOUT': '86400', 10:38:15 INFO - 'USER': 'cltbld', 10:38:15 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1484246267.213446-354033062', 10:38:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:15 INFO - '_': '/tools/buildbot/bin/python'} 10:38:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:38:15 INFO - Cleaning up... 10:38:15 INFO - Return code: 0 10:38:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:38:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:38:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:15 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 0x7f71fd3dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229af60>, '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 0x229bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229c1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1484246267.213446-354033062', '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 10:38:15 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 10:38:15 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 10:38:15 INFO - Using env: {'DISPLAY': ':0', 10:38:15 INFO - 'HOME': '/home/cltbld', 10:38:15 INFO - 'LANG': 'en_US.UTF-8', 10:38:15 INFO - 'LANGUAGE': 'en_US:en', 10:38:15 INFO - 'LOGNAME': 'cltbld', 10:38:15 INFO - 'MAIL': '/var/mail/cltbld', 10:38:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:15 INFO - 'MOZ_NO_REMOTE': '1', 10:38:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:15 INFO - 'NO_EM_RESTART': '1', 10:38:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:15 INFO - 'PWD': '/builds/slave/test', 10:38:15 INFO - 'SHELL': '/bin/bash', 10:38:15 INFO - 'SHLVL': '1', 10:38:15 INFO - 'TERM': 'linux', 10:38:15 INFO - 'TMOUT': '86400', 10:38:15 INFO - 'USER': 'cltbld', 10:38:15 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1484246267.213446-354033062', 10:38:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:15 INFO - '_': '/tools/buildbot/bin/python'} 10:38:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:15 INFO - Downloading/unpacking blobuploader==1.2.4 10:38: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 10:38: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 10:38: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 10:38: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 10:38: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 10:38: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 10:38:17 INFO - Downloading blobuploader-1.2.4.tar.gz 10:38:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:38:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:38:17 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 10:38:17 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 10:38:17 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 10:38:17 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 10:38:17 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 10:38:17 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 10:38:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:38:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:38: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 10:38: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 10:38: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 10:38: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 10:38: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 10:38: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 10:38:18 INFO - Downloading docopt-0.6.1.tar.gz 10:38:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:38:18 INFO - Installing collected packages: blobuploader, requests, docopt 10:38:18 INFO - Running setup.py install for blobuploader 10:38:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:38:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:38:18 INFO - Running setup.py install for requests 10:38:18 INFO - Running setup.py install for docopt 10:38:18 INFO - Successfully installed blobuploader requests docopt 10:38:18 INFO - Cleaning up... 10:38:18 INFO - Return code: 0 10:38:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:38:18 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')]} 10:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:18 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')]} 10:38:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:18 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 0x7f71fd3dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229af60>, '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 0x229bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229c1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1484246267.213446-354033062', '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 10:38:18 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 10:38:18 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 10:38:18 INFO - Using env: {'DISPLAY': ':0', 10:38:18 INFO - 'HOME': '/home/cltbld', 10:38:18 INFO - 'LANG': 'en_US.UTF-8', 10:38:18 INFO - 'LANGUAGE': 'en_US:en', 10:38:18 INFO - 'LOGNAME': 'cltbld', 10:38:18 INFO - 'MAIL': '/var/mail/cltbld', 10:38:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:18 INFO - 'MOZ_NO_REMOTE': '1', 10:38:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:18 INFO - 'NO_EM_RESTART': '1', 10:38:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:18 INFO - 'PWD': '/builds/slave/test', 10:38:18 INFO - 'SHELL': '/bin/bash', 10:38:18 INFO - 'SHLVL': '1', 10:38:18 INFO - 'TERM': 'linux', 10:38:18 INFO - 'TMOUT': '86400', 10:38:18 INFO - 'USER': 'cltbld', 10:38:18 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1484246267.213446-354033062', 10:38:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:18 INFO - '_': '/tools/buildbot/bin/python'} 10:38:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:38:19 INFO - Running setup.py (path:/tmp/pip-2zT21F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:38:19 INFO - Running setup.py (path:/tmp/pip-AZOCbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:38:19 INFO - Running setup.py (path:/tmp/pip-4ZGLid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:38:19 INFO - Running setup.py (path:/tmp/pip-PZog4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:38:19 INFO - Running setup.py (path:/tmp/pip-NxUKcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:38:19 INFO - Running setup.py (path:/tmp/pip-eqg60f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:38:19 INFO - Running setup.py (path:/tmp/pip-8ubEbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:38:19 INFO - Running setup.py (path:/tmp/pip-pQnncA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:38:19 INFO - Running setup.py (path:/tmp/pip-ksubcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:38:19 INFO - Running setup.py (path:/tmp/pip-4Vj0TA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:38:19 INFO - Running setup.py (path:/tmp/pip-FIY9J0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:38:19 INFO - Running setup.py (path:/tmp/pip-BlQg95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:38:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:38:20 INFO - Running setup.py (path:/tmp/pip-5lrGFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:38:20 INFO - Running setup.py (path:/tmp/pip-sliVwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:38:20 INFO - Running setup.py (path:/tmp/pip-jItKP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:38:20 INFO - Running setup.py (path:/tmp/pip-YdNeqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:38:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:38:20 INFO - Running setup.py (path:/tmp/pip-Ec49i6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:38:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:38:20 INFO - Running setup.py install for manifestparser 10:38:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:38:20 INFO - Running setup.py install for mozcrash 10:38:20 INFO - Running setup.py install for mozdebug 10:38:20 INFO - Running setup.py install for mozdevice 10:38:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:38:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:38:20 INFO - Running setup.py install for mozfile 10:38:20 INFO - Running setup.py install for mozhttpd 10:38:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:38:20 INFO - Running setup.py install for mozinfo 10:38:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:38:21 INFO - Running setup.py install for mozInstall 10:38:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:38:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:38:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:38:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:38:21 INFO - Running setup.py install for mozleak 10:38:21 INFO - Running setup.py install for mozlog 10:38:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:38:21 INFO - Running setup.py install for moznetwork 10:38:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:38:21 INFO - Running setup.py install for mozprocess 10:38:21 INFO - Running setup.py install for mozprofile 10:38:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:38:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:38:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:38:21 INFO - Running setup.py install for mozrunner 10:38:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:38:21 INFO - Running setup.py install for mozscreenshot 10:38:21 INFO - Running setup.py install for moztest 10:38:22 INFO - Running setup.py install for mozversion 10:38:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:38:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:38:22 INFO - Cleaning up... 10:38:22 INFO - Return code: 0 10:38:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:38: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')]} 10:38:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38: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')]} 10:38:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:22 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 0x7f71fd3dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229af60>, '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 0x229bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229c1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1484246267.213446-354033062', '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 10:38:22 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 10:38:22 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 10:38:22 INFO - Using env: {'DISPLAY': ':0', 10:38:22 INFO - 'HOME': '/home/cltbld', 10:38:22 INFO - 'LANG': 'en_US.UTF-8', 10:38:22 INFO - 'LANGUAGE': 'en_US:en', 10:38:22 INFO - 'LOGNAME': 'cltbld', 10:38:22 INFO - 'MAIL': '/var/mail/cltbld', 10:38:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:22 INFO - 'MOZ_NO_REMOTE': '1', 10:38:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:22 INFO - 'NO_EM_RESTART': '1', 10:38:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:22 INFO - 'PWD': '/builds/slave/test', 10:38:22 INFO - 'SHELL': '/bin/bash', 10:38:22 INFO - 'SHLVL': '1', 10:38:22 INFO - 'TERM': 'linux', 10:38:22 INFO - 'TMOUT': '86400', 10:38:22 INFO - 'USER': 'cltbld', 10:38:22 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1484246267.213446-354033062', 10:38:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:22 INFO - '_': '/tools/buildbot/bin/python'} 10:38:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:38:22 INFO - Running setup.py (path:/tmp/pip-ZiJ6Hk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:38:22 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)) 10:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:38:22 INFO - Running setup.py (path:/tmp/pip-jre77b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:38:22 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)) 10:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:38:22 INFO - Running setup.py (path:/tmp/pip-XMU37q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:38:22 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)) 10:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:38:22 INFO - Running setup.py (path:/tmp/pip-Q8BG36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:38:22 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)) 10:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:38:22 INFO - Running setup.py (path:/tmp/pip-uxsYf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:38:22 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)) 10:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:38:22 INFO - Running setup.py (path:/tmp/pip-wrWerZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:38:22 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)) 10:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:38:22 INFO - Running setup.py (path:/tmp/pip-DiiJmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:38:22 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)) 10:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:38:22 INFO - Running setup.py (path:/tmp/pip-uP08Es-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:38:22 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)) 10:38:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:38:22 INFO - Running setup.py (path:/tmp/pip-7RqitT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:38:23 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)) 10:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:38:23 INFO - Running setup.py (path:/tmp/pip-q1V5JX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:38:23 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)) 10:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:38:23 INFO - Running setup.py (path:/tmp/pip-A641Ze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:38:23 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)) 10:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:38:23 INFO - Running setup.py (path:/tmp/pip-S23wXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:38:23 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)) 10:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:38:23 INFO - Running setup.py (path:/tmp/pip-XMIn1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:38:23 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)) 10:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:38:23 INFO - Running setup.py (path:/tmp/pip-S6uUxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:38:23 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)) 10:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:38:23 INFO - Running setup.py (path:/tmp/pip-3CPNWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:38:23 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)) 10:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:38:23 INFO - Running setup.py (path:/tmp/pip-56zhZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:38:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 10:38:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:38:23 INFO - Running setup.py (path:/tmp/pip-23YCV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:38:23 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)) 10:38:23 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)) 10:38:23 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)) 10:38:23 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)) 10:38:23 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)) 10:38:23 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)) 10:38:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:38: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 10:38: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 10:38: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 10:38: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 10:38: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 10:38: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 10:38:25 INFO - Downloading blessings-1.6.tar.gz 10:38:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:38:25 INFO - Installing collected packages: blessings 10:38:25 INFO - Running setup.py install for blessings 10:38:25 INFO - Successfully installed blessings 10:38:25 INFO - Cleaning up... 10:38:25 INFO - Return code: 0 10:38:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:38:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:38:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:38:26 INFO - Reading from file tmpfile_stdout 10:38:26 INFO - Current package versions: 10:38:26 INFO - argparse == 1.2.1 10:38:26 INFO - blessings == 1.6 10:38:26 INFO - blobuploader == 1.2.4 10:38:26 INFO - docopt == 0.6.1 10:38:26 INFO - functools32 == 3.2.3-2 10:38:26 INFO - jsonschema == 2.5.1 10:38:26 INFO - manifestparser == 1.1 10:38:26 INFO - mozInstall == 1.12 10:38:26 INFO - mozcrash == 1.0 10:38:26 INFO - mozdebug == 0.1 10:38:26 INFO - mozdevice == 0.48 10:38:26 INFO - mozfile == 1.2 10:38:26 INFO - mozhttpd == 0.7 10:38:26 INFO - mozinfo == 0.9 10:38:26 INFO - mozleak == 0.1 10:38:26 INFO - mozlog == 3.4 10:38:26 INFO - moznetwork == 0.27 10:38:26 INFO - mozprocess == 0.23 10:38:26 INFO - mozprofile == 0.28 10:38:26 INFO - mozrunner == 6.13 10:38:26 INFO - mozscreenshot == 0.1 10:38:26 INFO - mozsystemmonitor == 0.3 10:38:26 INFO - moztest == 0.8 10:38:26 INFO - mozversion == 1.4 10:38:26 INFO - psutil == 3.1.1 10:38:26 INFO - requests == 1.2.3 10:38:26 INFO - wsgiref == 0.1.2 10:38:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:38: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')]} 10:38:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38: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')]} 10:38:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:26 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 0x7f71fd3dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229af60>, '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 0x229bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229c1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1484246267.213446-354033062', '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 10:38:26 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 10:38:26 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 10:38:26 INFO - Using env: {'DISPLAY': ':0', 10:38:26 INFO - 'HOME': '/home/cltbld', 10:38:26 INFO - 'LANG': 'en_US.UTF-8', 10:38:26 INFO - 'LANGUAGE': 'en_US:en', 10:38:26 INFO - 'LOGNAME': 'cltbld', 10:38:26 INFO - 'MAIL': '/var/mail/cltbld', 10:38:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:26 INFO - 'MOZ_NO_REMOTE': '1', 10:38:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:26 INFO - 'NO_EM_RESTART': '1', 10:38:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:26 INFO - 'PWD': '/builds/slave/test', 10:38:26 INFO - 'SHELL': '/bin/bash', 10:38:26 INFO - 'SHLVL': '1', 10:38:26 INFO - 'TERM': 'linux', 10:38:26 INFO - 'TMOUT': '86400', 10:38:26 INFO - 'USER': 'cltbld', 10:38:26 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1484246267.213446-354033062', 10:38:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:26 INFO - '_': '/tools/buildbot/bin/python'} 10:38:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:26 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)) 10:38:26 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)) 10:38:26 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)) 10:38:26 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)) 10:38:26 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)) 10:38:26 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)) 10:38:26 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)) 10:38:26 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)) 10:38:26 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)) 10:38:26 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)) 10:38:26 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)) 10:38:26 INFO - Cleaning up... 10:38:26 INFO - Return code: 0 10:38:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:38: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')]} 10:38:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:38:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38: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')]} 10:38:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:38:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:38:26 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 0x7f71fd3dff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21d08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x229dca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229af60>, '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 0x229bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229c1d0>, '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': '82c74bd3bc9a11c5833d2010000001e6-1484246267.213446-354033062', '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 10:38:26 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 10:38:26 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 10:38:26 INFO - Using env: {'DISPLAY': ':0', 10:38:26 INFO - 'HOME': '/home/cltbld', 10:38:26 INFO - 'LANG': 'en_US.UTF-8', 10:38:26 INFO - 'LANGUAGE': 'en_US:en', 10:38:26 INFO - 'LOGNAME': 'cltbld', 10:38:26 INFO - 'MAIL': '/var/mail/cltbld', 10:38:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:26 INFO - 'MOZ_NO_REMOTE': '1', 10:38:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:26 INFO - 'NO_EM_RESTART': '1', 10:38:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:26 INFO - 'PWD': '/builds/slave/test', 10:38:26 INFO - 'SHELL': '/bin/bash', 10:38:26 INFO - 'SHLVL': '1', 10:38:26 INFO - 'TERM': 'linux', 10:38:26 INFO - 'TMOUT': '86400', 10:38:26 INFO - 'USER': 'cltbld', 10:38:26 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1484246267.213446-354033062', 10:38:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:26 INFO - '_': '/tools/buildbot/bin/python'} 10:38:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:38:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:38:26 INFO - Cleaning up... 10:38:26 INFO - Return code: 0 10:38:26 INFO - Running post-action listener: _resource_record_post_action 10:38:26 INFO - Running post-action listener: _start_resource_monitoring 10:38:26 INFO - Starting resource monitoring. 10:38:26 INFO - [mozharness: 2017-01-12 18:38:26.640630Z] Finished create-virtualenv step (success) 10:38:26 INFO - [mozharness: 2017-01-12 18:38:26.641205Z] Running install step. 10:38:26 INFO - Running pre-action listener: _resource_record_pre_action 10:38:26 INFO - Running main action method: install 10:38:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:38:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:38:26 INFO - Reading from file tmpfile_stdout 10:38:26 INFO - Detecting whether we're running mozinstall >=1.0... 10:38:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:38:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:38:26 INFO - Reading from file tmpfile_stdout 10:38:26 INFO - Output received: 10:38:26 INFO - Usage: mozinstall [options] installer 10:38:26 INFO - Options: 10:38:26 INFO - -h, --help show this help message and exit 10:38:26 INFO - -d DEST, --destination=DEST 10:38:26 INFO - Directory to install application into. [default: 10:38:26 INFO - "/builds/slave/test"] 10:38:26 INFO - --app=APP Application being installed. [default: firefox] 10:38:26 INFO - mkdir: /builds/slave/test/build/application 10:38:26 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'] 10:38:26 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 10:38:42 INFO - Reading from file tmpfile_stdout 10:38:42 INFO - Output received: 10:38:42 INFO - /builds/slave/test/build/application/firefox/firefox 10:38:42 INFO - Running post-action listener: _resource_record_post_action 10:38:42 INFO - [mozharness: 2017-01-12 18:38:42.881897Z] Finished install step (success) 10:38:42 INFO - [mozharness: 2017-01-12 18:38:42.882142Z] Running run-tests step. 10:38:42 INFO - Running pre-action listener: _resource_record_pre_action 10:38:42 INFO - Running main action method: run_tests 10:38:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:38:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:38:42 INFO - Python 2.7.3 10:38:42 INFO - Return code: 0 10:38:42 INFO - grabbing minidump binary from tooltool 10:38:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:38:42 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x229af60>, '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 0x229bd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x229c1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:38:42 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:38:42 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:38:42 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:38:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:38:42 INFO - Return code: 0 10:38:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:38:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:38:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:38:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:38:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:38:42 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/J40wkCC5TIy-aCCdT_VCug/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 10:38:42 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/J40wkCC5TIy-aCCdT_VCug/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 10:38:42 INFO - Using env: {'DISPLAY': ':0', 10:38:42 INFO - 'HOME': '/home/cltbld', 10:38:42 INFO - 'LANG': 'en_US.UTF-8', 10:38:42 INFO - 'LANGUAGE': 'en_US:en', 10:38:42 INFO - 'LOGNAME': 'cltbld', 10:38:42 INFO - 'MAIL': '/var/mail/cltbld', 10:38:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:38:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:38:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:38:42 INFO - 'MOZ_NO_REMOTE': '1', 10:38:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:38:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:38:42 INFO - 'NO_EM_RESTART': '1', 10:38:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:38:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:38:42 INFO - 'PWD': '/builds/slave/test', 10:38:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:38:42 INFO - 'SHELL': '/bin/bash', 10:38:42 INFO - 'SHLVL': '1', 10:38:42 INFO - 'TERM': 'linux', 10:38:42 INFO - 'TMOUT': '86400', 10:38:42 INFO - 'USER': 'cltbld', 10:38:42 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1484246267.213446-354033062', 10:38:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:38:42 INFO - '_': '/tools/buildbot/bin/python'} 10:38:42 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/J40wkCC5TIy-aCCdT_VCug/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 10:38:43 INFO - mozversion application_buildid: 20170112090117 10:38:43 INFO - mozversion application_changeset: 8a89dd47e7847c27ffe04b12832f0cdba7262b56 10:38:43 INFO - mozversion application_display_name: FirefoxDeveloperEdition 10:38:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:38:43 INFO - mozversion application_name: Firefox 10:38:43 INFO - mozversion application_remotingname: firefox-dev 10:38:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:38:43 INFO - mozversion application_vendor: Mozilla 10:38:43 INFO - mozversion application_version: 52.0a2 10:38:43 INFO - mozversion platform_buildid: 20170112090117 10:38:43 INFO - mozversion platform_changeset: 8a89dd47e7847c27ffe04b12832f0cdba7262b56 10:38:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 10:38:43 INFO - mozversion platform_version: 52.0a2 10:38:43 INFO - using testdate: 1484246323 10:38:43 INFO - actual date: 1484246323 10:38:43 INFO - starting webserver on 'localhost:45272' 10:38:43 INFO - SUITE-START | Running 2 tests 10:38:43 INFO - TEST-START | dromaeo_css 10:38:43 INFO - operating with platform_type : linux_ 10:38:43 INFO - Initialising browser for dromaeo_css test... 10:38:43 INFO - TEST-INFO | started process 11906 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt5qNmy/profile http://localhost:45272/getInfo.html) 10:38:47 INFO - PROCESS | 11906 | __metrics Screen width/height:1600/1200 10:38:47 INFO - PROCESS | 11906 | colorDepth:24 10:38:47 INFO - PROCESS | 11906 | Browser inner width/height: 1024/697 10:38:47 INFO - PROCESS | 11906 | __metrics 10:38:48 INFO - PROCESS | 11906 | 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" 10:38:48 INFO - PROCESS | 11906 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:38:48 INFO - PROCESS | 11906 | console.error: PushService: 10:38:48 INFO - PROCESS | 11906 | stateChangeProcessEnqueue: Error transitioning state 10:38:48 INFO - PROCESS | 11906 | UnknownError 10:38:49 INFO - TEST-INFO | 11906: exit 0 10:38:49 INFO - Browser initialized. 10:38:49 INFO - Running cycle 1/1 for dromaeo_css test... 10:38:49 INFO - TEST-INFO | started process 11998 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt5qNmy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:39:01 INFO - PROCESS | 11998 | RSS: Main: 143818752 10:39:01 INFO - PROCESS | 11998 | 10:42:02 INFO - PROCESS | 11998 | Cycle 1(1): loaded http://localhost:45272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45272/tests/dromaeo/cssquery-ext.html) 10:42:03 INFO - PROCESS | 11998 | RSS: Main: 261734400 10:42:03 INFO - PROCESS | 11998 | 10:45:05 INFO - PROCESS | 11998 | Cycle 1(1): loaded http://localhost:45272/tests/dromaeo/cssquery-ext.html (next: http://localhost:45272/tests/dromaeo/cssquery-jquery.html) 10:45:06 INFO - PROCESS | 11998 | RSS: Main: 229367808 10:45:06 INFO - PROCESS | 11998 | 10:48:08 INFO - PROCESS | 11998 | Cycle 1(1): loaded http://localhost:45272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45272/tests/dromaeo/cssquery-mootools.html) 10:48:09 INFO - PROCESS | 11998 | RSS: Main: 219009024 10:48:09 INFO - PROCESS | 11998 | 10:51:11 INFO - PROCESS | 11998 | Cycle 1(1): loaded http://localhost:45272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45272/tests/dromaeo/cssquery-prototype.html) 10:51:11 INFO - PROCESS | 11998 | RSS: Main: 218116096 10:51:11 INFO - PROCESS | 11998 | 10:54:14 INFO - PROCESS | 11998 | Cycle 1(1): loaded http://localhost:45272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45272/tests/dromaeo/cssquery-yui.html) 10:54:14 INFO - PROCESS | 11998 | RSS: Main: 176865280 10:54:14 INFO - PROCESS | 11998 | 10:57:17 INFO - PROCESS | 11998 | Cycle 1(1): loaded http://localhost:45272/tests/dromaeo/cssquery-yui.html (next: http://localhost:45272/tests/dromaeo/cssquery-dojo.html) 10:57:17 INFO - PROCESS | 11998 | RSS: Main: 268369920 10:57:17 INFO - PROCESS | 11998 | 10:57:17 INFO - PROCESS | 11998 | __start_tp_report 10:57:17 INFO - PROCESS | 11998 | _x_x_mozilla_page_load 10:57:17 INFO - PROCESS | 11998 | _x_x_mozilla_page_load_details 10:57:17 INFO - PROCESS | 11998 | |i|pagename|runs| 10:57:17 INFO - PROCESS | 11998 | |0;dojo.html;3179.6661350558193;3202.631697354804;3216.212028053127;3235.6440791512946;3248.0418276608398;5444.591655625829;5540.196671482632;5553.861153471165;5560.249366335549;5566.666000040001;5507.834764957048;5577.52591029762;5588.6646801191955;5591.440855914407;5598.580106492009;5031.949680503203;5044.419891712463;5068.138416469209;5107.8467645970495;5144.305518754976;4919.1637421638225;5086.745662716868;5140.820071297505;5142.254373115896;5146.614003949719;4900.338454308659;4938.432080310757;4973.403191617011;4975.228839529878;4985.800567977295;5051.722155281458;5057.241413787924;5066.670666406671;5068.163752980754;5088.974555127238;4801.991581767833;4971.055499455092;4996.625253106032;5008.874778130576;5032.748362581856;5348.652337598082;5365.651232669864;5390.434004429557;5398.973005134949;5408.269883565747;5811.535077193815;5814.069748840166;5931.673757943311;5934.1098835174635;5937.435943585352;5705.400932902027;5974.522038236931;5979.252593425822;5986.940130598726;6011.669358185298;5352.625316227865;5438.265834112423;5458;5514.503694667499;5544.3346798384455;5952.523798096142;5980.43185897339;5988.880222395528;5992.940070599326;5996.430339117776;5668.7165641718575;5750.856228594319;5751.396103409165;5765.88468230633;5768.048272035151;5782.826515204551;5788;5806.622569532967;5813.534917206698;5908.350081491032;5842.065269556851;5844.532437404998;5847.94152058474;5848.473637372572;5849.356570777211;5814.767409303665;5863.149843272701;5868.765249389977;5882.117682347682;5896.587238893237;4400.4939431965095;4411.801468933906;4414.558544145624;4464.196444639996;4468.994476242884;4005.0788318686864;4017.276890159741;4020.43713880057;4022.8189731462153;4059.817308221137;5633.352164501053;5634.464725851038;5638.956792993309;5640.915386269209;5669.6314739541795;5950.880982380415;5957.702114894325;5959.851003724855;5961.791337303173;5962.135490353961;5372.623916325898;5373.758180881791;5385.596080293915;5573.191887176417;5650.66096034231;4888.633352498577;4916.778744956486;4925.11347957364;4927.384076990376;4929.112759703216;6025.517958563304;6061.151438798572;6071;6126.120738204555;6132.600268413531;5963.582549221686;5964.642121472725;5980.760769569169;5987.7604895805425;5989;6144.324124346229;6165.938340616536;6168.0439531872635;6172.660503672341;6176.536759742948;5579;5608.383077861514;5783.884322313615;5791.913121303268;5826.592138550261;6005.219321488354;6005.669688167192;6006.549508786771;6008.789692360921;6024.638521688713;5780.421957804186;5842.2405087338375;5867.20792692981;5868.295804503487;5873.765049397976;5568.860778480571;5611.5230205433;5621;5656.1798539212405;5836.854078648068;5670.064439367458;5690.459406356389;5701.657900525982;5703.116017017369;5733;5745.683987380734;5748.425157484386;5774.682392468455;5780.075187969905;5781.161731548986;5462.6995515247045;5497.917531236954;5637.88724225505;5641.15382692583;5641.153826925994 10:57:17 INFO - PROCESS | 11998 | |1;ext.html;582.2140110850353;612.8896798576257;613.2395829171828;626.9937300626993;630.8643641617051;33649.158771030736;37048;44116.558834411684;45184.322235166495;45379.319310210376;46471.76764116183;46866.29700554486;46963;46964.76517617407;47010;8902.33232507563;9034;9040.367174297802;9051.59267832949;9053.547322633875;8029.317508011826;8206.466579672333;10497.475126243695;10695.144388448944;10720.195985301094;10888.67333979982;10942.398168100752;10944.945275273612;10954.561817527328;10960.397178155199;10740.08709259714;10771.407572583505;10812.243142979916;10828.783424331548;10838.349699018045;10673.412962287071;10697.304675196086;10721.571137154504;10734;10736.624218152327;43514.12971740548;43672;43798.562014379764;43868.56131438677;43873.78063109664;3130.843457827122;3289.7861638993627;3587.461880717887;3866.4780254665543;3942.5071866016747;32450.51324230115;33465.33069338624;33802.32395352079;33815;34107.147321316916;3943.4084887266854;3974.284628766821;4037.152198038386;4094.549599544048;4121.52602450719;344558;345290.0090495022;345441.27279363695;346192;347201;62927.42411066791;63009;63383.6830815843;63386.68306658437;63467.36532634707;40090.19819603592;41023.1795364091;41045.794771025954;66302.66848665726;66461.66769166123;17331.133443328035;17863.374781882572;17893;17894.731579026324;17901.28394864217;10913;11176.161787865942;13372.264525451194;13663.111897726814;13665.726685466434;19911.502212444804;21229.256976005767;21332.573348532944;21384.893075534525;21405.35783926485;7272.236415176436;7426.220246874001;7535.6985720570565;7600.581967991813;7730.342920851678;1002.4787110702393;1026.2457094035879;1030.314840630987;1114.576460944852;1147.9196456247982;33543.49684754731;33966.66033339635;33985.660143398745;33994.49008264878;34061.48907766386;947.7251597036782;955.5652178259014;998.4807899892015;1027.753339198587;1122.5004872831676;17632.647347052985;17805.03150935279;17844.464666060037;18005.7299140513;18023.459296221135;520022;523558;526200;526363;526937;61237;61714;61804.69097654483;61834.69082654648;61871.69064154741;1173.1553281637207;1265.7215412609212;1344.173333399952;1408.9506867259597;1430.763923952557;32003.83998079995;33835.4924676135;33922.15194620154;34242.71588070127;34369.48445773265;52971.20543191932;53478.73260633672;53576.196357053894;53636.46363536471;53730.19404709011;394216;394996;395953;397258;397845;45108.77445612882;46686.29970550376;49635;49906.25140622966;50249.49750502448;46405.30392044054;47033.52966470292;51818.74090629523;51891.48108519018;52049;42502;42534.78732606441;42610.36084458797;43405.78297108494;44459.33311000402;42511;42715.145697086504;42878.29199819684;43044.35433468438;44961.550384495735;41098;41914.58085419107;44288.557114429736;45240.32139517844;46021.079578407574;42375;43945.34081988837;44366.77816610896;45066.549334506235;45469.54530454653;34405.31189376248;35358.29283414266;35584.46623300601;35672;35833 10:57:17 INFO - PROCESS | 11998 | |2;jquery.html;385.29298736817935;400.9318415869304;416.4066205656939;420.68869036912685;428.23132477203416;14382.49661261856;16183.595410114738;19345.226190952344;19966.20135194594;20149.496262593442;19462.610747785035;19686.803131968674;19743.5064123397;19981.700274495895;20306.18775248992;5757.553039958022;5768.134779783035;5939.703014849262;5999.580029397944;6006;4367.08291258836;4552.385427967231;5890.734916928727;5969.955257829884;5976;6243.531735119862;6475.7733479328235;6523.3150519195515;6606.8017959461295;6701.631410272457;6395.584287021329;6525.738970441201;6553.967230163867;6571.211454625475;6580.93419065808;5704;5789.04480760674;5790.420957904218;5793.681347525884;5801.30384353876;23572.88213558921;24038;24089.518209635884;24218.63672044921;24448.755512444826;2357.351728274721;2612.020492315382;2695.460907818444;3054.312779624589;3072.201227680797;14125.717485650332;14427.49503767363;14840.851591484055;14931.477398291008;14980;2017.8991050447419;2043.4074118505764;2047.846411519127;2055.629986602411;2063.6801295799173;69632;70868.29131708668;71858.64070679613;74729;86695;11183.04944079746;11356.829647555292;11662.650120496399;11884.227525211007;12111;16785.91607041957;16823.663526729397;16841.32634694623;16863.241154148094;16885.240164192393;8355.289800366916;8628.741137765877;8653.69712060075;8843.469391836381;8855.38012339143;8520.829583408296;8561.657533698706;8625.741227763177;8754.56227188638;8759;4586.564276393738;4698.553637404441;4950.504949505021;5060.924086138637;5242.895142097137;2016.7378240828598;2033.4916270932267;2060.402483279862;2088.425682937174;2245.831562632809;881.9029906710257;951.2627713521938;1012.3976234140674;1031.1750599520503;1039.6621098143135;18838.905805470884;19647;19805.20779168846;19878.403647890587;20018.29935952264;947.7820101376584;962.0764066496102;970.3401686853008;998.8351921932945;1073.9677809665723;10017.248706346907;10731.409772462433;10760.892391076146;10764.13886889047;10768.676939691823;535549;541490;546191;551363;555156;58528;96363.51818241004;99215.50392247993;99284;100731.49634251781;1016.654337525245;1030.283952652914;1050.4642632257603;1070.6092276319243;1072.7479042425025;17786.733199001766;17869.821301787335;18230.81769182291;18251.81748182501;18386.264549418407;46379.53620463752;47242;47507.52492475031;47842.760786195846;47999;63272;63683.68158159365;64217.036744449804;64505.67747161422;64962;7881.487703299267;8837.91162088371;8905.599248033983;9277.118673725985;9370.812583748424;12704.555340563036;13615.52345667897;13714.17714937107;13723.176609403468;13909.165450073027;11784.528618855149;12279.324637145042;12445.564405245774;12510.687232819253;12574.559890403792;11840.940795295968;11860.644180674593;12170.087243456954;12428.875711242772;12512.687182820138;12354.320512371905;12379.93810030944;12395.132340736061;12503.4373453193;12637.368131593199;7779.611019448892;8227.79430514218;8383.371247156365;8517.105703901248;8738.432001919855;11066.225364224427;11209.663710088711;11286.097112230838;11315.717107072389;12291.139620226499 10:57:17 INFO - PROCESS | 11998 | |3;mootools.html;1453.1644304524898;1509.9320530576124;1637.688839120567;1763.470958712386;1818.6271814278075;8037.517748935068;8532.658693652254;8580.74257772267;8588.95705521473;8615.827683446327;7509;7676.884846727289;7680.116786569546;7836.882446763303;8444.155584441552;2401.5317013182394;2447.3759191406166;2456.9508609827794;2466.5560199164233;2479.987600062006;2449.1183174057323;2490.5392502387026;2506;2509.0841842727364;2509.372656835791;2421.055788242587;2436.110819550869;2454.067454367338;2457.496213276274;2458.9877050614723;2424.527217192648;2444.987775061122;2448.2899959011866;2450.8161887858305;2453.092355828337;2443.2059580636187;2476.7647073527987;2477.306354220821;2482.007197121148;2482.094035676983;8128.959355203246;8144.796380090486;8158;8199.42604017719;8260.008798944165;5157.5616072633875;5277.472252774692;5294.867628309285;5307.28351672527;5311.7344132793205;3194.648588655246;3298.835058247102;3381.0702056934538;3416.760826742129;3418.1454636340914;997.1424574865609;1037.118449318081;1067.4982758103679;1076.8976947190004;1081.9296745711504;10983.560657573767;11723.648290551211;11777.823332650018;11790;11892.286462812172;4729.196036673774;4862.586680132228;4893.388326459192;4907.509249075135;4913.729744864067;9388.812223755487;9396.71809845692;9402.576884040234;9415.058494150668;9415.199708024895;5407;5413.188021796684;5414.485623865805;5414.648047876875;5416.539594134464;4361.236783562864;4816.54242846929;4966.925496117561;4998.250262460588;5009.298698182258;3549.982250088785;3799;3878.6315300047013;3922.7254092213843;3933.8426462941734;1154.5554961339776;1202.6692659518703;1218.2629509146839;1229.877012298763;1230.028277660656;757.36381439591;777.5140537164273;799.4723482501521;858.9312854971587;868.5657171414293;5616.185653080281;5702.914456283159;5845.035569131131;5876.265466816648;5950.285965684146;889;889.1020069729619;899.5052721003552;953.208836665566;956.9043095690514;3973.8013099345494;4135.338345864648;4158.688098392633;4188.748675079505;4195.958040419557;10100.545475453622;10565.524551395205;10589.364638121584;10592.046715795615;10653.201009924287;10540.420276884692;10542.367457952394;10554.577816887238;10604.840927386096;10605.310654807567;7641.197674244236;7694.384449244159;7892.934453848657;7912.129665736765;8061.677532898619;5786.623869448473;5792.275965504312;5871.119332100219;5955.76176952917;5971.671558064349;9655.517224138905;9663.323567350219;9679.612815487302;9687.70936871895;9726.36778609388;9615.471149086867;9679.612815487584;9794.608215671578;9820.803583928138;9826.705198844045;6618.6690665467495;7041.718331266692;7219.494635375473;7248.34764871143;7297.963510182415;7137.571745695275;7565.848683026198;7758.534487930742;7772.611369431393;7972.362211022988;6884.449244060564;6912.585244885323;6927.203371612128;6951.7914462566205;7068.29317068289;6961.930380696331;7018.5788852666965;7036.542624729376;7045.436365090678;7055.647217638995;6579.868402631825;6590.2421221560135;6673.299303573055;6728.259891412039;6794;5132.307138536399;5136.049830781318;5253.868653283698;5260.210968354624;5288.867778305573;5170.302009228706;5189.11784996544;5304.681719096867;5309.787608495617;5334.199870019528 10:57:17 INFO - PROCESS | 11998 | |4;prototype.html;358.8295559609186;360.3657562689666;361.78293024185484;373.66183603838533;375.5249609244308;5334.399680095975;5425.484578964992;5442.58492791874;5483.862903427416;5488.615796894219;5283.471652834714;5376.51611354978;5379.515843574078;5384.892302153955;5415.972920135404;4287.614114729681;4294.463192100988;4296.140771845628;4309.504406993189;4314.460692413449;4175.206710724968;4265.402843601898;4272.380504826799;4275.700700950934;4282.122164956192;4220.05877296444;4227.583759440576;4254.765987870666;4267.210566045276;4270.807813648377;4224.9226447255905;4230.302000169968;4232.343986682069;4245.87262382129;4247.87256382309;3747.4378843173467;3797.1266608680157;3804.562475315319;3819.102510909934;3832.080300727805;5251.789928402897;5253.579713622901;5285.550728188108;5286.141116984584;5310.468953104697;4862.7325497097645;4864.927026094611;4906.264060390934;4912.214045752698;4934.358533390672;5438.395673276393;5646.745896434671;5652.660840349592;5677.261955945742;5691.231683722686;4184.184084103601;4206.390073439365;4208.726432781859;4210.789460526961;4211.957880421187;5869.413058694139;5871.442212989759;5882.558808089368;5900.763969441217;5903.35063143054;4201.138766552849;4307.396964424983;4313.576519748475;4316.784160791948;4318.244307246219;4281.901868084616;4372.300431930876;4374.703280777617;4378.540253273424;4383.890402739957;4890.779914903838;4932.852014439501;4934.284528743312;4955.207166853286;4956.776945037482;5542.63972841764;5682.374938756733;5705.62913410627;5711.314642242957;5733.598648094677;1463.3195564062762;1468.8457711940307;1471.661517850879;1473.4990103364694;1481.3704175725275;1017.3029710539071;1028.619410818002;1033.7312298802365;1037.8910214427528;1043.1706793099352;5268.947310526845;5308.601854860901;5311.28297679816;5330.7068111253475;5335.839924802262;5572.693501857356;5600.4959553640365;5615.382307946123;5632.6200080980425;5642;5034.446210916796;5281.762320695578;5315;5331.866703332447;5339.252504649352;2956.4826155422716;2980.5976193213637;2989.6412430508044;2995.236214765221;2997.7451916586897;5686.601937864392;5752.878188753237;5763.94236057634;5771.095538472294;5814.325410311304;5669.43305669438;5942.940570594239;5972.343042265347;5987.850303742442;5989.753842309134;6023.969880150571;6035.171862510062;6035.245594300713;6046.606970546901;6048.42539958712;5688.431156884279;5846.56150788684;5866.2373891393845;5910.911336330045;5920.141579471038;5804.506616937608;5829.921464528906;5836.591438599257;5837.67892765902;5871.236739223874;5832.445917637818;5951.910721339097;6001.909971350346;6016.939830601813;6039.497091686723;3956.4460975462885;4015.317396042621;4124.649404800625;4146.5853414658295;4203.936940945827;5803.216565763568;5804.970975145097;5854.268216472941;5865.149553314831;5872.735726892385;5616.6068375213345;5740.339860916049;5752.482276594959;5753.367129615655;5766.279215098113;5663.093904975184;5667.971660141673;5677.744501497526;5682.6306290091015;5701.315842098975;5616.213730077874;5632.802851900164;5638.746256418389;5641.223014750341;5665.178549110438;5494.945050549603;5675.3394060829705;5678.858028549319;5703.7433315500075;5731.541476681939;5547.805826796042;5560.749766260447;5564.4991950724625;5584;5594.216809646734 10:57:17 INFO - PROCESS | 11998 | |5;yui.html;688.8691148681753;734.14105496569;746.5371469688793;776.386654542911;811.7037281392294;14964.700705985873;15706.921465392657;15739.527814165593;15753.842461575381;15783.053016818985;14041.22773247471;14067.226302553356;14186.006979511412;14202.573922782307;14212.857871421284;699.440447641887;716.1227496316995;797.9321757650607;822.5681517203457;824.9133840946704;842.6713581703141;847.6228078505068;849.8852654891604;850.2857599616322;851.5103815306223;882.2853488674194;882.9117088291151;883.7569668341225;883.9513826739527;884.5488800711619;729.9233580474054;744.9702011919517;870.0690261420283;876.5617191404298;881.4534988307258;651.4072194303209;652.3248437866785;652.8302641313245;652.8759535688251;653.3564439027554;15031.323590438347;15308.540743777705;15331.386744530206;15367.385304587802;15385.615359616098;13912.234827084507;13983.440662373492;14042;14232.430702771877;14523;13011.414486348138;13083.598813578014;13170.60488185356;13326.666833329147;13659;4607.401037865089;4642.1876171670165;4678.298255261704;4796.040791841646;4806;67567.3243267566;68092.3190768096;69028.30971690269;69607.65196173987;69885.65057174732;11537.48081336342;11552.480138393792;11617.709557260967;11783.88216117845;11977.820332695017;20415.387538373874;20418.795812041688;20533.58932821335;20715.378538643865;21021.579568408546;8213.79465513367;8654.697085601974;8667.956660216658;8741.08218637034;8789.692360767342;4740.14677358072;4755.548222918817;4817.349657796222;4826.6621336506105;4937.481564435754;3432.8970130896114;3513.7540372174212;3531.2760884018717;3533.116720819795;3536.487209354629;649.2403887451693;649.9772507962199;650.8372906773307;682.0315152483486;687.9071325371111;591.2963573347788;622.9099076615922;627.645380360095;671.7380221713536;718.1956209045902;8827.955860220658;9353.672621458216;9501.477418742035;9594;9618.374805637612;668.8695704337607;692.5498426023024;698.9650517474207;710.2364957670525;717.3579646216607;4396.384506169139;4533.727976321431;4545.659075569345;4558.840440584564;4590.770461476913;54153.45846541563;55251.02740753352;88459;90249;93081.53459232795;66359.33640663628;67637;77751.61124194456;79036;79037.60481197672;64541.67729161324;65026.67486662631;65348.67325663341;65394.346056539776;66325.33674663288;9512.429254244767;9631.133198012212;9699.563519641773;9718.271129665445;9773.364731292444;43201.35197972096;43317;44064;45418;46404.30393544167;53769;54447.72776136094;55194;62151;63208.36791632209;12520.561780337644;12788.424520896397;12868.099233053596;12890.935545322589;12946.546870859474;13913.443462261395;14056.875449963774;14094.718105637625;14438.566842994727;14668.853311466748;12150.270983741004;13000.739985200433;13187.406566704329;13298.933505332412;13327.933360333136;12927.870721293042;13467;13750.518731844337;13814.309284535531;13898.72202555923;12657.303848288433;13261.336933153496;13453.125546839425;14109.153450792985;14180.432782688576;11430.14273929442;11509.942450287695;11733;12128.785871744172;12240;11516.769664606829;11521.308721476738;11930.522779088738;12120.575779847662;12298.139130260795 10:57:17 INFO - PROCESS | 11998 | __end_tp_report 10:57:17 INFO - PROCESS | 11998 | __start_cc_report 10:57:17 INFO - PROCESS | 11998 | _x_x_mozilla_cycle_collect,1087 10:57:17 INFO - PROCESS | 11998 | __end_cc_report 10:57:17 INFO - PROCESS | 11998 | __startTimestamp1484247437688__endTimestamp 10:57:17 INFO - PROCESS | 11998 | 10:57:17 INFO - PROCESS | 11998 | ------- Summary: start ------- 10:57:17 INFO - PROCESS | 11998 | Number of tests: 6 10:57:17 INFO - PROCESS | 11998 | 10:57:17 INFO - PROCESS | 11998 | [#0] dojo.html Cycles:165 Average:5464.76 Median:5641.15 stddev:626.09 (11.1%) stddev-sans-first:601.80 10:57:17 INFO - PROCESS | 11998 | Values: 3179.7 3202.6 3216.2 3235.6 3248.0 5444.6 5540.2 5553.9 5560.2 5566.7 5507.8 5577.5 5588.7 5591.4 5598.6 5031.9 5044.4 5068.1 5107.8 5144.3 4919.2 5086.7 5140.8 5142.3 5146.6 4900.3 4938.4 4973.4 4975.2 4985.8 5051.7 5057.2 5066.7 5068.2 5089.0 4802.0 4971.1 4996.6 5008.9 5032.7 5348.7 5365.7 5390.4 5399.0 5408.3 5811.5 5814.1 5931.7 5934.1 5937.4 5705.4 5974.5 5979.3 5986.9 6011.7 5352.6 5438.3 5458.0 5514.5 5544.3 5952.5 5980.4 5988.9 5992.9 5996.4 5668.7 5750.9 5751.4 5765.9 5768.0 5782.8 5788.0 5806.6 5813.5 5908.4 5842.1 5844.5 5847.9 5848.5 5849.4 5814.8 5863.1 5868.8 5882.1 5896.6 4400.5 4411.8 4414.6 4464.2 4469.0 4005.1 4017.3 4020.4 4022.8 4059.8 5633.4 5634.5 5639.0 5640.9 5669.6 5950.9 5957.7 5959.9 5961.8 5962.1 5372.6 5373.8 5385.6 5573.2 5650.7 4888.6 4916.8 4925.1 4927.4 4929.1 6025.5 6061.2 6071.0 6126.1 6132.6 5963.6 5964.6 5980.8 5987.8 5989.0 6144.3 6165.9 6168.0 6172.7 6176.5 5579.0 5608.4 5783.9 5791.9 5826.6 6005.2 6005.7 6006.5 6008.8 6024.6 5780.4 5842.2 5867.2 5868.3 5873.8 5568.9 5611.5 5621.0 5656.2 5836.9 5670.1 5690.5 5701.7 5703.1 5733.0 5745.7 5748.4 5774.7 5780.1 5781.2 5462.7 5497.9 5637.9 5641.2 5641.2 10:57:17 INFO - PROCESS | 11998 | 10:57:17 INFO - PROCESS | 11998 | [#1] ext.html Cycles:180 Average:60440.63 Median:4065.85 stddev:113144.40 (2782.8%) stddev-sans-first:113372.54 10:57:17 INFO - PROCESS | 11998 | Values: 582.2 612.9 613.2 627.0 630.9 33649.2 37048.0 44116.6 45184.3 45379.3 46471.8 46866.3 46963.0 46964.8 47010.0 8902.3 9034.0 9040.4 9051.6 9053.5 8029.3 8206.5 10497.5 10695.1 10720.2 10888.7 10942.4 10944.9 10954.6 10960.4 10740.1 10771.4 10812.2 10828.8 10838.3 10673.4 10697.3 10721.6 10734.0 10736.6 43514.1 43672.0 43798.6 43868.6 43873.8 3130.8 3289.8 3587.5 3866.5 3942.5 32450.5 33465.3 33802.3 33815.0 34107.1 3943.4 3974.3 4037.2 4094.5 4121.5 344558.0 345290.0 345441.3 346192.0 347201.0 62927.4 63009.0 63383.7 63386.7 63467.4 40090.2 41023.2 41045.8 66302.7 66461.7 17331.1 17863.4 17893.0 17894.7 17901.3 10913.0 11176.2 13372.3 13663.1 13665.7 19911.5 21229.3 21332.6 21384.9 21405.4 7272.2 7426.2 7535.7 7600.6 7730.3 1002.5 1026.2 1030.3 1114.6 1147.9 33543.5 33966.7 33985.7 33994.5 34061.5 947.7 955.6 998.5 1027.8 1122.5 17632.6 17805.0 17844.5 18005.7 18023.5 520022.0 523558.0 526200.0 526363.0 526937.0 61237.0 61714.0 61804.7 61834.7 61871.7 1173.2 1265.7 1344.2 1409.0 1430.8 32003.8 33835.5 33922.2 34242.7 34369.5 52971.2 53478.7 53576.2 53636.5 53730.2 394216.0 394996.0 395953.0 397258.0 397845.0 45108.8 46686.3 49635.0 49906.3 50249.5 46405.3 47033.5 51818.7 51891.5 52049.0 42502.0 42534.8 42610.4 43405.8 44459.3 42511.0 42715.1 42878.3 43044.4 44961.6 41098.0 41914.6 44288.6 45240.3 46021.1 42375.0 43945.3 44366.8 45066.5 45469.5 34405.3 35358.3 35584.5 35672.0 35833.0 10:57:17 INFO - PROCESS | 11998 | 10:57:17 INFO - PROCESS | 11998 | [#2] jquery.html Cycles:180 Average:31059.67 Median:13530.39 stddev:89682.07 (662.8%) stddev-sans-first:89904.07 10:57:17 INFO - PROCESS | 11998 | Values: 385.3 400.9 416.4 420.7 428.2 14382.5 16183.6 19345.2 19966.2 20149.5 19462.6 19686.8 19743.5 19981.7 20306.2 5757.6 5768.1 5939.7 5999.6 6006.0 4367.1 4552.4 5890.7 5970.0 5976.0 6243.5 6475.8 6523.3 6606.8 6701.6 6395.6 6525.7 6554.0 6571.2 6580.9 5704.0 5789.0 5790.4 5793.7 5801.3 23572.9 24038.0 24089.5 24218.6 24448.8 2357.4 2612.0 2695.5 3054.3 3072.2 14125.7 14427.5 14840.9 14931.5 14980.0 2017.9 2043.4 2047.8 2055.6 2063.7 69632.0 70868.3 71858.6 74729.0 86695.0 11183.0 11356.8 11662.7 11884.2 12111.0 16785.9 16823.7 16841.3 16863.2 16885.2 8355.3 8628.7 8653.7 8843.5 8855.4 8520.8 8561.7 8625.7 8754.6 8759.0 4586.6 4698.6 4950.5 5060.9 5242.9 2016.7 2033.5 2060.4 2088.4 2245.8 881.9 951.3 1012.4 1031.2 1039.7 18838.9 19647.0 19805.2 19878.4 20018.3 947.8 962.1 970.3 998.8 1074.0 10017.2 10731.4 10760.9 10764.1 10768.7 535549.0 541490.0 546191.0 551363.0 555156.0 58528.0 96363.5 99215.5 99284.0 100731.5 1016.7 1030.3 1050.5 1070.6 1072.7 17786.7 17869.8 18230.8 18251.8 18386.3 46379.5 47242.0 47507.5 47842.8 47999.0 63272.0 63683.7 64217.0 64505.7 64962.0 7881.5 8837.9 8905.6 9277.1 9370.8 12704.6 13615.5 13714.2 13723.2 13909.2 11784.5 12279.3 12445.6 12510.7 12574.6 11840.9 11860.6 12170.1 12428.9 12512.7 12354.3 12379.9 12395.1 12503.4 12637.4 7779.6 8227.8 8383.4 8517.1 8738.4 11066.2 11209.7 11286.1 11315.7 12291.1 10:57:17 INFO - PROCESS | 11998 | 10:57:17 INFO - PROCESS | 11998 | [#3] mootools.html Cycles:180 Average:5582.58 Median:5308.54 stddev:3046.36 (57.4%) stddev-sans-first:3039.10 10:57:17 INFO - PROCESS | 11998 | Values: 1453.2 1509.9 1637.7 1763.5 1818.6 8037.5 8532.7 8580.7 8589.0 8615.8 7509.0 7676.9 7680.1 7836.9 8444.2 2401.5 2447.4 2457.0 2466.6 2480.0 2449.1 2490.5 2506.0 2509.1 2509.4 2421.1 2436.1 2454.1 2457.5 2459.0 2424.5 2445.0 2448.3 2450.8 2453.1 2443.2 2476.8 2477.3 2482.0 2482.1 8129.0 8144.8 8158.0 8199.4 8260.0 5157.6 5277.5 5294.9 5307.3 5311.7 3194.6 3298.8 3381.1 3416.8 3418.1 997.1 1037.1 1067.5 1076.9 1081.9 10983.6 11723.6 11777.8 11790.0 11892.3 4729.2 4862.6 4893.4 4907.5 4913.7 9388.8 9396.7 9402.6 9415.1 9415.2 5407.0 5413.2 5414.5 5414.6 5416.5 4361.2 4816.5 4966.9 4998.3 5009.3 3550.0 3799.0 3878.6 3922.7 3933.8 1154.6 1202.7 1218.3 1229.9 1230.0 757.4 777.5 799.5 858.9 868.6 5616.2 5702.9 5845.0 5876.3 5950.3 889.0 889.1 899.5 953.2 956.9 3973.8 4135.3 4158.7 4188.7 4196.0 10100.5 10565.5 10589.4 10592.0 10653.2 10540.4 10542.4 10554.6 10604.8 10605.3 7641.2 7694.4 7892.9 7912.1 8061.7 5786.6 5792.3 5871.1 5955.8 5971.7 9655.5 9663.3 9679.6 9687.7 9726.4 9615.5 9679.6 9794.6 9820.8 9826.7 6618.7 7041.7 7219.5 7248.3 7298.0 7137.6 7565.8 7758.5 7772.6 7972.4 6884.4 6912.6 6927.2 6951.8 7068.3 6961.9 7018.6 7036.5 7045.4 7055.6 6579.9 6590.2 6673.3 6728.3 6794.0 5132.3 5136.0 5253.9 5260.2 5288.9 5170.3 5189.1 5304.7 5309.8 5334.2 10:57:17 INFO - PROCESS | 11998 | 10:57:17 INFO - PROCESS | 11998 | [#4] prototype.html Cycles:180 Average:4788.40 Median:5337.55 stddev:1383.24 (25.9%) stddev-sans-first:1346.57 10:57:17 INFO - PROCESS | 11998 | Values: 358.8 360.4 361.8 373.7 375.5 5334.4 5425.5 5442.6 5483.9 5488.6 5283.5 5376.5 5379.5 5384.9 5416.0 4287.6 4294.5 4296.1 4309.5 4314.5 4175.2 4265.4 4272.4 4275.7 4282.1 4220.1 4227.6 4254.8 4267.2 4270.8 4224.9 4230.3 4232.3 4245.9 4247.9 3747.4 3797.1 3804.6 3819.1 3832.1 5251.8 5253.6 5285.6 5286.1 5310.5 4862.7 4864.9 4906.3 4912.2 4934.4 5438.4 5646.7 5652.7 5677.3 5691.2 4184.2 4206.4 4208.7 4210.8 4212.0 5869.4 5871.4 5882.6 5900.8 5903.4 4201.1 4307.4 4313.6 4316.8 4318.2 4281.9 4372.3 4374.7 4378.5 4383.9 4890.8 4932.9 4934.3 4955.2 4956.8 5542.6 5682.4 5705.6 5711.3 5733.6 1463.3 1468.8 1471.7 1473.5 1481.4 1017.3 1028.6 1033.7 1037.9 1043.2 5268.9 5308.6 5311.3 5330.7 5335.8 5572.7 5600.5 5615.4 5632.6 5642.0 5034.4 5281.8 5315.0 5331.9 5339.3 2956.5 2980.6 2989.6 2995.2 2997.7 5686.6 5752.9 5763.9 5771.1 5814.3 5669.4 5942.9 5972.3 5987.9 5989.8 6024.0 6035.2 6035.2 6046.6 6048.4 5688.4 5846.6 5866.2 5910.9 5920.1 5804.5 5829.9 5836.6 5837.7 5871.2 5832.4 5951.9 6001.9 6016.9 6039.5 3956.4 4015.3 4124.6 4146.6 4203.9 5803.2 5805.0 5854.3 5865.1 5872.7 5616.6 5740.3 5752.5 5753.4 5766.3 5663.1 5668.0 5677.7 5682.6 5701.3 5616.2 5632.8 5638.7 5641.2 5665.2 5494.9 5675.3 5678.9 5703.7 5731.5 5547.8 5560.7 5564.5 5584.0 5594.2 10:57:17 INFO - PROCESS | 11998 | 10:57:17 INFO - PROCESS | 11998 | [#5] yui.html Cycles:180 Average:17613.73 Median:4801.02 stddev:22382.79 (466.2%) stddev-sans-first:22409.49 10:57:17 INFO - PROCESS | 11998 | Values: 688.9 734.1 746.5 776.4 811.7 14964.7 15706.9 15739.5 15753.8 15783.1 14041.2 14067.2 14186.0 14202.6 14212.9 699.4 716.1 797.9 822.6 824.9 842.7 847.6 849.9 850.3 851.5 882.3 882.9 883.8 884.0 884.5 729.9 745.0 870.1 876.6 881.5 651.4 652.3 652.8 652.9 653.4 15031.3 15308.5 15331.4 15367.4 15385.6 13912.2 13983.4 14042.0 14232.4 14523.0 13011.4 13083.6 13170.6 13326.7 13659.0 4607.4 4642.2 4678.3 4796.0 4806.0 67567.3 68092.3 69028.3 69607.7 69885.7 11537.5 11552.5 11617.7 11783.9 11977.8 20415.4 20418.8 20533.6 20715.4 21021.6 8213.8 8654.7 8668.0 8741.1 8789.7 4740.1 4755.5 4817.3 4826.7 4937.5 3432.9 3513.8 3531.3 3533.1 3536.5 649.2 650.0 650.8 682.0 687.9 591.3 622.9 627.6 671.7 718.2 8828.0 9353.7 9501.5 9594.0 9618.4 668.9 692.5 699.0 710.2 717.4 4396.4 4533.7 4545.7 4558.8 4590.8 54153.5 55251.0 88459.0 90249.0 93081.5 66359.3 67637.0 77751.6 79036.0 79037.6 64541.7 65026.7 65348.7 65394.3 66325.3 9512.4 9631.1 9699.6 9718.3 9773.4 43201.4 43317.0 44064.0 45418.0 46404.3 53769.0 54447.7 55194.0 62151.0 63208.4 12520.6 12788.4 12868.1 12890.9 12946.5 13913.4 14056.9 14094.7 14438.6 14668.9 12150.3 13000.7 13187.4 13298.9 13327.9 12927.9 13467.0 13750.5 13814.3 13898.7 12657.3 13261.3 13453.1 14109.2 14180.4 11430.1 11509.9 11733.0 12128.8 12240.0 11516.8 11521.3 11930.5 12120.6 12298.1 10:57:17 INFO - PROCESS | 11998 | -------- Summary: end -------- 10:57:17 INFO - PROCESS | 11998 | 10:57:18 INFO - TEST-INFO | 11998: exit 0 10:57:18 INFO - TEST-OK | dromaeo_css | took 1115291ms 10:57:18 INFO - TEST-START | kraken 10:57:18 INFO - operating with platform_type : linux_ 10:57:18 INFO - Initialising browser for kraken test... 10:57:18 INFO - TEST-INFO | started process 12315 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4GWJBt/profile http://localhost:45272/getInfo.html) 10:57:22 INFO - PROCESS | 12315 | __metrics Screen width/height:1600/1200 10:57:22 INFO - PROCESS | 12315 | colorDepth:24 10:57:22 INFO - PROCESS | 12315 | Browser inner width/height: 1024/697 10:57:22 INFO - PROCESS | 12315 | __metrics 10:57:23 INFO - PROCESS | 12315 | 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" 10:57:23 INFO - PROCESS | 12315 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:57:23 INFO - PROCESS | 12315 | console.error: PushService: 10:57:23 INFO - PROCESS | 12315 | stateChangeProcessEnqueue: Error transitioning state 10:57:23 INFO - PROCESS | 12315 | UnknownError 10:57:24 INFO - TEST-INFO | 12315: exit 0 10:57:24 INFO - Browser initialized. 10:57:24 INFO - Running cycle 1/1 for kraken test... 10:57:24 INFO - TEST-INFO | started process 12407 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4GWJBt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:57:36 INFO - PROCESS | 12407 | RSS: Main: 144220160 10:57:36 INFO - PROCESS | 12407 | 10:57:38 INFO - PROCESS | 12407 | Cycle 1(1): loaded http://localhost:45272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45272/tests/kraken/driver.html?testName=audio-beat-detection) 10:57:39 INFO - PROCESS | 12407 | RSS: Main: 185954304 10:57:39 INFO - PROCESS | 12407 | 10:57:42 INFO - PROCESS | 12407 | Cycle 1(1): loaded http://localhost:45272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45272/tests/kraken/driver.html?testName=audio-dft) 10:57:42 INFO - PROCESS | 12407 | RSS: Main: 175341568 10:57:42 INFO - PROCESS | 12407 | 10:57:45 INFO - PROCESS | 12407 | Cycle 1(1): loaded http://localhost:45272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45272/tests/kraken/driver.html?testName=audio-fft) 10:57:46 INFO - PROCESS | 12407 | RSS: Main: 266653696 10:57:46 INFO - PROCESS | 12407 | 10:57:48 INFO - PROCESS | 12407 | Cycle 1(1): loaded http://localhost:45272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45272/tests/kraken/driver.html?testName=audio-oscillator) 10:57:48 INFO - PROCESS | 12407 | RSS: Main: 172994560 10:57:48 INFO - PROCESS | 12407 | 10:57:50 INFO - PROCESS | 12407 | Cycle 1(1): loaded http://localhost:45272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:57:51 INFO - PROCESS | 12407 | RSS: Main: 175448064 10:57:51 INFO - PROCESS | 12407 | 10:57:54 INFO - PROCESS | 12407 | Cycle 1(1): loaded http://localhost:45272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45272/tests/kraken/driver.html?testName=imaging-darkroom) 10:57:55 INFO - PROCESS | 12407 | RSS: Main: 213639168 10:57:55 INFO - PROCESS | 12407 | 10:57:58 INFO - PROCESS | 12407 | Cycle 1(1): loaded http://localhost:45272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45272/tests/kraken/driver.html?testName=imaging-desaturate) 10:57:58 INFO - PROCESS | 12407 | RSS: Main: 213299200 10:57:58 INFO - PROCESS | 12407 | 10:58:01 INFO - PROCESS | 12407 | Cycle 1(1): loaded http://localhost:45272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45272/tests/kraken/driver.html?testName=json-parse-financial) 10:58:02 INFO - PROCESS | 12407 | RSS: Main: 211755008 10:58:02 INFO - PROCESS | 12407 | 10:58:03 INFO - PROCESS | 12407 | Cycle 1(1): loaded http://localhost:45272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:58:04 INFO - PROCESS | 12407 | RSS: Main: 173973504 10:58:04 INFO - PROCESS | 12407 | 10:58:05 INFO - PROCESS | 12407 | Cycle 1(1): loaded http://localhost:45272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45272/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:58:06 INFO - PROCESS | 12407 | RSS: Main: 180887552 10:58:06 INFO - PROCESS | 12407 | 10:58:08 INFO - PROCESS | 12407 | Cycle 1(1): loaded http://localhost:45272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:58:09 INFO - PROCESS | 12407 | RSS: Main: 189796352 10:58:09 INFO - PROCESS | 12407 | 10:58:11 INFO - PROCESS | 12407 | Cycle 1(1): loaded http://localhost:45272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:58:12 INFO - PROCESS | 12407 | RSS: Main: 197844992 10:58:12 INFO - PROCESS | 12407 | 10:58:15 INFO - PROCESS | 12407 | Cycle 1(1): loaded http://localhost:45272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:58:15 INFO - PROCESS | 12407 | RSS: Main: 194912256 10:58:15 INFO - PROCESS | 12407 | 10:58:17 INFO - PROCESS | 12407 | Cycle 1(1): loaded http://localhost:45272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45272/tests/kraken/driver.html?testName=ai-astar) 10:58:17 INFO - PROCESS | 12407 | RSS: Main: 247050240 10:58:17 INFO - PROCESS | 12407 | 10:58:17 INFO - PROCESS | 12407 | __start_tp_report 10:58:17 INFO - PROCESS | 12407 | _x_x_mozilla_page_load 10:58:17 INFO - PROCESS | 12407 | _x_x_mozilla_page_load_details 10:58:17 INFO - PROCESS | 12407 | |i|pagename|runs| 10:58:17 INFO - PROCESS | 12407 | |0;ai-astar;102;112;112;110;114;111;111;111;111;110 10:58:17 INFO - PROCESS | 12407 | |1;audio-beat-detection;143;121;118;161;117;115;115;118;156;118 10:58:17 INFO - PROCESS | 12407 | |2;audio-dft;163;160;161;162;160;160;159;161;160;160 10:58:17 INFO - PROCESS | 12407 | |3;audio-fft;75;76;73;105;75;76;75;75;96;75 10:58:17 INFO - PROCESS | 12407 | |4;audio-oscillator;83;81;113;82;81;81;98;82;81;99 10:58:17 INFO - PROCESS | 12407 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;116;117;116 10:58:17 INFO - PROCESS | 12407 | |6;imaging-darkroom;145;145;147;146;146;145;146;146;146;146 10:58:17 INFO - PROCESS | 12407 | |7;imaging-desaturate;85;85;85;85;85;85;84;85;84;85 10:58:17 INFO - PROCESS | 12407 | |8;json-parse-financial;52;51;50;50;51;51;51;50;49;51 10:58:17 INFO - PROCESS | 12407 | |9;json-stringify-tinderbox;72;64;64;60;60;61;59;58;60;59 10:58:17 INFO - PROCESS | 12407 | |10;stanford-crypto-aes;76;80;75;85;75;74;83;77;74;76 10:58:17 INFO - PROCESS | 12407 | |11;stanford-crypto-ccm;129;123;129;128;120;124;128;117;152;120 10:58:17 INFO - PROCESS | 12407 | |12;stanford-crypto-pbkdf2;159;154;154;153;155;155;155;156;156;163 10:58:17 INFO - PROCESS | 12407 | |13;stanford-crypto-sha256-iterative;62;62;62;62;62;61;65;61;61;64 10:58:17 INFO - PROCESS | 12407 | __end_tp_report 10:58:17 INFO - PROCESS | 12407 | __start_cc_report 10:58:17 INFO - PROCESS | 12407 | _x_x_mozilla_cycle_collect,1569 10:58:17 INFO - PROCESS | 12407 | __end_cc_report 10:58:17 INFO - PROCESS | 12407 | __startTimestamp1484247497526__endTimestamp 10:58:17 INFO - PROCESS | 12407 | 10:58:17 INFO - PROCESS | 12407 | ------- Summary: start ------- 10:58:17 INFO - PROCESS | 12407 | Number of tests: 14 10:58:17 INFO - PROCESS | 12407 | 10:58:17 INFO - PROCESS | 12407 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:3.17 (2.9%) stddev-sans-first:1.22 10:58:17 INFO - PROCESS | 12407 | Values: 102.0 112.0 112.0 110.0 114.0 111.0 111.0 111.0 111.0 110.0 10:58:17 INFO - PROCESS | 12407 | 10:58:17 INFO - PROCESS | 12407 | [#1] audio-beat-detection Cycles:10 Average:128.20 Median:119.50 stddev:17.97 (15.0%) stddev-sans-first:18.24 10:58:17 INFO - PROCESS | 12407 | Values: 143.0 121.0 118.0 161.0 117.0 115.0 115.0 118.0 156.0 118.0 10:58:17 INFO - PROCESS | 12407 | 10:58:17 INFO - PROCESS | 12407 | [#2] audio-dft Cycles:10 Average:160.60 Median:160.50 stddev:1.17 (0.7%) stddev-sans-first:0.87 10:58:17 INFO - PROCESS | 12407 | Values: 163.0 160.0 161.0 162.0 160.0 160.0 159.0 161.0 160.0 160.0 10:58:17 INFO - PROCESS | 12407 | 10:58:17 INFO - PROCESS | 12407 | [#3] audio-fft Cycles:10 Average:80.10 Median:75.00 stddev:10.99 (14.7%) stddev-sans-first:11.50 10:58:17 INFO - PROCESS | 12407 | Values: 75.0 76.0 73.0 105.0 75.0 76.0 75.0 75.0 96.0 75.0 10:58:17 INFO - PROCESS | 12407 | 10:58:17 INFO - PROCESS | 12407 | [#4] audio-oscillator Cycles:10 Average:88.10 Median:82.00 stddev:11.25 (13.7%) stddev-sans-first:11.78 10:58:17 INFO - PROCESS | 12407 | Values: 83.0 81.0 113.0 82.0 81.0 81.0 98.0 82.0 81.0 99.0 10:58:17 INFO - PROCESS | 12407 | 10:58:17 INFO - PROCESS | 12407 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 10:58:17 INFO - PROCESS | 12407 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 116.0 10:58:17 INFO - PROCESS | 12407 | 10:58:17 INFO - PROCESS | 12407 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.60 10:58:17 INFO - PROCESS | 12407 | Values: 145.0 145.0 147.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 10:58:17 INFO - PROCESS | 12407 | 10:58:17 INFO - PROCESS | 12407 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 10:58:17 INFO - PROCESS | 12407 | Values: 85.0 85.0 85.0 85.0 85.0 85.0 84.0 85.0 84.0 85.0 10:58:17 INFO - PROCESS | 12407 | 10:58:17 INFO - PROCESS | 12407 | [#8] json-parse-financial Cycles:10 Average:50.60 Median:51.00 stddev:0.84 (1.7%) stddev-sans-first:0.73 10:58:17 INFO - PROCESS | 12407 | Values: 52.0 51.0 50.0 50.0 51.0 51.0 51.0 50.0 49.0 51.0 10:58:17 INFO - PROCESS | 12407 | 10:58:17 INFO - PROCESS | 12407 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:60.50 stddev:4.14 (6.8%) stddev-sans-first:2.13 10:58:17 INFO - PROCESS | 12407 | Values: 72.0 64.0 64.0 60.0 60.0 61.0 59.0 58.0 60.0 59.0 10:58:17 INFO - PROCESS | 12407 | 10:58:17 INFO - PROCESS | 12407 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:76.50 stddev:3.87 (5.1%) stddev-sans-first:4.06 10:58:17 INFO - PROCESS | 12407 | Values: 76.0 80.0 75.0 85.0 75.0 74.0 83.0 77.0 74.0 76.0 10:58:17 INFO - PROCESS | 12407 | 10:58:17 INFO - PROCESS | 12407 | [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:128.00 stddev:9.76 (7.6%) stddev-sans-first:10.33 10:58:17 INFO - PROCESS | 12407 | Values: 129.0 123.0 129.0 128.0 120.0 124.0 128.0 117.0 152.0 120.0 10:58:17 INFO - PROCESS | 12407 | 10:58:17 INFO - PROCESS | 12407 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.00 Median:155.50 stddev:2.94 (1.9%) stddev-sans-first:2.92 10:58:17 INFO - PROCESS | 12407 | Values: 159.0 154.0 154.0 153.0 155.0 155.0 155.0 156.0 156.0 163.0 10:58:17 INFO - PROCESS | 12407 | 10:58:17 INFO - PROCESS | 12407 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.20 Median:62.00 stddev:1.32 (2.1%) stddev-sans-first:1.39 10:58:17 INFO - PROCESS | 12407 | Values: 62.0 62.0 62.0 62.0 62.0 61.0 65.0 61.0 61.0 64.0 10:58:17 INFO - PROCESS | 12407 | -------- Summary: end -------- 10:58:17 INFO - PROCESS | 12407 | 10:58:18 INFO - TEST-INFO | 12407: exit 0 10:58:18 INFO - TEST-OK | kraken | took 60092ms 10:58:18 INFO - SUITE-END | took 1175s 10:58:18 INFO - Completed test suite (00:19:35) 10:58:18 INFO - javascript benchmark 10:58:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3179.6661350558193, 3202.631697354804, 3216.212028053127, 3235.6440791512946, 3248.0418276608398, 5444.591655625829, 5540.196671482632, 5553.861153471165, 5560.249366335549, 5566.666000040001, 5507.834764957048, 5577.52591029762, 5588.6646801191955, 5591.440855914407, 5598.580106492009, 5031.949680503203, 5044.419891712463, 5068.138416469209, 5107.8467645970495, 5144.305518754976, 4919.1637421638225, 5086.745662716868, 5140.820071297505, 5142.254373115896, 5146.614003949719, 4900.338454308659, 4938.432080310757, 4973.403191617011, 4975.228839529878, 4985.800567977295, 5051.722155281458, 5057.241413787924, 5066.670666406671, 5068.163752980754, 5088.974555127238, 4801.991581767833, 4971.055499455092, 4996.625253106032, 5008.874778130576, 5032.748362581856, 5348.652337598082, 5365.651232669864, 5390.434004429557, 5398.973005134949, 5408.269883565747, 5811.535077193815, 5814.069748840166, 5931.673757943311, 5934.1098835174635, 5937.435943585352, 5705.400932902027, 5974.522038236931, 5979.252593425822, 5986.940130598726, 6011.669358185298, 5352.625316227865, 5438.265834112423, 5458.0, 5514.503694667499, 5544.3346798384455, 5952.523798096142, 5980.43185897339, 5988.880222395528, 5992.940070599326, 5996.430339117776, 5668.7165641718575, 5750.856228594319, 5751.396103409165, 5765.88468230633, 5768.048272035151, 5782.826515204551, 5788.0, 5806.622569532967, 5813.534917206698, 5908.350081491032, 5842.065269556851, 5844.532437404998, 5847.94152058474, 5848.473637372572, 5849.356570777211, 5814.767409303665, 5863.149843272701, 5868.765249389977, 5882.117682347682, 5896.587238893237, 4400.4939431965095, 4411.801468933906, 4414.558544145624, 4464.196444639996, 4468.994476242884, 4005.0788318686864, 4017.276890159741, 4020.43713880057, 4022.8189731462153, 4059.817308221137, 5633.352164501053, 5634.464725851038, 5638.956792993309, 5640.915386269209, 5669.6314739541795, 5950.880982380415, 5957.702114894325, 5959.851003724855, 5961.791337303173, 5962.135490353961, 5372.623916325898, 5373.758180881791, 5385.596080293915, 5573.191887176417, 5650.66096034231, 4888.633352498577, 4916.778744956486, 4925.11347957364, 4927.384076990376, 4929.112759703216, 6025.517958563304, 6061.151438798572, 6071.0, 6126.120738204555, 6132.600268413531, 5963.582549221686, 5964.642121472725, 5980.760769569169, 5987.7604895805425, 5989.0, 6144.324124346229, 6165.938340616536, 6168.0439531872635, 6172.660503672341, 6176.536759742948, 5579.0, 5608.383077861514, 5783.884322313615, 5791.913121303268, 5826.592138550261, 6005.219321488354, 6005.669688167192, 6006.549508786771, 6008.789692360921, 6024.638521688713, 5780.421957804186, 5842.2405087338375, 5867.20792692981, 5868.295804503487, 5873.765049397976, 5568.860778480571, 5611.5230205433, 5621.0, 5656.1798539212405, 5836.854078648068, 5670.064439367458, 5690.459406356389, 5701.657900525982, 5703.116017017369, 5733.0, 5745.683987380734, 5748.425157484386, 5774.682392468455, 5780.075187969905, 5781.161731548986, 5462.6995515247045, 5497.917531236954, 5637.88724225505, 5641.15382692583, 5641.153826925994], "value": 5422.504924620645, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.2140110850353, 612.8896798576257, 613.2395829171828, 626.9937300626993, 630.8643641617051, 33649.158771030736, 37048.0, 44116.558834411684, 45184.322235166495, 45379.319310210376, 46471.76764116183, 46866.29700554486, 46963.0, 46964.76517617407, 47010.0, 8902.33232507563, 9034.0, 9040.367174297802, 9051.59267832949, 9053.547322633875, 8029.317508011826, 8206.466579672333, 10497.475126243695, 10695.144388448944, 10720.195985301094, 10888.67333979982, 10942.398168100752, 10944.945275273612, 10954.561817527328, 10960.397178155199, 10740.08709259714, 10771.407572583505, 10812.243142979916, 10828.783424331548, 10838.349699018045, 10673.412962287071, 10697.304675196086, 10721.571137154504, 10734.0, 10736.624218152327, 43514.12971740548, 43672.0, 43798.562014379764, 43868.56131438677, 43873.78063109664, 3130.843457827122, 3289.7861638993627, 3587.461880717887, 3866.4780254665543, 3942.5071866016747, 32450.51324230115, 33465.33069338624, 33802.32395352079, 33815.0, 34107.147321316916, 3943.4084887266854, 3974.284628766821, 4037.152198038386, 4094.549599544048, 4121.52602450719, 344558.0, 345290.0090495022, 345441.27279363695, 346192.0, 347201.0, 62927.42411066791, 63009.0, 63383.6830815843, 63386.68306658437, 63467.36532634707, 40090.19819603592, 41023.1795364091, 41045.794771025954, 66302.66848665726, 66461.66769166123, 17331.133443328035, 17863.374781882572, 17893.0, 17894.731579026324, 17901.28394864217, 10913.0, 11176.161787865942, 13372.264525451194, 13663.111897726814, 13665.726685466434, 19911.502212444804, 21229.256976005767, 21332.573348532944, 21384.893075534525, 21405.35783926485, 7272.236415176436, 7426.220246874001, 7535.6985720570565, 7600.581967991813, 7730.342920851678, 1002.4787110702393, 1026.2457094035879, 1030.314840630987, 1114.576460944852, 1147.9196456247982, 33543.49684754731, 33966.66033339635, 33985.660143398745, 33994.49008264878, 34061.48907766386, 947.7251597036782, 955.5652178259014, 998.4807899892015, 1027.753339198587, 1122.5004872831676, 17632.647347052985, 17805.03150935279, 17844.464666060037, 18005.7299140513, 18023.459296221135, 520022.0, 523558.0, 526200.0, 526363.0, 526937.0, 61237.0, 61714.0, 61804.69097654483, 61834.69082654648, 61871.69064154741, 1173.1553281637207, 1265.7215412609212, 1344.173333399952, 1408.9506867259597, 1430.763923952557, 32003.83998079995, 33835.4924676135, 33922.15194620154, 34242.71588070127, 34369.48445773265, 52971.20543191932, 53478.73260633672, 53576.196357053894, 53636.46363536471, 53730.19404709011, 394216.0, 394996.0, 395953.0, 397258.0, 397845.0, 45108.77445612882, 46686.29970550376, 49635.0, 49906.25140622966, 50249.49750502448, 46405.30392044054, 47033.52966470292, 51818.74090629523, 51891.48108519018, 52049.0, 42502.0, 42534.78732606441, 42610.36084458797, 43405.78297108494, 44459.33311000402, 42511.0, 42715.145697086504, 42878.29199819684, 43044.35433468438, 44961.550384495735, 41098.0, 41914.58085419107, 44288.557114429736, 45240.32139517844, 46021.079578407574, 42375.0, 43945.34081988837, 44366.77816610896, 45066.549334506235, 45469.54530454653, 34405.31189376248, 35358.29283414266, 35584.46623300601, 35672.0, 35833.0], "value": 21297.63133837415, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.29298736817935, 400.9318415869304, 416.4066205656939, 420.68869036912685, 428.23132477203416, 14382.49661261856, 16183.595410114738, 19345.226190952344, 19966.20135194594, 20149.496262593442, 19462.610747785035, 19686.803131968674, 19743.5064123397, 19981.700274495895, 20306.18775248992, 5757.553039958022, 5768.134779783035, 5939.703014849262, 5999.580029397944, 6006.0, 4367.08291258836, 4552.385427967231, 5890.734916928727, 5969.955257829884, 5976.0, 6243.531735119862, 6475.7733479328235, 6523.3150519195515, 6606.8017959461295, 6701.631410272457, 6395.584287021329, 6525.738970441201, 6553.967230163867, 6571.211454625475, 6580.93419065808, 5704.0, 5789.04480760674, 5790.420957904218, 5793.681347525884, 5801.30384353876, 23572.88213558921, 24038.0, 24089.518209635884, 24218.63672044921, 24448.755512444826, 2357.351728274721, 2612.020492315382, 2695.460907818444, 3054.312779624589, 3072.201227680797, 14125.717485650332, 14427.49503767363, 14840.851591484055, 14931.477398291008, 14980.0, 2017.8991050447419, 2043.4074118505764, 2047.846411519127, 2055.629986602411, 2063.6801295799173, 69632.0, 70868.29131708668, 71858.64070679613, 74729.0, 86695.0, 11183.04944079746, 11356.829647555292, 11662.650120496399, 11884.227525211007, 12111.0, 16785.91607041957, 16823.663526729397, 16841.32634694623, 16863.241154148094, 16885.240164192393, 8355.289800366916, 8628.741137765877, 8653.69712060075, 8843.469391836381, 8855.38012339143, 8520.829583408296, 8561.657533698706, 8625.741227763177, 8754.56227188638, 8759.0, 4586.564276393738, 4698.553637404441, 4950.504949505021, 5060.924086138637, 5242.895142097137, 2016.7378240828598, 2033.4916270932267, 2060.402483279862, 2088.425682937174, 2245.831562632809, 881.9029906710257, 951.2627713521938, 1012.3976234140674, 1031.1750599520503, 1039.6621098143135, 18838.905805470884, 19647.0, 19805.20779168846, 19878.403647890587, 20018.29935952264, 947.7820101376584, 962.0764066496102, 970.3401686853008, 998.8351921932945, 1073.9677809665723, 10017.248706346907, 10731.409772462433, 10760.892391076146, 10764.13886889047, 10768.676939691823, 535549.0, 541490.0, 546191.0, 551363.0, 555156.0, 58528.0, 96363.51818241004, 99215.50392247993, 99284.0, 100731.49634251781, 1016.654337525245, 1030.283952652914, 1050.4642632257603, 1070.6092276319243, 1072.7479042425025, 17786.733199001766, 17869.821301787335, 18230.81769182291, 18251.81748182501, 18386.264549418407, 46379.53620463752, 47242.0, 47507.52492475031, 47842.760786195846, 47999.0, 63272.0, 63683.68158159365, 64217.036744449804, 64505.67747161422, 64962.0, 7881.487703299267, 8837.91162088371, 8905.599248033983, 9277.118673725985, 9370.812583748424, 12704.555340563036, 13615.52345667897, 13714.17714937107, 13723.176609403468, 13909.165450073027, 11784.528618855149, 12279.324637145042, 12445.564405245774, 12510.687232819253, 12574.559890403792, 11840.940795295968, 11860.644180674593, 12170.087243456954, 12428.875711242772, 12512.687182820138, 12354.320512371905, 12379.93810030944, 12395.132340736061, 12503.4373453193, 12637.368131593199, 7779.611019448892, 8227.79430514218, 8383.371247156365, 8517.105703901248, 8738.432001919855, 11066.225364224427, 11209.663710088711, 11286.097112230838, 11315.717107072389, 12291.139620226499], "value": 9684.997314742946, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1453.1644304524898, 1509.9320530576124, 1637.688839120567, 1763.470958712386, 1818.6271814278075, 8037.517748935068, 8532.658693652254, 8580.74257772267, 8588.95705521473, 8615.827683446327, 7509.0, 7676.884846727289, 7680.116786569546, 7836.882446763303, 8444.155584441552, 2401.5317013182394, 2447.3759191406166, 2456.9508609827794, 2466.5560199164233, 2479.987600062006, 2449.1183174057323, 2490.5392502387026, 2506.0, 2509.0841842727364, 2509.372656835791, 2421.055788242587, 2436.110819550869, 2454.067454367338, 2457.496213276274, 2458.9877050614723, 2424.527217192648, 2444.987775061122, 2448.2899959011866, 2450.8161887858305, 2453.092355828337, 2443.2059580636187, 2476.7647073527987, 2477.306354220821, 2482.007197121148, 2482.094035676983, 8128.959355203246, 8144.796380090486, 8158.0, 8199.42604017719, 8260.008798944165, 5157.5616072633875, 5277.472252774692, 5294.867628309285, 5307.28351672527, 5311.7344132793205, 3194.648588655246, 3298.835058247102, 3381.0702056934538, 3416.760826742129, 3418.1454636340914, 997.1424574865609, 1037.118449318081, 1067.4982758103679, 1076.8976947190004, 1081.9296745711504, 10983.560657573767, 11723.648290551211, 11777.823332650018, 11790.0, 11892.286462812172, 4729.196036673774, 4862.586680132228, 4893.388326459192, 4907.509249075135, 4913.729744864067, 9388.812223755487, 9396.71809845692, 9402.576884040234, 9415.058494150668, 9415.199708024895, 5407.0, 5413.188021796684, 5414.485623865805, 5414.648047876875, 5416.539594134464, 4361.236783562864, 4816.54242846929, 4966.925496117561, 4998.250262460588, 5009.298698182258, 3549.982250088785, 3799.0, 3878.6315300047013, 3922.7254092213843, 3933.8426462941734, 1154.5554961339776, 1202.6692659518703, 1218.2629509146839, 1229.877012298763, 1230.028277660656, 757.36381439591, 777.5140537164273, 799.4723482501521, 858.9312854971587, 868.5657171414293, 5616.185653080281, 5702.914456283159, 5845.035569131131, 5876.265466816648, 5950.285965684146, 889.0, 889.1020069729619, 899.5052721003552, 953.208836665566, 956.9043095690514, 3973.8013099345494, 4135.338345864648, 4158.688098392633, 4188.748675079505, 4195.958040419557, 10100.545475453622, 10565.524551395205, 10589.364638121584, 10592.046715795615, 10653.201009924287, 10540.420276884692, 10542.367457952394, 10554.577816887238, 10604.840927386096, 10605.310654807567, 7641.197674244236, 7694.384449244159, 7892.934453848657, 7912.129665736765, 8061.677532898619, 5786.623869448473, 5792.275965504312, 5871.119332100219, 5955.76176952917, 5971.671558064349, 9655.517224138905, 9663.323567350219, 9679.612815487302, 9687.70936871895, 9726.36778609388, 9615.471149086867, 9679.612815487584, 9794.608215671578, 9820.803583928138, 9826.705198844045, 6618.6690665467495, 7041.718331266692, 7219.494635375473, 7248.34764871143, 7297.963510182415, 7137.571745695275, 7565.848683026198, 7758.534487930742, 7772.611369431393, 7972.362211022988, 6884.449244060564, 6912.585244885323, 6927.203371612128, 6951.7914462566205, 7068.29317068289, 6961.930380696331, 7018.5788852666965, 7036.542624729376, 7045.436365090678, 7055.647217638995, 6579.868402631825, 6590.2421221560135, 6673.299303573055, 6728.259891412039, 6794.0, 5132.307138536399, 5136.049830781318, 5253.868653283698, 5260.210968354624, 5288.867778305573, 5170.302009228706, 5189.11784996544, 5304.681719096867, 5309.787608495617, 5334.199870019528], "value": 4524.173882815555, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.8295559609186, 360.3657562689666, 361.78293024185484, 373.66183603838533, 375.5249609244308, 5334.399680095975, 5425.484578964992, 5442.58492791874, 5483.862903427416, 5488.615796894219, 5283.471652834714, 5376.51611354978, 5379.515843574078, 5384.892302153955, 5415.972920135404, 4287.614114729681, 4294.463192100988, 4296.140771845628, 4309.504406993189, 4314.460692413449, 4175.206710724968, 4265.402843601898, 4272.380504826799, 4275.700700950934, 4282.122164956192, 4220.05877296444, 4227.583759440576, 4254.765987870666, 4267.210566045276, 4270.807813648377, 4224.9226447255905, 4230.302000169968, 4232.343986682069, 4245.87262382129, 4247.87256382309, 3747.4378843173467, 3797.1266608680157, 3804.562475315319, 3819.102510909934, 3832.080300727805, 5251.789928402897, 5253.579713622901, 5285.550728188108, 5286.141116984584, 5310.468953104697, 4862.7325497097645, 4864.927026094611, 4906.264060390934, 4912.214045752698, 4934.358533390672, 5438.395673276393, 5646.745896434671, 5652.660840349592, 5677.261955945742, 5691.231683722686, 4184.184084103601, 4206.390073439365, 4208.726432781859, 4210.789460526961, 4211.957880421187, 5869.413058694139, 5871.442212989759, 5882.558808089368, 5900.763969441217, 5903.35063143054, 4201.138766552849, 4307.396964424983, 4313.576519748475, 4316.784160791948, 4318.244307246219, 4281.901868084616, 4372.300431930876, 4374.703280777617, 4378.540253273424, 4383.890402739957, 4890.779914903838, 4932.852014439501, 4934.284528743312, 4955.207166853286, 4956.776945037482, 5542.63972841764, 5682.374938756733, 5705.62913410627, 5711.314642242957, 5733.598648094677, 1463.3195564062762, 1468.8457711940307, 1471.661517850879, 1473.4990103364694, 1481.3704175725275, 1017.3029710539071, 1028.619410818002, 1033.7312298802365, 1037.8910214427528, 1043.1706793099352, 5268.947310526845, 5308.601854860901, 5311.28297679816, 5330.7068111253475, 5335.839924802262, 5572.693501857356, 5600.4959553640365, 5615.382307946123, 5632.6200080980425, 5642.0, 5034.446210916796, 5281.762320695578, 5315.0, 5331.866703332447, 5339.252504649352, 2956.4826155422716, 2980.5976193213637, 2989.6412430508044, 2995.236214765221, 2997.7451916586897, 5686.601937864392, 5752.878188753237, 5763.94236057634, 5771.095538472294, 5814.325410311304, 5669.43305669438, 5942.940570594239, 5972.343042265347, 5987.850303742442, 5989.753842309134, 6023.969880150571, 6035.171862510062, 6035.245594300713, 6046.606970546901, 6048.42539958712, 5688.431156884279, 5846.56150788684, 5866.2373891393845, 5910.911336330045, 5920.141579471038, 5804.506616937608, 5829.921464528906, 5836.591438599257, 5837.67892765902, 5871.236739223874, 5832.445917637818, 5951.910721339097, 6001.909971350346, 6016.939830601813, 6039.497091686723, 3956.4460975462885, 4015.317396042621, 4124.649404800625, 4146.5853414658295, 4203.936940945827, 5803.216565763568, 5804.970975145097, 5854.268216472941, 5865.149553314831, 5872.735726892385, 5616.6068375213345, 5740.339860916049, 5752.482276594959, 5753.367129615655, 5766.279215098113, 5663.093904975184, 5667.971660141673, 5677.744501497526, 5682.6306290091015, 5701.315842098975, 5616.213730077874, 5632.802851900164, 5638.746256418389, 5641.223014750341, 5665.178549110438, 5494.945050549603, 5675.3394060829705, 5678.858028549319, 5703.7433315500075, 5731.541476681939, 5547.805826796042, 5560.749766260447, 5564.4991950724625, 5584.0, 5594.216809646734], "value": 4358.1869284365075, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [688.8691148681753, 734.14105496569, 746.5371469688793, 776.386654542911, 811.7037281392294, 14964.700705985873, 15706.921465392657, 15739.527814165593, 15753.842461575381, 15783.053016818985, 14041.22773247471, 14067.226302553356, 14186.006979511412, 14202.573922782307, 14212.857871421284, 699.440447641887, 716.1227496316995, 797.9321757650607, 822.5681517203457, 824.9133840946704, 842.6713581703141, 847.6228078505068, 849.8852654891604, 850.2857599616322, 851.5103815306223, 882.2853488674194, 882.9117088291151, 883.7569668341225, 883.9513826739527, 884.5488800711619, 729.9233580474054, 744.9702011919517, 870.0690261420283, 876.5617191404298, 881.4534988307258, 651.4072194303209, 652.3248437866785, 652.8302641313245, 652.8759535688251, 653.3564439027554, 15031.323590438347, 15308.540743777705, 15331.386744530206, 15367.385304587802, 15385.615359616098, 13912.234827084507, 13983.440662373492, 14042.0, 14232.430702771877, 14523.0, 13011.414486348138, 13083.598813578014, 13170.60488185356, 13326.666833329147, 13659.0, 4607.401037865089, 4642.1876171670165, 4678.298255261704, 4796.040791841646, 4806.0, 67567.3243267566, 68092.3190768096, 69028.30971690269, 69607.65196173987, 69885.65057174732, 11537.48081336342, 11552.480138393792, 11617.709557260967, 11783.88216117845, 11977.820332695017, 20415.387538373874, 20418.795812041688, 20533.58932821335, 20715.378538643865, 21021.579568408546, 8213.79465513367, 8654.697085601974, 8667.956660216658, 8741.08218637034, 8789.692360767342, 4740.14677358072, 4755.548222918817, 4817.349657796222, 4826.6621336506105, 4937.481564435754, 3432.8970130896114, 3513.7540372174212, 3531.2760884018717, 3533.116720819795, 3536.487209354629, 649.2403887451693, 649.9772507962199, 650.8372906773307, 682.0315152483486, 687.9071325371111, 591.2963573347788, 622.9099076615922, 627.645380360095, 671.7380221713536, 718.1956209045902, 8827.955860220658, 9353.672621458216, 9501.477418742035, 9594.0, 9618.374805637612, 668.8695704337607, 692.5498426023024, 698.9650517474207, 710.2364957670525, 717.3579646216607, 4396.384506169139, 4533.727976321431, 4545.659075569345, 4558.840440584564, 4590.770461476913, 54153.45846541563, 55251.02740753352, 88459.0, 90249.0, 93081.53459232795, 66359.33640663628, 67637.0, 77751.61124194456, 79036.0, 79037.60481197672, 64541.67729161324, 65026.67486662631, 65348.67325663341, 65394.346056539776, 66325.33674663288, 9512.429254244767, 9631.133198012212, 9699.563519641773, 9718.271129665445, 9773.364731292444, 43201.35197972096, 43317.0, 44064.0, 45418.0, 46404.30393544167, 53769.0, 54447.72776136094, 55194.0, 62151.0, 63208.36791632209, 12520.561780337644, 12788.424520896397, 12868.099233053596, 12890.935545322589, 12946.546870859474, 13913.443462261395, 14056.875449963774, 14094.718105637625, 14438.566842994727, 14668.853311466748, 12150.270983741004, 13000.739985200433, 13187.406566704329, 13298.933505332412, 13327.933360333136, 12927.870721293042, 13467.0, 13750.518731844337, 13814.309284535531, 13898.72202555923, 12657.303848288433, 13261.336933153496, 13453.125546839425, 14109.153450792985, 14180.432782688576, 11430.14273929442, 11509.942450287695, 11733.0, 12128.785871744172, 12240.0, 11516.769664606829, 11521.308721476738, 11930.522779088738, 12120.575779847662, 12298.139130260795], "value": 7299.276621819048, "unit": "score"}], "name": "dromaeo_css", "value": 7375.65309384493, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 112.0, 110.0, 114.0, 111.0, 111.0, 111.0, 111.0, 110.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 121.0, 118.0, 161.0, 117.0, 115.0, 115.0, 118.0, 156.0, 118.0], "value": 128.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 161.0, 162.0, 160.0, 160.0, 159.0, 161.0, 160.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 73.0, 105.0, 75.0, 76.0, 75.0, 75.0, 96.0, 75.0], "value": 80.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 113.0, 82.0, 81.0, 81.0, 98.0, 82.0, 81.0, 99.0], "value": 88.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 147.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 85.0, 85.0, 84.0, 85.0, 84.0, 85.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 50.0, 50.0, 51.0, 51.0, 51.0, 50.0, 49.0, 51.0], "value": 50.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 64.0, 64.0, 60.0, 60.0, 61.0, 59.0, 58.0, 60.0, 59.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 80.0, 75.0, 85.0, 75.0, 74.0, 83.0, 77.0, 74.0, 76.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 123.0, 129.0, 128.0, 120.0, 124.0, 128.0, 117.0, 152.0, 120.0], "value": 127.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 154.0, 154.0, 153.0, 155.0, 155.0, 155.0, 156.0, 156.0, 163.0], "value": 156.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 61.0, 65.0, 61.0, 61.0, 64.0], "value": 62.2, "unit": "score"}], "name": "kraken", "value": 1449.7, "alertThreshold": 2.0}]} 10:58:18 INFO - Return code: 0 10:58:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:58:18 INFO - # TBPL SUCCESS # 10:58:18 INFO - Running post-action listener: _resource_record_post_action 10:58:18 INFO - [mozharness: 2017-01-12 18:58:18.825173Z] Finished run-tests step (success) 10:58:18 INFO - Running post-run listener: _resource_record_post_run 10:58:18 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 354861056; Read time: 0; Write time: 285376 10:58:18 INFO - TinderboxPrint: CPU usage
13.0% 10:58:18 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 10:58:18 INFO - TinderboxPrint: I/O write bytes / time
354,861,056 / 285,376 10:58:18 INFO - TinderboxPrint: CPU idle
8,280.1 (87.0%) 10:58:18 INFO - TinderboxPrint: CPU user
1,187.7 (12.5%) 10:58:18 INFO - TinderboxPrint: Swap in / out
0 / 0 10:58:18 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108371968; Read time: 0; Write time: 122084 10:58:18 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 246157312; Read time: 0; Write time: 163288 10:58:19 INFO - Running post-run listener: _upload_blobber_files 10:58:19 INFO - Blob upload gear active. 10:58:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:58:19 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 10:58:19 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'] 10:58:19 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 10:58:19 INFO - (blobuploader) - INFO - Open directory for files ... 10:58:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:58:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:58:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:58:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:58:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:58:23 INFO - (blobuploader) - INFO - Done attempting. 10:58:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:58:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:58:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:58:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:58:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:58:23 INFO - (blobuploader) - INFO - Done attempting. 10:58:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:58:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:58:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:58:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:58:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:58:24 INFO - (blobuploader) - INFO - Done attempting. 10:58:24 INFO - (blobuploader) - INFO - Iteration through files over. 10:58:24 INFO - Return code: 0 10:58:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:58:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:58:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5f3794c1f8225afb42c290490d2f0d42dd8ce94c385ced84c12f5157b6c52f14c5ea901aa0a9d787144b000054270ed8c78a513c6c852658fee2b728d7d80233", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d93ae2cd14f31a5fb9eb62b5a4bc7a617616f7f031e3c170fc5597cba4e6a35a714b2ab024f0230bb0249468b82633df931843feb5053d6e5341c91b33282b10", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9f470971ca346a87f9fdcbfe543ceab6c4ac37088cc38ea8228ae08afd70e5fffd9966c1526f279d5a6a1373041f1e724becf1bffb6eaa98e7b961c9cdcba0e4"} 10:58:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:58:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:58:24 INFO - Contents: 10:58:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5f3794c1f8225afb42c290490d2f0d42dd8ce94c385ced84c12f5157b6c52f14c5ea901aa0a9d787144b000054270ed8c78a513c6c852658fee2b728d7d80233", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d93ae2cd14f31a5fb9eb62b5a4bc7a617616f7f031e3c170fc5597cba4e6a35a714b2ab024f0230bb0249468b82633df931843feb5053d6e5341c91b33282b10", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9f470971ca346a87f9fdcbfe543ceab6c4ac37088cc38ea8228ae08afd70e5fffd9966c1526f279d5a6a1373041f1e724becf1bffb6eaa98e7b961c9cdcba0e4"} 10:58:24 INFO - Running post-run listener: copy_logs_to_upload_dir 10:58:24 INFO - Copying logs to upload dir... 10:58:24 INFO - mkdir: /builds/slave/test/build/upload/logs 10:58:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.885585 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-01-12 10:58:23.725024) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 10:58:23.728722) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1484246267.213446-354033062 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/5f3794c1f8225afb42c290490d2f0d42dd8ce94c385ced84c12f5157b6c52f14c5ea901aa0a9d787144b000054270ed8c78a513c6c852658fee2b728d7d80233", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d93ae2cd14f31a5fb9eb62b5a4bc7a617616f7f031e3c170fc5597cba4e6a35a714b2ab024f0230bb0249468b82633df931843feb5053d6e5341c91b33282b10", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9f470971ca346a87f9fdcbfe543ceab6c4ac37088cc38ea8228ae08afd70e5fffd9966c1526f279d5a6a1373041f1e724becf1bffb6eaa98e7b961c9cdcba0e4"} build_url:https://queue.taskcluster.net/v1/task/J40wkCC5TIy-aCCdT_VCug/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011399 build_url: 'https://queue.taskcluster.net/v1/task/J40wkCC5TIy-aCCdT_VCug/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/5f3794c1f8225afb42c290490d2f0d42dd8ce94c385ced84c12f5157b6c52f14c5ea901aa0a9d787144b000054270ed8c78a513c6c852658fee2b728d7d80233", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d93ae2cd14f31a5fb9eb62b5a4bc7a617616f7f031e3c170fc5597cba4e6a35a714b2ab024f0230bb0249468b82633df931843feb5053d6e5341c91b33282b10", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9f470971ca346a87f9fdcbfe543ceab6c4ac37088cc38ea8228ae08afd70e5fffd9966c1526f279d5a6a1373041f1e724becf1bffb6eaa98e7b961c9cdcba0e4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-12 10:58:23.755200) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 10:58:23.755542) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1484246267.213446-354033062 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-12 10:58:23.840490) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 10:58:23.840810) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-12 10:58:23.841203) ========= ========= Total master_lag: 0.15 =========