builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-024 starttime: 1479492912.08 results: success (0) buildid: 20161118073145 builduid: d22eb731b3ee4f1aa6720b521ec7de3f revision: 46127b3a981bceb0413c8199849f4e47afc949da ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 10:15:12.084815) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 10:15:12.085177) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 10:15:12.085440) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 10:15:12.103908) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 10:15:12.104183) ========= 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=41a7e32711b8e08598a63237000001d6-1479492863.879721-404384121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-18 10:15:12-- 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% 223M=0s 2016-11-18 10:15:12 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.261744 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 10:15:12.381111) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 10:15:12.381424) ========= 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=41a7e32711b8e08598a63237000001d6-1479492863.879721-404384121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017803 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 10:15:12.430466) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 10:15:12.430780) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 46127b3a981bceb0413c8199849f4e47afc949da --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 46127b3a981bceb0413c8199849f4e47afc949da --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=41a7e32711b8e08598a63237000001d6-1479492863.879721-404384121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-18 10:15:12,542 truncating revision to first 12 chars 2016-11-18 10:15:12,542 Setting DEBUG logging. 2016-11-18 10:15:12,542 attempt 1/10 2016-11-18 10:15:12,542 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/46127b3a981b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-18 10:15:12,835 unpacking tar archive at: mozilla-central-46127b3a981b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.654757 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 10:15:13.098826) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 10:15:13.099145) ========= script_repo_revision: 46127b3a981bceb0413c8199849f4e47afc949da ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 10:15:13.099528) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 10:15:13.099799) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 10:15:13.108770) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-11-18 10:15:13.109196) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=41a7e32711b8e08598a63237000001d6-1479492863.879721-404384121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:15:13 INFO - MultiFileLogger online at 20161118 10:15:13 in /builds/slave/test 10:15:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:15:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:15:13 INFO - {'append_to_log': False, 10:15:13 INFO - 'base_work_dir': '/builds/slave/test', 10:15:13 INFO - 'blob_upload_branch': 'Firefox', 10:15:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:15:13 INFO - 'branch': 'Firefox', 10:15:13 INFO - 'buildbot_json_path': 'buildprops.json', 10:15:13 INFO - 'config_files': ('talos/linux_config.py',), 10:15:13 INFO - 'default_actions': ('clobber', 10:15:13 INFO - 'read-buildbot-config', 10:15:13 INFO - 'download-and-extract', 10:15:13 INFO - 'populate-webroot', 10:15:13 INFO - 'create-virtualenv', 10:15:13 INFO - 'install', 10:15:13 INFO - 'run-tests'), 10:15:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:15:13 INFO - 'download_minidump_stackwalk': True, 10:15:13 INFO - 'download_symbols': 'ondemand', 10:15:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:15:13 INFO - 'tooltool.py': '/tools/tooltool.py', 10:15:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:15:13 INFO - '/tools/misc-python/virtualenv.py')}, 10:15:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:15:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:15:13 INFO - 'installer_path': 'installer.exe', 10:15:13 INFO - 'log_level': 'info', 10:15:13 INFO - 'log_name': 'talos', 10:15:13 INFO - 'log_to_console': True, 10:15:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:15:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:15:13 INFO - 'opt_config_files': (), 10:15:13 INFO - 'pip_index': False, 10:15:13 INFO - 'sps_profile': False, 10:15:13 INFO - 'sps_profile_interval': 0, 10:15:13 INFO - 'suite': 'dromaeojs', 10:15:13 INFO - 'system_bits': '32', 10:15:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:15:13 INFO - 'title': 'talos-linux64-ix-024', 10:15:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:15:13 INFO - 'use_talos_json': True, 10:15:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:15:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:15:13 INFO - 'work_dir': 'build'} 10:15:13 INFO - [mozharness: 2016-11-18 18:15:13.325329Z] Running clobber step. 10:15:13 INFO - Running pre-action listener: _resource_record_pre_action 10:15:13 INFO - Running main action method: clobber 10:15:13 INFO - rmtree: /builds/slave/test/build 10:15:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:15:13 INFO - Running post-action listener: _resource_record_post_action 10:15:13 INFO - [mozharness: 2016-11-18 18:15:13.781907Z] Finished clobber step (success) 10:15:13 INFO - [mozharness: 2016-11-18 18:15:13.782007Z] Running read-buildbot-config step. 10:15:13 INFO - Running pre-action listener: _resource_record_pre_action 10:15:13 INFO - Running main action method: read_buildbot_config 10:15:13 INFO - Using buildbot properties: 10:15:13 INFO - { 10:15:13 INFO - "project": "", 10:15:13 INFO - "product": "firefox", 10:15:13 INFO - "script_repo_revision": "production", 10:15:13 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 10:15:13 INFO - "repository": "", 10:15:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 10:15:13 INFO - "buildid": "20161118073145", 10:15:13 INFO - "pgo_build": "True", 10:15:13 INFO - "basedir": "/builds/slave/test", 10:15:13 INFO - "buildnumber": 75, 10:15:13 INFO - "slavename": "talos-linux64-ix-024", 10:15:13 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:15:13 INFO - "platform": "ubuntu64_hw", 10:15:13 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:15:13 INFO - "branch": "mozilla-central", 10:15:13 INFO - "repo_path": "mozilla-central", 10:15:13 INFO - "revision": "46127b3a981bceb0413c8199849f4e47afc949da", 10:15:13 INFO - "stage_platform": "linux64-pgo", 10:15:13 INFO - "builduid": "d22eb731b3ee4f1aa6720b521ec7de3f", 10:15:13 INFO - "slavebuilddir": "test" 10:15:13 INFO - } 10:15:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/dREUHLS-RmO9BTKTsLvTKQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 10:15:13 INFO - Running post-action listener: _resource_record_post_action 10:15:13 INFO - [mozharness: 2016-11-18 18:15:13.785112Z] Finished read-buildbot-config step (success) 10:15:13 INFO - [mozharness: 2016-11-18 18:15:13.785201Z] Running download-and-extract step. 10:15:13 INFO - Running pre-action listener: _resource_record_pre_action 10:15:13 INFO - Running main action method: download_and_extract 10:15:13 INFO - mkdir: /builds/slave/test/build/tests 10:15: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')]} 10:15:13 INFO - trying https://queue.taskcluster.net/v1/task/dREUHLS-RmO9BTKTsLvTKQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 10:15:13 INFO - Downloading https://queue.taskcluster.net/v1/task/dREUHLS-RmO9BTKTsLvTKQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 10:15:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dREUHLS-RmO9BTKTsLvTKQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:15:14 INFO - Downloaded 1361 bytes. 10:15:14 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 10:15:14 INFO - Using the following test package requirements: 10:15:14 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 10:15:14 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:14 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:15:14 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:14 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:15:14 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:14 INFO - u'jsshell-linux-x86_64.zip'], 10:15:14 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:14 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:15:14 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 10:15:14 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:14 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:15:14 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:14 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:15:14 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:14 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:15:14 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:14 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:15:14 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:15:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dREUHLS-RmO9BTKTsLvTKQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 10:15:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dREUHLS-RmO9BTKTsLvTKQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:15:14 INFO - Fetch https://queue.taskcluster.net/v1/task/dREUHLS-RmO9BTKTsLvTKQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:15:14 INFO - Http code: 200 10:15:14 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 10:15:14 INFO - x-amz-cf-id: nfaVSfuFJ5LrsoiqeT5K7TLuB6QgJaMOmfPW1QWzmWt_N1CjvOslrg== 10:15:14 INFO - x-amz-version-id: dOFOjDHqurcyVovzCZ.KYZwvmumPGEvc 10:15:15 INFO - Expected file size: 21864792 10:15:15 INFO - Obtained file size: 21864792 10:15:19 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:15:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dREUHLS-RmO9BTKTsLvTKQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 10:15:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dREUHLS-RmO9BTKTsLvTKQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:15:19 INFO - Fetch https://queue.taskcluster.net/v1/task/dREUHLS-RmO9BTKTsLvTKQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 10:15:19 INFO - Http code: 200 10:15:19 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 10:15:19 INFO - x-amz-cf-id: 2rfmwcH3BVefcHMHBMk_cDyaOUuHp64VYgdFBEGm4KgPJfxBeZFU0Q== 10:15:19 INFO - x-amz-version-id: dOFOjDHqurcyVovzCZ.KYZwvmumPGEvc 10:15:20 INFO - Expected file size: 21864792 10:15:20 INFO - Obtained file size: 21864792 10:15:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dREUHLS-RmO9BTKTsLvTKQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 10:15:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dREUHLS-RmO9BTKTsLvTKQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:15:24 INFO - Fetch https://queue.taskcluster.net/v1/task/dREUHLS-RmO9BTKTsLvTKQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 10:15:25 INFO - Http code: 200 10:15:25 INFO - via: 1.1 4c2196e36fd33f377384d605b4424e95.cloudfront.net (CloudFront) 10:15:25 INFO - x-amz-cf-id: fUGktjkoo6vlLnvRgivdLAIBnfNw8hS9hMCCaVoTQnhYLgZd3Tc7yw== 10:15:25 INFO - x-amz-version-id: kbNsee4Vq7wstZf4yJe.QpgIDNF12790 10:15:25 INFO - Expected file size: 14409392 10:15:25 INFO - Obtained file size: 14409392 10:15:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:25 INFO - trying https://queue.taskcluster.net/v1/task/dREUHLS-RmO9BTKTsLvTKQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 10:15:25 INFO - Downloading https://queue.taskcluster.net/v1/task/dREUHLS-RmO9BTKTsLvTKQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 10:15:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dREUHLS-RmO9BTKTsLvTKQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:15:26 INFO - Downloaded 59609560 bytes. 10:15:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dREUHLS-RmO9BTKTsLvTKQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 10:15:26 INFO - mkdir: /builds/slave/test/properties 10:15:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:15:26 INFO - Writing to file /builds/slave/test/properties/build_url 10:15:26 INFO - Contents: 10:15:26 INFO - build_url:https://queue.taskcluster.net/v1/task/dREUHLS-RmO9BTKTsLvTKQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 10:15:27 INFO - Running post-action listener: _resource_record_post_action 10:15:27 INFO - Running post-action listener: set_extra_try_arguments 10:15:27 INFO - [mozharness: 2016-11-18 18:15:27.325131Z] Finished download-and-extract step (success) 10:15:27 INFO - [mozharness: 2016-11-18 18:15:27.325360Z] Running populate-webroot step. 10:15:27 INFO - Running pre-action listener: _resource_record_pre_action 10:15:27 INFO - Running main action method: populate_webroot 10:15:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:15:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:15:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:15:27 INFO - '--tppagecycles', 10:15:27 INFO - '7'], 10:15:27 INFO - 'tests': ['tsvgm']}}, 10:15:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:15:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:15:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:15:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:15:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:15:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:15:27 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 10:15:27 INFO - 'talos_options': ['--disable-e10s'], 10:15:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:15:27 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 10:15:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:15:27 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 10:15:27 INFO - 'talos_options': ['--disable-e10s'], 10:15:27 INFO - 'tests': ['damp', 'tps']}, 10:15:27 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 10:15:27 INFO - 'tests': ['damp', 'tps']}, 10:15:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:15:27 INFO - 'tests': ['dromaeo_dom']}, 10:15:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:15:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:15:27 INFO - 'tests': ['basic_compositor_video']}, 10:15:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:15:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:15:27 INFO - 'tests': ['a11yr', 10:15:27 INFO - 'ts_paint', 10:15:27 INFO - 'tpaint', 10:15:27 INFO - 'sessionrestore', 10:15:27 INFO - 'sessionrestore_no_auto_restore', 10:15:27 INFO - 'tabpaint']}, 10:15:27 INFO - 'other-e10s': {'tests': ['a11yr', 10:15:27 INFO - 'ts_paint', 10:15:27 INFO - 'tpaint', 10:15:27 INFO - 'sessionrestore', 10:15:27 INFO - 'sessionrestore_no_auto_restore', 10:15:27 INFO - 'tabpaint']}, 10:15:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:15:27 INFO - 'ts_paint', 10:15:27 INFO - 'tpaint', 10:15:27 INFO - 'sessionrestore', 10:15:27 INFO - 'sessionrestore_no_auto_restore', 10:15:27 INFO - 'tabpaint']}, 10:15:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:15:27 INFO - 'ts_paint', 10:15:27 INFO - 'tpaint', 10:15:27 INFO - 'sessionrestore', 10:15:27 INFO - 'sessionrestore_no_auto_restore', 10:15:27 INFO - 'tabpaint']}, 10:15:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:15:27 INFO - 'tests': ['a11yr', 10:15:27 INFO - 'ts_paint', 10:15:27 INFO - 'tpaint', 10:15:27 INFO - 'sessionrestore', 10:15:27 INFO - 'sessionrestore_no_auto_restore', 10:15:27 INFO - 'tabpaint']}, 10:15:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:15:27 INFO - 'tests': ['a11yr', 10:15:27 INFO - 'ts_paint', 10:15:27 INFO - 'tpaint', 10:15:27 INFO - 'sessionrestore', 10:15:27 INFO - 'sessionrestore_no_auto_restore', 10:15:27 INFO - 'tabpaint']}, 10:15:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:15:27 INFO - 'tests': ['tsvgx', 10:15:27 INFO - 'tsvgr_opacity', 10:15:27 INFO - 'tart', 10:15:27 INFO - 'tscrollx', 10:15:27 INFO - 'cart']}, 10:15:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:15:27 INFO - 'tsvgr_opacity', 10:15:27 INFO - 'tart', 10:15:27 INFO - 'tscrollx', 10:15:27 INFO - 'cart']}, 10:15:27 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 10:15:27 INFO - 'talos_options': ['--disable-e10s'], 10:15:27 INFO - 'tests': ['tp5o']}, 10:15:27 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 10:15:27 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 10:15:27 INFO - 'talos_options': ['--disable-e10s', 10:15:27 INFO - '--xperf_path', 10:15:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:15:27 INFO - 'tests': ['tp5n']}, 10:15:27 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 10:15:27 INFO - 'talos_options': ['--xperf_path', 10:15:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:15:27 INFO - 'tests': ['tp5n']}}, 10:15:27 INFO - 'talos.zip': {'path': '', 10:15:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:15:27 INFO - Running post-action listener: _resource_record_post_action 10:15:27 INFO - [mozharness: 2016-11-18 18:15:27.346647Z] Finished populate-webroot step (success) 10:15:27 INFO - [mozharness: 2016-11-18 18:15:27.346736Z] Running create-virtualenv step. 10:15:27 INFO - Running pre-action listener: _resource_record_pre_action 10:15:27 INFO - Running main action method: create_virtualenv 10:15:27 INFO - Creating virtualenv /builds/slave/test/build/venv 10:15:27 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:15:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:15:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:15:27 INFO - Using real prefix '/usr' 10:15:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:15:27 INFO - Installing distribute.............................................................................................................................................................................................done. 10:15:29 INFO - Installing pip.................done. 10:15:29 INFO - Return code: 0 10:15:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 10:15:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 10:15:30 INFO - Reading from file tmpfile_stdout 10:15:30 INFO - Output received: 10:15:30 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 10:15:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:15: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')]} 10:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15: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')]} 10:15:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa477afde30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c56fc0>, '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 0x2c57ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c58350>, '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': '41a7e32711b8e08598a63237000001d6-1479492863.879721-404384121', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:15:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:15:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:15:30 INFO - Using env: {'DISPLAY': ':0', 10:15:30 INFO - 'HOME': '/home/cltbld', 10:15:30 INFO - 'LANG': 'en_US.UTF-8', 10:15:30 INFO - 'LANGUAGE': 'en_US:en', 10:15:30 INFO - 'LOGNAME': 'cltbld', 10:15:30 INFO - 'MAIL': '/var/mail/cltbld', 10:15:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:30 INFO - 'MOZ_NO_REMOTE': '1', 10:15:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:30 INFO - 'NO_EM_RESTART': '1', 10:15:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:30 INFO - 'PWD': '/builds/slave/test', 10:15:30 INFO - 'SHELL': '/bin/bash', 10:15:30 INFO - 'SHLVL': '1', 10:15:30 INFO - 'TERM': 'linux', 10:15:30 INFO - 'TMOUT': '86400', 10:15:30 INFO - 'USER': 'cltbld', 10:15:30 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1479492863.879721-404384121', 10:15:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:30 INFO - '_': '/tools/buildbot/bin/python'} 10:15:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:30 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:15:30 INFO - Cleaning up... 10:15:30 INFO - Return code: 0 10:15:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:15: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')]} 10:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15: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')]} 10:15:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa477afde30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c56fc0>, '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 0x2c57ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c58350>, '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': '41a7e32711b8e08598a63237000001d6-1479492863.879721-404384121', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:15:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:15:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:15:30 INFO - Using env: {'DISPLAY': ':0', 10:15:30 INFO - 'HOME': '/home/cltbld', 10:15:30 INFO - 'LANG': 'en_US.UTF-8', 10:15:30 INFO - 'LANGUAGE': 'en_US:en', 10:15:30 INFO - 'LOGNAME': 'cltbld', 10:15:30 INFO - 'MAIL': '/var/mail/cltbld', 10:15:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:30 INFO - 'MOZ_NO_REMOTE': '1', 10:15:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:30 INFO - 'NO_EM_RESTART': '1', 10:15:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:30 INFO - 'PWD': '/builds/slave/test', 10:15:30 INFO - 'SHELL': '/bin/bash', 10:15:30 INFO - 'SHLVL': '1', 10:15:30 INFO - 'TERM': 'linux', 10:15:30 INFO - 'TMOUT': '86400', 10:15:30 INFO - 'USER': 'cltbld', 10:15:30 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1479492863.879721-404384121', 10:15:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:30 INFO - '_': '/tools/buildbot/bin/python'} 10:15:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:30 INFO - Downloading/unpacking psutil>=3.1.1 10:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:15:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:15:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:15:32 INFO - Installing collected packages: psutil 10:15:32 INFO - Running setup.py install for psutil 10:15:32 INFO - building 'psutil._psutil_linux' extension 10:15:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:15:32 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:15:32 INFO - building 'psutil._psutil_posix' extension 10:15:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:15:33 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:15:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:15:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:15:33 INFO - Successfully installed psutil 10:15:33 INFO - Cleaning up... 10:15:33 INFO - Return code: 0 10:15:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:15: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')]} 10:15:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15: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')]} 10:15:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:33 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 0x7fa477afde30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c56fc0>, '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 0x2c57ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c58350>, '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': '41a7e32711b8e08598a63237000001d6-1479492863.879721-404384121', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:15:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:15:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:15:33 INFO - Using env: {'DISPLAY': ':0', 10:15:33 INFO - 'HOME': '/home/cltbld', 10:15:33 INFO - 'LANG': 'en_US.UTF-8', 10:15:33 INFO - 'LANGUAGE': 'en_US:en', 10:15:33 INFO - 'LOGNAME': 'cltbld', 10:15:33 INFO - 'MAIL': '/var/mail/cltbld', 10:15:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:33 INFO - 'MOZ_NO_REMOTE': '1', 10:15:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:33 INFO - 'NO_EM_RESTART': '1', 10:15:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:33 INFO - 'PWD': '/builds/slave/test', 10:15:33 INFO - 'SHELL': '/bin/bash', 10:15:33 INFO - 'SHLVL': '1', 10:15:33 INFO - 'TERM': 'linux', 10:15:33 INFO - 'TMOUT': '86400', 10:15:33 INFO - 'USER': 'cltbld', 10:15:33 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1479492863.879721-404384121', 10:15:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:33 INFO - '_': '/tools/buildbot/bin/python'} 10:15:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:15:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:15:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:15:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:15:35 INFO - Installing collected packages: mozsystemmonitor 10:15:35 INFO - Running setup.py install for mozsystemmonitor 10:15:35 INFO - Successfully installed mozsystemmonitor 10:15:35 INFO - Cleaning up... 10:15:35 INFO - Return code: 0 10:15:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:35 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 0x7fa477afde30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c56fc0>, '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 0x2c57ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c58350>, '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': '41a7e32711b8e08598a63237000001d6-1479492863.879721-404384121', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:15:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:15:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:15:35 INFO - Using env: {'DISPLAY': ':0', 10:15:35 INFO - 'HOME': '/home/cltbld', 10:15:35 INFO - 'LANG': 'en_US.UTF-8', 10:15:35 INFO - 'LANGUAGE': 'en_US:en', 10:15:35 INFO - 'LOGNAME': 'cltbld', 10:15:35 INFO - 'MAIL': '/var/mail/cltbld', 10:15:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:35 INFO - 'MOZ_NO_REMOTE': '1', 10:15:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:35 INFO - 'NO_EM_RESTART': '1', 10:15:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:35 INFO - 'PWD': '/builds/slave/test', 10:15:35 INFO - 'SHELL': '/bin/bash', 10:15:35 INFO - 'SHLVL': '1', 10:15:35 INFO - 'TERM': 'linux', 10:15:35 INFO - 'TMOUT': '86400', 10:15:35 INFO - 'USER': 'cltbld', 10:15:35 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1479492863.879721-404384121', 10:15:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:35 INFO - '_': '/tools/buildbot/bin/python'} 10:15:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:35 INFO - Downloading/unpacking jsonschema==2.5.1 10:15: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 10:15: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 10:15: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 10:15: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 10:15: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 10:15: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 10:15:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:15:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:37 INFO - Downloading functools32-3.2.3-2.tar.gz 10:15:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:15:37 INFO - warning: no files found matching '*.txt' 10:15:37 INFO - no previously-included directories found matching 'build' 10:15:37 INFO - no previously-included directories found matching 'dist' 10:15:37 INFO - no previously-included directories found matching '.git*' 10:15:37 INFO - Installing collected packages: jsonschema, functools32 10:15:38 INFO - Running setup.py install for functools32 10:15:38 INFO - warning: no files found matching '*.txt' 10:15:38 INFO - no previously-included directories found matching 'build' 10:15:38 INFO - no previously-included directories found matching 'dist' 10:15:38 INFO - no previously-included directories found matching '.git*' 10:15:38 INFO - Successfully installed jsonschema functools32 10:15:38 INFO - Cleaning up... 10:15:38 INFO - Return code: 0 10:15:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:15: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')]} 10:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15: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')]} 10:15:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15: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', '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 0x7fa477afde30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c56fc0>, '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 0x2c57ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c58350>, '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': '41a7e32711b8e08598a63237000001d6-1479492863.879721-404384121', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:15: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 10:15: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 functools32==3.2.3-2 10:15:38 INFO - Using env: {'DISPLAY': ':0', 10:15:38 INFO - 'HOME': '/home/cltbld', 10:15:38 INFO - 'LANG': 'en_US.UTF-8', 10:15:38 INFO - 'LANGUAGE': 'en_US:en', 10:15:38 INFO - 'LOGNAME': 'cltbld', 10:15:38 INFO - 'MAIL': '/var/mail/cltbld', 10:15:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:38 INFO - 'MOZ_NO_REMOTE': '1', 10:15:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:38 INFO - 'NO_EM_RESTART': '1', 10:15:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:38 INFO - 'PWD': '/builds/slave/test', 10:15:38 INFO - 'SHELL': '/bin/bash', 10:15:38 INFO - 'SHLVL': '1', 10:15:38 INFO - 'TERM': 'linux', 10:15:38 INFO - 'TMOUT': '86400', 10:15:38 INFO - 'USER': 'cltbld', 10:15:38 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1479492863.879721-404384121', 10:15:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:38 INFO - '_': '/tools/buildbot/bin/python'} 10:15:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:15:38 INFO - Cleaning up... 10:15:38 INFO - Return code: 0 10:15:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:15: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')]} 10:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15: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')]} 10:15:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15: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', '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 0x7fa477afde30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c56fc0>, '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 0x2c57ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c58350>, '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': '41a7e32711b8e08598a63237000001d6-1479492863.879721-404384121', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:15: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:15: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 blobuploader==1.2.4 10:15:38 INFO - Using env: {'DISPLAY': ':0', 10:15:38 INFO - 'HOME': '/home/cltbld', 10:15:38 INFO - 'LANG': 'en_US.UTF-8', 10:15:38 INFO - 'LANGUAGE': 'en_US:en', 10:15:38 INFO - 'LOGNAME': 'cltbld', 10:15:38 INFO - 'MAIL': '/var/mail/cltbld', 10:15:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:38 INFO - 'MOZ_NO_REMOTE': '1', 10:15:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:38 INFO - 'NO_EM_RESTART': '1', 10:15:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:38 INFO - 'PWD': '/builds/slave/test', 10:15:38 INFO - 'SHELL': '/bin/bash', 10:15:38 INFO - 'SHLVL': '1', 10:15:38 INFO - 'TERM': 'linux', 10:15:38 INFO - 'TMOUT': '86400', 10:15:38 INFO - 'USER': 'cltbld', 10:15:38 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1479492863.879721-404384121', 10:15:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:38 INFO - '_': '/tools/buildbot/bin/python'} 10:15:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:38 INFO - Downloading/unpacking blobuploader==1.2.4 10:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:40 INFO - Downloading blobuploader-1.2.4.tar.gz 10:15:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:15:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:15:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:41 INFO - Downloading docopt-0.6.1.tar.gz 10:15:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:15:41 INFO - Installing collected packages: blobuploader, requests, docopt 10:15:41 INFO - Running setup.py install for blobuploader 10:15:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:15:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:15:41 INFO - Running setup.py install for requests 10:15:41 INFO - Running setup.py install for docopt 10:15:41 INFO - Successfully installed blobuploader requests docopt 10:15:41 INFO - Cleaning up... 10:15:41 INFO - Return code: 0 10:15:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:41 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 0x7fa477afde30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c56fc0>, '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 0x2c57ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c58350>, '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': '41a7e32711b8e08598a63237000001d6-1479492863.879721-404384121', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:15:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:15:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:15:41 INFO - Using env: {'DISPLAY': ':0', 10:15:41 INFO - 'HOME': '/home/cltbld', 10:15:41 INFO - 'LANG': 'en_US.UTF-8', 10:15:41 INFO - 'LANGUAGE': 'en_US:en', 10:15:41 INFO - 'LOGNAME': 'cltbld', 10:15:41 INFO - 'MAIL': '/var/mail/cltbld', 10:15:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:41 INFO - 'MOZ_NO_REMOTE': '1', 10:15:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:41 INFO - 'NO_EM_RESTART': '1', 10:15:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:41 INFO - 'PWD': '/builds/slave/test', 10:15:41 INFO - 'SHELL': '/bin/bash', 10:15:41 INFO - 'SHLVL': '1', 10:15:41 INFO - 'TERM': 'linux', 10:15:41 INFO - 'TMOUT': '86400', 10:15:41 INFO - 'USER': 'cltbld', 10:15:41 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1479492863.879721-404384121', 10:15:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:41 INFO - '_': '/tools/buildbot/bin/python'} 10:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:15:42 INFO - Running setup.py (path:/tmp/pip-mHnimj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:15:42 INFO - Running setup.py (path:/tmp/pip-KX6DL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:15:42 INFO - Running setup.py (path:/tmp/pip-A4W0Lv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:15:42 INFO - Running setup.py (path:/tmp/pip-U7Gk83-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:15:42 INFO - Running setup.py (path:/tmp/pip-msY0pz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:15:42 INFO - Running setup.py (path:/tmp/pip-4hnbV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:15:42 INFO - Running setup.py (path:/tmp/pip-S2hQ6F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:15:42 INFO - Running setup.py (path:/tmp/pip-r1w5Ov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:15:42 INFO - Running setup.py (path:/tmp/pip-ANTX2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:15:42 INFO - Running setup.py (path:/tmp/pip-dTpvPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:15:42 INFO - Running setup.py (path:/tmp/pip-77LTkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:15:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:15:42 INFO - Running setup.py (path:/tmp/pip-jZexgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:15:43 INFO - Running setup.py (path:/tmp/pip-KIXe6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:15:43 INFO - Running setup.py (path:/tmp/pip-W5O2Mr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:43 INFO - Running setup.py (path:/tmp/pip-srwN6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:15:43 INFO - Running setup.py (path:/tmp/pip-N3Lpqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:15:43 INFO - Running setup.py (path:/tmp/pip-sd0QrX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:15:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:15:43 INFO - Running setup.py install for manifestparser 10:15:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:15:43 INFO - Running setup.py install for mozcrash 10:15:43 INFO - Running setup.py install for mozdebug 10:15:43 INFO - Running setup.py install for mozdevice 10:15:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:15:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:15:43 INFO - Running setup.py install for mozfile 10:15:43 INFO - Running setup.py install for mozhttpd 10:15:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:15:43 INFO - Running setup.py install for mozinfo 10:15:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:15:44 INFO - Running setup.py install for mozInstall 10:15:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:15:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:15:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:15:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:15:44 INFO - Running setup.py install for mozleak 10:15:44 INFO - Running setup.py install for mozlog 10:15:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:15:44 INFO - Running setup.py install for moznetwork 10:15:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:15:44 INFO - Running setup.py install for mozprocess 10:15:44 INFO - Running setup.py install for mozprofile 10:15:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:15:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:15:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:15:44 INFO - Running setup.py install for mozrunner 10:15:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:15:44 INFO - Running setup.py install for mozscreenshot 10:15:44 INFO - Running setup.py install for moztest 10:15:45 INFO - Running setup.py install for mozversion 10:15:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:15:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:15:45 INFO - Cleaning up... 10:15:45 INFO - Return code: 0 10:15:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:45 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 0x7fa477afde30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c56fc0>, '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 0x2c57ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c58350>, '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': '41a7e32711b8e08598a63237000001d6-1479492863.879721-404384121', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:15:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:15:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:15:45 INFO - Using env: {'DISPLAY': ':0', 10:15:45 INFO - 'HOME': '/home/cltbld', 10:15:45 INFO - 'LANG': 'en_US.UTF-8', 10:15:45 INFO - 'LANGUAGE': 'en_US:en', 10:15:45 INFO - 'LOGNAME': 'cltbld', 10:15:45 INFO - 'MAIL': '/var/mail/cltbld', 10:15:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:45 INFO - 'MOZ_NO_REMOTE': '1', 10:15:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:45 INFO - 'NO_EM_RESTART': '1', 10:15:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:45 INFO - 'PWD': '/builds/slave/test', 10:15:45 INFO - 'SHELL': '/bin/bash', 10:15:45 INFO - 'SHLVL': '1', 10:15:45 INFO - 'TERM': 'linux', 10:15:45 INFO - 'TMOUT': '86400', 10:15:45 INFO - 'USER': 'cltbld', 10:15:45 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1479492863.879721-404384121', 10:15:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:45 INFO - '_': '/tools/buildbot/bin/python'} 10:15:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:15:45 INFO - Running setup.py (path:/tmp/pip-67H5G_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:15:45 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:15:45 INFO - Running setup.py (path:/tmp/pip-DfUTjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:15:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:15:45 INFO - Running setup.py (path:/tmp/pip-enuSPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:15:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:15:45 INFO - Running setup.py (path:/tmp/pip-XsAoxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:15:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:15:45 INFO - Running setup.py (path:/tmp/pip-l1YVfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:15:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:15:45 INFO - Running setup.py (path:/tmp/pip-RtQ30q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:15:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:15:45 INFO - Running setup.py (path:/tmp/pip-NuEBVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:15:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:15:45 INFO - Running setup.py (path:/tmp/pip-FjU5ij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:15:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:15:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:15:45 INFO - Running setup.py (path:/tmp/pip-SRvSzZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:15:46 INFO - Running setup.py (path:/tmp/pip-oamcgD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:15:46 INFO - Running setup.py (path:/tmp/pip-5XNZLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:15:46 INFO - Running setup.py (path:/tmp/pip-YolgBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:15:46 INFO - Running setup.py (path:/tmp/pip-4yQZPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:15:46 INFO - Running setup.py (path:/tmp/pip-YFqtbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:46 INFO - Running setup.py (path:/tmp/pip-DzxQkw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:15:46 INFO - Running setup.py (path:/tmp/pip-tcyTdd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:15:46 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)) 10:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:15:46 INFO - Running setup.py (path:/tmp/pip-YfOZw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:15:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:48 INFO - Downloading blessings-1.6.tar.gz 10:15:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:15:48 INFO - Installing collected packages: blessings 10:15:48 INFO - Running setup.py install for blessings 10:15:48 INFO - Successfully installed blessings 10:15:48 INFO - Cleaning up... 10:15:48 INFO - Return code: 0 10:15:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:15:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:15:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:15:49 INFO - Reading from file tmpfile_stdout 10:15:49 INFO - Current package versions: 10:15:49 INFO - argparse == 1.2.1 10:15:49 INFO - blessings == 1.6 10:15:49 INFO - blobuploader == 1.2.4 10:15:49 INFO - docopt == 0.6.1 10:15:49 INFO - functools32 == 3.2.3-2 10:15:49 INFO - jsonschema == 2.5.1 10:15:49 INFO - manifestparser == 1.1 10:15:49 INFO - mozInstall == 1.12 10:15:49 INFO - mozcrash == 1.0 10:15:49 INFO - mozdebug == 0.1 10:15:49 INFO - mozdevice == 0.48 10:15:49 INFO - mozfile == 1.2 10:15:49 INFO - mozhttpd == 0.7 10:15:49 INFO - mozinfo == 0.9 10:15:49 INFO - mozleak == 0.1 10:15:49 INFO - mozlog == 3.4 10:15:49 INFO - moznetwork == 0.27 10:15:49 INFO - mozprocess == 0.23 10:15:49 INFO - mozprofile == 0.28 10:15:49 INFO - mozrunner == 6.13 10:15:49 INFO - mozscreenshot == 0.1 10:15:49 INFO - mozsystemmonitor == 0.3 10:15:49 INFO - moztest == 0.7 10:15:49 INFO - mozversion == 1.4 10:15:49 INFO - psutil == 3.1.1 10:15:49 INFO - requests == 1.2.3 10:15:49 INFO - wsgiref == 0.1.2 10:15:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:49 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 0x7fa477afde30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c56fc0>, '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 0x2c57ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c58350>, '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': '41a7e32711b8e08598a63237000001d6-1479492863.879721-404384121', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:15:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:15:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:15:49 INFO - Using env: {'DISPLAY': ':0', 10:15:49 INFO - 'HOME': '/home/cltbld', 10:15:49 INFO - 'LANG': 'en_US.UTF-8', 10:15:49 INFO - 'LANGUAGE': 'en_US:en', 10:15:49 INFO - 'LOGNAME': 'cltbld', 10:15:49 INFO - 'MAIL': '/var/mail/cltbld', 10:15:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:49 INFO - 'MOZ_NO_REMOTE': '1', 10:15:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:49 INFO - 'NO_EM_RESTART': '1', 10:15:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:49 INFO - 'PWD': '/builds/slave/test', 10:15:49 INFO - 'SHELL': '/bin/bash', 10:15:49 INFO - 'SHLVL': '1', 10:15:49 INFO - 'TERM': 'linux', 10:15:49 INFO - 'TMOUT': '86400', 10:15:49 INFO - 'USER': 'cltbld', 10:15:49 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1479492863.879721-404384121', 10:15:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:49 INFO - '_': '/tools/buildbot/bin/python'} 10:15:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:15:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:15:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:15:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:15:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:15:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:15:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:15:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:15:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:15:49 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:15:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:15:49 INFO - Cleaning up... 10:15:49 INFO - Return code: 0 10:15:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:15:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:49 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 0x7fa477afde30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2cb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bc8130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c56fc0>, '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 0x2c57ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c58350>, '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': '41a7e32711b8e08598a63237000001d6-1479492863.879721-404384121', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:15:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:15:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:15:49 INFO - Using env: {'DISPLAY': ':0', 10:15:49 INFO - 'HOME': '/home/cltbld', 10:15:49 INFO - 'LANG': 'en_US.UTF-8', 10:15:49 INFO - 'LANGUAGE': 'en_US:en', 10:15:49 INFO - 'LOGNAME': 'cltbld', 10:15:49 INFO - 'MAIL': '/var/mail/cltbld', 10:15:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:49 INFO - 'MOZ_NO_REMOTE': '1', 10:15:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:49 INFO - 'NO_EM_RESTART': '1', 10:15:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:49 INFO - 'PWD': '/builds/slave/test', 10:15:49 INFO - 'SHELL': '/bin/bash', 10:15:49 INFO - 'SHLVL': '1', 10:15:49 INFO - 'TERM': 'linux', 10:15:49 INFO - 'TMOUT': '86400', 10:15:49 INFO - 'USER': 'cltbld', 10:15:49 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1479492863.879721-404384121', 10:15:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:49 INFO - '_': '/tools/buildbot/bin/python'} 10:15:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:15:49 INFO - Cleaning up... 10:15:49 INFO - Return code: 0 10:15:49 INFO - Running post-action listener: _resource_record_post_action 10:15:49 INFO - Running post-action listener: _start_resource_monitoring 10:15:49 INFO - Starting resource monitoring. 10:15:49 INFO - [mozharness: 2016-11-18 18:15:49.554816Z] Finished create-virtualenv step (success) 10:15:49 INFO - [mozharness: 2016-11-18 18:15:49.555335Z] Running install step. 10:15:49 INFO - Running pre-action listener: _resource_record_pre_action 10:15:49 INFO - Running main action method: install 10:15:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:15:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:15:49 INFO - Reading from file tmpfile_stdout 10:15:49 INFO - Detecting whether we're running mozinstall >=1.0... 10:15:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:15:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:15:49 INFO - Reading from file tmpfile_stdout 10:15:49 INFO - Output received: 10:15:49 INFO - Usage: mozinstall [options] installer 10:15:49 INFO - Options: 10:15:49 INFO - -h, --help show this help message and exit 10:15:49 INFO - -d DEST, --destination=DEST 10:15:49 INFO - Directory to install application into. [default: 10:15:49 INFO - "/builds/slave/test"] 10:15:49 INFO - --app=APP Application being installed. [default: firefox] 10:15:49 INFO - mkdir: /builds/slave/test/build/application 10:15:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:15:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:16:06 INFO - Reading from file tmpfile_stdout 10:16:06 INFO - Output received: 10:16:06 INFO - /builds/slave/test/build/application/firefox/firefox 10:16:06 INFO - Running post-action listener: _resource_record_post_action 10:16:06 INFO - [mozharness: 2016-11-18 18:16:06.830217Z] Finished install step (success) 10:16:06 INFO - [mozharness: 2016-11-18 18:16:06.830470Z] Running run-tests step. 10:16:06 INFO - Running pre-action listener: _resource_record_pre_action 10:16:06 INFO - Running main action method: run_tests 10:16:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:16:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:16:06 INFO - Python 2.7.3 10:16:06 INFO - Return code: 0 10:16:06 INFO - grabbing minidump binary from tooltool 10:16:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:16:06 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 0x2c56fc0>, '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 0x2c57ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c58350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:16:06 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:16:06 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:16:06 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:16:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:16:06 INFO - Return code: 0 10:16:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:16:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:16:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:16:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:16:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:16:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dREUHLS-RmO9BTKTsLvTKQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 10:16:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dREUHLS-RmO9BTKTsLvTKQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 10:16:06 INFO - Using env: {'DISPLAY': ':0', 10:16:06 INFO - 'HOME': '/home/cltbld', 10:16:06 INFO - 'LANG': 'en_US.UTF-8', 10:16:06 INFO - 'LANGUAGE': 'en_US:en', 10:16:06 INFO - 'LOGNAME': 'cltbld', 10:16:06 INFO - 'MAIL': '/var/mail/cltbld', 10:16:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:16:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:16:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:06 INFO - 'MOZ_NO_REMOTE': '1', 10:16:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:16:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:06 INFO - 'NO_EM_RESTART': '1', 10:16:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:06 INFO - 'PWD': '/builds/slave/test', 10:16:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:16:06 INFO - 'SHELL': '/bin/bash', 10:16:06 INFO - 'SHLVL': '1', 10:16:06 INFO - 'TERM': 'linux', 10:16:06 INFO - 'TMOUT': '86400', 10:16:06 INFO - 'USER': 'cltbld', 10:16:06 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1479492863.879721-404384121', 10:16:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:06 INFO - '_': '/tools/buildbot/bin/python'} 10:16:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dREUHLS-RmO9BTKTsLvTKQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 10:16:07 INFO - mozversion application_buildid: 20161118073145 10:16:07 INFO - mozversion application_changeset: 46127b3a981bceb0413c8199849f4e47afc949da 10:16:07 INFO - mozversion application_display_name: Nightly 10:16:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:16:07 INFO - mozversion application_name: Firefox 10:16:07 INFO - mozversion application_remotingname: firefox 10:16:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:16:07 INFO - mozversion application_vendor: Mozilla 10:16:07 INFO - mozversion application_version: 53.0a1 10:16:07 INFO - mozversion platform_buildid: 20161118073145 10:16:07 INFO - mozversion platform_changeset: 46127b3a981bceb0413c8199849f4e47afc949da 10:16:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:16:07 INFO - mozversion platform_version: 53.0a1 10:16:07 INFO - using testdate: 1479492967 10:16:07 INFO - actual date: 1479492967 10:16:07 INFO - starting webserver on 'localhost:39293' 10:16:07 INFO - SUITE-START | Running 2 tests 10:16:07 INFO - TEST-START | dromaeo_css 10:16:07 INFO - operating with platform_type : linux_ 10:16:07 INFO - Initialising browser for dromaeo_css test... 10:16:07 INFO - TEST-INFO | started process 606 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvLP5lR/profile http://localhost:39293/getInfo.html) 10:16:11 INFO - PROCESS | 606 | __metrics Screen width/height:1600/1200 10:16:11 INFO - PROCESS | 606 | colorDepth:24 10:16:11 INFO - PROCESS | 606 | Browser inner width/height: 1024/697 10:16:11 INFO - PROCESS | 606 | __metrics 10:16:12 INFO - PROCESS | 606 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:16:12 INFO - PROCESS | 606 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:16:12 INFO - PROCESS | 606 | console.error: PushService: 10:16:12 INFO - PROCESS | 606 | stateChangeProcessEnqueue: Error transitioning state 10:16:12 INFO - PROCESS | 606 | UnknownError 10:16:13 INFO - TEST-INFO | 606: exit 0 10:16:13 INFO - Browser initialized. 10:16:13 INFO - Running cycle 1/1 for dromaeo_css test... 10:16:13 INFO - TEST-INFO | started process 689 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvLP5lR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:16:25 INFO - PROCESS | 689 | RSS: Main: 173666304 10:16:25 INFO - PROCESS | 689 | 10:17:16 INFO - PROCESS | 689 | 1479493036771 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] 10:19:27 INFO - PROCESS | 689 | Cycle 1(1): loaded http://localhost:39293/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39293/tests/dromaeo/cssquery-ext.html) 10:19:28 INFO - PROCESS | 689 | RSS: Main: 325533696 10:19:28 INFO - PROCESS | 689 | 10:22:31 INFO - PROCESS | 689 | Cycle 1(1): loaded http://localhost:39293/tests/dromaeo/cssquery-ext.html (next: http://localhost:39293/tests/dromaeo/cssquery-jquery.html) 10:22:32 INFO - PROCESS | 689 | RSS: Main: 279302144 10:22:32 INFO - PROCESS | 689 | 10:25:34 INFO - PROCESS | 689 | Cycle 1(1): loaded http://localhost:39293/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39293/tests/dromaeo/cssquery-mootools.html) 10:25:34 INFO - PROCESS | 689 | RSS: Main: 281419776 10:25:34 INFO - PROCESS | 689 | 10:28:36 INFO - PROCESS | 689 | Cycle 1(1): loaded http://localhost:39293/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39293/tests/dromaeo/cssquery-prototype.html) 10:28:37 INFO - PROCESS | 689 | RSS: Main: 220295168 10:28:37 INFO - PROCESS | 689 | 10:31:40 INFO - PROCESS | 689 | Cycle 1(1): loaded http://localhost:39293/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39293/tests/dromaeo/cssquery-yui.html) 10:31:40 INFO - PROCESS | 689 | RSS: Main: 216522752 10:31:40 INFO - PROCESS | 689 | 10:34:43 INFO - PROCESS | 689 | Cycle 1(1): loaded http://localhost:39293/tests/dromaeo/cssquery-yui.html (next: http://localhost:39293/tests/dromaeo/cssquery-dojo.html) 10:34:43 INFO - PROCESS | 689 | RSS: Main: 309559296 10:34:43 INFO - PROCESS | 689 | 10:34:43 INFO - PROCESS | 689 | __start_tp_report 10:34:43 INFO - PROCESS | 689 | _x_x_mozilla_page_load 10:34:43 INFO - PROCESS | 689 | _x_x_mozilla_page_load_details 10:34:43 INFO - PROCESS | 689 | |i|pagename|runs| 10:34:43 INFO - PROCESS | 689 | |0;dojo.html;2875.1518302100876;3013.1864396612923;3013.623297087864;3026.8183908965448;3030.848457577122;5180.067587834188;5205.479452054793;5255.080360936835;5322.414534401213;5346.732663366831;5226.973865130679;5277.525022747952;5291.100512912804;5307.920381194285;5343.812966546172;4781.713097214161;4806.83176088837;4847.321375007502;4854.393200849894;4896.290037944496;4899.730514821684;4921.8523444296725;4927.926081108768;4969.751512424383;4989.401271847383;4789.521047895218;4818.975905120487;4863.270509423597;4872.171730805771;4897.828575999841;4686.2267725825195;4731.834385796481;4733.786979585927;4783.689060211075;4833.564979151858;4800.399950006249;4824.5899098576665;4825.493323201048;4854.956184420366;4878.365812444359;5243.947560524384;5294.841154765363;5311.309529761145;5314.176302673091;5338.9466105339225;5450.509454149106;5489.533389661883;5682;5688.63023903445;5696.629719068247;5593.860153496154;5656.038473459522;5662.716864156776;5680.204771332017;5717.456841600041;5311.389190243133;5312.867178320535;5316.65441746293;5317.335333083403;5319.255304257407;5605.495505404533;5800.59395842287;5802.390748971382;5808.099744539603;5842.444967728059;5345.545628621533;5495.0383682855345;5575.52608028314;5602.523785478198;5602.719864006784;5610.354809196994;5641.069223578145;5644.915326270109;5650.604457688005;5671.064274394761;5578.609497335228;5584.888302233932;5589.049861523551;5589.524890384281;5605.439456054362;5516.91724624131;5526.06056970316;5576.9163462548095;5654.547636189095;5662.009148399014;4382.978085109554;4389.934150987738;4394.934075988863;4395.604395604347;4427.800748966304;3821.121142137268;3901.200253947934;3919.235749028912;3968.543617484026;3982.6017398260524;5416.566674666017;5422.945770542323;5429.67421954684;5447.400785913546;5476.096444086761;5684.346300175533;5685.772569097273;5688.800891968761;5689.317281926195;5691.089425691869;5208.8437346879655;5269.341332333458;5421.376541697677;5422.728863556886;5461.0716178249795;4943.4809345018975;4974.626902982291;4983.8504844854715;5010.298558201855;5048.040872234264;5884.676342801015;5956.8808623828145;5958.582899197101;5966.105084237399;5968.104784282393;5448.83653490396;5671.886562268649;5686.402927692533;5695.772169113189;5697.1454281856395;5762.654240745569;5870.55970802183;5889.204957330706;5901.616394934315;5984.700764961822;5552;5563.415841336763;5563.471470210324;5564.165375193591;5566.053770859045;5649.6327738696855;5660.094384898396;5663.5469162467725;5665.291838520185;5666.376698563073;5372.301600791872;5386.596005299697;5442.918356224581;5450.236966824568;5516.117421212587;5401.297831281908;5449.945500544944;5452.591055670761;5472.179173124063;5490.176473529003;5436.809711660231;5480.314960629921;5491.835244942658;5500.4224556420995;5531.668099914018;5461.890762184814;5498.752556134904;5515.641483303572;5519.862003449946;5551.722413879209;5494.697791621499;5495.175723641326;5498.230247765236;5527.50252477279;5546.7781288748 10:34:43 INFO - PROCESS | 689 | |1;ext.html;534.6285399125555;578.6441338576775;586.4106572894241;604.407680473136;604.6795198544772;31458;34273.82863085684;41473.79263103684;42274.78862605683;42406;42859.57140428603;43060.13879722403;43263;43349;43396.783016084875;8449.493030418163;8638.827223455528;8643.265322447569;8647.264982476498;8650.091740367265;7914.129445760962;8125.959370203141;8570.057293697688;9992.050755178247;10245.129164021067;10312.742181445486;10375.16998640107;10376.377417354945;10382.79234415315;10389.896101039007;10232.846507302396;10325.58697652093;10344.948275258575;10352.948235258775;10358.482075896212;10223.335483193643;10282.845757313646;10293.536790844355;10295.124914382286;10296.742581435525;40021.59978400208;40816;40893.38659920103;40945.38581921274;40952.180956381;3727.4036154215196;3792.4500947362753;3938.6652134568308;4076.2255171517613;4154.1068670235745;31068.378632427226;31364.686353136633;31619;31876.25556436228;32303.192420189447;4079.388091786226;4223.577642235752;4240.109576988805;4269.658427325807;4482.932756008662;309304;310688;312100.99999999773;312386;312424;34907.4763878542;56914.89361702108;57210.14184787231;57533;57641.13538296929;35567.39946702404;37481.250374992895;37711.81144094262;37731.81134094312;37737.62262377396;14979.400823967137;15118.773218401733;15125.773113403307;15130.89816587597;15140.697186056217;11318.830217546743;12295.077869159848;12346.876531234573;12366.690832729073;12389.876101239053;8187.877181842277;8372.748817535483;8554.331905278412;8565.271951884035;8688.913110868936;3353.480210567366;3355.865765369358;3359.428897087501;3374.578177727784;3387.644297348743;1027.2552399510296;1047.518141654832;1109.7170221593442;1129.0741591894569;1164.4119719541748;31389.37221255562;31822.681773182434;35177;35198.472022919676;35268;1090.1932569898377;1110.5058249079243;1137.988620113805;1163.4938801621151;1184.490669012333;16756.329746810236;16762.497125086265;16823.66352672964;16925.576860578338;16927.915360423118;454322;454346;456495;456594;458146;55775;56111.15833262504;56124.15813762797;56232.437675623536;56557.7172114145;1250.6498180509473;1277.3549357574552;1287.0604458745167;1332.5202926946292;1359.4358341288255;27959.58060629133;33454.83272583621;34212.82893585516;34529.30941381209;34788.47817282692;53659;54733;55188.72405638107;55256.44743552513;60649;433796;437933;438815;439069;439191;27413.17760467189;28010.85994570014;42926;43274.45618210168;43784.34323485214;36968.054578210904;46593.53406465892;46696.766516167205;46750;47023;39503.80248098741;40462.393064103475;40533.39199912063;40940.59059409487;41722.791386042874;39777.40333895052;39909.60090399059;39934.40098398585;40374.1925161501;41614.58385416107;40424.3936340961;40753.796231018656;40977.59022409738;41285.38071928984;41343.173136537705;33743.83128084344;35801.82099089592;36235.63764362428;37087.629123708415;37328.25343493061;27017.459650806482;27751.722482774912;27926;27929;27964.161075166965 10:34:43 INFO - PROCESS | 689 | |2;jquery.html;395.62020460358036;396.8313466776623;404.4822627037393;408.9039075817183;414.7926036981509;13779;17055.317787288495;17808.28766849326;19354.322598709048;19362.32231871883;15255.160966146857;16651.250693718783;17990;18131;18223.36218232362;4920.48334924834;5179.989901969117;5194.220866869962;5198.142306519419;5205.427402985669;5069.2142717878605;5155.20094385369;5233.084210263208;5233.528982391584;5233.712145831978;5140.871478213037;5192.1952097424955;5200.349956255468;5203.245529398235;5204.245384419257;5177.404598471167;5193.402758682724;5198.27224188612;5200.713960732158;5202.791888324463;5129.3075434816565;5159.58723302135;5160.148575485078;5163.483651634844;5165.121929271995;13325.267110308929;13442;17511;23046.16030633569;23253.651195232083;2296.6555016747457;2336.2757545161053;2400.627902675088;2491.95016099677;2534.2903986883516;9886.258530610234;10153.543090560943;10318.071373576415;10455.21585881062;11583.826242606368;1874.8687591868575;1907.1322548240516;1951.7755458122356;1952.2776572668063;1986.523234423728;81490.63882393192;81727;86347;87166.56416717939;87434.12565874323;10536.631217907336;10749.140068794477;10820.458977051116;10913.618023369303;11100.666979990614;14916.179610121331;14916.701665966837;14939.925300373428;14981;15026.17356045428;7132.465065120136;7421.8125099983745;7501.212372700897;7535.321821036133;7765.602433097211;6949.93050069503;6954.79135625932;6970.302969703091;7153.213146553875;8197.262246397853;4650.534946505322;4687.789049492781;4795.136875362398;4828.275758636162;4858.441279252931;1878.8872667639985;1937.467196520968;1958.4516335426104;1961.901904904749;2009.276660402254;948.6584829461389;955.9952200238954;991.1525645573075;1037.5901518899993;1038.6260946059413;19447;19470.902645486683;19514.12186451613;19527.707084393747;19624.607507849763;875.9824803503894;961.3558915526474;987.7777500062429;1007.5365331947386;1025.620520407439;9954.203663706887;10641.787164256672;10792.78414431707;10819.350838949687;10863;453238;453539.71682265337;457954;459678;463510.6015988611;89059;89930.99999999869;91689.5415522918;92151;94788;983.5033308179324;999.0309399882103;1006.225206590921;1032.7418145463635;1035.0219043004288;16398.508044758677;16612.2524486396;16884.409045683344;16927.830721693117;17156.571085722957;39874.401883971186;40026.39960400655;41163.588364115974;42345.788271058445;42952.78523607362;53879.730601346746;54739;55771;57763.711181445506;58681;8150.673973041012;8287.751367458744;8314.542700151549;8374.241409304115;8600.09698981598;12374.690632734253;12639.620811375673;12678.175918565632;12772.42524086437;13124.803127952897;11009.229353945148;11229.943850280697;11537.250078744855;11718.70703232426;11745.823812642646;10888.836667449836;11053.336799792038;11188;11423.885761142283;11451.48468318911;11374.146938979444;11416.543338266376;11481.425928703698;11486.770264594828;11568.363739994382;8159.673613055411;8319.916800832156;8367.330613551023;8494.787630309293;8630.223279904838;10997.800439911889;11425.828612570984;11575.76848463043;11743.706407339543;11984.28094314344 10:34:43 INFO - PROCESS | 689 | |3;mootools.html;1323.5301467978861;1477.2392218007722;1492.693997730465;1597.7124117658825;1716.5022143578362;7516.624168791559;7985.600719964001;8122.025356957166;8218.547979861105;8419.115992820758;8223.34213262939;8273.91726082739;8293.460925039868;8300.91699083009;8303.252707256346;2278.7949084582424;2307.457747429353;2313.618252988255;2315.2938353802083;2315.316981490456;2228.5877112734197;2285.325828880484;2286.1541229745017;2286.8627882327114;2308.4575124845646;2276.8406211565116;2296.7473577906417;2308.9422764430856;2312.2022902098834;2317.4206448387904;2168.6638571021517;2184.071769497957;2196.494806194576;2197.8131858791944;2198.076807740753;2243.8541494802785;2267.5351552931775;2270.3416009357265;2270.965935510969;2274.465500607356;8240.093589705128;8322.62548185333;8327.458715183555;8328.750137495885;8437.662493500315;5187.299714538564;5339.652922560022;5342;5343.973280133613;5353.866153346197;3309.7186739127205;3415.624281329052;3420.794752314844;3489.9825500872334;3492.0396890854963;1116.2967330581762;1117.4859564600295;1128.8363187337873;1137.2039572299423;1138.869030061537;11514.654560363202;11601.651950441415;11607.477663505162;11646.650600481998;11664.766704665859;4195.349720793282;4486.64106871456;4504.256797628354;4575.725456472623;4578.5421457853945;9514.952425237829;9517.762055948657;9519.048095190565;9524.666636667822;9527.333086683866;5171.922421163686;5174.767135478913;5183.81856635016;5189.4032186299055;5195.480451954774;4130.297849365615;4248.74507529543;4620.67655264135;4711.010687755541;4858.222684370484;3699.186179040607;3738.327096126283;3788.8484460621817;3810.371288737327;3815.561210460777;1155.8150695888785;1178.4932479034098;1183.911206659504;1187.3706935324292;1191.1840389333333;873.8732883731823;882.280941033056;890.955452227399;902.1654969153507;915.272358475014;5362;5372.409035006146;5471.972640136853;5510;5622.7750889963945;422.5710903432957;427.6429181633371;431.51239099817633;431.9762413067249;440.9581089796464;3526.365254254259;3576.2847430514003;3609.5488063992;3622.4747411625694;3708.054446116277;10269.640562580424;10813.351198928089;10813.56745730162;10815.080718139046;10839.783204335869;10607.84088238677;10709.839352409721;10713.464326783629;10738.892611073788;10742.73143171427;7554.357879580188;8014.078380986145;8075.313598344089;8106.63520141595;8113;5188.143956247328;5218.347706536683;5241.895162096813;5359.544438722753;5480.342358916955;9740.659076932274;9754.365966212174;9760.902390976284;9768.023197680175;9885.209183265179;9844;10133.695989120339;10196.643117490852;10199.796004080024;10226.233032522441;6703.93296067033;6864.107666003388;6892.862142757217;6918.377346038679;7120.465965052538;8163.79590510242;8532.829343413221;8549.444286121383;8549.615267312862;8556.828863422572;7297.963510182415;7322.926770732224;7478.775636730907;7514.248575142442;7545.283198096172;6973.093497845248;7141.750038748619;7169.964150179424;7171.1394632644415;7303.926960730537;6545.705443254969;6662.467002639874;6663.167104111986;6667.233268174028;6667.899981500184;4464.084862603224;4584.472785629695;4688.226442637063;4739.289106634033;4808.158572249912;4596.6092882105395;4661.091087238092;4702.623790096715;4737.360456338351;4907.116718990616 10:34:43 INFO - PROCESS | 689 | |4;prototype.html;329.7790480378148;332.82512730062876;339.82499013008305;340.3210594863248;342.19583977652536;4986.950130498694;5064.898702025957;5106.565941894939;5197.76610052548;5213.478652134785;4922.60619150468;5034.572061374787;5059.721715305656;5095.643304968654;5096.79612815487;4043.919121617566;4048.6153815387493;4060.4721386219826;4063.939040914374;4069.633732964033;3776.4146557283666;3861.1891502784447;4072.7149099563044;4075;4077.5718549552316;4002.359622460407;4010.6189911958318;4011.679065674739;4032.5362583303004;4037.5263028994354;3977.9005524861823;3984.362501999666;3991.1419044905483;4010.5588385277597;4011.63895249426;3577.9821100894587;3591.407417776064;3595;3595.676389124991;3598.8200589970656;4878.682885612424;4947.194274089968;4948.480409556981;4978.6514943953935;4990.575801056914;4571.588557029883;4575.428071491064;4576.199165146119;4581.5647513486165;4587.1513769952335;5297.17893726473;5299.152135658314;5301.860100078463;5303.814366497193;5306.6550674206055;3846.807659617036;3900.3564411872007;3920.1375697346825;3936.5866584008554;3953.6441720245316;5484.369297530795;5504;5515.61390702655;5517.200005999148;5526.585506087019;4020.859269925597;4021.5174179098694;4026.174634199982;4031;4036.889855289819;3972.682185425159;4018.2530756234655;4046.575109613448;4053.9391909121387;4071.776052317151;4543.204939135638;4561.954380456153;4580.404547408815;4580.427446569179;4591.4260717410325;5293.100172970604;5293.920591191135;5351.919721204185;5356.303680521585;5358.6248962572245;1238.3622434446268;1292.4184117147322;1313.9802902956462;1368.6167872995577;1374.9862501375057;945.921649319776;955.254901177083;962.767657398531;963.1283688262134;966.6703245179225;4962.478939711278;4986.925196122061;4994.40067191932;4994.675346102492;5004.724740139327;5233.979374022029;5237.476252374809;5244;5256.868578285497;5270.841874743764;4760.9285860711425;4924.433690125681;4933.28467372229;4948.604111671058;5009.248612708123;2743.6021776842244;2749.5015216706943;2766.806323557332;2774.750272475487;2778.7360200780895;5477.917831232535;5496.532794712414;5497.917531236954;5510;5513.889722205534;5070.29015937769;5291.417944026154;5314.7874085036165;5339.305890234323;5362.946370536322;5459.597776978117;5466.972665136649;5468.28912241406;5470.699111548983;5510.6969116698165;5198.246254293182;5203.531682148625;5228.712420816892;5241.240020196974;5242.135047717084;5074.892142406676;5130.4100028497205;5130.435652078343;5184.222366645034;5185;5412.675239485643;5426.972865135649;5446;5447.291852059207;5467.835964921059;3876.7673939563715;3880.4761357216416;3902.4536564881505;3902.492675952222;3905.6875449964505;5093.853734053809;5139.6145289102715;5141.845744627667;5142.614303927146;5190.870228244324;5141.434442211428;5157.581665041994;5287.233351164136;5301.496357845998;5340.919886201632;5331.920021199608;5353.170258609922;5364.865878353073;5367.597430192673;5369.946300536944;5155.381354237516;5288.180332048539;5330.573554115739;5345.305110335787;5350.384705758887;5387.407385187705;5400.972995134999;5413.431589683027;5423.538999185113;5432.130859062531;5304.628675992798;5312.681239125664;5324;5329.493698098674;5332.253484512249 10:34:43 INFO - PROCESS | 689 | |5;yui.html;769.3306823063933;770.7841804294798;804.798800299925;817.1868990354598;823.1357075071173;13450.19298842069;14377.56867293983;14389.424423023067;14395;14411.27943602821;12237.510499580007;13629.25039122848;13802.516911908086;13828.723425531483;14742.63143421415;763.9961800191019;783.5533745764916;784.6155383861895;784.6861255497818;786.4691333349995;793.2226418110256;794.8489786940492;796.0526972902256;796.4066770256168;797.1390897830358;839.7522730794431;841.4824882697159;841.7769291137853;841.9957900210491;842.065307508668;834.5243211369522;836.5566249887569;836.9916300837035;837.2381133168788;838.2330167896398;611.5902345428574;612.2224774536359;612.4763327355092;612.8712970276202;612.9785457508966;13816.032877698564;13845.515406960809;13867.37596808146;13955.651108722263;13980.790288145687;13440.5295814647;14107.294635268297;14121.85878141226;14221.288935553284;14357.282135893163;11476.4835582399;11496;11606.129540284512;11610.245334053345;11619.767604647945;3719.6094410087094;3750.1562148516364;3774.9622503774885;3788.45067465216;3902.4731661225655;41583.37624935628;42721.35917961233;50499.24251136236;53894.73052634751;59797.40202598005;10952.890471095187;11157.609483668033;11295.322280663186;11373.829392559119;11396;19824.107915143853;19893.701594476093;19900.90049549743;20054.89972550157;20121.496962576053;7992.68029278834;8061.234182752629;8210.466319689202;8328.167183281745;8403.805496828796;4482.260427029503;4607.654425918069;4627.606653434428;4714.57568818808;4819.903601928012;3268.9019329420157;3366.377220214268;3370.7808992415416;3374.4263475209273;3376.341613385366;603.8882806680778;609.7743834781071;612.5589575505629;623.5946634687399;631.4285571557748;740.0822979505482;740.226463345805;745.8918456823839;768.7036319756879;779.4855395439097;8155.592220388957;8267.090620031911;8521.53131577769;8793.736187914245;8826.779330516789;724.1021133794163;730.1274976403254;736.9705211791576;739.3826155160393;748.6518768772547;4006.8797936061383;4223.767692776927;4245.893852653709;4322.37325587788;4380.6933514653665;78993;89475;90625.54687226654;91286.54356728174;94917.52541237387;77145;78332.21667783249;78813;80747.19252807515;82919.5854020738;44535.777321113186;65103.34896650973;65174.67412662906;66049.33950660432;66565.66717166384;9318.72043838686;9815.214782817215;9919.65281215154;9933.255005874444;10037.197024237897;40388.394174086825;43157.17378154035;43846.56153438425;44372.33441498445;46259.074818504116;53935.73032134814;61910.69044654748;61976.69011654913;63267.683661581395;64120.35879641144;11862.762744745229;12040.75918481608;12320.507179712711;12623.179493332904;12633.494660213857;13491;13492.5277615283;13935.442582296595;14013;14206.289685515889;12322.507099715911;12509.124361294622;12707.618771436872;13151.868481315065;13445.932770336085;11881.762364752483;11907.404629768303;11919.821202681793;11962.222455540363;12880.806787898002;12389.504419823106;12684.175528590613;12691;12800.935995320337;12829.294388808705;10428.478576071015;10558.861334299474;10725.356478611307;10795.40625265618;11001.644498427737;10445.529951152368;10652.361622517468;10950;11054.22620416563;11185.552577897119 10:34:43 INFO - PROCESS | 689 | __end_tp_report 10:34:43 INFO - PROCESS | 689 | __start_cc_report 10:34:43 INFO - PROCESS | 689 | _x_x_mozilla_cycle_collect,1420 10:34:43 INFO - PROCESS | 689 | __end_cc_report 10:34:43 INFO - PROCESS | 689 | __startTimestamp1479494083739__endTimestamp 10:34:43 INFO - PROCESS | 689 | 10:34:43 INFO - PROCESS | 689 | ------- Summary: start ------- 10:34:43 INFO - PROCESS | 689 | Number of tests: 6 10:34:43 INFO - PROCESS | 689 | 10:34:43 INFO - PROCESS | 689 | [#0] dojo.html Cycles:165 Average:5261.76 Median:5450.51 stddev:590.41 (10.8%) stddev-sans-first:561.75 10:34:43 INFO - PROCESS | 689 | Values: 2875.2 3013.2 3013.6 3026.8 3030.8 5180.1 5205.5 5255.1 5322.4 5346.7 5227.0 5277.5 5291.1 5307.9 5343.8 4781.7 4806.8 4847.3 4854.4 4896.3 4899.7 4921.9 4927.9 4969.8 4989.4 4789.5 4819.0 4863.3 4872.2 4897.8 4686.2 4731.8 4733.8 4783.7 4833.6 4800.4 4824.6 4825.5 4855.0 4878.4 5243.9 5294.8 5311.3 5314.2 5338.9 5450.5 5489.5 5682.0 5688.6 5696.6 5593.9 5656.0 5662.7 5680.2 5717.5 5311.4 5312.9 5316.7 5317.3 5319.3 5605.5 5800.6 5802.4 5808.1 5842.4 5345.5 5495.0 5575.5 5602.5 5602.7 5610.4 5641.1 5644.9 5650.6 5671.1 5578.6 5584.9 5589.0 5589.5 5605.4 5516.9 5526.1 5576.9 5654.5 5662.0 4383.0 4389.9 4394.9 4395.6 4427.8 3821.1 3901.2 3919.2 3968.5 3982.6 5416.6 5422.9 5429.7 5447.4 5476.1 5684.3 5685.8 5688.8 5689.3 5691.1 5208.8 5269.3 5421.4 5422.7 5461.1 4943.5 4974.6 4983.9 5010.3 5048.0 5884.7 5956.9 5958.6 5966.1 5968.1 5448.8 5671.9 5686.4 5695.8 5697.1 5762.7 5870.6 5889.2 5901.6 5984.7 5552.0 5563.4 5563.5 5564.2 5566.1 5649.6 5660.1 5663.5 5665.3 5666.4 5372.3 5386.6 5442.9 5450.2 5516.1 5401.3 5449.9 5452.6 5472.2 5490.2 5436.8 5480.3 5491.8 5500.4 5531.7 5461.9 5498.8 5515.6 5519.9 5551.7 5494.7 5495.2 5498.2 5527.5 5546.8 10:34:43 INFO - PROCESS | 689 | 10:34:43 INFO - PROCESS | 689 | [#1] ext.html Cycles:180 Average:55897.14 Median:37721.81 stddev:107612.02 (285.3%) stddev-sans-first:107833.62 10:34:43 INFO - PROCESS | 689 | Values: 534.6 578.6 586.4 604.4 604.7 31458.0 34273.8 41473.8 42274.8 42406.0 42859.6 43060.1 43263.0 43349.0 43396.8 8449.5 8638.8 8643.3 8647.3 8650.1 7914.1 8126.0 8570.1 9992.1 10245.1 10312.7 10375.2 10376.4 10382.8 10389.9 10232.8 10325.6 10344.9 10352.9 10358.5 10223.3 10282.8 10293.5 10295.1 10296.7 40021.6 40816.0 40893.4 40945.4 40952.2 3727.4 3792.5 3938.7 4076.2 4154.1 31068.4 31364.7 31619.0 31876.3 32303.2 4079.4 4223.6 4240.1 4269.7 4482.9 309304.0 310688.0 312101.0 312386.0 312424.0 34907.5 56914.9 57210.1 57533.0 57641.1 35567.4 37481.3 37711.8 37731.8 37737.6 14979.4 15118.8 15125.8 15130.9 15140.7 11318.8 12295.1 12346.9 12366.7 12389.9 8187.9 8372.7 8554.3 8565.3 8688.9 3353.5 3355.9 3359.4 3374.6 3387.6 1027.3 1047.5 1109.7 1129.1 1164.4 31389.4 31822.7 35177.0 35198.5 35268.0 1090.2 1110.5 1138.0 1163.5 1184.5 16756.3 16762.5 16823.7 16925.6 16927.9 454322.0 454346.0 456495.0 456594.0 458146.0 55775.0 56111.2 56124.2 56232.4 56557.7 1250.6 1277.4 1287.1 1332.5 1359.4 27959.6 33454.8 34212.8 34529.3 34788.5 53659.0 54733.0 55188.7 55256.4 60649.0 433796.0 437933.0 438815.0 439069.0 439191.0 27413.2 28010.9 42926.0 43274.5 43784.3 36968.1 46593.5 46696.8 46750.0 47023.0 39503.8 40462.4 40533.4 40940.6 41722.8 39777.4 39909.6 39934.4 40374.2 41614.6 40424.4 40753.8 40977.6 41285.4 41343.2 33743.8 35801.8 36235.6 37087.6 37328.3 27017.5 27751.7 27926.0 27929.0 27964.2 10:34:43 INFO - PROCESS | 689 | 10:34:43 INFO - PROCESS | 689 | [#2] jquery.html Cycles:180 Average:27709.52 Median:396.23 stddev:75762.70 (19121.1%) stddev-sans-first:75947.48 10:34:43 INFO - PROCESS | 689 | Values: 395.6 396.8 404.5 408.9 414.8 13779.0 17055.3 17808.3 19354.3 19362.3 15255.2 16651.3 17990.0 18131.0 18223.4 4920.5 5180.0 5194.2 5198.1 5205.4 5069.2 5155.2 5233.1 5233.5 5233.7 5140.9 5192.2 5200.3 5203.2 5204.2 5177.4 5193.4 5198.3 5200.7 5202.8 5129.3 5159.6 5160.1 5163.5 5165.1 13325.3 13442.0 17511.0 23046.2 23253.7 2296.7 2336.3 2400.6 2492.0 2534.3 9886.3 10153.5 10318.1 10455.2 11583.8 1874.9 1907.1 1951.8 1952.3 1986.5 81490.6 81727.0 86347.0 87166.6 87434.1 10536.6 10749.1 10820.5 10913.6 11100.7 14916.2 14916.7 14939.9 14981.0 15026.2 7132.5 7421.8 7501.2 7535.3 7765.6 6949.9 6954.8 6970.3 7153.2 8197.3 4650.5 4687.8 4795.1 4828.3 4858.4 1878.9 1937.5 1958.5 1961.9 2009.3 948.7 956.0 991.2 1037.6 1038.6 19447.0 19470.9 19514.1 19527.7 19624.6 876.0 961.4 987.8 1007.5 1025.6 9954.2 10641.8 10792.8 10819.4 10863.0 453238.0 453539.7 457954.0 459678.0 463510.6 89059.0 89931.0 91689.5 92151.0 94788.0 983.5 999.0 1006.2 1032.7 1035.0 16398.5 16612.3 16884.4 16927.8 17156.6 39874.4 40026.4 41163.6 42345.8 42952.8 53879.7 54739.0 55771.0 57763.7 58681.0 8150.7 8287.8 8314.5 8374.2 8600.1 12374.7 12639.6 12678.2 12772.4 13124.8 11009.2 11229.9 11537.3 11718.7 11745.8 10888.8 11053.3 11188.0 11423.9 11451.5 11374.1 11416.5 11481.4 11486.8 11568.4 8159.7 8319.9 8367.3 8494.8 8630.2 10997.8 11425.8 11575.8 11743.7 11984.3 10:34:43 INFO - PROCESS | 689 | 10:34:43 INFO - PROCESS | 689 | [#3] mootools.html Cycles:180 Average:5516.51 Median:4674.66 stddev:3179.38 (68.0%) stddev-sans-first:3172.69 10:34:43 INFO - PROCESS | 689 | Values: 1323.5 1477.2 1492.7 1597.7 1716.5 7516.6 7985.6 8122.0 8218.5 8419.1 8223.3 8273.9 8293.5 8300.9 8303.3 2278.8 2307.5 2313.6 2315.3 2315.3 2228.6 2285.3 2286.2 2286.9 2308.5 2276.8 2296.7 2308.9 2312.2 2317.4 2168.7 2184.1 2196.5 2197.8 2198.1 2243.9 2267.5 2270.3 2271.0 2274.5 8240.1 8322.6 8327.5 8328.8 8437.7 5187.3 5339.7 5342.0 5344.0 5353.9 3309.7 3415.6 3420.8 3490.0 3492.0 1116.3 1117.5 1128.8 1137.2 1138.9 11514.7 11601.7 11607.5 11646.7 11664.8 4195.3 4486.6 4504.3 4575.7 4578.5 9515.0 9517.8 9519.0 9524.7 9527.3 5171.9 5174.8 5183.8 5189.4 5195.5 4130.3 4248.7 4620.7 4711.0 4858.2 3699.2 3738.3 3788.8 3810.4 3815.6 1155.8 1178.5 1183.9 1187.4 1191.2 873.9 882.3 891.0 902.2 915.3 5362.0 5372.4 5472.0 5510.0 5622.8 422.6 427.6 431.5 432.0 441.0 3526.4 3576.3 3609.5 3622.5 3708.1 10269.6 10813.4 10813.6 10815.1 10839.8 10607.8 10709.8 10713.5 10738.9 10742.7 7554.4 8014.1 8075.3 8106.6 8113.0 5188.1 5218.3 5241.9 5359.5 5480.3 9740.7 9754.4 9760.9 9768.0 9885.2 9844.0 10133.7 10196.6 10199.8 10226.2 6703.9 6864.1 6892.9 6918.4 7120.5 8163.8 8532.8 8549.4 8549.6 8556.8 7298.0 7322.9 7478.8 7514.2 7545.3 6973.1 7141.8 7170.0 7171.1 7303.9 6545.7 6662.5 6663.2 6667.2 6667.9 4464.1 4584.5 4688.2 4739.3 4808.2 4596.6 4661.1 4702.6 4737.4 4907.1 10:34:43 INFO - PROCESS | 689 | 10:34:43 INFO - PROCESS | 689 | [#4] prototype.html Cycles:180 Average:4451.42 Median:5072.59 stddev:1276.75 (25.2%) stddev-sans-first:1242.29 10:34:43 INFO - PROCESS | 689 | Values: 329.8 332.8 339.8 340.3 342.2 4987.0 5064.9 5106.6 5197.8 5213.5 4922.6 5034.6 5059.7 5095.6 5096.8 4043.9 4048.6 4060.5 4063.9 4069.6 3776.4 3861.2 4072.7 4075.0 4077.6 4002.4 4010.6 4011.7 4032.5 4037.5 3977.9 3984.4 3991.1 4010.6 4011.6 3578.0 3591.4 3595.0 3595.7 3598.8 4878.7 4947.2 4948.5 4978.7 4990.6 4571.6 4575.4 4576.2 4581.6 4587.2 5297.2 5299.2 5301.9 5303.8 5306.7 3846.8 3900.4 3920.1 3936.6 3953.6 5484.4 5504.0 5515.6 5517.2 5526.6 4020.9 4021.5 4026.2 4031.0 4036.9 3972.7 4018.3 4046.6 4053.9 4071.8 4543.2 4562.0 4580.4 4580.4 4591.4 5293.1 5293.9 5351.9 5356.3 5358.6 1238.4 1292.4 1314.0 1368.6 1375.0 945.9 955.3 962.8 963.1 966.7 4962.5 4986.9 4994.4 4994.7 5004.7 5234.0 5237.5 5244.0 5256.9 5270.8 4760.9 4924.4 4933.3 4948.6 5009.2 2743.6 2749.5 2766.8 2774.8 2778.7 5477.9 5496.5 5497.9 5510.0 5513.9 5070.3 5291.4 5314.8 5339.3 5362.9 5459.6 5467.0 5468.3 5470.7 5510.7 5198.2 5203.5 5228.7 5241.2 5242.1 5074.9 5130.4 5130.4 5184.2 5185.0 5412.7 5427.0 5446.0 5447.3 5467.8 3876.8 3880.5 3902.5 3902.5 3905.7 5093.9 5139.6 5141.8 5142.6 5190.9 5141.4 5157.6 5287.2 5301.5 5340.9 5331.9 5353.2 5364.9 5367.6 5369.9 5155.4 5288.2 5330.6 5345.3 5350.4 5387.4 5401.0 5413.4 5423.5 5432.1 5304.6 5312.7 5324.0 5329.5 5332.3 10:34:43 INFO - PROCESS | 689 | 10:34:43 INFO - PROCESS | 689 | [#5] yui.html Cycles:180 Average:17156.86 Median:44109.45 stddev:22737.11 (51.5%) stddev-sans-first:22767.59 10:34:43 INFO - PROCESS | 689 | Values: 769.3 770.8 804.8 817.2 823.1 13450.2 14377.6 14389.4 14395.0 14411.3 12237.5 13629.3 13802.5 13828.7 14742.6 764.0 783.6 784.6 784.7 786.5 793.2 794.8 796.1 796.4 797.1 839.8 841.5 841.8 842.0 842.1 834.5 836.6 837.0 837.2 838.2 611.6 612.2 612.5 612.9 613.0 13816.0 13845.5 13867.4 13955.7 13980.8 13440.5 14107.3 14121.9 14221.3 14357.3 11476.5 11496.0 11606.1 11610.2 11619.8 3719.6 3750.2 3775.0 3788.5 3902.5 41583.4 42721.4 50499.2 53894.7 59797.4 10952.9 11157.6 11295.3 11373.8 11396.0 19824.1 19893.7 19900.9 20054.9 20121.5 7992.7 8061.2 8210.5 8328.2 8403.8 4482.3 4607.7 4627.6 4714.6 4819.9 3268.9 3366.4 3370.8 3374.4 3376.3 603.9 609.8 612.6 623.6 631.4 740.1 740.2 745.9 768.7 779.5 8155.6 8267.1 8521.5 8793.7 8826.8 724.1 730.1 737.0 739.4 748.7 4006.9 4223.8 4245.9 4322.4 4380.7 78993.0 89475.0 90625.5 91286.5 94917.5 77145.0 78332.2 78813.0 80747.2 82919.6 44535.8 65103.3 65174.7 66049.3 66565.7 9318.7 9815.2 9919.7 9933.3 10037.2 40388.4 43157.2 43846.6 44372.3 46259.1 53935.7 61910.7 61976.7 63267.7 64120.4 11862.8 12040.8 12320.5 12623.2 12633.5 13491.0 13492.5 13935.4 14013.0 14206.3 12322.5 12509.1 12707.6 13151.9 13445.9 11881.8 11907.4 11919.8 11962.2 12880.8 12389.5 12684.2 12691.0 12800.9 12829.3 10428.5 10558.9 10725.4 10795.4 11001.6 10445.5 10652.4 10950.0 11054.2 11185.6 10:34:43 INFO - PROCESS | 689 | -------- Summary: end -------- 10:34:43 INFO - PROCESS | 689 | 10:34:44 INFO - TEST-INFO | 689: exit 0 10:34:44 INFO - TEST-OK | dromaeo_css | took 1117545ms 10:34:44 INFO - TEST-START | kraken 10:34:44 INFO - operating with platform_type : linux_ 10:34:44 INFO - Initialising browser for kraken test... 10:34:44 INFO - TEST-INFO | started process 1008 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvWxKg7/profile http://localhost:39293/getInfo.html) 10:34:48 INFO - PROCESS | 1008 | __metrics Screen width/height:1600/1200 10:34:48 INFO - PROCESS | 1008 | colorDepth:24 10:34:48 INFO - PROCESS | 1008 | Browser inner width/height: 1024/697 10:34:48 INFO - PROCESS | 1008 | __metrics 10:34:49 INFO - PROCESS | 1008 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:34:49 INFO - PROCESS | 1008 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:34:50 INFO - TEST-INFO | 1008: exit 0 10:34:50 INFO - Browser initialized. 10:34:50 INFO - Running cycle 1/1 for kraken test... 10:34:50 INFO - TEST-INFO | started process 1106 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvWxKg7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:35:02 INFO - PROCESS | 1106 | RSS: Main: 173649920 10:35:02 INFO - PROCESS | 1106 | 10:35:05 INFO - PROCESS | 1106 | Cycle 1(1): loaded http://localhost:39293/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39293/tests/kraken/driver.html?testName=audio-beat-detection) 10:35:06 INFO - PROCESS | 1106 | RSS: Main: 234881024 10:35:06 INFO - PROCESS | 1106 | 10:35:08 INFO - PROCESS | 1106 | Cycle 1(1): loaded http://localhost:39293/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39293/tests/kraken/driver.html?testName=audio-dft) 10:35:09 INFO - PROCESS | 1106 | RSS: Main: 216657920 10:35:09 INFO - PROCESS | 1106 | 10:35:12 INFO - PROCESS | 1106 | Cycle 1(1): loaded http://localhost:39293/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39293/tests/kraken/driver.html?testName=audio-fft) 10:35:13 INFO - PROCESS | 1106 | RSS: Main: 297787392 10:35:13 INFO - PROCESS | 1106 | 10:35:15 INFO - PROCESS | 1106 | Cycle 1(1): loaded http://localhost:39293/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39293/tests/kraken/driver.html?testName=audio-oscillator) 10:35:15 INFO - PROCESS | 1106 | RSS: Main: 207556608 10:35:15 INFO - PROCESS | 1106 | 10:35:18 INFO - PROCESS | 1106 | Cycle 1(1): loaded http://localhost:39293/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39293/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:35:18 INFO - PROCESS | 1106 | RSS: Main: 213303296 10:35:18 INFO - PROCESS | 1106 | 10:35:21 INFO - PROCESS | 1106 | Cycle 1(1): loaded http://localhost:39293/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39293/tests/kraken/driver.html?testName=imaging-darkroom) 10:35:22 INFO - PROCESS | 1106 | RSS: Main: 252923904 10:35:22 INFO - PROCESS | 1106 | 10:35:25 INFO - PROCESS | 1106 | Cycle 1(1): loaded http://localhost:39293/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39293/tests/kraken/driver.html?testName=imaging-desaturate) 10:35:26 INFO - PROCESS | 1106 | RSS: Main: 252317696 10:35:26 INFO - PROCESS | 1106 | 10:35:29 INFO - PROCESS | 1106 | Cycle 1(1): loaded http://localhost:39293/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39293/tests/kraken/driver.html?testName=json-parse-financial) 10:35:29 INFO - PROCESS | 1106 | RSS: Main: 251641856 10:35:29 INFO - PROCESS | 1106 | 10:35:31 INFO - PROCESS | 1106 | Cycle 1(1): loaded http://localhost:39293/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39293/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:35:31 INFO - PROCESS | 1106 | RSS: Main: 213364736 10:35:31 INFO - PROCESS | 1106 | 10:35:33 INFO - PROCESS | 1106 | Cycle 1(1): loaded http://localhost:39293/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39293/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:35:34 INFO - PROCESS | 1106 | RSS: Main: 220106752 10:35:34 INFO - PROCESS | 1106 | 10:35:36 INFO - PROCESS | 1106 | Cycle 1(1): loaded http://localhost:39293/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39293/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:35:36 INFO - PROCESS | 1106 | RSS: Main: 229756928 10:35:36 INFO - PROCESS | 1106 | 10:35:39 INFO - PROCESS | 1106 | Cycle 1(1): loaded http://localhost:39293/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39293/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:35:40 INFO - PROCESS | 1106 | RSS: Main: 238239744 10:35:40 INFO - PROCESS | 1106 | 10:35:42 INFO - PROCESS | 1106 | Cycle 1(1): loaded http://localhost:39293/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39293/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:35:43 INFO - PROCESS | 1106 | RSS: Main: 234795008 10:35:43 INFO - PROCESS | 1106 | 10:35:45 INFO - PROCESS | 1106 | Cycle 1(1): loaded http://localhost:39293/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39293/tests/kraken/driver.html?testName=ai-astar) 10:35:45 INFO - PROCESS | 1106 | RSS: Main: 286158848 10:35:45 INFO - PROCESS | 1106 | 10:35:45 INFO - PROCESS | 1106 | __start_tp_report 10:35:45 INFO - PROCESS | 1106 | _x_x_mozilla_page_load 10:35:45 INFO - PROCESS | 1106 | _x_x_mozilla_page_load_details 10:35:45 INFO - PROCESS | 1106 | |i|pagename|runs| 10:35:45 INFO - PROCESS | 1106 | |0;ai-astar;104;113;112;110;110;111;112;110;111;110 10:35:45 INFO - PROCESS | 1106 | |1;audio-beat-detection;145;124;123;160;126;124;122;127;159;123 10:35:45 INFO - PROCESS | 1106 | |2;audio-dft;161;160;162;163;160;161;161;160;162;162 10:35:45 INFO - PROCESS | 1106 | |3;audio-fft;75;75;76;109;77;76;76;75;101;75 10:35:45 INFO - PROCESS | 1106 | |4;audio-oscillator;83;82;116;82;81;82;101;82;81;116 10:35:45 INFO - PROCESS | 1106 | |5;imaging-gaussian-blur;117;117;117;116;116;117;117;117;117;117 10:35:45 INFO - PROCESS | 1106 | |6;imaging-darkroom;146;146;146;146;145;147;146;146;147;146 10:35:45 INFO - PROCESS | 1106 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;96 10:35:45 INFO - PROCESS | 1106 | |8;json-parse-financial;65;51;61;52;53;52;52;52;52;52 10:35:45 INFO - PROCESS | 1106 | |9;json-stringify-tinderbox;62;63;62;63;63;63;63;63;63;63 10:35:45 INFO - PROCESS | 1106 | |10;stanford-crypto-aes;84;87;81;81;82;86;85;81;80;82 10:35:45 INFO - PROCESS | 1106 | |11;stanford-crypto-ccm;132;133;144;135;133;131;144;139;176;149 10:35:45 INFO - PROCESS | 1106 | |12;stanford-crypto-pbkdf2;167;168;164;165;169;170;162;169;167;164 10:35:45 INFO - PROCESS | 1106 | |13;stanford-crypto-sha256-iterative;64;66;65;65;65;64;64;64;64;62 10:35:45 INFO - PROCESS | 1106 | __end_tp_report 10:35:45 INFO - PROCESS | 1106 | __start_cc_report 10:35:45 INFO - PROCESS | 1106 | _x_x_mozilla_cycle_collect,1662 10:35:45 INFO - PROCESS | 1106 | __end_cc_report 10:35:45 INFO - PROCESS | 1106 | __startTimestamp1479494145398__endTimestamp 10:35:45 INFO - PROCESS | 1106 | 10:35:45 INFO - PROCESS | 1106 | ------- Summary: start ------- 10:35:45 INFO - PROCESS | 1106 | Number of tests: 14 10:35:45 INFO - PROCESS | 1106 | 10:35:45 INFO - PROCESS | 1106 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:2.45 (2.2%) stddev-sans-first:1.12 10:35:45 INFO - PROCESS | 1106 | Values: 104.0 113.0 112.0 110.0 110.0 111.0 112.0 110.0 111.0 110.0 10:35:45 INFO - PROCESS | 1106 | 10:35:45 INFO - PROCESS | 1106 | [#1] audio-beat-detection Cycles:10 Average:133.30 Median:126.50 stddev:15.33 (12.1%) stddev-sans-first:15.67 10:35:45 INFO - PROCESS | 1106 | Values: 145.0 124.0 123.0 160.0 126.0 124.0 122.0 127.0 159.0 123.0 10:35:45 INFO - PROCESS | 1106 | 10:35:45 INFO - PROCESS | 1106 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.03 (0.6%) stddev-sans-first:1.09 10:35:45 INFO - PROCESS | 1106 | Values: 161.0 160.0 162.0 163.0 160.0 161.0 161.0 160.0 162.0 162.0 10:35:45 INFO - PROCESS | 1106 | 10:35:45 INFO - PROCESS | 1106 | [#3] audio-fft Cycles:10 Average:81.50 Median:75.50 stddev:12.55 (16.6%) stddev-sans-first:13.08 10:35:45 INFO - PROCESS | 1106 | Values: 75.0 75.0 76.0 109.0 77.0 76.0 76.0 75.0 101.0 75.0 10:35:45 INFO - PROCESS | 1106 | 10:35:45 INFO - PROCESS | 1106 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:82.00 stddev:14.67 (17.9%) stddev-sans-first:15.30 10:35:45 INFO - PROCESS | 1106 | Values: 83.0 82.0 116.0 82.0 81.0 82.0 101.0 82.0 81.0 116.0 10:35:45 INFO - PROCESS | 1106 | 10:35:45 INFO - PROCESS | 1106 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:35:45 INFO - PROCESS | 1106 | Values: 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 10:35:45 INFO - PROCESS | 1106 | 10:35:45 INFO - PROCESS | 1106 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 10:35:45 INFO - PROCESS | 1106 | Values: 146.0 146.0 146.0 146.0 145.0 147.0 146.0 146.0 147.0 146.0 10:35:45 INFO - PROCESS | 1106 | 10:35:45 INFO - PROCESS | 1106 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 10:35:45 INFO - PROCESS | 1106 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 10:35:45 INFO - PROCESS | 1106 | 10:35:45 INFO - PROCESS | 1106 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:52.00 stddev:4.76 (9.1%) stddev-sans-first:3.04 10:35:45 INFO - PROCESS | 1106 | Values: 65.0 51.0 61.0 52.0 53.0 52.0 52.0 52.0 52.0 52.0 10:35:45 INFO - PROCESS | 1106 | 10:35:45 INFO - PROCESS | 1106 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:63.00 stddev:0.42 (0.7%) stddev-sans-first:0.33 10:35:45 INFO - PROCESS | 1106 | Values: 62.0 63.0 62.0 63.0 63.0 63.0 63.0 63.0 63.0 63.0 10:35:45 INFO - PROCESS | 1106 | 10:35:45 INFO - PROCESS | 1106 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:2.42 (2.9%) stddev-sans-first:2.54 10:35:45 INFO - PROCESS | 1106 | Values: 84.0 87.0 81.0 81.0 82.0 86.0 85.0 81.0 80.0 82.0 10:35:45 INFO - PROCESS | 1106 | 10:35:45 INFO - PROCESS | 1106 | [#11] stanford-crypto-ccm Cycles:10 Average:141.60 Median:141.50 stddev:13.55 (9.6%) stddev-sans-first:13.92 10:35:45 INFO - PROCESS | 1106 | Values: 132.0 133.0 144.0 135.0 133.0 131.0 144.0 139.0 176.0 149.0 10:35:45 INFO - PROCESS | 1106 | 10:35:45 INFO - PROCESS | 1106 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.50 Median:167.50 stddev:2.64 (1.6%) stddev-sans-first:2.79 10:35:45 INFO - PROCESS | 1106 | Values: 167.0 168.0 164.0 165.0 169.0 170.0 162.0 169.0 167.0 164.0 10:35:45 INFO - PROCESS | 1106 | 10:35:45 INFO - PROCESS | 1106 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:64.50 stddev:1.06 (1.6%) stddev-sans-first:1.12 10:35:45 INFO - PROCESS | 1106 | Values: 64.0 66.0 65.0 65.0 65.0 64.0 64.0 64.0 64.0 62.0 10:35:45 INFO - PROCESS | 1106 | -------- Summary: end -------- 10:35:45 INFO - PROCESS | 1106 | 10:35:46 INFO - TEST-INFO | 1106: exit 0 10:35:46 INFO - TEST-OK | kraken | took 62051ms 10:35:46 INFO - SUITE-END | took 1179s 10:35:47 INFO - Completed test suite (00:19:39) 10:35:47 INFO - javascript benchmark 10:35:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2875.1518302100876, 3013.1864396612923, 3013.623297087864, 3026.8183908965448, 3030.848457577122, 5180.067587834188, 5205.479452054793, 5255.080360936835, 5322.414534401213, 5346.732663366831, 5226.973865130679, 5277.525022747952, 5291.100512912804, 5307.920381194285, 5343.812966546172, 4781.713097214161, 4806.83176088837, 4847.321375007502, 4854.393200849894, 4896.290037944496, 4899.730514821684, 4921.8523444296725, 4927.926081108768, 4969.751512424383, 4989.401271847383, 4789.521047895218, 4818.975905120487, 4863.270509423597, 4872.171730805771, 4897.828575999841, 4686.2267725825195, 4731.834385796481, 4733.786979585927, 4783.689060211075, 4833.564979151858, 4800.399950006249, 4824.5899098576665, 4825.493323201048, 4854.956184420366, 4878.365812444359, 5243.947560524384, 5294.841154765363, 5311.309529761145, 5314.176302673091, 5338.9466105339225, 5450.509454149106, 5489.533389661883, 5682.0, 5688.63023903445, 5696.629719068247, 5593.860153496154, 5656.038473459522, 5662.716864156776, 5680.204771332017, 5717.456841600041, 5311.389190243133, 5312.867178320535, 5316.65441746293, 5317.335333083403, 5319.255304257407, 5605.495505404533, 5800.59395842287, 5802.390748971382, 5808.099744539603, 5842.444967728059, 5345.545628621533, 5495.0383682855345, 5575.52608028314, 5602.523785478198, 5602.719864006784, 5610.354809196994, 5641.069223578145, 5644.915326270109, 5650.604457688005, 5671.064274394761, 5578.609497335228, 5584.888302233932, 5589.049861523551, 5589.524890384281, 5605.439456054362, 5516.91724624131, 5526.06056970316, 5576.9163462548095, 5654.547636189095, 5662.009148399014, 4382.978085109554, 4389.934150987738, 4394.934075988863, 4395.604395604347, 4427.800748966304, 3821.121142137268, 3901.200253947934, 3919.235749028912, 3968.543617484026, 3982.6017398260524, 5416.566674666017, 5422.945770542323, 5429.67421954684, 5447.400785913546, 5476.096444086761, 5684.346300175533, 5685.772569097273, 5688.800891968761, 5689.317281926195, 5691.089425691869, 5208.8437346879655, 5269.341332333458, 5421.376541697677, 5422.728863556886, 5461.0716178249795, 4943.4809345018975, 4974.626902982291, 4983.8504844854715, 5010.298558201855, 5048.040872234264, 5884.676342801015, 5956.8808623828145, 5958.582899197101, 5966.105084237399, 5968.104784282393, 5448.83653490396, 5671.886562268649, 5686.402927692533, 5695.772169113189, 5697.1454281856395, 5762.654240745569, 5870.55970802183, 5889.204957330706, 5901.616394934315, 5984.700764961822, 5552.0, 5563.415841336763, 5563.471470210324, 5564.165375193591, 5566.053770859045, 5649.6327738696855, 5660.094384898396, 5663.5469162467725, 5665.291838520185, 5666.376698563073, 5372.301600791872, 5386.596005299697, 5442.918356224581, 5450.236966824568, 5516.117421212587, 5401.297831281908, 5449.945500544944, 5452.591055670761, 5472.179173124063, 5490.176473529003, 5436.809711660231, 5480.314960629921, 5491.835244942658, 5500.4224556420995, 5531.668099914018, 5461.890762184814, 5498.752556134904, 5515.641483303572, 5519.862003449946, 5551.722413879209, 5494.697791621499, 5495.175723641326, 5498.230247765236, 5527.50252477279, 5546.7781288748], "value": 5221.743036022714, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [534.6285399125555, 578.6441338576775, 586.4106572894241, 604.407680473136, 604.6795198544772, 31458.0, 34273.82863085684, 41473.79263103684, 42274.78862605683, 42406.0, 42859.57140428603, 43060.13879722403, 43263.0, 43349.0, 43396.783016084875, 8449.493030418163, 8638.827223455528, 8643.265322447569, 8647.264982476498, 8650.091740367265, 7914.129445760962, 8125.959370203141, 8570.057293697688, 9992.050755178247, 10245.129164021067, 10312.742181445486, 10375.16998640107, 10376.377417354945, 10382.79234415315, 10389.896101039007, 10232.846507302396, 10325.58697652093, 10344.948275258575, 10352.948235258775, 10358.482075896212, 10223.335483193643, 10282.845757313646, 10293.536790844355, 10295.124914382286, 10296.742581435525, 40021.59978400208, 40816.0, 40893.38659920103, 40945.38581921274, 40952.180956381, 3727.4036154215196, 3792.4500947362753, 3938.6652134568308, 4076.2255171517613, 4154.1068670235745, 31068.378632427226, 31364.686353136633, 31619.0, 31876.25556436228, 32303.192420189447, 4079.388091786226, 4223.577642235752, 4240.109576988805, 4269.658427325807, 4482.932756008662, 309304.0, 310688.0, 312100.99999999773, 312386.0, 312424.0, 34907.4763878542, 56914.89361702108, 57210.14184787231, 57533.0, 57641.13538296929, 35567.39946702404, 37481.250374992895, 37711.81144094262, 37731.81134094312, 37737.62262377396, 14979.400823967137, 15118.773218401733, 15125.773113403307, 15130.89816587597, 15140.697186056217, 11318.830217546743, 12295.077869159848, 12346.876531234573, 12366.690832729073, 12389.876101239053, 8187.877181842277, 8372.748817535483, 8554.331905278412, 8565.271951884035, 8688.913110868936, 3353.480210567366, 3355.865765369358, 3359.428897087501, 3374.578177727784, 3387.644297348743, 1027.2552399510296, 1047.518141654832, 1109.7170221593442, 1129.0741591894569, 1164.4119719541748, 31389.37221255562, 31822.681773182434, 35177.0, 35198.472022919676, 35268.0, 1090.1932569898377, 1110.5058249079243, 1137.988620113805, 1163.4938801621151, 1184.490669012333, 16756.329746810236, 16762.497125086265, 16823.66352672964, 16925.576860578338, 16927.915360423118, 454322.0, 454346.0, 456495.0, 456594.0, 458146.0, 55775.0, 56111.15833262504, 56124.15813762797, 56232.437675623536, 56557.7172114145, 1250.6498180509473, 1277.3549357574552, 1287.0604458745167, 1332.5202926946292, 1359.4358341288255, 27959.58060629133, 33454.83272583621, 34212.82893585516, 34529.30941381209, 34788.47817282692, 53659.0, 54733.0, 55188.72405638107, 55256.44743552513, 60649.0, 433796.0, 437933.0, 438815.0, 439069.0, 439191.0, 27413.17760467189, 28010.85994570014, 42926.0, 43274.45618210168, 43784.34323485214, 36968.054578210904, 46593.53406465892, 46696.766516167205, 46750.0, 47023.0, 39503.80248098741, 40462.393064103475, 40533.39199912063, 40940.59059409487, 41722.791386042874, 39777.40333895052, 39909.60090399059, 39934.40098398585, 40374.1925161501, 41614.58385416107, 40424.3936340961, 40753.796231018656, 40977.59022409738, 41285.38071928984, 41343.173136537705, 33743.83128084344, 35801.82099089592, 36235.63764362428, 37087.629123708415, 37328.25343493061, 27017.459650806482, 27751.722482774912, 27926.0, 27929.0, 27964.161075166965], "value": 19057.813347769534, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.62020460358036, 396.8313466776623, 404.4822627037393, 408.9039075817183, 414.7926036981509, 13779.0, 17055.317787288495, 17808.28766849326, 19354.322598709048, 19362.32231871883, 15255.160966146857, 16651.250693718783, 17990.0, 18131.0, 18223.36218232362, 4920.48334924834, 5179.989901969117, 5194.220866869962, 5198.142306519419, 5205.427402985669, 5069.2142717878605, 5155.20094385369, 5233.084210263208, 5233.528982391584, 5233.712145831978, 5140.871478213037, 5192.1952097424955, 5200.349956255468, 5203.245529398235, 5204.245384419257, 5177.404598471167, 5193.402758682724, 5198.27224188612, 5200.713960732158, 5202.791888324463, 5129.3075434816565, 5159.58723302135, 5160.148575485078, 5163.483651634844, 5165.121929271995, 13325.267110308929, 13442.0, 17511.0, 23046.16030633569, 23253.651195232083, 2296.6555016747457, 2336.2757545161053, 2400.627902675088, 2491.95016099677, 2534.2903986883516, 9886.258530610234, 10153.543090560943, 10318.071373576415, 10455.21585881062, 11583.826242606368, 1874.8687591868575, 1907.1322548240516, 1951.7755458122356, 1952.2776572668063, 1986.523234423728, 81490.63882393192, 81727.0, 86347.0, 87166.56416717939, 87434.12565874323, 10536.631217907336, 10749.140068794477, 10820.458977051116, 10913.618023369303, 11100.666979990614, 14916.179610121331, 14916.701665966837, 14939.925300373428, 14981.0, 15026.17356045428, 7132.465065120136, 7421.8125099983745, 7501.212372700897, 7535.321821036133, 7765.602433097211, 6949.93050069503, 6954.79135625932, 6970.302969703091, 7153.213146553875, 8197.262246397853, 4650.534946505322, 4687.789049492781, 4795.136875362398, 4828.275758636162, 4858.441279252931, 1878.8872667639985, 1937.467196520968, 1958.4516335426104, 1961.901904904749, 2009.276660402254, 948.6584829461389, 955.9952200238954, 991.1525645573075, 1037.5901518899993, 1038.6260946059413, 19447.0, 19470.902645486683, 19514.12186451613, 19527.707084393747, 19624.607507849763, 875.9824803503894, 961.3558915526474, 987.7777500062429, 1007.5365331947386, 1025.620520407439, 9954.203663706887, 10641.787164256672, 10792.78414431707, 10819.350838949687, 10863.0, 453238.0, 453539.71682265337, 457954.0, 459678.0, 463510.6015988611, 89059.0, 89930.99999999869, 91689.5415522918, 92151.0, 94788.0, 983.5033308179324, 999.0309399882103, 1006.225206590921, 1032.7418145463635, 1035.0219043004288, 16398.508044758677, 16612.2524486396, 16884.409045683344, 16927.830721693117, 17156.571085722957, 39874.401883971186, 40026.39960400655, 41163.588364115974, 42345.788271058445, 42952.78523607362, 53879.730601346746, 54739.0, 55771.0, 57763.711181445506, 58681.0, 8150.673973041012, 8287.751367458744, 8314.542700151549, 8374.241409304115, 8600.09698981598, 12374.690632734253, 12639.620811375673, 12678.175918565632, 12772.42524086437, 13124.803127952897, 11009.229353945148, 11229.943850280697, 11537.250078744855, 11718.70703232426, 11745.823812642646, 10888.836667449836, 11053.336799792038, 11188.0, 11423.885761142283, 11451.48468318911, 11374.146938979444, 11416.543338266376, 11481.425928703698, 11486.770264594828, 11568.363739994382, 8159.673613055411, 8319.916800832156, 8367.330613551023, 8494.787630309293, 8630.223279904838, 10997.800439911889, 11425.828612570984, 11575.76848463043, 11743.706407339543, 11984.28094314344], "value": 8879.093817392462, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1323.5301467978861, 1477.2392218007722, 1492.693997730465, 1597.7124117658825, 1716.5022143578362, 7516.624168791559, 7985.600719964001, 8122.025356957166, 8218.547979861105, 8419.115992820758, 8223.34213262939, 8273.91726082739, 8293.460925039868, 8300.91699083009, 8303.252707256346, 2278.7949084582424, 2307.457747429353, 2313.618252988255, 2315.2938353802083, 2315.316981490456, 2228.5877112734197, 2285.325828880484, 2286.1541229745017, 2286.8627882327114, 2308.4575124845646, 2276.8406211565116, 2296.7473577906417, 2308.9422764430856, 2312.2022902098834, 2317.4206448387904, 2168.6638571021517, 2184.071769497957, 2196.494806194576, 2197.8131858791944, 2198.076807740753, 2243.8541494802785, 2267.5351552931775, 2270.3416009357265, 2270.965935510969, 2274.465500607356, 8240.093589705128, 8322.62548185333, 8327.458715183555, 8328.750137495885, 8437.662493500315, 5187.299714538564, 5339.652922560022, 5342.0, 5343.973280133613, 5353.866153346197, 3309.7186739127205, 3415.624281329052, 3420.794752314844, 3489.9825500872334, 3492.0396890854963, 1116.2967330581762, 1117.4859564600295, 1128.8363187337873, 1137.2039572299423, 1138.869030061537, 11514.654560363202, 11601.651950441415, 11607.477663505162, 11646.650600481998, 11664.766704665859, 4195.349720793282, 4486.64106871456, 4504.256797628354, 4575.725456472623, 4578.5421457853945, 9514.952425237829, 9517.762055948657, 9519.048095190565, 9524.666636667822, 9527.333086683866, 5171.922421163686, 5174.767135478913, 5183.81856635016, 5189.4032186299055, 5195.480451954774, 4130.297849365615, 4248.74507529543, 4620.67655264135, 4711.010687755541, 4858.222684370484, 3699.186179040607, 3738.327096126283, 3788.8484460621817, 3810.371288737327, 3815.561210460777, 1155.8150695888785, 1178.4932479034098, 1183.911206659504, 1187.3706935324292, 1191.1840389333333, 873.8732883731823, 882.280941033056, 890.955452227399, 902.1654969153507, 915.272358475014, 5362.0, 5372.409035006146, 5471.972640136853, 5510.0, 5622.7750889963945, 422.5710903432957, 427.6429181633371, 431.51239099817633, 431.9762413067249, 440.9581089796464, 3526.365254254259, 3576.2847430514003, 3609.5488063992, 3622.4747411625694, 3708.054446116277, 10269.640562580424, 10813.351198928089, 10813.56745730162, 10815.080718139046, 10839.783204335869, 10607.84088238677, 10709.839352409721, 10713.464326783629, 10738.892611073788, 10742.73143171427, 7554.357879580188, 8014.078380986145, 8075.313598344089, 8106.63520141595, 8113.0, 5188.143956247328, 5218.347706536683, 5241.895162096813, 5359.544438722753, 5480.342358916955, 9740.659076932274, 9754.365966212174, 9760.902390976284, 9768.023197680175, 9885.209183265179, 9844.0, 10133.695989120339, 10196.643117490852, 10199.796004080024, 10226.233032522441, 6703.93296067033, 6864.107666003388, 6892.862142757217, 6918.377346038679, 7120.465965052538, 8163.79590510242, 8532.829343413221, 8549.444286121383, 8549.615267312862, 8556.828863422572, 7297.963510182415, 7322.926770732224, 7478.775636730907, 7514.248575142442, 7545.283198096172, 6973.093497845248, 7141.750038748619, 7169.964150179424, 7171.1394632644415, 7303.926960730537, 6545.705443254969, 6662.467002639874, 6663.167104111986, 6667.233268174028, 6667.899981500184, 4464.084862603224, 4584.472785629695, 4688.226442637063, 4739.289106634033, 4808.158572249912, 4596.6092882105395, 4661.091087238092, 4702.623790096715, 4737.360456338351, 4907.116718990616], "value": 4339.39117720771, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.7790480378148, 332.82512730062876, 339.82499013008305, 340.3210594863248, 342.19583977652536, 4986.950130498694, 5064.898702025957, 5106.565941894939, 5197.76610052548, 5213.478652134785, 4922.60619150468, 5034.572061374787, 5059.721715305656, 5095.643304968654, 5096.79612815487, 4043.919121617566, 4048.6153815387493, 4060.4721386219826, 4063.939040914374, 4069.633732964033, 3776.4146557283666, 3861.1891502784447, 4072.7149099563044, 4075.0, 4077.5718549552316, 4002.359622460407, 4010.6189911958318, 4011.679065674739, 4032.5362583303004, 4037.5263028994354, 3977.9005524861823, 3984.362501999666, 3991.1419044905483, 4010.5588385277597, 4011.63895249426, 3577.9821100894587, 3591.407417776064, 3595.0, 3595.676389124991, 3598.8200589970656, 4878.682885612424, 4947.194274089968, 4948.480409556981, 4978.6514943953935, 4990.575801056914, 4571.588557029883, 4575.428071491064, 4576.199165146119, 4581.5647513486165, 4587.1513769952335, 5297.17893726473, 5299.152135658314, 5301.860100078463, 5303.814366497193, 5306.6550674206055, 3846.807659617036, 3900.3564411872007, 3920.1375697346825, 3936.5866584008554, 3953.6441720245316, 5484.369297530795, 5504.0, 5515.61390702655, 5517.200005999148, 5526.585506087019, 4020.859269925597, 4021.5174179098694, 4026.174634199982, 4031.0, 4036.889855289819, 3972.682185425159, 4018.2530756234655, 4046.575109613448, 4053.9391909121387, 4071.776052317151, 4543.204939135638, 4561.954380456153, 4580.404547408815, 4580.427446569179, 4591.4260717410325, 5293.100172970604, 5293.920591191135, 5351.919721204185, 5356.303680521585, 5358.6248962572245, 1238.3622434446268, 1292.4184117147322, 1313.9802902956462, 1368.6167872995577, 1374.9862501375057, 945.921649319776, 955.254901177083, 962.767657398531, 963.1283688262134, 966.6703245179225, 4962.478939711278, 4986.925196122061, 4994.40067191932, 4994.675346102492, 5004.724740139327, 5233.979374022029, 5237.476252374809, 5244.0, 5256.868578285497, 5270.841874743764, 4760.9285860711425, 4924.433690125681, 4933.28467372229, 4948.604111671058, 5009.248612708123, 2743.6021776842244, 2749.5015216706943, 2766.806323557332, 2774.750272475487, 2778.7360200780895, 5477.917831232535, 5496.532794712414, 5497.917531236954, 5510.0, 5513.889722205534, 5070.29015937769, 5291.417944026154, 5314.7874085036165, 5339.305890234323, 5362.946370536322, 5459.597776978117, 5466.972665136649, 5468.28912241406, 5470.699111548983, 5510.6969116698165, 5198.246254293182, 5203.531682148625, 5228.712420816892, 5241.240020196974, 5242.135047717084, 5074.892142406676, 5130.4100028497205, 5130.435652078343, 5184.222366645034, 5185.0, 5412.675239485643, 5426.972865135649, 5446.0, 5447.291852059207, 5467.835964921059, 3876.7673939563715, 3880.4761357216416, 3902.4536564881505, 3902.492675952222, 3905.6875449964505, 5093.853734053809, 5139.6145289102715, 5141.845744627667, 5142.614303927146, 5190.870228244324, 5141.434442211428, 5157.581665041994, 5287.233351164136, 5301.496357845998, 5340.919886201632, 5331.920021199608, 5353.170258609922, 5364.865878353073, 5367.597430192673, 5369.946300536944, 5155.381354237516, 5288.180332048539, 5330.573554115739, 5345.305110335787, 5350.384705758887, 5387.407385187705, 5400.972995134999, 5413.431589683027, 5423.538999185113, 5432.130859062531, 5304.628675992798, 5312.681239125664, 5324.0, 5329.493698098674, 5332.253484512249], "value": 4050.4991166832, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [769.3306823063933, 770.7841804294798, 804.798800299925, 817.1868990354598, 823.1357075071173, 13450.19298842069, 14377.56867293983, 14389.424423023067, 14395.0, 14411.27943602821, 12237.510499580007, 13629.25039122848, 13802.516911908086, 13828.723425531483, 14742.63143421415, 763.9961800191019, 783.5533745764916, 784.6155383861895, 784.6861255497818, 786.4691333349995, 793.2226418110256, 794.8489786940492, 796.0526972902256, 796.4066770256168, 797.1390897830358, 839.7522730794431, 841.4824882697159, 841.7769291137853, 841.9957900210491, 842.065307508668, 834.5243211369522, 836.5566249887569, 836.9916300837035, 837.2381133168788, 838.2330167896398, 611.5902345428574, 612.2224774536359, 612.4763327355092, 612.8712970276202, 612.9785457508966, 13816.032877698564, 13845.515406960809, 13867.37596808146, 13955.651108722263, 13980.790288145687, 13440.5295814647, 14107.294635268297, 14121.85878141226, 14221.288935553284, 14357.282135893163, 11476.4835582399, 11496.0, 11606.129540284512, 11610.245334053345, 11619.767604647945, 3719.6094410087094, 3750.1562148516364, 3774.9622503774885, 3788.45067465216, 3902.4731661225655, 41583.37624935628, 42721.35917961233, 50499.24251136236, 53894.73052634751, 59797.40202598005, 10952.890471095187, 11157.609483668033, 11295.322280663186, 11373.829392559119, 11396.0, 19824.107915143853, 19893.701594476093, 19900.90049549743, 20054.89972550157, 20121.496962576053, 7992.68029278834, 8061.234182752629, 8210.466319689202, 8328.167183281745, 8403.805496828796, 4482.260427029503, 4607.654425918069, 4627.606653434428, 4714.57568818808, 4819.903601928012, 3268.9019329420157, 3366.377220214268, 3370.7808992415416, 3374.4263475209273, 3376.341613385366, 603.8882806680778, 609.7743834781071, 612.5589575505629, 623.5946634687399, 631.4285571557748, 740.0822979505482, 740.226463345805, 745.8918456823839, 768.7036319756879, 779.4855395439097, 8155.592220388957, 8267.090620031911, 8521.53131577769, 8793.736187914245, 8826.779330516789, 724.1021133794163, 730.1274976403254, 736.9705211791576, 739.3826155160393, 748.6518768772547, 4006.8797936061383, 4223.767692776927, 4245.893852653709, 4322.37325587788, 4380.6933514653665, 78993.0, 89475.0, 90625.54687226654, 91286.54356728174, 94917.52541237387, 77145.0, 78332.21667783249, 78813.0, 80747.19252807515, 82919.5854020738, 44535.777321113186, 65103.34896650973, 65174.67412662906, 66049.33950660432, 66565.66717166384, 9318.72043838686, 9815.214782817215, 9919.65281215154, 9933.255005874444, 10037.197024237897, 40388.394174086825, 43157.17378154035, 43846.56153438425, 44372.33441498445, 46259.074818504116, 53935.73032134814, 61910.69044654748, 61976.69011654913, 63267.683661581395, 64120.35879641144, 11862.762744745229, 12040.75918481608, 12320.507179712711, 12623.179493332904, 12633.494660213857, 13491.0, 13492.5277615283, 13935.442582296595, 14013.0, 14206.289685515889, 12322.507099715911, 12509.124361294622, 12707.618771436872, 13151.868481315065, 13445.932770336085, 11881.762364752483, 11907.404629768303, 11919.821202681793, 11962.222455540363, 12880.806787898002, 12389.504419823106, 12684.175528590613, 12691.0, 12800.935995320337, 12829.294388808705, 10428.478576071015, 10558.861334299474, 10725.356478611307, 10795.40625265618, 11001.644498427737, 10445.529951152368, 10652.361622517468, 10950.0, 11054.22620416563, 11185.552577897119], "value": 7009.037003545687, "unit": "score"}], "name": "dromaeo_css", "value": 6910.083923303146, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 112.0, 110.0, 110.0, 111.0, 112.0, 110.0, 111.0, 110.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 124.0, 123.0, 160.0, 126.0, 124.0, 122.0, 127.0, 159.0, 123.0], "value": 133.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 163.0, 160.0, 161.0, 161.0, 160.0, 162.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 109.0, 77.0, 76.0, 76.0, 75.0, 101.0, 75.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 116.0, 82.0, 81.0, 82.0, 101.0, 82.0, 81.0, 116.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 147.0, 146.0, 146.0, 147.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 51.0, 61.0, 52.0, 53.0, 52.0, 52.0, 52.0, 52.0, 52.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 87.0, 81.0, 81.0, 82.0, 86.0, 85.0, 81.0, 80.0, 82.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 133.0, 144.0, 135.0, 133.0, 131.0, 144.0, 139.0, 176.0, 149.0], "value": 141.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 168.0, 164.0, 165.0, 169.0, 170.0, 162.0, 169.0, 167.0, 164.0], "value": 166.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 65.0, 65.0, 64.0, 64.0, 64.0, 64.0, 62.0], "value": 64.3, "unit": "score"}], "name": "kraken", "value": 1507.2, "alertThreshold": 2.0}]} 10:35:47 INFO - Return code: 0 10:35:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:35:47 INFO - # TBPL SUCCESS # 10:35:47 INFO - Running post-action listener: _resource_record_post_action 10:35:47 INFO - [mozharness: 2016-11-18 18:35:47.196741Z] Finished run-tests step (success) 10:35:47 INFO - Running post-run listener: _resource_record_post_run 10:35:47 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392265728; Read time: 16; Write time: 217224 10:35:47 INFO - TinderboxPrint: CPU usage
13.1% 10:35:47 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 10:35:47 INFO - TinderboxPrint: I/O write bytes / time
392,265,728 / 217,224 10:35:47 INFO - TinderboxPrint: CPU idle
8,300.8 (86.9%) 10:35:47 INFO - TinderboxPrint: CPU user
1,199.6 (12.6%) 10:35:47 INFO - TinderboxPrint: Swap in / out
0 / 0 10:35:47 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 105607168; Read time: 0; Write time: 59452 10:35:47 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 286658560; Read time: 0; Write time: 157772 10:35:47 INFO - Running post-run listener: _upload_blobber_files 10:35:47 INFO - Blob upload gear active. 10:35:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:35:47 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 10:35:47 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:35:47 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:35:48 INFO - (blobuploader) - INFO - Open directory for files ... 10:35:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:35:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:35:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:35:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:35:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:35:52 INFO - (blobuploader) - INFO - Done attempting. 10:35:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:35:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:35:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:35:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:35:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:35:54 INFO - (blobuploader) - INFO - Done attempting. 10:35:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:35:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:35:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:35:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:35:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:35:54 INFO - (blobuploader) - INFO - Done attempting. 10:35:54 INFO - (blobuploader) - INFO - Iteration through files over. 10:35:54 INFO - Return code: 0 10:35:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:35:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:35:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6883eff5c278ccae1c31442458e900262a21f37001498f4af404bd2ae2837325438fea0359d1ac4210ee2aa92a99b26b397ac22546bd1c9fe78fa6dc50624f73", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32967c168246182c18ae03739a530ffa20e13ae3d0bf73d63ed9ff3f6e2cb885b173da29999d5614262fd10d60309e030dda6b3f9e4b9aa89a984e5e9e9badb3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14a4dbfae7288d7f7f8f2c2d6e339eb154331915d32688dd5d7da4d6cd43951cd44f7130f8e692c2f0f226c99a42c1338e7cf699b97bcdf4dc223863f7f0edd7"} 10:35:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:35:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:35:54 INFO - Contents: 10:35:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6883eff5c278ccae1c31442458e900262a21f37001498f4af404bd2ae2837325438fea0359d1ac4210ee2aa92a99b26b397ac22546bd1c9fe78fa6dc50624f73", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32967c168246182c18ae03739a530ffa20e13ae3d0bf73d63ed9ff3f6e2cb885b173da29999d5614262fd10d60309e030dda6b3f9e4b9aa89a984e5e9e9badb3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14a4dbfae7288d7f7f8f2c2d6e339eb154331915d32688dd5d7da4d6cd43951cd44f7130f8e692c2f0f226c99a42c1338e7cf699b97bcdf4dc223863f7f0edd7"} 10:35:54 INFO - Running post-run listener: copy_logs_to_upload_dir 10:35:54 INFO - Copying logs to upload dir... 10:35:54 INFO - mkdir: /builds/slave/test/build/upload/logs 10:35:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.723932 ========= master_lag: 0.19 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-11-18 10:35:55.023453) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 10:35:55.026488) ========= 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=41a7e32711b8e08598a63237000001d6-1479492863.879721-404384121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6883eff5c278ccae1c31442458e900262a21f37001498f4af404bd2ae2837325438fea0359d1ac4210ee2aa92a99b26b397ac22546bd1c9fe78fa6dc50624f73", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32967c168246182c18ae03739a530ffa20e13ae3d0bf73d63ed9ff3f6e2cb885b173da29999d5614262fd10d60309e030dda6b3f9e4b9aa89a984e5e9e9badb3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14a4dbfae7288d7f7f8f2c2d6e339eb154331915d32688dd5d7da4d6cd43951cd44f7130f8e692c2f0f226c99a42c1338e7cf699b97bcdf4dc223863f7f0edd7"} build_url:https://queue.taskcluster.net/v1/task/dREUHLS-RmO9BTKTsLvTKQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011792 build_url: 'https://queue.taskcluster.net/v1/task/dREUHLS-RmO9BTKTsLvTKQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6883eff5c278ccae1c31442458e900262a21f37001498f4af404bd2ae2837325438fea0359d1ac4210ee2aa92a99b26b397ac22546bd1c9fe78fa6dc50624f73", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/32967c168246182c18ae03739a530ffa20e13ae3d0bf73d63ed9ff3f6e2cb885b173da29999d5614262fd10d60309e030dda6b3f9e4b9aa89a984e5e9e9badb3", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/14a4dbfae7288d7f7f8f2c2d6e339eb154331915d32688dd5d7da4d6cd43951cd44f7130f8e692c2f0f226c99a42c1338e7cf699b97bcdf4dc223863f7f0edd7"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 10:35:55.069570) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 10:35:55.069903) ========= 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=41a7e32711b8e08598a63237000001d6-1479492863.879721-404384121 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004515 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 10:35:55.122855) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 10:35:55.126268) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 10:35:55.132384) ========= ========= Total master_lag: 0.33 =========