builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-060 starttime: 1487349122.65 results: success (0) buildid: 20170217064138 builduid: 45929baae1b64ce19bc70c2fbe086079 revision: 546f359ac8c0dbb466e6b307a0f906ea6df62a45 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-17 08:32:02.646440) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-17 08:32:02.646873) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-17 08:32:02.647150) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-17 08:32:02.664139) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 08:32:02.664535) ========= 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=337fe3f4b1febe37b85fccc40000019e-1487349121.824119-1307638427 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-17 08:32:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 102M=0s 2017-02-17 08:32:02 (102 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.142021 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 08:32:02.819927) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 08:32:02.820259) ========= 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=337fe3f4b1febe37b85fccc40000019e-1487349121.824119-1307638427 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019824 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 08:32:02.876515) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 08:32:02.876883) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 546f359ac8c0dbb466e6b307a0f906ea6df62a45 --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-beta --rev 546f359ac8c0dbb466e6b307a0f906ea6df62a45 --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=337fe3f4b1febe37b85fccc40000019e-1487349121.824119-1307638427 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-17 08:32:03,111 truncating revision to first 12 chars 2017-02-17 08:32:03,111 Setting DEBUG logging. 2017-02-17 08:32:03,111 attempt 1/10 2017-02-17 08:32:03,111 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/546f359ac8c0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-17 08:32:03,423 unpacking tar archive at: mozilla-beta-546f359ac8c0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.639777 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 08:32:03.531794) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-17 08:32:03.532122) ========= script_repo_revision: 546f359ac8c0dbb466e6b307a0f906ea6df62a45 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-17 08:32:03.532518) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-17 08:32:03.532814) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-17 08:32:03.541525) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-02-17 08:32:03.541827) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=337fe3f4b1febe37b85fccc40000019e-1487349121.824119-1307638427 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:32:03 INFO - MultiFileLogger online at 20170217 08:32:03 in /builds/slave/test 08:32:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:32:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:32:03 INFO - {'append_to_log': False, 08:32:03 INFO - 'base_work_dir': '/builds/slave/test', 08:32:03 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:32:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:32:03 INFO - 'branch': 'Mozilla-Beta', 08:32:03 INFO - 'buildbot_json_path': 'buildprops.json', 08:32:03 INFO - 'config_files': ('talos/linux_config.py',), 08:32:03 INFO - 'default_actions': ('clobber', 08:32:03 INFO - 'read-buildbot-config', 08:32:03 INFO - 'download-and-extract', 08:32:03 INFO - 'populate-webroot', 08:32:03 INFO - 'create-virtualenv', 08:32:03 INFO - 'install', 08:32:03 INFO - 'run-tests'), 08:32:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:32:03 INFO - 'download_minidump_stackwalk': True, 08:32:03 INFO - 'download_symbols': 'ondemand', 08:32:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:32:03 INFO - 'tooltool.py': '/tools/tooltool.py', 08:32:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:32:03 INFO - '/tools/misc-python/virtualenv.py')}, 08:32:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:32:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:32:03 INFO - 'installer_path': 'installer.exe', 08:32:03 INFO - 'log_level': 'info', 08:32:03 INFO - 'log_name': 'talos', 08:32:03 INFO - 'log_to_console': True, 08:32:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:32:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:32:03 INFO - 'opt_config_files': (), 08:32:03 INFO - 'pip_index': False, 08:32:03 INFO - 'sps_profile': False, 08:32:03 INFO - 'sps_profile_interval': 0, 08:32:03 INFO - 'suite': 'dromaeojs', 08:32:03 INFO - 'system_bits': '32', 08:32:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:32:03 INFO - 'title': 'talos-linux64-ix-060', 08:32:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:32:03 INFO - 'use_talos_json': True, 08:32:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:32:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:32:03 INFO - 'work_dir': 'build'} 08:32:03 INFO - [mozharness: 2017-02-17 16:32:03.871218Z] Running clobber step. 08:32:03 INFO - Running pre-action listener: _resource_record_pre_action 08:32:03 INFO - Running main action method: clobber 08:32:03 INFO - rmtree: /builds/slave/test/build 08:32:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:32:05 INFO - Running post-action listener: _resource_record_post_action 08:32:05 INFO - [mozharness: 2017-02-17 16:32:05.302533Z] Finished clobber step (success) 08:32:05 INFO - [mozharness: 2017-02-17 16:32:05.302631Z] Running read-buildbot-config step. 08:32:05 INFO - Running pre-action listener: _resource_record_pre_action 08:32:05 INFO - Running main action method: read_buildbot_config 08:32:05 INFO - Using buildbot properties: 08:32:05 INFO - { 08:32:05 INFO - "project": "", 08:32:05 INFO - "product": "firefox", 08:32:05 INFO - "script_repo_revision": "production", 08:32:05 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 08:32:05 INFO - "repository": "", 08:32:05 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 08:32:05 INFO - "buildid": "20170217064138", 08:32:05 INFO - "pgo_build": "True", 08:32:05 INFO - "basedir": "/builds/slave/test", 08:32:05 INFO - "buildnumber": 146, 08:32:05 INFO - "slavename": "talos-linux64-ix-060", 08:32:05 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:32:05 INFO - "platform": "ubuntu64_hw", 08:32:05 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 08:32:05 INFO - "branch": "mozilla-beta", 08:32:05 INFO - "repo_path": "releases/mozilla-beta", 08:32:05 INFO - "revision": "546f359ac8c0dbb466e6b307a0f906ea6df62a45", 08:32:05 INFO - "stage_platform": "linux64-pgo", 08:32:05 INFO - "builduid": "45929baae1b64ce19bc70c2fbe086079", 08:32:05 INFO - "slavebuilddir": "test" 08:32:05 INFO - } 08:32:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/YyieLW-SSoWBSIHpSKNHDQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 08:32:05 INFO - Running post-action listener: _resource_record_post_action 08:32:05 INFO - [mozharness: 2017-02-17 16:32:05.305281Z] Finished read-buildbot-config step (success) 08:32:05 INFO - [mozharness: 2017-02-17 16:32:05.305370Z] Running download-and-extract step. 08:32:05 INFO - Running pre-action listener: _resource_record_pre_action 08:32:05 INFO - Running main action method: download_and_extract 08:32:05 INFO - mkdir: /builds/slave/test/build/tests 08:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:05 INFO - trying https://queue.taskcluster.net/v1/task/YyieLW-SSoWBSIHpSKNHDQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 08:32:05 INFO - Downloading https://queue.taskcluster.net/v1/task/YyieLW-SSoWBSIHpSKNHDQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 08:32:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YyieLW-SSoWBSIHpSKNHDQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:32:05 INFO - Downloaded 1327 bytes. 08:32:05 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 08:32:05 INFO - Using the following test package requirements: 08:32:05 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 08:32:05 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 08:32:05 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 08:32:05 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 08:32:05 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 08:32:05 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 08:32:05 INFO - u'jsshell-linux-x86_64.zip'], 08:32:05 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 08:32:05 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 08:32:05 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 08:32:05 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 08:32:05 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 08:32:05 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 08:32:05 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 08:32:05 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 08:32:05 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 08:32:05 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 08:32:05 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 08:32:05 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:32:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YyieLW-SSoWBSIHpSKNHDQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 08:32:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YyieLW-SSoWBSIHpSKNHDQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:32:05 INFO - Fetch https://queue.taskcluster.net/v1/task/YyieLW-SSoWBSIHpSKNHDQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 08:32:06 INFO - Http code: 200 08:32:06 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 08:32:06 INFO - x-amz-cf-id: Lc8tppgtAJsWgtOpU0jZi1KxA4bnTeOs8oFp9UitZvh4DZqlpJaTyg== 08:32:06 INFO - x-amz-version-id: vAl.K15b._g95Af87EFYfX8PeQy1aKFJ 08:32:06 INFO - Expected file size: 21958319 08:32:06 INFO - Obtained file size: 21958319 08:32:10 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:32:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YyieLW-SSoWBSIHpSKNHDQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 08:32:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YyieLW-SSoWBSIHpSKNHDQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:32:10 INFO - Fetch https://queue.taskcluster.net/v1/task/YyieLW-SSoWBSIHpSKNHDQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 08:32:11 INFO - Http code: 200 08:32:11 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 08:32:11 INFO - x-amz-cf-id: 6-uIUpfkdt-uUyBJ48FQ19JJhD5RZW6_1xEckpfonMLF452IpGDDew== 08:32:11 INFO - x-amz-version-id: vAl.K15b._g95Af87EFYfX8PeQy1aKFJ 08:32:11 INFO - Expected file size: 21958319 08:32:11 INFO - Obtained file size: 21958319 08:32:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YyieLW-SSoWBSIHpSKNHDQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 08:32:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YyieLW-SSoWBSIHpSKNHDQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:32:16 INFO - Fetch https://queue.taskcluster.net/v1/task/YyieLW-SSoWBSIHpSKNHDQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 08:32:16 INFO - Http code: 200 08:32:16 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 08:32:16 INFO - x-amz-cf-id: 5-LPUcC6BzD5JH4bzBj_LNiGG_V8L7-EmHZoGVfzhYcsGSNLap-i1A== 08:32:16 INFO - x-amz-version-id: CIWf6GQ2Y.XZuk5OJsMcF75l4WkgWSiQ 08:32:16 INFO - Expected file size: 14403005 08:32:16 INFO - Obtained file size: 14403005 08:32:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:17 INFO - trying https://queue.taskcluster.net/v1/task/YyieLW-SSoWBSIHpSKNHDQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 08:32:17 INFO - Downloading https://queue.taskcluster.net/v1/task/YyieLW-SSoWBSIHpSKNHDQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 08:32:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YyieLW-SSoWBSIHpSKNHDQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:32:18 INFO - Downloaded 57760361 bytes. 08:32:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YyieLW-SSoWBSIHpSKNHDQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 08:32:18 INFO - mkdir: /builds/slave/test/properties 08:32:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:32:18 INFO - Writing to file /builds/slave/test/properties/build_url 08:32:18 INFO - Contents: 08:32:18 INFO - build_url:https://queue.taskcluster.net/v1/task/YyieLW-SSoWBSIHpSKNHDQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 08:32:18 INFO - Running post-action listener: _resource_record_post_action 08:32:18 INFO - Running post-action listener: set_extra_try_arguments 08:32:18 INFO - [mozharness: 2017-02-17 16:32:18.832759Z] Finished download-and-extract step (success) 08:32:18 INFO - [mozharness: 2017-02-17 16:32:18.833058Z] Running populate-webroot step. 08:32:18 INFO - Running pre-action listener: _resource_record_pre_action 08:32:18 INFO - Running main action method: populate_webroot 08:32:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:32:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:32:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:32:18 INFO - '--tppagecycles', 08:32:18 INFO - '7'], 08:32:18 INFO - 'tests': ['tsvgm']}}, 08:32:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:32:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:32:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:32:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:32:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:32:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:32:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:18 INFO - 'talos_options': ['--disable-e10s'], 08:32:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:32:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:32:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:18 INFO - 'talos_options': ['--disable-e10s'], 08:32:18 INFO - 'tests': ['damp', 'tps']}, 08:32:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:18 INFO - 'tests': ['damp', 'tps']}, 08:32:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:32:18 INFO - 'tests': ['dromaeo_dom']}, 08:32:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:32:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:32:18 INFO - 'tests': ['basic_compositor_video']}, 08:32:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:32:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:32:18 INFO - 'tests': ['a11yr', 08:32:18 INFO - 'ts_paint', 08:32:18 INFO - 'tpaint', 08:32:18 INFO - 'sessionrestore', 08:32:18 INFO - 'sessionrestore_no_auto_restore', 08:32:18 INFO - 'tabpaint']}, 08:32:18 INFO - 'other-e10s': {'tests': ['a11yr', 08:32:18 INFO - 'ts_paint', 08:32:18 INFO - 'tpaint', 08:32:18 INFO - 'sessionrestore', 08:32:18 INFO - 'sessionrestore_no_auto_restore', 08:32:18 INFO - 'tabpaint']}, 08:32:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:32:18 INFO - 'ts_paint', 08:32:18 INFO - 'tpaint', 08:32:18 INFO - 'sessionrestore', 08:32:18 INFO - 'sessionrestore_no_auto_restore', 08:32:18 INFO - 'tabpaint']}, 08:32:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:32:18 INFO - 'ts_paint', 08:32:18 INFO - 'tpaint', 08:32:18 INFO - 'sessionrestore', 08:32:18 INFO - 'sessionrestore_no_auto_restore', 08:32:18 INFO - 'tabpaint']}, 08:32:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:32:18 INFO - 'tests': ['a11yr', 08:32:18 INFO - 'ts_paint', 08:32:18 INFO - 'tpaint', 08:32:18 INFO - 'sessionrestore', 08:32:18 INFO - 'sessionrestore_no_auto_restore', 08:32:18 INFO - 'tabpaint']}, 08:32:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:32:18 INFO - 'tests': ['a11yr', 08:32:18 INFO - 'ts_paint', 08:32:18 INFO - 'tpaint', 08:32:18 INFO - 'sessionrestore', 08:32:18 INFO - 'sessionrestore_no_auto_restore', 08:32:18 INFO - 'tabpaint']}, 08:32:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:32:18 INFO - 'tests': ['tsvgx', 08:32:18 INFO - 'tsvgr_opacity', 08:32:18 INFO - 'tart', 08:32:18 INFO - 'tscrollx', 08:32:18 INFO - 'cart']}, 08:32:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:32:18 INFO - 'tsvgr_opacity', 08:32:18 INFO - 'tart', 08:32:18 INFO - 'tscrollx', 08:32:18 INFO - 'cart']}, 08:32:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:18 INFO - 'talos_options': ['--disable-e10s'], 08:32:18 INFO - 'tests': ['tp5o']}, 08:32:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:18 INFO - 'tests': ['tp5o']}, 08:32:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:18 INFO - 'talos_options': ['--disable-e10s', 08:32:18 INFO - '--xperf_path', 08:32:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:32:18 INFO - 'tests': ['tp5n']}, 08:32:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:32:18 INFO - 'talos_options': ['--xperf_path', 08:32:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:32:18 INFO - 'tests': ['tp5n']}}, 08:32:18 INFO - 'talos.zip': {'path': '', 08:32:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:32:18 INFO - Running post-action listener: _resource_record_post_action 08:32:18 INFO - [mozharness: 2017-02-17 16:32:18.854088Z] Finished populate-webroot step (success) 08:32:18 INFO - [mozharness: 2017-02-17 16:32:18.854180Z] Running create-virtualenv step. 08:32:18 INFO - Running pre-action listener: _resource_record_pre_action 08:32:18 INFO - Running main action method: create_virtualenv 08:32:18 INFO - Creating virtualenv /builds/slave/test/build/venv 08:32:18 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:32:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:32:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:32:18 INFO - Using real prefix '/usr' 08:32:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:32:19 INFO - Installing distribute.............................................................................................................................................................................................done. 08:32:21 INFO - Installing pip.................done. 08:32:21 INFO - Return code: 0 08:32:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:32:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:32:21 INFO - Reading from file tmpfile_stdout 08:32:21 INFO - Output received: 08:32:21 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:32:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:21 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 0x7f8c59ca9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d1f60>, '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 0x16d2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d31d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1487349121.824119-1307638427', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:32:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:32:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:32:21 INFO - Using env: {'DISPLAY': ':0', 08:32:21 INFO - 'HOME': '/home/cltbld', 08:32:21 INFO - 'LANG': 'en_US.UTF-8', 08:32:21 INFO - 'LANGUAGE': 'en_US:en', 08:32:21 INFO - 'LOGNAME': 'cltbld', 08:32:21 INFO - 'MAIL': '/var/mail/cltbld', 08:32:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:21 INFO - 'MOZ_NO_REMOTE': '1', 08:32:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:21 INFO - 'NO_EM_RESTART': '1', 08:32:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:21 INFO - 'PWD': '/builds/slave/test', 08:32:21 INFO - 'SHELL': '/bin/bash', 08:32:21 INFO - 'SHLVL': '1', 08:32:21 INFO - 'TERM': 'linux', 08:32:21 INFO - 'TMOUT': '86400', 08:32:21 INFO - 'USER': 'cltbld', 08:32:21 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1487349121.824119-1307638427', 08:32:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:21 INFO - '_': '/tools/buildbot/bin/python'} 08:32:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:21 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:32:21 INFO - Cleaning up... 08:32:21 INFO - Return code: 0 08:32:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:21 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 0x7f8c59ca9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d1f60>, '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 0x16d2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d31d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1487349121.824119-1307638427', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:32:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:32:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:32:21 INFO - Using env: {'DISPLAY': ':0', 08:32:21 INFO - 'HOME': '/home/cltbld', 08:32:21 INFO - 'LANG': 'en_US.UTF-8', 08:32:21 INFO - 'LANGUAGE': 'en_US:en', 08:32:21 INFO - 'LOGNAME': 'cltbld', 08:32:21 INFO - 'MAIL': '/var/mail/cltbld', 08:32:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:21 INFO - 'MOZ_NO_REMOTE': '1', 08:32:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:21 INFO - 'NO_EM_RESTART': '1', 08:32:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:21 INFO - 'PWD': '/builds/slave/test', 08:32:21 INFO - 'SHELL': '/bin/bash', 08:32:21 INFO - 'SHLVL': '1', 08:32:21 INFO - 'TERM': 'linux', 08:32:21 INFO - 'TMOUT': '86400', 08:32:21 INFO - 'USER': 'cltbld', 08:32:21 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1487349121.824119-1307638427', 08:32:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:21 INFO - '_': '/tools/buildbot/bin/python'} 08:32:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:22 INFO - Downloading/unpacking psutil>=3.1.1 08:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:32:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:32:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:32:24 INFO - Installing collected packages: psutil 08:32:24 INFO - Running setup.py install for psutil 08:32:24 INFO - building 'psutil._psutil_linux' extension 08:32:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:32:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:32:24 INFO - building 'psutil._psutil_posix' extension 08:32:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:32:24 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:32:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:32:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:32:24 INFO - Successfully installed psutil 08:32:24 INFO - Cleaning up... 08:32:24 INFO - Return code: 0 08:32:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:32:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:24 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 0x7f8c59ca9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d1f60>, '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 0x16d2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d31d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1487349121.824119-1307638427', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:32:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:32:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:32:24 INFO - Using env: {'DISPLAY': ':0', 08:32:24 INFO - 'HOME': '/home/cltbld', 08:32:24 INFO - 'LANG': 'en_US.UTF-8', 08:32:24 INFO - 'LANGUAGE': 'en_US:en', 08:32:24 INFO - 'LOGNAME': 'cltbld', 08:32:24 INFO - 'MAIL': '/var/mail/cltbld', 08:32:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:24 INFO - 'MOZ_NO_REMOTE': '1', 08:32:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:24 INFO - 'NO_EM_RESTART': '1', 08:32:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:24 INFO - 'PWD': '/builds/slave/test', 08:32:24 INFO - 'SHELL': '/bin/bash', 08:32:24 INFO - 'SHLVL': '1', 08:32:24 INFO - 'TERM': 'linux', 08:32:24 INFO - 'TMOUT': '86400', 08:32:24 INFO - 'USER': 'cltbld', 08:32:24 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1487349121.824119-1307638427', 08:32:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:24 INFO - '_': '/tools/buildbot/bin/python'} 08:32:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:32:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:32:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:32:26 INFO - Installing collected packages: mozsystemmonitor 08:32:26 INFO - Running setup.py install for mozsystemmonitor 08:32:27 INFO - Successfully installed mozsystemmonitor 08:32:27 INFO - Cleaning up... 08:32:27 INFO - Return code: 0 08:32:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:27 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 0x7f8c59ca9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d1f60>, '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 0x16d2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d31d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1487349121.824119-1307638427', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:32:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:32:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:32:27 INFO - Using env: {'DISPLAY': ':0', 08:32:27 INFO - 'HOME': '/home/cltbld', 08:32:27 INFO - 'LANG': 'en_US.UTF-8', 08:32:27 INFO - 'LANGUAGE': 'en_US:en', 08:32:27 INFO - 'LOGNAME': 'cltbld', 08:32:27 INFO - 'MAIL': '/var/mail/cltbld', 08:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:27 INFO - 'MOZ_NO_REMOTE': '1', 08:32:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:27 INFO - 'NO_EM_RESTART': '1', 08:32:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:27 INFO - 'PWD': '/builds/slave/test', 08:32:27 INFO - 'SHELL': '/bin/bash', 08:32:27 INFO - 'SHLVL': '1', 08:32:27 INFO - 'TERM': 'linux', 08:32:27 INFO - 'TMOUT': '86400', 08:32:27 INFO - 'USER': 'cltbld', 08:32:27 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1487349121.824119-1307638427', 08:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:27 INFO - '_': '/tools/buildbot/bin/python'} 08:32:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:27 INFO - Downloading/unpacking jsonschema==2.5.1 08:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:32:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:29 INFO - Downloading functools32-3.2.3-2.tar.gz 08:32:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:32:29 INFO - warning: no files found matching '*.txt' 08:32:29 INFO - no previously-included directories found matching 'build' 08:32:29 INFO - no previously-included directories found matching 'dist' 08:32:29 INFO - no previously-included directories found matching '.git*' 08:32:29 INFO - Installing collected packages: jsonschema, functools32 08:32:29 INFO - Running setup.py install for functools32 08:32:29 INFO - warning: no files found matching '*.txt' 08:32:29 INFO - no previously-included directories found matching 'build' 08:32:29 INFO - no previously-included directories found matching 'dist' 08:32:29 INFO - no previously-included directories found matching '.git*' 08:32:29 INFO - Successfully installed jsonschema functools32 08:32:29 INFO - Cleaning up... 08:32:29 INFO - Return code: 0 08:32:29 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:32:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:29 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 0x7f8c59ca9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d1f60>, '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 0x16d2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d31d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1487349121.824119-1307638427', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:32:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:32:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:32:29 INFO - Using env: {'DISPLAY': ':0', 08:32:29 INFO - 'HOME': '/home/cltbld', 08:32:29 INFO - 'LANG': 'en_US.UTF-8', 08:32:29 INFO - 'LANGUAGE': 'en_US:en', 08:32:29 INFO - 'LOGNAME': 'cltbld', 08:32:29 INFO - 'MAIL': '/var/mail/cltbld', 08:32:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:29 INFO - 'MOZ_NO_REMOTE': '1', 08:32:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:29 INFO - 'NO_EM_RESTART': '1', 08:32:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:29 INFO - 'PWD': '/builds/slave/test', 08:32:29 INFO - 'SHELL': '/bin/bash', 08:32:29 INFO - 'SHLVL': '1', 08:32:29 INFO - 'TERM': 'linux', 08:32:29 INFO - 'TMOUT': '86400', 08:32:29 INFO - 'USER': 'cltbld', 08:32:29 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1487349121.824119-1307638427', 08:32:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:29 INFO - '_': '/tools/buildbot/bin/python'} 08:32:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:32:30 INFO - Cleaning up... 08:32:30 INFO - Return code: 0 08:32:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:30 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 0x7f8c59ca9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d1f60>, '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 0x16d2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d31d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1487349121.824119-1307638427', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:32:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:32:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:32:30 INFO - Using env: {'DISPLAY': ':0', 08:32:30 INFO - 'HOME': '/home/cltbld', 08:32:30 INFO - 'LANG': 'en_US.UTF-8', 08:32:30 INFO - 'LANGUAGE': 'en_US:en', 08:32:30 INFO - 'LOGNAME': 'cltbld', 08:32:30 INFO - 'MAIL': '/var/mail/cltbld', 08:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:30 INFO - 'MOZ_NO_REMOTE': '1', 08:32:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:30 INFO - 'NO_EM_RESTART': '1', 08:32:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:30 INFO - 'PWD': '/builds/slave/test', 08:32:30 INFO - 'SHELL': '/bin/bash', 08:32:30 INFO - 'SHLVL': '1', 08:32:30 INFO - 'TERM': 'linux', 08:32:30 INFO - 'TMOUT': '86400', 08:32:30 INFO - 'USER': 'cltbld', 08:32:30 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1487349121.824119-1307638427', 08:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:30 INFO - '_': '/tools/buildbot/bin/python'} 08:32:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:30 INFO - Downloading/unpacking blobuploader==1.2.4 08:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:32 INFO - Downloading blobuploader-1.2.4.tar.gz 08:32:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:32:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:32:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:33 INFO - Downloading docopt-0.6.1.tar.gz 08:32:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:32:33 INFO - Installing collected packages: blobuploader, requests, docopt 08:32:33 INFO - Running setup.py install for blobuploader 08:32:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:32:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:32:33 INFO - Running setup.py install for requests 08:32:33 INFO - Running setup.py install for docopt 08:32:33 INFO - Successfully installed blobuploader requests docopt 08:32:33 INFO - Cleaning up... 08:32:33 INFO - Return code: 0 08:32:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:32:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:33 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 0x7f8c59ca9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d1f60>, '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 0x16d2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d31d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1487349121.824119-1307638427', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:32:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:32:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:32:33 INFO - Using env: {'DISPLAY': ':0', 08:32:33 INFO - 'HOME': '/home/cltbld', 08:32:33 INFO - 'LANG': 'en_US.UTF-8', 08:32:33 INFO - 'LANGUAGE': 'en_US:en', 08:32:33 INFO - 'LOGNAME': 'cltbld', 08:32:33 INFO - 'MAIL': '/var/mail/cltbld', 08:32:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:33 INFO - 'MOZ_NO_REMOTE': '1', 08:32:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:33 INFO - 'NO_EM_RESTART': '1', 08:32:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:33 INFO - 'PWD': '/builds/slave/test', 08:32:33 INFO - 'SHELL': '/bin/bash', 08:32:33 INFO - 'SHLVL': '1', 08:32:33 INFO - 'TERM': 'linux', 08:32:33 INFO - 'TMOUT': '86400', 08:32:33 INFO - 'USER': 'cltbld', 08:32:33 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1487349121.824119-1307638427', 08:32:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:33 INFO - '_': '/tools/buildbot/bin/python'} 08:32:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:32:33 INFO - Running setup.py (path:/tmp/pip-ju2RBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:32:34 INFO - Running setup.py (path:/tmp/pip-0rloZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:32:34 INFO - Running setup.py (path:/tmp/pip-54RyZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:32:34 INFO - Running setup.py (path:/tmp/pip-c5udfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:32:34 INFO - Running setup.py (path:/tmp/pip-TdGgXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:32:34 INFO - Running setup.py (path:/tmp/pip-vspi8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:32:34 INFO - Running setup.py (path:/tmp/pip-tyoAGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:32:34 INFO - Running setup.py (path:/tmp/pip-iHcPy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:32:34 INFO - Running setup.py (path:/tmp/pip-ZZj9J6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:32:34 INFO - Running setup.py (path:/tmp/pip-Kj5cuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:32:34 INFO - Running setup.py (path:/tmp/pip-3COWHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:32:34 INFO - Running setup.py (path:/tmp/pip-aKxSOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:32:34 INFO - Running setup.py (path:/tmp/pip-DQ3ayN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:32:34 INFO - Running setup.py (path:/tmp/pip-Aqgivn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:32:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:32:34 INFO - Running setup.py (path:/tmp/pip-GrQGf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:32:35 INFO - Running setup.py (path:/tmp/pip-eAXfhe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:32:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:32:35 INFO - Running setup.py (path:/tmp/pip-olDnUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:32:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:32:35 INFO - Running setup.py install for manifestparser 08:32:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:32:35 INFO - Running setup.py install for mozcrash 08:32:35 INFO - Running setup.py install for mozdebug 08:32:35 INFO - Running setup.py install for mozdevice 08:32:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:32:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:32:35 INFO - Running setup.py install for mozfile 08:32:35 INFO - Running setup.py install for mozhttpd 08:32:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:32:35 INFO - Running setup.py install for mozinfo 08:32:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:32:35 INFO - Running setup.py install for mozInstall 08:32:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:32:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:32:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:32:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:32:35 INFO - Running setup.py install for mozleak 08:32:36 INFO - Running setup.py install for mozlog 08:32:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:32:36 INFO - Running setup.py install for moznetwork 08:32:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:32:36 INFO - Running setup.py install for mozprocess 08:32:36 INFO - Running setup.py install for mozprofile 08:32:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:32:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:32:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:32:36 INFO - Running setup.py install for mozrunner 08:32:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:32:36 INFO - Running setup.py install for mozscreenshot 08:32:36 INFO - Running setup.py install for moztest 08:32:36 INFO - Running setup.py install for mozversion 08:32:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:32:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:32:36 INFO - Cleaning up... 08:32:36 INFO - Return code: 0 08:32:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:32:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:36 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 0x7f8c59ca9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d1f60>, '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 0x16d2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d31d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1487349121.824119-1307638427', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:32:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:32:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:32:36 INFO - Using env: {'DISPLAY': ':0', 08:32:36 INFO - 'HOME': '/home/cltbld', 08:32:36 INFO - 'LANG': 'en_US.UTF-8', 08:32:36 INFO - 'LANGUAGE': 'en_US:en', 08:32:36 INFO - 'LOGNAME': 'cltbld', 08:32:36 INFO - 'MAIL': '/var/mail/cltbld', 08:32:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:36 INFO - 'MOZ_NO_REMOTE': '1', 08:32:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:36 INFO - 'NO_EM_RESTART': '1', 08:32:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:36 INFO - 'PWD': '/builds/slave/test', 08:32:36 INFO - 'SHELL': '/bin/bash', 08:32:36 INFO - 'SHLVL': '1', 08:32:36 INFO - 'TERM': 'linux', 08:32:36 INFO - 'TMOUT': '86400', 08:32:36 INFO - 'USER': 'cltbld', 08:32:36 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1487349121.824119-1307638427', 08:32:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:36 INFO - '_': '/tools/buildbot/bin/python'} 08:32:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:32:37 INFO - Running setup.py (path:/tmp/pip-iIL88w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:32:37 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:32:37 INFO - Running setup.py (path:/tmp/pip-deRuEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:32:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:32:37 INFO - Running setup.py (path:/tmp/pip-c4GX1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:32:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:32:37 INFO - Running setup.py (path:/tmp/pip-mEKzj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:32:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:32:37 INFO - Running setup.py (path:/tmp/pip-ZZu4kV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:32:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:32:37 INFO - Running setup.py (path:/tmp/pip-KG4PHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:32:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:32:37 INFO - Running setup.py (path:/tmp/pip-_9AJ7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:32:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:32:37 INFO - Running setup.py (path:/tmp/pip-2LH73m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:32:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:32:37 INFO - Running setup.py (path:/tmp/pip-GmaQvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:32:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:32:37 INFO - Running setup.py (path:/tmp/pip-9sJ0dz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:32:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:32:37 INFO - Running setup.py (path:/tmp/pip-ayhYu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:32:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:32:37 INFO - Running setup.py (path:/tmp/pip-BNnNGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:32:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:32:38 INFO - Running setup.py (path:/tmp/pip-BKw4Pg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:32:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:32:38 INFO - Running setup.py (path:/tmp/pip-eqUJ54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:32:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:32:38 INFO - Running setup.py (path:/tmp/pip-M7_sIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:32:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:32:38 INFO - Running setup.py (path:/tmp/pip-gcuPjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:32:38 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)) 08:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:32:38 INFO - Running setup.py (path:/tmp/pip-x7MBh2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:32:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:32:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:32:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:32:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:32:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:32:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:32:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:32:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:32:40 INFO - Downloading blessings-1.6.tar.gz 08:32:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:32:40 INFO - Installing collected packages: blessings 08:32:40 INFO - Running setup.py install for blessings 08:32:40 INFO - Successfully installed blessings 08:32:40 INFO - Cleaning up... 08:32:40 INFO - Return code: 0 08:32:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:32:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:32:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:32:40 INFO - Reading from file tmpfile_stdout 08:32:40 INFO - Current package versions: 08:32:40 INFO - argparse == 1.2.1 08:32:40 INFO - blessings == 1.6 08:32:40 INFO - blobuploader == 1.2.4 08:32:40 INFO - docopt == 0.6.1 08:32:40 INFO - functools32 == 3.2.3-2 08:32:40 INFO - jsonschema == 2.5.1 08:32:40 INFO - manifestparser == 1.1 08:32:40 INFO - mozInstall == 1.12 08:32:40 INFO - mozcrash == 1.0 08:32:40 INFO - mozdebug == 0.1 08:32:40 INFO - mozdevice == 0.48 08:32:40 INFO - mozfile == 1.2 08:32:40 INFO - mozhttpd == 0.7 08:32:40 INFO - mozinfo == 0.9 08:32:40 INFO - mozleak == 0.1 08:32:40 INFO - mozlog == 3.4 08:32:40 INFO - moznetwork == 0.27 08:32:40 INFO - mozprocess == 0.23 08:32:40 INFO - mozprofile == 0.28 08:32:40 INFO - mozrunner == 6.13 08:32:40 INFO - mozscreenshot == 0.1 08:32:40 INFO - mozsystemmonitor == 0.3 08:32:40 INFO - moztest == 0.8 08:32:40 INFO - mozversion == 1.4 08:32:40 INFO - psutil == 3.1.1 08:32:40 INFO - requests == 1.2.3 08:32:40 INFO - wsgiref == 0.1.2 08:32:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:40 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 0x7f8c59ca9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d1f60>, '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 0x16d2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d31d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1487349121.824119-1307638427', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:32:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:32:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:32:40 INFO - Using env: {'DISPLAY': ':0', 08:32:40 INFO - 'HOME': '/home/cltbld', 08:32:40 INFO - 'LANG': 'en_US.UTF-8', 08:32:40 INFO - 'LANGUAGE': 'en_US:en', 08:32:40 INFO - 'LOGNAME': 'cltbld', 08:32:40 INFO - 'MAIL': '/var/mail/cltbld', 08:32:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:40 INFO - 'MOZ_NO_REMOTE': '1', 08:32:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:40 INFO - 'NO_EM_RESTART': '1', 08:32:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:40 INFO - 'PWD': '/builds/slave/test', 08:32:40 INFO - 'SHELL': '/bin/bash', 08:32:40 INFO - 'SHLVL': '1', 08:32:40 INFO - 'TERM': 'linux', 08:32:40 INFO - 'TMOUT': '86400', 08:32:40 INFO - 'USER': 'cltbld', 08:32:40 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1487349121.824119-1307638427', 08:32:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:40 INFO - '_': '/tools/buildbot/bin/python'} 08:32:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:32:41 INFO - Cleaning up... 08:32:41 INFO - Return code: 0 08:32:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:32:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:32:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:32:41 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 0x7f8c59ca9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16078a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16d4ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16d1f60>, '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 0x16d2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d31d0>, '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': '337fe3f4b1febe37b85fccc40000019e-1487349121.824119-1307638427', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:32:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:32:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:32:41 INFO - Using env: {'DISPLAY': ':0', 08:32:41 INFO - 'HOME': '/home/cltbld', 08:32:41 INFO - 'LANG': 'en_US.UTF-8', 08:32:41 INFO - 'LANGUAGE': 'en_US:en', 08:32:41 INFO - 'LOGNAME': 'cltbld', 08:32:41 INFO - 'MAIL': '/var/mail/cltbld', 08:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:41 INFO - 'MOZ_NO_REMOTE': '1', 08:32:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:41 INFO - 'NO_EM_RESTART': '1', 08:32:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:41 INFO - 'PWD': '/builds/slave/test', 08:32:41 INFO - 'SHELL': '/bin/bash', 08:32:41 INFO - 'SHLVL': '1', 08:32:41 INFO - 'TERM': 'linux', 08:32:41 INFO - 'TMOUT': '86400', 08:32:41 INFO - 'USER': 'cltbld', 08:32:41 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1487349121.824119-1307638427', 08:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:41 INFO - '_': '/tools/buildbot/bin/python'} 08:32:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:32:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:32:41 INFO - Cleaning up... 08:32:41 INFO - Return code: 0 08:32:41 INFO - Running post-action listener: _resource_record_post_action 08:32:41 INFO - Running post-action listener: _start_resource_monitoring 08:32:41 INFO - Starting resource monitoring. 08:32:41 INFO - [mozharness: 2017-02-17 16:32:41.381856Z] Finished create-virtualenv step (success) 08:32:41 INFO - [mozharness: 2017-02-17 16:32:41.382344Z] Running install step. 08:32:41 INFO - Running pre-action listener: _resource_record_pre_action 08:32:41 INFO - Running main action method: install 08:32:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:32:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:32:41 INFO - Reading from file tmpfile_stdout 08:32:41 INFO - Detecting whether we're running mozinstall >=1.0... 08:32:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:32:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:32:41 INFO - Reading from file tmpfile_stdout 08:32:41 INFO - Output received: 08:32:41 INFO - Usage: mozinstall [options] installer 08:32:41 INFO - Options: 08:32:41 INFO - -h, --help show this help message and exit 08:32:41 INFO - -d DEST, --destination=DEST 08:32:41 INFO - Directory to install application into. [default: 08:32:41 INFO - "/builds/slave/test"] 08:32:41 INFO - --app=APP Application being installed. [default: firefox] 08:32:41 INFO - mkdir: /builds/slave/test/build/application 08:32:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:32:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:32:55 INFO - Reading from file tmpfile_stdout 08:32:55 INFO - Output received: 08:32:55 INFO - /builds/slave/test/build/application/firefox/firefox 08:32:55 INFO - Running post-action listener: _resource_record_post_action 08:32:55 INFO - [mozharness: 2017-02-17 16:32:55.317291Z] Finished install step (success) 08:32:55 INFO - [mozharness: 2017-02-17 16:32:55.317533Z] Running run-tests step. 08:32:55 INFO - Running pre-action listener: _resource_record_pre_action 08:32:55 INFO - Running main action method: run_tests 08:32:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:32:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:32:55 INFO - Python 2.7.3 08:32:55 INFO - Return code: 0 08:32:55 INFO - grabbing minidump binary from tooltool 08:32:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:32:55 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 0x16d1f60>, '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 0x16d2d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16d31d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:32:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:32:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:32:55 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:32:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:32:55 INFO - Return code: 0 08:32:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:32:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:32:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:32:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:32:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:32:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YyieLW-SSoWBSIHpSKNHDQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:32:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YyieLW-SSoWBSIHpSKNHDQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:32:55 INFO - Using env: {'DISPLAY': ':0', 08:32:55 INFO - 'HOME': '/home/cltbld', 08:32:55 INFO - 'LANG': 'en_US.UTF-8', 08:32:55 INFO - 'LANGUAGE': 'en_US:en', 08:32:55 INFO - 'LOGNAME': 'cltbld', 08:32:55 INFO - 'MAIL': '/var/mail/cltbld', 08:32:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:32:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:32:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:32:55 INFO - 'MOZ_NO_REMOTE': '1', 08:32:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:32:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:32:55 INFO - 'NO_EM_RESTART': '1', 08:32:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:32:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:32:55 INFO - 'PWD': '/builds/slave/test', 08:32:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:32:55 INFO - 'SHELL': '/bin/bash', 08:32:55 INFO - 'SHLVL': '1', 08:32:55 INFO - 'TERM': 'linux', 08:32:55 INFO - 'TMOUT': '86400', 08:32:55 INFO - 'USER': 'cltbld', 08:32:55 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1487349121.824119-1307638427', 08:32:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:32:55 INFO - '_': '/tools/buildbot/bin/python'} 08:32:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YyieLW-SSoWBSIHpSKNHDQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:32:55 INFO - mozversion application_buildid: 20170217064138 08:32:55 INFO - mozversion application_changeset: 546f359ac8c0dbb466e6b307a0f906ea6df62a45 08:32:55 INFO - mozversion application_display_name: Firefox 08:32:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:32:55 INFO - mozversion application_name: Firefox 08:32:55 INFO - mozversion application_remotingname: firefox 08:32:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:32:55 INFO - mozversion application_vendor: Mozilla 08:32:55 INFO - mozversion application_version: 52.0 08:32:55 INFO - mozversion platform_buildid: 20170217064138 08:32:55 INFO - mozversion platform_changeset: 546f359ac8c0dbb466e6b307a0f906ea6df62a45 08:32:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:32:55 INFO - mozversion platform_version: 52.0 08:32:55 INFO - using testdate: 1487349175 08:32:55 INFO - actual date: 1487349175 08:32:55 INFO - starting webserver on 'localhost:58914' 08:32:55 INFO - SUITE-START | Running 2 tests 08:32:55 INFO - TEST-START | dromaeo_css 08:32:55 INFO - operating with platform_type : linux_ 08:32:55 INFO - Initialising browser for dromaeo_css test... 08:32:55 INFO - TEST-INFO | started process 28167 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt1EzYK/profile http://localhost:58914/getInfo.html) 08:32:59 INFO - PROCESS | 28167 | __metrics Screen width/height:1600/1200 08:32:59 INFO - PROCESS | 28167 | colorDepth:24 08:32:59 INFO - PROCESS | 28167 | Browser inner width/height: 1024/697 08:32:59 INFO - PROCESS | 28167 | __metrics 08:33:00 INFO - PROCESS | 28167 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:33:00 INFO - PROCESS | 28167 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:33:01 INFO - TEST-INFO | 28167: exit 0 08:33:01 INFO - Browser initialized. 08:33:01 INFO - Running cycle 1/1 for dromaeo_css test... 08:33:01 INFO - TEST-INFO | started process 28259 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt1EzYK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:33:13 INFO - PROCESS | 28259 | RSS: Main: 142110720 08:33:13 INFO - PROCESS | 28259 | 08:36:14 INFO - PROCESS | 28259 | Cycle 1(1): loaded http://localhost:58914/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58914/tests/dromaeo/cssquery-ext.html) 08:36:15 INFO - PROCESS | 28259 | RSS: Main: 245817344 08:36:15 INFO - PROCESS | 28259 | 08:39:18 INFO - PROCESS | 28259 | Cycle 1(1): loaded http://localhost:58914/tests/dromaeo/cssquery-ext.html (next: http://localhost:58914/tests/dromaeo/cssquery-jquery.html) 08:39:18 INFO - PROCESS | 28259 | RSS: Main: 226643968 08:39:18 INFO - PROCESS | 28259 | 08:42:20 INFO - PROCESS | 28259 | Cycle 1(1): loaded http://localhost:58914/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58914/tests/dromaeo/cssquery-mootools.html) 08:42:21 INFO - PROCESS | 28259 | RSS: Main: 208596992 08:42:21 INFO - PROCESS | 28259 | 08:45:23 INFO - PROCESS | 28259 | Cycle 1(1): loaded http://localhost:58914/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58914/tests/dromaeo/cssquery-prototype.html) 08:45:23 INFO - PROCESS | 28259 | RSS: Main: 225169408 08:45:23 INFO - PROCESS | 28259 | 08:48:26 INFO - PROCESS | 28259 | Cycle 1(1): loaded http://localhost:58914/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58914/tests/dromaeo/cssquery-yui.html) 08:48:26 INFO - PROCESS | 28259 | RSS: Main: 175996928 08:48:26 INFO - PROCESS | 28259 | 08:51:29 INFO - PROCESS | 28259 | Cycle 1(1): loaded http://localhost:58914/tests/dromaeo/cssquery-yui.html (next: http://localhost:58914/tests/dromaeo/cssquery-dojo.html) 08:51:29 INFO - PROCESS | 28259 | RSS: Main: 267681792 08:51:29 INFO - PROCESS | 28259 | 08:51:29 INFO - PROCESS | 28259 | __start_tp_report 08:51:29 INFO - PROCESS | 28259 | _x_x_mozilla_page_load 08:51:29 INFO - PROCESS | 28259 | _x_x_mozilla_page_load_details 08:51:29 INFO - PROCESS | 28259 | |i|pagename|runs| 08:51:29 INFO - PROCESS | 28259 | |0;dojo.html;3237.33634604906;3262.4127657021736;3266.967330326696;3290.1939024938865;3313.90058298251;5520.66875987441;5588.524975377093;5613.214150019001;5615.578831587637;5623.662580245188;5592.916106258409;5636;5638.746256418461;5640.5487560995025;5674.971625141879;5052.671576347544;5089.236614507817;5119.206522988924;5126.282320475137;5166.328377310944;4966.776495057731;4986.351774269358;5154.329937108189;5181.818636347729;5186.118359878811;5023.824166154185;5046.82336118236;5075.238714192864;5094.872628184306;5107.591392688594;5116.820911268106;5141.280220769077;5204.3234379530795;5207.453217412193;5228.712420816853;4808.711477311337;5090.0583392072585;5113.667611605234;5163.63854530183;5179.948200517984;5363.195520671891;5386.326709161355;5428.538574221196;5438.619296649236;5505.807296744595;5935.643861368331;5942.494887934531;6037.818865434044;6042.848928776772;6044.032954727267;5843.357230704619;6071.089336599502;6093.664848433335;6095.542834287402;6098.207233059718;5503.229547863262;5507.339119305669;5515.696636685021;5562.582806289504;5569.0254205513875;6031.366706495843;6034.849128771728;6036.245469316335;6037.486813620892;6040.214772079689;5690.260266165372;5788.88422231553;5801.361850196475;5803.593748437569;5809.796657116981;5812.825615231465;5890.4698577128265;5957.553183511254;5957.76168953237;6042.12389203563;5971.462568368867;5980.192673988956;5980.491658209101;5982.970085149546;5986.191864098291;5929.3181284152015;5987.042073268343;5989.041753319448;5993.400659934059;6013.639181649115;4511.684182107221;4540.636749060067;4572.245579479415;4581.335706322565;4587.266037434061;4073.287174744408;4099.405586190045;4104.651104656137;4130.0294430808735;4130.112025914443;5679.914801277984;5680.403557626472;5697.515711164598;5714.428557144335;5741.110127930177;5839.036558967808;5863.2670916135485;5894.204282421904;5911.024680927685;5958.225430693982;5681.630694004876;5704.771809127671;5706.258186435737;5711.628744131618;5722.713864306768;5083.161278389024;5086.872828179251;5094.643374963717;5096.668716533413;5120.769565369567;5912.733926973297;6049.213602231682;6080.118382834553;6185.474234690012;6196.0705894115345;5887.499562537232;5970.880582388415;5985.670788106696;6002.909956350571;6021.789237376671;6153.107799369156;6180.969095154495;6182.814515564541;6184.474319682878;6201.3178550358525;5683.9715801420725;5705.771769129188;5835.708214589169;5835.766569337179;5839.970800146142;5932.0508718604815;5938.524918006463;5979.222701048836;6019.578629495893;6053.485453736482;5762.510186634183;5785.39253378406;5851.882962340645;5869.002269614261;5872.119182122716;5593.944060559343;5768.884622307614;5773.509251713652;5783.074708046693;5789.073748200436;5526.778928842962;5733.455321744427;5761.5102716269585;5785.3636100028125;5793.536517078539;5942.940570594412;5953.91069133972;5956;5956.344802071682;5966.970165149147;5571.331440227199;5603.859903502445;5652.85867853307;5792.4497172768515;5809.50619197373 08:51:29 INFO - PROCESS | 28259 | |1;ext.html;580.8431723434672;603.1254680712966;632.5034847644598;660.6102399584247;661.7584581627701;32804.507932381006;43270.78364608176;43900.56099439005;44097.338539921926;46795.76602116993;44669.10661786771;44990.32514512277;45150.09699806002;45234.773826130826;45270.32094518585;8258.380621453414;8925.285977121815;9072.863907041366;9078.319126065571;9084.454932704059;8158.347332213439;8400.285975692073;8402.495850248974;10643.78712425755;10883.945580272088;11030.117590592734;11091.33451992883;11094.889051109507;11096.611618593352;11106.888931110667;10788.892111078907;10847;10854.45727713615;10856.728581785439;10879.83680244797;10707.625233116803;10768.78462430755;10771.407572583505;10776.946115269451;10788.838167427495;42706.57293427057;42973;43110.353344699855;43127;43145.13709725788;3389.084947064279;3573.6783689468075;3658.634136586347;3715.851365945386;3872.9930218143204;30337.848310758305;30941.535876961865;30979.535306970414;31344.37311253762;31702;4098.672106231495;4154.833806647761;4172.833086676529;4180.874573762792;4260.786960651955;333073;335846;339532;339607;339889.99999999756;57556.71221643949;57898;57944.13083803746;57997.71001144967;58029.12956305659;38537.614623853406;39471.802640986614;39518.82646454473;42221.577784222376;42250.788746056685;17384.130793460277;17492.825071749376;17494.825051749573;17506.299748009937;17509.474715758548;13512;13545.729085418236;13588;13599.660008499866;13620.863791362157;17969.191386387643;18279.36022239215;18303.26786928508;19229.4231173065;19436.319728809423;6823.351781580742;7108.253633368526;7141.929230246583;7362.263773622595;7367.852642947111;970.7670159161751;1020.2959957629361;1055.8416237564427;1064.377339256528;1101.983470247947;31806;31916;32117;32540.186495337333;32587.51118733221;1115.2806439846254;1159.675290918544;1177.6879127031343;1195.7907366211052;1235.3576140407117;17056.2324695389;17315.307387704604;17329.7400538992;17402.21690023952;17445.21496532659;515835;520384;520885;521499;525402;52075.218871716956;53060;56308.718456407456;60132.39867601355;60782.08826867512;1400.95096671616;1406.3249640172774;1422.3528294625921;1422.5447856685762;1423.615623781594;30283.394332113676;32022.35955280928;32444.51333229956;32615.18462038468;32960.1759956003;51277;51839.481605183464;51842.48157518527;51854.74072629613;51858.74070629623;402643;423620;426566;427949;434017;29823.956161534243;29897.252568685955;29909.850450747606;30104.09687709372;30320.696793031788;46893.29660055033;47832.52167478281;47856.282155766996;48064.7596762028;48316;39341.6065839338;39887;40448.595514044486;41558.1688366237;41895.371569427094;39449.80275098606;39881.60118398779;40032.39951400673;41128.38307425451;41286;40369;40898.79550602228;41008.79495602503;41012.179756405305;41200.38199426951;34008;36208.456873146395;36739.816300918326;37425.43861842129;37640.43539346857;27410.177694669193;28126.578101328087;28128.29679258035;28337.43325133527;28363.290917726397 08:51:29 INFO - PROCESS | 28259 | |2;jquery.html;410.8562003298844;413.6607981455208;419.8551499732592;420.94738157730285;441.3203666353815;18631.534211644717;19566.804331956693;19663.5084122897;20031.599368012667;20063.799362006393;19256.22975080995;19488.220471181172;19723.21107155712;19758.30845920393;19779.901100494513;5460.563154947605;5762.4525670061485;5791.768329266824;5802.216700745387;5804.2744656917885;5682.715864206793;5779.162021506879;5803.50670193032;5809.535237181015;5812.796552120677;6081.239845019372;6109.572329936884;6118.418750218744;6121;6121.449069583737;6105.450509454148;6113.296970848342;6161.1066395372645;6514.283428822826;6559.540832141752;5867.501262392701;5867.941320586782;5886.440788125121;5886.9705651471895;5891.05743081105;17533.912330438394;22181;22444.32667019992;22868.199613013632;23050.308490745305;2159.7408311002623;2284.851484653492;2408.9397765055837;2683.2889284339667;2741.8354898706143;9721.319507634398;10214.387136771817;10321.43232122233;10654.09440197584;10694.839577406345;1683.6127690631224;1728.0495727349908;1752.3253547384222;1833.4591295567839;1856.2482194711163;74153;76647;78741;79668;81889;10821.67534973952;11292;11490.712732181595;11699.473523691455;11821.349825759666;16459.753103703453;16511.752323715154;16516.50450486487;16528.25622846975;16532.256048477608;8420.452670576515;8703.956480217685;8706.47761134334;8784;8954.597043132944;8422.789430264293;8468.280196183394;8534.402591818513;8682.131786821268;8749.431286966326;4882.316475693406;4998.775055122528;5008.398992120896;5113.463086375951;5135.717535535581;1947.6688962876344;2038.86747361424;2071.337172104942;2077.418322869599;2097.968530472044;911.2618778789202;986.6398764451068;1022.2844009193594;1028.2339656955467;1037.3775734559356;19062;19126.2349506021;19206.807931920503;19268.518287042934;19400.2239910402;984.6209209454269;1018.7707765752795;1041.5833666533447;1042.1142029275056;1089.0525243038448;9871.605135794487;10652.786944261226;10694.893051069545;10747.301425407324;10790.406527641055;472497;490199;495244;497765;499715;69948;75312;80513;95402.52298738463;99829.50085249527;1029.161233594633;1039.589362201926;1074.55406006508;1083.2363183955292;1083.5557421457165;16522.339106435607;16743.832561674226;17172.570685732957;17355.913220433817;17616.471505854846;41117.1776564461;41951.58048419477;42408.93977650583;42667.3599896008;42741.78629106835;59964.40035599588;59966;61212.693936530035;61421;61544.69227653833;8442.577871106298;8591.52746598918;8709.346798990227;8939.865902011345;8982.461052336881;11824.82262766042;11984.221025633306;12286.754264914473;13317.134386264861;13821.654458638212;10833.29583577065;10950.835737463785;11127.276727012719;11212.43937803123;11347.886521134684;11110.50002749862;11404.543818247177;11494.080473562262;11689.532418703157;11742.412879356169;10866.13070954306;11177.608783692533;11309.830352544883;11842.348670823187;12088.274703517465;8712.520811355183;8910.287177025952;8935.553222338987;8944.910550894409;9036.051214622634;8764.868526971974;11534.480948357512;11744.29534227949;11866.584669536525;12233.3271670059 08:51:29 INFO - PROCESS | 28259 | |3;mootools.html;1490.225082956862;1518.53684626189;1635.133379308966;1711.161530849884;1777.4934143769028;8376.95811520943;8977.192052715254;8988.101189881008;8993.145651163137;8996.505192214425;7420.183779784233;7680.692772289116;8393.496390216591;8623.741287761362;8631.611577479012;2404.3388068281233;2430.307362401716;2433.8661373624445;2437.122635851092;2440.7559244075537;2398.304491697406;2448.608222684371;2466.0998735461517;2466.124525793344;2466.469709012562;2430.149447693302;2451.0195921631403;2451.889664965072;2470.938226544333;2496.5256601245796;2407.3620490570015;2424.163663536086;2436.817238707104;2443.511297740441;2447.730749617541;2409.3133456964856;2434.525267572806;2458.8524688518746;2459.397447625325;2460.3603063203695;8847.823043539092;8916.598753056129;8930.955345223298;8937.821243575092;8938.329625278131;5339.70631615261;5481.177823326493;5491.28613280275;5492.47821456961;5497.422770609109;3482.146874015857;3490.3542844573835;3509.94735078974;3559.8220088995445;3679.5400574928135;1169.5555688838272;1171.0748508678134;1202.8436303280605;1209.6371088673363;1221.6457227404042;11722;11728.472218750177;11740.295582265177;11751.764964700658;11754.118441116865;4643.535646435397;4668.416447944007;4819.927701084486;4832.299316599074;4998.625103117281;10427.322224055411;10430.061294483532;10436.060754532129;10439.843402348972;10444.164466842634;5442.945570544323;5460;5475.917861232085;5477.643953143033;5483.725813709299;4292.763897985641;4420.425344705232;4859.586935110555;4921.335619691367;5061.44324124346;4119.701189055372;4121;4159.5879046039145;4193.811278492475;4198.307279298942;1304.712963148106;1358.8844948179317;1359.5717349035021;1363.2842757552364;1369.2537567025995;850.3282406898604;872.8123453457537;873.5894129759004;890.7550423633553;893.1470445724318;5837.153612726216;5954.642721436728;6012.579119461596;6187.412195841388;6514.022896565553;941.9858702119474;947.346331031586;953.8473844184897;966.4346357381011;982.4596471940404;4300.827966881289;4303.655707543389;4348.130373925228;4374.715643483163;4436.44544431946;10475.895241047645;10492.842607360895;10648.467576621139;10677.519511621995;10691.572337106429;10509.632162874263;10511.159107271553;10559.947200263949;10567.63013294531;10605;7902.920970790218;8010.118886922434;8168.469049511644;8181.427300088937;8221.917780822236;5914.58597898143;5998;6091.086337049478;6128.111423843607;6175.104609831639;10005.649802256887;10112.696619101438;10119.392836429543;10119.645812396826;10162.745931351776;10050.145737612385;10377.896221037692;10389.220808439548;10414.479276036016;10459.110975566859;6972.546784458994;7225.530340527849;7574.962125189339;7886.566238856918;8075.152109028468;8284.875726864222;8653.091425400242;8654.177853103945;8669.21977022071;8672.479651220947;7521.661525231269;7570.129435114812;7685.769426917202;7730.806729831799;7920.920790792018;7467.850642987001;7483.962580187064;7519.172890982097;7551.660175292235;7613.695452181851;7053.612051337226;7157.033800436874;7159.069320988238;7164.677589508589;7164.89252661221;5120.103981803244;5384.946150538444;5394.568434525307;5472.808451704172;5489.039418101736;5359.785608575613;5375.274337964324;5427.945720542902;5497.642653227527;5501.202325662836 08:51:29 INFO - PROCESS | 28259 | |4;prototype.html;326.9705726484617;352.3252970561375;353.19471604741193;360.63575788453653;362.04420330327923;5417.539509141723;5429.945700542993;5435.9728201358985;5440.972795136028;5444.673319600826;5081.644284900059;5173.5085166909175;5223;5260;5361.490658387456;4222.78886055696;4224.8732538023905;4232.555581663927;4246.4691913510815;4258.467691538558;4216.409702641633;4233.809478573472;4238.682098842583;4243.511996120439;4245.915081698364;4108.26051310764;4183.707140500166;4192.392103145042;4223.197592457439;4223.197592457439;4203.327467605184;4206.894827629303;4211.515675697304;4215.6205941465105;4253.957460425387;3766.5291838520184;3768.1333293342686;3794.924101517982;3824.521934758155;3842.1931394407206;5088.440271570124;5259.3951695555115;5297.516695325315;5299.788008479656;5328.653637513588;4854.466008739036;4855.36880205571;4863.416390033183;4863.416390033219;4883.072216278932;5587.580931430119;5588.758520058356;5602.831915042555;5607.57943154261;5608.383077861432;4108.815103320358;4160.1679664067005;4180.519240287345;4181.26827805136;4183.435236243099;5782.421757824184;5800.825975220708;5809.091317836422;5809.390014048548;5867.207926929853;4289.863186255645;4291.399204111427;4292.420523229386;4321.956780432155;4328.783560821947;4075.89810254746;4298.183345164409;4377.802998864995;4382.408374869416;4387.27609944362;4815.951840481621;4816.036792641486;4831.154547954094;4865.8053677853195;4872.853814385574;5660.094384898479;5691.26013618227;5710.571707121982;5732;5737.569682273846;1398.8880889528814;1424.2095636921608;1425.3799597175262;1429.2496439369415;1437.3172742947227;979.6962941488162;1005.8440941653909;1006.4414250091123;1006.6325791086201;1016.3241444439365;5304.939012197576;5325.405351387875;5326.760295786699;5338.092524270884;5347.973260133675;5597.272354593877;5600.103983362643;5612.438756124437;5624.887502250014;5690.118031705092;5229.692576855786;5291.618771552817;5318.601104917147;5323.467653234646;5563.304586926634;2942.5880376747273;2975.6577993530586;2986.6266716660416;3004.3240270938863;3006.909792706222;5803.65178089316;5812.360640329561;5821.679807610622;5829.271341082364;5841.795537156179;5459.2902922619805;5705.771769129188;5720.48515633595;5737.225474560881;5738.540916726652;5781.219535362757;5801.825945221734;5826;5835.912461313083;5869.266341707286;5343.572514198932;5568.832935011957;5573.888522229614;5618.775248990158;5630.971845140748;5519.254900588369;5526.613137080366;5542.836004439113;5552.583556233218;5557.527610153183;5789.842031593614;5790.247267855152;5790.478856902899;5820.621659592282;5834.541364658835;3980.4626375440102;4067.3695577185586;4069.2065047316673;4086.795660216918;4093.099518106012;5528.474794894479;5558.888822223452;5605.878824235251;5744.626599271034;5749.655020698771;5557.971340460784;5589.664620122806;5611.551075913835;5641;5647.5199608032135;5489.615726899079;5605.635633683797;5606.495415412633;5608.551315894801;5628;5555.722213889208;5577.8047768327915;5579.4978451937895;5581.218629391969;5586.413426590312;5592.748326325243;5607.831765047055;5641.294838145232;5645.491905728504;5687.402822703557;5320.361556613231;5463.262459567907;5486.506214440719;5515.61390702647;5515.869246804476 08:51:29 INFO - PROCESS | 28259 | |5;yui.html;760.733743189884;768.8385439057797;790.8813677948303;796.6773456750017;820.7619790260823;14090.859091409084;14788.6302842429;14829.184394858292;14833.110013399204;14861.182634955074;14726.705465890676;14907.627309317273;14950.775738363933;14958.850411495881;14962.925185374084;722.12622726501;737.5943231222806;846.4878748357247;869.0266901070778;879.634951495132;874.9693760718376;876.7369789063288;877.188600544497;877.5392918717661;877.7981064355203;919.4161707315869;919.5953780336664;920.8848893888264;920.9815803683956;922.1193759959257;917.3303488453433;923.0630909626734;923.5843870258343;923.6536298887917;923.8290916180528;670.1656437735003;670.792054463118;671.9865602687919;672.1765836849869;672.4317951331118;15020.774688379683;15033.699326013528;15103.697926041528;15132.167730774803;15341.92329038359;14153.504627337994;14481.855181448156;14636.121832690073;15003.1748253846;15048.623784405478;11023.724406889813;11030.558777648885;11103.72240693981;11223.60717374888;11245.269057511236;3708.2212735325616;3751.8311675974373;3754.080250338657;3804.2201348723447;3833.4441505981754;56475.43524564743;57594;59043.70478147625;63745.36254637487;63912.680436597984;10486.213533984981;10713.83929241062;10714.980714631352;11368.374739389248;11464.31214127155;19707.605847882962;19854.90072549628;20095.397138085882;20139;20176.69734953977;7734.2265773422205;7975.8404831903035;8003.319717823933;8063.314618257514;8194.631241594023;4472.485664148665;4545.068261006486;4573.6569757268335;4659.930101048487;4694.554017368345;3469.4795780632603;3570.625084366156;3575.66031227033;3578.8568457261417;3598.460230965376;591.9467247947705;594.9851253718691;600.3966014155833;601.8104297146385;613.0650757594703;589.8584339758427;610.2158726037021;668.6289109544152;685.8011176758783;700.4501466348994;8180.386471014579;8597.192488684606;8702.695405660772;8887.244584210286;9074.410163339362;571.4399888109676;591.5947575910429;646.1825790375179;648.4002297874541;659.9538032337787;4092.9181416371507;4208.978955105266;4271.893202669896;4299.78501074945;4479.3057076153245;69531;70789.64605177044;71935.28064719286;81374.18625813666;87267.56366218129;45922.54077459183;65562;68138.31861681418;69399;70840;55618;64310;64454.677726612004;64534.67732661401;65733.67133164399;8886.422382545114;9169.35814492979;9203.723888283363;9268.629254829732;9300.767480813034;42232.36651450292;42413.57586424219;43613.78193109014;43859.34210986774;43892.78053609839;54162;58790.706046469495;58857.41142588691;58924.70537647456;60020.699896500235;10875.891241087487;11182.32906025641;11318.60384886525;11463.828042579202;11514.366709830705;12958.53130674885;13594.524191653245;13646.795298070736;13696.52062177819;14160.150390976574;11958.342291174069;12069.39653017328;12421.875781242434;12452.252864828139;12464;13234.867651323364;13285.66785830362;13355.53255636048;13478;13622.591322260349;10094.8485772712;10477.947610262205;10685.465726713788;12154.331511766584;12163.939180304396;9724;10326.845097323396;10399.896001040195;10473.9476302618;10935.56257749681;10305.587776488857;10431.16550675929;10569.524371403151;10629.36223826542;10859.34843909368 08:51:29 INFO - PROCESS | 28259 | __end_tp_report 08:51:29 INFO - PROCESS | 28259 | __start_cc_report 08:51:29 INFO - PROCESS | 28259 | _x_x_mozilla_cycle_collect,1002 08:51:29 INFO - PROCESS | 28259 | __end_cc_report 08:51:29 INFO - PROCESS | 28259 | __startTimestamp1487350289621__endTimestamp 08:51:29 INFO - PROCESS | 28259 | 08:51:29 INFO - PROCESS | 28259 | ------- Summary: start ------- 08:51:29 INFO - PROCESS | 28259 | Number of tests: 6 08:51:29 INFO - PROCESS | 28259 | 08:51:29 INFO - PROCESS | 28259 | [#0] dojo.html Cycles:165 Average:5537.43 Median:5733.46 stddev:615.40 (10.7%) stddev-sans-first:590.25 08:51:29 INFO - PROCESS | 28259 | Values: 3237.3 3262.4 3267.0 3290.2 3313.9 5520.7 5588.5 5613.2 5615.6 5623.7 5592.9 5636.0 5638.7 5640.5 5675.0 5052.7 5089.2 5119.2 5126.3 5166.3 4966.8 4986.4 5154.3 5181.8 5186.1 5023.8 5046.8 5075.2 5094.9 5107.6 5116.8 5141.3 5204.3 5207.5 5228.7 4808.7 5090.1 5113.7 5163.6 5179.9 5363.2 5386.3 5428.5 5438.6 5505.8 5935.6 5942.5 6037.8 6042.8 6044.0 5843.4 6071.1 6093.7 6095.5 6098.2 5503.2 5507.3 5515.7 5562.6 5569.0 6031.4 6034.8 6036.2 6037.5 6040.2 5690.3 5788.9 5801.4 5803.6 5809.8 5812.8 5890.5 5957.6 5957.8 6042.1 5971.5 5980.2 5980.5 5983.0 5986.2 5929.3 5987.0 5989.0 5993.4 6013.6 4511.7 4540.6 4572.2 4581.3 4587.3 4073.3 4099.4 4104.7 4130.0 4130.1 5679.9 5680.4 5697.5 5714.4 5741.1 5839.0 5863.3 5894.2 5911.0 5958.2 5681.6 5704.8 5706.3 5711.6 5722.7 5083.2 5086.9 5094.6 5096.7 5120.8 5912.7 6049.2 6080.1 6185.5 6196.1 5887.5 5970.9 5985.7 6002.9 6021.8 6153.1 6181.0 6182.8 6184.5 6201.3 5684.0 5705.8 5835.7 5835.8 5840.0 5932.1 5938.5 5979.2 6019.6 6053.5 5762.5 5785.4 5851.9 5869.0 5872.1 5593.9 5768.9 5773.5 5783.1 5789.1 5526.8 5733.5 5761.5 5785.4 5793.5 5942.9 5953.9 5956.0 5956.3 5967.0 5571.3 5603.9 5652.9 5792.4 5809.5 08:51:29 INFO - PROCESS | 28259 | 08:51:29 INFO - PROCESS | 28259 | [#1] ext.html Cycles:180 Average:58741.31 Median:38089.03 stddev:114772.58 (301.3%) stddev-sans-first:115011.47 08:51:29 INFO - PROCESS | 28259 | Values: 580.8 603.1 632.5 660.6 661.8 32804.5 43270.8 43900.6 44097.3 46795.8 44669.1 44990.3 45150.1 45234.8 45270.3 8258.4 8925.3 9072.9 9078.3 9084.5 8158.3 8400.3 8402.5 10643.8 10883.9 11030.1 11091.3 11094.9 11096.6 11106.9 10788.9 10847.0 10854.5 10856.7 10879.8 10707.6 10768.8 10771.4 10776.9 10788.8 42706.6 42973.0 43110.4 43127.0 43145.1 3389.1 3573.7 3658.6 3715.9 3873.0 30337.8 30941.5 30979.5 31344.4 31702.0 4098.7 4154.8 4172.8 4180.9 4260.8 333073.0 335846.0 339532.0 339607.0 339890.0 57556.7 57898.0 57944.1 57997.7 58029.1 38537.6 39471.8 39518.8 42221.6 42250.8 17384.1 17492.8 17494.8 17506.3 17509.5 13512.0 13545.7 13588.0 13599.7 13620.9 17969.2 18279.4 18303.3 19229.4 19436.3 6823.4 7108.3 7141.9 7362.3 7367.9 970.8 1020.3 1055.8 1064.4 1102.0 31806.0 31916.0 32117.0 32540.2 32587.5 1115.3 1159.7 1177.7 1195.8 1235.4 17056.2 17315.3 17329.7 17402.2 17445.2 515835.0 520384.0 520885.0 521499.0 525402.0 52075.2 53060.0 56308.7 60132.4 60782.1 1401.0 1406.3 1422.4 1422.5 1423.6 30283.4 32022.4 32444.5 32615.2 32960.2 51277.0 51839.5 51842.5 51854.7 51858.7 402643.0 423620.0 426566.0 427949.0 434017.0 29824.0 29897.3 29909.9 30104.1 30320.7 46893.3 47832.5 47856.3 48064.8 48316.0 39341.6 39887.0 40448.6 41558.2 41895.4 39449.8 39881.6 40032.4 41128.4 41286.0 40369.0 40898.8 41008.8 41012.2 41200.4 34008.0 36208.5 36739.8 37425.4 37640.4 27410.2 28126.6 28128.3 28337.4 28363.3 08:51:29 INFO - PROCESS | 28259 | 08:51:29 INFO - PROCESS | 28259 | [#2] jquery.html Cycles:180 Average:28884.86 Median:12729.62 stddev:80808.28 (634.8%) stddev-sans-first:81006.68 08:51:29 INFO - PROCESS | 28259 | Values: 410.9 413.7 419.9 420.9 441.3 18631.5 19566.8 19663.5 20031.6 20063.8 19256.2 19488.2 19723.2 19758.3 19779.9 5460.6 5762.5 5791.8 5802.2 5804.3 5682.7 5779.2 5803.5 5809.5 5812.8 6081.2 6109.6 6118.4 6121.0 6121.4 6105.5 6113.3 6161.1 6514.3 6559.5 5867.5 5867.9 5886.4 5887.0 5891.1 17533.9 22181.0 22444.3 22868.2 23050.3 2159.7 2284.9 2408.9 2683.3 2741.8 9721.3 10214.4 10321.4 10654.1 10694.8 1683.6 1728.0 1752.3 1833.5 1856.2 74153.0 76647.0 78741.0 79668.0 81889.0 10821.7 11292.0 11490.7 11699.5 11821.3 16459.8 16511.8 16516.5 16528.3 16532.3 8420.5 8704.0 8706.5 8784.0 8954.6 8422.8 8468.3 8534.4 8682.1 8749.4 4882.3 4998.8 5008.4 5113.5 5135.7 1947.7 2038.9 2071.3 2077.4 2098.0 911.3 986.6 1022.3 1028.2 1037.4 19062.0 19126.2 19206.8 19268.5 19400.2 984.6 1018.8 1041.6 1042.1 1089.1 9871.6 10652.8 10694.9 10747.3 10790.4 472497.0 490199.0 495244.0 497765.0 499715.0 69948.0 75312.0 80513.0 95402.5 99829.5 1029.2 1039.6 1074.6 1083.2 1083.6 16522.3 16743.8 17172.6 17355.9 17616.5 41117.2 41951.6 42408.9 42667.4 42741.8 59964.4 59966.0 61212.7 61421.0 61544.7 8442.6 8591.5 8709.3 8939.9 8982.5 11824.8 11984.2 12286.8 13317.1 13821.7 10833.3 10950.8 11127.3 11212.4 11347.9 11110.5 11404.5 11494.1 11689.5 11742.4 10866.1 11177.6 11309.8 11842.3 12088.3 8712.5 8910.3 8935.6 8944.9 9036.1 8764.9 11534.5 11744.3 11866.6 12233.3 08:51:29 INFO - PROCESS | 28259 | 08:51:29 INFO - PROCESS | 28259 | [#3] mootools.html Cycles:180 Average:5832.12 Median:4845.94 stddev:3199.64 (66.0%) stddev-sans-first:3191.97 08:51:29 INFO - PROCESS | 28259 | Values: 1490.2 1518.5 1635.1 1711.2 1777.5 8377.0 8977.2 8988.1 8993.1 8996.5 7420.2 7680.7 8393.5 8623.7 8631.6 2404.3 2430.3 2433.9 2437.1 2440.8 2398.3 2448.6 2466.1 2466.1 2466.5 2430.1 2451.0 2451.9 2470.9 2496.5 2407.4 2424.2 2436.8 2443.5 2447.7 2409.3 2434.5 2458.9 2459.4 2460.4 8847.8 8916.6 8931.0 8937.8 8938.3 5339.7 5481.2 5491.3 5492.5 5497.4 3482.1 3490.4 3509.9 3559.8 3679.5 1169.6 1171.1 1202.8 1209.6 1221.6 11722.0 11728.5 11740.3 11751.8 11754.1 4643.5 4668.4 4819.9 4832.3 4998.6 10427.3 10430.1 10436.1 10439.8 10444.2 5442.9 5460.0 5475.9 5477.6 5483.7 4292.8 4420.4 4859.6 4921.3 5061.4 4119.7 4121.0 4159.6 4193.8 4198.3 1304.7 1358.9 1359.6 1363.3 1369.3 850.3 872.8 873.6 890.8 893.1 5837.2 5954.6 6012.6 6187.4 6514.0 942.0 947.3 953.8 966.4 982.5 4300.8 4303.7 4348.1 4374.7 4436.4 10475.9 10492.8 10648.5 10677.5 10691.6 10509.6 10511.2 10559.9 10567.6 10605.0 7902.9 8010.1 8168.5 8181.4 8221.9 5914.6 5998.0 6091.1 6128.1 6175.1 10005.6 10112.7 10119.4 10119.6 10162.7 10050.1 10377.9 10389.2 10414.5 10459.1 6972.5 7225.5 7575.0 7886.6 8075.2 8284.9 8653.1 8654.2 8669.2 8672.5 7521.7 7570.1 7685.8 7730.8 7920.9 7467.9 7484.0 7519.2 7551.7 7613.7 7053.6 7157.0 7159.1 7164.7 7164.9 5120.1 5384.9 5394.6 5472.8 5489.0 5359.8 5375.3 5427.9 5497.6 5501.2 08:51:29 INFO - PROCESS | 28259 | 08:51:29 INFO - PROCESS | 28259 | [#4] prototype.html Cycles:180 Average:4722.61 Median:5333.37 stddev:1355.82 (25.4%) stddev-sans-first:1318.87 08:51:29 INFO - PROCESS | 28259 | Values: 327.0 352.3 353.2 360.6 362.0 5417.5 5429.9 5436.0 5441.0 5444.7 5081.6 5173.5 5223.0 5260.0 5361.5 4222.8 4224.9 4232.6 4246.5 4258.5 4216.4 4233.8 4238.7 4243.5 4245.9 4108.3 4183.7 4192.4 4223.2 4223.2 4203.3 4206.9 4211.5 4215.6 4254.0 3766.5 3768.1 3794.9 3824.5 3842.2 5088.4 5259.4 5297.5 5299.8 5328.7 4854.5 4855.4 4863.4 4863.4 4883.1 5587.6 5588.8 5602.8 5607.6 5608.4 4108.8 4160.2 4180.5 4181.3 4183.4 5782.4 5800.8 5809.1 5809.4 5867.2 4289.9 4291.4 4292.4 4322.0 4328.8 4075.9 4298.2 4377.8 4382.4 4387.3 4816.0 4816.0 4831.2 4865.8 4872.9 5660.1 5691.3 5710.6 5732.0 5737.6 1398.9 1424.2 1425.4 1429.2 1437.3 979.7 1005.8 1006.4 1006.6 1016.3 5304.9 5325.4 5326.8 5338.1 5348.0 5597.3 5600.1 5612.4 5624.9 5690.1 5229.7 5291.6 5318.6 5323.5 5563.3 2942.6 2975.7 2986.6 3004.3 3006.9 5803.7 5812.4 5821.7 5829.3 5841.8 5459.3 5705.8 5720.5 5737.2 5738.5 5781.2 5801.8 5826.0 5835.9 5869.3 5343.6 5568.8 5573.9 5618.8 5631.0 5519.3 5526.6 5542.8 5552.6 5557.5 5789.8 5790.2 5790.5 5820.6 5834.5 3980.5 4067.4 4069.2 4086.8 4093.1 5528.5 5558.9 5605.9 5744.6 5749.7 5558.0 5589.7 5611.6 5641.0 5647.5 5489.6 5605.6 5606.5 5608.6 5628.0 5555.7 5577.8 5579.5 5581.2 5586.4 5592.7 5607.8 5641.3 5645.5 5687.4 5320.4 5463.3 5486.5 5515.6 5515.9 08:51:29 INFO - PROCESS | 28259 | 08:51:29 INFO - PROCESS | 28259 | [#5] yui.html Cycles:180 Average:16598.10 Median:4559.36 stddev:20989.47 (460.4%) stddev-sans-first:21014.66 08:51:29 INFO - PROCESS | 28259 | Values: 760.7 768.8 790.9 796.7 820.8 14090.9 14788.6 14829.2 14833.1 14861.2 14726.7 14907.6 14950.8 14958.9 14962.9 722.1 737.6 846.5 869.0 879.6 875.0 876.7 877.2 877.5 877.8 919.4 919.6 920.9 921.0 922.1 917.3 923.1 923.6 923.7 923.8 670.2 670.8 672.0 672.2 672.4 15020.8 15033.7 15103.7 15132.2 15341.9 14153.5 14481.9 14636.1 15003.2 15048.6 11023.7 11030.6 11103.7 11223.6 11245.3 3708.2 3751.8 3754.1 3804.2 3833.4 56475.4 57594.0 59043.7 63745.4 63912.7 10486.2 10713.8 10715.0 11368.4 11464.3 19707.6 19854.9 20095.4 20139.0 20176.7 7734.2 7975.8 8003.3 8063.3 8194.6 4472.5 4545.1 4573.7 4659.9 4694.6 3469.5 3570.6 3575.7 3578.9 3598.5 591.9 595.0 600.4 601.8 613.1 589.9 610.2 668.6 685.8 700.5 8180.4 8597.2 8702.7 8887.2 9074.4 571.4 591.6 646.2 648.4 660.0 4092.9 4209.0 4271.9 4299.8 4479.3 69531.0 70789.6 71935.3 81374.2 87267.6 45922.5 65562.0 68138.3 69399.0 70840.0 55618.0 64310.0 64454.7 64534.7 65733.7 8886.4 9169.4 9203.7 9268.6 9300.8 42232.4 42413.6 43613.8 43859.3 43892.8 54162.0 58790.7 58857.4 58924.7 60020.7 10875.9 11182.3 11318.6 11463.8 11514.4 12958.5 13594.5 13646.8 13696.5 14160.2 11958.3 12069.4 12421.9 12452.3 12464.0 13234.9 13285.7 13355.5 13478.0 13622.6 10094.8 10477.9 10685.5 12154.3 12163.9 9724.0 10326.8 10399.9 10473.9 10935.6 10305.6 10431.2 10569.5 10629.4 10859.3 08:51:29 INFO - PROCESS | 28259 | -------- Summary: end -------- 08:51:29 INFO - PROCESS | 28259 | 08:51:30 INFO - TEST-INFO | 28259: exit 0 08:51:30 INFO - TEST-OK | dromaeo_css | took 1114795ms 08:51:30 INFO - TEST-START | kraken 08:51:30 INFO - operating with platform_type : linux_ 08:51:30 INFO - Initialising browser for kraken test... 08:51:30 INFO - TEST-INFO | started process 28560 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8oSb8A/profile http://localhost:58914/getInfo.html) 08:51:34 INFO - PROCESS | 28560 | __metrics Screen width/height:1600/1200 08:51:34 INFO - PROCESS | 28560 | colorDepth:24 08:51:34 INFO - PROCESS | 28560 | Browser inner width/height: 1024/697 08:51:34 INFO - PROCESS | 28560 | __metrics 08:51:35 INFO - PROCESS | 28560 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:51:35 INFO - PROCESS | 28560 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:51:36 INFO - TEST-INFO | 28560: exit 0 08:51:36 INFO - Browser initialized. 08:51:36 INFO - Running cycle 1/1 for kraken test... 08:51:36 INFO - TEST-INFO | started process 28652 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8oSb8A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:51:48 INFO - PROCESS | 28652 | RSS: Main: 142336000 08:51:48 INFO - PROCESS | 28652 | 08:51:50 INFO - PROCESS | 28652 | Cycle 1(1): loaded http://localhost:58914/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58914/tests/kraken/driver.html?testName=audio-beat-detection) 08:51:51 INFO - PROCESS | 28652 | RSS: Main: 184475648 08:51:51 INFO - PROCESS | 28652 | 08:51:53 INFO - PROCESS | 28652 | Cycle 1(1): loaded http://localhost:58914/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58914/tests/kraken/driver.html?testName=audio-dft) 08:51:54 INFO - PROCESS | 28652 | RSS: Main: 173838336 08:51:54 INFO - PROCESS | 28652 | 08:51:57 INFO - PROCESS | 28652 | Cycle 1(1): loaded http://localhost:58914/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58914/tests/kraken/driver.html?testName=audio-fft) 08:51:57 INFO - PROCESS | 28652 | RSS: Main: 265224192 08:51:57 INFO - PROCESS | 28652 | 08:51:59 INFO - PROCESS | 28652 | Cycle 1(1): loaded http://localhost:58914/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58914/tests/kraken/driver.html?testName=audio-oscillator) 08:52:00 INFO - PROCESS | 28652 | RSS: Main: 171966464 08:52:00 INFO - PROCESS | 28652 | 08:52:02 INFO - PROCESS | 28652 | Cycle 1(1): loaded http://localhost:58914/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58914/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:52:03 INFO - PROCESS | 28652 | RSS: Main: 174125056 08:52:03 INFO - PROCESS | 28652 | 08:52:06 INFO - PROCESS | 28652 | Cycle 1(1): loaded http://localhost:58914/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58914/tests/kraken/driver.html?testName=imaging-darkroom) 08:52:06 INFO - PROCESS | 28652 | RSS: Main: 213037056 08:52:06 INFO - PROCESS | 28652 | 08:52:10 INFO - PROCESS | 28652 | Cycle 1(1): loaded http://localhost:58914/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58914/tests/kraken/driver.html?testName=imaging-desaturate) 08:52:10 INFO - PROCESS | 28652 | RSS: Main: 211779584 08:52:10 INFO - PROCESS | 28652 | 08:52:13 INFO - PROCESS | 28652 | Cycle 1(1): loaded http://localhost:58914/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58914/tests/kraken/driver.html?testName=json-parse-financial) 08:52:13 INFO - PROCESS | 28652 | RSS: Main: 210059264 08:52:13 INFO - PROCESS | 28652 | 08:52:15 INFO - PROCESS | 28652 | Cycle 1(1): loaded http://localhost:58914/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58914/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:52:16 INFO - PROCESS | 28652 | RSS: Main: 172322816 08:52:16 INFO - PROCESS | 28652 | 08:52:17 INFO - PROCESS | 28652 | Cycle 1(1): loaded http://localhost:58914/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58914/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:52:18 INFO - PROCESS | 28652 | RSS: Main: 179957760 08:52:18 INFO - PROCESS | 28652 | 08:52:20 INFO - PROCESS | 28652 | Cycle 1(1): loaded http://localhost:58914/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58914/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:52:20 INFO - PROCESS | 28652 | RSS: Main: 188735488 08:52:20 INFO - PROCESS | 28652 | 08:52:23 INFO - PROCESS | 28652 | Cycle 1(1): loaded http://localhost:58914/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58914/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:52:24 INFO - PROCESS | 28652 | RSS: Main: 197566464 08:52:24 INFO - PROCESS | 28652 | 08:52:26 INFO - PROCESS | 28652 | Cycle 1(1): loaded http://localhost:58914/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58914/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:52:27 INFO - PROCESS | 28652 | RSS: Main: 193798144 08:52:27 INFO - PROCESS | 28652 | 08:52:29 INFO - PROCESS | 28652 | Cycle 1(1): loaded http://localhost:58914/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58914/tests/kraken/driver.html?testName=ai-astar) 08:52:29 INFO - PROCESS | 28652 | RSS: Main: 245583872 08:52:29 INFO - PROCESS | 28652 | 08:52:29 INFO - PROCESS | 28652 | __start_tp_report 08:52:29 INFO - PROCESS | 28652 | _x_x_mozilla_page_load 08:52:29 INFO - PROCESS | 28652 | _x_x_mozilla_page_load_details 08:52:29 INFO - PROCESS | 28652 | |i|pagename|runs| 08:52:29 INFO - PROCESS | 28652 | |0;ai-astar;105;112;113;112;112;113;113;112;113;113 08:52:29 INFO - PROCESS | 28652 | |1;audio-beat-detection;144;119;121;154;118;118;117;120;150;117 08:52:29 INFO - PROCESS | 28652 | |2;audio-dft;161;162;160;160;159;162;160;161;160;160 08:52:29 INFO - PROCESS | 28652 | |3;audio-fft;73;75;75;103;76;77;76;77;96;75 08:52:29 INFO - PROCESS | 28652 | |4;audio-oscillator;83;82;125;84;82;84;102;84;82;121 08:52:29 INFO - PROCESS | 28652 | |5;imaging-gaussian-blur;117;118;117;116;117;116;117;117;116;117 08:52:29 INFO - PROCESS | 28652 | |6;imaging-darkroom;148;149;147;148;147;147;147;147;146;146 08:52:29 INFO - PROCESS | 28652 | |7;imaging-desaturate;85;84;84;85;84;84;84;85;84;85 08:52:29 INFO - PROCESS | 28652 | |8;json-parse-financial;52;52;52;52;52;53;51;52;52;52 08:52:29 INFO - PROCESS | 28652 | |9;json-stringify-tinderbox;59;58;58;61;59;59;59;59;60;59 08:52:29 INFO - PROCESS | 28652 | |10;stanford-crypto-aes;75;78;80;75;76;83;77;82;74;75 08:52:29 INFO - PROCESS | 28652 | |11;stanford-crypto-ccm;133;125;122;122;131;121;129;129;158;122 08:52:29 INFO - PROCESS | 28652 | |12;stanford-crypto-pbkdf2;160;162;156;157;160;159;155;156;159;158 08:52:29 INFO - PROCESS | 28652 | |13;stanford-crypto-sha256-iterative;63;65;63;61;64;61;65;63;62;63 08:52:29 INFO - PROCESS | 28652 | __end_tp_report 08:52:29 INFO - PROCESS | 28652 | __start_cc_report 08:52:29 INFO - PROCESS | 28652 | _x_x_mozilla_cycle_collect,1578 08:52:29 INFO - PROCESS | 28652 | __end_cc_report 08:52:29 INFO - PROCESS | 28652 | __startTimestamp1487350349328__endTimestamp 08:52:29 INFO - PROCESS | 28652 | 08:52:29 INFO - PROCESS | 28652 | ------- Summary: start ------- 08:52:29 INFO - PROCESS | 28652 | Number of tests: 14 08:52:29 INFO - PROCESS | 28652 | 08:52:29 INFO - PROCESS | 28652 | [#0] ai-astar Cycles:10 Average:111.80 Median:113.00 stddev:2.44 (2.2%) stddev-sans-first:0.53 08:52:29 INFO - PROCESS | 28652 | Values: 105.0 112.0 113.0 112.0 112.0 113.0 113.0 112.0 113.0 113.0 08:52:29 INFO - PROCESS | 28652 | 08:52:29 INFO - PROCESS | 28652 | [#1] audio-beat-detection Cycles:10 Average:127.80 Median:120.50 stddev:15.10 (12.5%) stddev-sans-first:14.83 08:52:29 INFO - PROCESS | 28652 | Values: 144.0 119.0 121.0 154.0 118.0 118.0 117.0 120.0 150.0 117.0 08:52:29 INFO - PROCESS | 28652 | 08:52:29 INFO - PROCESS | 28652 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:0.97 (0.6%) stddev-sans-first:1.01 08:52:29 INFO - PROCESS | 28652 | Values: 161.0 162.0 160.0 160.0 159.0 162.0 160.0 161.0 160.0 160.0 08:52:29 INFO - PROCESS | 28652 | 08:52:29 INFO - PROCESS | 28652 | [#3] audio-fft Cycles:10 Average:80.30 Median:76.00 stddev:10.32 (13.6%) stddev-sans-first:10.60 08:52:29 INFO - PROCESS | 28652 | Values: 73.0 75.0 75.0 103.0 76.0 77.0 76.0 77.0 96.0 75.0 08:52:29 INFO - PROCESS | 28652 | 08:52:29 INFO - PROCESS | 28652 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:82.50 stddev:16.98 (20.6%) stddev-sans-first:17.63 08:52:29 INFO - PROCESS | 28652 | Values: 83.0 82.0 125.0 84.0 82.0 84.0 102.0 84.0 82.0 121.0 08:52:29 INFO - PROCESS | 28652 | 08:52:29 INFO - PROCESS | 28652 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 08:52:29 INFO - PROCESS | 28652 | Values: 117.0 118.0 117.0 116.0 117.0 116.0 117.0 117.0 116.0 117.0 08:52:29 INFO - PROCESS | 28652 | 08:52:29 INFO - PROCESS | 28652 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 08:52:29 INFO - PROCESS | 28652 | Values: 148.0 149.0 147.0 148.0 147.0 147.0 147.0 147.0 146.0 146.0 08:52:29 INFO - PROCESS | 28652 | 08:52:29 INFO - PROCESS | 28652 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.50 08:52:29 INFO - PROCESS | 28652 | Values: 85.0 84.0 84.0 85.0 84.0 84.0 84.0 85.0 84.0 85.0 08:52:29 INFO - PROCESS | 28652 | 08:52:29 INFO - PROCESS | 28652 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.00 stddev:0.47 (0.9%) stddev-sans-first:0.50 08:52:29 INFO - PROCESS | 28652 | Values: 52.0 52.0 52.0 52.0 52.0 53.0 51.0 52.0 52.0 52.0 08:52:29 INFO - PROCESS | 28652 | 08:52:29 INFO - PROCESS | 28652 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:0.88 (1.5%) stddev-sans-first:0.93 08:52:29 INFO - PROCESS | 28652 | Values: 59.0 58.0 58.0 61.0 59.0 59.0 59.0 59.0 60.0 59.0 08:52:29 INFO - PROCESS | 28652 | 08:52:29 INFO - PROCESS | 28652 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:77.50 stddev:3.17 (4.1%) stddev-sans-first:3.23 08:52:29 INFO - PROCESS | 28652 | Values: 75.0 78.0 80.0 75.0 76.0 83.0 77.0 82.0 74.0 75.0 08:52:29 INFO - PROCESS | 28652 | 08:52:29 INFO - PROCESS | 28652 | [#11] stanford-crypto-ccm Cycles:10 Average:129.20 Median:129.00 stddev:10.99 (8.5%) stddev-sans-first:11.57 08:52:29 INFO - PROCESS | 28652 | Values: 133.0 125.0 122.0 122.0 131.0 121.0 129.0 129.0 158.0 122.0 08:52:29 INFO - PROCESS | 28652 | 08:52:29 INFO - PROCESS | 28652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.20 Median:159.00 stddev:2.20 (1.4%) stddev-sans-first:2.24 08:52:29 INFO - PROCESS | 28652 | Values: 160.0 162.0 156.0 157.0 160.0 159.0 155.0 156.0 159.0 158.0 08:52:29 INFO - PROCESS | 28652 | 08:52:29 INFO - PROCESS | 28652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.00 Median:63.00 stddev:1.41 (2.2%) stddev-sans-first:1.50 08:52:29 INFO - PROCESS | 28652 | Values: 63.0 65.0 63.0 61.0 64.0 61.0 65.0 63.0 62.0 63.0 08:52:29 INFO - PROCESS | 28652 | -------- Summary: end -------- 08:52:29 INFO - PROCESS | 28652 | 08:52:30 INFO - TEST-INFO | 28652: exit 0 08:52:30 INFO - TEST-OK | kraken | took 60034ms 08:52:30 INFO - SUITE-END | took 1174s 08:52:30 INFO - Completed test suite (00:19:34) 08:52:30 INFO - javascript benchmark 08:52:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3237.33634604906, 3262.4127657021736, 3266.967330326696, 3290.1939024938865, 3313.90058298251, 5520.66875987441, 5588.524975377093, 5613.214150019001, 5615.578831587637, 5623.662580245188, 5592.916106258409, 5636.0, 5638.746256418461, 5640.5487560995025, 5674.971625141879, 5052.671576347544, 5089.236614507817, 5119.206522988924, 5126.282320475137, 5166.328377310944, 4966.776495057731, 4986.351774269358, 5154.329937108189, 5181.818636347729, 5186.118359878811, 5023.824166154185, 5046.82336118236, 5075.238714192864, 5094.872628184306, 5107.591392688594, 5116.820911268106, 5141.280220769077, 5204.3234379530795, 5207.453217412193, 5228.712420816853, 4808.711477311337, 5090.0583392072585, 5113.667611605234, 5163.63854530183, 5179.948200517984, 5363.195520671891, 5386.326709161355, 5428.538574221196, 5438.619296649236, 5505.807296744595, 5935.643861368331, 5942.494887934531, 6037.818865434044, 6042.848928776772, 6044.032954727267, 5843.357230704619, 6071.089336599502, 6093.664848433335, 6095.542834287402, 6098.207233059718, 5503.229547863262, 5507.339119305669, 5515.696636685021, 5562.582806289504, 5569.0254205513875, 6031.366706495843, 6034.849128771728, 6036.245469316335, 6037.486813620892, 6040.214772079689, 5690.260266165372, 5788.88422231553, 5801.361850196475, 5803.593748437569, 5809.796657116981, 5812.825615231465, 5890.4698577128265, 5957.553183511254, 5957.76168953237, 6042.12389203563, 5971.462568368867, 5980.192673988956, 5980.491658209101, 5982.970085149546, 5986.191864098291, 5929.3181284152015, 5987.042073268343, 5989.041753319448, 5993.400659934059, 6013.639181649115, 4511.684182107221, 4540.636749060067, 4572.245579479415, 4581.335706322565, 4587.266037434061, 4073.287174744408, 4099.405586190045, 4104.651104656137, 4130.0294430808735, 4130.112025914443, 5679.914801277984, 5680.403557626472, 5697.515711164598, 5714.428557144335, 5741.110127930177, 5839.036558967808, 5863.2670916135485, 5894.204282421904, 5911.024680927685, 5958.225430693982, 5681.630694004876, 5704.771809127671, 5706.258186435737, 5711.628744131618, 5722.713864306768, 5083.161278389024, 5086.872828179251, 5094.643374963717, 5096.668716533413, 5120.769565369567, 5912.733926973297, 6049.213602231682, 6080.118382834553, 6185.474234690012, 6196.0705894115345, 5887.499562537232, 5970.880582388415, 5985.670788106696, 6002.909956350571, 6021.789237376671, 6153.107799369156, 6180.969095154495, 6182.814515564541, 6184.474319682878, 6201.3178550358525, 5683.9715801420725, 5705.771769129188, 5835.708214589169, 5835.766569337179, 5839.970800146142, 5932.0508718604815, 5938.524918006463, 5979.222701048836, 6019.578629495893, 6053.485453736482, 5762.510186634183, 5785.39253378406, 5851.882962340645, 5869.002269614261, 5872.119182122716, 5593.944060559343, 5768.884622307614, 5773.509251713652, 5783.074708046693, 5789.073748200436, 5526.778928842962, 5733.455321744427, 5761.5102716269585, 5785.3636100028125, 5793.536517078539, 5942.940570594412, 5953.91069133972, 5956.0, 5956.344802071682, 5966.970165149147, 5571.331440227199, 5603.859903502445, 5652.85867853307, 5792.4497172768515, 5809.50619197373], "value": 5497.020255881002, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.8431723434672, 603.1254680712966, 632.5034847644598, 660.6102399584247, 661.7584581627701, 32804.507932381006, 43270.78364608176, 43900.56099439005, 44097.338539921926, 46795.76602116993, 44669.10661786771, 44990.32514512277, 45150.09699806002, 45234.773826130826, 45270.32094518585, 8258.380621453414, 8925.285977121815, 9072.863907041366, 9078.319126065571, 9084.454932704059, 8158.347332213439, 8400.285975692073, 8402.495850248974, 10643.78712425755, 10883.945580272088, 11030.117590592734, 11091.33451992883, 11094.889051109507, 11096.611618593352, 11106.888931110667, 10788.892111078907, 10847.0, 10854.45727713615, 10856.728581785439, 10879.83680244797, 10707.625233116803, 10768.78462430755, 10771.407572583505, 10776.946115269451, 10788.838167427495, 42706.57293427057, 42973.0, 43110.353344699855, 43127.0, 43145.13709725788, 3389.084947064279, 3573.6783689468075, 3658.634136586347, 3715.851365945386, 3872.9930218143204, 30337.848310758305, 30941.535876961865, 30979.535306970414, 31344.37311253762, 31702.0, 4098.672106231495, 4154.833806647761, 4172.833086676529, 4180.874573762792, 4260.786960651955, 333073.0, 335846.0, 339532.0, 339607.0, 339889.99999999756, 57556.71221643949, 57898.0, 57944.13083803746, 57997.71001144967, 58029.12956305659, 38537.614623853406, 39471.802640986614, 39518.82646454473, 42221.577784222376, 42250.788746056685, 17384.130793460277, 17492.825071749376, 17494.825051749573, 17506.299748009937, 17509.474715758548, 13512.0, 13545.729085418236, 13588.0, 13599.660008499866, 13620.863791362157, 17969.191386387643, 18279.36022239215, 18303.26786928508, 19229.4231173065, 19436.319728809423, 6823.351781580742, 7108.253633368526, 7141.929230246583, 7362.263773622595, 7367.852642947111, 970.7670159161751, 1020.2959957629361, 1055.8416237564427, 1064.377339256528, 1101.983470247947, 31806.0, 31916.0, 32117.0, 32540.186495337333, 32587.51118733221, 1115.2806439846254, 1159.675290918544, 1177.6879127031343, 1195.7907366211052, 1235.3576140407117, 17056.2324695389, 17315.307387704604, 17329.7400538992, 17402.21690023952, 17445.21496532659, 515835.0, 520384.0, 520885.0, 521499.0, 525402.0, 52075.218871716956, 53060.0, 56308.718456407456, 60132.39867601355, 60782.08826867512, 1400.95096671616, 1406.3249640172774, 1422.3528294625921, 1422.5447856685762, 1423.615623781594, 30283.394332113676, 32022.35955280928, 32444.51333229956, 32615.18462038468, 32960.1759956003, 51277.0, 51839.481605183464, 51842.48157518527, 51854.74072629613, 51858.74070629623, 402643.0, 423620.0, 426566.0, 427949.0, 434017.0, 29823.956161534243, 29897.252568685955, 29909.850450747606, 30104.09687709372, 30320.696793031788, 46893.29660055033, 47832.52167478281, 47856.282155766996, 48064.7596762028, 48316.0, 39341.6065839338, 39887.0, 40448.595514044486, 41558.1688366237, 41895.371569427094, 39449.80275098606, 39881.60118398779, 40032.39951400673, 41128.38307425451, 41286.0, 40369.0, 40898.79550602228, 41008.79495602503, 41012.179756405305, 41200.38199426951, 34008.0, 36208.456873146395, 36739.816300918326, 37425.43861842129, 37640.43539346857, 27410.177694669193, 28126.578101328087, 28128.29679258035, 28337.43325133527, 28363.290917726397], "value": 20346.683115128235, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.8562003298844, 413.6607981455208, 419.8551499732592, 420.94738157730285, 441.3203666353815, 18631.534211644717, 19566.804331956693, 19663.5084122897, 20031.599368012667, 20063.799362006393, 19256.22975080995, 19488.220471181172, 19723.21107155712, 19758.30845920393, 19779.901100494513, 5460.563154947605, 5762.4525670061485, 5791.768329266824, 5802.216700745387, 5804.2744656917885, 5682.715864206793, 5779.162021506879, 5803.50670193032, 5809.535237181015, 5812.796552120677, 6081.239845019372, 6109.572329936884, 6118.418750218744, 6121.0, 6121.449069583737, 6105.450509454148, 6113.296970848342, 6161.1066395372645, 6514.283428822826, 6559.540832141752, 5867.501262392701, 5867.941320586782, 5886.440788125121, 5886.9705651471895, 5891.05743081105, 17533.912330438394, 22181.0, 22444.32667019992, 22868.199613013632, 23050.308490745305, 2159.7408311002623, 2284.851484653492, 2408.9397765055837, 2683.2889284339667, 2741.8354898706143, 9721.319507634398, 10214.387136771817, 10321.43232122233, 10654.09440197584, 10694.839577406345, 1683.6127690631224, 1728.0495727349908, 1752.3253547384222, 1833.4591295567839, 1856.2482194711163, 74153.0, 76647.0, 78741.0, 79668.0, 81889.0, 10821.67534973952, 11292.0, 11490.712732181595, 11699.473523691455, 11821.349825759666, 16459.753103703453, 16511.752323715154, 16516.50450486487, 16528.25622846975, 16532.256048477608, 8420.452670576515, 8703.956480217685, 8706.47761134334, 8784.0, 8954.597043132944, 8422.789430264293, 8468.280196183394, 8534.402591818513, 8682.131786821268, 8749.431286966326, 4882.316475693406, 4998.775055122528, 5008.398992120896, 5113.463086375951, 5135.717535535581, 1947.6688962876344, 2038.86747361424, 2071.337172104942, 2077.418322869599, 2097.968530472044, 911.2618778789202, 986.6398764451068, 1022.2844009193594, 1028.2339656955467, 1037.3775734559356, 19062.0, 19126.2349506021, 19206.807931920503, 19268.518287042934, 19400.2239910402, 984.6209209454269, 1018.7707765752795, 1041.5833666533447, 1042.1142029275056, 1089.0525243038448, 9871.605135794487, 10652.786944261226, 10694.893051069545, 10747.301425407324, 10790.406527641055, 472497.0, 490199.0, 495244.0, 497765.0, 499715.0, 69948.0, 75312.0, 80513.0, 95402.52298738463, 99829.50085249527, 1029.161233594633, 1039.589362201926, 1074.55406006508, 1083.2363183955292, 1083.5557421457165, 16522.339106435607, 16743.832561674226, 17172.570685732957, 17355.913220433817, 17616.471505854846, 41117.1776564461, 41951.58048419477, 42408.93977650583, 42667.3599896008, 42741.78629106835, 59964.40035599588, 59966.0, 61212.693936530035, 61421.0, 61544.69227653833, 8442.577871106298, 8591.52746598918, 8709.346798990227, 8939.865902011345, 8982.461052336881, 11824.82262766042, 11984.221025633306, 12286.754264914473, 13317.134386264861, 13821.654458638212, 10833.29583577065, 10950.835737463785, 11127.276727012719, 11212.43937803123, 11347.886521134684, 11110.50002749862, 11404.543818247177, 11494.080473562262, 11689.532418703157, 11742.412879356169, 10866.13070954306, 11177.608783692533, 11309.830352544883, 11842.348670823187, 12088.274703517465, 8712.520811355183, 8910.287177025952, 8935.553222338987, 8944.910550894409, 9036.051214622634, 8764.868526971974, 11534.480948357512, 11744.29534227949, 11866.584669536525, 12233.3271670059], "value": 9343.920141642508, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1490.225082956862, 1518.53684626189, 1635.133379308966, 1711.161530849884, 1777.4934143769028, 8376.95811520943, 8977.192052715254, 8988.101189881008, 8993.145651163137, 8996.505192214425, 7420.183779784233, 7680.692772289116, 8393.496390216591, 8623.741287761362, 8631.611577479012, 2404.3388068281233, 2430.307362401716, 2433.8661373624445, 2437.122635851092, 2440.7559244075537, 2398.304491697406, 2448.608222684371, 2466.0998735461517, 2466.124525793344, 2466.469709012562, 2430.149447693302, 2451.0195921631403, 2451.889664965072, 2470.938226544333, 2496.5256601245796, 2407.3620490570015, 2424.163663536086, 2436.817238707104, 2443.511297740441, 2447.730749617541, 2409.3133456964856, 2434.525267572806, 2458.8524688518746, 2459.397447625325, 2460.3603063203695, 8847.823043539092, 8916.598753056129, 8930.955345223298, 8937.821243575092, 8938.329625278131, 5339.70631615261, 5481.177823326493, 5491.28613280275, 5492.47821456961, 5497.422770609109, 3482.146874015857, 3490.3542844573835, 3509.94735078974, 3559.8220088995445, 3679.5400574928135, 1169.5555688838272, 1171.0748508678134, 1202.8436303280605, 1209.6371088673363, 1221.6457227404042, 11722.0, 11728.472218750177, 11740.295582265177, 11751.764964700658, 11754.118441116865, 4643.535646435397, 4668.416447944007, 4819.927701084486, 4832.299316599074, 4998.625103117281, 10427.322224055411, 10430.061294483532, 10436.060754532129, 10439.843402348972, 10444.164466842634, 5442.945570544323, 5460.0, 5475.917861232085, 5477.643953143033, 5483.725813709299, 4292.763897985641, 4420.425344705232, 4859.586935110555, 4921.335619691367, 5061.44324124346, 4119.701189055372, 4121.0, 4159.5879046039145, 4193.811278492475, 4198.307279298942, 1304.712963148106, 1358.8844948179317, 1359.5717349035021, 1363.2842757552364, 1369.2537567025995, 850.3282406898604, 872.8123453457537, 873.5894129759004, 890.7550423633553, 893.1470445724318, 5837.153612726216, 5954.642721436728, 6012.579119461596, 6187.412195841388, 6514.022896565553, 941.9858702119474, 947.346331031586, 953.8473844184897, 966.4346357381011, 982.4596471940404, 4300.827966881289, 4303.655707543389, 4348.130373925228, 4374.715643483163, 4436.44544431946, 10475.895241047645, 10492.842607360895, 10648.467576621139, 10677.519511621995, 10691.572337106429, 10509.632162874263, 10511.159107271553, 10559.947200263949, 10567.63013294531, 10605.0, 7902.920970790218, 8010.118886922434, 8168.469049511644, 8181.427300088937, 8221.917780822236, 5914.58597898143, 5998.0, 6091.086337049478, 6128.111423843607, 6175.104609831639, 10005.649802256887, 10112.696619101438, 10119.392836429543, 10119.645812396826, 10162.745931351776, 10050.145737612385, 10377.896221037692, 10389.220808439548, 10414.479276036016, 10459.110975566859, 6972.546784458994, 7225.530340527849, 7574.962125189339, 7886.566238856918, 8075.152109028468, 8284.875726864222, 8653.091425400242, 8654.177853103945, 8669.21977022071, 8672.479651220947, 7521.661525231269, 7570.129435114812, 7685.769426917202, 7730.806729831799, 7920.920790792018, 7467.850642987001, 7483.962580187064, 7519.172890982097, 7551.660175292235, 7613.695452181851, 7053.612051337226, 7157.033800436874, 7159.069320988238, 7164.677589508589, 7164.89252661221, 5120.103981803244, 5384.946150538444, 5394.568434525307, 5472.808451704172, 5489.039418101736, 5359.785608575613, 5375.274337964324, 5427.945720542902, 5497.642653227527, 5501.202325662836], "value": 4717.55321731076, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.9705726484617, 352.3252970561375, 353.19471604741193, 360.63575788453653, 362.04420330327923, 5417.539509141723, 5429.945700542993, 5435.9728201358985, 5440.972795136028, 5444.673319600826, 5081.644284900059, 5173.5085166909175, 5223.0, 5260.0, 5361.490658387456, 4222.78886055696, 4224.8732538023905, 4232.555581663927, 4246.4691913510815, 4258.467691538558, 4216.409702641633, 4233.809478573472, 4238.682098842583, 4243.511996120439, 4245.915081698364, 4108.26051310764, 4183.707140500166, 4192.392103145042, 4223.197592457439, 4223.197592457439, 4203.327467605184, 4206.894827629303, 4211.515675697304, 4215.6205941465105, 4253.957460425387, 3766.5291838520184, 3768.1333293342686, 3794.924101517982, 3824.521934758155, 3842.1931394407206, 5088.440271570124, 5259.3951695555115, 5297.516695325315, 5299.788008479656, 5328.653637513588, 4854.466008739036, 4855.36880205571, 4863.416390033183, 4863.416390033219, 4883.072216278932, 5587.580931430119, 5588.758520058356, 5602.831915042555, 5607.57943154261, 5608.383077861432, 4108.815103320358, 4160.1679664067005, 4180.519240287345, 4181.26827805136, 4183.435236243099, 5782.421757824184, 5800.825975220708, 5809.091317836422, 5809.390014048548, 5867.207926929853, 4289.863186255645, 4291.399204111427, 4292.420523229386, 4321.956780432155, 4328.783560821947, 4075.89810254746, 4298.183345164409, 4377.802998864995, 4382.408374869416, 4387.27609944362, 4815.951840481621, 4816.036792641486, 4831.154547954094, 4865.8053677853195, 4872.853814385574, 5660.094384898479, 5691.26013618227, 5710.571707121982, 5732.0, 5737.569682273846, 1398.8880889528814, 1424.2095636921608, 1425.3799597175262, 1429.2496439369415, 1437.3172742947227, 979.6962941488162, 1005.8440941653909, 1006.4414250091123, 1006.6325791086201, 1016.3241444439365, 5304.939012197576, 5325.405351387875, 5326.760295786699, 5338.092524270884, 5347.973260133675, 5597.272354593877, 5600.103983362643, 5612.438756124437, 5624.887502250014, 5690.118031705092, 5229.692576855786, 5291.618771552817, 5318.601104917147, 5323.467653234646, 5563.304586926634, 2942.5880376747273, 2975.6577993530586, 2986.6266716660416, 3004.3240270938863, 3006.909792706222, 5803.65178089316, 5812.360640329561, 5821.679807610622, 5829.271341082364, 5841.795537156179, 5459.2902922619805, 5705.771769129188, 5720.48515633595, 5737.225474560881, 5738.540916726652, 5781.219535362757, 5801.825945221734, 5826.0, 5835.912461313083, 5869.266341707286, 5343.572514198932, 5568.832935011957, 5573.888522229614, 5618.775248990158, 5630.971845140748, 5519.254900588369, 5526.613137080366, 5542.836004439113, 5552.583556233218, 5557.527610153183, 5789.842031593614, 5790.247267855152, 5790.478856902899, 5820.621659592282, 5834.541364658835, 3980.4626375440102, 4067.3695577185586, 4069.2065047316673, 4086.795660216918, 4093.099518106012, 5528.474794894479, 5558.888822223452, 5605.878824235251, 5744.626599271034, 5749.655020698771, 5557.971340460784, 5589.664620122806, 5611.551075913835, 5641.0, 5647.5199608032135, 5489.615726899079, 5605.635633683797, 5606.495415412633, 5608.551315894801, 5628.0, 5555.722213889208, 5577.8047768327915, 5579.4978451937895, 5581.218629391969, 5586.413426590312, 5592.748326325243, 5607.831765047055, 5641.294838145232, 5645.491905728504, 5687.402822703557, 5320.361556613231, 5463.262459567907, 5486.506214440719, 5515.61390702647, 5515.869246804476], "value": 4295.352224745949, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [760.733743189884, 768.8385439057797, 790.8813677948303, 796.6773456750017, 820.7619790260823, 14090.859091409084, 14788.6302842429, 14829.184394858292, 14833.110013399204, 14861.182634955074, 14726.705465890676, 14907.627309317273, 14950.775738363933, 14958.850411495881, 14962.925185374084, 722.12622726501, 737.5943231222806, 846.4878748357247, 869.0266901070778, 879.634951495132, 874.9693760718376, 876.7369789063288, 877.188600544497, 877.5392918717661, 877.7981064355203, 919.4161707315869, 919.5953780336664, 920.8848893888264, 920.9815803683956, 922.1193759959257, 917.3303488453433, 923.0630909626734, 923.5843870258343, 923.6536298887917, 923.8290916180528, 670.1656437735003, 670.792054463118, 671.9865602687919, 672.1765836849869, 672.4317951331118, 15020.774688379683, 15033.699326013528, 15103.697926041528, 15132.167730774803, 15341.92329038359, 14153.504627337994, 14481.855181448156, 14636.121832690073, 15003.1748253846, 15048.623784405478, 11023.724406889813, 11030.558777648885, 11103.72240693981, 11223.60717374888, 11245.269057511236, 3708.2212735325616, 3751.8311675974373, 3754.080250338657, 3804.2201348723447, 3833.4441505981754, 56475.43524564743, 57594.0, 59043.70478147625, 63745.36254637487, 63912.680436597984, 10486.213533984981, 10713.83929241062, 10714.980714631352, 11368.374739389248, 11464.31214127155, 19707.605847882962, 19854.90072549628, 20095.397138085882, 20139.0, 20176.69734953977, 7734.2265773422205, 7975.8404831903035, 8003.319717823933, 8063.314618257514, 8194.631241594023, 4472.485664148665, 4545.068261006486, 4573.6569757268335, 4659.930101048487, 4694.554017368345, 3469.4795780632603, 3570.625084366156, 3575.66031227033, 3578.8568457261417, 3598.460230965376, 591.9467247947705, 594.9851253718691, 600.3966014155833, 601.8104297146385, 613.0650757594703, 589.8584339758427, 610.2158726037021, 668.6289109544152, 685.8011176758783, 700.4501466348994, 8180.386471014579, 8597.192488684606, 8702.695405660772, 8887.244584210286, 9074.410163339362, 571.4399888109676, 591.5947575910429, 646.1825790375179, 648.4002297874541, 659.9538032337787, 4092.9181416371507, 4208.978955105266, 4271.893202669896, 4299.78501074945, 4479.3057076153245, 69531.0, 70789.64605177044, 71935.28064719286, 81374.18625813666, 87267.56366218129, 45922.54077459183, 65562.0, 68138.31861681418, 69399.0, 70840.0, 55618.0, 64310.0, 64454.677726612004, 64534.67732661401, 65733.67133164399, 8886.422382545114, 9169.35814492979, 9203.723888283363, 9268.629254829732, 9300.767480813034, 42232.36651450292, 42413.57586424219, 43613.78193109014, 43859.34210986774, 43892.78053609839, 54162.0, 58790.706046469495, 58857.41142588691, 58924.70537647456, 60020.699896500235, 10875.891241087487, 11182.32906025641, 11318.60384886525, 11463.828042579202, 11514.366709830705, 12958.53130674885, 13594.524191653245, 13646.795298070736, 13696.52062177819, 14160.150390976574, 11958.342291174069, 12069.39653017328, 12421.875781242434, 12452.252864828139, 12464.0, 13234.867651323364, 13285.66785830362, 13355.53255636048, 13478.0, 13622.591322260349, 10094.8485772712, 10477.947610262205, 10685.465726713788, 12154.331511766584, 12163.939180304396, 9724.0, 10326.845097323396, 10399.896001040195, 10473.9476302618, 10935.56257749681, 10305.587776488857, 10431.16550675929, 10569.524371403151, 10629.36223826542, 10859.34843909368], "value": 6964.8404995046185, "unit": "score"}], "name": "dromaeo_css", "value": 7268.923813155173, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 113.0, 112.0, 112.0, 113.0, 113.0, 112.0, 113.0, 113.0], "value": 111.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 119.0, 121.0, 154.0, 118.0, 118.0, 117.0, 120.0, 150.0, 117.0], "value": 127.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 160.0, 159.0, 162.0, 160.0, 161.0, 160.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 75.0, 103.0, 76.0, 77.0, 76.0, 77.0, 96.0, 75.0], "value": 80.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 125.0, 84.0, 82.0, 84.0, 102.0, 84.0, 82.0, 121.0], "value": 92.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 147.0, 148.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 85.0, 84.0, 84.0, 84.0, 85.0, 84.0, 85.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 52.0, 52.0, 53.0, 51.0, 52.0, 52.0, 52.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 58.0, 61.0, 59.0, 59.0, 59.0, 59.0, 60.0, 59.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 80.0, 75.0, 76.0, 83.0, 77.0, 82.0, 74.0, 75.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 125.0, 122.0, 122.0, 131.0, 121.0, 129.0, 129.0, 158.0, 122.0], "value": 129.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 156.0, 157.0, 160.0, 159.0, 155.0, 156.0, 159.0, 158.0], "value": 158.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 65.0, 63.0, 61.0, 64.0, 61.0, 65.0, 63.0, 62.0, 63.0], "value": 63.0, "unit": "score"}], "name": "kraken", "value": 1460.7, "alertThreshold": 2.0}]} 08:52:30 INFO - Return code: 0 08:52:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:52:30 INFO - # TBPL SUCCESS # 08:52:30 INFO - Running post-action listener: _resource_record_post_action 08:52:30 INFO - [mozharness: 2017-02-17 16:52:30.654279Z] Finished run-tests step (success) 08:52:30 INFO - Running post-run listener: _resource_record_post_run 08:52:30 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 322068480; Read time: 12; Write time: 157432 08:52:30 INFO - TinderboxPrint: CPU usage
13.0% 08:52:30 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:52:30 INFO - TinderboxPrint: I/O write bytes / time
322,068,480 / 157,432 08:52:30 INFO - TinderboxPrint: CPU idle
8,258.4 (87.0%) 08:52:30 INFO - TinderboxPrint: CPU user
1,191.0 (12.5%) 08:52:30 INFO - TinderboxPrint: Swap in / out
0 / 0 08:52:30 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 101076992; Read time: 0; Write time: 51732 08:52:30 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 4096; Write bytes: 220991488; Read time: 12; Write time: 105700 08:52:31 INFO - Running post-run listener: _upload_blobber_files 08:52:31 INFO - Blob upload gear active. 08:52:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:52:31 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:52:31 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:52:31 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:52:31 INFO - (blobuploader) - INFO - Open directory for files ... 08:52:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:52:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:52:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:52:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:52:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:52:32 INFO - (blobuploader) - INFO - Done attempting. 08:52:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:52:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:52:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:52:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:52:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:52:33 INFO - (blobuploader) - INFO - Done attempting. 08:52:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:52:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:52:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:52:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:52:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:52:36 INFO - (blobuploader) - INFO - Done attempting. 08:52:36 INFO - (blobuploader) - INFO - Iteration through files over. 08:52:36 INFO - Return code: 0 08:52:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:52:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:52:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9a370c2e81fb1e5f79f64f75224e00a7d3ed2b627f3c3db4c4033dc11561e9ae1e0552fbdb7b2eccba0bca2bd3b83dfae1ca2b0e29f7da19e622d97f9ebbbc5e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4fce6aa6601ce61fd94dc2d798f92968d6238519e8c20db0b4c1b8884c83f44ddd2944aa4fd3113851f29c5f08cdf0fb9d3b729e19adbef40bb1f6a123892040", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2c2e990c2de4aa1ea3de9556a0869a1dfdc8aba3f33f7a5c1a954f3e149207eecbd1c74a7d5a18727581353d708e700bd5a9c6a240a99cfb6265d8175de1ae15"} 08:52:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:52:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:52:36 INFO - Contents: 08:52:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9a370c2e81fb1e5f79f64f75224e00a7d3ed2b627f3c3db4c4033dc11561e9ae1e0552fbdb7b2eccba0bca2bd3b83dfae1ca2b0e29f7da19e622d97f9ebbbc5e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4fce6aa6601ce61fd94dc2d798f92968d6238519e8c20db0b4c1b8884c83f44ddd2944aa4fd3113851f29c5f08cdf0fb9d3b729e19adbef40bb1f6a123892040", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2c2e990c2de4aa1ea3de9556a0869a1dfdc8aba3f33f7a5c1a954f3e149207eecbd1c74a7d5a18727581353d708e700bd5a9c6a240a99cfb6265d8175de1ae15"} 08:52:36 INFO - Running post-run listener: copy_logs_to_upload_dir 08:52:36 INFO - Copying logs to upload dir... 08:52:36 INFO - mkdir: /builds/slave/test/build/upload/logs 08:52:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.666621 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2017-02-17 08:52:36.220318) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-17 08:52:36.223894) ========= 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=337fe3f4b1febe37b85fccc40000019e-1487349121.824119-1307638427 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-Beta/sha512/9a370c2e81fb1e5f79f64f75224e00a7d3ed2b627f3c3db4c4033dc11561e9ae1e0552fbdb7b2eccba0bca2bd3b83dfae1ca2b0e29f7da19e622d97f9ebbbc5e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4fce6aa6601ce61fd94dc2d798f92968d6238519e8c20db0b4c1b8884c83f44ddd2944aa4fd3113851f29c5f08cdf0fb9d3b729e19adbef40bb1f6a123892040", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2c2e990c2de4aa1ea3de9556a0869a1dfdc8aba3f33f7a5c1a954f3e149207eecbd1c74a7d5a18727581353d708e700bd5a9c6a240a99cfb6265d8175de1ae15"} build_url:https://queue.taskcluster.net/v1/task/YyieLW-SSoWBSIHpSKNHDQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011323 build_url: 'https://queue.taskcluster.net/v1/task/YyieLW-SSoWBSIHpSKNHDQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9a370c2e81fb1e5f79f64f75224e00a7d3ed2b627f3c3db4c4033dc11561e9ae1e0552fbdb7b2eccba0bca2bd3b83dfae1ca2b0e29f7da19e622d97f9ebbbc5e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4fce6aa6601ce61fd94dc2d798f92968d6238519e8c20db0b4c1b8884c83f44ddd2944aa4fd3113851f29c5f08cdf0fb9d3b729e19adbef40bb1f6a123892040", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2c2e990c2de4aa1ea3de9556a0869a1dfdc8aba3f33f7a5c1a954f3e149207eecbd1c74a7d5a18727581353d708e700bd5a9c6a240a99cfb6265d8175de1ae15"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-17 08:52:36.248204) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 08:52:36.248523) ========= 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=337fe3f4b1febe37b85fccc40000019e-1487349121.824119-1307638427 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 08:52:36.331173) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-17 08:52:36.331504) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-17 08:52:36.331826) ========= ========= Total master_lag: 0.17 =========