builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-018 starttime: 1483419719.1 results: success (0) buildid: 20170102192820 builduid: 7e387bb9f62d44839255dcfec281dcce revision: a6f6cf4180980a74083cc03f611cc510eb15b5cc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-02 21:01:59.102600) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-02 21:01:59.103074) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-02 21:01:59.103364) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-02 21:01:59.122706) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 21:01:59.122975) ========= 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=62c568580acbfdaac3eec7be000001dc-1483419373.866878-194076106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-02 21:02:00-- 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% 222M=0s 2017-01-02 21:02:00 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.090425 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 21:01:59.227164) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 21:01:59.227503) ========= 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=62c568580acbfdaac3eec7be000001dc-1483419373.866878-194076106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019141 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 21:01:59.277220) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 21:01:59.277597) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a6f6cf4180980a74083cc03f611cc510eb15b5cc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a6f6cf4180980a74083cc03f611cc510eb15b5cc --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=62c568580acbfdaac3eec7be000001dc-1483419373.866878-194076106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-02 21:02:00,645 truncating revision to first 12 chars 2017-01-02 21:02:00,645 Setting DEBUG logging. 2017-01-02 21:02:00,645 attempt 1/10 2017-01-02 21:02:00,645 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a6f6cf418098?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-02 21:02:00,940 unpacking tar archive at: mozilla-aurora-a6f6cf418098/testing/mozharness/ program finished with exit code 0 elapsedTime=0.602180 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 21:01:59.895294) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-02 21:01:59.895661) ========= script_repo_revision: a6f6cf4180980a74083cc03f611cc510eb15b5cc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-02 21:01:59.896095) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-02 21:01:59.896371) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-02 21:01:59.907163) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-02 21:01:59.907570) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1483419373.866878-194076106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:02:01 INFO - MultiFileLogger online at 20170102 21:02:01 in /builds/slave/test 21:02:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 21:02:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:02:01 INFO - {'append_to_log': False, 21:02:01 INFO - 'base_work_dir': '/builds/slave/test', 21:02:01 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 21:02:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:02:01 INFO - 'branch': 'Mozilla-Aurora', 21:02:01 INFO - 'buildbot_json_path': 'buildprops.json', 21:02:01 INFO - 'config_files': ('talos/linux_config.py',), 21:02:01 INFO - 'default_actions': ('clobber', 21:02:01 INFO - 'read-buildbot-config', 21:02:01 INFO - 'download-and-extract', 21:02:01 INFO - 'populate-webroot', 21:02:01 INFO - 'create-virtualenv', 21:02:01 INFO - 'install', 21:02:01 INFO - 'run-tests'), 21:02:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:02:01 INFO - 'download_minidump_stackwalk': True, 21:02:01 INFO - 'download_symbols': 'ondemand', 21:02:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:02:01 INFO - 'tooltool.py': '/tools/tooltool.py', 21:02:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:02:01 INFO - '/tools/misc-python/virtualenv.py')}, 21:02:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:02:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:02:01 INFO - 'installer_path': 'installer.exe', 21:02:01 INFO - 'log_level': 'info', 21:02:01 INFO - 'log_name': 'talos', 21:02:01 INFO - 'log_to_console': True, 21:02:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:02:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:02:01 INFO - 'opt_config_files': (), 21:02:01 INFO - 'pip_index': False, 21:02:01 INFO - 'sps_profile': False, 21:02:01 INFO - 'sps_profile_interval': 0, 21:02:01 INFO - 'suite': 'dromaeojs-e10s', 21:02:01 INFO - 'system_bits': '32', 21:02:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:02:01 INFO - 'title': 'talos-linux64-ix-018', 21:02:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:02:01 INFO - 'use_talos_json': True, 21:02:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:02:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:02:01 INFO - 'work_dir': 'build'} 21:02:01 INFO - [mozharness: 2017-01-03 05:02:01.369217Z] Running clobber step. 21:02:01 INFO - Running pre-action listener: _resource_record_pre_action 21:02:01 INFO - Running main action method: clobber 21:02:01 INFO - rmtree: /builds/slave/test/build 21:02:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:02:02 INFO - Running post-action listener: _resource_record_post_action 21:02:02 INFO - [mozharness: 2017-01-03 05:02:02.347048Z] Finished clobber step (success) 21:02:02 INFO - [mozharness: 2017-01-03 05:02:02.347146Z] Running read-buildbot-config step. 21:02:02 INFO - Running pre-action listener: _resource_record_pre_action 21:02:02 INFO - Running main action method: read_buildbot_config 21:02:02 INFO - Using buildbot properties: 21:02:02 INFO - { 21:02:02 INFO - "project": "", 21:02:02 INFO - "product": "firefox", 21:02:02 INFO - "script_repo_revision": "production", 21:02:02 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 21:02:02 INFO - "repository": "", 21:02:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 21:02:02 INFO - "buildid": "20170102192820", 21:02:02 INFO - "pgo_build": "True", 21:02:02 INFO - "basedir": "/builds/slave/test", 21:02:02 INFO - "buildnumber": 746, 21:02:02 INFO - "slavename": "talos-linux64-ix-018", 21:02:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 21:02:02 INFO - "platform": "ubuntu64_hw", 21:02:02 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 21:02:02 INFO - "branch": "mozilla-aurora", 21:02:02 INFO - "repo_path": "releases/mozilla-aurora", 21:02:02 INFO - "revision": "a6f6cf4180980a74083cc03f611cc510eb15b5cc", 21:02:02 INFO - "stage_platform": "linux64-pgo", 21:02:02 INFO - "builduid": "7e387bb9f62d44839255dcfec281dcce", 21:02:02 INFO - "slavebuilddir": "test" 21:02:02 INFO - } 21:02:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/SuOHcJzuRCqa-72hkgWxhA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 21:02:02 INFO - Running post-action listener: _resource_record_post_action 21:02:02 INFO - [mozharness: 2017-01-03 05:02:02.349541Z] Finished read-buildbot-config step (success) 21:02:02 INFO - [mozharness: 2017-01-03 05:02:02.349627Z] Running download-and-extract step. 21:02:02 INFO - Running pre-action listener: _resource_record_pre_action 21:02:02 INFO - Running main action method: download_and_extract 21:02:02 INFO - mkdir: /builds/slave/test/build/tests 21:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:02 INFO - trying https://queue.taskcluster.net/v1/task/SuOHcJzuRCqa-72hkgWxhA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 21:02:02 INFO - Downloading https://queue.taskcluster.net/v1/task/SuOHcJzuRCqa-72hkgWxhA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 21:02:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SuOHcJzuRCqa-72hkgWxhA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:02:02 INFO - Downloaded 1361 bytes. 21:02:02 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 21:02:02 INFO - Using the following test package requirements: 21:02:02 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 21:02:02 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 21:02:02 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 21:02:02 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 21:02:02 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 21:02:02 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 21:02:02 INFO - u'jsshell-linux-x86_64.zip'], 21:02:02 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 21:02:02 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 21:02:02 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 21:02:02 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 21:02:02 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 21:02:02 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 21:02:02 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 21:02:02 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 21:02:02 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 21:02:02 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 21:02:02 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 21:02:02 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:02:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SuOHcJzuRCqa-72hkgWxhA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 21:02:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SuOHcJzuRCqa-72hkgWxhA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:02:02 INFO - Fetch https://queue.taskcluster.net/v1/task/SuOHcJzuRCqa-72hkgWxhA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 21:02:03 INFO - Http code: 200 21:02:03 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 21:02:03 INFO - x-amz-cf-id: 7OG7lX9EgXnsKT1RCK5XqQGrbV-VW4vHbn4xiK--0jyvx76-TekAjQ== 21:02:03 INFO - x-amz-version-id: UrEu94KO..p.UUDMGoGRldSr2JmdxkWc 21:02:03 INFO - Expected file size: 21940846 21:02:03 INFO - Obtained file size: 21940846 21:02:07 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:02:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SuOHcJzuRCqa-72hkgWxhA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 21:02:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SuOHcJzuRCqa-72hkgWxhA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:02:07 INFO - Fetch https://queue.taskcluster.net/v1/task/SuOHcJzuRCqa-72hkgWxhA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 21:02:08 INFO - Http code: 200 21:02:08 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 21:02:08 INFO - x-amz-cf-id: QMbCF1x2b7wM5eznCM6FkINTCcESDLQ8TASyr_L0WAc-SOUqZH2lqQ== 21:02:08 INFO - x-amz-version-id: UrEu94KO..p.UUDMGoGRldSr2JmdxkWc 21:02:08 INFO - Expected file size: 21940846 21:02:08 INFO - Obtained file size: 21940846 21:02:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SuOHcJzuRCqa-72hkgWxhA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 21:02:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SuOHcJzuRCqa-72hkgWxhA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:02:13 INFO - Fetch https://queue.taskcluster.net/v1/task/SuOHcJzuRCqa-72hkgWxhA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 21:02:13 INFO - Http code: 200 21:02:13 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 21:02:13 INFO - x-amz-cf-id: d3n4aKNoYB3RN46DuKUBDrDjzexWI235zMX0vLGShPfcgsxARd8ABw== 21:02:13 INFO - x-amz-version-id: 41RGwOOExO8wg0ZXMuC.MWAv9zY9Whgn 21:02:13 INFO - Expected file size: 14409038 21:02:13 INFO - Obtained file size: 14409038 21:02:13 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')]} 21:02:13 INFO - trying https://queue.taskcluster.net/v1/task/SuOHcJzuRCqa-72hkgWxhA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 21:02:13 INFO - Downloading https://queue.taskcluster.net/v1/task/SuOHcJzuRCqa-72hkgWxhA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 21:02:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SuOHcJzuRCqa-72hkgWxhA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:02:15 INFO - Downloaded 64017783 bytes. 21:02:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SuOHcJzuRCqa-72hkgWxhA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 21:02:15 INFO - mkdir: /builds/slave/test/properties 21:02:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:02:15 INFO - Writing to file /builds/slave/test/properties/build_url 21:02:15 INFO - Contents: 21:02:15 INFO - build_url:https://queue.taskcluster.net/v1/task/SuOHcJzuRCqa-72hkgWxhA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 21:02:15 INFO - Running post-action listener: _resource_record_post_action 21:02:15 INFO - Running post-action listener: set_extra_try_arguments 21:02:15 INFO - [mozharness: 2017-01-03 05:02:15.838393Z] Finished download-and-extract step (success) 21:02:15 INFO - [mozharness: 2017-01-03 05:02:15.838623Z] Running populate-webroot step. 21:02:15 INFO - Running pre-action listener: _resource_record_pre_action 21:02:15 INFO - Running main action method: populate_webroot 21:02:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:02:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:02:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:02:15 INFO - '--tppagecycles', 21:02:15 INFO - '7'], 21:02:15 INFO - 'tests': ['tsvgm']}}, 21:02:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:02:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:02:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:02:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:02:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:02:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:02:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:15 INFO - 'talos_options': ['--disable-e10s'], 21:02:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:02:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:02:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:15 INFO - 'talos_options': ['--disable-e10s'], 21:02:15 INFO - 'tests': ['damp', 'tps']}, 21:02:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:15 INFO - 'tests': ['damp', 'tps']}, 21:02:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:02:15 INFO - 'tests': ['dromaeo_dom']}, 21:02:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:02:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:02:15 INFO - 'tests': ['basic_compositor_video']}, 21:02:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:02:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:02:15 INFO - 'tests': ['a11yr', 21:02:15 INFO - 'ts_paint', 21:02:15 INFO - 'tpaint', 21:02:15 INFO - 'sessionrestore', 21:02:15 INFO - 'sessionrestore_no_auto_restore', 21:02:15 INFO - 'tabpaint']}, 21:02:15 INFO - 'other-e10s': {'tests': ['a11yr', 21:02:15 INFO - 'ts_paint', 21:02:15 INFO - 'tpaint', 21:02:15 INFO - 'sessionrestore', 21:02:15 INFO - 'sessionrestore_no_auto_restore', 21:02:15 INFO - 'tabpaint']}, 21:02:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:02:15 INFO - 'ts_paint', 21:02:15 INFO - 'tpaint', 21:02:15 INFO - 'sessionrestore', 21:02:15 INFO - 'sessionrestore_no_auto_restore', 21:02:15 INFO - 'tabpaint']}, 21:02:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:02:15 INFO - 'ts_paint', 21:02:15 INFO - 'tpaint', 21:02:15 INFO - 'sessionrestore', 21:02:15 INFO - 'sessionrestore_no_auto_restore', 21:02:15 INFO - 'tabpaint']}, 21:02:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:02:15 INFO - 'tests': ['a11yr', 21:02:15 INFO - 'ts_paint', 21:02:15 INFO - 'tpaint', 21:02:15 INFO - 'sessionrestore', 21:02:15 INFO - 'sessionrestore_no_auto_restore', 21:02:15 INFO - 'tabpaint']}, 21:02:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:02:15 INFO - 'tests': ['a11yr', 21:02:15 INFO - 'ts_paint', 21:02:15 INFO - 'tpaint', 21:02:15 INFO - 'sessionrestore', 21:02:15 INFO - 'sessionrestore_no_auto_restore', 21:02:15 INFO - 'tabpaint']}, 21:02:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:02:15 INFO - 'tests': ['tsvgx', 21:02:15 INFO - 'tsvgr_opacity', 21:02:15 INFO - 'tart', 21:02:15 INFO - 'tscrollx', 21:02:15 INFO - 'cart']}, 21:02:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:02:15 INFO - 'tsvgr_opacity', 21:02:15 INFO - 'tart', 21:02:15 INFO - 'tscrollx', 21:02:15 INFO - 'cart']}, 21:02:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:15 INFO - 'talos_options': ['--disable-e10s'], 21:02:15 INFO - 'tests': ['tp5o']}, 21:02:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:15 INFO - 'tests': ['tp5o']}, 21:02:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:15 INFO - 'talos_options': ['--disable-e10s', 21:02:15 INFO - '--xperf_path', 21:02:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:02:15 INFO - 'tests': ['tp5n']}, 21:02:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:15 INFO - 'talos_options': ['--xperf_path', 21:02:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:02:15 INFO - 'tests': ['tp5n']}}, 21:02:15 INFO - 'talos.zip': {'path': '', 21:02:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:02:15 INFO - Running post-action listener: _resource_record_post_action 21:02:15 INFO - [mozharness: 2017-01-03 05:02:15.858384Z] Finished populate-webroot step (success) 21:02:15 INFO - [mozharness: 2017-01-03 05:02:15.858471Z] Running create-virtualenv step. 21:02:15 INFO - Running pre-action listener: _resource_record_pre_action 21:02:15 INFO - Running main action method: create_virtualenv 21:02:15 INFO - Creating virtualenv /builds/slave/test/build/venv 21:02:15 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 21:02:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:02:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:02:15 INFO - Using real prefix '/usr' 21:02:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:02:16 INFO - Installing distribute.............................................................................................................................................................................................done. 21:02:18 INFO - Installing pip.................done. 21:02:18 INFO - Return code: 0 21:02:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:02:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:02:18 INFO - Reading from file tmpfile_stdout 21:02:18 INFO - Output received: 21:02:18 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) 21:02:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:18 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 0x7fe4dfcdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215bf60>, '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 0x215cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215d1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1483419373.866878-194076106', '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 21:02:18 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 21:02:18 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 21:02:18 INFO - Using env: {'DISPLAY': ':0', 21:02:18 INFO - 'HOME': '/home/cltbld', 21:02:18 INFO - 'LANG': 'en_US.UTF-8', 21:02:18 INFO - 'LANGUAGE': 'en_US:en', 21:02:18 INFO - 'LOGNAME': 'cltbld', 21:02:18 INFO - 'MAIL': '/var/mail/cltbld', 21:02:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:18 INFO - 'MOZ_NO_REMOTE': '1', 21:02:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:18 INFO - 'NO_EM_RESTART': '1', 21:02:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:18 INFO - 'PWD': '/builds/slave/test', 21:02:18 INFO - 'SHELL': '/bin/bash', 21:02:18 INFO - 'SHLVL': '1', 21:02:18 INFO - 'TERM': 'linux', 21:02:18 INFO - 'TMOUT': '86400', 21:02:18 INFO - 'USER': 'cltbld', 21:02:18 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1483419373.866878-194076106', 21:02:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:18 INFO - '_': '/tools/buildbot/bin/python'} 21:02:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:18 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 21:02:18 INFO - Cleaning up... 21:02:18 INFO - Return code: 0 21:02:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:18 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 0x7fe4dfcdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215bf60>, '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 0x215cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215d1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1483419373.866878-194076106', '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 21:02:18 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 21:02:18 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 21:02:18 INFO - Using env: {'DISPLAY': ':0', 21:02:18 INFO - 'HOME': '/home/cltbld', 21:02:18 INFO - 'LANG': 'en_US.UTF-8', 21:02:18 INFO - 'LANGUAGE': 'en_US:en', 21:02:18 INFO - 'LOGNAME': 'cltbld', 21:02:18 INFO - 'MAIL': '/var/mail/cltbld', 21:02:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:18 INFO - 'MOZ_NO_REMOTE': '1', 21:02:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:18 INFO - 'NO_EM_RESTART': '1', 21:02:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:18 INFO - 'PWD': '/builds/slave/test', 21:02:18 INFO - 'SHELL': '/bin/bash', 21:02:18 INFO - 'SHLVL': '1', 21:02:18 INFO - 'TERM': 'linux', 21:02:18 INFO - 'TMOUT': '86400', 21:02:18 INFO - 'USER': 'cltbld', 21:02:18 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1483419373.866878-194076106', 21:02:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:18 INFO - '_': '/tools/buildbot/bin/python'} 21:02:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:19 INFO - Downloading/unpacking psutil>=3.1.1 21:02:19 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 21:02:19 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 21:02:19 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 21:02:19 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 21:02:19 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 21:02:19 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 21:02:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:02:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:02:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:02:21 INFO - Installing collected packages: psutil 21:02:21 INFO - Running setup.py install for psutil 21:02:21 INFO - building 'psutil._psutil_linux' extension 21:02:21 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 21:02:21 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 21:02:21 INFO - building 'psutil._psutil_posix' extension 21:02:21 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 21:02:21 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 21:02:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:02:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:02:21 INFO - Successfully installed psutil 21:02:21 INFO - Cleaning up... 21:02:21 INFO - Return code: 0 21:02:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:02: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')]} 21:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02: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')]} 21:02:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4dfcdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215bf60>, '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 0x215cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215d1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1483419373.866878-194076106', '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 21:02: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:02: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 mozsystemmonitor==0.3 21:02:21 INFO - Using env: {'DISPLAY': ':0', 21:02:21 INFO - 'HOME': '/home/cltbld', 21:02:21 INFO - 'LANG': 'en_US.UTF-8', 21:02:21 INFO - 'LANGUAGE': 'en_US:en', 21:02:21 INFO - 'LOGNAME': 'cltbld', 21:02:21 INFO - 'MAIL': '/var/mail/cltbld', 21:02:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:21 INFO - 'MOZ_NO_REMOTE': '1', 21:02:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:21 INFO - 'NO_EM_RESTART': '1', 21:02:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:21 INFO - 'PWD': '/builds/slave/test', 21:02:21 INFO - 'SHELL': '/bin/bash', 21:02:21 INFO - 'SHLVL': '1', 21:02:21 INFO - 'TERM': 'linux', 21:02:21 INFO - 'TMOUT': '86400', 21:02:21 INFO - 'USER': 'cltbld', 21:02:21 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1483419373.866878-194076106', 21:02:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:21 INFO - '_': '/tools/buildbot/bin/python'} 21:02:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:02:21 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 21:02:21 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 21:02:21 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 21:02:21 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 21:02:21 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 21:02:21 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 21:02:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:02:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:02:24 INFO - Installing collected packages: mozsystemmonitor 21:02:24 INFO - Running setup.py install for mozsystemmonitor 21:02:24 INFO - Successfully installed mozsystemmonitor 21:02:24 INFO - Cleaning up... 21:02:24 INFO - Return code: 0 21:02:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:02: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')]} 21:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02: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')]} 21:02:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02: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', '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 0x7fe4dfcdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215bf60>, '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 0x215cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215d1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1483419373.866878-194076106', '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 21:02: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:02: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 jsonschema==2.5.1 21:02:24 INFO - Using env: {'DISPLAY': ':0', 21:02:24 INFO - 'HOME': '/home/cltbld', 21:02:24 INFO - 'LANG': 'en_US.UTF-8', 21:02:24 INFO - 'LANGUAGE': 'en_US:en', 21:02:24 INFO - 'LOGNAME': 'cltbld', 21:02:24 INFO - 'MAIL': '/var/mail/cltbld', 21:02:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:24 INFO - 'MOZ_NO_REMOTE': '1', 21:02:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:24 INFO - 'NO_EM_RESTART': '1', 21:02:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:24 INFO - 'PWD': '/builds/slave/test', 21:02:24 INFO - 'SHELL': '/bin/bash', 21:02:24 INFO - 'SHLVL': '1', 21:02:24 INFO - 'TERM': 'linux', 21:02:24 INFO - 'TMOUT': '86400', 21:02:24 INFO - 'USER': 'cltbld', 21:02:24 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1483419373.866878-194076106', 21:02:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:24 INFO - '_': '/tools/buildbot/bin/python'} 21:02:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:24 INFO - Downloading/unpacking jsonschema==2.5.1 21:02: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 21:02: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 21:02: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 21:02: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 21:02: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 21:02: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 21:02:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:02:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:02:26 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 21:02:26 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 21:02:26 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 21:02:26 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 21:02:26 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 21:02:26 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 21:02:26 INFO - Downloading functools32-3.2.3-2.tar.gz 21:02:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:02:26 INFO - warning: no files found matching '*.txt' 21:02:26 INFO - no previously-included directories found matching 'build' 21:02:26 INFO - no previously-included directories found matching 'dist' 21:02:26 INFO - no previously-included directories found matching '.git*' 21:02:26 INFO - Installing collected packages: jsonschema, functools32 21:02:26 INFO - Running setup.py install for functools32 21:02:26 INFO - warning: no files found matching '*.txt' 21:02:26 INFO - no previously-included directories found matching 'build' 21:02:26 INFO - no previously-included directories found matching 'dist' 21:02:26 INFO - no previously-included directories found matching '.git*' 21:02:26 INFO - Successfully installed jsonschema functools32 21:02:26 INFO - Cleaning up... 21:02:26 INFO - Return code: 0 21:02:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:02:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe4dfcdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215bf60>, '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 0x215cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215d1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1483419373.866878-194076106', '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 21:02:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:02:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:02:26 INFO - Using env: {'DISPLAY': ':0', 21:02:26 INFO - 'HOME': '/home/cltbld', 21:02:26 INFO - 'LANG': 'en_US.UTF-8', 21:02:26 INFO - 'LANGUAGE': 'en_US:en', 21:02:26 INFO - 'LOGNAME': 'cltbld', 21:02:26 INFO - 'MAIL': '/var/mail/cltbld', 21:02:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:26 INFO - 'MOZ_NO_REMOTE': '1', 21:02:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:26 INFO - 'NO_EM_RESTART': '1', 21:02:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:26 INFO - 'PWD': '/builds/slave/test', 21:02:26 INFO - 'SHELL': '/bin/bash', 21:02:26 INFO - 'SHLVL': '1', 21:02:26 INFO - 'TERM': 'linux', 21:02:26 INFO - 'TMOUT': '86400', 21:02:26 INFO - 'USER': 'cltbld', 21:02:26 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1483419373.866878-194076106', 21:02:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:26 INFO - '_': '/tools/buildbot/bin/python'} 21:02:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:02:27 INFO - Cleaning up... 21:02:27 INFO - Return code: 0 21:02:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:02: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')]} 21:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02: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')]} 21:02:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02: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', '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 0x7fe4dfcdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215bf60>, '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 0x215cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215d1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1483419373.866878-194076106', '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 21:02: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:02: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 blobuploader==1.2.4 21:02:27 INFO - Using env: {'DISPLAY': ':0', 21:02:27 INFO - 'HOME': '/home/cltbld', 21:02:27 INFO - 'LANG': 'en_US.UTF-8', 21:02:27 INFO - 'LANGUAGE': 'en_US:en', 21:02:27 INFO - 'LOGNAME': 'cltbld', 21:02:27 INFO - 'MAIL': '/var/mail/cltbld', 21:02:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:27 INFO - 'MOZ_NO_REMOTE': '1', 21:02:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:27 INFO - 'NO_EM_RESTART': '1', 21:02:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:27 INFO - 'PWD': '/builds/slave/test', 21:02:27 INFO - 'SHELL': '/bin/bash', 21:02:27 INFO - 'SHLVL': '1', 21:02:27 INFO - 'TERM': 'linux', 21:02:27 INFO - 'TMOUT': '86400', 21:02:27 INFO - 'USER': 'cltbld', 21:02:27 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1483419373.866878-194076106', 21:02:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:27 INFO - '_': '/tools/buildbot/bin/python'} 21:02:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:27 INFO - Downloading/unpacking blobuploader==1.2.4 21:02: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 21:02: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 21:02: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 21:02: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 21:02: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 21:02: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 21:02:29 INFO - Downloading blobuploader-1.2.4.tar.gz 21:02:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:02:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:02: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 21:02: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 21:02: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 21:02: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 21:02: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 21:02: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 21:02:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:02:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:02: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 21:02: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 21:02: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 21:02: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 21:02: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 21:02: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 21:02:30 INFO - Downloading docopt-0.6.1.tar.gz 21:02:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:02:30 INFO - Installing collected packages: blobuploader, requests, docopt 21:02:30 INFO - Running setup.py install for blobuploader 21:02:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:02:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:02:30 INFO - Running setup.py install for requests 21:02:30 INFO - Running setup.py install for docopt 21:02:30 INFO - Successfully installed blobuploader requests docopt 21:02:30 INFO - Cleaning up... 21:02:30 INFO - Return code: 0 21:02:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:02: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')]} 21:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02: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')]} 21:02:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:30 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 0x7fe4dfcdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215bf60>, '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 0x215cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215d1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1483419373.866878-194076106', '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 21:02:30 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 21:02:30 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 21:02:30 INFO - Using env: {'DISPLAY': ':0', 21:02:30 INFO - 'HOME': '/home/cltbld', 21:02:30 INFO - 'LANG': 'en_US.UTF-8', 21:02:30 INFO - 'LANGUAGE': 'en_US:en', 21:02:30 INFO - 'LOGNAME': 'cltbld', 21:02:30 INFO - 'MAIL': '/var/mail/cltbld', 21:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:30 INFO - 'MOZ_NO_REMOTE': '1', 21:02:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:30 INFO - 'NO_EM_RESTART': '1', 21:02:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:30 INFO - 'PWD': '/builds/slave/test', 21:02:30 INFO - 'SHELL': '/bin/bash', 21:02:30 INFO - 'SHLVL': '1', 21:02:30 INFO - 'TERM': 'linux', 21:02:30 INFO - 'TMOUT': '86400', 21:02:30 INFO - 'USER': 'cltbld', 21:02:30 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1483419373.866878-194076106', 21:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:30 INFO - '_': '/tools/buildbot/bin/python'} 21:02:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:02:30 INFO - Running setup.py (path:/tmp/pip-1X9SKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:02:31 INFO - Running setup.py (path:/tmp/pip-1_SDlD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:02:31 INFO - Running setup.py (path:/tmp/pip-Rf8MRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:02:31 INFO - Running setup.py (path:/tmp/pip-I97DM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:02:31 INFO - Running setup.py (path:/tmp/pip-bbDqSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:02:31 INFO - Running setup.py (path:/tmp/pip-eyKQB7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:02:31 INFO - Running setup.py (path:/tmp/pip-JvnOdm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:02:31 INFO - Running setup.py (path:/tmp/pip-MIAN9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:02:31 INFO - Running setup.py (path:/tmp/pip-ndWhTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:02:31 INFO - Running setup.py (path:/tmp/pip-sDwh61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:02:31 INFO - Running setup.py (path:/tmp/pip-_zWQKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:02:31 INFO - Running setup.py (path:/tmp/pip-WYv_bx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:02:31 INFO - Running setup.py (path:/tmp/pip-RBVeO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:02:31 INFO - Running setup.py (path:/tmp/pip-zXEN0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:02:31 INFO - Running setup.py (path:/tmp/pip-qQq1Sw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:02:32 INFO - Running setup.py (path:/tmp/pip-t2Eido-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:02:32 INFO - Running setup.py (path:/tmp/pip-HfTw5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:02:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:02:32 INFO - Running setup.py install for manifestparser 21:02:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:02:32 INFO - Running setup.py install for mozcrash 21:02:32 INFO - Running setup.py install for mozdebug 21:02:32 INFO - Running setup.py install for mozdevice 21:02:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:02:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:02:32 INFO - Running setup.py install for mozfile 21:02:32 INFO - Running setup.py install for mozhttpd 21:02:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:02:32 INFO - Running setup.py install for mozinfo 21:02:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:02:32 INFO - Running setup.py install for mozInstall 21:02:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:02:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:02:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:02:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:02:32 INFO - Running setup.py install for mozleak 21:02:33 INFO - Running setup.py install for mozlog 21:02:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:02:33 INFO - Running setup.py install for moznetwork 21:02:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:02:33 INFO - Running setup.py install for mozprocess 21:02:33 INFO - Running setup.py install for mozprofile 21:02:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:02:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:02:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:02:33 INFO - Running setup.py install for mozrunner 21:02:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:02:33 INFO - Running setup.py install for mozscreenshot 21:02:33 INFO - Running setup.py install for moztest 21:02:33 INFO - Running setup.py install for mozversion 21:02:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:02:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:02:33 INFO - Cleaning up... 21:02:33 INFO - Return code: 0 21:02:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:02: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')]} 21:02:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02: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')]} 21:02:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:33 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 0x7fe4dfcdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215bf60>, '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 0x215cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215d1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1483419373.866878-194076106', '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 21:02:33 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 21:02:33 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 21:02:33 INFO - Using env: {'DISPLAY': ':0', 21:02:33 INFO - 'HOME': '/home/cltbld', 21:02:33 INFO - 'LANG': 'en_US.UTF-8', 21:02:33 INFO - 'LANGUAGE': 'en_US:en', 21:02:33 INFO - 'LOGNAME': 'cltbld', 21:02:33 INFO - 'MAIL': '/var/mail/cltbld', 21:02:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:33 INFO - 'MOZ_NO_REMOTE': '1', 21:02:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:33 INFO - 'NO_EM_RESTART': '1', 21:02:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:33 INFO - 'PWD': '/builds/slave/test', 21:02:33 INFO - 'SHELL': '/bin/bash', 21:02:33 INFO - 'SHLVL': '1', 21:02:33 INFO - 'TERM': 'linux', 21:02:33 INFO - 'TMOUT': '86400', 21:02:33 INFO - 'USER': 'cltbld', 21:02:33 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1483419373.866878-194076106', 21:02:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:33 INFO - '_': '/tools/buildbot/bin/python'} 21:02:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:02:34 INFO - Running setup.py (path:/tmp/pip-kDHCmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:02:34 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)) 21:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:02:34 INFO - Running setup.py (path:/tmp/pip-rO5LWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:02:34 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)) 21:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:02:34 INFO - Running setup.py (path:/tmp/pip-v3KqQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:02:34 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)) 21:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:02:34 INFO - Running setup.py (path:/tmp/pip-G_LB5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:02:34 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)) 21:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:02:34 INFO - Running setup.py (path:/tmp/pip-WfiQIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:02:34 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)) 21:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:02:34 INFO - Running setup.py (path:/tmp/pip-BRi1RO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:02:34 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)) 21:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:02:34 INFO - Running setup.py (path:/tmp/pip-W7oCiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:02:34 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)) 21:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:02:34 INFO - Running setup.py (path:/tmp/pip-TLcIdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:02:34 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)) 21:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:02:34 INFO - Running setup.py (path:/tmp/pip-APDcdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:02:34 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)) 21:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:02:34 INFO - Running setup.py (path:/tmp/pip-wHugk0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:02:34 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)) 21:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:02:34 INFO - Running setup.py (path:/tmp/pip-5WoSHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:02:34 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)) 21:02:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:02:34 INFO - Running setup.py (path:/tmp/pip-0jEetc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:02:35 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)) 21:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:02:35 INFO - Running setup.py (path:/tmp/pip-oHP8kf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:02:35 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)) 21:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:02:35 INFO - Running setup.py (path:/tmp/pip-iuSbFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:02:35 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)) 21:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:02:35 INFO - Running setup.py (path:/tmp/pip-pZvlNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:02:35 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)) 21:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:02:35 INFO - Running setup.py (path:/tmp/pip-8MTivN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:02:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:02:35 INFO - Running setup.py (path:/tmp/pip-Jbh_l7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:02:35 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)) 21:02:35 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)) 21:02:35 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)) 21:02:35 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)) 21:02:35 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)) 21:02:35 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)) 21:02:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:02:35 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 21:02:35 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 21:02:35 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 21:02:35 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 21:02:35 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 21:02:35 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 21:02:37 INFO - Downloading blessings-1.6.tar.gz 21:02:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:02:37 INFO - Installing collected packages: blessings 21:02:37 INFO - Running setup.py install for blessings 21:02:37 INFO - Successfully installed blessings 21:02:37 INFO - Cleaning up... 21:02:37 INFO - Return code: 0 21:02:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:02:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:02:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:02:37 INFO - Reading from file tmpfile_stdout 21:02:37 INFO - Current package versions: 21:02:37 INFO - argparse == 1.2.1 21:02:37 INFO - blessings == 1.6 21:02:37 INFO - blobuploader == 1.2.4 21:02:37 INFO - docopt == 0.6.1 21:02:37 INFO - functools32 == 3.2.3-2 21:02:37 INFO - jsonschema == 2.5.1 21:02:37 INFO - manifestparser == 1.1 21:02:37 INFO - mozInstall == 1.12 21:02:37 INFO - mozcrash == 1.0 21:02:37 INFO - mozdebug == 0.1 21:02:37 INFO - mozdevice == 0.48 21:02:37 INFO - mozfile == 1.2 21:02:37 INFO - mozhttpd == 0.7 21:02:37 INFO - mozinfo == 0.9 21:02:37 INFO - mozleak == 0.1 21:02:37 INFO - mozlog == 3.4 21:02:37 INFO - moznetwork == 0.27 21:02:37 INFO - mozprocess == 0.23 21:02:37 INFO - mozprofile == 0.28 21:02:37 INFO - mozrunner == 6.13 21:02:37 INFO - mozscreenshot == 0.1 21:02:37 INFO - mozsystemmonitor == 0.3 21:02:37 INFO - moztest == 0.7 21:02:37 INFO - mozversion == 1.4 21:02:37 INFO - psutil == 3.1.1 21:02:37 INFO - requests == 1.2.3 21:02:37 INFO - wsgiref == 0.1.2 21:02:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:02:37 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')]} 21:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:37 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')]} 21:02:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:37 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 0x7fe4dfcdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215bf60>, '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 0x215cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215d1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1483419373.866878-194076106', '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 21:02:37 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 21:02:37 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 21:02:37 INFO - Using env: {'DISPLAY': ':0', 21:02:37 INFO - 'HOME': '/home/cltbld', 21:02:37 INFO - 'LANG': 'en_US.UTF-8', 21:02:37 INFO - 'LANGUAGE': 'en_US:en', 21:02:37 INFO - 'LOGNAME': 'cltbld', 21:02:37 INFO - 'MAIL': '/var/mail/cltbld', 21:02:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:37 INFO - 'MOZ_NO_REMOTE': '1', 21:02:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:37 INFO - 'NO_EM_RESTART': '1', 21:02:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:37 INFO - 'PWD': '/builds/slave/test', 21:02:37 INFO - 'SHELL': '/bin/bash', 21:02:37 INFO - 'SHLVL': '1', 21:02:37 INFO - 'TERM': 'linux', 21:02:37 INFO - 'TMOUT': '86400', 21:02:37 INFO - 'USER': 'cltbld', 21:02:37 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1483419373.866878-194076106', 21:02:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:37 INFO - '_': '/tools/buildbot/bin/python'} 21:02:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:38 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)) 21:02:38 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)) 21:02:38 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)) 21:02:38 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)) 21:02:38 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)) 21:02:38 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)) 21:02:38 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)) 21:02:38 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)) 21:02:38 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)) 21:02:38 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)) 21:02:38 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)) 21:02:38 INFO - Cleaning up... 21:02:38 INFO - Return code: 0 21:02:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:02:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:38 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 0x7fe4dfcdff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20918a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x215eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x215bf60>, '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 0x215cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215d1d0>, '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': '62c568580acbfdaac3eec7be000001dc-1483419373.866878-194076106', '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 21:02:38 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 21:02:38 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 21:02:38 INFO - Using env: {'DISPLAY': ':0', 21:02:38 INFO - 'HOME': '/home/cltbld', 21:02:38 INFO - 'LANG': 'en_US.UTF-8', 21:02:38 INFO - 'LANGUAGE': 'en_US:en', 21:02:38 INFO - 'LOGNAME': 'cltbld', 21:02:38 INFO - 'MAIL': '/var/mail/cltbld', 21:02:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:38 INFO - 'MOZ_NO_REMOTE': '1', 21:02:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:38 INFO - 'NO_EM_RESTART': '1', 21:02:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:38 INFO - 'PWD': '/builds/slave/test', 21:02:38 INFO - 'SHELL': '/bin/bash', 21:02:38 INFO - 'SHLVL': '1', 21:02:38 INFO - 'TERM': 'linux', 21:02:38 INFO - 'TMOUT': '86400', 21:02:38 INFO - 'USER': 'cltbld', 21:02:38 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1483419373.866878-194076106', 21:02:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:38 INFO - '_': '/tools/buildbot/bin/python'} 21:02:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:02:38 INFO - Cleaning up... 21:02:38 INFO - Return code: 0 21:02:38 INFO - Running post-action listener: _resource_record_post_action 21:02:38 INFO - Running post-action listener: _start_resource_monitoring 21:02:38 INFO - Starting resource monitoring. 21:02:38 INFO - [mozharness: 2017-01-03 05:02:38.389905Z] Finished create-virtualenv step (success) 21:02:38 INFO - [mozharness: 2017-01-03 05:02:38.390419Z] Running install step. 21:02:38 INFO - Running pre-action listener: _resource_record_pre_action 21:02:38 INFO - Running main action method: install 21:02:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:02:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:02:38 INFO - Reading from file tmpfile_stdout 21:02:38 INFO - Detecting whether we're running mozinstall >=1.0... 21:02:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:02:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:02:38 INFO - Reading from file tmpfile_stdout 21:02:38 INFO - Output received: 21:02:38 INFO - Usage: mozinstall [options] installer 21:02:38 INFO - Options: 21:02:38 INFO - -h, --help show this help message and exit 21:02:38 INFO - -d DEST, --destination=DEST 21:02:38 INFO - Directory to install application into. [default: 21:02:38 INFO - "/builds/slave/test"] 21:02:38 INFO - --app=APP Application being installed. [default: firefox] 21:02:38 INFO - mkdir: /builds/slave/test/build/application 21:02:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:02:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:02:54 INFO - Reading from file tmpfile_stdout 21:02:54 INFO - Output received: 21:02:54 INFO - /builds/slave/test/build/application/firefox/firefox 21:02:54 INFO - Running post-action listener: _resource_record_post_action 21:02:54 INFO - [mozharness: 2017-01-03 05:02:54.614647Z] Finished install step (success) 21:02:54 INFO - [mozharness: 2017-01-03 05:02:54.614886Z] Running run-tests step. 21:02:54 INFO - Running pre-action listener: _resource_record_pre_action 21:02:54 INFO - Running main action method: run_tests 21:02:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:02:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:02:54 INFO - Python 2.7.3 21:02:54 INFO - Return code: 0 21:02:54 INFO - grabbing minidump binary from tooltool 21:02:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:54 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 0x215bf60>, '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 0x215cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x215d1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:02:54 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 21:02:54 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 21:02:54 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 21:02:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:02:54 INFO - Return code: 0 21:02:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:02:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:02:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:02:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:02:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:02:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SuOHcJzuRCqa-72hkgWxhA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 21:02:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SuOHcJzuRCqa-72hkgWxhA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 21:02:54 INFO - Using env: {'DISPLAY': ':0', 21:02:54 INFO - 'HOME': '/home/cltbld', 21:02:54 INFO - 'LANG': 'en_US.UTF-8', 21:02:54 INFO - 'LANGUAGE': 'en_US:en', 21:02:54 INFO - 'LOGNAME': 'cltbld', 21:02:54 INFO - 'MAIL': '/var/mail/cltbld', 21:02:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:02:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:02:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:54 INFO - 'MOZ_NO_REMOTE': '1', 21:02:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:02:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:54 INFO - 'NO_EM_RESTART': '1', 21:02:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:54 INFO - 'PWD': '/builds/slave/test', 21:02:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:02:54 INFO - 'SHELL': '/bin/bash', 21:02:54 INFO - 'SHLVL': '1', 21:02:54 INFO - 'TERM': 'linux', 21:02:54 INFO - 'TMOUT': '86400', 21:02:54 INFO - 'USER': 'cltbld', 21:02:54 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1483419373.866878-194076106', 21:02:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:54 INFO - '_': '/tools/buildbot/bin/python'} 21:02:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SuOHcJzuRCqa-72hkgWxhA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 21:02:54 INFO - mozversion application_buildid: 20170102192820 21:02:54 INFO - mozversion application_changeset: a6f6cf4180980a74083cc03f611cc510eb15b5cc 21:02:54 INFO - mozversion application_display_name: FirefoxDeveloperEdition 21:02:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:02:54 INFO - mozversion application_name: Firefox 21:02:54 INFO - mozversion application_remotingname: firefox-dev 21:02:54 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:02:54 INFO - mozversion application_vendor: Mozilla 21:02:54 INFO - mozversion application_version: 52.0a2 21:02:54 INFO - mozversion platform_buildid: 20170102192820 21:02:54 INFO - mozversion platform_changeset: a6f6cf4180980a74083cc03f611cc510eb15b5cc 21:02:54 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:02:54 INFO - mozversion platform_version: 52.0a2 21:02:54 INFO - using testdate: 1483419774 21:02:54 INFO - actual date: 1483419774 21:02:54 INFO - starting webserver on 'localhost:59657' 21:02:54 INFO - SUITE-START | Running 2 tests 21:02:54 INFO - TEST-START | dromaeo_css 21:02:54 INFO - operating with platform_type : linux_ 21:02:54 INFO - Initialising browser for dromaeo_css test... 21:02:54 INFO - TEST-INFO | started process 23185 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDTuo1Y/profile http://localhost:59657/getInfo.html) 21:02:59 INFO - PROCESS | 23185 | __metrics Screen width/height:1600/1200 21:02:59 INFO - PROCESS | 23185 | colorDepth:24 21:02:59 INFO - PROCESS | 23185 | Browser inner width/height: 1024/697 21:02:59 INFO - PROCESS | 23185 | __metrics 21:02:59 ERROR - PROCESS | 23185 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 21:03:00 INFO - TEST-INFO | 23185: exit 0 21:03:00 INFO - Browser initialized. 21:03:00 INFO - Running cycle 1/1 for dromaeo_css test... 21:03:00 INFO - TEST-INFO | started process 23316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDTuo1Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:03:12 INFO - PROCESS | 23316 | RSS: Main: 152248320 21:03:12 INFO - PROCESS | 23316 | 21:04:01 INFO - PROCESS | 23316 | 1483419841727 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:06:12 INFO - PROCESS | 23316 | Cycle 1(1): loaded http://localhost:59657/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59657/tests/dromaeo/cssquery-ext.html) 21:06:14 INFO - PROCESS | 23316 | RSS: Main: 156901376 21:06:14 INFO - PROCESS | 23316 | 21:09:16 INFO - PROCESS | 23316 | Cycle 1(1): loaded http://localhost:59657/tests/dromaeo/cssquery-ext.html (next: http://localhost:59657/tests/dromaeo/cssquery-jquery.html) 21:09:16 INFO - PROCESS | 23316 | RSS: Main: 153194496 21:09:16 INFO - PROCESS | 23316 | 21:12:18 INFO - PROCESS | 23316 | Cycle 1(1): loaded http://localhost:59657/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59657/tests/dromaeo/cssquery-mootools.html) 21:12:19 INFO - PROCESS | 23316 | RSS: Main: 153784320 21:12:19 INFO - PROCESS | 23316 | 21:15:21 INFO - PROCESS | 23316 | Cycle 1(1): loaded http://localhost:59657/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59657/tests/dromaeo/cssquery-prototype.html) 21:15:21 INFO - PROCESS | 23316 | RSS: Main: 151920640 21:15:21 INFO - PROCESS | 23316 | 21:18:24 INFO - PROCESS | 23316 | Cycle 1(1): loaded http://localhost:59657/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59657/tests/dromaeo/cssquery-yui.html) 21:18:24 INFO - PROCESS | 23316 | RSS: Main: 154484736 21:18:24 INFO - PROCESS | 23316 | 21:21:26 INFO - PROCESS | 23316 | Cycle 1(1): loaded http://localhost:59657/tests/dromaeo/cssquery-yui.html (next: http://localhost:59657/tests/dromaeo/cssquery-dojo.html) 21:21:27 INFO - PROCESS | 23316 | RSS: Main: 154591232 21:21:27 INFO - PROCESS | 23316 | 21:21:27 INFO - PROCESS | 23316 | __start_tp_report 21:21:27 INFO - PROCESS | 23316 | _x_x_mozilla_page_load 21:21:27 INFO - PROCESS | 23316 | _x_x_mozilla_page_load_details 21:21:27 INFO - PROCESS | 23316 | |i|pagename|runs| 21:21:27 INFO - PROCESS | 23316 | |0;dojo.html;3299.65353637868;3344.598648162221;3351.0617027232374;3362.4788157835515;3368.814715190665;5753.108268218428;5811.535077193825;5829.795957141496;5847.1521629363715;5866.325372582154;5780.306363236417;5816.272965879265;5840.53275737941;5865.090910908816;5878.617889837157;5269.394019687747;5286.31277933869;5324.387695415038;5330.520253177213;5359.5712343012665;5366.6243362964415;5369.5972802039805;5373.032854086263;5374.193870919374;5382.838514844561;5138.743062846861;5145.485451454862;5324.520793128618;5369.543588794957;5373;5251.081060814361;5289.127293996486;5350.3312085989255;5371.677699338053;5431.2396264522995;5276.630635855492;5355.518003379676;5360.812371566976;5363.758630861582;5368.033753924292;5497.752601132958;5787.652740835563;5848.941510584882;5884.382139875294;5925.911111333334;5970.462658360725;6081.996470582349;6096.786612468542;6102.664353460602;6113.810786210604;6176.7838125665385;6195.070739389128;6205.410486003822;6291.905621415683;6330.335314791972;5851.8537036574;5852.970735146382;5881.411858814085;5882.294124704978;5918.348981612019;6312.747490100344;6334.714937827809;6381.8085457436355;6436.581622194636;6462.159919210472;6187.041008643668;6192.907106393408;6197.721102550396;6206.441420272197;6212.844678882973;5995.46040856325;6041.939580604226;6300.621962682162;6311.431971122621;6317.557770955989;6092.482139018144;6116.113163591254;6123.862238009563;6204.875902481925;6207.937920620826;6080.604760690541;6185.165002724664;6194.566380353332;6195.938040619626;6196.969015154986;4627.051454451829;4760.571548560577;4760.809567617256;4761.142994260997;4768.117898188846;4146.979265103655;4157.792110394468;4167.1457351243525;4252.340887162495;4255.936160957588;5879.353271140171;5922.674252916045;5951.880962380815;5961.731722072517;5965.701714914324;6217.067439884054;6219.0982307566055;6228.626282423069;6230.345813689588;6241.282252541016;5800.709964501758;5859.121131830259;5918.556108291896;5945.791897283661;5971.223740913741;5411.080116380225;5432.049391356576;5434.402215756264;5436.184572314184;5450.645708028966;6499.317571655098;6506.414422701885;6509.967450162719;6553.049807777846;6570.737170513126;6026.548008899263;6079.179310792986;6140.811014692577;6145.463634091477;6288.6855657217875;6445.16212892321;6461.773837915651;6472.126262954441;6490.837729056811;6491.707873145625;6097.390260973867;6134.6625935573975;6146.231721034871;6162.815115546541;6173.59871608344;5923.940760592339;6032.426919442646;6140.416660417253;6234.2830574484515;6269.404406581368;6043.516518678583;6104.4200800923845;6124.625058545733;6132.324915438686;6132.447291485866;6080.939190608037;6094.14681944537;6094.8171554853425;6100.725467353891;6135.969320153549;5718.628289161191;5769.798057067983;6006.969965150146;6043.909341359971;6083.026715725463;6081.513478921587;6131.835460087213;6152.107944347955;6220.160278362544;6228.719707613078;6006.489448396936;6016.699165041643;6023.5181185505935;6025.307089684742;6040.546958978182 21:21:27 INFO - PROCESS | 23316 | |1;ext.html;563.2681494750461;585.3707264690457;613.9324674285828;622.3216693803753;634.2294112653126;44655.77672111639;45829.31256031158;45853.541464585345;48459.27311090336;48504;45116.774416127875;45296;45693.08613827721;45713.7714311428;45734.313985290246;8694.652213911451;8814.603342849587;8831.116888311182;8836.204741573258;8839.425437346585;8669.349798765086;8792.428492148021;8830.116988301183;8839.381243312971;8849.380543361967;8828.205461508463;8846.02693703692;8887.066857979917;8888.644454221823;8904.376693631448;8764.824703505927;8780.429272097294;8833.33749968755;8834.028256891768;8860.24687901526;8606.225439710455;8615.82768344636;8717.651293948235;8720.52037137957;8742.12578742127;43051;43451.34822977658;43468;43510;43533.34699979503;3610.963890361089;3850.2107068051264;4003.779792111433;4119.299719047769;4460.041091165415;31963.360732785215;32577;32603.83698081518;32705.50941735876;32840.52217650211;4464.084862603158;4558.840440584564;4563.201439748064;4569.383133277031;4617.722936623813;361747;363570.9999999974;363884;363995;364248;61044.69477652583;61223.38776612177;61337.38662613406;61484.38515614876;61585;65267.34732652707;65299.67350163314;65346.67326663336;65466;65489.67255163693;17503.562410939827;17534.298628054734;17661.558461038578;17662.116894155242;17739.290428382978;12819;12952.740945181044;12969.157004794659;13016.349182541024;13032.47870085186;17299.827001730075;18001.909990449964;18073.7288940666;18083.09584520769;18173;5855.2973643163095;5895.4399332063385;6113.358097399709;6120.785772497941;6170.845728856725;1033.3076838518211;1072.7532667486366;1130.5816847766214;1138.038357587837;1180.722530205401;32642.673573264437;32891.83554082262;33238.66761332404;33523.66476335254;35985.46021809675;1178.293024185482;1183.7810005149074;1185.9229150105216;1241.2552468518998;1243.9067069969788;16911.23899424529;17167.828321716624;17203.569910752332;17241.224144913507;17286.394976175772;532952;534147;534582;536334;537756;60023.39976600266;60182;60244.69877650672;60297.69851150716;60299.09551356733;1433.032702925521;1436.3033928544648;1448.1238850495508;1448.9710205795825;1452.2956366162614;31257.8437107813;31789;31835;32709.509357360133;33109.33781324312;52298;52831.735841320544;52864.73567632291;53020;53094.469055310496;455411;456240;457045;458227;459494;29983.55024674588;30018.24954376158;30037.249068773457;30046.84976575103;30316.5452518208;47217;47651;48504.75747621239;48559.5144048555;48753;40547.797261013504;40582;40584.18831623292;41865;42779;40940.38589421221;41350.58649413467;41912.790436047624;42357.788211058745;42952.78523607362;36095.27809443849;36492.635073648926;39947.20237589257;40476.59523404728;42084.57915420806;35354.29291414106;36479.088022799646;36825.81587092047;37036.81481592575;37519.624803752704;28774.42451151007;28824.567631485126;28861.422771544032;29077;29249.561256581594 21:21:27 INFO - PROCESS | 23316 | |2;jquery.html;423.2064878353088;425.3577098581143;430.9694867766304;440.8611287444456;444.349028672994;18938.810611893878;19618.215271389163;19957.50106247341;20168.69746953797;20530.281440149596;16645.50063498094;18871.15079821408;19327.130279137436;19453.124609392577;19657.311994080173;5101.872453188681;5326.254324394568;5332.466753324676;5340.813071542497;5345.705986170759;4445.599896009358;4673.813047478096;5280.287161233223;5345.091334473149;5348.117560602496;6361.141245931809;6420.26166990795;6478;6489.61062336259;6498.70755815987;6410.903836442457;6495.220573531183;7121.323474269936;7428.702851885918;7450.329470347695;7144.8928266076055;7169.045208082898;7178.856422871513;7308.342249197544;7354.705811767523;26943.32641683954;27007.32481687954;27052.45895082107;27295.044673436532;27872.16383508498;2501.9374515637073;2654.561997270448;2685.9328516787236;2698.5007773561756;2749.3676454415595;15654.373825046985;16617.667646646998;16913.323467061302;16917.66164676712;17474.7378789317;2084;2085.536802276219;2126.5002724359765;2222.311083564084;2259.8870056497276;79799.20200797975;86438;96444;97907.51046244794;101500.49249753704;18131.72802407965;19251.614967700567;19515.51211219731;19658.508537286398;19742.802571974386;35291;35412.29175416477;35519;35804.10489737777;36019.4597081044;10119.139873110867;10350.741231469274;10500.684979450629;10708;10771;8497.660093596187;8534.317254619615;8735.563221838882;8823.205911467998;8829.426087304304;9194.63221471147;9647.179989700953;9652.806943861224;9705;9744.95127524372;3444.4661077533024;3462.6364231755806;3511.9824400877833;3735.9066023349633;3765.6987441004653;940.5908429833045;974.7319487140951;987.7925635616601;1022.7596514819012;1030.1964467715195;19144.904275478813;19982.800171998093;20125.597488050156;20131.19475221004;20217.29239476611;1013.716159475348;1018.0481250031245;1026.7997740440542;1047.6490375724065;1080.2345994254733;10934.4532773361;11278.139107047245;11404.942975285236;11418.942905285421;11515.481803318871;358809;366244;366844;538401;543659;97729;102413;102785;106697;107522;1054.4938429553856;1075.8171110911164;1078.800421921947;1102.8014957307762;1118.3345909184186;17923.820761792736;18160.364387246384;18375.63248734991;18538.144587339244;18688.719669205246;42403.363949540166;42724.78637606792;43488.78255608702;43621.56378436175;44186;56629;59053.40946590479;60672.696636516535;62057.68971155115;63036;6448.742050317935;7055.400290975324;8020.799480013046;8349.499030058216;8695.217430431292;12760.74478510406;13727.45090196381;13881.097728647606;14060;14074;12162.331071790783;12188.20776649515;12219.938900305442;12364.134510584172;12450.501979920702;11943.880561194625;12334.50661973547;12472.251664900135;12507.874921251036;12531.874681253435;12147.939260303641;12249.877501224873;12302.077344199042;12405.379731013594;12578.748425031632;7957.681692732457;8048.718294859652;8072.313853322298;8318.875216871631;8394.412391132562;8926.553672316488;11692.70768230801;12067.336296503776;12149.392530373623;12186.57346992851 21:21:27 INFO - PROCESS | 23316 | |3;mootools.html;1441.7981482592436;1510.4260381055196;1657.5607464022028;1848.196034724894;1862.0317434933827;8054.073781515113;8270.421070525066;8576.74269771907;9107.635694572218;9113.043130471297;8574.099719529437;8808.691695790649;8811.911880881205;8967.37228394011;9043.412178208428;2517.7356377580363;2530.228280374485;2539.7206307306274;2541.4154744408797;2544.3257536752776;2405.4467472481338;2444.584420648494;2446.694163229596;2448.571499987504;2456.8648724320155;2384.9284521464297;2402.699662542182;2405.0980882169188;2406.5427568761966;2423.5395274897714;2454.067454367338;2459.8770061496944;2480.2807185916154;2483.242611003643;2486.8507889526686;2387.271882075966;2392.7009123859516;2393.4375421775867;2402.279316205149;2410.0841680161425;8924.955375223148;8943.150400711922;9064.13890680391;9092.181703646704;9114.13415725505;5614.9438505615235;5697.487226149625;5705.001624715658;5723;5756.683382413966;3586.4620306953907;3625.619309972468;3699.6670299672887;3706.7034637229226;3755.211405604799;1199.724063465399;1221.1451983611507;1228.6314105768324;1231.5258625429185;1270.8474983002006;12545.74908501834;12654;12665.873341266562;12697;12709.237445753284;4793.784279707422;5013.147764879979;5107.259447380109;5124.538791508782;5135.101357262464;10541.525631346607;10565.524551395205;10572.312799667998;10606.522706478227;10625.25623206368;5647.519960803295;5663.716814159276;5672.801451949162;5674.77300907959;5675.5459563234845;4581.839635612804;4937.506249375034;5154.14956532168;5155.639105262596;5238.869028274324;4184.644305234089;4232.91534169321;4273.55127711592;4280.978595107004;4300.720453170597;1321.3063141850605;1395.5603984744773;1400.4748219417718;1407.9577612671637;1412.0821466047153;906.8277027364779;1026.645807196516;1046.5238316565944;1052.1845569683555;1058.1481907064733;6085.421884920926;6232.283287422005;6257.311695713468;6289.465395441347;6399.552031357854;478.3040675816678;494.1771949703703;496.79383056032066;497.09032470578757;519.2444992535851;4239.27932251518;4258.659307255412;4275.337322714984;4297.591728785823;4398.47218333802;10767.6231331903;11064.612738554111;11093.500792464358;11145.331280123219;11188.888111118948;10510.737231569272;10931.508082136323;10958.232923695265;11030.889691103146;11281.379524126252;8414.410991230678;8491.787705307417;8579.356548258906;8634.568271586395;8636.481811091355;5874.530037597067;5945.583809133319;5985.491233245223;6128.233970753656;6201.751929922752;9747.415155090717;10018.39889606626;10059.74850628711;10185.541650625592;10205.795884082128;10262.230332725225;10278.17774578017;10344.844827327746;10349.172066234834;10453;7594.468387213063;7799.298063174341;7817.5309481431295;7926.722564710208;8059.919400805917;8909.955450222707;8946.150115738994;8951.507667078373;8956.820863582821;8977.057408971963;7438.218987006287;7445.702171913063;7522.511036782592;7649.88525172134;7744.845103097794;7629.084509858631;7681.7695469136015;7700.268474494914;7796.259355361231;7904.20957904205;7202.351788339075;7286.271372862883;7305.780826575211;7307.671154798153;7479.102507699111;5234.13636749932;5342.118550439134;5381.11211650089;5406.83779486616;5422.430644782399;5502.147167189092;5524.392316845224;5534.225208470737;5558.861028474159;5634.985702573576 21:21:27 INFO - PROCESS | 23316 | |4;prototype.html;347.89563131060675;353.2687337211971;363.7581008629261;365.7531166462637;368.2689860626657;5526.889462210754;5653.802116925908;5688.5823525001915;5692.260006199199;5721.227634269368;5610.186522954169;5619.915701264474;5621.971890140544;5633.380328163909;5638.844036972411;3979.7612143271353;4279.87160385189;4464.866054018368;4470.865874023776;4471.4857791353925;4366.214081465335;4399.5820397062225;4422.491413487458;4427.601515863572;4437.4675038995365;4383.495897971727;4391.187630288391;4393.758343291118;4405.207062728708;4410.669199810011;4378.78106094694;4390;4400.185965596375;4403.141387429452;4414.315781053958;3751.4747935289083;3767.7550959187565;3805.334066538345;3818.9045273868096;3823.885283441501;5435.374931882845;5439.782408703647;5452.700101494416;5472.72636368184;5473.972630136824;5007.4992500749995;5035.521625445614;5040.143175660147;5040.253062081175;5041.117804384218;5711.600187986843;5754.97122514389;5808.82573522795;5819.476247137778;5856.502197313191;4195.286801243766;4213.768242746648;4219.4598971375535;4234.428352172448;4249.320108782611;5894.616849904743;6115.205023346936;6146.17026701394;6156.722947467375;6175.166352542395;4343.630791382705;4357.694961352739;4372.846950356722;4387.846425375161;4406.691531592758;4430.867073987785;4434.7117437367115;4445.977770111129;4454.532274111237;4466.7766611669285;4868.732219727949;5017.648764586517;5033.546980771748;5055.241713742895;5081.74591270435;5900.527957763368;5915.733791979371;5921.7860338631335;5926.7925622603;5939.168516407706;1471.3526048538608;1480.6446452851237;1485.6211666025094;1486.5540337898587;1488.6873756511038;974.70758772368;1013.8276492996208;1025.9176568720072;1046.7383154211448;1046.7801761629992;5461.672299662033;5472.753726082336;5517.668939863621;5595.300587426572;5597.80407685729;5867.647941123546;5873.970630146908;5879.265091863517;5905.793297234576;5906.497947674496;5417.4311697272005;5451.746098397391;5498.890022199534;5579.80034292629;5587.608867379326;3103.6430810456636;3115.7195852373397;3120.828354440482;3124.562561241428;3136.9843150784554;5914;6079.787207447718;6085.756569737249;6089.878202435926;6116.226294374582;5909.763609455574;5918.201042859245;5920.703964801743;5933.042096108274;5991;6091.8172454825535;6106.389361063858;6120.265568131764;6149.754009839557;6157.907631385533;5694.259746232963;5826.679532625746;5841.591088623755;5849.338550959218;5873.500752436091;5761;5830.76676932918;5834;5837.147482661423;5847.210626565359;6222.62664240147;6378.2346118466085;6389.840253993687;6391.456726178141;6397.264314603694;4407.449068866392;4414.668899832461;4418.513963463952;4423.225935461346;4437.933430998473;6030.427109424598;6116.204893363834;6181.227346581677;6185.752569897154;6190.876182476415;5983.640981541122;6002.0996850472775;6009.65623406863;6026.638401695912;6027.397260273938;5803.3616302207565;5927.644341339534;6015.729292181775;6019.458248757633;6038.698065096815;5891.941080589139;5909.202257695156;5925.229720136354;5926.644401335933;5962.4633782959745;6063.848403789941;6072;6083.209182806384;6095.512359011357;6099.359567245553;5755.1367294906095;5826.883462330645;5855.180274761452;5874.530037597067;5895.492182151613 21:21:27 INFO - PROCESS | 23316 | |5;yui.html;750.6359415683389;756.5702810047173;791.3194652598768;837.6984285657164;857.6912311567836;14618;15125.697486050287;15130.319135638894;15292.2353882306;15385.999910005856;13355.866441335584;13735;13780.517681881136;13810.585682429519;13811.861881381183;811.0429692962302;826.2357319479487;839.9244068033876;840.0926998841237;843.3000609494105;829.9668013279462;831.9750407487785;833.9249467547919;834.7161964931922;834.9791255218638;862.6463150108457;862.6894318045498;863.1066845814584;863.8099618084011;864.7794812322849;856.9014563325235;857.3355649371756;857.6697971281039;857.8412993596143;859.866720658299;630.224823467138;635.6503922842418;635.7615894039735;635.8060791458603;637.716216283754;12820.35898205086;13161.802572961413;13179.538716144889;13191.670208244775;13223.867761322359;12684.936575317064;12691.809622855664;12699.619011429671;12815.16701414405;13196.274204918725;10619.41593212373;10932.234743567953;10952.726181845437;11215.158863085302;11234.943825280903;3716.1267102230954;3781.68590638712;3789.8673546425744;3811.7522361046445;3948.072203032285;63764;63918.680406598134;64445.677771611314;64981.67509162471;66800.3319966799;10475.266731328886;10911.127109831194;10939.28894621847;11119.722006949729;11505.884941150649;19858;20012.59974800496;20037.499062523555;20073.197072116953;20140.597188056156;7878.1334053254095;7918.485298455582;8147.75556733299;8161.551114688749;8342.66629334832;4559.042601053749;4563.292689633112;4566.49768525462;4643.141018911512;4687.648426368036;3422.5892892853017;3459.965400345964;3476.617572067071;3478.530398396184;3488.162840918212;616.7695447582103;618.4619381138349;625.2840497630187;627.8775638750491;644.2172760096505;551.6552154903186;603.8701679139007;644.458654730029;715.6994062493661;720.6360787802126;8878.644854205759;9143.857017872766;9155.771105722277;9305.395149315409;9585.424874507551;577.3591313641854;603.0020316376404;647.2007071266981;660.7191943424026;676.648142965665;4293.892652683708;4403.647708183337;4416.712913660602;4516.909661806745;4810.5670489656095;88803.55598222096;89360.5531972336;90749;92907;97241;79575;80102;81242.97046850254;81552;82735.586322068;72080;73292;73742.26257737461;73893.630531847;75858.62070689611;9878.851817222603;10280.280380373302;10362.637307694195;10374.948125259325;10481.685549433529;47185.29222061603;47261.2910806345;47538.28692569683;47633;48587;61893.690531548855;65027.34972650213;66603.33396665972;67211.32788672051;67934;12911.5480958166;13403.463861445824;13426.530071447452;13553.86446135526;13623.455061797416;15214.641730531785;15251.313690883715;15512.767308490156;15521.223938803241;16359.754603681193;13049;13122.212667239995;13393.464261429433;13553.864461355655;13575.592732218049;12324.198927069712;12675.80986285225;13487.730245395234;13496.392662330023;13497.987650926416;11968.521259149884;12168.391580421121;12998.220106793622;13033.15284506504;13055.804162937373;11205.887941120485;11405.600803971822;11421.257618254787;11562.653120406401;11850.288982661068;10356.741081472723;10936.940164815376;11194.776104477702;11252.887471125512;11370.886291137314 21:21:27 INFO - PROCESS | 23316 | __end_tp_report 21:21:27 INFO - PROCESS | 23316 | __start_cc_report 21:21:27 INFO - PROCESS | 23316 | _x_x_mozilla_cycle_collect,313 21:21:27 INFO - PROCESS | 23316 | __end_cc_report 21:21:27 INFO - PROCESS | 23316 | __startTimestamp1483420887235__endTimestamp 21:21:27 INFO - PROCESS | 23316 | 21:21:27 INFO - PROCESS | 23316 | ------- Summary: start ------- 21:21:27 INFO - PROCESS | 23316 | Number of tests: 6 21:21:27 INFO - PROCESS | 23316 | 21:21:27 INFO - PROCESS | 23316 | [#0] dojo.html Cycles:165 Average:5783.84 Median:6016.70 stddev:658.42 (10.9%) stddev-sans-first:630.94 21:21:27 INFO - PROCESS | 23316 | Values: 3299.7 3344.6 3351.1 3362.5 3368.8 5753.1 5811.5 5829.8 5847.2 5866.3 5780.3 5816.3 5840.5 5865.1 5878.6 5269.4 5286.3 5324.4 5330.5 5359.6 5366.6 5369.6 5373.0 5374.2 5382.8 5138.7 5145.5 5324.5 5369.5 5373.0 5251.1 5289.1 5350.3 5371.7 5431.2 5276.6 5355.5 5360.8 5363.8 5368.0 5497.8 5787.7 5848.9 5884.4 5925.9 5970.5 6082.0 6096.8 6102.7 6113.8 6176.8 6195.1 6205.4 6291.9 6330.3 5851.9 5853.0 5881.4 5882.3 5918.3 6312.7 6334.7 6381.8 6436.6 6462.2 6187.0 6192.9 6197.7 6206.4 6212.8 5995.5 6041.9 6300.6 6311.4 6317.6 6092.5 6116.1 6123.9 6204.9 6207.9 6080.6 6185.2 6194.6 6195.9 6197.0 4627.1 4760.6 4760.8 4761.1 4768.1 4147.0 4157.8 4167.1 4252.3 4255.9 5879.4 5922.7 5951.9 5961.7 5965.7 6217.1 6219.1 6228.6 6230.3 6241.3 5800.7 5859.1 5918.6 5945.8 5971.2 5411.1 5432.0 5434.4 5436.2 5450.6 6499.3 6506.4 6510.0 6553.0 6570.7 6026.5 6079.2 6140.8 6145.5 6288.7 6445.2 6461.8 6472.1 6490.8 6491.7 6097.4 6134.7 6146.2 6162.8 6173.6 5923.9 6032.4 6140.4 6234.3 6269.4 6043.5 6104.4 6124.6 6132.3 6132.4 6080.9 6094.1 6094.8 6100.7 6136.0 5718.6 5769.8 6007.0 6043.9 6083.0 6081.5 6131.8 6152.1 6220.2 6228.7 6006.5 6016.7 6023.5 6025.3 6040.5 21:21:27 INFO - PROCESS | 23316 | 21:21:27 INFO - PROCESS | 23316 | [#1] ext.html Cycles:180 Average:61782.74 Median:43459.67 stddev:121210.93 (278.9%) stddev-sans-first:121463.80 21:21:27 INFO - PROCESS | 23316 | Values: 563.3 585.4 613.9 622.3 634.2 44655.8 45829.3 45853.5 48459.3 48504.0 45116.8 45296.0 45693.1 45713.8 45734.3 8694.7 8814.6 8831.1 8836.2 8839.4 8669.3 8792.4 8830.1 8839.4 8849.4 8828.2 8846.0 8887.1 8888.6 8904.4 8764.8 8780.4 8833.3 8834.0 8860.2 8606.2 8615.8 8717.7 8720.5 8742.1 43051.0 43451.3 43468.0 43510.0 43533.3 3611.0 3850.2 4003.8 4119.3 4460.0 31963.4 32577.0 32603.8 32705.5 32840.5 4464.1 4558.8 4563.2 4569.4 4617.7 361747.0 363571.0 363884.0 363995.0 364248.0 61044.7 61223.4 61337.4 61484.4 61585.0 65267.3 65299.7 65346.7 65466.0 65489.7 17503.6 17534.3 17661.6 17662.1 17739.3 12819.0 12952.7 12969.2 13016.3 13032.5 17299.8 18001.9 18073.7 18083.1 18173.0 5855.3 5895.4 6113.4 6120.8 6170.8 1033.3 1072.8 1130.6 1138.0 1180.7 32642.7 32891.8 33238.7 33523.7 35985.5 1178.3 1183.8 1185.9 1241.3 1243.9 16911.2 17167.8 17203.6 17241.2 17286.4 532952.0 534147.0 534582.0 536334.0 537756.0 60023.4 60182.0 60244.7 60297.7 60299.1 1433.0 1436.3 1448.1 1449.0 1452.3 31257.8 31789.0 31835.0 32709.5 33109.3 52298.0 52831.7 52864.7 53020.0 53094.5 455411.0 456240.0 457045.0 458227.0 459494.0 29983.6 30018.2 30037.2 30046.8 30316.5 47217.0 47651.0 48504.8 48559.5 48753.0 40547.8 40582.0 40584.2 41865.0 42779.0 40940.4 41350.6 41912.8 42357.8 42952.8 36095.3 36492.6 39947.2 40476.6 42084.6 35354.3 36479.1 36825.8 37036.8 37519.6 28774.4 28824.6 28861.4 29077.0 29249.6 21:21:27 INFO - PROCESS | 23316 | 21:21:27 INFO - PROCESS | 23316 | [#2] jquery.html Cycles:180 Average:29746.14 Median:14852.91 stddev:73846.59 (497.2%) stddev-sans-first:74020.93 21:21:27 INFO - PROCESS | 23316 | Values: 423.2 425.4 431.0 440.9 444.3 18938.8 19618.2 19957.5 20168.7 20530.3 16645.5 18871.2 19327.1 19453.1 19657.3 5101.9 5326.3 5332.5 5340.8 5345.7 4445.6 4673.8 5280.3 5345.1 5348.1 6361.1 6420.3 6478.0 6489.6 6498.7 6410.9 6495.2 7121.3 7428.7 7450.3 7144.9 7169.0 7178.9 7308.3 7354.7 26943.3 27007.3 27052.5 27295.0 27872.2 2501.9 2654.6 2685.9 2698.5 2749.4 15654.4 16617.7 16913.3 16917.7 17474.7 2084.0 2085.5 2126.5 2222.3 2259.9 79799.2 86438.0 96444.0 97907.5 101500.5 18131.7 19251.6 19515.5 19658.5 19742.8 35291.0 35412.3 35519.0 35804.1 36019.5 10119.1 10350.7 10500.7 10708.0 10771.0 8497.7 8534.3 8735.6 8823.2 8829.4 9194.6 9647.2 9652.8 9705.0 9745.0 3444.5 3462.6 3512.0 3735.9 3765.7 940.6 974.7 987.8 1022.8 1030.2 19144.9 19982.8 20125.6 20131.2 20217.3 1013.7 1018.0 1026.8 1047.6 1080.2 10934.5 11278.1 11404.9 11418.9 11515.5 358809.0 366244.0 366844.0 538401.0 543659.0 97729.0 102413.0 102785.0 106697.0 107522.0 1054.5 1075.8 1078.8 1102.8 1118.3 17923.8 18160.4 18375.6 18538.1 18688.7 42403.4 42724.8 43488.8 43621.6 44186.0 56629.0 59053.4 60672.7 62057.7 63036.0 6448.7 7055.4 8020.8 8349.5 8695.2 12760.7 13727.5 13881.1 14060.0 14074.0 12162.3 12188.2 12219.9 12364.1 12450.5 11943.9 12334.5 12472.3 12507.9 12531.9 12147.9 12249.9 12302.1 12405.4 12578.7 7957.7 8048.7 8072.3 8318.9 8394.4 8926.6 11692.7 12067.3 12149.4 12186.6 21:21:27 INFO - PROCESS | 23316 | 21:21:27 INFO - PROCESS | 23316 | [#3] mootools.html Cycles:180 Average:5970.44 Median:4865.65 stddev:3325.58 (68.3%) stddev-sans-first:3317.49 21:21:27 INFO - PROCESS | 23316 | Values: 1441.8 1510.4 1657.6 1848.2 1862.0 8054.1 8270.4 8576.7 9107.6 9113.0 8574.1 8808.7 8811.9 8967.4 9043.4 2517.7 2530.2 2539.7 2541.4 2544.3 2405.4 2444.6 2446.7 2448.6 2456.9 2384.9 2402.7 2405.1 2406.5 2423.5 2454.1 2459.9 2480.3 2483.2 2486.9 2387.3 2392.7 2393.4 2402.3 2410.1 8925.0 8943.2 9064.1 9092.2 9114.1 5614.9 5697.5 5705.0 5723.0 5756.7 3586.5 3625.6 3699.7 3706.7 3755.2 1199.7 1221.1 1228.6 1231.5 1270.8 12545.7 12654.0 12665.9 12697.0 12709.2 4793.8 5013.1 5107.3 5124.5 5135.1 10541.5 10565.5 10572.3 10606.5 10625.3 5647.5 5663.7 5672.8 5674.8 5675.5 4581.8 4937.5 5154.1 5155.6 5238.9 4184.6 4232.9 4273.6 4281.0 4300.7 1321.3 1395.6 1400.5 1408.0 1412.1 906.8 1026.6 1046.5 1052.2 1058.1 6085.4 6232.3 6257.3 6289.5 6399.6 478.3 494.2 496.8 497.1 519.2 4239.3 4258.7 4275.3 4297.6 4398.5 10767.6 11064.6 11093.5 11145.3 11188.9 10510.7 10931.5 10958.2 11030.9 11281.4 8414.4 8491.8 8579.4 8634.6 8636.5 5874.5 5945.6 5985.5 6128.2 6201.8 9747.4 10018.4 10059.7 10185.5 10205.8 10262.2 10278.2 10344.8 10349.2 10453.0 7594.5 7799.3 7817.5 7926.7 8059.9 8910.0 8946.2 8951.5 8956.8 8977.1 7438.2 7445.7 7522.5 7649.9 7744.8 7629.1 7681.8 7700.3 7796.3 7904.2 7202.4 7286.3 7305.8 7307.7 7479.1 5234.1 5342.1 5381.1 5406.8 5422.4 5502.1 5524.4 5534.2 5558.9 5635.0 21:21:27 INFO - PROCESS | 23316 | 21:21:27 INFO - PROCESS | 23316 | [#4] prototype.html Cycles:180 Average:4954.50 Median:5615.05 stddev:1450.81 (25.8%) stddev-sans-first:1413.08 21:21:27 INFO - PROCESS | 23316 | Values: 347.9 353.3 363.8 365.8 368.3 5526.9 5653.8 5688.6 5692.3 5721.2 5610.2 5619.9 5622.0 5633.4 5638.8 3979.8 4279.9 4464.9 4470.9 4471.5 4366.2 4399.6 4422.5 4427.6 4437.5 4383.5 4391.2 4393.8 4405.2 4410.7 4378.8 4390.0 4400.2 4403.1 4414.3 3751.5 3767.8 3805.3 3818.9 3823.9 5435.4 5439.8 5452.7 5472.7 5474.0 5007.5 5035.5 5040.1 5040.3 5041.1 5711.6 5755.0 5808.8 5819.5 5856.5 4195.3 4213.8 4219.5 4234.4 4249.3 5894.6 6115.2 6146.2 6156.7 6175.2 4343.6 4357.7 4372.8 4387.8 4406.7 4430.9 4434.7 4446.0 4454.5 4466.8 4868.7 5017.6 5033.5 5055.2 5081.7 5900.5 5915.7 5921.8 5926.8 5939.2 1471.4 1480.6 1485.6 1486.6 1488.7 974.7 1013.8 1025.9 1046.7 1046.8 5461.7 5472.8 5517.7 5595.3 5597.8 5867.6 5874.0 5879.3 5905.8 5906.5 5417.4 5451.7 5498.9 5579.8 5587.6 3103.6 3115.7 3120.8 3124.6 3137.0 5914.0 6079.8 6085.8 6089.9 6116.2 5909.8 5918.2 5920.7 5933.0 5991.0 6091.8 6106.4 6120.3 6149.8 6157.9 5694.3 5826.7 5841.6 5849.3 5873.5 5761.0 5830.8 5834.0 5837.1 5847.2 6222.6 6378.2 6389.8 6391.5 6397.3 4407.4 4414.7 4418.5 4423.2 4437.9 6030.4 6116.2 6181.2 6185.8 6190.9 5983.6 6002.1 6009.7 6026.6 6027.4 5803.4 5927.6 6015.7 6019.5 6038.7 5891.9 5909.2 5925.2 5926.6 5962.5 6063.8 6072.0 6083.2 6095.5 6099.4 5755.1 5826.9 5855.2 5874.5 5895.5 21:21:27 INFO - PROCESS | 23316 | 21:21:27 INFO - PROCESS | 23316 | [#5] yui.html Cycles:180 Average:18409.79 Median:4604.82 stddev:24763.52 (537.8%) stddev-sans-first:24797.49 21:21:27 INFO - PROCESS | 23316 | Values: 750.6 756.6 791.3 837.7 857.7 14618.0 15125.7 15130.3 15292.2 15386.0 13355.9 13735.0 13780.5 13810.6 13811.9 811.0 826.2 839.9 840.1 843.3 830.0 832.0 833.9 834.7 835.0 862.6 862.7 863.1 863.8 864.8 856.9 857.3 857.7 857.8 859.9 630.2 635.7 635.8 635.8 637.7 12820.4 13161.8 13179.5 13191.7 13223.9 12684.9 12691.8 12699.6 12815.2 13196.3 10619.4 10932.2 10952.7 11215.2 11234.9 3716.1 3781.7 3789.9 3811.8 3948.1 63764.0 63918.7 64445.7 64981.7 66800.3 10475.3 10911.1 10939.3 11119.7 11505.9 19858.0 20012.6 20037.5 20073.2 20140.6 7878.1 7918.5 8147.8 8161.6 8342.7 4559.0 4563.3 4566.5 4643.1 4687.6 3422.6 3460.0 3476.6 3478.5 3488.2 616.8 618.5 625.3 627.9 644.2 551.7 603.9 644.5 715.7 720.6 8878.6 9143.9 9155.8 9305.4 9585.4 577.4 603.0 647.2 660.7 676.6 4293.9 4403.6 4416.7 4516.9 4810.6 88803.6 89360.6 90749.0 92907.0 97241.0 79575.0 80102.0 81243.0 81552.0 82735.6 72080.0 73292.0 73742.3 73893.6 75858.6 9878.9 10280.3 10362.6 10374.9 10481.7 47185.3 47261.3 47538.3 47633.0 48587.0 61893.7 65027.3 66603.3 67211.3 67934.0 12911.5 13403.5 13426.5 13553.9 13623.5 15214.6 15251.3 15512.8 15521.2 16359.8 13049.0 13122.2 13393.5 13553.9 13575.6 12324.2 12675.8 13487.7 13496.4 13498.0 11968.5 12168.4 12998.2 13033.2 13055.8 11205.9 11405.6 11421.3 11562.7 11850.3 10356.7 10936.9 11194.8 11252.9 11370.9 21:21:27 INFO - PROCESS | 23316 | -------- Summary: end -------- 21:21:27 INFO - PROCESS | 23316 | 21:21:27 INFO - TEST-INFO | 23316: exit 0 21:21:27 INFO - TEST-OK | dromaeo_css | took 1113080ms 21:21:27 INFO - TEST-START | kraken 21:21:27 INFO - operating with platform_type : linux_ 21:21:27 INFO - Initialising browser for kraken test... 21:21:27 INFO - TEST-INFO | started process 23687 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvZ6nxg/profile http://localhost:59657/getInfo.html) 21:21:32 INFO - PROCESS | 23687 | __metrics Screen width/height:1600/1200 21:21:32 INFO - PROCESS | 23687 | colorDepth:24 21:21:32 INFO - PROCESS | 23687 | Browser inner width/height: 1024/697 21:21:32 INFO - PROCESS | 23687 | __metrics 21:21:32 ERROR - PROCESS | 23687 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3175: TypeError: this.tabs is undefined 21:21:33 INFO - TEST-INFO | 23687: exit 0 21:21:33 INFO - Browser initialized. 21:21:33 INFO - Running cycle 1/1 for kraken test... 21:21:33 INFO - TEST-INFO | started process 23818 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvZ6nxg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:21:45 INFO - PROCESS | 23818 | RSS: Main: 152117248 21:21:45 INFO - PROCESS | 23818 | 21:21:47 INFO - PROCESS | 23818 | Cycle 1(1): loaded http://localhost:59657/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59657/tests/kraken/driver.html?testName=audio-beat-detection) 21:21:48 INFO - PROCESS | 23818 | RSS: Main: 156766208 21:21:48 INFO - PROCESS | 23818 | 21:21:51 INFO - PROCESS | 23818 | Cycle 1(1): loaded http://localhost:59657/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59657/tests/kraken/driver.html?testName=audio-dft) 21:21:51 INFO - PROCESS | 23818 | RSS: Main: 155496448 21:21:51 INFO - PROCESS | 23818 | 21:21:54 INFO - PROCESS | 23818 | Cycle 1(1): loaded http://localhost:59657/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59657/tests/kraken/driver.html?testName=audio-fft) 21:21:55 INFO - PROCESS | 23818 | RSS: Main: 155504640 21:21:55 INFO - PROCESS | 23818 | 21:21:57 INFO - PROCESS | 23818 | Cycle 1(1): loaded http://localhost:59657/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59657/tests/kraken/driver.html?testName=audio-oscillator) 21:21:57 INFO - PROCESS | 23818 | RSS: Main: 155189248 21:21:57 INFO - PROCESS | 23818 | 21:22:00 INFO - PROCESS | 23818 | Cycle 1(1): loaded http://localhost:59657/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59657/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:22:00 INFO - PROCESS | 23818 | RSS: Main: 155164672 21:22:00 INFO - PROCESS | 23818 | 21:22:03 INFO - PROCESS | 23818 | Cycle 1(1): loaded http://localhost:59657/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59657/tests/kraken/driver.html?testName=imaging-darkroom) 21:22:04 INFO - PROCESS | 23818 | RSS: Main: 158089216 21:22:04 INFO - PROCESS | 23818 | 21:22:07 INFO - PROCESS | 23818 | Cycle 1(1): loaded http://localhost:59657/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59657/tests/kraken/driver.html?testName=imaging-desaturate) 21:22:08 INFO - PROCESS | 23818 | RSS: Main: 158494720 21:22:08 INFO - PROCESS | 23818 | 21:22:11 INFO - PROCESS | 23818 | Cycle 1(1): loaded http://localhost:59657/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59657/tests/kraken/driver.html?testName=json-parse-financial) 21:22:11 INFO - PROCESS | 23818 | RSS: Main: 158339072 21:22:11 INFO - PROCESS | 23818 | 21:22:13 INFO - PROCESS | 23818 | Cycle 1(1): loaded http://localhost:59657/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59657/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:22:13 INFO - PROCESS | 23818 | RSS: Main: 157667328 21:22:13 INFO - PROCESS | 23818 | 21:22:15 INFO - PROCESS | 23818 | Cycle 1(1): loaded http://localhost:59657/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59657/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:22:16 INFO - PROCESS | 23818 | RSS: Main: 157495296 21:22:16 INFO - PROCESS | 23818 | 21:22:18 INFO - PROCESS | 23818 | Cycle 1(1): loaded http://localhost:59657/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59657/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:22:18 INFO - PROCESS | 23818 | RSS: Main: 157933568 21:22:18 INFO - PROCESS | 23818 | 21:22:21 INFO - PROCESS | 23818 | Cycle 1(1): loaded http://localhost:59657/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59657/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:22:22 INFO - PROCESS | 23818 | RSS: Main: 157761536 21:22:22 INFO - PROCESS | 23818 | 21:22:24 INFO - PROCESS | 23818 | Cycle 1(1): loaded http://localhost:59657/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59657/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:22:25 INFO - PROCESS | 23818 | RSS: Main: 157900800 21:22:25 INFO - PROCESS | 23818 | 21:22:27 INFO - PROCESS | 23818 | Cycle 1(1): loaded http://localhost:59657/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59657/tests/kraken/driver.html?testName=ai-astar) 21:22:27 INFO - PROCESS | 23818 | RSS: Main: 159301632 21:22:27 INFO - PROCESS | 23818 | 21:22:27 INFO - PROCESS | 23818 | __start_tp_report 21:22:27 INFO - PROCESS | 23818 | _x_x_mozilla_page_load 21:22:27 INFO - PROCESS | 23818 | _x_x_mozilla_page_load_details 21:22:27 INFO - PROCESS | 23818 | |i|pagename|runs| 21:22:27 INFO - PROCESS | 23818 | |0;ai-astar;102;112;113;112;114;111;112;113;114;112 21:22:27 INFO - PROCESS | 23818 | |1;audio-beat-detection;155;118;122;168;123;118;117;120;146;118 21:22:27 INFO - PROCESS | 23818 | |2;audio-dft;162;163;164;163;167;162;163;163;162;160 21:22:27 INFO - PROCESS | 23818 | |3;audio-fft;75;75;75;113;76;75;76;75;96;75 21:22:27 INFO - PROCESS | 23818 | |4;audio-oscillator;82;82;116;81;82;82;93;81;82;119 21:22:27 INFO - PROCESS | 23818 | |5;imaging-gaussian-blur;118;118;117;117;117;118;118;117;117;120 21:22:27 INFO - PROCESS | 23818 | |6;imaging-darkroom;147;147;147;147;146;148;147;148;147;146 21:22:27 INFO - PROCESS | 23818 | |7;imaging-desaturate;85;85;85;86;85;87;85;85;86;85 21:22:27 INFO - PROCESS | 23818 | |8;json-parse-financial;52;52;57;52;52;53;52;51;52;51 21:22:27 INFO - PROCESS | 23818 | |9;json-stringify-tinderbox;60;61;60;59;59;60;60;61;60;59 21:22:27 INFO - PROCESS | 23818 | |10;stanford-crypto-aes;75;74;76;74;75;74;74;75;74;74 21:22:27 INFO - PROCESS | 23818 | |11;stanford-crypto-ccm;122;134;129;122;125;119;133;120;161;119 21:22:27 INFO - PROCESS | 23818 | |12;stanford-crypto-pbkdf2;155;157;158;153;156;156;159;156;158;153 21:22:27 INFO - PROCESS | 23818 | |13;stanford-crypto-sha256-iterative;63;63;63;68;63;64;63;63;61;61 21:22:27 INFO - PROCESS | 23818 | __end_tp_report 21:22:27 INFO - PROCESS | 23818 | __start_cc_report 21:22:27 INFO - PROCESS | 23818 | _x_x_mozilla_cycle_collect,789 21:22:27 INFO - PROCESS | 23818 | __end_cc_report 21:22:27 INFO - PROCESS | 23818 | __startTimestamp1483420947321__endTimestamp 21:22:27 INFO - PROCESS | 23818 | 21:22:27 INFO - PROCESS | 23818 | ------- Summary: start ------- 21:22:27 INFO - PROCESS | 23818 | Number of tests: 14 21:22:27 INFO - PROCESS | 23818 | 21:22:27 INFO - PROCESS | 23818 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.50 stddev:3.47 (3.1%) stddev-sans-first:1.01 21:22:27 INFO - PROCESS | 23818 | Values: 102.0 112.0 113.0 112.0 114.0 111.0 112.0 113.0 114.0 112.0 21:22:27 INFO - PROCESS | 23818 | 21:22:27 INFO - PROCESS | 23818 | [#1] audio-beat-detection Cycles:10 Average:130.50 Median:122.50 stddev:18.67 (15.2%) stddev-sans-first:17.57 21:22:27 INFO - PROCESS | 23818 | Values: 155.0 118.0 122.0 168.0 123.0 118.0 117.0 120.0 146.0 118.0 21:22:27 INFO - PROCESS | 23818 | 21:22:27 INFO - PROCESS | 23818 | [#2] audio-dft Cycles:10 Average:162.90 Median:163.00 stddev:1.79 (1.1%) stddev-sans-first:1.87 21:22:27 INFO - PROCESS | 23818 | Values: 162.0 163.0 164.0 163.0 167.0 162.0 163.0 163.0 162.0 160.0 21:22:27 INFO - PROCESS | 23818 | 21:22:27 INFO - PROCESS | 23818 | [#3] audio-fft Cycles:10 Average:81.10 Median:75.00 stddev:12.97 (17.3%) stddev-sans-first:13.57 21:22:27 INFO - PROCESS | 23818 | Values: 75.0 75.0 75.0 113.0 76.0 75.0 76.0 75.0 96.0 75.0 21:22:27 INFO - PROCESS | 23818 | 21:22:27 INFO - PROCESS | 23818 | [#4] audio-oscillator Cycles:10 Average:90.00 Median:82.00 stddev:14.94 (18.2%) stddev-sans-first:15.56 21:22:27 INFO - PROCESS | 23818 | Values: 82.0 82.0 116.0 81.0 82.0 82.0 93.0 81.0 82.0 119.0 21:22:27 INFO - PROCESS | 23818 | 21:22:27 INFO - PROCESS | 23818 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.95 (0.8%) stddev-sans-first:1.00 21:22:27 INFO - PROCESS | 23818 | Values: 118.0 118.0 117.0 117.0 117.0 118.0 118.0 117.0 117.0 120.0 21:22:27 INFO - PROCESS | 23818 | 21:22:27 INFO - PROCESS | 23818 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 21:22:27 INFO - PROCESS | 23818 | Values: 147.0 147.0 147.0 147.0 146.0 148.0 147.0 148.0 147.0 146.0 21:22:27 INFO - PROCESS | 23818 | 21:22:27 INFO - PROCESS | 23818 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.00 stddev:0.70 (0.8%) stddev-sans-first:0.73 21:22:27 INFO - PROCESS | 23818 | Values: 85.0 85.0 85.0 86.0 85.0 87.0 85.0 85.0 86.0 85.0 21:22:27 INFO - PROCESS | 23818 | 21:22:27 INFO - PROCESS | 23818 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:52.00 stddev:1.71 (3.3%) stddev-sans-first:1.81 21:22:27 INFO - PROCESS | 23818 | Values: 52.0 52.0 57.0 52.0 52.0 53.0 52.0 51.0 52.0 51.0 21:22:27 INFO - PROCESS | 23818 | 21:22:27 INFO - PROCESS | 23818 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.00 stddev:0.74 (1.2%) stddev-sans-first:0.78 21:22:27 INFO - PROCESS | 23818 | Values: 60.0 61.0 60.0 59.0 59.0 60.0 60.0 61.0 60.0 59.0 21:22:27 INFO - PROCESS | 23818 | 21:22:27 INFO - PROCESS | 23818 | [#10] stanford-crypto-aes Cycles:10 Average:74.50 Median:74.50 stddev:0.71 (0.9%) stddev-sans-first:0.73 21:22:27 INFO - PROCESS | 23818 | Values: 75.0 74.0 76.0 74.0 75.0 74.0 74.0 75.0 74.0 74.0 21:22:27 INFO - PROCESS | 23818 | 21:22:27 INFO - PROCESS | 23818 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:127.00 stddev:12.72 (10.0%) stddev-sans-first:13.28 21:22:27 INFO - PROCESS | 23818 | Values: 122.0 134.0 129.0 122.0 125.0 119.0 133.0 120.0 161.0 119.0 21:22:27 INFO - PROCESS | 23818 | 21:22:27 INFO - PROCESS | 23818 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.10 Median:156.50 stddev:2.02 (1.3%) stddev-sans-first:2.11 21:22:27 INFO - PROCESS | 23818 | Values: 155.0 157.0 158.0 153.0 156.0 156.0 159.0 156.0 158.0 153.0 21:22:27 INFO - PROCESS | 23818 | 21:22:27 INFO - PROCESS | 23818 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.00 stddev:1.93 (3.1%) stddev-sans-first:2.05 21:22:27 INFO - PROCESS | 23818 | Values: 63.0 63.0 63.0 68.0 63.0 64.0 63.0 63.0 61.0 61.0 21:22:27 INFO - PROCESS | 23818 | -------- Summary: end -------- 21:22:27 INFO - PROCESS | 23818 | 21:22:28 INFO - TEST-INFO | 23818: exit 0 21:22:28 INFO - TEST-OK | kraken | took 60323ms 21:22:28 INFO - SUITE-END | took 1173s 21:22:28 INFO - Completed test suite (00:19:33) 21:22:28 INFO - javascript benchmark 21:22:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7594.379077329885, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3299.65353637868, 3344.598648162221, 3351.0617027232374, 3362.4788157835515, 3368.814715190665, 5753.108268218428, 5811.535077193825, 5829.795957141496, 5847.1521629363715, 5866.325372582154, 5780.306363236417, 5816.272965879265, 5840.53275737941, 5865.090910908816, 5878.617889837157, 5269.394019687747, 5286.31277933869, 5324.387695415038, 5330.520253177213, 5359.5712343012665, 5366.6243362964415, 5369.5972802039805, 5373.032854086263, 5374.193870919374, 5382.838514844561, 5138.743062846861, 5145.485451454862, 5324.520793128618, 5369.543588794957, 5373.0, 5251.081060814361, 5289.127293996486, 5350.3312085989255, 5371.677699338053, 5431.2396264522995, 5276.630635855492, 5355.518003379676, 5360.812371566976, 5363.758630861582, 5368.033753924292, 5497.752601132958, 5787.652740835563, 5848.941510584882, 5884.382139875294, 5925.911111333334, 5970.462658360725, 6081.996470582349, 6096.786612468542, 6102.664353460602, 6113.810786210604, 6176.7838125665385, 6195.070739389128, 6205.410486003822, 6291.905621415683, 6330.335314791972, 5851.8537036574, 5852.970735146382, 5881.411858814085, 5882.294124704978, 5918.348981612019, 6312.747490100344, 6334.714937827809, 6381.8085457436355, 6436.581622194636, 6462.159919210472, 6187.041008643668, 6192.907106393408, 6197.721102550396, 6206.441420272197, 6212.844678882973, 5995.46040856325, 6041.939580604226, 6300.621962682162, 6311.431971122621, 6317.557770955989, 6092.482139018144, 6116.113163591254, 6123.862238009563, 6204.875902481925, 6207.937920620826, 6080.604760690541, 6185.165002724664, 6194.566380353332, 6195.938040619626, 6196.969015154986, 4627.051454451829, 4760.571548560577, 4760.809567617256, 4761.142994260997, 4768.117898188846, 4146.979265103655, 4157.792110394468, 4167.1457351243525, 4252.340887162495, 4255.936160957588, 5879.353271140171, 5922.674252916045, 5951.880962380815, 5961.731722072517, 5965.701714914324, 6217.067439884054, 6219.0982307566055, 6228.626282423069, 6230.345813689588, 6241.282252541016, 5800.709964501758, 5859.121131830259, 5918.556108291896, 5945.791897283661, 5971.223740913741, 5411.080116380225, 5432.049391356576, 5434.402215756264, 5436.184572314184, 5450.645708028966, 6499.317571655098, 6506.414422701885, 6509.967450162719, 6553.049807777846, 6570.737170513126, 6026.548008899263, 6079.179310792986, 6140.811014692577, 6145.463634091477, 6288.6855657217875, 6445.16212892321, 6461.773837915651, 6472.126262954441, 6490.837729056811, 6491.707873145625, 6097.390260973867, 6134.6625935573975, 6146.231721034871, 6162.815115546541, 6173.59871608344, 5923.940760592339, 6032.426919442646, 6140.416660417253, 6234.2830574484515, 6269.404406581368, 6043.516518678583, 6104.4200800923845, 6124.625058545733, 6132.324915438686, 6132.447291485866, 6080.939190608037, 6094.14681944537, 6094.8171554853425, 6100.725467353891, 6135.969320153549, 5718.628289161191, 5769.798057067983, 6006.969965150146, 6043.909341359971, 6083.026715725463, 6081.513478921587, 6131.835460087213, 6152.107944347955, 6220.160278362544, 6228.719707613078, 6006.489448396936, 6016.699165041643, 6023.5181185505935, 6025.307089684742, 6040.546958978182], "value": 5739.037123822016, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.2681494750461, 585.3707264690457, 613.9324674285828, 622.3216693803753, 634.2294112653126, 44655.77672111639, 45829.31256031158, 45853.541464585345, 48459.27311090336, 48504.0, 45116.774416127875, 45296.0, 45693.08613827721, 45713.7714311428, 45734.313985290246, 8694.652213911451, 8814.603342849587, 8831.116888311182, 8836.204741573258, 8839.425437346585, 8669.349798765086, 8792.428492148021, 8830.116988301183, 8839.381243312971, 8849.380543361967, 8828.205461508463, 8846.02693703692, 8887.066857979917, 8888.644454221823, 8904.376693631448, 8764.824703505927, 8780.429272097294, 8833.33749968755, 8834.028256891768, 8860.24687901526, 8606.225439710455, 8615.82768344636, 8717.651293948235, 8720.52037137957, 8742.12578742127, 43051.0, 43451.34822977658, 43468.0, 43510.0, 43533.34699979503, 3610.963890361089, 3850.2107068051264, 4003.779792111433, 4119.299719047769, 4460.041091165415, 31963.360732785215, 32577.0, 32603.83698081518, 32705.50941735876, 32840.52217650211, 4464.084862603158, 4558.840440584564, 4563.201439748064, 4569.383133277031, 4617.722936623813, 361747.0, 363570.9999999974, 363884.0, 363995.0, 364248.0, 61044.69477652583, 61223.38776612177, 61337.38662613406, 61484.38515614876, 61585.0, 65267.34732652707, 65299.67350163314, 65346.67326663336, 65466.0, 65489.67255163693, 17503.562410939827, 17534.298628054734, 17661.558461038578, 17662.116894155242, 17739.290428382978, 12819.0, 12952.740945181044, 12969.157004794659, 13016.349182541024, 13032.47870085186, 17299.827001730075, 18001.909990449964, 18073.7288940666, 18083.09584520769, 18173.0, 5855.2973643163095, 5895.4399332063385, 6113.358097399709, 6120.785772497941, 6170.845728856725, 1033.3076838518211, 1072.7532667486366, 1130.5816847766214, 1138.038357587837, 1180.722530205401, 32642.673573264437, 32891.83554082262, 33238.66761332404, 33523.66476335254, 35985.46021809675, 1178.293024185482, 1183.7810005149074, 1185.9229150105216, 1241.2552468518998, 1243.9067069969788, 16911.23899424529, 17167.828321716624, 17203.569910752332, 17241.224144913507, 17286.394976175772, 532952.0, 534147.0, 534582.0, 536334.0, 537756.0, 60023.39976600266, 60182.0, 60244.69877650672, 60297.69851150716, 60299.09551356733, 1433.032702925521, 1436.3033928544648, 1448.1238850495508, 1448.9710205795825, 1452.2956366162614, 31257.8437107813, 31789.0, 31835.0, 32709.509357360133, 33109.33781324312, 52298.0, 52831.735841320544, 52864.73567632291, 53020.0, 53094.469055310496, 455411.0, 456240.0, 457045.0, 458227.0, 459494.0, 29983.55024674588, 30018.24954376158, 30037.249068773457, 30046.84976575103, 30316.5452518208, 47217.0, 47651.0, 48504.75747621239, 48559.5144048555, 48753.0, 40547.797261013504, 40582.0, 40584.18831623292, 41865.0, 42779.0, 40940.38589421221, 41350.58649413467, 41912.790436047624, 42357.788211058745, 42952.78523607362, 36095.27809443849, 36492.635073648926, 39947.20237589257, 40476.59523404728, 42084.57915420806, 35354.29291414106, 36479.088022799646, 36825.81587092047, 37036.81481592575, 37519.624803752704, 28774.42451151007, 28824.567631485126, 28861.422771544032, 29077.0, 29249.561256581594], "value": 20548.640619956812, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [423.2064878353088, 425.3577098581143, 430.9694867766304, 440.8611287444456, 444.349028672994, 18938.810611893878, 19618.215271389163, 19957.50106247341, 20168.69746953797, 20530.281440149596, 16645.50063498094, 18871.15079821408, 19327.130279137436, 19453.124609392577, 19657.311994080173, 5101.872453188681, 5326.254324394568, 5332.466753324676, 5340.813071542497, 5345.705986170759, 4445.599896009358, 4673.813047478096, 5280.287161233223, 5345.091334473149, 5348.117560602496, 6361.141245931809, 6420.26166990795, 6478.0, 6489.61062336259, 6498.70755815987, 6410.903836442457, 6495.220573531183, 7121.323474269936, 7428.702851885918, 7450.329470347695, 7144.8928266076055, 7169.045208082898, 7178.856422871513, 7308.342249197544, 7354.705811767523, 26943.32641683954, 27007.32481687954, 27052.45895082107, 27295.044673436532, 27872.16383508498, 2501.9374515637073, 2654.561997270448, 2685.9328516787236, 2698.5007773561756, 2749.3676454415595, 15654.373825046985, 16617.667646646998, 16913.323467061302, 16917.66164676712, 17474.7378789317, 2084.0, 2085.536802276219, 2126.5002724359765, 2222.311083564084, 2259.8870056497276, 79799.20200797975, 86438.0, 96444.0, 97907.51046244794, 101500.49249753704, 18131.72802407965, 19251.614967700567, 19515.51211219731, 19658.508537286398, 19742.802571974386, 35291.0, 35412.29175416477, 35519.0, 35804.10489737777, 36019.4597081044, 10119.139873110867, 10350.741231469274, 10500.684979450629, 10708.0, 10771.0, 8497.660093596187, 8534.317254619615, 8735.563221838882, 8823.205911467998, 8829.426087304304, 9194.63221471147, 9647.179989700953, 9652.806943861224, 9705.0, 9744.95127524372, 3444.4661077533024, 3462.6364231755806, 3511.9824400877833, 3735.9066023349633, 3765.6987441004653, 940.5908429833045, 974.7319487140951, 987.7925635616601, 1022.7596514819012, 1030.1964467715195, 19144.904275478813, 19982.800171998093, 20125.597488050156, 20131.19475221004, 20217.29239476611, 1013.716159475348, 1018.0481250031245, 1026.7997740440542, 1047.6490375724065, 1080.2345994254733, 10934.4532773361, 11278.139107047245, 11404.942975285236, 11418.942905285421, 11515.481803318871, 358809.0, 366244.0, 366844.0, 538401.0, 543659.0, 97729.0, 102413.0, 102785.0, 106697.0, 107522.0, 1054.4938429553856, 1075.8171110911164, 1078.800421921947, 1102.8014957307762, 1118.3345909184186, 17923.820761792736, 18160.364387246384, 18375.63248734991, 18538.144587339244, 18688.719669205246, 42403.363949540166, 42724.78637606792, 43488.78255608702, 43621.56378436175, 44186.0, 56629.0, 59053.40946590479, 60672.696636516535, 62057.68971155115, 63036.0, 6448.742050317935, 7055.400290975324, 8020.799480013046, 8349.499030058216, 8695.217430431292, 12760.74478510406, 13727.45090196381, 13881.097728647606, 14060.0, 14074.0, 12162.331071790783, 12188.20776649515, 12219.938900305442, 12364.134510584172, 12450.501979920702, 11943.880561194625, 12334.50661973547, 12472.251664900135, 12507.874921251036, 12531.874681253435, 12147.939260303641, 12249.877501224873, 12302.077344199042, 12405.379731013594, 12578.748425031632, 7957.681692732457, 8048.718294859652, 8072.313853322298, 8318.875216871631, 8394.412391132562, 8926.553672316488, 11692.70768230801, 12067.336296503776, 12149.392530373623, 12186.57346992851], "value": 10565.065604421012, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1441.7981482592436, 1510.4260381055196, 1657.5607464022028, 1848.196034724894, 1862.0317434933827, 8054.073781515113, 8270.421070525066, 8576.74269771907, 9107.635694572218, 9113.043130471297, 8574.099719529437, 8808.691695790649, 8811.911880881205, 8967.37228394011, 9043.412178208428, 2517.7356377580363, 2530.228280374485, 2539.7206307306274, 2541.4154744408797, 2544.3257536752776, 2405.4467472481338, 2444.584420648494, 2446.694163229596, 2448.571499987504, 2456.8648724320155, 2384.9284521464297, 2402.699662542182, 2405.0980882169188, 2406.5427568761966, 2423.5395274897714, 2454.067454367338, 2459.8770061496944, 2480.2807185916154, 2483.242611003643, 2486.8507889526686, 2387.271882075966, 2392.7009123859516, 2393.4375421775867, 2402.279316205149, 2410.0841680161425, 8924.955375223148, 8943.150400711922, 9064.13890680391, 9092.181703646704, 9114.13415725505, 5614.9438505615235, 5697.487226149625, 5705.001624715658, 5723.0, 5756.683382413966, 3586.4620306953907, 3625.619309972468, 3699.6670299672887, 3706.7034637229226, 3755.211405604799, 1199.724063465399, 1221.1451983611507, 1228.6314105768324, 1231.5258625429185, 1270.8474983002006, 12545.74908501834, 12654.0, 12665.873341266562, 12697.0, 12709.237445753284, 4793.784279707422, 5013.147764879979, 5107.259447380109, 5124.538791508782, 5135.101357262464, 10541.525631346607, 10565.524551395205, 10572.312799667998, 10606.522706478227, 10625.25623206368, 5647.519960803295, 5663.716814159276, 5672.801451949162, 5674.77300907959, 5675.5459563234845, 4581.839635612804, 4937.506249375034, 5154.14956532168, 5155.639105262596, 5238.869028274324, 4184.644305234089, 4232.91534169321, 4273.55127711592, 4280.978595107004, 4300.720453170597, 1321.3063141850605, 1395.5603984744773, 1400.4748219417718, 1407.9577612671637, 1412.0821466047153, 906.8277027364779, 1026.645807196516, 1046.5238316565944, 1052.1845569683555, 1058.1481907064733, 6085.421884920926, 6232.283287422005, 6257.311695713468, 6289.465395441347, 6399.552031357854, 478.3040675816678, 494.1771949703703, 496.79383056032066, 497.09032470578757, 519.2444992535851, 4239.27932251518, 4258.659307255412, 4275.337322714984, 4297.591728785823, 4398.47218333802, 10767.6231331903, 11064.612738554111, 11093.500792464358, 11145.331280123219, 11188.888111118948, 10510.737231569272, 10931.508082136323, 10958.232923695265, 11030.889691103146, 11281.379524126252, 8414.410991230678, 8491.787705307417, 8579.356548258906, 8634.568271586395, 8636.481811091355, 5874.530037597067, 5945.583809133319, 5985.491233245223, 6128.233970753656, 6201.751929922752, 9747.415155090717, 10018.39889606626, 10059.74850628711, 10185.541650625592, 10205.795884082128, 10262.230332725225, 10278.17774578017, 10344.844827327746, 10349.172066234834, 10453.0, 7594.468387213063, 7799.298063174341, 7817.5309481431295, 7926.722564710208, 8059.919400805917, 8909.955450222707, 8946.150115738994, 8951.507667078373, 8956.820863582821, 8977.057408971963, 7438.218987006287, 7445.702171913063, 7522.511036782592, 7649.88525172134, 7744.845103097794, 7629.084509858631, 7681.7695469136015, 7700.268474494914, 7796.259355361231, 7904.20957904205, 7202.351788339075, 7286.271372862883, 7305.780826575211, 7307.671154798153, 7479.102507699111, 5234.13636749932, 5342.118550439134, 5381.11211650089, 5406.83779486616, 5422.430644782399, 5502.147167189092, 5524.392316845224, 5534.225208470737, 5558.861028474159, 5634.985702573576], "value": 4751.357786708674, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.89563131060675, 353.2687337211971, 363.7581008629261, 365.7531166462637, 368.2689860626657, 5526.889462210754, 5653.802116925908, 5688.5823525001915, 5692.260006199199, 5721.227634269368, 5610.186522954169, 5619.915701264474, 5621.971890140544, 5633.380328163909, 5638.844036972411, 3979.7612143271353, 4279.87160385189, 4464.866054018368, 4470.865874023776, 4471.4857791353925, 4366.214081465335, 4399.5820397062225, 4422.491413487458, 4427.601515863572, 4437.4675038995365, 4383.495897971727, 4391.187630288391, 4393.758343291118, 4405.207062728708, 4410.669199810011, 4378.78106094694, 4390.0, 4400.185965596375, 4403.141387429452, 4414.315781053958, 3751.4747935289083, 3767.7550959187565, 3805.334066538345, 3818.9045273868096, 3823.885283441501, 5435.374931882845, 5439.782408703647, 5452.700101494416, 5472.72636368184, 5473.972630136824, 5007.4992500749995, 5035.521625445614, 5040.143175660147, 5040.253062081175, 5041.117804384218, 5711.600187986843, 5754.97122514389, 5808.82573522795, 5819.476247137778, 5856.502197313191, 4195.286801243766, 4213.768242746648, 4219.4598971375535, 4234.428352172448, 4249.320108782611, 5894.616849904743, 6115.205023346936, 6146.17026701394, 6156.722947467375, 6175.166352542395, 4343.630791382705, 4357.694961352739, 4372.846950356722, 4387.846425375161, 4406.691531592758, 4430.867073987785, 4434.7117437367115, 4445.977770111129, 4454.532274111237, 4466.7766611669285, 4868.732219727949, 5017.648764586517, 5033.546980771748, 5055.241713742895, 5081.74591270435, 5900.527957763368, 5915.733791979371, 5921.7860338631335, 5926.7925622603, 5939.168516407706, 1471.3526048538608, 1480.6446452851237, 1485.6211666025094, 1486.5540337898587, 1488.6873756511038, 974.70758772368, 1013.8276492996208, 1025.9176568720072, 1046.7383154211448, 1046.7801761629992, 5461.672299662033, 5472.753726082336, 5517.668939863621, 5595.300587426572, 5597.80407685729, 5867.647941123546, 5873.970630146908, 5879.265091863517, 5905.793297234576, 5906.497947674496, 5417.4311697272005, 5451.746098397391, 5498.890022199534, 5579.80034292629, 5587.608867379326, 3103.6430810456636, 3115.7195852373397, 3120.828354440482, 3124.562561241428, 3136.9843150784554, 5914.0, 6079.787207447718, 6085.756569737249, 6089.878202435926, 6116.226294374582, 5909.763609455574, 5918.201042859245, 5920.703964801743, 5933.042096108274, 5991.0, 6091.8172454825535, 6106.389361063858, 6120.265568131764, 6149.754009839557, 6157.907631385533, 5694.259746232963, 5826.679532625746, 5841.591088623755, 5849.338550959218, 5873.500752436091, 5761.0, 5830.76676932918, 5834.0, 5837.147482661423, 5847.210626565359, 6222.62664240147, 6378.2346118466085, 6389.840253993687, 6391.456726178141, 6397.264314603694, 4407.449068866392, 4414.668899832461, 4418.513963463952, 4423.225935461346, 4437.933430998473, 6030.427109424598, 6116.204893363834, 6181.227346581677, 6185.752569897154, 6190.876182476415, 5983.640981541122, 6002.0996850472775, 6009.65623406863, 6026.638401695912, 6027.397260273938, 5803.3616302207565, 5927.644341339534, 6015.729292181775, 6019.458248757633, 6038.698065096815, 5891.941080589139, 5909.202257695156, 5925.229720136354, 5926.644401335933, 5962.4633782959745, 6063.848403789941, 6072.0, 6083.209182806384, 6095.512359011357, 6099.359567245553, 5755.1367294906095, 5826.883462330645, 5855.180274761452, 5874.530037597067, 5895.492182151613], "value": 4493.939702268218, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.6359415683389, 756.5702810047173, 791.3194652598768, 837.6984285657164, 857.6912311567836, 14618.0, 15125.697486050287, 15130.319135638894, 15292.2353882306, 15385.999910005856, 13355.866441335584, 13735.0, 13780.517681881136, 13810.585682429519, 13811.861881381183, 811.0429692962302, 826.2357319479487, 839.9244068033876, 840.0926998841237, 843.3000609494105, 829.9668013279462, 831.9750407487785, 833.9249467547919, 834.7161964931922, 834.9791255218638, 862.6463150108457, 862.6894318045498, 863.1066845814584, 863.8099618084011, 864.7794812322849, 856.9014563325235, 857.3355649371756, 857.6697971281039, 857.8412993596143, 859.866720658299, 630.224823467138, 635.6503922842418, 635.7615894039735, 635.8060791458603, 637.716216283754, 12820.35898205086, 13161.802572961413, 13179.538716144889, 13191.670208244775, 13223.867761322359, 12684.936575317064, 12691.809622855664, 12699.619011429671, 12815.16701414405, 13196.274204918725, 10619.41593212373, 10932.234743567953, 10952.726181845437, 11215.158863085302, 11234.943825280903, 3716.1267102230954, 3781.68590638712, 3789.8673546425744, 3811.7522361046445, 3948.072203032285, 63764.0, 63918.680406598134, 64445.677771611314, 64981.67509162471, 66800.3319966799, 10475.266731328886, 10911.127109831194, 10939.28894621847, 11119.722006949729, 11505.884941150649, 19858.0, 20012.59974800496, 20037.499062523555, 20073.197072116953, 20140.597188056156, 7878.1334053254095, 7918.485298455582, 8147.75556733299, 8161.551114688749, 8342.66629334832, 4559.042601053749, 4563.292689633112, 4566.49768525462, 4643.141018911512, 4687.648426368036, 3422.5892892853017, 3459.965400345964, 3476.617572067071, 3478.530398396184, 3488.162840918212, 616.7695447582103, 618.4619381138349, 625.2840497630187, 627.8775638750491, 644.2172760096505, 551.6552154903186, 603.8701679139007, 644.458654730029, 715.6994062493661, 720.6360787802126, 8878.644854205759, 9143.857017872766, 9155.771105722277, 9305.395149315409, 9585.424874507551, 577.3591313641854, 603.0020316376404, 647.2007071266981, 660.7191943424026, 676.648142965665, 4293.892652683708, 4403.647708183337, 4416.712913660602, 4516.909661806745, 4810.5670489656095, 88803.55598222096, 89360.5531972336, 90749.0, 92907.0, 97241.0, 79575.0, 80102.0, 81242.97046850254, 81552.0, 82735.586322068, 72080.0, 73292.0, 73742.26257737461, 73893.630531847, 75858.62070689611, 9878.851817222603, 10280.280380373302, 10362.637307694195, 10374.948125259325, 10481.685549433529, 47185.29222061603, 47261.2910806345, 47538.28692569683, 47633.0, 48587.0, 61893.690531548855, 65027.34972650213, 66603.33396665972, 67211.32788672051, 67934.0, 12911.5480958166, 13403.463861445824, 13426.530071447452, 13553.86446135526, 13623.455061797416, 15214.641730531785, 15251.313690883715, 15512.767308490156, 15521.223938803241, 16359.754603681193, 13049.0, 13122.212667239995, 13393.464261429433, 13553.864461355655, 13575.592732218049, 12324.198927069712, 12675.80986285225, 13487.730245395234, 13496.392662330023, 13497.987650926416, 11968.521259149884, 12168.391580421121, 12998.220106793622, 13033.15284506504, 13055.804162937373, 11205.887941120485, 11405.600803971822, 11421.257618254787, 11562.653120406401, 11850.288982661068, 10356.741081472723, 10936.940164815376, 11194.776104477702, 11252.887471125512, 11370.886291137314], "value": 7210.597648500386, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1460.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 113.0, 112.0, 114.0, 111.0, 112.0, 113.0, 114.0, 112.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 118.0, 122.0, 168.0, 123.0, 118.0, 117.0, 120.0, 146.0, 118.0], "value": 130.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 164.0, 163.0, 167.0, 162.0, 163.0, 163.0, 162.0, 160.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 113.0, 76.0, 75.0, 76.0, 75.0, 96.0, 75.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 116.0, 81.0, 82.0, 82.0, 93.0, 81.0, 82.0, 119.0], "value": 90.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 117.0, 120.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 146.0, 148.0, 147.0, 148.0, 147.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 86.0, 85.0, 87.0, 85.0, 85.0, 86.0, 85.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 57.0, 52.0, 52.0, 53.0, 52.0, 51.0, 52.0, 51.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 59.0, 59.0, 60.0, 60.0, 61.0, 60.0, 59.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 74.0, 75.0, 74.0, 74.0, 75.0, 74.0, 74.0], "value": 74.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 134.0, 129.0, 122.0, 125.0, 119.0, 133.0, 120.0, 161.0, 119.0], "value": 128.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 157.0, 158.0, 153.0, 156.0, 156.0, 159.0, 156.0, 158.0, 153.0], "value": 156.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 68.0, 63.0, 64.0, 63.0, 63.0, 61.0, 61.0], "value": 63.2, "unit": "score"}]}]} 21:22:28 INFO - Return code: 0 21:22:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:22:28 ERROR - # TBPL SUCCESS # 21:22:28 INFO - Running post-action listener: _resource_record_post_action 21:22:28 INFO - [mozharness: 2017-01-03 05:22:28.644752Z] Finished run-tests step (success) 21:22:28 INFO - Running post-run listener: _resource_record_post_run 21:22:28 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 373010432; Read time: 16; Write time: 283492 21:22:28 INFO - TinderboxPrint: CPU usage
13.3% 21:22:28 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 21:22:28 INFO - TinderboxPrint: I/O write bytes / time
373,010,432 / 283,492 21:22:28 INFO - TinderboxPrint: CPU idle
8,228.3 (86.7%) 21:22:28 INFO - TinderboxPrint: CPU user
1,208.4 (12.7%) 21:22:28 INFO - TinderboxPrint: Swap in / out
0 / 0 21:22:28 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 124055552; Read time: 0; Write time: 104396 21:22:28 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 248954880; Read time: 0; Write time: 179096 21:22:29 INFO - Running post-run listener: _upload_blobber_files 21:22:29 INFO - Blob upload gear active. 21:22:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:22:29 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 21:22:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:22:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:22:29 INFO - (blobuploader) - INFO - Open directory for files ... 21:22:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:22:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:22:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:22:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:22:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:22:32 INFO - (blobuploader) - INFO - Done attempting. 21:22:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:22:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:22:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:22:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:22:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:22:33 INFO - (blobuploader) - INFO - Done attempting. 21:22:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:22:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:22:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:22:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:22:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:22:37 INFO - (blobuploader) - INFO - Done attempting. 21:22:37 INFO - (blobuploader) - INFO - Iteration through files over. 21:22:37 INFO - Return code: 0 21:22:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:22:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:22:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc03fec4602df9f2bf9a6d9e6aec2dd80acff0ffa68f9608b28eada82b9164c58afeb9dfeabcd75c285763d97f4ec4c5015def628aa42da651e1746fb4c7e86c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e646fa75f5fdb86eccae75aa85954d734d3a4442f04dc98c108988cfbd44497b33c9182895fae60edb6d9eec68b98900b8b7af05237ccd96fc28f1dc083ce1ec", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e73389fae6fce62e689227248428e3c566d391b1cd57d4b51079f1ef70480d32b180a0c45f8cab4763514e02b82f997743eaef650aee3d4e72227fc82bc2a0b5"} 21:22:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:22:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:22:37 INFO - Contents: 21:22:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc03fec4602df9f2bf9a6d9e6aec2dd80acff0ffa68f9608b28eada82b9164c58afeb9dfeabcd75c285763d97f4ec4c5015def628aa42da651e1746fb4c7e86c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e646fa75f5fdb86eccae75aa85954d734d3a4442f04dc98c108988cfbd44497b33c9182895fae60edb6d9eec68b98900b8b7af05237ccd96fc28f1dc083ce1ec", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e73389fae6fce62e689227248428e3c566d391b1cd57d4b51079f1ef70480d32b180a0c45f8cab4763514e02b82f997743eaef650aee3d4e72227fc82bc2a0b5"} 21:22:37 INFO - Running post-run listener: copy_logs_to_upload_dir 21:22:37 INFO - Copying logs to upload dir... 21:22:37 INFO - mkdir: /builds/slave/test/build/upload/logs 21:22:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.880553 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-02 21:22:35.807608) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-02 21:22:35.811197) ========= 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=62c568580acbfdaac3eec7be000001dc-1483419373.866878-194076106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc03fec4602df9f2bf9a6d9e6aec2dd80acff0ffa68f9608b28eada82b9164c58afeb9dfeabcd75c285763d97f4ec4c5015def628aa42da651e1746fb4c7e86c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e646fa75f5fdb86eccae75aa85954d734d3a4442f04dc98c108988cfbd44497b33c9182895fae60edb6d9eec68b98900b8b7af05237ccd96fc28f1dc083ce1ec", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e73389fae6fce62e689227248428e3c566d391b1cd57d4b51079f1ef70480d32b180a0c45f8cab4763514e02b82f997743eaef650aee3d4e72227fc82bc2a0b5"} build_url:https://queue.taskcluster.net/v1/task/SuOHcJzuRCqa-72hkgWxhA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011734 build_url: 'https://queue.taskcluster.net/v1/task/SuOHcJzuRCqa-72hkgWxhA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cc03fec4602df9f2bf9a6d9e6aec2dd80acff0ffa68f9608b28eada82b9164c58afeb9dfeabcd75c285763d97f4ec4c5015def628aa42da651e1746fb4c7e86c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e646fa75f5fdb86eccae75aa85954d734d3a4442f04dc98c108988cfbd44497b33c9182895fae60edb6d9eec68b98900b8b7af05237ccd96fc28f1dc083ce1ec", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e73389fae6fce62e689227248428e3c566d391b1cd57d4b51079f1ef70480d32b180a0c45f8cab4763514e02b82f997743eaef650aee3d4e72227fc82bc2a0b5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-02 21:22:35.837372) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 21:22:35.837706) ========= 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=62c568580acbfdaac3eec7be000001dc-1483419373.866878-194076106 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004537 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 21:22:35.922562) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-02 21:22:35.922872) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-02 21:22:35.923159) ========= ========= Total master_lag: 0.17 =========